builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1475690763.88 results: success (0) buildid: 20161005080800 builduid: 73a7db6c0aac495dbb2af125db887b24 revision: dacddb224d32cd5f979fa4b53e702c7dc69be46c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:03.884110) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:03.884589) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:03.884882) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:03.896290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:03.896645) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 11:06:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2016-10-05 11:06:04 (18.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102284 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:04.010325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:04.010676) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016175 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:04.060647) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 11:06:04.060992) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dacddb224d32cd5f979fa4b53e702c7dc69be46c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev dacddb224d32cd5f979fa4b53e702c7dc69be46c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 11:06:04,150 truncating revision to first 12 chars 2016-10-05 11:06:04,150 Setting DEBUG logging. 2016-10-05 11:06:04,150 attempt 1/10 2016-10-05 11:06:04,150 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/dacddb224d32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 11:06:05,373 unpacking tar archive at: mozilla-beta-dacddb224d32/testing/mozharness/ program finished with exit code 0 elapsedTime=1.559584 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 11:06:05.633815) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:05.634159) ========= script_repo_revision: dacddb224d32cd5f979fa4b53e702c7dc69be46c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:05.634584) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:05.634879) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 11:06:05.642954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-10-05 11:06:05.643310) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:05 INFO - MultiFileLogger online at 20161005 11:06:05 in /builds/slave/test 11:06:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:06:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:05 INFO - {'append_to_log': False, 11:06:05 INFO - 'base_work_dir': '/builds/slave/test', 11:06:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:06:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:05 INFO - 'branch': 'Mozilla-Beta', 11:06:05 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:05 INFO - 'config_files': ('talos/linux_config.py',), 11:06:05 INFO - 'default_actions': ('clobber', 11:06:05 INFO - 'read-buildbot-config', 11:06:05 INFO - 'download-and-extract', 11:06:05 INFO - 'populate-webroot', 11:06:05 INFO - 'create-virtualenv', 11:06:05 INFO - 'install', 11:06:05 INFO - 'run-tests'), 11:06:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:05 INFO - 'download_minidump_stackwalk': True, 11:06:05 INFO - 'download_symbols': 'ondemand', 11:06:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:05 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:05 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:05 INFO - 'installer_path': 'installer.exe', 11:06:05 INFO - 'log_level': 'info', 11:06:05 INFO - 'log_name': 'talos', 11:06:05 INFO - 'log_to_console': True, 11:06:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:05 INFO - 'opt_config_files': (), 11:06:05 INFO - 'pip_index': False, 11:06:05 INFO - 'sps_profile': False, 11:06:05 INFO - 'sps_profile_interval': 0, 11:06:05 INFO - 'suite': 'dromaeojs-e10s', 11:06:05 INFO - 'system_bits': '32', 11:06:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:05 INFO - 'title': 'talos-linux64-ix-011', 11:06:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:05 INFO - 'use_talos_json': True, 11:06:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:05 INFO - 'work_dir': 'build'} 11:06:05 INFO - [mozharness: 2016-10-05 18:06:05.821957Z] Running clobber step. 11:06:05 INFO - Running pre-action listener: _resource_record_pre_action 11:06:05 INFO - Running main action method: clobber 11:06:05 INFO - rmtree: /builds/slave/test/build 11:06:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:06:06 INFO - Running post-action listener: _resource_record_post_action 11:06:06 INFO - [mozharness: 2016-10-05 18:06:06.274207Z] Finished clobber step (success) 11:06:06 INFO - [mozharness: 2016-10-05 18:06:06.274307Z] Running read-buildbot-config step. 11:06:06 INFO - Running pre-action listener: _resource_record_pre_action 11:06:06 INFO - Running main action method: read_buildbot_config 11:06:06 INFO - Using buildbot properties: 11:06:06 INFO - { 11:06:06 INFO - "project": "", 11:06:06 INFO - "product": "firefox", 11:06:06 INFO - "script_repo_revision": "production", 11:06:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:06:06 INFO - "repository": "", 11:06:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 11:06:06 INFO - "buildid": "20161005080800", 11:06:06 INFO - "pgo_build": "True", 11:06:06 INFO - "basedir": "/builds/slave/test", 11:06:06 INFO - "buildnumber": 276, 11:06:06 INFO - "slavename": "talos-linux64-ix-011", 11:06:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:06:06 INFO - "platform": "ubuntu64_hw", 11:06:06 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:06:06 INFO - "branch": "mozilla-beta", 11:06:06 INFO - "repo_path": "releases/mozilla-beta", 11:06:06 INFO - "revision": "dacddb224d32cd5f979fa4b53e702c7dc69be46c", 11:06:06 INFO - "stage_platform": "linux64-pgo", 11:06:06 INFO - "builduid": "73a7db6c0aac495dbb2af125db887b24", 11:06:06 INFO - "slavebuilddir": "test" 11:06:06 INFO - } 11:06:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 11:06:06 INFO - Running post-action listener: _resource_record_post_action 11:06:06 INFO - [mozharness: 2016-10-05 18:06:06.276739Z] Finished read-buildbot-config step (success) 11:06:06 INFO - [mozharness: 2016-10-05 18:06:06.276828Z] Running download-and-extract step. 11:06:06 INFO - Running pre-action listener: _resource_record_pre_action 11:06:06 INFO - Running main action method: download_and_extract 11:06:06 INFO - mkdir: /builds/slave/test/build/tests 11:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:06 INFO - https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:06:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:06:06 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:06:06 INFO - retry: Failed, sleeping 30 seconds before retrying 11:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 11:06:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:06:36 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:06:36 INFO - retry: Failed, sleeping 60 seconds before retrying 11:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 11:07:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:07:36 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:07:36 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 11:07:36 INFO - Caught exception: HTTP Error 404: Not Found 11:07:36 INFO - Caught exception: HTTP Error 404: Not Found 11:07:36 INFO - Caught exception: HTTP Error 404: Not Found 11:07:36 INFO - trying https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:07:36 INFO - Downloading https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:07:36 INFO - Downloaded 1327 bytes. 11:07:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 11:07:36 INFO - Using the following test package requirements: 11:07:36 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 11:07:36 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:07:36 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:07:36 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:07:36 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 11:07:36 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:07:36 INFO - u'jsshell-linux-x86_64.zip'], 11:07:36 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:07:36 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:07:36 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 11:07:36 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:07:36 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 11:07:36 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:07:36 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 11:07:36 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:07:36 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:07:36 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 11:07:36 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:07:36 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:36 INFO - https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:07:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:07:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:07:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:07:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:07:36 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:07:36 INFO - retry: Failed, sleeping 30 seconds before retrying 11:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 11:08:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:08:07 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:08:07 INFO - retry: Failed, sleeping 60 seconds before retrying 11:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 11:09:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:09:07 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:09:07 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 11:09:07 INFO - Caught exception: HTTP Error 404: Not Found 11:09:07 INFO - Caught exception: HTTP Error 404: Not Found 11:09:07 INFO - Caught exception: HTTP Error 404: Not Found 11:09:07 INFO - trying https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:09:07 INFO - Downloading https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:09:07 INFO - Downloaded 21772138 bytes. 11:09:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:09:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:09:09 INFO - Return code: 0 11:09:09 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:09 INFO - https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:09:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:09:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:09:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:09:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:09:09 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:09:09 INFO - retry: Failed, sleeping 30 seconds before retrying 11:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 11:09:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:09:39 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:09:39 INFO - retry: Failed, sleeping 60 seconds before retrying 11:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 11:10:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:10:39 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:10:39 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 11:10:39 INFO - Caught exception: HTTP Error 404: Not Found 11:10:39 INFO - Caught exception: HTTP Error 404: Not Found 11:10:39 INFO - Caught exception: HTTP Error 404: Not Found 11:10:39 INFO - trying https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:10:39 INFO - Downloading https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 11:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:10:40 INFO - Downloaded 21772138 bytes. 11:10:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:10:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:10:41 INFO - Return code: 0 11:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:41 INFO - https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:10:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:10:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:10:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:10:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:10:41 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:10:41 INFO - retry: Failed, sleeping 30 seconds before retrying 11:11:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 11:11:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:11:11 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:11:11 INFO - retry: Failed, sleeping 60 seconds before retrying 11:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 11:12:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:12:11 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:12:11 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 11:12:11 INFO - Caught exception: HTTP Error 404: Not Found 11:12:11 INFO - Caught exception: HTTP Error 404: Not Found 11:12:11 INFO - Caught exception: HTTP Error 404: Not Found 11:12:11 INFO - trying https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:12:11 INFO - Downloading https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 11:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:12:12 INFO - Downloaded 14413740 bytes. 11:12:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:12:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:12:12 INFO - Return code: 0 11:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:12:12 INFO - https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:12:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:12:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:12:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:12:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:12:12 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 11:12:12 INFO - retry: Failed, sleeping 30 seconds before retrying 11:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 11:12:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:12:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 11:12:42 INFO - retry: Failed, sleeping 60 seconds before retrying 11:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 11:13:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:13:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 11:13:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 11:13:42 INFO - Caught exception: HTTP Error 404: Not Found 11:13:42 INFO - Caught exception: HTTP Error 404: Not Found 11:13:42 INFO - Caught exception: HTTP Error 404: Not Found 11:13:42 INFO - trying https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:13:42 INFO - Downloading https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:13:43 INFO - Downloaded 56767662 bytes. 11:13:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:13:43 INFO - mkdir: /builds/slave/test/properties 11:13:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:13:43 INFO - Writing to file /builds/slave/test/properties/build_url 11:13:43 INFO - Contents: 11:13:43 INFO - build_url:https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 11:13:44 INFO - Running post-action listener: _resource_record_post_action 11:13:44 INFO - Running post-action listener: set_extra_try_arguments 11:13:44 INFO - [mozharness: 2016-10-05 18:13:44.270320Z] Finished download-and-extract step (success) 11:13:44 INFO - [mozharness: 2016-10-05 18:13:44.270553Z] Running populate-webroot step. 11:13:44 INFO - Running pre-action listener: _resource_record_pre_action 11:13:44 INFO - Running main action method: populate_webroot 11:13:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:13:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:13:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:13:44 INFO - '--tppagecycles', 11:13:44 INFO - '7'], 11:13:44 INFO - 'tests': ['tsvgm']}}, 11:13:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:13:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:13:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:13:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:13:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:44 INFO - 'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:44 INFO - 'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['damp', 'tps']}, 11:13:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:44 INFO - 'tests': ['damp', 'tps']}, 11:13:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['dromaeo_dom']}, 11:13:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:13:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['basic_compositor_video']}, 11:13:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:13:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['a11yr', 11:13:44 INFO - 'ts_paint', 11:13:44 INFO - 'tpaint', 11:13:44 INFO - 'sessionrestore', 11:13:44 INFO - 'sessionrestore_no_auto_restore', 11:13:44 INFO - 'tabpaint']}, 11:13:44 INFO - 'other-e10s': {'tests': ['a11yr', 11:13:44 INFO - 'ts_paint', 11:13:44 INFO - 'tpaint', 11:13:44 INFO - 'sessionrestore', 11:13:44 INFO - 'sessionrestore_no_auto_restore', 11:13:44 INFO - 'tabpaint']}, 11:13:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:13:44 INFO - 'ts_paint', 11:13:44 INFO - 'tpaint', 11:13:44 INFO - 'sessionrestore', 11:13:44 INFO - 'sessionrestore_no_auto_restore', 11:13:44 INFO - 'tabpaint']}, 11:13:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:13:44 INFO - 'ts_paint', 11:13:44 INFO - 'tpaint', 11:13:44 INFO - 'sessionrestore', 11:13:44 INFO - 'sessionrestore_no_auto_restore', 11:13:44 INFO - 'tabpaint']}, 11:13:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['a11yr', 11:13:44 INFO - 'ts_paint', 11:13:44 INFO - 'tpaint', 11:13:44 INFO - 'sessionrestore', 11:13:44 INFO - 'sessionrestore_no_auto_restore', 11:13:44 INFO - 'tabpaint']}, 11:13:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['a11yr', 11:13:44 INFO - 'ts_paint', 11:13:44 INFO - 'tpaint', 11:13:44 INFO - 'sessionrestore', 11:13:44 INFO - 'sessionrestore_no_auto_restore', 11:13:44 INFO - 'tabpaint']}, 11:13:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['tsvgx', 11:13:44 INFO - 'tsvgr_opacity', 11:13:44 INFO - 'tart', 11:13:44 INFO - 'tscrollx', 11:13:44 INFO - 'cart']}, 11:13:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:13:44 INFO - 'tsvgr_opacity', 11:13:44 INFO - 'tart', 11:13:44 INFO - 'tscrollx', 11:13:44 INFO - 'cart']}, 11:13:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:44 INFO - 'talos_options': ['--disable-e10s'], 11:13:44 INFO - 'tests': ['tp5o']}, 11:13:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:44 INFO - 'tests': ['tp5o']}, 11:13:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:44 INFO - 'talos_options': ['--disable-e10s', 11:13:44 INFO - '--xperf_path', 11:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:44 INFO - 'tests': ['tp5n']}, 11:13:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:44 INFO - 'talos_options': ['--xperf_path', 11:13:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:44 INFO - 'tests': ['tp5n']}}, 11:13:44 INFO - 'talos.zip': {'path': '', 11:13:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:13:44 INFO - Running post-action listener: _resource_record_post_action 11:13:44 INFO - [mozharness: 2016-10-05 18:13:44.290610Z] Finished populate-webroot step (success) 11:13:44 INFO - [mozharness: 2016-10-05 18:13:44.290698Z] Running create-virtualenv step. 11:13:44 INFO - Running pre-action listener: _resource_record_pre_action 11:13:44 INFO - Running main action method: create_virtualenv 11:13:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:13:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:13:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:13:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:13:44 INFO - Using real prefix '/usr' 11:13:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:13:44 INFO - Installing distribute.............................................................................................................................................................................................done. 11:13:46 INFO - Installing pip.................done. 11:13:46 INFO - Return code: 0 11:13:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:13:46 INFO - Using env: {'DISPLAY': ':0', 11:13:46 INFO - 'HOME': '/home/cltbld', 11:13:46 INFO - 'LANG': 'en_US.UTF-8', 11:13:46 INFO - 'LANGUAGE': 'en_US:en', 11:13:46 INFO - 'LOGNAME': 'cltbld', 11:13:46 INFO - 'MAIL': '/var/mail/cltbld', 11:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:46 INFO - 'MOZ_NO_REMOTE': '1', 11:13:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:46 INFO - 'NO_EM_RESTART': '1', 11:13:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:46 INFO - 'PWD': '/builds/slave/test', 11:13:46 INFO - 'SHELL': '/bin/bash', 11:13:46 INFO - 'SHLVL': '1', 11:13:46 INFO - 'TERM': 'linux', 11:13:46 INFO - 'TMOUT': '86400', 11:13:46 INFO - 'USER': 'cltbld', 11:13:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:46 INFO - '_': '/tools/buildbot/bin/python'} 11:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:13:47 INFO - Cleaning up... 11:13:47 INFO - Return code: 0 11:13:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:13:47 INFO - Using env: {'DISPLAY': ':0', 11:13:47 INFO - 'HOME': '/home/cltbld', 11:13:47 INFO - 'LANG': 'en_US.UTF-8', 11:13:47 INFO - 'LANGUAGE': 'en_US:en', 11:13:47 INFO - 'LOGNAME': 'cltbld', 11:13:47 INFO - 'MAIL': '/var/mail/cltbld', 11:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:47 INFO - 'MOZ_NO_REMOTE': '1', 11:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:47 INFO - 'NO_EM_RESTART': '1', 11:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:47 INFO - 'PWD': '/builds/slave/test', 11:13:47 INFO - 'SHELL': '/bin/bash', 11:13:47 INFO - 'SHLVL': '1', 11:13:47 INFO - 'TERM': 'linux', 11:13:47 INFO - 'TMOUT': '86400', 11:13:47 INFO - 'USER': 'cltbld', 11:13:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:47 INFO - '_': '/tools/buildbot/bin/python'} 11:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:47 INFO - Downloading/unpacking psutil>=3.1.1 11:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:49 INFO - Installing collected packages: psutil 11:13:49 INFO - Running setup.py install for psutil 11:13:49 INFO - building 'psutil._psutil_linux' extension 11:13:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:13:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:13:49 INFO - building 'psutil._psutil_posix' extension 11:13:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:13:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:49 INFO - Successfully installed psutil 11:13:49 INFO - Cleaning up... 11:13:49 INFO - Return code: 0 11:13:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:13:49 INFO - Using env: {'DISPLAY': ':0', 11:13:49 INFO - 'HOME': '/home/cltbld', 11:13:49 INFO - 'LANG': 'en_US.UTF-8', 11:13:49 INFO - 'LANGUAGE': 'en_US:en', 11:13:49 INFO - 'LOGNAME': 'cltbld', 11:13:49 INFO - 'MAIL': '/var/mail/cltbld', 11:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:49 INFO - 'MOZ_NO_REMOTE': '1', 11:13:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:49 INFO - 'NO_EM_RESTART': '1', 11:13:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:49 INFO - 'PWD': '/builds/slave/test', 11:13:49 INFO - 'SHELL': '/bin/bash', 11:13:49 INFO - 'SHLVL': '1', 11:13:49 INFO - 'TERM': 'linux', 11:13:49 INFO - 'TMOUT': '86400', 11:13:49 INFO - 'USER': 'cltbld', 11:13:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:49 INFO - '_': '/tools/buildbot/bin/python'} 11:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:13:52 INFO - Installing collected packages: mozsystemmonitor 11:13:52 INFO - Running setup.py install for mozsystemmonitor 11:13:52 INFO - Successfully installed mozsystemmonitor 11:13:52 INFO - Cleaning up... 11:13:52 INFO - Return code: 0 11:13:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:13:52 INFO - Using env: {'DISPLAY': ':0', 11:13:52 INFO - 'HOME': '/home/cltbld', 11:13:52 INFO - 'LANG': 'en_US.UTF-8', 11:13:52 INFO - 'LANGUAGE': 'en_US:en', 11:13:52 INFO - 'LOGNAME': 'cltbld', 11:13:52 INFO - 'MAIL': '/var/mail/cltbld', 11:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:52 INFO - 'MOZ_NO_REMOTE': '1', 11:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:52 INFO - 'NO_EM_RESTART': '1', 11:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:52 INFO - 'PWD': '/builds/slave/test', 11:13:52 INFO - 'SHELL': '/bin/bash', 11:13:52 INFO - 'SHLVL': '1', 11:13:52 INFO - 'TERM': 'linux', 11:13:52 INFO - 'TMOUT': '86400', 11:13:52 INFO - 'USER': 'cltbld', 11:13:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:52 INFO - '_': '/tools/buildbot/bin/python'} 11:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:52 INFO - Downloading/unpacking jsonschema==2.5.1 11:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:54 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:54 INFO - warning: no files found matching '*.txt' 11:13:54 INFO - no previously-included directories found matching 'build' 11:13:54 INFO - no previously-included directories found matching 'dist' 11:13:54 INFO - no previously-included directories found matching '.git*' 11:13:54 INFO - Installing collected packages: jsonschema, functools32 11:13:54 INFO - Running setup.py install for functools32 11:13:54 INFO - warning: no files found matching '*.txt' 11:13:54 INFO - no previously-included directories found matching 'build' 11:13:54 INFO - no previously-included directories found matching 'dist' 11:13:54 INFO - no previously-included directories found matching '.git*' 11:13:54 INFO - Successfully installed jsonschema functools32 11:13:54 INFO - Cleaning up... 11:13:54 INFO - Return code: 0 11:13:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:13:54 INFO - Using env: {'DISPLAY': ':0', 11:13:54 INFO - 'HOME': '/home/cltbld', 11:13:54 INFO - 'LANG': 'en_US.UTF-8', 11:13:54 INFO - 'LANGUAGE': 'en_US:en', 11:13:54 INFO - 'LOGNAME': 'cltbld', 11:13:54 INFO - 'MAIL': '/var/mail/cltbld', 11:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:54 INFO - 'MOZ_NO_REMOTE': '1', 11:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:54 INFO - 'NO_EM_RESTART': '1', 11:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:54 INFO - 'PWD': '/builds/slave/test', 11:13:54 INFO - 'SHELL': '/bin/bash', 11:13:54 INFO - 'SHLVL': '1', 11:13:54 INFO - 'TERM': 'linux', 11:13:54 INFO - 'TMOUT': '86400', 11:13:54 INFO - 'USER': 'cltbld', 11:13:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:54 INFO - '_': '/tools/buildbot/bin/python'} 11:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:13:54 INFO - Cleaning up... 11:13:54 INFO - Return code: 0 11:13:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:13:54 INFO - Using env: {'DISPLAY': ':0', 11:13:54 INFO - 'HOME': '/home/cltbld', 11:13:54 INFO - 'LANG': 'en_US.UTF-8', 11:13:54 INFO - 'LANGUAGE': 'en_US:en', 11:13:54 INFO - 'LOGNAME': 'cltbld', 11:13:54 INFO - 'MAIL': '/var/mail/cltbld', 11:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:54 INFO - 'MOZ_NO_REMOTE': '1', 11:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:54 INFO - 'NO_EM_RESTART': '1', 11:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:54 INFO - 'PWD': '/builds/slave/test', 11:13:54 INFO - 'SHELL': '/bin/bash', 11:13:54 INFO - 'SHLVL': '1', 11:13:54 INFO - 'TERM': 'linux', 11:13:54 INFO - 'TMOUT': '86400', 11:13:54 INFO - 'USER': 'cltbld', 11:13:54 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:54 INFO - '_': '/tools/buildbot/bin/python'} 11:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:55 INFO - Downloading/unpacking blobuploader==1.2.4 11:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:57 INFO - Downloading docopt-0.6.1.tar.gz 11:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:57 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:57 INFO - Running setup.py install for blobuploader 11:13:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:57 INFO - Running setup.py install for requests 11:13:58 INFO - Running setup.py install for docopt 11:13:58 INFO - Successfully installed blobuploader requests docopt 11:13:58 INFO - Cleaning up... 11:13:58 INFO - Return code: 0 11:13:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:13:58 INFO - Using env: {'DISPLAY': ':0', 11:13:58 INFO - 'HOME': '/home/cltbld', 11:13:58 INFO - 'LANG': 'en_US.UTF-8', 11:13:58 INFO - 'LANGUAGE': 'en_US:en', 11:13:58 INFO - 'LOGNAME': 'cltbld', 11:13:58 INFO - 'MAIL': '/var/mail/cltbld', 11:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:58 INFO - 'MOZ_NO_REMOTE': '1', 11:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:58 INFO - 'NO_EM_RESTART': '1', 11:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:58 INFO - 'PWD': '/builds/slave/test', 11:13:58 INFO - 'SHELL': '/bin/bash', 11:13:58 INFO - 'SHLVL': '1', 11:13:58 INFO - 'TERM': 'linux', 11:13:58 INFO - 'TMOUT': '86400', 11:13:58 INFO - 'USER': 'cltbld', 11:13:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:58 INFO - '_': '/tools/buildbot/bin/python'} 11:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:58 INFO - Running setup.py (path:/tmp/pip-kEJFv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:58 INFO - Running setup.py (path:/tmp/pip-OwpctJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:58 INFO - Running setup.py (path:/tmp/pip-Y2Ruzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:58 INFO - Running setup.py (path:/tmp/pip-LRSQXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:58 INFO - Running setup.py (path:/tmp/pip-Mjv0G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:59 INFO - Running setup.py (path:/tmp/pip-NsaEYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:59 INFO - Running setup.py (path:/tmp/pip-D4DMhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:59 INFO - Running setup.py (path:/tmp/pip-gzzxZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:59 INFO - Running setup.py (path:/tmp/pip-zVwM2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:59 INFO - Running setup.py (path:/tmp/pip-CDtgQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:59 INFO - Running setup.py (path:/tmp/pip-7rrUSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:59 INFO - Running setup.py (path:/tmp/pip-TMRgR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:59 INFO - Running setup.py (path:/tmp/pip-PmTrIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:59 INFO - Running setup.py (path:/tmp/pip-aUILpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:59 INFO - Running setup.py (path:/tmp/pip-CTimSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:59 INFO - Running setup.py (path:/tmp/pip-3DAyI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:59 INFO - Running setup.py (path:/tmp/pip-g6v4sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:59 INFO - Running setup.py install for manifestparser 11:13:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:59 INFO - Running setup.py install for mozcrash 11:14:00 INFO - Running setup.py install for mozdebug 11:14:00 INFO - Running setup.py install for mozdevice 11:14:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:14:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:14:00 INFO - Running setup.py install for mozfile 11:14:00 INFO - Running setup.py install for mozhttpd 11:14:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:14:00 INFO - Running setup.py install for mozinfo 11:14:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:14:00 INFO - Running setup.py install for mozInstall 11:14:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:14:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:14:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:14:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:14:00 INFO - Running setup.py install for mozleak 11:14:00 INFO - Running setup.py install for mozlog 11:14:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:14:00 INFO - Running setup.py install for moznetwork 11:14:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:14:01 INFO - Running setup.py install for mozprocess 11:14:01 INFO - Running setup.py install for mozprofile 11:14:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:14:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:14:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:14:01 INFO - Running setup.py install for mozrunner 11:14:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:14:01 INFO - Running setup.py install for mozscreenshot 11:14:01 INFO - Running setup.py install for moztest 11:14:01 INFO - Running setup.py install for mozversion 11:14:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:14:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:14:01 INFO - Cleaning up... 11:14:01 INFO - Return code: 0 11:14:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:14:01 INFO - Using env: {'DISPLAY': ':0', 11:14:01 INFO - 'HOME': '/home/cltbld', 11:14:01 INFO - 'LANG': 'en_US.UTF-8', 11:14:01 INFO - 'LANGUAGE': 'en_US:en', 11:14:01 INFO - 'LOGNAME': 'cltbld', 11:14:01 INFO - 'MAIL': '/var/mail/cltbld', 11:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:01 INFO - 'MOZ_NO_REMOTE': '1', 11:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:01 INFO - 'NO_EM_RESTART': '1', 11:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:01 INFO - 'PWD': '/builds/slave/test', 11:14:01 INFO - 'SHELL': '/bin/bash', 11:14:01 INFO - 'SHLVL': '1', 11:14:01 INFO - 'TERM': 'linux', 11:14:01 INFO - 'TMOUT': '86400', 11:14:01 INFO - 'USER': 'cltbld', 11:14:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:01 INFO - '_': '/tools/buildbot/bin/python'} 11:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:14:01 INFO - Running setup.py (path:/tmp/pip-XSunUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:14:01 INFO - Running setup.py (path:/tmp/pip-NZxvLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:14:02 INFO - Running setup.py (path:/tmp/pip-SKb8JM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:14:02 INFO - Running setup.py (path:/tmp/pip-p8JZhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:14:02 INFO - Running setup.py (path:/tmp/pip-txGY2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:14:02 INFO - Running setup.py (path:/tmp/pip-b3plvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:14:02 INFO - Running setup.py (path:/tmp/pip-M4Nc4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:14:02 INFO - Running setup.py (path:/tmp/pip-x_oRj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:14:02 INFO - Running setup.py (path:/tmp/pip-517nQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:14:02 INFO - Running setup.py (path:/tmp/pip-XUhqxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:14:02 INFO - Running setup.py (path:/tmp/pip-QCxqEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:14:02 INFO - Running setup.py (path:/tmp/pip-K4Yv74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:14:02 INFO - Running setup.py (path:/tmp/pip-nPpkGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:14:02 INFO - Running setup.py (path:/tmp/pip-bpOMYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:02 INFO - Running setup.py (path:/tmp/pip-8112B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:14:02 INFO - Running setup.py (path:/tmp/pip-jwAtr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:14:03 INFO - Running setup.py (path:/tmp/pip-3i3Uzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:14:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:14:04 INFO - Downloading blessings-1.6.tar.gz 11:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:14:05 INFO - Installing collected packages: blessings 11:14:05 INFO - Running setup.py install for blessings 11:14:05 INFO - Successfully installed blessings 11:14:05 INFO - Cleaning up... 11:14:05 INFO - Return code: 0 11:14:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:05 INFO - Reading from file tmpfile_stdout 11:14:05 INFO - Current package versions: 11:14:05 INFO - argparse == 1.2.1 11:14:05 INFO - blessings == 1.6 11:14:05 INFO - blobuploader == 1.2.4 11:14:05 INFO - docopt == 0.6.1 11:14:05 INFO - functools32 == 3.2.3-2 11:14:05 INFO - jsonschema == 2.5.1 11:14:05 INFO - manifestparser == 1.1 11:14:05 INFO - mozInstall == 1.12 11:14:05 INFO - mozcrash == 0.17 11:14:05 INFO - mozdebug == 0.1 11:14:05 INFO - mozdevice == 0.48 11:14:05 INFO - mozfile == 1.2 11:14:05 INFO - mozhttpd == 0.7 11:14:05 INFO - mozinfo == 0.9 11:14:05 INFO - mozleak == 0.1 11:14:05 INFO - mozlog == 3.3 11:14:05 INFO - moznetwork == 0.27 11:14:05 INFO - mozprocess == 0.23 11:14:05 INFO - mozprofile == 0.28 11:14:05 INFO - mozrunner == 6.12 11:14:05 INFO - mozscreenshot == 0.1 11:14:05 INFO - mozsystemmonitor == 0.3 11:14:05 INFO - moztest == 0.7 11:14:05 INFO - mozversion == 1.4 11:14:05 INFO - psutil == 3.1.1 11:14:05 INFO - requests == 1.2.3 11:14:05 INFO - wsgiref == 0.1.2 11:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:14:05 INFO - Using env: {'DISPLAY': ':0', 11:14:05 INFO - 'HOME': '/home/cltbld', 11:14:05 INFO - 'LANG': 'en_US.UTF-8', 11:14:05 INFO - 'LANGUAGE': 'en_US:en', 11:14:05 INFO - 'LOGNAME': 'cltbld', 11:14:05 INFO - 'MAIL': '/var/mail/cltbld', 11:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:05 INFO - 'MOZ_NO_REMOTE': '1', 11:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:05 INFO - 'NO_EM_RESTART': '1', 11:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:05 INFO - 'PWD': '/builds/slave/test', 11:14:05 INFO - 'SHELL': '/bin/bash', 11:14:05 INFO - 'SHLVL': '1', 11:14:05 INFO - 'TERM': 'linux', 11:14:05 INFO - 'TMOUT': '86400', 11:14:05 INFO - 'USER': 'cltbld', 11:14:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:05 INFO - '_': '/tools/buildbot/bin/python'} 11:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:14:05 INFO - Cleaning up... 11:14:05 INFO - Return code: 0 11:14:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:14:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xecb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:14:05 INFO - Using env: {'DISPLAY': ':0', 11:14:05 INFO - 'HOME': '/home/cltbld', 11:14:05 INFO - 'LANG': 'en_US.UTF-8', 11:14:05 INFO - 'LANGUAGE': 'en_US:en', 11:14:05 INFO - 'LOGNAME': 'cltbld', 11:14:05 INFO - 'MAIL': '/var/mail/cltbld', 11:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:05 INFO - 'MOZ_NO_REMOTE': '1', 11:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:05 INFO - 'NO_EM_RESTART': '1', 11:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:05 INFO - 'PWD': '/builds/slave/test', 11:14:05 INFO - 'SHELL': '/bin/bash', 11:14:05 INFO - 'SHLVL': '1', 11:14:05 INFO - 'TERM': 'linux', 11:14:05 INFO - 'TMOUT': '86400', 11:14:05 INFO - 'USER': 'cltbld', 11:14:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:05 INFO - '_': '/tools/buildbot/bin/python'} 11:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:14:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:14:05 INFO - Cleaning up... 11:14:05 INFO - Return code: 0 11:14:05 INFO - Running post-action listener: _resource_record_post_action 11:14:05 INFO - Running post-action listener: _start_resource_monitoring 11:14:05 INFO - Starting resource monitoring. 11:14:05 INFO - [mozharness: 2016-10-05 18:14:05.949614Z] Finished create-virtualenv step (success) 11:14:05 INFO - [mozharness: 2016-10-05 18:14:05.950050Z] Running install step. 11:14:05 INFO - Running pre-action listener: _resource_record_pre_action 11:14:05 INFO - Running main action method: install 11:14:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:14:06 INFO - Reading from file tmpfile_stdout 11:14:06 INFO - Detecting whether we're running mozinstall >=1.0... 11:14:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:14:06 INFO - Reading from file tmpfile_stdout 11:14:06 INFO - Output received: 11:14:06 INFO - Usage: mozinstall [options] installer 11:14:06 INFO - Options: 11:14:06 INFO - -h, --help show this help message and exit 11:14:06 INFO - -d DEST, --destination=DEST 11:14:06 INFO - Directory to install application into. [default: 11:14:06 INFO - "/builds/slave/test"] 11:14:06 INFO - --app=APP Application being installed. [default: firefox] 11:14:06 INFO - mkdir: /builds/slave/test/build/application 11:14:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:14:20 INFO - Reading from file tmpfile_stdout 11:14:20 INFO - Output received: 11:14:20 INFO - /builds/slave/test/build/application/firefox/firefox 11:14:20 INFO - Running post-action listener: _resource_record_post_action 11:14:20 INFO - [mozharness: 2016-10-05 18:14:20.841938Z] Finished install step (success) 11:14:20 INFO - [mozharness: 2016-10-05 18:14:20.842216Z] Running run-tests step. 11:14:20 INFO - Running pre-action listener: _resource_record_pre_action 11:14:20 INFO - Running main action method: run_tests 11:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:14:20 INFO - Python 2.7.3 11:14:20 INFO - Return code: 0 11:14:20 INFO - grabbing minidump binary from tooltool 11:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:14:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1189570>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118a470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118a900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:14:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:14:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:14:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:14:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:14:20 INFO - Return code: 0 11:14:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:14:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:14:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:14:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:14:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:14:20 INFO - Using env: {'DISPLAY': ':0', 11:14:20 INFO - 'HOME': '/home/cltbld', 11:14:20 INFO - 'LANG': 'en_US.UTF-8', 11:14:20 INFO - 'LANGUAGE': 'en_US:en', 11:14:20 INFO - 'LOGNAME': 'cltbld', 11:14:20 INFO - 'MAIL': '/var/mail/cltbld', 11:14:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:14:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:14:20 INFO - 'MOZ_NO_REMOTE': '1', 11:14:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:14:20 INFO - 'NO_EM_RESTART': '1', 11:14:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:14:20 INFO - 'PWD': '/builds/slave/test', 11:14:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:14:20 INFO - 'SHELL': '/bin/bash', 11:14:20 INFO - 'SHLVL': '1', 11:14:20 INFO - 'TERM': 'linux', 11:14:20 INFO - 'TMOUT': '86400', 11:14:20 INFO - 'USER': 'cltbld', 11:14:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112', 11:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:14:20 INFO - '_': '/tools/buildbot/bin/python'} 11:14:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:14:21 INFO - mozversion application_buildid: 20161005080800 11:14:21 INFO - mozversion application_changeset: dacddb224d32cd5f979fa4b53e702c7dc69be46c 11:14:21 INFO - mozversion application_display_name: Firefox 11:14:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:14:21 INFO - mozversion application_name: Firefox 11:14:21 INFO - mozversion application_remotingname: firefox 11:14:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:14:21 INFO - mozversion application_vendor: Mozilla 11:14:21 INFO - mozversion application_version: 50.0 11:14:21 INFO - mozversion platform_buildid: 20161005080800 11:14:21 INFO - mozversion platform_changeset: dacddb224d32cd5f979fa4b53e702c7dc69be46c 11:14:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:14:21 INFO - mozversion platform_version: 50.0 11:14:21 INFO - using testdate: 1475691261 11:14:21 INFO - actual date: 1475691261 11:14:21 INFO - starting webserver on 'localhost:39297' 11:14:21 INFO - SUITE-START | Running 2 tests 11:14:21 INFO - TEST-START | dromaeo_css 11:14:21 INFO - operating with platform_type : linux_ 11:14:21 INFO - Initialising browser for dromaeo_css test... 11:14:21 INFO - TEST-INFO | started process 10384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3bdxT6/profile http://localhost:39297/getInfo.html) 11:14:26 INFO - PROCESS | 10384 | __metrics Screen width/height:1600/1200 11:14:26 INFO - PROCESS | 10384 | colorDepth:24 11:14:26 INFO - PROCESS | 10384 | Browser inner width/height: 1024/697 11:14:26 INFO - PROCESS | 10384 | __metrics 11:14:27 ERROR - PROCESS | 10384 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 11:14:28 INFO - TEST-INFO | 10384: exit 0 11:14:28 INFO - Browser initialized. 11:14:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:14:28 INFO - TEST-INFO | started process 10513 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3bdxT6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:40 INFO - PROCESS | 10513 | RSS: Main: 150134784 11:14:40 INFO - PROCESS | 10513 | 11:15:29 INFO - PROCESS | 10513 | 1475691329763 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:17:38 INFO - PROCESS | 10513 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39297/tests/dromaeo/cssquery-ext.html) 11:17:39 INFO - PROCESS | 10513 | RSS: Main: 158650368 11:17:39 INFO - PROCESS | 10513 | 11:20:41 INFO - PROCESS | 10513 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-ext.html (next: http://localhost:39297/tests/dromaeo/cssquery-jquery.html) 11:20:41 INFO - PROCESS | 10513 | RSS: Main: 155160576 11:20:41 INFO - PROCESS | 10513 | 11:23:43 INFO - PROCESS | 10513 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39297/tests/dromaeo/cssquery-mootools.html) 11:23:44 INFO - PROCESS | 10513 | RSS: Main: 154943488 11:23:44 INFO - PROCESS | 10513 | 11:26:46 INFO - PROCESS | 10513 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39297/tests/dromaeo/cssquery-prototype.html) 11:26:46 INFO - PROCESS | 10513 | RSS: Main: 157118464 11:26:46 INFO - PROCESS | 10513 | 11:29:48 INFO - PROCESS | 10513 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39297/tests/dromaeo/cssquery-yui.html) 11:29:49 INFO - PROCESS | 10513 | RSS: Main: 157892608 11:29:49 INFO - PROCESS | 10513 | 11:32:51 INFO - PROCESS | 10513 | Cycle 1(1): loaded http://localhost:39297/tests/dromaeo/cssquery-yui.html (next: http://localhost:39297/tests/dromaeo/cssquery-dojo.html) 11:32:52 INFO - PROCESS | 10513 | RSS: Main: 157151232 11:32:52 INFO - PROCESS | 10513 | 11:32:52 INFO - PROCESS | 10513 | __start_tp_report 11:32:52 INFO - PROCESS | 10513 | _x_x_mozilla_page_load 11:32:52 INFO - PROCESS | 10513 | _x_x_mozilla_page_load_details 11:32:52 INFO - PROCESS | 10513 | |i|pagename|runs| 11:32:52 INFO - PROCESS | 10513 | |0;dojo.html;3294.9341013179737;3312.917177070573;3322.5348451216832;3341.1480072581503;3352.178716214528;5680;5684;5713.885722285552;5757.510611598009;5772.971135144324;5770.480656740892;5834.21238132852;5850.590458667884;5869.911951320723;5875.236219291497;5239.86900327492;5314.893702125955;5328.094223981913;5344.973275133639;5357.812476563321;5350.946490535103;5365.597580181482;5366.731663416833;5368.194770784375;5408.4591540845795;5141.254518094874;5155.252488389181;5340.225667278242;5348.812791552277;5352.063388906945;5176.948230517684;5249.343832020997;5269.104252277122;5271.973640131813;5287.735613219362;5202.4537423570355;5206.5314121729225;5230.476952304777;5241.921371179397;5252.212168174766;5595.664260144405;5649.152627105926;5691.601587888849;5716.971415142939;5807.5644326675665;6122.032243765652;6216.067589861512;6230.034344676583;6230.252369715663;6244.843878903019;6234.127222188898;6240.500759939194;6240.719167637467;6242.500599952038;6255;5580.386157522669;5720.313562372458;5802.883942321172;5825.242718446617;5853.678047707374;6269.905951410732;6352.777652782131;6363.395477429637;6367.840803979938;6368.808935731936;6095.939040609625;6102.0541816018585;6136.754529818846;6149;6149.600275982137;6059;6065.363136870565;6166;6211.9068213976825;6232.968835155886;6092.39076092396;6196.535259855529;6221.502279817604;6224.9377506224355;6241.126242326078;6171.074338849208;6181.907271390933;6190.442860142519;6196.597221180699;6225.28409232944;4645.326427668037;4647.767611619473;4757.405324334458;4758.5241475852135;4779.856604301876;4132.2561938851295;4182.330827067715;4196.2027214829695;4207.621314081747;4221.366794980778;5961.165436838846;5968.343482216953;5969.403059693996;5976.073708575178;5979.308524150858;6075.969620151959;6086.482648974798;6183.628982261079;6190.473809726223;6193.318734939153;5837;5939.346671866091;5961.523078153824;5962.37395073511;6003.399660034049;5296.947030529645;5298.841034768963;5319.893602127936;5331.067063263913;5342.198670199501;6012.909806352908;6207.534434917399;6215.223097112861;6252.74989000444;6305.684715764193;6316.431521163117;6324.873502530016;6336.7465301389275;6340.30256671775;6352.618842869442;6349.460295874717;6384.521160912857;6403.2316122063785;6405.967970160119;6406.519511036598;5825.854353641193;6054.666993315233;6099.268087829489;6147.262328520606;6197.783077592263;6262.3111457738705;6264.843378915381;6302;6317.336679648571;6322.810315690536;6113.816585502442;6118.112873633388;6143.354947730424;6161.4146656067605;6162.291336496181;5830.82507524775;5913.053911374332;5920.111983202554;6135.601185922901;6157.84605384869;5894.351621321565;5920.2895652521975;5977.5217982560425;5978.551608629457;5988.490978266722;6034.336223015553;6056.878862422815;6088.056351265561;6100.054491553817;6134.846628834136;5851.9173952818865;5866.794662186803;5941.821745347646;5972.731227094878;5984.13230081627 11:32:52 INFO - PROCESS | 10513 | |1;ext.html;592.2478452365496;632.936706329367;645.1355184053367;657.4674513643947;709.6451774112943;43976;47476.525234747685;47917;48004;48047;47825;48411.75794121033;48488.27267590989;48567.75716121415;48605.75697121518;8912.01967783545;9122.22461090808;9122.452652840817;9124.498152601604;9124.635014599442;8969.416987895765;9035.954820225923;9060.456372617631;9072.727818165433;9074.59164337603;9063;9065.728028159167;9089.818203635923;9139.360244782867;9151.130642588943;8971.865422018642;9015.098490150998;9022.188003079722;9105.36262461628;9108.089191080906;9007.864882026775;9064.728058158265;9110.453372797654;9113.681021164228;9114.680986165453;44881.55118448806;45143.54856451426;45231.54768452339;45367;45417.77291113523;3830.578636349999;4007.198560287954;4032.038088625475;4073.3279008963486;4074.0222346636892;36291.27417451663;36574.817125914204;36624.81687591572;37060.814695926616;38398;4707.293905914106;4715.245560710304;4720.669553131283;4743.810247590092;4796.640251981081;401604;407757;408516;409137.9543102295;409706;39752.80123599363;40585;67699.32300676931;68101;68101.31898681048;40023.599764001985;40195.59804401977;40289;40297.59702402997;40347;16203.270852811651;16353.182340883146;16372.181390930406;16381.918090409472;16382.508524744277;14475.49335773264;14520.273986300643;14586.4894728684;14673.486427975184;14708.705825883422;9570.473623950611;9571;9582.56526134265;9591.328606997582;9622.855657165148;3543.6257707336144;3554.43129099348;3625.329314076904;3636.4363523653874;3663.3440755452084;1110.3171549497001;1150.930944143354;1214.987850121505;1223.247702662856;1246.6322434881731;34761.478577821355;34778.478322825176;34947.4757878632;35080.47379289313;35329.82335088308;1161.8838116188313;1180.695331658522;1182.148852825964;1191.5531675621642;1285.1261142423054;18222.362217322596;18256.178471968793;18257.269709211483;18410.539736506427;18437.26250949974;598574;599322;599852;605569;606069;65515;65530;65926.67036664882;65993;66319.66840165768;1434.3868906685896;1447.6887469193964;1453.4622189789845;1475.6532214929482;1502.8046353973914;33297.66702332946;33342;33496.497552536246;33881.32237355288;33960;58987.41012589819;67833;70124.29875701178;70166.29833701802;70259.64870175616;562170;562935;566844;568280;574017;48770.26844597405;49569.25646115239;49702;49803.501964979885;49831.501684982686;54697.453025469236;55386.44613553974;55526.16710749261;55548.444515555944;55685;46946.765266173454;47281.52718472771;47789.56631301066;47972.52027479681;48600.513994861016;47314;47742.52257477381;47920.2811957814;48344.516554834;48852.5114748848;45531.54468455273;46041.53958460373;46551.76724116358;46630.76684616691;49119.754401227765;39751.80124099361;40825.795871020455;41011.384829228184;41027;41416;30183.547246791753;30470.019448736646;30685.23286917845;30809.845950771;31163 11:32:52 INFO - PROCESS | 10513 | |2;jquery.html;421.2228438530909;430.66838534328565;433.36944745395454;435.72549293944815;444.2514363297843;18853;19489.707654385176;20226.89886550567;20625.1749930003;20681.689774653354;19618.60762784747;19741.309054183108;20118.59762804743;20493.4876628084;20702.378928632126;5813.6802475863915;6020.909686354708;6021.09683547467;6029.427204415573;6036.577439579231;5866.325372582143;5883.8529036774;5936.7328470218945;5937.495312898409;5994.130851026599;5887.823365299027;5903.173555702205;5908.261467316585;5923.674197919113;5946.583739138262;5771.220885180489;5876.353601103875;5877.764889404419;5902.822915312548;5906.497947674453;5327.30745003151;5333;5336.039512887679;5347.438518955492;5349.037173308803;23915.402114947265;24257.636135457982;24573.262802115965;24663.136790212437;24935.87532062346;2616.2282126772648;2637.4988752137033;2652.814302998791;2715.823471474348;2770.667519897605;15247;15374.846251537454;15439.304222792478;15735.370585176579;16057.357705691875;2051.241040814893;2159.865713988614;2174.695542624018;2209.2267706302664;2219.7336319641745;78290.60854695748;80174;80189.19810801875;80685;91907.54046229726;11423.771524569629;11893.34586597728;11981.46083426248;12054.41932065827;12199.39003049844;17166.31334746621;17204.65590688179;17205.7419138713;17249.827501725074;17261.65476690459;9119.544022798833;9224.446533207894;9315.161635452841;9363.531823408803;9390.85913711295;8884.067172946747;9060.411073280216;9110.453372797521;9122;9240.95379523098;5147.948520514822;5173.611979101583;5196.142636465017;5210.062188805976;5260.184671375943;2075.858277947123;2156.13754498202;2164.9567008660056;2168.316980151279;2174.1955476473804;980.5587485631495;1049.532957833772;1056.1234175634206;1096.8848270931596;1144.8855114488485;20512.58974820495;20528.58942821135;20630.27794027202;20722.79277207239;21391.46521336948;1007.778288776468;1011.7318910488726;1014.3001329083056;1053.5417093564172;1065.925385223027;10806.621768238074;11333.886661133283;11380.829287560693;11420.543178272943;11523.48144333507;523099;549328;553831;560119;570850;88021.84096555888;95769.52115239379;100272;100735;101351.4932425348;980.2011360740973;1075.3762817565948;1088.276296262992;1090.4820210400155;1096.1669131460148;17963;18177.272909083487;18642;18861.434156975312;18902.338418155297;34170.48744268788;44709.329360058975;45112;45383.092338153714;45882.31176532288;64501.677491612245;64627;64883.67558162179;65298.34701653113;65616.67191664012;8580;8708.73873783762;8750.562471876254;8755.430896991675;9037.322200834833;10983.340999540053;13044.608661740163;14081.577552673436;14261.358238879482;14532.346044428237;12278.324692142018;12291.69270768238;12545.560905368267;12897.935510322388;12998.610041698765;12057.035437165181;12236.388180590757;12490.625281241577;12529.93735031319;12643;12764.2341459509;12961.41673624708;13081.149725267827;13159.60521184366;13215;8245.340372770044;8558.358123140664;8885.600147993226;8956.955215223883;9244.861327079965;9491.38306010107;11493.138014648768;11831.763364732486;12418.875811241773;12458.813117803422 11:32:52 INFO - PROCESS | 10513 | |3;mootools.html;1573.1347758732695;1589.5867074560613;1783.589774351899;1881.1628825172804;1883.0396497786126;9531.952340238298;9783.364081334708;10083.848742268872;10288.897111028888;10334.121599664019;9731.854022189673;9815.165710914564;9875.75310617235;9887.555060022298;9911.851322230154;2515.006572403904;2555.3356127406914;2561.9231423057245;2563.115725074846;2567.1271767599014;2473.863937483438;2542.2627438042946;2545.7072436669837;2546.401595625027;2547.121243171103;2501.7248102708686;2502.27434044127;2518.5970244760842;2523.1673547729297;2527.0523553667376;2439.9756002439926;2449.0571130114945;2458;2460.052879641333;2482.5779617465073;2450.3996520852506;2475.356407334088;2476.120977053138;2489.5269898719366;2506.2105436787538;10000.099991000845;10108.898911010943;10117.645882394154;10162.542685579092;10166.13587845034;5555.083411237141;5676.290463692038;5704.828855134353;5717.285339332583;5732.942670573324;3423.606285277175;3479.512868198429;3541.5041894134843;3556.05764472415;3583.283343331318;1176.3765204441659;1332.4004198110888;1351.72965406919;2358.2217868103485;2398.59223931932;13982.510612128526;14209.786853197107;14224;14256.572302830828;14300.070495417765;4617.238155704338;4654.767261636905;4778.354922085474;4797.856064318076;4902.779374928136;11036.889631103746;11043.39261340634;11050.613228536962;11052.115830733523;11083.445827708581;5611.971940140274;5657.12314591239;5676.318841739017;5691.800786972436;5695.800646977336;5041.117804384218;5151.5106064923775;5187.325647665854;5210.5831533477985;5330.866728331823;4301.354796780508;4356.302991521405;4405.581469760367;4474.7762611869275;4478.305862591304;1341.4634146341346;1390.9026368154132;1392.7841184616198;1409.7039621679357;1421.9289035548181;959.8656188133527;1060.098915921476;1069.6790962711154;1073.2004656530778;1083.111848284415;6319;6449.645269510128;6632.403083722488;6634.800955971328;6663.733450661919;453.67108846086325;461.98614041578804;475.3701345716939;502.6933570521979;503.23257033024197;4503.819847206075;4505.459344878635;4553.772311384484;4599.839005634787;4658.976705116453;12221.877781222252;12236.938815305866;12546.05904557162;12569.811452828215;12579.496820127275;12453.93773031129;12468.127231093737;12489.93755031219;12505.812412813815;12512.374381280899;9078.90921090794;9168.312376571785;9172.403793753385;9229.261659067259;9285.210757085724;6305.527085468517;6343.111964324906;6469.611823290617;6509.609423434609;6566.9343306566325;10286.794264114526;10587.947060264649;11267.887321127011;11268;11381.374024428736;10690.465476726287;10943;11002;11008.119350452105;11052.502637381176;8024.398170137147;8513.914860851311;8676.479411235347;8735.868961965703;8927.375083744075;9631.614735410505;9729.805403892024;9730.708078757649;9735.659251926148;9746.463944483121;8240.464369815943;8387.077421483755;8467.745967620735;8483.363747718822;8530.70142545008;8580.227779499875;8583.871241931502;8588.441751286146;8663.566821658766;8775.956120219358;7216.71133154689;7245.891311630435;7261.72919739033;7281.381082608038;7288.854222915618;5642.520385767091;5717.285339332583;5911.320198177093;5932.436418540232;5932.79235226765;5562.332520097614;5676.318841739017;5717.371089180104;5775.768969241351;5813.563982701399 11:32:52 INFO - PROCESS | 10513 | |4;prototype.html;340.49266592776763;349.9770142215235;366.92844895245423;371.34828376199766;375.12595652130557;5737.196792449061;5771.942280577193;5813.622114562556;5814.970925145379;5840.474357307841;5583.58123140765;5675.921574900766;5718.971405142968;5745.741441635126;5754.280714910637;4425.933610995838;4441.289393697001;4452.443444569429;4461.219286624844;4471.88820279494;4435.223835828733;4443.84446544371;4447.155040542287;4480.305552639346;4483.4843992940905;4441.866743997685;4456.8885777855485;4464.174127786354;4465.598096171344;4495.865124046284;4321.385561735136;4400.713953593006;4417.586372360845;4431.534688857656;4434.201843668122;3964.6630036446936;3965.2466031453932;3982.4424580558743;3984.7609143451486;3987.182627561372;5534.225208470817;5559.610827242094;5562.7774889004395;5584.4136365681425;5605.803796867131;5025.592834006484;5139.948600514022;5156.664816786897;5180.870478238075;5188.429272779991;5956.927753004457;5962.463378295931;5979.13001759158;6060.272767267912;6075.635461872258;4327.896386421474;4426.535213802536;4445.199864024475;4447.3996010538485;4455.8217671293105;6075.9696201519155;6194.938050619481;6210.378962103753;6265.310815810257;6290.3709629037185;4405.118976204772;4425.336199570091;4437.2234858899565;4470.597646211857;4481.260592002348;4516.616087632522;4519.661025423106;4536.750478723702;4540.6821522493765;4556.270996640522;5088.694678319239;5099.413567439792;5152;5192.584593232532;5227.58179345659;6058.1518587397795;6059.030555111161;6070.119832624245;6090.33006369299;6136.8772624547255;1544.3282172255106;1557.7819105325264;1561.2584022589178;1570.6858628274163;1579.289319806069;969.6654654144309;1004.7136566078633;1014.4369874719454;1018.9796204076025;1029.939162662444;5128.692278463304;5204.698825293676;5208.5312321891215;5230.843074707765;5250.7374631268285;5482.862928426742;5486.231927530149;5498.285222920995;5500.28496295487;5514.393416724157;4855.32956873718;5215.852512447255;5233.39815921174;5275.841724748264;5277.20841873722;2907.5431260584774;2912.694167112465;2929.61914951055;2929.7070292970957;2932.501474749298;5449.536789372948;5482.259894914216;5483.670979741229;5485.725713714378;5489.972550137303;5922.3485416604135;6344.842753463752;6368.10846481493;6372.769530664231;6447.3552644735155;6366.904496432558;6374.330695277022;6375.458086062644;6393.968030159819;6400.7198560288125;6033.948457524462;6229.781957631461;6274.749010039547;6299.181106456314;6372.904406433814;6183.96908015457;6184.969075154595;6249.718762655601;6283.7800676976085;6289.213848268966;6157.538184636081;6276.748930042747;6277.71750271248;6300.21247344082;6308.0667489617545;4344.109457561256;4377.956220437755;4386.210482113251;4389.473263208435;4423.314386270134;6222.253329600477;6254.468370188585;6256.122183795505;6375.458086062551;6379.202599675041;6131.54013449002;6134.754609815557;6209.130721698875;6213.285472170758;6255.343188965093;5994.890945175157;6093.507090762791;6206.665566903138;6208.50331973432;6268.498520118288;6067.30005147705;6089.360617135314;6091.238595175603;6095.725692343766;6100.23747031621;6188.133661287334;6213.96893015532;6232.25212974446;6253.5622506424115;6254.781082662085;5808.854778630399;5907.822765317047;5958.940410595838;6015.699215039143;6020.819375418744 11:32:52 INFO - PROCESS | 10513 | |5;yui.html;820.6758330459472;829.1832544943234;848.1772680499913;897.8967418746845;915.9084091590842;15999.760003599955;17077.23152458139;17738.02440865755;17824.287028518844;18080.81919180811;16423.507294781175;16516.83483165168;16570.42003529877;16586.419475318366;16710.749338759928;874.1608056265992;879.3317079019959;896.157611844867;902.0438335364502;903.1420150856679;896.0815164456419;898.9056149104348;899.851524498457;900.5632268349846;900.779309069279;914.89021317442;930.1163894300441;930.6044930904338;931.2317338195982;937.6015193542751;915.1900567997304;923.612082925173;924.6994726713812;925.8379783537888;926.2266007883392;685.7051467868814;688.102026854954;688.4801974509263;688.9552179108392;691.3950293493193;16546.089965051917;16711.164441777983;16716.74924876128;16721.91639041797;16722.08028558429;15532.689346213125;15609.609759755984;15694.215289235606;15718.37126514938;15868.52394428169;12811.359432028454;12936.482540698455;13072.738545229042;13203.801942970864;13489.797653035212;4042.1309418474875;4055.1686904184867;4079.9592004080173;4086.4074709167303;4126.546079931205;92575;95093.52453237689;96046;96638;97162.5141874286;11355.148363872742;11401.429928503541;11820.23168494045;11843.526258949545;12154.939225303817;23452.765472345058;23764.405889852893;23779.048838046285;23810;23831.7616823833;8489.490630562186;8528.317734581218;8597;8758;9173.58718857653;4945.752712364368;4962.379702537183;4994.850154495298;5123.641345105882;5188.533032027136;3928.4107383892647;4036.1322315702264;4039.0912044790275;4050.1899620075515;4073.551909289976;609.1867357078262;627.5011365964069;631.5863109663086;638.2149955554694;649.9892666903012;707.3598393453932;782.7025730222479;837.3050368194506;844.9915500845036;855.8331125430482;10516.474176291307;10836.59163060598;10900.672979810619;11003.724906877393;11147.777044459228;631.9557630965788;770.8805135204052;832.3341326938425;832.7834762961553;844.2823599940125;5012.223105418666;5307.28351672527;5370.62405631602;5378.784848606012;5389.595780316492;72318.63840680868;73560;73606.63196683982;73802.26197738061;76815.61592192003;114580.42709786398;115158;117931;118308;118386;56140.157897631565;59973.700131499936;102815.48592256842;103370.48314758528;105478.47260763648;9896.554655040396;10118.836333821704;10153;10198.33710808795;10202.744931376776;44560.77719611381;49259.50740492549;58247;58747.41252587419;59930.10104848518;73876.26123738693;76764.23235767795;80212.19787802047;80294.598527007;81093.94292341177;13954.860451395762;14411.063280886709;14449.566513004627;14647.487337943121;14709.411623535367;15812.76280855765;15976.520704378887;16253.837461625233;16291.59271018234;16467.83532164663;14890.404383824525;15076.773848392064;15384.538970456704;15385.84614153844;15689.29398177062;14248.643783905485;15063.183657160158;15202.695946081238;15327.310271037608;15354.385824567338;14393.568192954228;14639.48761793332;14780.260986950825;14879.62800929942;14912.328945197709;11262;11698.532058717556;11706;11797.410129493663;12506.437210325375;12767.93616031914;12929.870701293243;12998.80501792455;13126.738339084073;13305.401256943267 11:32:52 INFO - PROCESS | 10513 | __end_tp_report 11:32:52 INFO - PROCESS | 10513 | __start_cc_report 11:32:52 INFO - PROCESS | 10513 | _x_x_mozilla_cycle_collect,329 11:32:52 INFO - PROCESS | 10513 | __end_cc_report 11:32:52 INFO - PROCESS | 10513 | __startTimestamp1475692372000__endTimestamp 11:32:52 INFO - PROCESS | 10513 | 11:32:52 INFO - PROCESS | 10513 | ------- Summary: start ------- 11:32:52 INFO - PROCESS | 10513 | Number of tests: 6 11:32:52 INFO - PROCESS | 10513 | 11:32:52 INFO - PROCESS | 10513 | [#0] dojo.html Cycles:165 Average:5753.93 Median:5976.07 stddev:659.33 (11.0%) stddev-sans-first:632.51 11:32:52 INFO - PROCESS | 10513 | Values: 3294.9 3312.9 3322.5 3341.1 3352.2 5680.0 5684.0 5713.9 5757.5 5773.0 5770.5 5834.2 5850.6 5869.9 5875.2 5239.9 5314.9 5328.1 5345.0 5357.8 5350.9 5365.6 5366.7 5368.2 5408.5 5141.3 5155.3 5340.2 5348.8 5352.1 5176.9 5249.3 5269.1 5272.0 5287.7 5202.5 5206.5 5230.5 5241.9 5252.2 5595.7 5649.2 5691.6 5717.0 5807.6 6122.0 6216.1 6230.0 6230.3 6244.8 6234.1 6240.5 6240.7 6242.5 6255.0 5580.4 5720.3 5802.9 5825.2 5853.7 6269.9 6352.8 6363.4 6367.8 6368.8 6095.9 6102.1 6136.8 6149.0 6149.6 6059.0 6065.4 6166.0 6211.9 6233.0 6092.4 6196.5 6221.5 6224.9 6241.1 6171.1 6181.9 6190.4 6196.6 6225.3 4645.3 4647.8 4757.4 4758.5 4779.9 4132.3 4182.3 4196.2 4207.6 4221.4 5961.2 5968.3 5969.4 5976.1 5979.3 6076.0 6086.5 6183.6 6190.5 6193.3 5837.0 5939.3 5961.5 5962.4 6003.4 5296.9 5298.8 5319.9 5331.1 5342.2 6012.9 6207.5 6215.2 6252.7 6305.7 6316.4 6324.9 6336.7 6340.3 6352.6 6349.5 6384.5 6403.2 6406.0 6406.5 5825.9 6054.7 6099.3 6147.3 6197.8 6262.3 6264.8 6302.0 6317.3 6322.8 6113.8 6118.1 6143.4 6161.4 6162.3 5830.8 5913.1 5920.1 6135.6 6157.8 5894.4 5920.3 5977.5 5978.6 5988.5 6034.3 6056.9 6088.1 6100.1 6134.8 5851.9 5866.8 5941.8 5972.7 5984.1 11:32:52 INFO - PROCESS | 10513 | 11:32:52 INFO - PROCESS | 10513 | [#1] ext.html Cycles:180 Average:69240.30 Median:26001.10 stddev:141568.83 (544.5%) stddev-sans-first:141872.14 11:32:52 INFO - PROCESS | 10513 | Values: 592.2 632.9 645.1 657.5 709.6 43976.0 47476.5 47917.0 48004.0 48047.0 47825.0 48411.8 48488.3 48567.8 48605.8 8912.0 9122.2 9122.5 9124.5 9124.6 8969.4 9036.0 9060.5 9072.7 9074.6 9063.0 9065.7 9089.8 9139.4 9151.1 8971.9 9015.1 9022.2 9105.4 9108.1 9007.9 9064.7 9110.5 9113.7 9114.7 44881.6 45143.5 45231.5 45367.0 45417.8 3830.6 4007.2 4032.0 4073.3 4074.0 36291.3 36574.8 36624.8 37060.8 38398.0 4707.3 4715.2 4720.7 4743.8 4796.6 401604.0 407757.0 408516.0 409138.0 409706.0 39752.8 40585.0 67699.3 68101.0 68101.3 40023.6 40195.6 40289.0 40297.6 40347.0 16203.3 16353.2 16372.2 16381.9 16382.5 14475.5 14520.3 14586.5 14673.5 14708.7 9570.5 9571.0 9582.6 9591.3 9622.9 3543.6 3554.4 3625.3 3636.4 3663.3 1110.3 1150.9 1215.0 1223.2 1246.6 34761.5 34778.5 34947.5 35080.5 35329.8 1161.9 1180.7 1182.1 1191.6 1285.1 18222.4 18256.2 18257.3 18410.5 18437.3 598574.0 599322.0 599852.0 605569.0 606069.0 65515.0 65530.0 65926.7 65993.0 66319.7 1434.4 1447.7 1453.5 1475.7 1502.8 33297.7 33342.0 33496.5 33881.3 33960.0 58987.4 67833.0 70124.3 70166.3 70259.6 562170.0 562935.0 566844.0 568280.0 574017.0 48770.3 49569.3 49702.0 49803.5 49831.5 54697.5 55386.4 55526.2 55548.4 55685.0 46946.8 47281.5 47789.6 47972.5 48600.5 47314.0 47742.5 47920.3 48344.5 48852.5 45531.5 46041.5 46551.8 46630.8 49119.8 39751.8 40825.8 41011.4 41027.0 41416.0 30183.5 30470.0 30685.2 30809.8 31163.0 11:32:52 INFO - PROCESS | 10513 | 11:32:52 INFO - PROCESS | 10513 | [#2] jquery.html Cycles:180 Average:31735.26 Median:24086.52 stddev:90741.07 (376.7%) stddev-sans-first:90965.16 11:32:52 INFO - PROCESS | 10513 | Values: 421.2 430.7 433.4 435.7 444.3 18853.0 19489.7 20226.9 20625.2 20681.7 19618.6 19741.3 20118.6 20493.5 20702.4 5813.7 6020.9 6021.1 6029.4 6036.6 5866.3 5883.9 5936.7 5937.5 5994.1 5887.8 5903.2 5908.3 5923.7 5946.6 5771.2 5876.4 5877.8 5902.8 5906.5 5327.3 5333.0 5336.0 5347.4 5349.0 23915.4 24257.6 24573.3 24663.1 24935.9 2616.2 2637.5 2652.8 2715.8 2770.7 15247.0 15374.8 15439.3 15735.4 16057.4 2051.2 2159.9 2174.7 2209.2 2219.7 78290.6 80174.0 80189.2 80685.0 91907.5 11423.8 11893.3 11981.5 12054.4 12199.4 17166.3 17204.7 17205.7 17249.8 17261.7 9119.5 9224.4 9315.2 9363.5 9390.9 8884.1 9060.4 9110.5 9122.0 9241.0 5147.9 5173.6 5196.1 5210.1 5260.2 2075.9 2156.1 2165.0 2168.3 2174.2 980.6 1049.5 1056.1 1096.9 1144.9 20512.6 20528.6 20630.3 20722.8 21391.5 1007.8 1011.7 1014.3 1053.5 1065.9 10806.6 11333.9 11380.8 11420.5 11523.5 523099.0 549328.0 553831.0 560119.0 570850.0 88021.8 95769.5 100272.0 100735.0 101351.5 980.2 1075.4 1088.3 1090.5 1096.2 17963.0 18177.3 18642.0 18861.4 18902.3 34170.5 44709.3 45112.0 45383.1 45882.3 64501.7 64627.0 64883.7 65298.3 65616.7 8580.0 8708.7 8750.6 8755.4 9037.3 10983.3 13044.6 14081.6 14261.4 14532.3 12278.3 12291.7 12545.6 12897.9 12998.6 12057.0 12236.4 12490.6 12529.9 12643.0 12764.2 12961.4 13081.1 13159.6 13215.0 8245.3 8558.4 8885.6 8957.0 9244.9 9491.4 11493.1 11831.8 12418.9 12458.8 11:32:52 INFO - PROCESS | 10513 | 11:32:52 INFO - PROCESS | 10513 | [#3] mootools.html Cycles:180 Average:6417.16 Median:4476.54 stddev:3736.74 (83.5%) stddev-sans-first:3729.49 11:32:52 INFO - PROCESS | 10513 | Values: 1573.1 1589.6 1783.6 1881.2 1883.0 9532.0 9783.4 10083.8 10288.9 10334.1 9731.9 9815.2 9875.8 9887.6 9911.9 2515.0 2555.3 2561.9 2563.1 2567.1 2473.9 2542.3 2545.7 2546.4 2547.1 2501.7 2502.3 2518.6 2523.2 2527.1 2440.0 2449.1 2458.0 2460.1 2482.6 2450.4 2475.4 2476.1 2489.5 2506.2 10000.1 10108.9 10117.6 10162.5 10166.1 5555.1 5676.3 5704.8 5717.3 5732.9 3423.6 3479.5 3541.5 3556.1 3583.3 1176.4 1332.4 1351.7 2358.2 2398.6 13982.5 14209.8 14224.0 14256.6 14300.1 4617.2 4654.8 4778.4 4797.9 4902.8 11036.9 11043.4 11050.6 11052.1 11083.4 5612.0 5657.1 5676.3 5691.8 5695.8 5041.1 5151.5 5187.3 5210.6 5330.9 4301.4 4356.3 4405.6 4474.8 4478.3 1341.5 1390.9 1392.8 1409.7 1421.9 959.9 1060.1 1069.7 1073.2 1083.1 6319.0 6449.6 6632.4 6634.8 6663.7 453.7 462.0 475.4 502.7 503.2 4503.8 4505.5 4553.8 4599.8 4659.0 12221.9 12236.9 12546.1 12569.8 12579.5 12453.9 12468.1 12489.9 12505.8 12512.4 9078.9 9168.3 9172.4 9229.3 9285.2 6305.5 6343.1 6469.6 6509.6 6566.9 10286.8 10587.9 11267.9 11268.0 11381.4 10690.5 10943.0 11002.0 11008.1 11052.5 8024.4 8513.9 8676.5 8735.9 8927.4 9631.6 9729.8 9730.7 9735.7 9746.5 8240.5 8387.1 8467.7 8483.4 8530.7 8580.2 8583.9 8588.4 8663.6 8776.0 7216.7 7245.9 7261.7 7281.4 7288.9 5642.5 5717.3 5911.3 5932.4 5932.8 5562.3 5676.3 5717.4 5775.8 5813.6 11:32:52 INFO - PROCESS | 10513 | 11:32:52 INFO - PROCESS | 10513 | [#4] prototype.html Cycles:180 Average:5019.58 Median:5494.13 stddev:1487.19 (27.1%) stddev-sans-first:1449.30 11:32:52 INFO - PROCESS | 10513 | Values: 340.5 350.0 366.9 371.3 375.1 5737.2 5771.9 5813.6 5815.0 5840.5 5583.6 5675.9 5719.0 5745.7 5754.3 4425.9 4441.3 4452.4 4461.2 4471.9 4435.2 4443.8 4447.2 4480.3 4483.5 4441.9 4456.9 4464.2 4465.6 4495.9 4321.4 4400.7 4417.6 4431.5 4434.2 3964.7 3965.2 3982.4 3984.8 3987.2 5534.2 5559.6 5562.8 5584.4 5605.8 5025.6 5139.9 5156.7 5180.9 5188.4 5956.9 5962.5 5979.1 6060.3 6075.6 4327.9 4426.5 4445.2 4447.4 4455.8 6076.0 6194.9 6210.4 6265.3 6290.4 4405.1 4425.3 4437.2 4470.6 4481.3 4516.6 4519.7 4536.8 4540.7 4556.3 5088.7 5099.4 5152.0 5192.6 5227.6 6058.2 6059.0 6070.1 6090.3 6136.9 1544.3 1557.8 1561.3 1570.7 1579.3 969.7 1004.7 1014.4 1019.0 1029.9 5128.7 5204.7 5208.5 5230.8 5250.7 5482.9 5486.2 5498.3 5500.3 5514.4 4855.3 5215.9 5233.4 5275.8 5277.2 2907.5 2912.7 2929.6 2929.7 2932.5 5449.5 5482.3 5483.7 5485.7 5490.0 5922.3 6344.8 6368.1 6372.8 6447.4 6366.9 6374.3 6375.5 6394.0 6400.7 6033.9 6229.8 6274.7 6299.2 6372.9 6184.0 6185.0 6249.7 6283.8 6289.2 6157.5 6276.7 6277.7 6300.2 6308.1 4344.1 4378.0 4386.2 4389.5 4423.3 6222.3 6254.5 6256.1 6375.5 6379.2 6131.5 6134.8 6209.1 6213.3 6255.3 5994.9 6093.5 6206.7 6208.5 6268.5 6067.3 6089.4 6091.2 6095.7 6100.2 6188.1 6214.0 6232.3 6253.6 6254.8 5808.9 5907.8 5958.9 6015.7 6020.8 11:32:52 INFO - PROCESS | 10513 | 11:32:52 INFO - PROCESS | 10513 | [#5] yui.html Cycles:180 Average:21538.44 Median:4046.16 stddev:30055.86 (742.8%) stddev-sans-first:30099.92 11:32:52 INFO - PROCESS | 10513 | Values: 820.7 829.2 848.2 897.9 915.9 15999.8 17077.2 17738.0 17824.3 18080.8 16423.5 16516.8 16570.4 16586.4 16710.7 874.2 879.3 896.2 902.0 903.1 896.1 898.9 899.9 900.6 900.8 914.9 930.1 930.6 931.2 937.6 915.2 923.6 924.7 925.8 926.2 685.7 688.1 688.5 689.0 691.4 16546.1 16711.2 16716.7 16721.9 16722.1 15532.7 15609.6 15694.2 15718.4 15868.5 12811.4 12936.5 13072.7 13203.8 13489.8 4042.1 4055.2 4080.0 4086.4 4126.5 92575.0 95093.5 96046.0 96638.0 97162.5 11355.1 11401.4 11820.2 11843.5 12154.9 23452.8 23764.4 23779.0 23810.0 23831.8 8489.5 8528.3 8597.0 8758.0 9173.6 4945.8 4962.4 4994.9 5123.6 5188.5 3928.4 4036.1 4039.1 4050.2 4073.6 609.2 627.5 631.6 638.2 650.0 707.4 782.7 837.3 845.0 855.8 10516.5 10836.6 10900.7 11003.7 11147.8 632.0 770.9 832.3 832.8 844.3 5012.2 5307.3 5370.6 5378.8 5389.6 72318.6 73560.0 73606.6 73802.3 76815.6 114580.4 115158.0 117931.0 118308.0 118386.0 56140.2 59973.7 102815.5 103370.5 105478.5 9896.6 10118.8 10153.0 10198.3 10202.7 44560.8 49259.5 58247.0 58747.4 59930.1 73876.3 76764.2 80212.2 80294.6 81093.9 13954.9 14411.1 14449.6 14647.5 14709.4 15812.8 15976.5 16253.8 16291.6 16467.8 14890.4 15076.8 15384.5 15385.8 15689.3 14248.6 15063.2 15202.7 15327.3 15354.4 14393.6 14639.5 14780.3 14879.6 14912.3 11262.0 11698.5 11706.0 11797.4 12506.4 12767.9 12929.9 12998.8 13126.7 13305.4 11:32:52 INFO - PROCESS | 10513 | -------- Summary: end -------- 11:32:52 INFO - PROCESS | 10513 | 11:32:52 INFO - TEST-INFO | 10513: exit 0 11:32:52 INFO - TEST-OK | dromaeo_css | took 1111603ms 11:32:52 INFO - TEST-START | kraken 11:32:52 INFO - operating with platform_type : linux_ 11:32:52 INFO - Initialising browser for kraken test... 11:32:52 INFO - TEST-INFO | started process 10757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBOqIYS/profile http://localhost:39297/getInfo.html) 11:32:57 INFO - PROCESS | 10757 | __metrics Screen width/height:1600/1200 11:32:57 INFO - PROCESS | 10757 | colorDepth:24 11:32:57 INFO - PROCESS | 10757 | Browser inner width/height: 1024/697 11:32:57 INFO - PROCESS | 10757 | __metrics 11:32:58 ERROR - PROCESS | 10757 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 11:32:59 INFO - TEST-INFO | 10757: exit 0 11:32:59 INFO - Browser initialized. 11:32:59 INFO - Running cycle 1/1 for kraken test... 11:32:59 INFO - TEST-INFO | started process 10878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBOqIYS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:11 INFO - PROCESS | 10878 | RSS: Main: 150626304 11:33:11 INFO - PROCESS | 10878 | 11:33:13 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-beat-detection) 11:33:14 INFO - PROCESS | 10878 | RSS: Main: 156987392 11:33:14 INFO - PROCESS | 10878 | 11:33:17 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-dft) 11:33:17 INFO - PROCESS | 10878 | RSS: Main: 155590656 11:33:18 INFO - PROCESS | 10878 | 11:33:20 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-fft) 11:33:21 INFO - PROCESS | 10878 | RSS: Main: 156549120 11:33:21 INFO - PROCESS | 10878 | 11:33:23 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39297/tests/kraken/driver.html?testName=audio-oscillator) 11:33:24 INFO - PROCESS | 10878 | RSS: Main: 156098560 11:33:24 INFO - PROCESS | 10878 | 11:33:26 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:33:26 INFO - PROCESS | 10878 | RSS: Main: 156659712 11:33:26 INFO - PROCESS | 10878 | 11:33:30 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39297/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:30 INFO - PROCESS | 10878 | RSS: Main: 156778496 11:33:30 INFO - PROCESS | 10878 | 11:33:34 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39297/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:34 INFO - PROCESS | 10878 | RSS: Main: 156504064 11:33:34 INFO - PROCESS | 10878 | 11:33:37 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39297/tests/kraken/driver.html?testName=json-parse-financial) 11:33:38 INFO - PROCESS | 10878 | RSS: Main: 156434432 11:33:38 INFO - PROCESS | 10878 | 11:33:39 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:40 INFO - PROCESS | 10878 | RSS: Main: 155533312 11:33:40 INFO - PROCESS | 10878 | 11:33:41 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:42 INFO - PROCESS | 10878 | RSS: Main: 155934720 11:33:42 INFO - PROCESS | 10878 | 11:33:44 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:45 INFO - PROCESS | 10878 | RSS: Main: 156221440 11:33:45 INFO - PROCESS | 10878 | 11:33:47 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:48 INFO - PROCESS | 10878 | RSS: Main: 157237248 11:33:48 INFO - PROCESS | 10878 | 11:33:51 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:51 INFO - PROCESS | 10878 | RSS: Main: 156712960 11:33:51 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | Cycle 1(1): loaded http://localhost:39297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39297/tests/kraken/driver.html?testName=ai-astar) 11:33:53 INFO - PROCESS | 10878 | RSS: Main: 158752768 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | __start_tp_report 11:33:53 INFO - PROCESS | 10878 | _x_x_mozilla_page_load 11:33:53 INFO - PROCESS | 10878 | _x_x_mozilla_page_load_details 11:33:53 INFO - PROCESS | 10878 | |i|pagename|runs| 11:33:53 INFO - PROCESS | 10878 | |0;ai-astar;101;112;106;110;110;110;109;112;110;111 11:33:53 INFO - PROCESS | 10878 | |1;audio-beat-detection;150;117;142;178;137;149;142;119;170;116 11:33:53 INFO - PROCESS | 10878 | |2;audio-dft;162;164;164;160;161;163;160;161;161;161 11:33:53 INFO - PROCESS | 10878 | |3;audio-fft;74;76;74;176;77;75;75;77;170;79 11:33:53 INFO - PROCESS | 10878 | |4;audio-oscillator;84;83;148;83;89;85;148;83;83;154 11:33:53 INFO - PROCESS | 10878 | |5;imaging-gaussian-blur;118;121;117;116;117;117;118;117;117;117 11:33:53 INFO - PROCESS | 10878 | |6;imaging-darkroom;147;150;146;146;147;147;146;147;146;147 11:33:53 INFO - PROCESS | 10878 | |7;imaging-desaturate;96;95;95;96;95;96;95;95;95;95 11:33:53 INFO - PROCESS | 10878 | |8;json-parse-financial;51;52;51;53;55;52;52;52;51;52 11:33:53 INFO - PROCESS | 10878 | |9;json-stringify-tinderbox;62;59;59;60;59;58;59;59;61;59 11:33:53 INFO - PROCESS | 10878 | |10;stanford-crypto-aes;81;75;81;72;73;73;72;73;73;72 11:33:53 INFO - PROCESS | 10878 | |11;stanford-crypto-ccm;127;132;130;123;119;129;132;117;161;123 11:33:53 INFO - PROCESS | 10878 | |12;stanford-crypto-pbkdf2;153;153;152;151;153;151;154;151;153;148 11:33:53 INFO - PROCESS | 10878 | |13;stanford-crypto-sha256-iterative;69;63;61;65;62;61;60;63;61;64 11:33:53 INFO - PROCESS | 10878 | __end_tp_report 11:33:53 INFO - PROCESS | 10878 | __start_cc_report 11:33:53 INFO - PROCESS | 10878 | _x_x_mozilla_cycle_collect,868 11:33:53 INFO - PROCESS | 10878 | __end_cc_report 11:33:53 INFO - PROCESS | 10878 | __startTimestamp1475692433589__endTimestamp 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | ------- Summary: start ------- 11:33:53 INFO - PROCESS | 10878 | Number of tests: 14 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.31 (3.0%) stddev-sans-first:1.80 11:33:53 INFO - PROCESS | 10878 | Values: 101.0 112.0 106.0 110.0 110.0 110.0 109.0 112.0 110.0 111.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:145.50 stddev:21.21 (14.6%) stddev-sans-first:22.30 11:33:53 INFO - PROCESS | 10878 | Values: 150.0 117.0 142.0 178.0 137.0 149.0 142.0 119.0 170.0 116.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.49 (0.9%) stddev-sans-first:1.58 11:33:53 INFO - PROCESS | 10878 | Values: 162.0 164.0 164.0 160.0 161.0 163.0 160.0 161.0 161.0 161.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.50 stddev:41.00 (54.3%) stddev-sans-first:42.76 11:33:53 INFO - PROCESS | 10878 | Values: 74.0 76.0 74.0 176.0 77.0 75.0 75.0 77.0 170.0 79.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:83.00 stddev:31.84 (38.4%) stddev-sans-first:32.93 11:33:53 INFO - PROCESS | 10878 | Values: 84.0 83.0 148.0 83.0 89.0 85.0 148.0 83.0 83.0 154.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 11:33:53 INFO - PROCESS | 10878 | Values: 118.0 121.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 11:33:53 INFO - PROCESS | 10878 | Values: 147.0 150.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:33:53 INFO - PROCESS | 10878 | Values: 96.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.20 (2.3%) stddev-sans-first:1.20 11:33:53 INFO - PROCESS | 10878 | Values: 51.0 52.0 51.0 53.0 55.0 52.0 52.0 52.0 51.0 52.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.00 stddev:1.18 (2.0%) stddev-sans-first:0.83 11:33:53 INFO - PROCESS | 10878 | Values: 62.0 59.0 59.0 60.0 59.0 58.0 59.0 59.0 61.0 59.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:73.00 stddev:3.54 (4.8%) stddev-sans-first:2.86 11:33:53 INFO - PROCESS | 10878 | Values: 81.0 75.0 81.0 72.0 73.0 73.0 72.0 73.0 73.0 72.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:129.50 stddev:12.30 (9.5%) stddev-sans-first:13.02 11:33:53 INFO - PROCESS | 10878 | Values: 127.0 132.0 130.0 123.0 119.0 129.0 132.0 117.0 161.0 123.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:153.00 stddev:1.73 (1.1%) stddev-sans-first:1.79 11:33:53 INFO - PROCESS | 10878 | Values: 153.0 153.0 152.0 151.0 153.0 151.0 154.0 151.0 153.0 148.0 11:33:53 INFO - PROCESS | 10878 | 11:33:53 INFO - PROCESS | 10878 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:2.64 (4.2%) stddev-sans-first:1.64 11:33:53 INFO - PROCESS | 10878 | Values: 69.0 63.0 61.0 65.0 62.0 61.0 60.0 63.0 61.0 64.0 11:33:53 INFO - PROCESS | 10878 | -------- Summary: end -------- 11:33:53 INFO - PROCESS | 10878 | 11:33:54 INFO - TEST-INFO | 10878: exit 0 11:33:54 INFO - TEST-OK | kraken | took 61747ms 11:33:54 INFO - SUITE-END | took 1173s 11:33:54 INFO - Completed test suite (00:19:33) 11:33:54 INFO - javascript benchmark 11:33:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7796.572620878544, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.9341013179737, 3312.917177070573, 3322.5348451216832, 3341.1480072581503, 3352.178716214528, 5680.0, 5684.0, 5713.885722285552, 5757.510611598009, 5772.971135144324, 5770.480656740892, 5834.21238132852, 5850.590458667884, 5869.911951320723, 5875.236219291497, 5239.86900327492, 5314.893702125955, 5328.094223981913, 5344.973275133639, 5357.812476563321, 5350.946490535103, 5365.597580181482, 5366.731663416833, 5368.194770784375, 5408.4591540845795, 5141.254518094874, 5155.252488389181, 5340.225667278242, 5348.812791552277, 5352.063388906945, 5176.948230517684, 5249.343832020997, 5269.104252277122, 5271.973640131813, 5287.735613219362, 5202.4537423570355, 5206.5314121729225, 5230.476952304777, 5241.921371179397, 5252.212168174766, 5595.664260144405, 5649.152627105926, 5691.601587888849, 5716.971415142939, 5807.5644326675665, 6122.032243765652, 6216.067589861512, 6230.034344676583, 6230.252369715663, 6244.843878903019, 6234.127222188898, 6240.500759939194, 6240.719167637467, 6242.500599952038, 6255.0, 5580.386157522669, 5720.313562372458, 5802.883942321172, 5825.242718446617, 5853.678047707374, 6269.905951410732, 6352.777652782131, 6363.395477429637, 6367.840803979938, 6368.808935731936, 6095.939040609625, 6102.0541816018585, 6136.754529818846, 6149.0, 6149.600275982137, 6059.0, 6065.363136870565, 6166.0, 6211.9068213976825, 6232.968835155886, 6092.39076092396, 6196.535259855529, 6221.502279817604, 6224.9377506224355, 6241.126242326078, 6171.074338849208, 6181.907271390933, 6190.442860142519, 6196.597221180699, 6225.28409232944, 4645.326427668037, 4647.767611619473, 4757.405324334458, 4758.5241475852135, 4779.856604301876, 4132.2561938851295, 4182.330827067715, 4196.2027214829695, 4207.621314081747, 4221.366794980778, 5961.165436838846, 5968.343482216953, 5969.403059693996, 5976.073708575178, 5979.308524150858, 6075.969620151959, 6086.482648974798, 6183.628982261079, 6190.473809726223, 6193.318734939153, 5837.0, 5939.346671866091, 5961.523078153824, 5962.37395073511, 6003.399660034049, 5296.947030529645, 5298.841034768963, 5319.893602127936, 5331.067063263913, 5342.198670199501, 6012.909806352908, 6207.534434917399, 6215.223097112861, 6252.74989000444, 6305.684715764193, 6316.431521163117, 6324.873502530016, 6336.7465301389275, 6340.30256671775, 6352.618842869442, 6349.460295874717, 6384.521160912857, 6403.2316122063785, 6405.967970160119, 6406.519511036598, 5825.854353641193, 6054.666993315233, 6099.268087829489, 6147.262328520606, 6197.783077592263, 6262.3111457738705, 6264.843378915381, 6302.0, 6317.336679648571, 6322.810315690536, 6113.816585502442, 6118.112873633388, 6143.354947730424, 6161.4146656067605, 6162.291336496181, 5830.82507524775, 5913.053911374332, 5920.111983202554, 6135.601185922901, 6157.84605384869, 5894.351621321565, 5920.2895652521975, 5977.5217982560425, 5978.551608629457, 5988.490978266722, 6034.336223015553, 6056.878862422815, 6088.056351265561, 6100.054491553817, 6134.846628834136, 5851.9173952818865, 5866.794662186803, 5941.821745347646, 5972.731227094878, 5984.13230081627], "value": 5708.759401428904, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2478452365496, 632.936706329367, 645.1355184053367, 657.4674513643947, 709.6451774112943, 43976.0, 47476.525234747685, 47917.0, 48004.0, 48047.0, 47825.0, 48411.75794121033, 48488.27267590989, 48567.75716121415, 48605.75697121518, 8912.01967783545, 9122.22461090808, 9122.452652840817, 9124.498152601604, 9124.635014599442, 8969.416987895765, 9035.954820225923, 9060.456372617631, 9072.727818165433, 9074.59164337603, 9063.0, 9065.728028159167, 9089.818203635923, 9139.360244782867, 9151.130642588943, 8971.865422018642, 9015.098490150998, 9022.188003079722, 9105.36262461628, 9108.089191080906, 9007.864882026775, 9064.728058158265, 9110.453372797654, 9113.681021164228, 9114.680986165453, 44881.55118448806, 45143.54856451426, 45231.54768452339, 45367.0, 45417.77291113523, 3830.578636349999, 4007.198560287954, 4032.038088625475, 4073.3279008963486, 4074.0222346636892, 36291.27417451663, 36574.817125914204, 36624.81687591572, 37060.814695926616, 38398.0, 4707.293905914106, 4715.245560710304, 4720.669553131283, 4743.810247590092, 4796.640251981081, 401604.0, 407757.0, 408516.0, 409137.9543102295, 409706.0, 39752.80123599363, 40585.0, 67699.32300676931, 68101.0, 68101.31898681048, 40023.599764001985, 40195.59804401977, 40289.0, 40297.59702402997, 40347.0, 16203.270852811651, 16353.182340883146, 16372.181390930406, 16381.918090409472, 16382.508524744277, 14475.49335773264, 14520.273986300643, 14586.4894728684, 14673.486427975184, 14708.705825883422, 9570.473623950611, 9571.0, 9582.56526134265, 9591.328606997582, 9622.855657165148, 3543.6257707336144, 3554.43129099348, 3625.329314076904, 3636.4363523653874, 3663.3440755452084, 1110.3171549497001, 1150.930944143354, 1214.987850121505, 1223.247702662856, 1246.6322434881731, 34761.478577821355, 34778.478322825176, 34947.4757878632, 35080.47379289313, 35329.82335088308, 1161.8838116188313, 1180.695331658522, 1182.148852825964, 1191.5531675621642, 1285.1261142423054, 18222.362217322596, 18256.178471968793, 18257.269709211483, 18410.539736506427, 18437.26250949974, 598574.0, 599322.0, 599852.0, 605569.0, 606069.0, 65515.0, 65530.0, 65926.67036664882, 65993.0, 66319.66840165768, 1434.3868906685896, 1447.6887469193964, 1453.4622189789845, 1475.6532214929482, 1502.8046353973914, 33297.66702332946, 33342.0, 33496.497552536246, 33881.32237355288, 33960.0, 58987.41012589819, 67833.0, 70124.29875701178, 70166.29833701802, 70259.64870175616, 562170.0, 562935.0, 566844.0, 568280.0, 574017.0, 48770.26844597405, 49569.25646115239, 49702.0, 49803.501964979885, 49831.501684982686, 54697.453025469236, 55386.44613553974, 55526.16710749261, 55548.444515555944, 55685.0, 46946.765266173454, 47281.52718472771, 47789.56631301066, 47972.52027479681, 48600.513994861016, 47314.0, 47742.52257477381, 47920.2811957814, 48344.516554834, 48852.5114748848, 45531.54468455273, 46041.53958460373, 46551.76724116358, 46630.76684616691, 49119.754401227765, 39751.80124099361, 40825.795871020455, 41011.384829228184, 41027.0, 41416.0, 30183.547246791753, 30470.019448736646, 30685.23286917845, 30809.845950771, 31163.0], "value": 21194.79387596605, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.2228438530909, 430.66838534328565, 433.36944745395454, 435.72549293944815, 444.2514363297843, 18853.0, 19489.707654385176, 20226.89886550567, 20625.1749930003, 20681.689774653354, 19618.60762784747, 19741.309054183108, 20118.59762804743, 20493.4876628084, 20702.378928632126, 5813.6802475863915, 6020.909686354708, 6021.09683547467, 6029.427204415573, 6036.577439579231, 5866.325372582143, 5883.8529036774, 5936.7328470218945, 5937.495312898409, 5994.130851026599, 5887.823365299027, 5903.173555702205, 5908.261467316585, 5923.674197919113, 5946.583739138262, 5771.220885180489, 5876.353601103875, 5877.764889404419, 5902.822915312548, 5906.497947674453, 5327.30745003151, 5333.0, 5336.039512887679, 5347.438518955492, 5349.037173308803, 23915.402114947265, 24257.636135457982, 24573.262802115965, 24663.136790212437, 24935.87532062346, 2616.2282126772648, 2637.4988752137033, 2652.814302998791, 2715.823471474348, 2770.667519897605, 15247.0, 15374.846251537454, 15439.304222792478, 15735.370585176579, 16057.357705691875, 2051.241040814893, 2159.865713988614, 2174.695542624018, 2209.2267706302664, 2219.7336319641745, 78290.60854695748, 80174.0, 80189.19810801875, 80685.0, 91907.54046229726, 11423.771524569629, 11893.34586597728, 11981.46083426248, 12054.41932065827, 12199.39003049844, 17166.31334746621, 17204.65590688179, 17205.7419138713, 17249.827501725074, 17261.65476690459, 9119.544022798833, 9224.446533207894, 9315.161635452841, 9363.531823408803, 9390.85913711295, 8884.067172946747, 9060.411073280216, 9110.453372797521, 9122.0, 9240.95379523098, 5147.948520514822, 5173.611979101583, 5196.142636465017, 5210.062188805976, 5260.184671375943, 2075.858277947123, 2156.13754498202, 2164.9567008660056, 2168.316980151279, 2174.1955476473804, 980.5587485631495, 1049.532957833772, 1056.1234175634206, 1096.8848270931596, 1144.8855114488485, 20512.58974820495, 20528.58942821135, 20630.27794027202, 20722.79277207239, 21391.46521336948, 1007.778288776468, 1011.7318910488726, 1014.3001329083056, 1053.5417093564172, 1065.925385223027, 10806.621768238074, 11333.886661133283, 11380.829287560693, 11420.543178272943, 11523.48144333507, 523099.0, 549328.0, 553831.0, 560119.0, 570850.0, 88021.84096555888, 95769.52115239379, 100272.0, 100735.0, 101351.4932425348, 980.2011360740973, 1075.3762817565948, 1088.276296262992, 1090.4820210400155, 1096.1669131460148, 17963.0, 18177.272909083487, 18642.0, 18861.434156975312, 18902.338418155297, 34170.48744268788, 44709.329360058975, 45112.0, 45383.092338153714, 45882.31176532288, 64501.677491612245, 64627.0, 64883.67558162179, 65298.34701653113, 65616.67191664012, 8580.0, 8708.73873783762, 8750.562471876254, 8755.430896991675, 9037.322200834833, 10983.340999540053, 13044.608661740163, 14081.577552673436, 14261.358238879482, 14532.346044428237, 12278.324692142018, 12291.69270768238, 12545.560905368267, 12897.935510322388, 12998.610041698765, 12057.035437165181, 12236.388180590757, 12490.625281241577, 12529.93735031319, 12643.0, 12764.2341459509, 12961.41673624708, 13081.149725267827, 13159.60521184366, 13215.0, 8245.340372770044, 8558.358123140664, 8885.600147993226, 8956.955215223883, 9244.861327079965, 9491.38306010107, 11493.138014648768, 11831.763364732486, 12418.875811241773, 12458.813117803422], "value": 9917.732735451878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1573.1347758732695, 1589.5867074560613, 1783.589774351899, 1881.1628825172804, 1883.0396497786126, 9531.952340238298, 9783.364081334708, 10083.848742268872, 10288.897111028888, 10334.121599664019, 9731.854022189673, 9815.165710914564, 9875.75310617235, 9887.555060022298, 9911.851322230154, 2515.006572403904, 2555.3356127406914, 2561.9231423057245, 2563.115725074846, 2567.1271767599014, 2473.863937483438, 2542.2627438042946, 2545.7072436669837, 2546.401595625027, 2547.121243171103, 2501.7248102708686, 2502.27434044127, 2518.5970244760842, 2523.1673547729297, 2527.0523553667376, 2439.9756002439926, 2449.0571130114945, 2458.0, 2460.052879641333, 2482.5779617465073, 2450.3996520852506, 2475.356407334088, 2476.120977053138, 2489.5269898719366, 2506.2105436787538, 10000.099991000845, 10108.898911010943, 10117.645882394154, 10162.542685579092, 10166.13587845034, 5555.083411237141, 5676.290463692038, 5704.828855134353, 5717.285339332583, 5732.942670573324, 3423.606285277175, 3479.512868198429, 3541.5041894134843, 3556.05764472415, 3583.283343331318, 1176.3765204441659, 1332.4004198110888, 1351.72965406919, 2358.2217868103485, 2398.59223931932, 13982.510612128526, 14209.786853197107, 14224.0, 14256.572302830828, 14300.070495417765, 4617.238155704338, 4654.767261636905, 4778.354922085474, 4797.856064318076, 4902.779374928136, 11036.889631103746, 11043.39261340634, 11050.613228536962, 11052.115830733523, 11083.445827708581, 5611.971940140274, 5657.12314591239, 5676.318841739017, 5691.800786972436, 5695.800646977336, 5041.117804384218, 5151.5106064923775, 5187.325647665854, 5210.5831533477985, 5330.866728331823, 4301.354796780508, 4356.302991521405, 4405.581469760367, 4474.7762611869275, 4478.305862591304, 1341.4634146341346, 1390.9026368154132, 1392.7841184616198, 1409.7039621679357, 1421.9289035548181, 959.8656188133527, 1060.098915921476, 1069.6790962711154, 1073.2004656530778, 1083.111848284415, 6319.0, 6449.645269510128, 6632.403083722488, 6634.800955971328, 6663.733450661919, 453.67108846086325, 461.98614041578804, 475.3701345716939, 502.6933570521979, 503.23257033024197, 4503.819847206075, 4505.459344878635, 4553.772311384484, 4599.839005634787, 4658.976705116453, 12221.877781222252, 12236.938815305866, 12546.05904557162, 12569.811452828215, 12579.496820127275, 12453.93773031129, 12468.127231093737, 12489.93755031219, 12505.812412813815, 12512.374381280899, 9078.90921090794, 9168.312376571785, 9172.403793753385, 9229.261659067259, 9285.210757085724, 6305.527085468517, 6343.111964324906, 6469.611823290617, 6509.609423434609, 6566.9343306566325, 10286.794264114526, 10587.947060264649, 11267.887321127011, 11268.0, 11381.374024428736, 10690.465476726287, 10943.0, 11002.0, 11008.119350452105, 11052.502637381176, 8024.398170137147, 8513.914860851311, 8676.479411235347, 8735.868961965703, 8927.375083744075, 9631.614735410505, 9729.805403892024, 9730.708078757649, 9735.659251926148, 9746.463944483121, 8240.464369815943, 8387.077421483755, 8467.745967620735, 8483.363747718822, 8530.70142545008, 8580.227779499875, 8583.871241931502, 8588.441751286146, 8663.566821658766, 8775.956120219358, 7216.71133154689, 7245.891311630435, 7261.72919739033, 7281.381082608038, 7288.854222915618, 5642.520385767091, 5717.285339332583, 5911.320198177093, 5932.436418540232, 5932.79235226765, 5562.332520097614, 5676.318841739017, 5717.371089180104, 5775.768969241351, 5813.563982701399], "value": 5038.945444448742, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.49266592776763, 349.9770142215235, 366.92844895245423, 371.34828376199766, 375.12595652130557, 5737.196792449061, 5771.942280577193, 5813.622114562556, 5814.970925145379, 5840.474357307841, 5583.58123140765, 5675.921574900766, 5718.971405142968, 5745.741441635126, 5754.280714910637, 4425.933610995838, 4441.289393697001, 4452.443444569429, 4461.219286624844, 4471.88820279494, 4435.223835828733, 4443.84446544371, 4447.155040542287, 4480.305552639346, 4483.4843992940905, 4441.866743997685, 4456.8885777855485, 4464.174127786354, 4465.598096171344, 4495.865124046284, 4321.385561735136, 4400.713953593006, 4417.586372360845, 4431.534688857656, 4434.201843668122, 3964.6630036446936, 3965.2466031453932, 3982.4424580558743, 3984.7609143451486, 3987.182627561372, 5534.225208470817, 5559.610827242094, 5562.7774889004395, 5584.4136365681425, 5605.803796867131, 5025.592834006484, 5139.948600514022, 5156.664816786897, 5180.870478238075, 5188.429272779991, 5956.927753004457, 5962.463378295931, 5979.13001759158, 6060.272767267912, 6075.635461872258, 4327.896386421474, 4426.535213802536, 4445.199864024475, 4447.3996010538485, 4455.8217671293105, 6075.9696201519155, 6194.938050619481, 6210.378962103753, 6265.310815810257, 6290.3709629037185, 4405.118976204772, 4425.336199570091, 4437.2234858899565, 4470.597646211857, 4481.260592002348, 4516.616087632522, 4519.661025423106, 4536.750478723702, 4540.6821522493765, 4556.270996640522, 5088.694678319239, 5099.413567439792, 5152.0, 5192.584593232532, 5227.58179345659, 6058.1518587397795, 6059.030555111161, 6070.119832624245, 6090.33006369299, 6136.8772624547255, 1544.3282172255106, 1557.7819105325264, 1561.2584022589178, 1570.6858628274163, 1579.289319806069, 969.6654654144309, 1004.7136566078633, 1014.4369874719454, 1018.9796204076025, 1029.939162662444, 5128.692278463304, 5204.698825293676, 5208.5312321891215, 5230.843074707765, 5250.7374631268285, 5482.862928426742, 5486.231927530149, 5498.285222920995, 5500.28496295487, 5514.393416724157, 4855.32956873718, 5215.852512447255, 5233.39815921174, 5275.841724748264, 5277.20841873722, 2907.5431260584774, 2912.694167112465, 2929.61914951055, 2929.7070292970957, 2932.501474749298, 5449.536789372948, 5482.259894914216, 5483.670979741229, 5485.725713714378, 5489.972550137303, 5922.3485416604135, 6344.842753463752, 6368.10846481493, 6372.769530664231, 6447.3552644735155, 6366.904496432558, 6374.330695277022, 6375.458086062644, 6393.968030159819, 6400.7198560288125, 6033.948457524462, 6229.781957631461, 6274.749010039547, 6299.181106456314, 6372.904406433814, 6183.96908015457, 6184.969075154595, 6249.718762655601, 6283.7800676976085, 6289.213848268966, 6157.538184636081, 6276.748930042747, 6277.71750271248, 6300.21247344082, 6308.0667489617545, 4344.109457561256, 4377.956220437755, 4386.210482113251, 4389.473263208435, 4423.314386270134, 6222.253329600477, 6254.468370188585, 6256.122183795505, 6375.458086062551, 6379.202599675041, 6131.54013449002, 6134.754609815557, 6209.130721698875, 6213.285472170758, 6255.343188965093, 5994.890945175157, 6093.507090762791, 6206.665566903138, 6208.50331973432, 6268.498520118288, 6067.30005147705, 6089.360617135314, 6091.238595175603, 6095.725692343766, 6100.23747031621, 6188.133661287334, 6213.96893015532, 6232.25212974446, 6253.5622506424115, 6254.781082662085, 5808.854778630399, 5907.822765317047, 5958.940410595838, 6015.699215039143, 6020.819375418744], "value": 4547.2231369907795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.6758330459472, 829.1832544943234, 848.1772680499913, 897.8967418746845, 915.9084091590842, 15999.760003599955, 17077.23152458139, 17738.02440865755, 17824.287028518844, 18080.81919180811, 16423.507294781175, 16516.83483165168, 16570.42003529877, 16586.419475318366, 16710.749338759928, 874.1608056265992, 879.3317079019959, 896.157611844867, 902.0438335364502, 903.1420150856679, 896.0815164456419, 898.9056149104348, 899.851524498457, 900.5632268349846, 900.779309069279, 914.89021317442, 930.1163894300441, 930.6044930904338, 931.2317338195982, 937.6015193542751, 915.1900567997304, 923.612082925173, 924.6994726713812, 925.8379783537888, 926.2266007883392, 685.7051467868814, 688.102026854954, 688.4801974509263, 688.9552179108392, 691.3950293493193, 16546.089965051917, 16711.164441777983, 16716.74924876128, 16721.91639041797, 16722.08028558429, 15532.689346213125, 15609.609759755984, 15694.215289235606, 15718.37126514938, 15868.52394428169, 12811.359432028454, 12936.482540698455, 13072.738545229042, 13203.801942970864, 13489.797653035212, 4042.1309418474875, 4055.1686904184867, 4079.9592004080173, 4086.4074709167303, 4126.546079931205, 92575.0, 95093.52453237689, 96046.0, 96638.0, 97162.5141874286, 11355.148363872742, 11401.429928503541, 11820.23168494045, 11843.526258949545, 12154.939225303817, 23452.765472345058, 23764.405889852893, 23779.048838046285, 23810.0, 23831.7616823833, 8489.490630562186, 8528.317734581218, 8597.0, 8758.0, 9173.58718857653, 4945.752712364368, 4962.379702537183, 4994.850154495298, 5123.641345105882, 5188.533032027136, 3928.4107383892647, 4036.1322315702264, 4039.0912044790275, 4050.1899620075515, 4073.551909289976, 609.1867357078262, 627.5011365964069, 631.5863109663086, 638.2149955554694, 649.9892666903012, 707.3598393453932, 782.7025730222479, 837.3050368194506, 844.9915500845036, 855.8331125430482, 10516.474176291307, 10836.59163060598, 10900.672979810619, 11003.724906877393, 11147.777044459228, 631.9557630965788, 770.8805135204052, 832.3341326938425, 832.7834762961553, 844.2823599940125, 5012.223105418666, 5307.28351672527, 5370.62405631602, 5378.784848606012, 5389.595780316492, 72318.63840680868, 73560.0, 73606.63196683982, 73802.26197738061, 76815.61592192003, 114580.42709786398, 115158.0, 117931.0, 118308.0, 118386.0, 56140.157897631565, 59973.700131499936, 102815.48592256842, 103370.48314758528, 105478.47260763648, 9896.554655040396, 10118.836333821704, 10153.0, 10198.33710808795, 10202.744931376776, 44560.77719611381, 49259.50740492549, 58247.0, 58747.41252587419, 59930.10104848518, 73876.26123738693, 76764.23235767795, 80212.19787802047, 80294.598527007, 81093.94292341177, 13954.860451395762, 14411.063280886709, 14449.566513004627, 14647.487337943121, 14709.411623535367, 15812.76280855765, 15976.520704378887, 16253.837461625233, 16291.59271018234, 16467.83532164663, 14890.404383824525, 15076.773848392064, 15384.538970456704, 15385.84614153844, 15689.29398177062, 14248.643783905485, 15063.183657160158, 15202.695946081238, 15327.310271037608, 15354.385824567338, 14393.568192954228, 14639.48761793332, 14780.260986950825, 14879.62800929942, 14912.328945197709, 11262.0, 11698.532058717556, 11706.0, 11797.410129493663, 12506.437210325375, 12767.93616031914, 12929.870701293243, 12998.80501792455, 13126.738339084073, 13305.401256943267], "value": 8167.932104511899, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 106.0, 110.0, 110.0, 110.0, 109.0, 112.0, 110.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 142.0, 178.0, 137.0, 149.0, 142.0, 119.0, 170.0, 116.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 160.0, 161.0, 163.0, 160.0, 161.0, 161.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 176.0, 77.0, 75.0, 75.0, 77.0, 170.0, 79.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 148.0, 83.0, 89.0, 85.0, 148.0, 83.0, 83.0, 154.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 51.0, 53.0, 55.0, 52.0, 52.0, 52.0, 51.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 59.0, 60.0, 59.0, 58.0, 59.0, 59.0, 61.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 81.0, 72.0, 73.0, 73.0, 72.0, 73.0, 73.0, 72.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 132.0, 130.0, 123.0, 119.0, 129.0, 132.0, 117.0, 161.0, 123.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 152.0, 151.0, 153.0, 151.0, 154.0, 151.0, 153.0, 148.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 63.0, 61.0, 65.0, 62.0, 61.0, 60.0, 63.0, 61.0, 64.0], "value": 62.9, "unit": "score"}]}]} 11:33:54 INFO - Return code: 0 11:33:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:33:54 ERROR - # TBPL SUCCESS # 11:33:54 INFO - Running post-action listener: _resource_record_post_action 11:33:54 INFO - [mozharness: 2016-10-05 18:33:54.911563Z] Finished run-tests step (success) 11:33:54 INFO - Running post-run listener: _resource_record_post_run 11:33:54 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287154176; Read time: 52; Write time: 365228 11:33:54 INFO - TinderboxPrint: CPU usage
13.2% 11:33:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 52 11:33:54 INFO - TinderboxPrint: I/O write bytes / time
287,154,176 / 365,228 11:33:54 INFO - TinderboxPrint: CPU idle
8,226.6 (86.8%) 11:33:54 INFO - TinderboxPrint: CPU user
1,195.3 (12.6%) 11:33:54 INFO - TinderboxPrint: Swap in / out
0 / 0 11:33:54 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 70066176; Read time: 0; Write time: 153424 11:33:54 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 217088000; Read time: 52; Write time: 211804 11:33:55 INFO - Running post-run listener: _upload_blobber_files 11:33:55 INFO - Blob upload gear active. 11:33:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:33:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:33:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:33:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:56 INFO - (blobuploader) - INFO - Done attempting. 11:33:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:33:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:33:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:57 INFO - (blobuploader) - INFO - Done attempting. 11:33:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:33:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:34:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:34:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:34:00 INFO - (blobuploader) - INFO - Done attempting. 11:34:00 INFO - (blobuploader) - INFO - Iteration through files over. 11:34:00 INFO - Return code: 0 11:34:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:34:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:34:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/879c34348e95a19373baf47be83dba339f4a00492fa03eee5a282e608c38614f16e5fb6f89ba8ac135c9b118cd726ee29d0d4eb236b28d918345b49003224502", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/377a08aa0c2f6e1a08bffea52571fcb9df0cfc8d7927b03e4544d5d0dc171ccf60501e827aa51b305e957d44d1d55cf6713390bdcf2b26bf78748db3639dbca1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bfeb321ff0beb80ba692ccebff3b7be64f520ad233c3d9840cd435d395d96e6ecd2f0a022202945db5d14f19764659aa96d7b0a5e6de47e6ee98cef998c4825"} 11:34:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:34:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:34:00 INFO - Contents: 11:34:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/879c34348e95a19373baf47be83dba339f4a00492fa03eee5a282e608c38614f16e5fb6f89ba8ac135c9b118cd726ee29d0d4eb236b28d918345b49003224502", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/377a08aa0c2f6e1a08bffea52571fcb9df0cfc8d7927b03e4544d5d0dc171ccf60501e827aa51b305e957d44d1d55cf6713390bdcf2b26bf78748db3639dbca1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bfeb321ff0beb80ba692ccebff3b7be64f520ad233c3d9840cd435d395d96e6ecd2f0a022202945db5d14f19764659aa96d7b0a5e6de47e6ee98cef998c4825"} 11:34:00 INFO - Running post-run listener: copy_logs_to_upload_dir 11:34:00 INFO - Copying logs to upload dir... 11:34:00 INFO - mkdir: /builds/slave/test/build/upload/logs 11:34:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1674.971703 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-10-05 11:34:00.631152) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 11:34:00.635182) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/879c34348e95a19373baf47be83dba339f4a00492fa03eee5a282e608c38614f16e5fb6f89ba8ac135c9b118cd726ee29d0d4eb236b28d918345b49003224502", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/377a08aa0c2f6e1a08bffea52571fcb9df0cfc8d7927b03e4544d5d0dc171ccf60501e827aa51b305e957d44d1d55cf6713390bdcf2b26bf78748db3639dbca1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bfeb321ff0beb80ba692ccebff3b7be64f520ad233c3d9840cd435d395d96e6ecd2f0a022202945db5d14f19764659aa96d7b0a5e6de47e6ee98cef998c4825"} build_url:https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/HJ0qmajNSNWp9eCAHyA3Og/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/879c34348e95a19373baf47be83dba339f4a00492fa03eee5a282e608c38614f16e5fb6f89ba8ac135c9b118cd726ee29d0d4eb236b28d918345b49003224502", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/377a08aa0c2f6e1a08bffea52571fcb9df0cfc8d7927b03e4544d5d0dc171ccf60501e827aa51b305e957d44d1d55cf6713390bdcf2b26bf78748db3639dbca1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7bfeb321ff0beb80ba692ccebff3b7be64f520ad233c3d9840cd435d395d96e6ecd2f0a022202945db5d14f19764659aa96d7b0a5e6de47e6ee98cef998c4825"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 11:34:00.661623) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 11:34:00.662012) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475690763.230599-516094112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 11:34:00.746954) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 11:34:00.747325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 11:34:00.747687) ========= ========= Total master_lag: 0.17 =========