builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1475534249.0 results: success (0) buildid: 20161003124659 builduid: 37a071889354493a83defb3343a4d14d revision: 47dff98b4b466b0b373ff04a2bb95542260be0c3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:29.003608) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:29.004993) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:29.005278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:29.020335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:29.020757) ========= 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=920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-03 15:37:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-10-03 15:37:30 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145488 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:29.179859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:29.180233) ========= 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=920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021183 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:29.232000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 15:37:29.232391) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 47dff98b4b466b0b373ff04a2bb95542260be0c3 --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 47dff98b4b466b0b373ff04a2bb95542260be0c3 --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=920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-03 15:37:30,681 truncating revision to first 12 chars 2016-10-03 15:37:30,681 Setting DEBUG logging. 2016-10-03 15:37:30,681 attempt 1/10 2016-10-03 15:37:30,681 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/47dff98b4b46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 15:37:31,532 unpacking tar archive at: mozilla-beta-47dff98b4b46/testing/mozharness/ program finished with exit code 0 elapsedTime=1.188232 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-03 15:37:30.435983) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:30.436407) ========= script_repo_revision: 47dff98b4b466b0b373ff04a2bb95542260be0c3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:30.436857) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:30.437174) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 15:37:30.447920) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-10-03 15:37:30.448364) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:37:31 INFO - MultiFileLogger online at 20161003 15:37:31 in /builds/slave/test 15:37:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:37:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:37:31 INFO - {'append_to_log': False, 15:37:31 INFO - 'base_work_dir': '/builds/slave/test', 15:37:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:37:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:37:31 INFO - 'branch': 'Mozilla-Beta', 15:37:31 INFO - 'buildbot_json_path': 'buildprops.json', 15:37:31 INFO - 'config_files': ('talos/linux_config.py',), 15:37:31 INFO - 'default_actions': ('clobber', 15:37:31 INFO - 'read-buildbot-config', 15:37:31 INFO - 'download-and-extract', 15:37:31 INFO - 'populate-webroot', 15:37:31 INFO - 'create-virtualenv', 15:37:31 INFO - 'install', 15:37:31 INFO - 'run-tests'), 15:37:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:37:31 INFO - 'download_minidump_stackwalk': True, 15:37:31 INFO - 'download_symbols': 'ondemand', 15:37:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:37:31 INFO - 'tooltool.py': '/tools/tooltool.py', 15:37:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:37:31 INFO - '/tools/misc-python/virtualenv.py')}, 15:37:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:37:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:37:31 INFO - 'installer_path': 'installer.exe', 15:37:31 INFO - 'log_level': 'info', 15:37:31 INFO - 'log_name': 'talos', 15:37:31 INFO - 'log_to_console': True, 15:37:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:37:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:37:31 INFO - 'opt_config_files': (), 15:37:31 INFO - 'pip_index': False, 15:37:31 INFO - 'sps_profile': False, 15:37:31 INFO - 'sps_profile_interval': 0, 15:37:31 INFO - 'suite': 'dromaeojs', 15:37:31 INFO - 'system_bits': '32', 15:37:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:37:31 INFO - 'title': 'talos-linux64-ix-053', 15:37:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:37:31 INFO - 'use_talos_json': True, 15:37:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:37:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:37:31 INFO - 'work_dir': 'build'} 15:37:31 INFO - [mozharness: 2016-10-03 22:37:31.989878Z] Running clobber step. 15:37:31 INFO - Running pre-action listener: _resource_record_pre_action 15:37:31 INFO - Running main action method: clobber 15:37:31 INFO - rmtree: /builds/slave/test/build 15:37:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:37:32 INFO - Running post-action listener: _resource_record_post_action 15:37:32 INFO - [mozharness: 2016-10-03 22:37:32.448746Z] Finished clobber step (success) 15:37:32 INFO - [mozharness: 2016-10-03 22:37:32.448848Z] Running read-buildbot-config step. 15:37:32 INFO - Running pre-action listener: _resource_record_pre_action 15:37:32 INFO - Running main action method: read_buildbot_config 15:37:32 INFO - Using buildbot properties: 15:37:32 INFO - { 15:37:32 INFO - "project": "", 15:37:32 INFO - "product": "firefox", 15:37:32 INFO - "script_repo_revision": "production", 15:37:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:37:32 INFO - "repository": "", 15:37:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:37:32 INFO - "buildid": "20161003124659", 15:37:32 INFO - "pgo_build": "True", 15:37:32 INFO - "basedir": "/builds/slave/test", 15:37:32 INFO - "buildnumber": 406, 15:37:32 INFO - "slavename": "talos-linux64-ix-053", 15:37:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:37:32 INFO - "platform": "ubuntu64_hw", 15:37:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:37:32 INFO - "branch": "mozilla-beta", 15:37:32 INFO - "repo_path": "releases/mozilla-beta", 15:37:32 INFO - "revision": "47dff98b4b466b0b373ff04a2bb95542260be0c3", 15:37:32 INFO - "stage_platform": "linux64-pgo", 15:37:32 INFO - "builduid": "37a071889354493a83defb3343a4d14d", 15:37:32 INFO - "slavebuilddir": "test" 15:37:32 INFO - } 15:37:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 15:37:32 INFO - Running post-action listener: _resource_record_post_action 15:37:32 INFO - [mozharness: 2016-10-03 22:37:32.451846Z] Finished read-buildbot-config step (success) 15:37:32 INFO - [mozharness: 2016-10-03 22:37:32.451936Z] Running download-and-extract step. 15:37:32 INFO - Running pre-action listener: _resource_record_pre_action 15:37:32 INFO - Running main action method: download_and_extract 15:37:32 INFO - mkdir: /builds/slave/test/build/tests 15:37:32 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')]} 15:37:32 INFO - https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:37:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:37:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:37:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:37:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:37:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:37:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:37:32 INFO - retry: Failed, sleeping 30 seconds before retrying 15:38:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:38:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:38:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:38:02 INFO - retry: Failed, sleeping 60 seconds before retrying 15:39:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:39:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:39:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:39:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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! 15:39:02 INFO - Caught exception: HTTP Error 404: Not Found 15:39:02 INFO - Caught exception: HTTP Error 404: Not Found 15:39:02 INFO - Caught exception: HTTP Error 404: Not Found 15:39:02 INFO - trying https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:39:02 INFO - Downloading https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:39:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:39:03 INFO - Downloaded 1327 bytes. 15:39:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:39:03 INFO - Using the following test package requirements: 15:39:03 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:39:03 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:39:03 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:39:03 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:39:03 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 15:39:03 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:39:03 INFO - u'jsshell-linux-x86_64.zip'], 15:39:03 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:39:03 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:39:03 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:39:03 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:39:03 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 15:39:03 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:39:03 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 15:39:03 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:39:03 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:39:03 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:39:03 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:39:03 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:39:03 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')]} 15:39:03 INFO - https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:39:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:39:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:39:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:39:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:39:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:39:03 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:39:03 INFO - retry: Failed, sleeping 30 seconds before retrying 15:39:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:39:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:39:33 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:39:33 INFO - retry: Failed, sleeping 60 seconds before retrying 15:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:40:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:40:33 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:40:33 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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! 15:40:33 INFO - Caught exception: HTTP Error 404: Not Found 15:40:33 INFO - Caught exception: HTTP Error 404: Not Found 15:40:33 INFO - Caught exception: HTTP Error 404: Not Found 15:40:33 INFO - trying https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:40:33 INFO - Downloading https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:40:34 INFO - Downloaded 21841512 bytes. 15:40:34 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'] 15:40:34 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 15:40:35 INFO - Return code: 0 15:40:35 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 15:40:35 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')]} 15:40:35 INFO - https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:40:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:40:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:40:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:40:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:40:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:40:35 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:40:35 INFO - retry: Failed, sleeping 30 seconds before retrying 15:41:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:41:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:41:05 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:41:05 INFO - retry: Failed, sleeping 60 seconds before retrying 15:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:05 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:42:05 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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! 15:42:05 INFO - Caught exception: HTTP Error 404: Not Found 15:42:05 INFO - Caught exception: HTTP Error 404: Not Found 15:42:05 INFO - Caught exception: HTTP Error 404: Not Found 15:42:05 INFO - trying https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:05 INFO - Downloading https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:06 INFO - Downloaded 21841512 bytes. 15:42:06 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'] 15:42:06 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 15:42:07 INFO - Return code: 0 15:42:07 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')]} 15:42:07 INFO - https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:42:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:42:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:42:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:42:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:42:07 INFO - retry: Failed, sleeping 30 seconds before retrying 15:42:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:42:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:42:37 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:42:37 INFO - retry: Failed, sleeping 60 seconds before retrying 15:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:43:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:43:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:43:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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! 15:43:37 INFO - Caught exception: HTTP Error 404: Not Found 15:43:37 INFO - Caught exception: HTTP Error 404: Not Found 15:43:37 INFO - Caught exception: HTTP Error 404: Not Found 15:43:37 INFO - trying https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:43:37 INFO - Downloading https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:43:38 INFO - Downloaded 14413740 bytes. 15:43:38 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'] 15:43:38 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 15:43:38 INFO - Return code: 0 15:43:38 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')]} 15:43:38 INFO - https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:43:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:43:38 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:43:38 INFO - retry: Failed, sleeping 30 seconds before retrying 15:44:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:44:08 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:44:08 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:44:08 INFO - retry: Failed, sleeping 60 seconds before retrying 15:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:45:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:45:09 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:45:09 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KreGsP7xSne2N8C4Uzlstg/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! 15:45:09 INFO - Caught exception: HTTP Error 404: Not Found 15:45:09 INFO - Caught exception: HTTP Error 404: Not Found 15:45:09 INFO - Caught exception: HTTP Error 404: Not Found 15:45:09 INFO - trying https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:45:09 INFO - Downloading https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/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 15:45:10 INFO - Downloaded 56810134 bytes. 15:45:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:45:10 INFO - mkdir: /builds/slave/test/properties 15:45:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:45:10 INFO - Writing to file /builds/slave/test/properties/build_url 15:45:10 INFO - Contents: 15:45:10 INFO - build_url:https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:45:10 INFO - Running post-action listener: _resource_record_post_action 15:45:10 INFO - Running post-action listener: set_extra_try_arguments 15:45:10 INFO - [mozharness: 2016-10-03 22:45:10.837715Z] Finished download-and-extract step (success) 15:45:10 INFO - [mozharness: 2016-10-03 22:45:10.837951Z] Running populate-webroot step. 15:45:10 INFO - Running pre-action listener: _resource_record_pre_action 15:45:10 INFO - Running main action method: populate_webroot 15:45:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:45:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:45:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:45:10 INFO - '--tppagecycles', 15:45:10 INFO - '7'], 15:45:10 INFO - 'tests': ['tsvgm']}}, 15:45:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:45:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:45:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:45:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:45:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:10 INFO - 'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:10 INFO - 'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['damp', 'tps']}, 15:45:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:10 INFO - 'tests': ['damp', 'tps']}, 15:45:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['dromaeo_dom']}, 15:45:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:45:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['basic_compositor_video']}, 15:45:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:45:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['a11yr', 15:45:10 INFO - 'ts_paint', 15:45:10 INFO - 'tpaint', 15:45:10 INFO - 'sessionrestore', 15:45:10 INFO - 'sessionrestore_no_auto_restore', 15:45:10 INFO - 'tabpaint']}, 15:45:10 INFO - 'other-e10s': {'tests': ['a11yr', 15:45:10 INFO - 'ts_paint', 15:45:10 INFO - 'tpaint', 15:45:10 INFO - 'sessionrestore', 15:45:10 INFO - 'sessionrestore_no_auto_restore', 15:45:10 INFO - 'tabpaint']}, 15:45:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:45:10 INFO - 'ts_paint', 15:45:10 INFO - 'tpaint', 15:45:10 INFO - 'sessionrestore', 15:45:10 INFO - 'sessionrestore_no_auto_restore', 15:45:10 INFO - 'tabpaint']}, 15:45:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:45:10 INFO - 'ts_paint', 15:45:10 INFO - 'tpaint', 15:45:10 INFO - 'sessionrestore', 15:45:10 INFO - 'sessionrestore_no_auto_restore', 15:45:10 INFO - 'tabpaint']}, 15:45:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['a11yr', 15:45:10 INFO - 'ts_paint', 15:45:10 INFO - 'tpaint', 15:45:10 INFO - 'sessionrestore', 15:45:10 INFO - 'sessionrestore_no_auto_restore', 15:45:10 INFO - 'tabpaint']}, 15:45:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['a11yr', 15:45:10 INFO - 'ts_paint', 15:45:10 INFO - 'tpaint', 15:45:10 INFO - 'sessionrestore', 15:45:10 INFO - 'sessionrestore_no_auto_restore', 15:45:10 INFO - 'tabpaint']}, 15:45:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['tsvgx', 15:45:10 INFO - 'tsvgr_opacity', 15:45:10 INFO - 'tart', 15:45:10 INFO - 'tscrollx', 15:45:10 INFO - 'cart']}, 15:45:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:45:10 INFO - 'tsvgr_opacity', 15:45:10 INFO - 'tart', 15:45:10 INFO - 'tscrollx', 15:45:10 INFO - 'cart']}, 15:45:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:10 INFO - 'talos_options': ['--disable-e10s'], 15:45:10 INFO - 'tests': ['tp5o']}, 15:45:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:10 INFO - 'tests': ['tp5o']}, 15:45:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:10 INFO - 'talos_options': ['--disable-e10s', 15:45:10 INFO - '--xperf_path', 15:45:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:10 INFO - 'tests': ['tp5n']}, 15:45:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:10 INFO - 'talos_options': ['--xperf_path', 15:45:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:10 INFO - 'tests': ['tp5n']}}, 15:45:10 INFO - 'talos.zip': {'path': '', 15:45:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:45:10 INFO - Running post-action listener: _resource_record_post_action 15:45:10 INFO - [mozharness: 2016-10-03 22:45:10.855923Z] Finished populate-webroot step (success) 15:45:10 INFO - [mozharness: 2016-10-03 22:45:10.856012Z] Running create-virtualenv step. 15:45:10 INFO - Running pre-action listener: _resource_record_pre_action 15:45:10 INFO - Running main action method: create_virtualenv 15:45:10 INFO - Creating virtualenv /builds/slave/test/build/venv 15:45:10 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 15:45:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:45:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:45:10 INFO - Using real prefix '/usr' 15:45:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:45:11 INFO - Installing distribute.............................................................................................................................................................................................done. 15:45:13 INFO - Installing pip.................done. 15:45:13 INFO - Return code: 0 15:45:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:45:13 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')]} 15:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:13 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')]} 15:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:13 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 0x204e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, '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': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', '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 15:45:13 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 15:45:13 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 15:45:13 INFO - Using env: {'DISPLAY': ':0', 15:45:13 INFO - 'HOME': '/home/cltbld', 15:45:13 INFO - 'LANG': 'en_US.UTF-8', 15:45:13 INFO - 'LANGUAGE': 'en_US:en', 15:45:13 INFO - 'LOGNAME': 'cltbld', 15:45:13 INFO - 'MAIL': '/var/mail/cltbld', 15:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:13 INFO - 'MOZ_NO_REMOTE': '1', 15:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:13 INFO - 'NO_EM_RESTART': '1', 15:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:13 INFO - 'PWD': '/builds/slave/test', 15:45:13 INFO - 'SHELL': '/bin/bash', 15:45:13 INFO - 'SHLVL': '1', 15:45:13 INFO - 'TERM': 'linux', 15:45:13 INFO - 'TMOUT': '86400', 15:45:13 INFO - 'USER': 'cltbld', 15:45:13 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:13 INFO - '_': '/tools/buildbot/bin/python'} 15:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:13 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 15:45:13 INFO - Cleaning up... 15:45:13 INFO - Return code: 0 15:45:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:45:13 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')]} 15:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:13 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')]} 15:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:13 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 0x204e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, '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': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', '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 15:45:13 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 15:45:13 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 15:45:13 INFO - Using env: {'DISPLAY': ':0', 15:45:13 INFO - 'HOME': '/home/cltbld', 15:45:13 INFO - 'LANG': 'en_US.UTF-8', 15:45:13 INFO - 'LANGUAGE': 'en_US:en', 15:45:13 INFO - 'LOGNAME': 'cltbld', 15:45:13 INFO - 'MAIL': '/var/mail/cltbld', 15:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:13 INFO - 'MOZ_NO_REMOTE': '1', 15:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:13 INFO - 'NO_EM_RESTART': '1', 15:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:13 INFO - 'PWD': '/builds/slave/test', 15:45:13 INFO - 'SHELL': '/bin/bash', 15:45:13 INFO - 'SHLVL': '1', 15:45:13 INFO - 'TERM': 'linux', 15:45:13 INFO - 'TMOUT': '86400', 15:45:13 INFO - 'USER': 'cltbld', 15:45:13 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:13 INFO - '_': '/tools/buildbot/bin/python'} 15:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:13 INFO - Downloading/unpacking psutil>=3.1.1 15:45:13 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 15:45:13 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 15:45:13 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 15:45:13 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 15:45:13 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 15:45:13 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 15:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:45:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:15 INFO - Installing collected packages: psutil 15:45:15 INFO - Running setup.py install for psutil 15:45:15 INFO - building 'psutil._psutil_linux' extension 15:45:15 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 15:45:16 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 15:45:16 INFO - building 'psutil._psutil_posix' extension 15:45:16 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 15:45:16 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 15:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:16 INFO - Successfully installed psutil 15:45:16 INFO - Cleaning up... 15:45:16 INFO - Return code: 0 15:45:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:45:16 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')]} 15:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:16 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')]} 15:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:16 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 0x204e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, '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': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', '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 15:45:16 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 15:45:16 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 15:45:16 INFO - Using env: {'DISPLAY': ':0', 15:45:16 INFO - 'HOME': '/home/cltbld', 15:45:16 INFO - 'LANG': 'en_US.UTF-8', 15:45:16 INFO - 'LANGUAGE': 'en_US:en', 15:45:16 INFO - 'LOGNAME': 'cltbld', 15:45:16 INFO - 'MAIL': '/var/mail/cltbld', 15:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:16 INFO - 'MOZ_NO_REMOTE': '1', 15:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:16 INFO - 'NO_EM_RESTART': '1', 15:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:16 INFO - 'PWD': '/builds/slave/test', 15:45:16 INFO - 'SHELL': '/bin/bash', 15:45:16 INFO - 'SHLVL': '1', 15:45:16 INFO - 'TERM': 'linux', 15:45:16 INFO - 'TMOUT': '86400', 15:45:16 INFO - 'USER': 'cltbld', 15:45:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:16 INFO - '_': '/tools/buildbot/bin/python'} 15:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:45:16 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 15:45:16 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 15:45:16 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 15:45:16 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 15:45:16 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 15:45:16 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 15:45:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:45:18 INFO - Installing collected packages: mozsystemmonitor 15:45:18 INFO - Running setup.py install for mozsystemmonitor 15:45:18 INFO - Successfully installed mozsystemmonitor 15:45:18 INFO - Cleaning up... 15:45:18 INFO - Return code: 0 15:45:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:45:18 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')]} 15:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:18 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')]} 15:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:18 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 0x204e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, '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': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', '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 15:45:18 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 15:45:18 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 15:45:18 INFO - Using env: {'DISPLAY': ':0', 15:45:18 INFO - 'HOME': '/home/cltbld', 15:45:18 INFO - 'LANG': 'en_US.UTF-8', 15:45:18 INFO - 'LANGUAGE': 'en_US:en', 15:45:18 INFO - 'LOGNAME': 'cltbld', 15:45:18 INFO - 'MAIL': '/var/mail/cltbld', 15:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:18 INFO - 'MOZ_NO_REMOTE': '1', 15:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:18 INFO - 'NO_EM_RESTART': '1', 15:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:18 INFO - 'PWD': '/builds/slave/test', 15:45:18 INFO - 'SHELL': '/bin/bash', 15:45:18 INFO - 'SHLVL': '1', 15:45:18 INFO - 'TERM': 'linux', 15:45:18 INFO - 'TMOUT': '86400', 15:45:18 INFO - 'USER': 'cltbld', 15:45:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:18 INFO - '_': '/tools/buildbot/bin/python'} 15:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:18 INFO - Downloading/unpacking jsonschema==2.5.1 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:18 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 15:45:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:45:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:45:20 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 15:45:20 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 15:45:20 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 15:45:20 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 15:45:20 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 15:45:20 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 15:45:21 INFO - Downloading functools32-3.2.3-2.tar.gz 15:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:45:21 INFO - warning: no files found matching '*.txt' 15:45:21 INFO - no previously-included directories found matching 'build' 15:45:21 INFO - no previously-included directories found matching 'dist' 15:45:21 INFO - no previously-included directories found matching '.git*' 15:45:21 INFO - Installing collected packages: jsonschema, functools32 15:45:21 INFO - Running setup.py install for functools32 15:45:21 INFO - warning: no files found matching '*.txt' 15:45:21 INFO - no previously-included directories found matching 'build' 15:45:21 INFO - no previously-included directories found matching 'dist' 15:45:21 INFO - no previously-included directories found matching '.git*' 15:45:21 INFO - Successfully installed jsonschema functools32 15:45:21 INFO - Cleaning up... 15:45:21 INFO - Return code: 0 15:45:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:45:21 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')]} 15:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:21 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')]} 15:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:21 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 0x204e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, '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': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', '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 15:45:21 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 15:45:21 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 15:45:21 INFO - Using env: {'DISPLAY': ':0', 15:45:21 INFO - 'HOME': '/home/cltbld', 15:45:21 INFO - 'LANG': 'en_US.UTF-8', 15:45:21 INFO - 'LANGUAGE': 'en_US:en', 15:45:21 INFO - 'LOGNAME': 'cltbld', 15:45:21 INFO - 'MAIL': '/var/mail/cltbld', 15:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:21 INFO - 'MOZ_NO_REMOTE': '1', 15:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:21 INFO - 'NO_EM_RESTART': '1', 15:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:21 INFO - 'PWD': '/builds/slave/test', 15:45:21 INFO - 'SHELL': '/bin/bash', 15:45:21 INFO - 'SHLVL': '1', 15:45:21 INFO - 'TERM': 'linux', 15:45:21 INFO - 'TMOUT': '86400', 15:45:21 INFO - 'USER': 'cltbld', 15:45:21 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:21 INFO - '_': '/tools/buildbot/bin/python'} 15:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:45:21 INFO - Cleaning up... 15:45:21 INFO - Return code: 0 15:45:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:45:21 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')]} 15:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:21 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')]} 15:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:21 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 0x204e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, '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': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', '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 15:45:21 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 15:45:21 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 15:45:21 INFO - Using env: {'DISPLAY': ':0', 15:45:21 INFO - 'HOME': '/home/cltbld', 15:45:21 INFO - 'LANG': 'en_US.UTF-8', 15:45:21 INFO - 'LANGUAGE': 'en_US:en', 15:45:21 INFO - 'LOGNAME': 'cltbld', 15:45:21 INFO - 'MAIL': '/var/mail/cltbld', 15:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:21 INFO - 'MOZ_NO_REMOTE': '1', 15:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:21 INFO - 'NO_EM_RESTART': '1', 15:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:21 INFO - 'PWD': '/builds/slave/test', 15:45:21 INFO - 'SHELL': '/bin/bash', 15:45:21 INFO - 'SHLVL': '1', 15:45:21 INFO - 'TERM': 'linux', 15:45:21 INFO - 'TMOUT': '86400', 15:45:21 INFO - 'USER': 'cltbld', 15:45:21 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:21 INFO - '_': '/tools/buildbot/bin/python'} 15:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:21 INFO - Downloading/unpacking blobuploader==1.2.4 15:45:21 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 15:45:21 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 15:45:21 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 15:45:21 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 15:45:21 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 15:45:21 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 15:45:23 INFO - Downloading blobuploader-1.2.4.tar.gz 15:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:45:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:45:23 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 15:45:23 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 15:45:23 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 15:45:23 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 15:45:23 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 15:45:23 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 15:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:45:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:45:24 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 15:45:24 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 15:45:24 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 15:45:24 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 15:45:24 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 15:45:24 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 15:45:24 INFO - Downloading docopt-0.6.1.tar.gz 15:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:45:24 INFO - Installing collected packages: blobuploader, requests, docopt 15:45:24 INFO - Running setup.py install for blobuploader 15:45:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:45:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:45:24 INFO - Running setup.py install for requests 15:45:24 INFO - Running setup.py install for docopt 15:45:24 INFO - Successfully installed blobuploader requests docopt 15:45:24 INFO - Cleaning up... 15:45:24 INFO - Return code: 0 15:45:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:25 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')]} 15:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:25 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')]} 15:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:25 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 0x204e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, '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': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', '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 15:45:25 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 15:45:25 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 15:45:25 INFO - Using env: {'DISPLAY': ':0', 15:45:25 INFO - 'HOME': '/home/cltbld', 15:45:25 INFO - 'LANG': 'en_US.UTF-8', 15:45:25 INFO - 'LANGUAGE': 'en_US:en', 15:45:25 INFO - 'LOGNAME': 'cltbld', 15:45:25 INFO - 'MAIL': '/var/mail/cltbld', 15:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:25 INFO - 'MOZ_NO_REMOTE': '1', 15:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:25 INFO - 'NO_EM_RESTART': '1', 15:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:25 INFO - 'PWD': '/builds/slave/test', 15:45:25 INFO - 'SHELL': '/bin/bash', 15:45:25 INFO - 'SHLVL': '1', 15:45:25 INFO - 'TERM': 'linux', 15:45:25 INFO - 'TMOUT': '86400', 15:45:25 INFO - 'USER': 'cltbld', 15:45:25 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:25 INFO - '_': '/tools/buildbot/bin/python'} 15:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:25 INFO - Running setup.py (path:/tmp/pip-7uubZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:25 INFO - Running setup.py (path:/tmp/pip-HR288v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:25 INFO - Running setup.py (path:/tmp/pip-Zu7p8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:25 INFO - Running setup.py (path:/tmp/pip-1HCteY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:25 INFO - Running setup.py (path:/tmp/pip-vreKsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:25 INFO - Running setup.py (path:/tmp/pip-5dry3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:25 INFO - Running setup.py (path:/tmp/pip-1ufKfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:25 INFO - Running setup.py (path:/tmp/pip-yG1pqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:25 INFO - Running setup.py (path:/tmp/pip-TvQVHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:25 INFO - Running setup.py (path:/tmp/pip-a42SAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:25 INFO - Running setup.py (path:/tmp/pip-_bFpux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:26 INFO - Running setup.py (path:/tmp/pip-kVH8NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:26 INFO - Running setup.py (path:/tmp/pip-SlcFYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:26 INFO - Running setup.py (path:/tmp/pip-ad72hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:26 INFO - Running setup.py (path:/tmp/pip-pdjD3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:26 INFO - Running setup.py (path:/tmp/pip-KBXb9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:26 INFO - Running setup.py (path:/tmp/pip-jIpkHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:45:26 INFO - Running setup.py install for manifestparser 15:45:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:45:26 INFO - Running setup.py install for mozcrash 15:45:26 INFO - Running setup.py install for mozdebug 15:45:26 INFO - Running setup.py install for mozdevice 15:45:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:45:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:45:26 INFO - Running setup.py install for mozfile 15:45:26 INFO - Running setup.py install for mozhttpd 15:45:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Running setup.py install for mozinfo 15:45:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Running setup.py install for mozInstall 15:45:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Running setup.py install for mozleak 15:45:27 INFO - Running setup.py install for mozlog 15:45:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Running setup.py install for moznetwork 15:45:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Running setup.py install for mozprocess 15:45:27 INFO - Running setup.py install for mozprofile 15:45:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Running setup.py install for mozrunner 15:45:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Running setup.py install for mozscreenshot 15:45:28 INFO - Running setup.py install for moztest 15:45:28 INFO - Running setup.py install for mozversion 15:45:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:45:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:45:28 INFO - Cleaning up... 15:45:28 INFO - Return code: 0 15:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:28 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')]} 15:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:28 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')]} 15:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:28 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 0x204e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, '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': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', '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 15:45:28 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 15:45:28 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 15:45:28 INFO - Using env: {'DISPLAY': ':0', 15:45:28 INFO - 'HOME': '/home/cltbld', 15:45:28 INFO - 'LANG': 'en_US.UTF-8', 15:45:28 INFO - 'LANGUAGE': 'en_US:en', 15:45:28 INFO - 'LOGNAME': 'cltbld', 15:45:28 INFO - 'MAIL': '/var/mail/cltbld', 15:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:28 INFO - 'MOZ_NO_REMOTE': '1', 15:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:28 INFO - 'NO_EM_RESTART': '1', 15:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:28 INFO - 'PWD': '/builds/slave/test', 15:45:28 INFO - 'SHELL': '/bin/bash', 15:45:28 INFO - 'SHLVL': '1', 15:45:28 INFO - 'TERM': 'linux', 15:45:28 INFO - 'TMOUT': '86400', 15:45:28 INFO - 'USER': 'cltbld', 15:45:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:28 INFO - '_': '/tools/buildbot/bin/python'} 15:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:28 INFO - Running setup.py (path:/tmp/pip-J0ooy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:28 INFO - Running setup.py (path:/tmp/pip-oEEsMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:28 INFO - Running setup.py (path:/tmp/pip-2yrGXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:28 INFO - Running setup.py (path:/tmp/pip-EtmvC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:28 INFO - Running setup.py (path:/tmp/pip-rYA54T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:28 INFO - Running setup.py (path:/tmp/pip-S01B3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:28 INFO - Running setup.py (path:/tmp/pip-f4K7Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:28 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)) 15:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:28 INFO - Running setup.py (path:/tmp/pip-kE1yG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:29 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)) 15:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:29 INFO - Running setup.py (path:/tmp/pip-eY6EvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:29 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)) 15:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:29 INFO - Running setup.py (path:/tmp/pip-TTOl5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:29 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)) 15:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:29 INFO - Running setup.py (path:/tmp/pip-whEKfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:29 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)) 15:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:29 INFO - Running setup.py (path:/tmp/pip-6YRHvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:29 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)) 15:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:29 INFO - Running setup.py (path:/tmp/pip-JHHrzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:29 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)) 15:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:29 INFO - Running setup.py (path:/tmp/pip-f_2HvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:29 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)) 15:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:29 INFO - Running setup.py (path:/tmp/pip-k21JJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:29 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)) 15:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:29 INFO - Running setup.py (path:/tmp/pip-ysY8fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:29 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)) 15:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:29 INFO - Running setup.py (path:/tmp/pip-YGOk6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:29 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)) 15:45:29 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)) 15:45:29 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)) 15:45:29 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)) 15:45:29 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)) 15:45:29 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)) 15:45:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:45:29 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 15:45:29 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 15:45:29 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 15:45:29 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 15:45:29 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 15:45:29 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 15:45:31 INFO - Downloading blessings-1.6.tar.gz 15:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:45:31 INFO - Installing collected packages: blessings 15:45:31 INFO - Running setup.py install for blessings 15:45:31 INFO - Successfully installed blessings 15:45:31 INFO - Cleaning up... 15:45:31 INFO - Return code: 0 15:45:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:45:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:32 INFO - Reading from file tmpfile_stdout 15:45:32 INFO - Current package versions: 15:45:32 INFO - argparse == 1.2.1 15:45:32 INFO - blessings == 1.6 15:45:32 INFO - blobuploader == 1.2.4 15:45:32 INFO - docopt == 0.6.1 15:45:32 INFO - functools32 == 3.2.3-2 15:45:32 INFO - jsonschema == 2.5.1 15:45:32 INFO - manifestparser == 1.1 15:45:32 INFO - mozInstall == 1.12 15:45:32 INFO - mozcrash == 0.17 15:45:32 INFO - mozdebug == 0.1 15:45:32 INFO - mozdevice == 0.48 15:45:32 INFO - mozfile == 1.2 15:45:32 INFO - mozhttpd == 0.7 15:45:32 INFO - mozinfo == 0.9 15:45:32 INFO - mozleak == 0.1 15:45:32 INFO - mozlog == 3.3 15:45:32 INFO - moznetwork == 0.27 15:45:32 INFO - mozprocess == 0.23 15:45:32 INFO - mozprofile == 0.28 15:45:32 INFO - mozrunner == 6.12 15:45:32 INFO - mozscreenshot == 0.1 15:45:32 INFO - mozsystemmonitor == 0.3 15:45:32 INFO - moztest == 0.7 15:45:32 INFO - mozversion == 1.4 15:45:32 INFO - psutil == 3.1.1 15:45:32 INFO - requests == 1.2.3 15:45:32 INFO - wsgiref == 0.1.2 15:45:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:32 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')]} 15:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:32 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')]} 15:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:32 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 0x204e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, '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': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', '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 15:45:32 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 15:45:32 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 15:45:32 INFO - Using env: {'DISPLAY': ':0', 15:45:32 INFO - 'HOME': '/home/cltbld', 15:45:32 INFO - 'LANG': 'en_US.UTF-8', 15:45:32 INFO - 'LANGUAGE': 'en_US:en', 15:45:32 INFO - 'LOGNAME': 'cltbld', 15:45:32 INFO - 'MAIL': '/var/mail/cltbld', 15:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:32 INFO - 'MOZ_NO_REMOTE': '1', 15:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:32 INFO - 'NO_EM_RESTART': '1', 15:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:32 INFO - 'PWD': '/builds/slave/test', 15:45:32 INFO - 'SHELL': '/bin/bash', 15:45:32 INFO - 'SHLVL': '1', 15:45:32 INFO - 'TERM': 'linux', 15:45:32 INFO - 'TMOUT': '86400', 15:45:32 INFO - 'USER': 'cltbld', 15:45:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:32 INFO - '_': '/tools/buildbot/bin/python'} 15:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 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)) 15:45:32 INFO - Cleaning up... 15:45:32 INFO - Return code: 0 15:45:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:45:32 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')]} 15:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:32 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')]} 15:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:32 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 0x204e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, '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': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', '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 15:45:32 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 15:45:32 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 15:45:32 INFO - Using env: {'DISPLAY': ':0', 15:45:32 INFO - 'HOME': '/home/cltbld', 15:45:32 INFO - 'LANG': 'en_US.UTF-8', 15:45:32 INFO - 'LANGUAGE': 'en_US:en', 15:45:32 INFO - 'LOGNAME': 'cltbld', 15:45:32 INFO - 'MAIL': '/var/mail/cltbld', 15:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:32 INFO - 'MOZ_NO_REMOTE': '1', 15:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:32 INFO - 'NO_EM_RESTART': '1', 15:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:32 INFO - 'PWD': '/builds/slave/test', 15:45:32 INFO - 'SHELL': '/bin/bash', 15:45:32 INFO - 'SHLVL': '1', 15:45:32 INFO - 'TERM': 'linux', 15:45:32 INFO - 'TMOUT': '86400', 15:45:32 INFO - 'USER': 'cltbld', 15:45:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:32 INFO - '_': '/tools/buildbot/bin/python'} 15:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:45:32 INFO - Cleaning up... 15:45:32 INFO - Return code: 0 15:45:32 INFO - Running post-action listener: _resource_record_post_action 15:45:32 INFO - Running post-action listener: _start_resource_monitoring 15:45:32 INFO - Starting resource monitoring. 15:45:32 INFO - [mozharness: 2016-10-03 22:45:32.545200Z] Finished create-virtualenv step (success) 15:45:32 INFO - [mozharness: 2016-10-03 22:45:32.545750Z] Running install step. 15:45:32 INFO - Running pre-action listener: _resource_record_pre_action 15:45:32 INFO - Running main action method: install 15:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:32 INFO - Reading from file tmpfile_stdout 15:45:32 INFO - Detecting whether we're running mozinstall >=1.0... 15:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:45:32 INFO - Reading from file tmpfile_stdout 15:45:32 INFO - Output received: 15:45:32 INFO - Usage: mozinstall [options] installer 15:45:32 INFO - Options: 15:45:32 INFO - -h, --help show this help message and exit 15:45:32 INFO - -d DEST, --destination=DEST 15:45:32 INFO - Directory to install application into. [default: 15:45:32 INFO - "/builds/slave/test"] 15:45:32 INFO - --app=APP Application being installed. [default: firefox] 15:45:32 INFO - mkdir: /builds/slave/test/build/application 15:45:32 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'] 15:45:32 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 15:45:46 INFO - Reading from file tmpfile_stdout 15:45:46 INFO - Output received: 15:45:46 INFO - /builds/slave/test/build/application/firefox/firefox 15:45:46 INFO - Running post-action listener: _resource_record_post_action 15:45:46 INFO - [mozharness: 2016-10-03 22:45:46.326664Z] Finished install step (success) 15:45:46 INFO - [mozharness: 2016-10-03 22:45:46.326950Z] Running run-tests step. 15:45:46 INFO - Running pre-action listener: _resource_record_pre_action 15:45:46 INFO - Running main action method: run_tests 15:45:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:45:46 INFO - Python 2.7.3 15:45:46 INFO - Return code: 0 15:45:46 INFO - grabbing minidump binary from tooltool 15:45: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')]} 15:45:46 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 0x230d3b0>, '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 0x230e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:45:46 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 15:45:46 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 15:45:46 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 15:45:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:45:46 INFO - Return code: 0 15:45:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:45:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:45:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:45:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:45:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:45:46 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:45:46 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:45:46 INFO - Using env: {'DISPLAY': ':0', 15:45:46 INFO - 'HOME': '/home/cltbld', 15:45:46 INFO - 'LANG': 'en_US.UTF-8', 15:45:46 INFO - 'LANGUAGE': 'en_US:en', 15:45:46 INFO - 'LOGNAME': 'cltbld', 15:45:46 INFO - 'MAIL': '/var/mail/cltbld', 15:45:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:45:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:46 INFO - 'MOZ_NO_REMOTE': '1', 15:45:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:46 INFO - 'NO_EM_RESTART': '1', 15:45:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:46 INFO - 'PWD': '/builds/slave/test', 15:45:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:45:46 INFO - 'SHELL': '/bin/bash', 15:45:46 INFO - 'SHLVL': '1', 15:45:46 INFO - 'TERM': 'linux', 15:45:46 INFO - 'TMOUT': '86400', 15:45:46 INFO - 'USER': 'cltbld', 15:45:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443', 15:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:46 INFO - '_': '/tools/buildbot/bin/python'} 15:45:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:45:46 INFO - mozversion application_buildid: 20161003124659 15:45:46 INFO - mozversion application_changeset: 47dff98b4b466b0b373ff04a2bb95542260be0c3 15:45:46 INFO - mozversion application_display_name: Firefox 15:45:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:45:46 INFO - mozversion application_name: Firefox 15:45:46 INFO - mozversion application_remotingname: firefox 15:45:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:45:46 INFO - mozversion application_vendor: Mozilla 15:45:46 INFO - mozversion application_version: 50.0 15:45:46 INFO - mozversion platform_buildid: 20161003124659 15:45:46 INFO - mozversion platform_changeset: 47dff98b4b466b0b373ff04a2bb95542260be0c3 15:45:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:45:46 INFO - mozversion platform_version: 50.0 15:45:46 INFO - using testdate: 1475534746 15:45:46 INFO - actual date: 1475534746 15:45:46 INFO - starting webserver on 'localhost:50975' 15:45:46 INFO - SUITE-START | Running 2 tests 15:45:46 INFO - TEST-START | dromaeo_css 15:45:46 INFO - operating with platform_type : linux_ 15:45:46 INFO - Initialising browser for dromaeo_css test... 15:45:46 INFO - TEST-INFO | started process 19374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBI24BC/profile http://localhost:50975/getInfo.html) 15:45:50 INFO - PROCESS | 19374 | __metrics Screen width/height:1600/1200 15:45:50 INFO - PROCESS | 19374 | colorDepth:24 15:45:50 INFO - PROCESS | 19374 | Browser inner width/height: 1024/697 15:45:50 INFO - PROCESS | 19374 | __metrics 15:45:51 INFO - PROCESS | 19374 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:45:51 INFO - PROCESS | 19374 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:45:52 INFO - TEST-INFO | 19374: exit 0 15:45:52 INFO - Browser initialized. 15:45:52 INFO - Running cycle 1/1 for dromaeo_css test... 15:45:52 INFO - TEST-INFO | started process 19461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBI24BC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:04 INFO - PROCESS | 19461 | RSS: Main: 143945728 15:46:04 INFO - PROCESS | 19461 | 15:46:55 INFO - PROCESS | 19461 | 1475534815386 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] 15:49:04 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:50975/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50975/tests/dromaeo/cssquery-ext.html) 15:49:05 INFO - PROCESS | 19461 | RSS: Main: 240988160 15:49:05 INFO - PROCESS | 19461 | 15:52:07 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:50975/tests/dromaeo/cssquery-ext.html (next: http://localhost:50975/tests/dromaeo/cssquery-jquery.html) 15:52:08 INFO - PROCESS | 19461 | RSS: Main: 235114496 15:52:08 INFO - PROCESS | 19461 | 15:55:10 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:50975/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50975/tests/dromaeo/cssquery-mootools.html) 15:55:10 INFO - PROCESS | 19461 | RSS: Main: 193519616 15:55:10 INFO - PROCESS | 19461 | 15:58:12 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:50975/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50975/tests/dromaeo/cssquery-prototype.html) 15:58:13 INFO - PROCESS | 19461 | RSS: Main: 202690560 15:58:13 INFO - PROCESS | 19461 | 16:01:15 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:50975/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50975/tests/dromaeo/cssquery-yui.html) 16:01:16 INFO - PROCESS | 19461 | RSS: Main: 173035520 16:01:16 INFO - PROCESS | 19461 | 16:04:19 INFO - PROCESS | 19461 | Cycle 1(1): loaded http://localhost:50975/tests/dromaeo/cssquery-yui.html (next: http://localhost:50975/tests/dromaeo/cssquery-dojo.html) 16:04:19 INFO - PROCESS | 19461 | RSS: Main: 262610944 16:04:19 INFO - PROCESS | 19461 | 16:04:19 INFO - PROCESS | 19461 | __start_tp_report 16:04:19 INFO - PROCESS | 19461 | _x_x_mozilla_page_load 16:04:19 INFO - PROCESS | 19461 | _x_x_mozilla_page_load_details 16:04:19 INFO - PROCESS | 19461 | |i|pagename|runs| 16:04:19 INFO - PROCESS | 19461 | |0;dojo.html;3214.758893083019;3224.1456014156247;3232.385846689129;3259.054874086515;3272.1655977725677;5574.972125139374;5675.177099320601;5675.772969081242;5677.659340439566;5707.9143812842785;5653.717314134297;5688.63023903446;5691.715414229293;5692.6299790513585;5698.316202055748;5124.8975020499665;5131.153359695646;5140.974295128538;5142.0487209866105;5213.218017297398;5092.388913330406;5128.974355128219;5205.3233079699585;5226.346706661668;5248.790048398059;5069.771860266297;5113.2330150477355;5116.820911268106;5154.845354639367;5160.767765450545;5085.872853178663;5124.538791508745;5212.40057393397;5212.687238765686;5246.449122842085;5051.570616497602;5057.848264552069;5132.897342053138;5177.559907407875;5199.922001169985;5544.695041772701;5605.971970140164;5614.242077319551;5616.241807355996;5636.577256705723;6092.908606370908;6138.693065346715;6192.473639740628;6196.659183744892;6201.441870231656;5999.370066143036;6084.361142080106;6213.5029197664535;6217.68911554425;6230.096635987757;5722.856928576777;5746.454086861741;5767.250257466502;5801.506871915893;5812.186293918855;6302.4958003359625;6309.810705678837;6310.0850376695125;6310.368963103745;6321.778737744157;5866.442687944638;5932.317783454958;6045.546584006217;6053.00125479291;6064.575479716377;6135.661410523283;6145.4161854623735;6153.1693221415435;6165.445109940127;6166.537509686791;6120.326764055951;6128.3565225651555;6133.877322453526;6134.386561343919;6140.3552626974415;5907.350191478934;5929.199558059607;5966.731497082642;6060.122319887497;6112.235970503687;4610.792514336796;4641.18779213643;4646.814127434933;4647.697899636512;4649.139909116757;4080.2859499587453;4124.13393187428;4145.336746120606;4145.357469592218;4152.5432202457705;5787.71061446926;5791.449812267828;5792.507636850831;5792.768289268466;5820.3888591698105;6110.327863934964;6121.387861213843;6126.23422072241;6128.908066379008;6130.049842274455;5672.971635141798;5719.828405147852;5735.053716136791;5775.595708300379;5777.566682498829;5303.257543943851;5307.071262529042;5311.336082989626;5311.946880531223;5312.787488500417;6302.243730752248;6316.652584107918;6362.618242905348;6365.904511432333;6368.617882927039;5936.525077993664;6055.878882422238;6121.051237058263;6124.693765311806;6157.415045570664;6379.5215358847345;6394;6395.20059992501;6398.328175541687;6406;6079.756809727738;6082.300535438481;6088.908666370096;6096.055111457731;6096.8780624388155;5954.791582294599;5955.583109182316;5971.0744834550715;5972.163897054503;6146.938530614637;5866.032104702676;5900.940990590211;5913.349531551612;5927.288725352985;5930.970345148246;5832.445917637818;5887.116932460165;5888;5891.1752354671235;5904.911426328695;5767.365589785037;5871.706414679335;5887.911681324698;5952.226210592596;5956.642601443928;6061.636301821904;6061.939380606137;6071.216587609186;6074.088886667036;6087.817365479043;5865.73604187804;5894.086416605433;5899.616524925866;5903.557233207441;5923.49650279731 16:04:19 INFO - PROCESS | 19461 | |1;ext.html;598.2701104652323;637.6907200007997;653.5392548253482;656.0127008851678;667.1293961380399;27511.312217194554;28564.714352856467;47249.7637511812;48040.27939580909;48186.03627927439;49833;50333;50378.24432633514;50407.49592504074;50526.74736626321;8768.254698350647;9372.812543749122;9521.619135234618;9524;9533.713988580354;8711.259542938826;9011.639534418615;11251.099912007061;11530.942345288304;11538.596149134783;11560.364179970098;11620.709482262926;11624.302541847474;11626.128040397005;11632.243904146246;11499.885001149965;11569.247998880046;11577.6526704199;11578.942105289503;11582.536698532049;11381.146414018982;11432.657020289405;11448.484818183118;11453.37006464644;11455.828162577567;47136.528634713555;47271.29093063607;47552.762236188944;47578;47709.76145119287;3799.3731034379293;3871.728978971473;4082.6937979651348;4513.232750432401;4731.976340118312;33748.32503349919;36512.452313215326;37106.257874842355;37161.44257836135;38473.23053538942;4714.83498077569;4741.122892264942;4804.5916097131785;4805.8558243252755;4881.658283920127;409264;418796;418991;420322;420441;39344.80327598344;70512.2948770516;71514.2848571518;71614;71674.64162679258;40325.39511907324;42755.35866961998;42806.357904631455;43137.78431107824;43225.56774432278;15797.289121989537;15911;15911.920440397724;15925.203739812963;15931.522054338388;13258.734825303633;13311.267880266678;13313.33433328349;13317.134386264861;13324.533641322507;9172.44965302084;9563.282753793494;9857.309988300893;9857.408555486694;9970.651027214013;3675.963240367562;3722.2927643747603;3725.2921944830396;3762.3039737648623;3762.774233545996;1034.4414016431194;1140.937248451343;1159.4550561236206;1210.5365581042536;1218.7196944702769;33310.50034249488;33591;34023.149421264665;34166.316673666384;34435.655643443744;1152.7636834448917;1158.8551431071116;1170.6253998720329;1201.3392634051236;1222.3216115056052;17957;18141.482874225432;18239.908800455913;18275;18310.176042077874;576834;577380;577737;578573;579445;66890;67312.3268767306;67317;67369.66315168393;67480.66259668769;1337.104140226051;1390.5480718766441;1429.2496439369415;1432.9467841136757;1455.9814910846142;34193;35658.28683426369;35825.74609888641;35993.64006359903;36244.637553624125;56852.71573642105;57662;57697.4230257692;57753;57779.1333129995;432288;435319;435485;435527;435644;29123.563146553242;29445.558316625695;29537.852310738308;31499.685003149676;31614.683853162092;53830.19254711261;54015.45984540104;54182.72908635432;54546.181807273715;55034.17448738352;43833;44157.55842441534;46087.308690370344;46845.765771172286;47602.52397475981;44903.32645010393;45294;45804;46107.76946115248;46831.29753053775;44189.337159941984;44891.326630101226;45271.773641131585;45361.546384537054;45374.09251814879;37645.435318470794;39842;40377.79811100926;40470;40866;28300.168684410284;28369.574456383583;28697;28757;28849 16:04:19 INFO - PROCESS | 19461 | |2;jquery.html;415.792103948026;424.86057763775597;431.81431984246774;435.8060663004964;435.9542248063953;18615.720764188532;19160.61678766424;19788.70316945247;20189.899050504744;20609.175632974682;19594.608107837834;20075.297364592207;20088.799112008877;20562;20749.688754668692;5900.822975310747;6119.755209791603;6125.938740612603;6129.632222066668;6129.785457508988;5815.098659707752;5860.501857342131;5939.7921072762465;5964.582479226456;6005.909911351333;5931.436513531207;5931.673757943311;5932.199153114318;5934.821955341346;5935.109733539982;5871.236739223895;5933.614315069528;5963.552733544958;5965.403459654043;5972.07432847905;5239.21411788231;5294;5396.217548455452;5399.730013499309;5402.189671549259;23833.761662383502;24033.519329613486;24228.636570451457;24313.756862431503;24529.141480048114;2607.204802535226;2618.9345266368305;2791.734785195403;2872.755815755663;3041.4981528047847;7580.355669768076;7623.085229772408;11073.723156921142;15224.325324214327;15613.297401616954;1971.428285797117;1994.8104930031623;2005.6089062632793;2014.446027342478;2058.0944384470786;55957.720211398686;74697;74874.62562687152;79106.60446697788;85201.14798851994;11278.492467838967;11354.602588909349;11363.204575679623;11451.88548114525;11795.705107372385;16077.196140192944;16198.433054843259;16207.675846483004;16236.269367878474;16244.593885152966;8526.65893364271;8648.654053837776;8657.913420865836;8673.869891951626;8985.820283594292;8189.344852411793;8196.42625016243;8317.792055198668;8415.410921235578;8422.326213902874;6824;7041.605854009661;7046.577205367695;7059.2234854166;7080.256573059857;2004.2183548416128;2010.2863483463452;2018.4247489465727;2023.130054076761;2056.4036429435296;991.7619771254991;1004.1113614451117;1018.2261481274137;1047.6428036916936;1069.2087854987408;20457.79542204559;20972.685409718866;21010.15959361639;21056.473588160112;21066.578668426544;1041.6041904076553;1081.464674985887;1083.274206281793;1083.5774048121239;1121.6522877907876;11852.940735296268;12057.240643833307;12060.698482538006;12113;12155.574554890536;497507;500117;523949;580651;583047;59325.70337148373;80792;81192;81710.59144704239;83223.58388208141;1093.775775965925;1094.2887123369874;1099.4997276239133;1104.5526561742506;1115.3642423818346;18194.45416637503;18543.443696689123;18710;18900.072823040144;18907.905460472608;39630.2073958525;41240.1751964965;41811.58188418077;42030.57969420389;42115;49880.501194987584;58557.4144258569;58959.70520147372;60375.39624603698;60501.69749151402;8501.829963400574;8678.392512524315;8786.077461866413;8812.91187088121;9093.499857507635;9503.809923801624;13393.799093013418;13583.796243056164;14111.22388268655;14263.928680356532;11979.460924258256;12076.75846483083;12316;12335.074869384653;12522.874771252535;10950.671479855617;11102.666919992413;11316.377599231791;11435.085193184359;11535.884641153481;11935.880641193477;12062.155649104478;12149.574764883188;12672.683182920133;12708.36458177069;8667.609957552051;8825.823483530165;8977.596008179517;9002.774930626787;9036.954815225881;9334.39326443779;11712.648620541397;12082.577109801116;12142;12241.449134788778 16:04:19 INFO - PROCESS | 19461 | |3;mootools.html;1424.095699230988;1479.6448852275453;1534.7621118726597;1659.1704147926037;1819.6633622779786;7984.121746607876;8807.031226565081;8813.955930220356;8866.069062748415;9352.064793520645;9189.678361257358;9239.168474837263;9242.907570924288;9248.58381372838;9253.074692530743;2454.3127924181213;2476.2076135636603;2482.5407299649623;2483.751624837511;2485.5526005319034;2401.5317013182434;2471.542764588548;2480.2063339731294;2482.515909397668;2484.925452236436;2402.8318017738766;2417.190241269177;2432.0758111917535;2434.257551446808;2436.305652888927;2311.9653205201935;2318.675385446039;2321.3152120124605;2334.1363695432797;2374.442006128558;2323.6398358254496;2357.1749887539395;2368.6683864259016;2368.881555922197;2370.099362242354;9315.208207302387;9477.28920330978;9577.377470464398;9583.952080239555;9586.424814511152;5147.6911385317;5268.6575372600655;5331.813386531453;5339.866503337447;5372.785088596452;3457.896263112111;3482.2165012872156;3540.415831387818;3557.3952428087287;3585.551806024247;1222.144498850808;1222.5904322052122;1253.1916913590683;1254.26625424127;2271.670607761865;12784.04119691027;13141.342932853318;13659.180449173082;13671.17972921628;13698.452061917611;4960.131976904099;4984.352034235599;5031.295618613397;5066.898662026739;5074.416442109131;10478.947605262078;10540.051395374454;10575.418351990715;10601.787964240671;10604.787904241872;5426.186072089218;5427.1045277528765;5427.213054107132;5428.430014848463;5433.1035379161995;4373.365861949999;4495.797689103998;4799.760011999386;4840.080384726891;5014.6740461870595;4083.4487344208746;4117.794110294473;4123.113530590937;4205.222033923734;4260.360945858146;1184.5439505790332;1189.4766302826729;1190.571394298052;1190.8570971483477;1200.4357951762659;981.5877331520778;1063.3301020357126;1072.3940973350032;1110.3559935237543;1113.821788513834;6261.217347831521;6342.334054924167;6609.1077704510235;6640.468762498988;6746.8650626988165;471.61092099018447;481.1339588740254;1070.9946450267698;1114.4260705736551;1127.2391135983178;4179.91640167195;4491.618212451978;4577.496475387705;4581.152486789888;4710.811567537328;11684.532618695326;11962.282263064244;11987.34069626179;12042.15704900666;12057;11834.171607987359;11848.28910265387;11856.525738970344;11860.822087668692;11880.049596032297;8417.326613870875;8546.78633034179;8570.185832345916;8826.338024648048;8969.103089690849;6208.192934918432;6433.388828061326;6604.306547812603;6810.965945170243;6883.862322753617;10767.515461804081;10926.617568385069;11006.779864402828;11314.208005439541;11315.943420283174;9546.18857397129;9762.56068476906;9902.356346837432;11287.266327688674;11321.150913681671;8725.21473067427;9203.907960920573;9226.261899048195;9230.953845230732;9232.630694772133;8917.598708058023;8943.955280223558;8946.776330591527;9218.539073046455;9331.253499720142;8035.799105022421;8240.83518329618;8371.204735550113;8432.915670843213;8585.95707021486;8102.270795628422;8121.187881211831;8240.876386854083;8391.328693704367;8412.831743365221;7697.499662521918;7834.177411371724;7840.568768717775;7841.294283514511;7847.84304313922;5570.20698473583;5604.2154098425435;5746.913796293143;5750.654960702372;5858.062709966385;5604.131359639263;5608.803691870929;5642.322921249476;5733.913991290217;5774.162746401832 16:04:19 INFO - PROCESS | 19461 | |4;prototype.html;331.6650183314851;348.5364465261203;349.38508225523077;350.43929712460067;352.0599998005327;5580.218769372291;5580.414056524068;5589.916151257735;5591.8322450326505;5668.943310566903;5215.191645294976;5278.762455689493;5398.649087809299;5483.287172667558;5598.1602759586085;4315.913681726363;4330.56694330566;4343.913121737579;4351.390805287262;4374.278244089722;4344.522102568715;4370.759608221547;4380.255356589371;4388.188185185751;4403.515613282536;4059.7564146151176;4243.766592837393;4273.487181538204;4297.957020429787;4350.521442641323;4278.88195343304;4280.59334363235;4287.678424118204;4290.163418133465;4299.957000430002;3790.952885441858;3791.469194312798;3796.90507737306;3801.1637439763485;3804.9619503804884;5301.814436494704;5378.650387724824;5385.434529374398;5399.811006614789;5408;4889.339939108246;4920.7539623019065;4924.950750492485;4930.2851086592245;4932.432770231398;5706.172604972256;5729.9713501432225;5740.5981581289325;5740.856478588027;5744.913826292609;4058.857939972087;4123.134141830219;4159.584041595846;4168.916081818718;4173.791310434466;5987.341392446828;5992.910106348409;5997.370276121032;6007;6023.704903445737;4255.340422234559;4256.91486170281;4260.169266992969;4262.595053469915;4279.315309550457;4149.419081328617;4310.590493903074;4319.222539942841;4328.588784065509;4348.673849461303;4933.506649335038;4951.72765497901;4952.340965776505;4953.23224900141;4958.876028099255;5768.480836724715;5792.333881603585;5864.533866533367;5885.117232415087;5908.261467316585;1402.894782891267;1436.3140926467572;1449.3333066789185;1469.8162729658793;1492.8805695544331;1001.0990108902047;1005.3917379985149;1028.4240825137947;1031.1544533482622;1035.4201647077662;5554.555815488002;5554.583406244547;5559.63862348946;5570.582206334541;5616;5884.352721200665;5891.410858914074;5891.675957822361;5908.231929849092;5910.438508341701;5469.917951230735;5478.506934375925;5574.905927210356;5614.438556144353;5630.479770462034;2780.847053412041;2786.3452088759127;2801.215659615311;2809.8876044957974;2811.4096039831866;5304.9734751326;5307.840764777063;5329.706866122323;5358.517733404013;5381.4349493303425;4967.379077615298;5220.190870415092;5230.869228269324;5246.370435547682;5263.131583288791;5280.683159010472;5287.867803304948;5303.522682958553;5364.1417373220875;5374.5700343972385;5185.325907631984;5185.740712964262;5207.318231110905;5222.3472065991755;5226.738663066907;5479.890402192013;5918.141869428995;5918.319393269829;5940.79207227745;5949;6211.13044173807;6216.751329946752;6220.533459990609;6224.813255602339;6247.9062814056915;4221.345691417835;4278.272693642026;4296.398504209351;4307.22469955411;4321.546237645128;5999.6700181488695;6000.249968753906;6012.368701286302;6016.961434475562;6021.187139736079;5571.052921003358;5665.206871037975;5763.510101641407;5828.417158284137;5836.169457812873;5814.505767009682;5833.737481813244;5837.066069428871;5841.737121829613;5859.710863609999;5604.215305763401;5754.165645981393;5800.76796928135;5829.766809327749;5841.795537156179;5863.6806718488;5865.794697185578;5875.353711091691;5876.265466816648;5876.647401155944;5612.7754889803955;5653.689047102284;5660.603757736919;5692.3169219692245;5693.772249109989 16:04:19 INFO - PROCESS | 19461 | |5;yui.html;812.3907069697726;836.6318819719319;896.538282784366;903.1916434790858;931.5109567477076;15291;16297;16313.755293670605;16316.836831631681;16348.34606615737;15422;15457;15537.14545699989;15741;15887.602809929758;749.7375918428561;862.5945805471418;882.0561998661435;884.226301985764;901.076396693388;899.029048627484;900.1673452056854;902.2511315608062;902.5306840442965;902.6750369866843;949.2358651285713;949.9335046546745;951.4624237305935;951.6621599332241;951.8714973478561;946.2619157057507;947.346331031586;947.6683160893666;948.6679662118272;949.4920217683541;697.8604279144191;698.5389642835704;699.1505321034967;699.1889408286414;699.471898716471;14584.197869117193;14599.051061680957;14604.050736702187;14606.34271457787;14656.193909334983;13193.40629671667;13206.339683015907;14160.716785664332;15572.688546229012;15798.289076991448;14160.150390976574;14200;14367;14494.275286235752;14716.55850324492;4870.9269360959615;4905;4949.232868905326;5040.924386134174;5064.924026139611;84686.15313846845;84732;85484;86831;88209;12055.939720301518;12117.69705757363;12197;12295.69260768488;12461.501539938301;20666.689999650018;20943.47641308949;20984;21004.57990840205;21101.366958991253;8532.744017679479;8683.044865064838;8683.869741953877;8717.433366831263;8749.912500875038;4816.8314109006715;4864;4866.367372241586;4998.500149984972;5030.019146266516;3570.250247448013;3681.4661874028116;3723.236736469017;3724.832382542792;3727.7204209684382;600.6516220592046;602.87942411517;604.7883240865661;609.2719200555382;611.3886113886114;652.967351632426;653.9313372095957;668.204836244867;737.9114506259283;759.5746382026083;9733.853992190123;9917.801643967081;9976.201903847676;10012.449315287584;10291.485425728684;648.0570769530322;649.9642519661464;699.7550857200041;718.4970520635576;779.742684913977;4834.8791280218275;4969.701817890938;5038.672486288379;5074.82238121664;5118.948810511922;92786;129099.35450322877;134463;136032;136117;110636.44681776539;113171.4341428304;113885;115478;115608.42195788967;58149;91319.54340228256;95531.52234238785;96005.039949601;97051;9383;9650.662226822027;9747;10302.22733295021;10415.166786656897;40231;40945.79527102345;51571.22643160281;55080;57362.42637573738;81474;82356.58821706093;82379;83342.16657833586;84289.57855210685;14184.92907535497;14264.500742473963;14405.567832965027;14527.564173074825;14644.853551464776;16180.919095404448;16201.351945922032;16437.506874793777;16486.093264870546;16567.751483727996;15113.622159446102;15116.848831511545;15248.77126843076;15957.68084638324;16490.917545412198;14644.487442939446;14850;15715.607109822346;15807.13060781668;15978.680426391174;12657.620271391874;12900.677483062624;13027.413766380347;13956.09285396446;14084.15495070299;11043.171762118034;11102.666919992413;11303.04335556316;11411.543538258376;11590.826137608112;11269.605563805228;11344.149188811038;11417.486213120595;11418.885811141783;11717.238379505305 16:04:19 INFO - PROCESS | 19461 | __end_tp_report 16:04:19 INFO - PROCESS | 19461 | __start_cc_report 16:04:19 INFO - PROCESS | 19461 | _x_x_mozilla_cycle_collect,856 16:04:19 INFO - PROCESS | 19461 | __end_cc_report 16:04:19 INFO - PROCESS | 19461 | __startTimestamp1475535859308__endTimestamp 16:04:19 INFO - PROCESS | 19461 | 16:04:19 INFO - PROCESS | 19461 | ------- Summary: start ------- 16:04:19 INFO - PROCESS | 19461 | Number of tests: 6 16:04:19 INFO - PROCESS | 19461 | 16:04:19 INFO - PROCESS | 19461 | [#0] dojo.html Cycles:165 Average:5663.54 Median:5887.91 stddev:663.79 (11.3%) stddev-sans-first:637.42 16:04:19 INFO - PROCESS | 19461 | Values: 3214.8 3224.1 3232.4 3259.1 3272.2 5575.0 5675.2 5675.8 5677.7 5707.9 5653.7 5688.6 5691.7 5692.6 5698.3 5124.9 5131.2 5141.0 5142.0 5213.2 5092.4 5129.0 5205.3 5226.3 5248.8 5069.8 5113.2 5116.8 5154.8 5160.8 5085.9 5124.5 5212.4 5212.7 5246.4 5051.6 5057.8 5132.9 5177.6 5199.9 5544.7 5606.0 5614.2 5616.2 5636.6 6092.9 6138.7 6192.5 6196.7 6201.4 5999.4 6084.4 6213.5 6217.7 6230.1 5722.9 5746.5 5767.3 5801.5 5812.2 6302.5 6309.8 6310.1 6310.4 6321.8 5866.4 5932.3 6045.5 6053.0 6064.6 6135.7 6145.4 6153.2 6165.4 6166.5 6120.3 6128.4 6133.9 6134.4 6140.4 5907.4 5929.2 5966.7 6060.1 6112.2 4610.8 4641.2 4646.8 4647.7 4649.1 4080.3 4124.1 4145.3 4145.4 4152.5 5787.7 5791.4 5792.5 5792.8 5820.4 6110.3 6121.4 6126.2 6128.9 6130.0 5673.0 5719.8 5735.1 5775.6 5777.6 5303.3 5307.1 5311.3 5311.9 5312.8 6302.2 6316.7 6362.6 6365.9 6368.6 5936.5 6055.9 6121.1 6124.7 6157.4 6379.5 6394.0 6395.2 6398.3 6406.0 6079.8 6082.3 6088.9 6096.1 6096.9 5954.8 5955.6 5971.1 5972.2 6146.9 5866.0 5900.9 5913.3 5927.3 5931.0 5832.4 5887.1 5888.0 5891.2 5904.9 5767.4 5871.7 5887.9 5952.2 5956.6 6061.6 6061.9 6071.2 6074.1 6087.8 5865.7 5894.1 5899.6 5903.6 5923.5 16:04:19 INFO - PROCESS | 19461 | 16:04:19 INFO - PROCESS | 19461 | [#1] ext.html Cycles:180 Average:64566.83 Median:414030.00 stddev:127909.64 (30.9%) stddev-sans-first:128178.29 16:04:19 INFO - PROCESS | 19461 | Values: 598.3 637.7 653.5 656.0 667.1 27511.3 28564.7 47249.8 48040.3 48186.0 49833.0 50333.0 50378.2 50407.5 50526.7 8768.3 9372.8 9521.6 9524.0 9533.7 8711.3 9011.6 11251.1 11530.9 11538.6 11560.4 11620.7 11624.3 11626.1 11632.2 11499.9 11569.2 11577.7 11578.9 11582.5 11381.1 11432.7 11448.5 11453.4 11455.8 47136.5 47271.3 47552.8 47578.0 47709.8 3799.4 3871.7 4082.7 4513.2 4732.0 33748.3 36512.5 37106.3 37161.4 38473.2 4714.8 4741.1 4804.6 4805.9 4881.7 409264.0 418796.0 418991.0 420322.0 420441.0 39344.8 70512.3 71514.3 71614.0 71674.6 40325.4 42755.4 42806.4 43137.8 43225.6 15797.3 15911.0 15911.9 15925.2 15931.5 13258.7 13311.3 13313.3 13317.1 13324.5 9172.4 9563.3 9857.3 9857.4 9970.7 3676.0 3722.3 3725.3 3762.3 3762.8 1034.4 1140.9 1159.5 1210.5 1218.7 33310.5 33591.0 34023.1 34166.3 34435.7 1152.8 1158.9 1170.6 1201.3 1222.3 17957.0 18141.5 18239.9 18275.0 18310.2 576834.0 577380.0 577737.0 578573.0 579445.0 66890.0 67312.3 67317.0 67369.7 67480.7 1337.1 1390.5 1429.2 1432.9 1456.0 34193.0 35658.3 35825.7 35993.6 36244.6 56852.7 57662.0 57697.4 57753.0 57779.1 432288.0 435319.0 435485.0 435527.0 435644.0 29123.6 29445.6 29537.9 31499.7 31614.7 53830.2 54015.5 54182.7 54546.2 55034.2 43833.0 44157.6 46087.3 46845.8 47602.5 44903.3 45294.0 45804.0 46107.8 46831.3 44189.3 44891.3 45271.8 45361.5 45374.1 37645.4 39842.0 40377.8 40470.0 40866.0 28300.2 28369.6 28697.0 28757.0 28849.0 16:04:19 INFO - PROCESS | 19461 | 16:04:19 INFO - PROCESS | 19461 | [#2] jquery.html Cycles:180 Average:30102.92 Median:2613.07 stddev:88123.98 (3372.4%) stddev-sans-first:88343.00 16:04:19 INFO - PROCESS | 19461 | Values: 415.8 424.9 431.8 435.8 436.0 18615.7 19160.6 19788.7 20189.9 20609.2 19594.6 20075.3 20088.8 20562.0 20749.7 5900.8 6119.8 6125.9 6129.6 6129.8 5815.1 5860.5 5939.8 5964.6 6005.9 5931.4 5931.7 5932.2 5934.8 5935.1 5871.2 5933.6 5963.6 5965.4 5972.1 5239.2 5294.0 5396.2 5399.7 5402.2 23833.8 24033.5 24228.6 24313.8 24529.1 2607.2 2618.9 2791.7 2872.8 3041.5 7580.4 7623.1 11073.7 15224.3 15613.3 1971.4 1994.8 2005.6 2014.4 2058.1 55957.7 74697.0 74874.6 79106.6 85201.1 11278.5 11354.6 11363.2 11451.9 11795.7 16077.2 16198.4 16207.7 16236.3 16244.6 8526.7 8648.7 8657.9 8673.9 8985.8 8189.3 8196.4 8317.8 8415.4 8422.3 6824.0 7041.6 7046.6 7059.2 7080.3 2004.2 2010.3 2018.4 2023.1 2056.4 991.8 1004.1 1018.2 1047.6 1069.2 20457.8 20972.7 21010.2 21056.5 21066.6 1041.6 1081.5 1083.3 1083.6 1121.7 11852.9 12057.2 12060.7 12113.0 12155.6 497507.0 500117.0 523949.0 580651.0 583047.0 59325.7 80792.0 81192.0 81710.6 83223.6 1093.8 1094.3 1099.5 1104.6 1115.4 18194.5 18543.4 18710.0 18900.1 18907.9 39630.2 41240.2 41811.6 42030.6 42115.0 49880.5 58557.4 58959.7 60375.4 60501.7 8501.8 8678.4 8786.1 8812.9 9093.5 9503.8 13393.8 13583.8 14111.2 14263.9 11979.5 12076.8 12316.0 12335.1 12522.9 10950.7 11102.7 11316.4 11435.1 11535.9 11935.9 12062.2 12149.6 12672.7 12708.4 8667.6 8825.8 8977.6 9002.8 9037.0 9334.4 11712.6 12082.6 12142.0 12241.4 16:04:19 INFO - PROCESS | 19461 | 16:04:19 INFO - PROCESS | 19461 | [#3] mootools.html Cycles:180 Average:6202.06 Median:2591.21 stddev:3565.61 (137.6%) stddev-sans-first:3557.53 16:04:19 INFO - PROCESS | 19461 | Values: 1424.1 1479.6 1534.8 1659.2 1819.7 7984.1 8807.0 8814.0 8866.1 9352.1 9189.7 9239.2 9242.9 9248.6 9253.1 2454.3 2476.2 2482.5 2483.8 2485.6 2401.5 2471.5 2480.2 2482.5 2484.9 2402.8 2417.2 2432.1 2434.3 2436.3 2312.0 2318.7 2321.3 2334.1 2374.4 2323.6 2357.2 2368.7 2368.9 2370.1 9315.2 9477.3 9577.4 9584.0 9586.4 5147.7 5268.7 5331.8 5339.9 5372.8 3457.9 3482.2 3540.4 3557.4 3585.6 1222.1 1222.6 1253.2 1254.3 2271.7 12784.0 13141.3 13659.2 13671.2 13698.5 4960.1 4984.4 5031.3 5066.9 5074.4 10478.9 10540.1 10575.4 10601.8 10604.8 5426.2 5427.1 5427.2 5428.4 5433.1 4373.4 4495.8 4799.8 4840.1 5014.7 4083.4 4117.8 4123.1 4205.2 4260.4 1184.5 1189.5 1190.6 1190.9 1200.4 981.6 1063.3 1072.4 1110.4 1113.8 6261.2 6342.3 6609.1 6640.5 6746.9 471.6 481.1 1071.0 1114.4 1127.2 4179.9 4491.6 4577.5 4581.2 4710.8 11684.5 11962.3 11987.3 12042.2 12057.0 11834.2 11848.3 11856.5 11860.8 11880.0 8417.3 8546.8 8570.2 8826.3 8969.1 6208.2 6433.4 6604.3 6811.0 6883.9 10767.5 10926.6 11006.8 11314.2 11315.9 9546.2 9762.6 9902.4 11287.3 11321.2 8725.2 9203.9 9226.3 9231.0 9232.6 8917.6 8944.0 8946.8 9218.5 9331.3 8035.8 8240.8 8371.2 8432.9 8586.0 8102.3 8121.2 8240.9 8391.3 8412.8 7697.5 7834.2 7840.6 7841.3 7847.8 5570.2 5604.2 5746.9 5750.7 5858.1 5604.1 5608.8 5642.3 5733.9 5774.2 16:04:19 INFO - PROCESS | 19461 | 16:04:19 INFO - PROCESS | 19461 | [#4] prototype.html Cycles:180 Average:4791.06 Median:5304.25 stddev:1398.69 (26.4%) stddev-sans-first:1361.98 16:04:19 INFO - PROCESS | 19461 | Values: 331.7 348.5 349.4 350.4 352.1 5580.2 5580.4 5589.9 5591.8 5668.9 5215.2 5278.8 5398.6 5483.3 5598.2 4315.9 4330.6 4343.9 4351.4 4374.3 4344.5 4370.8 4380.3 4388.2 4403.5 4059.8 4243.8 4273.5 4298.0 4350.5 4278.9 4280.6 4287.7 4290.2 4300.0 3791.0 3791.5 3796.9 3801.2 3805.0 5301.8 5378.7 5385.4 5399.8 5408.0 4889.3 4920.8 4925.0 4930.3 4932.4 5706.2 5730.0 5740.6 5740.9 5744.9 4058.9 4123.1 4159.6 4168.9 4173.8 5987.3 5992.9 5997.4 6007.0 6023.7 4255.3 4256.9 4260.2 4262.6 4279.3 4149.4 4310.6 4319.2 4328.6 4348.7 4933.5 4951.7 4952.3 4953.2 4958.9 5768.5 5792.3 5864.5 5885.1 5908.3 1402.9 1436.3 1449.3 1469.8 1492.9 1001.1 1005.4 1028.4 1031.2 1035.4 5554.6 5554.6 5559.6 5570.6 5616.0 5884.4 5891.4 5891.7 5908.2 5910.4 5469.9 5478.5 5574.9 5614.4 5630.5 2780.8 2786.3 2801.2 2809.9 2811.4 5305.0 5307.8 5329.7 5358.5 5381.4 4967.4 5220.2 5230.9 5246.4 5263.1 5280.7 5287.9 5303.5 5364.1 5374.6 5185.3 5185.7 5207.3 5222.3 5226.7 5479.9 5918.1 5918.3 5940.8 5949.0 6211.1 6216.8 6220.5 6224.8 6247.9 4221.3 4278.3 4296.4 4307.2 4321.5 5999.7 6000.2 6012.4 6017.0 6021.2 5571.1 5665.2 5763.5 5828.4 5836.2 5814.5 5833.7 5837.1 5841.7 5859.7 5604.2 5754.2 5800.8 5829.8 5841.8 5863.7 5865.8 5875.4 5876.3 5876.6 5612.8 5653.7 5660.6 5692.3 5693.8 16:04:19 INFO - PROCESS | 19461 | 16:04:19 INFO - PROCESS | 19461 | [#5] yui.html Cycles:180 Average:22369.75 Median:4825.86 stddev:33042.13 (684.7%) stddev-sans-first:33095.18 16:04:19 INFO - PROCESS | 19461 | Values: 812.4 836.6 896.5 903.2 931.5 15291.0 16297.0 16313.8 16316.8 16348.3 15422.0 15457.0 15537.1 15741.0 15887.6 749.7 862.6 882.1 884.2 901.1 899.0 900.2 902.3 902.5 902.7 949.2 949.9 951.5 951.7 951.9 946.3 947.3 947.7 948.7 949.5 697.9 698.5 699.2 699.2 699.5 14584.2 14599.1 14604.1 14606.3 14656.2 13193.4 13206.3 14160.7 15572.7 15798.3 14160.2 14200.0 14367.0 14494.3 14716.6 4870.9 4905.0 4949.2 5040.9 5064.9 84686.2 84732.0 85484.0 86831.0 88209.0 12055.9 12117.7 12197.0 12295.7 12461.5 20666.7 20943.5 20984.0 21004.6 21101.4 8532.7 8683.0 8683.9 8717.4 8749.9 4816.8 4864.0 4866.4 4998.5 5030.0 3570.3 3681.5 3723.2 3724.8 3727.7 600.7 602.9 604.8 609.3 611.4 653.0 653.9 668.2 737.9 759.6 9733.9 9917.8 9976.2 10012.4 10291.5 648.1 650.0 699.8 718.5 779.7 4834.9 4969.7 5038.7 5074.8 5118.9 92786.0 129099.4 134463.0 136032.0 136117.0 110636.4 113171.4 113885.0 115478.0 115608.4 58149.0 91319.5 95531.5 96005.0 97051.0 9383.0 9650.7 9747.0 10302.2 10415.2 40231.0 40945.8 51571.2 55080.0 57362.4 81474.0 82356.6 82379.0 83342.2 84289.6 14184.9 14264.5 14405.6 14527.6 14644.9 16180.9 16201.4 16437.5 16486.1 16567.8 15113.6 15116.8 15248.8 15957.7 16490.9 14644.5 14850.0 15715.6 15807.1 15978.7 12657.6 12900.7 13027.4 13956.1 14084.2 11043.2 11102.7 11303.0 11411.5 11590.8 11269.6 11344.1 11417.5 11418.9 11717.2 16:04:19 INFO - PROCESS | 19461 | -------- Summary: end -------- 16:04:19 INFO - PROCESS | 19461 | 16:04:19 INFO - TEST-INFO | 19461: exit 0 16:04:20 INFO - TEST-OK | dromaeo_css | took 1113400ms 16:04:20 INFO - TEST-START | kraken 16:04:20 INFO - operating with platform_type : linux_ 16:04:20 INFO - Initialising browser for kraken test... 16:04:20 INFO - TEST-INFO | started process 19654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQM15R1/profile http://localhost:50975/getInfo.html) 16:04:23 INFO - PROCESS | 19654 | __metrics Screen width/height:1600/1200 16:04:23 INFO - PROCESS | 19654 | colorDepth:24 16:04:23 INFO - PROCESS | 19654 | Browser inner width/height: 1024/697 16:04:23 INFO - PROCESS | 19654 | __metrics 16:04:24 INFO - PROCESS | 19654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:04:24 INFO - PROCESS | 19654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:04:25 INFO - TEST-INFO | 19654: exit 0 16:04:25 INFO - Browser initialized. 16:04:25 INFO - Running cycle 1/1 for kraken test... 16:04:25 INFO - TEST-INFO | started process 19741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQM15R1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:37 INFO - PROCESS | 19741 | RSS: Main: 144105472 16:04:37 INFO - PROCESS | 19741 | 16:04:40 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50975/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:40 INFO - PROCESS | 19741 | RSS: Main: 199303168 16:04:40 INFO - PROCESS | 19741 | 16:04:43 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50975/tests/kraken/driver.html?testName=audio-dft) 16:04:44 INFO - PROCESS | 19741 | RSS: Main: 183185408 16:04:44 INFO - PROCESS | 19741 | 16:04:46 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50975/tests/kraken/driver.html?testName=audio-fft) 16:04:47 INFO - PROCESS | 19741 | RSS: Main: 275058688 16:04:47 INFO - PROCESS | 19741 | 16:04:49 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50975/tests/kraken/driver.html?testName=audio-oscillator) 16:04:50 INFO - PROCESS | 19741 | RSS: Main: 179908608 16:04:50 INFO - PROCESS | 19741 | 16:04:52 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50975/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:04:52 INFO - PROCESS | 19741 | RSS: Main: 178835456 16:04:52 INFO - PROCESS | 19741 | 16:04:55 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50975/tests/kraken/driver.html?testName=imaging-darkroom) 16:04:56 INFO - PROCESS | 19741 | RSS: Main: 214544384 16:04:56 INFO - PROCESS | 19741 | 16:04:59 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50975/tests/kraken/driver.html?testName=imaging-desaturate) 16:05:00 INFO - PROCESS | 19741 | RSS: Main: 213962752 16:05:00 INFO - PROCESS | 19741 | 16:05:03 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50975/tests/kraken/driver.html?testName=json-parse-financial) 16:05:03 INFO - PROCESS | 19741 | RSS: Main: 213794816 16:05:03 INFO - PROCESS | 19741 | 16:05:05 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50975/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:05:05 INFO - PROCESS | 19741 | RSS: Main: 176005120 16:05:05 INFO - PROCESS | 19741 | 16:05:07 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50975/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:05:08 INFO - PROCESS | 19741 | RSS: Main: 183382016 16:05:08 INFO - PROCESS | 19741 | 16:05:10 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50975/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:05:10 INFO - PROCESS | 19741 | RSS: Main: 184311808 16:05:10 INFO - PROCESS | 19741 | 16:05:13 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:05:13 INFO - PROCESS | 19741 | RSS: Main: 185237504 16:05:13 INFO - PROCESS | 19741 | 16:05:16 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:05:17 INFO - PROCESS | 19741 | RSS: Main: 182919168 16:05:17 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | Cycle 1(1): loaded http://localhost:50975/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50975/tests/kraken/driver.html?testName=ai-astar) 16:05:18 INFO - PROCESS | 19741 | RSS: Main: 233820160 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | __start_tp_report 16:05:18 INFO - PROCESS | 19741 | _x_x_mozilla_page_load 16:05:18 INFO - PROCESS | 19741 | _x_x_mozilla_page_load_details 16:05:18 INFO - PROCESS | 19741 | |i|pagename|runs| 16:05:18 INFO - PROCESS | 19741 | |0;ai-astar;111;110;121;108;110;110;111;111;110;110 16:05:18 INFO - PROCESS | 19741 | |1;audio-beat-detection;147;127;141;181;116;145;151;118;171;117 16:05:18 INFO - PROCESS | 19741 | |2;audio-dft;162;159;162;159;160;160;161;160;160;159 16:05:18 INFO - PROCESS | 19741 | |3;audio-fft;73;74;74;175;75;75;74;76;165;76 16:05:18 INFO - PROCESS | 19741 | |4;audio-oscillator;84;83;161;83;83;83;137;83;83;147 16:05:18 INFO - PROCESS | 19741 | |5;imaging-gaussian-blur;116;117;116;117;116;117;116;116;116;116 16:05:18 INFO - PROCESS | 19741 | |6;imaging-darkroom;146;146;148;145;146;146;147;147;147;147 16:05:18 INFO - PROCESS | 19741 | |7;imaging-desaturate;95;95;95;95;94;95;94;97;95;94 16:05:18 INFO - PROCESS | 19741 | |8;json-parse-financial;53;50;50;50;49;48;48;52;49;51 16:05:18 INFO - PROCESS | 19741 | |9;json-stringify-tinderbox;61;62;60;61;61;61;61;60;61;61 16:05:18 INFO - PROCESS | 19741 | |10;stanford-crypto-aes;72;73;72;72;76;73;74;72;73;81 16:05:18 INFO - PROCESS | 19741 | |11;stanford-crypto-ccm;127;128;116;119;118;127;118;119;149;120 16:05:18 INFO - PROCESS | 19741 | |12;stanford-crypto-pbkdf2;150;151;150;150;152;151;154;148;149;152 16:05:18 INFO - PROCESS | 19741 | |13;stanford-crypto-sha256-iterative;61;61;63;60;60;60;60;62;62;60 16:05:18 INFO - PROCESS | 19741 | __end_tp_report 16:05:18 INFO - PROCESS | 19741 | __start_cc_report 16:05:18 INFO - PROCESS | 19741 | _x_x_mozilla_cycle_collect,1676 16:05:18 INFO - PROCESS | 19741 | __end_cc_report 16:05:18 INFO - PROCESS | 19741 | __startTimestamp1475535918939__endTimestamp 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | ------- Summary: start ------- 16:05:18 INFO - PROCESS | 19741 | Number of tests: 14 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#0] ai-astar Cycles:10 Average:111.20 Median:110.50 stddev:3.55 (3.2%) stddev-sans-first:3.77 16:05:18 INFO - PROCESS | 19741 | Values: 111.0 110.0 121.0 108.0 110.0 110.0 111.0 111.0 110.0 110.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:146.00 stddev:22.55 (15.4%) stddev-sans-first:23.83 16:05:18 INFO - PROCESS | 19741 | Values: 147.0 127.0 141.0 181.0 116.0 145.0 151.0 118.0 171.0 117.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:1.14 (0.7%) stddev-sans-first:1.00 16:05:18 INFO - PROCESS | 19741 | Values: 162.0 159.0 162.0 159.0 160.0 160.0 161.0 160.0 160.0 159.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#3] audio-fft Cycles:10 Average:93.70 Median:74.50 stddev:40.29 (54.1%) stddev-sans-first:42.04 16:05:18 INFO - PROCESS | 19741 | Values: 73.0 74.0 74.0 175.0 75.0 75.0 74.0 76.0 165.0 76.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:83.00 stddev:32.00 (38.6%) stddev-sans-first:33.22 16:05:18 INFO - PROCESS | 19741 | Values: 84.0 83.0 161.0 83.0 83.0 83.0 137.0 83.0 83.0 147.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:05:18 INFO - PROCESS | 19741 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 116.0 116.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 16:05:18 INFO - PROCESS | 19741 | Values: 146.0 146.0 148.0 145.0 146.0 146.0 147.0 147.0 147.0 147.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 16:05:18 INFO - PROCESS | 19741 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 97.0 95.0 94.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:1.63 (3.3%) stddev-sans-first:1.32 16:05:18 INFO - PROCESS | 19741 | Values: 53.0 50.0 50.0 50.0 49.0 48.0 48.0 52.0 49.0 51.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 16:05:18 INFO - PROCESS | 19741 | Values: 61.0 62.0 60.0 61.0 61.0 61.0 61.0 60.0 61.0 61.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.00 stddev:2.82 (3.9%) stddev-sans-first:2.92 16:05:18 INFO - PROCESS | 19741 | Values: 72.0 73.0 72.0 72.0 76.0 73.0 74.0 72.0 73.0 81.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:123.50 stddev:9.78 (7.9%) stddev-sans-first:10.32 16:05:18 INFO - PROCESS | 19741 | Values: 127.0 128.0 116.0 119.0 118.0 127.0 118.0 119.0 149.0 120.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.70 Median:151.00 stddev:1.70 (1.1%) stddev-sans-first:1.79 16:05:18 INFO - PROCESS | 19741 | Values: 150.0 151.0 150.0 150.0 152.0 151.0 154.0 148.0 149.0 152.0 16:05:18 INFO - PROCESS | 19741 | 16:05:18 INFO - PROCESS | 19741 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 16:05:18 INFO - PROCESS | 19741 | Values: 61.0 61.0 63.0 60.0 60.0 60.0 60.0 62.0 62.0 60.0 16:05:18 INFO - PROCESS | 19741 | -------- Summary: end -------- 16:05:18 INFO - PROCESS | 19741 | 16:05:19 INFO - TEST-INFO | 19741: exit 0 16:05:19 INFO - TEST-OK | kraken | took 59931ms 16:05:19 INFO - SUITE-END | took 1173s 16:05:20 INFO - Completed test suite (00:19:33) 16:05:20 INFO - javascript benchmark 16:05:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.758893083019, 3224.1456014156247, 3232.385846689129, 3259.054874086515, 3272.1655977725677, 5574.972125139374, 5675.177099320601, 5675.772969081242, 5677.659340439566, 5707.9143812842785, 5653.717314134297, 5688.63023903446, 5691.715414229293, 5692.6299790513585, 5698.316202055748, 5124.8975020499665, 5131.153359695646, 5140.974295128538, 5142.0487209866105, 5213.218017297398, 5092.388913330406, 5128.974355128219, 5205.3233079699585, 5226.346706661668, 5248.790048398059, 5069.771860266297, 5113.2330150477355, 5116.820911268106, 5154.845354639367, 5160.767765450545, 5085.872853178663, 5124.538791508745, 5212.40057393397, 5212.687238765686, 5246.449122842085, 5051.570616497602, 5057.848264552069, 5132.897342053138, 5177.559907407875, 5199.922001169985, 5544.695041772701, 5605.971970140164, 5614.242077319551, 5616.241807355996, 5636.577256705723, 6092.908606370908, 6138.693065346715, 6192.473639740628, 6196.659183744892, 6201.441870231656, 5999.370066143036, 6084.361142080106, 6213.5029197664535, 6217.68911554425, 6230.096635987757, 5722.856928576777, 5746.454086861741, 5767.250257466502, 5801.506871915893, 5812.186293918855, 6302.4958003359625, 6309.810705678837, 6310.0850376695125, 6310.368963103745, 6321.778737744157, 5866.442687944638, 5932.317783454958, 6045.546584006217, 6053.00125479291, 6064.575479716377, 6135.661410523283, 6145.4161854623735, 6153.1693221415435, 6165.445109940127, 6166.537509686791, 6120.326764055951, 6128.3565225651555, 6133.877322453526, 6134.386561343919, 6140.3552626974415, 5907.350191478934, 5929.199558059607, 5966.731497082642, 6060.122319887497, 6112.235970503687, 4610.792514336796, 4641.18779213643, 4646.814127434933, 4647.697899636512, 4649.139909116757, 4080.2859499587453, 4124.13393187428, 4145.336746120606, 4145.357469592218, 4152.5432202457705, 5787.71061446926, 5791.449812267828, 5792.507636850831, 5792.768289268466, 5820.3888591698105, 6110.327863934964, 6121.387861213843, 6126.23422072241, 6128.908066379008, 6130.049842274455, 5672.971635141798, 5719.828405147852, 5735.053716136791, 5775.595708300379, 5777.566682498829, 5303.257543943851, 5307.071262529042, 5311.336082989626, 5311.946880531223, 5312.787488500417, 6302.243730752248, 6316.652584107918, 6362.618242905348, 6365.904511432333, 6368.617882927039, 5936.525077993664, 6055.878882422238, 6121.051237058263, 6124.693765311806, 6157.415045570664, 6379.5215358847345, 6394.0, 6395.20059992501, 6398.328175541687, 6406.0, 6079.756809727738, 6082.300535438481, 6088.908666370096, 6096.055111457731, 6096.8780624388155, 5954.791582294599, 5955.583109182316, 5971.0744834550715, 5972.163897054503, 6146.938530614637, 5866.032104702676, 5900.940990590211, 5913.349531551612, 5927.288725352985, 5930.970345148246, 5832.445917637818, 5887.116932460165, 5888.0, 5891.1752354671235, 5904.911426328695, 5767.365589785037, 5871.706414679335, 5887.911681324698, 5952.226210592596, 5956.642601443928, 6061.636301821904, 6061.939380606137, 6071.216587609186, 6074.088886667036, 6087.817365479043, 5865.73604187804, 5894.086416605433, 5899.616524925866, 5903.557233207441, 5923.49650279731], "value": 5617.047738028978, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.2701104652323, 637.6907200007997, 653.5392548253482, 656.0127008851678, 667.1293961380399, 27511.312217194554, 28564.714352856467, 47249.7637511812, 48040.27939580909, 48186.03627927439, 49833.0, 50333.0, 50378.24432633514, 50407.49592504074, 50526.74736626321, 8768.254698350647, 9372.812543749122, 9521.619135234618, 9524.0, 9533.713988580354, 8711.259542938826, 9011.639534418615, 11251.099912007061, 11530.942345288304, 11538.596149134783, 11560.364179970098, 11620.709482262926, 11624.302541847474, 11626.128040397005, 11632.243904146246, 11499.885001149965, 11569.247998880046, 11577.6526704199, 11578.942105289503, 11582.536698532049, 11381.146414018982, 11432.657020289405, 11448.484818183118, 11453.37006464644, 11455.828162577567, 47136.528634713555, 47271.29093063607, 47552.762236188944, 47578.0, 47709.76145119287, 3799.3731034379293, 3871.728978971473, 4082.6937979651348, 4513.232750432401, 4731.976340118312, 33748.32503349919, 36512.452313215326, 37106.257874842355, 37161.44257836135, 38473.23053538942, 4714.83498077569, 4741.122892264942, 4804.5916097131785, 4805.8558243252755, 4881.658283920127, 409264.0, 418796.0, 418991.0, 420322.0, 420441.0, 39344.80327598344, 70512.2948770516, 71514.2848571518, 71614.0, 71674.64162679258, 40325.39511907324, 42755.35866961998, 42806.357904631455, 43137.78431107824, 43225.56774432278, 15797.289121989537, 15911.0, 15911.920440397724, 15925.203739812963, 15931.522054338388, 13258.734825303633, 13311.267880266678, 13313.33433328349, 13317.134386264861, 13324.533641322507, 9172.44965302084, 9563.282753793494, 9857.309988300893, 9857.408555486694, 9970.651027214013, 3675.963240367562, 3722.2927643747603, 3725.2921944830396, 3762.3039737648623, 3762.774233545996, 1034.4414016431194, 1140.937248451343, 1159.4550561236206, 1210.5365581042536, 1218.7196944702769, 33310.50034249488, 33591.0, 34023.149421264665, 34166.316673666384, 34435.655643443744, 1152.7636834448917, 1158.8551431071116, 1170.6253998720329, 1201.3392634051236, 1222.3216115056052, 17957.0, 18141.482874225432, 18239.908800455913, 18275.0, 18310.176042077874, 576834.0, 577380.0, 577737.0, 578573.0, 579445.0, 66890.0, 67312.3268767306, 67317.0, 67369.66315168393, 67480.66259668769, 1337.104140226051, 1390.5480718766441, 1429.2496439369415, 1432.9467841136757, 1455.9814910846142, 34193.0, 35658.28683426369, 35825.74609888641, 35993.64006359903, 36244.637553624125, 56852.71573642105, 57662.0, 57697.4230257692, 57753.0, 57779.1333129995, 432288.0, 435319.0, 435485.0, 435527.0, 435644.0, 29123.563146553242, 29445.558316625695, 29537.852310738308, 31499.685003149676, 31614.683853162092, 53830.19254711261, 54015.45984540104, 54182.72908635432, 54546.181807273715, 55034.17448738352, 43833.0, 44157.55842441534, 46087.308690370344, 46845.765771172286, 47602.52397475981, 44903.32645010393, 45294.0, 45804.0, 46107.76946115248, 46831.29753053775, 44189.337159941984, 44891.326630101226, 45271.773641131585, 45361.546384537054, 45374.09251814879, 37645.435318470794, 39842.0, 40377.79811100926, 40470.0, 40866.0, 28300.168684410284, 28369.574456383583, 28697.0, 28757.0, 28849.0], "value": 21043.802073053033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.792103948026, 424.86057763775597, 431.81431984246774, 435.8060663004964, 435.9542248063953, 18615.720764188532, 19160.61678766424, 19788.70316945247, 20189.899050504744, 20609.175632974682, 19594.608107837834, 20075.297364592207, 20088.799112008877, 20562.0, 20749.688754668692, 5900.822975310747, 6119.755209791603, 6125.938740612603, 6129.632222066668, 6129.785457508988, 5815.098659707752, 5860.501857342131, 5939.7921072762465, 5964.582479226456, 6005.909911351333, 5931.436513531207, 5931.673757943311, 5932.199153114318, 5934.821955341346, 5935.109733539982, 5871.236739223895, 5933.614315069528, 5963.552733544958, 5965.403459654043, 5972.07432847905, 5239.21411788231, 5294.0, 5396.217548455452, 5399.730013499309, 5402.189671549259, 23833.761662383502, 24033.519329613486, 24228.636570451457, 24313.756862431503, 24529.141480048114, 2607.204802535226, 2618.9345266368305, 2791.734785195403, 2872.755815755663, 3041.4981528047847, 7580.355669768076, 7623.085229772408, 11073.723156921142, 15224.325324214327, 15613.297401616954, 1971.428285797117, 1994.8104930031623, 2005.6089062632793, 2014.446027342478, 2058.0944384470786, 55957.720211398686, 74697.0, 74874.62562687152, 79106.60446697788, 85201.14798851994, 11278.492467838967, 11354.602588909349, 11363.204575679623, 11451.88548114525, 11795.705107372385, 16077.196140192944, 16198.433054843259, 16207.675846483004, 16236.269367878474, 16244.593885152966, 8526.65893364271, 8648.654053837776, 8657.913420865836, 8673.869891951626, 8985.820283594292, 8189.344852411793, 8196.42625016243, 8317.792055198668, 8415.410921235578, 8422.326213902874, 6824.0, 7041.605854009661, 7046.577205367695, 7059.2234854166, 7080.256573059857, 2004.2183548416128, 2010.2863483463452, 2018.4247489465727, 2023.130054076761, 2056.4036429435296, 991.7619771254991, 1004.1113614451117, 1018.2261481274137, 1047.6428036916936, 1069.2087854987408, 20457.79542204559, 20972.685409718866, 21010.15959361639, 21056.473588160112, 21066.578668426544, 1041.6041904076553, 1081.464674985887, 1083.274206281793, 1083.5774048121239, 1121.6522877907876, 11852.940735296268, 12057.240643833307, 12060.698482538006, 12113.0, 12155.574554890536, 497507.0, 500117.0, 523949.0, 580651.0, 583047.0, 59325.70337148373, 80792.0, 81192.0, 81710.59144704239, 83223.58388208141, 1093.775775965925, 1094.2887123369874, 1099.4997276239133, 1104.5526561742506, 1115.3642423818346, 18194.45416637503, 18543.443696689123, 18710.0, 18900.072823040144, 18907.905460472608, 39630.2073958525, 41240.1751964965, 41811.58188418077, 42030.57969420389, 42115.0, 49880.501194987584, 58557.4144258569, 58959.70520147372, 60375.39624603698, 60501.69749151402, 8501.829963400574, 8678.392512524315, 8786.077461866413, 8812.91187088121, 9093.499857507635, 9503.809923801624, 13393.799093013418, 13583.796243056164, 14111.22388268655, 14263.928680356532, 11979.460924258256, 12076.75846483083, 12316.0, 12335.074869384653, 12522.874771252535, 10950.671479855617, 11102.666919992413, 11316.377599231791, 11435.085193184359, 11535.884641153481, 11935.880641193477, 12062.155649104478, 12149.574764883188, 12672.683182920133, 12708.36458177069, 8667.609957552051, 8825.823483530165, 8977.596008179517, 9002.774930626787, 9036.954815225881, 9334.39326443779, 11712.648620541397, 12082.577109801116, 12142.0, 12241.449134788778], "value": 9656.756982919633, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.095699230988, 1479.6448852275453, 1534.7621118726597, 1659.1704147926037, 1819.6633622779786, 7984.121746607876, 8807.031226565081, 8813.955930220356, 8866.069062748415, 9352.064793520645, 9189.678361257358, 9239.168474837263, 9242.907570924288, 9248.58381372838, 9253.074692530743, 2454.3127924181213, 2476.2076135636603, 2482.5407299649623, 2483.751624837511, 2485.5526005319034, 2401.5317013182434, 2471.542764588548, 2480.2063339731294, 2482.515909397668, 2484.925452236436, 2402.8318017738766, 2417.190241269177, 2432.0758111917535, 2434.257551446808, 2436.305652888927, 2311.9653205201935, 2318.675385446039, 2321.3152120124605, 2334.1363695432797, 2374.442006128558, 2323.6398358254496, 2357.1749887539395, 2368.6683864259016, 2368.881555922197, 2370.099362242354, 9315.208207302387, 9477.28920330978, 9577.377470464398, 9583.952080239555, 9586.424814511152, 5147.6911385317, 5268.6575372600655, 5331.813386531453, 5339.866503337447, 5372.785088596452, 3457.896263112111, 3482.2165012872156, 3540.415831387818, 3557.3952428087287, 3585.551806024247, 1222.144498850808, 1222.5904322052122, 1253.1916913590683, 1254.26625424127, 2271.670607761865, 12784.04119691027, 13141.342932853318, 13659.180449173082, 13671.17972921628, 13698.452061917611, 4960.131976904099, 4984.352034235599, 5031.295618613397, 5066.898662026739, 5074.416442109131, 10478.947605262078, 10540.051395374454, 10575.418351990715, 10601.787964240671, 10604.787904241872, 5426.186072089218, 5427.1045277528765, 5427.213054107132, 5428.430014848463, 5433.1035379161995, 4373.365861949999, 4495.797689103998, 4799.760011999386, 4840.080384726891, 5014.6740461870595, 4083.4487344208746, 4117.794110294473, 4123.113530590937, 4205.222033923734, 4260.360945858146, 1184.5439505790332, 1189.4766302826729, 1190.571394298052, 1190.8570971483477, 1200.4357951762659, 981.5877331520778, 1063.3301020357126, 1072.3940973350032, 1110.3559935237543, 1113.821788513834, 6261.217347831521, 6342.334054924167, 6609.1077704510235, 6640.468762498988, 6746.8650626988165, 471.61092099018447, 481.1339588740254, 1070.9946450267698, 1114.4260705736551, 1127.2391135983178, 4179.91640167195, 4491.618212451978, 4577.496475387705, 4581.152486789888, 4710.811567537328, 11684.532618695326, 11962.282263064244, 11987.34069626179, 12042.15704900666, 12057.0, 11834.171607987359, 11848.28910265387, 11856.525738970344, 11860.822087668692, 11880.049596032297, 8417.326613870875, 8546.78633034179, 8570.185832345916, 8826.338024648048, 8969.103089690849, 6208.192934918432, 6433.388828061326, 6604.306547812603, 6810.965945170243, 6883.862322753617, 10767.515461804081, 10926.617568385069, 11006.779864402828, 11314.208005439541, 11315.943420283174, 9546.18857397129, 9762.56068476906, 9902.356346837432, 11287.266327688674, 11321.150913681671, 8725.21473067427, 9203.907960920573, 9226.261899048195, 9230.953845230732, 9232.630694772133, 8917.598708058023, 8943.955280223558, 8946.776330591527, 9218.539073046455, 9331.253499720142, 8035.799105022421, 8240.83518329618, 8371.204735550113, 8432.915670843213, 8585.95707021486, 8102.270795628422, 8121.187881211831, 8240.876386854083, 8391.328693704367, 8412.831743365221, 7697.499662521918, 7834.177411371724, 7840.568768717775, 7841.294283514511, 7847.84304313922, 5570.20698473583, 5604.2154098425435, 5746.913796293143, 5750.654960702372, 5858.062709966385, 5604.131359639263, 5608.803691870929, 5642.322921249476, 5733.913991290217, 5774.162746401832], "value": 4927.630865656437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.6650183314851, 348.5364465261203, 349.38508225523077, 350.43929712460067, 352.0599998005327, 5580.218769372291, 5580.414056524068, 5589.916151257735, 5591.8322450326505, 5668.943310566903, 5215.191645294976, 5278.762455689493, 5398.649087809299, 5483.287172667558, 5598.1602759586085, 4315.913681726363, 4330.56694330566, 4343.913121737579, 4351.390805287262, 4374.278244089722, 4344.522102568715, 4370.759608221547, 4380.255356589371, 4388.188185185751, 4403.515613282536, 4059.7564146151176, 4243.766592837393, 4273.487181538204, 4297.957020429787, 4350.521442641323, 4278.88195343304, 4280.59334363235, 4287.678424118204, 4290.163418133465, 4299.957000430002, 3790.952885441858, 3791.469194312798, 3796.90507737306, 3801.1637439763485, 3804.9619503804884, 5301.814436494704, 5378.650387724824, 5385.434529374398, 5399.811006614789, 5408.0, 4889.339939108246, 4920.7539623019065, 4924.950750492485, 4930.2851086592245, 4932.432770231398, 5706.172604972256, 5729.9713501432225, 5740.5981581289325, 5740.856478588027, 5744.913826292609, 4058.857939972087, 4123.134141830219, 4159.584041595846, 4168.916081818718, 4173.791310434466, 5987.341392446828, 5992.910106348409, 5997.370276121032, 6007.0, 6023.704903445737, 4255.340422234559, 4256.91486170281, 4260.169266992969, 4262.595053469915, 4279.315309550457, 4149.419081328617, 4310.590493903074, 4319.222539942841, 4328.588784065509, 4348.673849461303, 4933.506649335038, 4951.72765497901, 4952.340965776505, 4953.23224900141, 4958.876028099255, 5768.480836724715, 5792.333881603585, 5864.533866533367, 5885.117232415087, 5908.261467316585, 1402.894782891267, 1436.3140926467572, 1449.3333066789185, 1469.8162729658793, 1492.8805695544331, 1001.0990108902047, 1005.3917379985149, 1028.4240825137947, 1031.1544533482622, 1035.4201647077662, 5554.555815488002, 5554.583406244547, 5559.63862348946, 5570.582206334541, 5616.0, 5884.352721200665, 5891.410858914074, 5891.675957822361, 5908.231929849092, 5910.438508341701, 5469.917951230735, 5478.506934375925, 5574.905927210356, 5614.438556144353, 5630.479770462034, 2780.847053412041, 2786.3452088759127, 2801.215659615311, 2809.8876044957974, 2811.4096039831866, 5304.9734751326, 5307.840764777063, 5329.706866122323, 5358.517733404013, 5381.4349493303425, 4967.379077615298, 5220.190870415092, 5230.869228269324, 5246.370435547682, 5263.131583288791, 5280.683159010472, 5287.867803304948, 5303.522682958553, 5364.1417373220875, 5374.5700343972385, 5185.325907631984, 5185.740712964262, 5207.318231110905, 5222.3472065991755, 5226.738663066907, 5479.890402192013, 5918.141869428995, 5918.319393269829, 5940.79207227745, 5949.0, 6211.13044173807, 6216.751329946752, 6220.533459990609, 6224.813255602339, 6247.9062814056915, 4221.345691417835, 4278.272693642026, 4296.398504209351, 4307.22469955411, 4321.546237645128, 5999.6700181488695, 6000.249968753906, 6012.368701286302, 6016.961434475562, 6021.187139736079, 5571.052921003358, 5665.206871037975, 5763.510101641407, 5828.417158284137, 5836.169457812873, 5814.505767009682, 5833.737481813244, 5837.066069428871, 5841.737121829613, 5859.710863609999, 5604.215305763401, 5754.165645981393, 5800.76796928135, 5829.766809327749, 5841.795537156179, 5863.6806718488, 5865.794697185578, 5875.353711091691, 5876.265466816648, 5876.647401155944, 5612.7754889803955, 5653.689047102284, 5660.603757736919, 5692.3169219692245, 5693.772249109989], "value": 4348.536215699183, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.3907069697726, 836.6318819719319, 896.538282784366, 903.1916434790858, 931.5109567477076, 15291.0, 16297.0, 16313.755293670605, 16316.836831631681, 16348.34606615737, 15422.0, 15457.0, 15537.14545699989, 15741.0, 15887.602809929758, 749.7375918428561, 862.5945805471418, 882.0561998661435, 884.226301985764, 901.076396693388, 899.029048627484, 900.1673452056854, 902.2511315608062, 902.5306840442965, 902.6750369866843, 949.2358651285713, 949.9335046546745, 951.4624237305935, 951.6621599332241, 951.8714973478561, 946.2619157057507, 947.346331031586, 947.6683160893666, 948.6679662118272, 949.4920217683541, 697.8604279144191, 698.5389642835704, 699.1505321034967, 699.1889408286414, 699.471898716471, 14584.197869117193, 14599.051061680957, 14604.050736702187, 14606.34271457787, 14656.193909334983, 13193.40629671667, 13206.339683015907, 14160.716785664332, 15572.688546229012, 15798.289076991448, 14160.150390976574, 14200.0, 14367.0, 14494.275286235752, 14716.55850324492, 4870.9269360959615, 4905.0, 4949.232868905326, 5040.924386134174, 5064.924026139611, 84686.15313846845, 84732.0, 85484.0, 86831.0, 88209.0, 12055.939720301518, 12117.69705757363, 12197.0, 12295.69260768488, 12461.501539938301, 20666.689999650018, 20943.47641308949, 20984.0, 21004.57990840205, 21101.366958991253, 8532.744017679479, 8683.044865064838, 8683.869741953877, 8717.433366831263, 8749.912500875038, 4816.8314109006715, 4864.0, 4866.367372241586, 4998.500149984972, 5030.019146266516, 3570.250247448013, 3681.4661874028116, 3723.236736469017, 3724.832382542792, 3727.7204209684382, 600.6516220592046, 602.87942411517, 604.7883240865661, 609.2719200555382, 611.3886113886114, 652.967351632426, 653.9313372095957, 668.204836244867, 737.9114506259283, 759.5746382026083, 9733.853992190123, 9917.801643967081, 9976.201903847676, 10012.449315287584, 10291.485425728684, 648.0570769530322, 649.9642519661464, 699.7550857200041, 718.4970520635576, 779.742684913977, 4834.8791280218275, 4969.701817890938, 5038.672486288379, 5074.82238121664, 5118.948810511922, 92786.0, 129099.35450322877, 134463.0, 136032.0, 136117.0, 110636.44681776539, 113171.4341428304, 113885.0, 115478.0, 115608.42195788967, 58149.0, 91319.54340228256, 95531.52234238785, 96005.039949601, 97051.0, 9383.0, 9650.662226822027, 9747.0, 10302.22733295021, 10415.166786656897, 40231.0, 40945.79527102345, 51571.22643160281, 55080.0, 57362.42637573738, 81474.0, 82356.58821706093, 82379.0, 83342.16657833586, 84289.57855210685, 14184.92907535497, 14264.500742473963, 14405.567832965027, 14527.564173074825, 14644.853551464776, 16180.919095404448, 16201.351945922032, 16437.506874793777, 16486.093264870546, 16567.751483727996, 15113.622159446102, 15116.848831511545, 15248.77126843076, 15957.68084638324, 16490.917545412198, 14644.487442939446, 14850.0, 15715.607109822346, 15807.13060781668, 15978.680426391174, 12657.620271391874, 12900.677483062624, 13027.413766380347, 13956.09285396446, 14084.15495070299, 11043.171762118034, 11102.666919992413, 11303.04335556316, 11411.543538258376, 11590.826137608112, 11269.605563805228, 11344.149188811038, 11417.486213120595, 11418.885811141783, 11717.238379505305], "value": 8049.2425571335325, "unit": "score"}], "name": "dromaeo_css", "value": 7627.353185732818, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 121.0, 108.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 127.0, 141.0, 181.0, 116.0, 145.0, 151.0, 118.0, 171.0, 117.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 162.0, 159.0, 160.0, 160.0, 161.0, 160.0, 160.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 175.0, 75.0, 75.0, 74.0, 76.0, 165.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 161.0, 83.0, 83.0, 83.0, 137.0, 83.0, 83.0, 147.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 145.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 97.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 50.0, 50.0, 49.0, 48.0, 48.0, 52.0, 49.0, 51.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 72.0, 72.0, 76.0, 73.0, 74.0, 72.0, 73.0, 81.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 128.0, 116.0, 119.0, 118.0, 127.0, 118.0, 119.0, 149.0, 120.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 150.0, 152.0, 151.0, 154.0, 148.0, 149.0, 152.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 63.0, 60.0, 60.0, 60.0, 60.0, 62.0, 62.0, 60.0], "value": 60.9, "unit": "score"}], "name": "kraken", "value": 1487.3, "alertThreshold": 2.0}]} 16:05:20 INFO - Return code: 0 16:05:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:05:20 INFO - # TBPL SUCCESS # 16:05:20 INFO - Running post-action listener: _resource_record_post_action 16:05:20 INFO - [mozharness: 2016-10-03 23:05:20.253775Z] Finished run-tests step (success) 16:05:20 INFO - Running post-run listener: _resource_record_post_run 16:05:20 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289247232; Read time: 16; Write time: 247812 16:05:20 INFO - TinderboxPrint: CPU usage
12.9% 16:05:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:05:20 INFO - TinderboxPrint: I/O write bytes / time
289,247,232 / 247,812 16:05:20 INFO - TinderboxPrint: CPU idle
8,251.0 (87.1%) 16:05:20 INFO - TinderboxPrint: CPU user
1,179.9 (12.5%) 16:05:20 INFO - TinderboxPrint: Swap in / out
0 / 0 16:05:20 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70098944; Read time: 0; Write time: 85048 16:05:20 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219148288; Read time: 16; Write time: 162764 16:05:20 INFO - Running post-run listener: _upload_blobber_files 16:05:20 INFO - Blob upload gear active. 16:05:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:05:20 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 16:05:20 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'] 16:05:20 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 16:05:21 INFO - (blobuploader) - INFO - Open directory for files ... 16:05:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:05:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:05:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:22 INFO - (blobuploader) - INFO - Done attempting. 16:05:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:05:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:05:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:25 INFO - (blobuploader) - INFO - Done attempting. 16:05:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:05:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:05:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:26 INFO - (blobuploader) - INFO - Done attempting. 16:05:26 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:26 INFO - Return code: 0 16:05:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:05:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9aa7655bac48395bd003518b1c24108c92cbd20d80728f49c42032cec691fcbf8037d2a9377febe44056451b308d025710e60ee4530f9592fba471585cf04167", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf17c03ad9e444c6ed5ae7652a4dfa9d2908a1b39b1b183e66424f2384bffa2d73f6cd28680b96342065b92e592d0146722b30633d95971b54ce13dcd9e74dc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21bfa1fdb6d38dbec740b29061a89e26a6cd9dd7e3b1a5a231f8247ea1bf2c751f15fa0d02ad6bd5849b9ee595f56e7b0051073ab3dd0dafc4cbc34c10d98db3"} 16:05:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:05:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:05:26 INFO - Contents: 16:05:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9aa7655bac48395bd003518b1c24108c92cbd20d80728f49c42032cec691fcbf8037d2a9377febe44056451b308d025710e60ee4530f9592fba471585cf04167", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf17c03ad9e444c6ed5ae7652a4dfa9d2908a1b39b1b183e66424f2384bffa2d73f6cd28680b96342065b92e592d0146722b30633d95971b54ce13dcd9e74dc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21bfa1fdb6d38dbec740b29061a89e26a6cd9dd7e3b1a5a231f8247ea1bf2c751f15fa0d02ad6bd5849b9ee595f56e7b0051073ab3dd0dafc4cbc34c10d98db3"} 16:05:26 INFO - Running post-run listener: copy_logs_to_upload_dir 16:05:26 INFO - Copying logs to upload dir... 16:05:26 INFO - mkdir: /builds/slave/test/build/upload/logs 16:05:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.020352 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-10-03 16:05:25.468748) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 16:05:25.472028) ========= 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=920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9aa7655bac48395bd003518b1c24108c92cbd20d80728f49c42032cec691fcbf8037d2a9377febe44056451b308d025710e60ee4530f9592fba471585cf04167", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf17c03ad9e444c6ed5ae7652a4dfa9d2908a1b39b1b183e66424f2384bffa2d73f6cd28680b96342065b92e592d0146722b30633d95971b54ce13dcd9e74dc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21bfa1fdb6d38dbec740b29061a89e26a6cd9dd7e3b1a5a231f8247ea1bf2c751f15fa0d02ad6bd5849b9ee595f56e7b0051073ab3dd0dafc4cbc34c10d98db3"} build_url:https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011282 build_url: 'https://queue.taskcluster.net/v1/task/KreGsP7xSne2N8C4Uzlstg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9aa7655bac48395bd003518b1c24108c92cbd20d80728f49c42032cec691fcbf8037d2a9377febe44056451b308d025710e60ee4530f9592fba471585cf04167", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf17c03ad9e444c6ed5ae7652a4dfa9d2908a1b39b1b183e66424f2384bffa2d73f6cd28680b96342065b92e592d0146722b30633d95971b54ce13dcd9e74dc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21bfa1fdb6d38dbec740b29061a89e26a6cd9dd7e3b1a5a231f8247ea1bf2c751f15fa0d02ad6bd5849b9ee595f56e7b0051073ab3dd0dafc4cbc34c10d98db3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 16:05:25.496853) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:05:25.497165) ========= 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=920470bf432669ad7e3a5387000001ca-1475534249.674394-2089335443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 16:05:25.579504) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 16:05:25.579821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 16:05:25.580119) ========= ========= Total master_lag: 0.15 =========