builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1476914990.66 results: success (0) buildid: 20161019122823 builduid: 7f1d71c721ef4a06ae2346446007a735 revision: 60d80f10cbadd3b2299701021bd9beab53a47ce8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:50.663981) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:50.664474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:50.664769) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:50.679732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:50.680126) ========= 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=6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 15:09:51-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-10-19 15:09:51 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:50.766454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:50.766791) ========= 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=6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017212 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:50.816894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:50.817265) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 60d80f10cbadd3b2299701021bd9beab53a47ce8 --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 60d80f10cbadd3b2299701021bd9beab53a47ce8 --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=6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 15:09:51,382 truncating revision to first 12 chars 2016-10-19 15:09:51,382 Setting DEBUG logging. 2016-10-19 15:09:51,382 attempt 1/10 2016-10-19 15:09:51,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/60d80f10cbad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 15:09:51,679 unpacking tar archive at: mozilla-beta-60d80f10cbad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637214 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:51.467945) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:51.468290) ========= script_repo_revision: 60d80f10cbadd3b2299701021bd9beab53a47ce8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:51.468710) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:51.468977) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 15:09:51.478259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-10-19 15:09:51.478689) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:09:52 INFO - MultiFileLogger online at 20161019 15:09:52 in /builds/slave/test 15:09:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:09:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:09:52 INFO - {'append_to_log': False, 15:09:52 INFO - 'base_work_dir': '/builds/slave/test', 15:09:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:09:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:09:52 INFO - 'branch': 'Mozilla-Beta', 15:09:52 INFO - 'buildbot_json_path': 'buildprops.json', 15:09:52 INFO - 'config_files': ('talos/linux_config.py',), 15:09:52 INFO - 'default_actions': ('clobber', 15:09:52 INFO - 'read-buildbot-config', 15:09:52 INFO - 'download-and-extract', 15:09:52 INFO - 'populate-webroot', 15:09:52 INFO - 'create-virtualenv', 15:09:52 INFO - 'install', 15:09:52 INFO - 'run-tests'), 15:09:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:09:52 INFO - 'download_minidump_stackwalk': True, 15:09:52 INFO - 'download_symbols': 'ondemand', 15:09:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:09:52 INFO - 'tooltool.py': '/tools/tooltool.py', 15:09:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:09:52 INFO - '/tools/misc-python/virtualenv.py')}, 15:09:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:09:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:09:52 INFO - 'installer_path': 'installer.exe', 15:09:52 INFO - 'log_level': 'info', 15:09:52 INFO - 'log_name': 'talos', 15:09:52 INFO - 'log_to_console': True, 15:09:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:09:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:09:52 INFO - 'opt_config_files': (), 15:09:52 INFO - 'pip_index': False, 15:09:52 INFO - 'sps_profile': False, 15:09:52 INFO - 'sps_profile_interval': 0, 15:09:52 INFO - 'suite': 'dromaeojs-e10s', 15:09:52 INFO - 'system_bits': '32', 15:09:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:09:52 INFO - 'title': 'talos-linux64-ix-050', 15:09:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:09:52 INFO - 'use_talos_json': True, 15:09:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:09:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:09:52 INFO - 'work_dir': 'build'} 15:09:52 INFO - [mozharness: 2016-10-19 22:09:52.138147Z] Running clobber step. 15:09:52 INFO - Running pre-action listener: _resource_record_pre_action 15:09:52 INFO - Running main action method: clobber 15:09:52 INFO - rmtree: /builds/slave/test/build 15:09:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:09:52 INFO - Running post-action listener: _resource_record_post_action 15:09:52 INFO - [mozharness: 2016-10-19 22:09:52.601195Z] Finished clobber step (success) 15:09:52 INFO - [mozharness: 2016-10-19 22:09:52.601295Z] Running read-buildbot-config step. 15:09:52 INFO - Running pre-action listener: _resource_record_pre_action 15:09:52 INFO - Running main action method: read_buildbot_config 15:09:52 INFO - Using buildbot properties: 15:09:52 INFO - { 15:09:52 INFO - "project": "", 15:09:52 INFO - "product": "firefox", 15:09:52 INFO - "script_repo_revision": "production", 15:09:52 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:09:52 INFO - "repository": "", 15:09:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 15:09:52 INFO - "buildid": "20161019122823", 15:09:52 INFO - "pgo_build": "True", 15:09:52 INFO - "basedir": "/builds/slave/test", 15:09:52 INFO - "buildnumber": 292, 15:09:52 INFO - "slavename": "talos-linux64-ix-050", 15:09:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:09:52 INFO - "platform": "ubuntu64_hw", 15:09:52 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:09:52 INFO - "branch": "mozilla-beta", 15:09:52 INFO - "repo_path": "releases/mozilla-beta", 15:09:52 INFO - "revision": "60d80f10cbadd3b2299701021bd9beab53a47ce8", 15:09:52 INFO - "stage_platform": "linux64-pgo", 15:09:52 INFO - "builduid": "7f1d71c721ef4a06ae2346446007a735", 15:09:52 INFO - "slavebuilddir": "test" 15:09:52 INFO - } 15:09:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 15:09:52 INFO - Running post-action listener: _resource_record_post_action 15:09:52 INFO - [mozharness: 2016-10-19 22:09:52.603723Z] Finished read-buildbot-config step (success) 15:09:52 INFO - [mozharness: 2016-10-19 22:09:52.603812Z] Running download-and-extract step. 15:09:52 INFO - Running pre-action listener: _resource_record_pre_action 15:09:52 INFO - Running main action method: download_and_extract 15:09:52 INFO - mkdir: /builds/slave/test/build/tests 15:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:52 INFO - https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:09:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:09:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:09:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:09:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:09:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:09:57 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:09:57 INFO - retry: Failed, sleeping 30 seconds before retrying 15:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:10:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:10:27 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:10:27 INFO - retry: Failed, sleeping 60 seconds before retrying 15:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:11:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:11:27 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:11:27 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:11:27 INFO - Caught exception: HTTP Error 404: Not Found 15:11:27 INFO - Caught exception: HTTP Error 404: Not Found 15:11:27 INFO - Caught exception: HTTP Error 404: Not Found 15:11:27 INFO - trying https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:11:27 INFO - Downloading https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:11:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:11:28 INFO - Downloaded 1327 bytes. 15:11:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:11:28 INFO - Using the following test package requirements: 15:11:28 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:11:28 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:11:28 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:11:28 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:11:28 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 15:11:28 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:11:28 INFO - u'jsshell-linux-x86_64.zip'], 15:11:28 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:11:28 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:11:28 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:11:28 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:11:28 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 15:11:28 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:11:28 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 15:11:28 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:11:28 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:11:28 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:11:28 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:11:28 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:11: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:11:28 INFO - https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:11:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:11:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:11:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:11:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:11:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:11:28 INFO - retry: Failed, sleeping 30 seconds before retrying 15:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:11:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:11:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:11:58 INFO - retry: Failed, sleeping 60 seconds before retrying 15:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:12:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:12:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:12:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:12:58 INFO - Caught exception: HTTP Error 404: Not Found 15:12:58 INFO - Caught exception: HTTP Error 404: Not Found 15:12:58 INFO - Caught exception: HTTP Error 404: Not Found 15:12:58 INFO - trying https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:12:58 INFO - Downloading https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:12:59 INFO - Downloaded 21774202 bytes. 15:12:59 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:12:59 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:13:00 INFO - Return code: 0 15:13:00 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:13:00 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:13:00 INFO - https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:13:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:13:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:13:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:13:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:13:00 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:13:00 INFO - retry: Failed, sleeping 30 seconds before retrying 15:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:13:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:13:30 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:13:30 INFO - retry: Failed, sleeping 60 seconds before retrying 15:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:14:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:14:30 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:14:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:14:30 INFO - Caught exception: HTTP Error 404: Not Found 15:14:30 INFO - Caught exception: HTTP Error 404: Not Found 15:14:30 INFO - Caught exception: HTTP Error 404: Not Found 15:14:30 INFO - trying https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:14:30 INFO - Downloading https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:14:31 INFO - Downloaded 21774202 bytes. 15:14:31 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:14:31 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:14:32 INFO - Return code: 0 15:14: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:14:32 INFO - https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:14:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:14:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:14:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:14:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:14:32 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:14:32 INFO - retry: Failed, sleeping 30 seconds before retrying 15:15:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:15:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:15:02 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:15:02 INFO - retry: Failed, sleeping 60 seconds before retrying 15:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:16:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:16:02 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:16:02 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:16:02 INFO - Caught exception: HTTP Error 404: Not Found 15:16:02 INFO - Caught exception: HTTP Error 404: Not Found 15:16:02 INFO - Caught exception: HTTP Error 404: Not Found 15:16:02 INFO - trying https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:16:02 INFO - Downloading https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:16:03 INFO - Downloaded 14413762 bytes. 15:16:03 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:16:03 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:16:03 INFO - Return code: 0 15:16: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:16:03 INFO - https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:16:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:16:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:16:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:16:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:16:03 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:16:03 INFO - retry: Failed, sleeping 30 seconds before retrying 15:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:16:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:16:33 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:16:33 INFO - retry: Failed, sleeping 60 seconds before retrying 15:17:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:17:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:17:33 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:17:33 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:17:33 INFO - Caught exception: HTTP Error 404: Not Found 15:17:33 INFO - Caught exception: HTTP Error 404: Not Found 15:17:33 INFO - Caught exception: HTTP Error 404: Not Found 15:17:33 INFO - trying https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:17:33 INFO - Downloading https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:17:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/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:17:35 INFO - Downloaded 56804439 bytes. 15:17:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:17:35 INFO - mkdir: /builds/slave/test/properties 15:17:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:17:35 INFO - Writing to file /builds/slave/test/properties/build_url 15:17:35 INFO - Contents: 15:17:35 INFO - build_url:https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:17:35 INFO - Running post-action listener: _resource_record_post_action 15:17:35 INFO - Running post-action listener: set_extra_try_arguments 15:17:35 INFO - [mozharness: 2016-10-19 22:17:35.958159Z] Finished download-and-extract step (success) 15:17:35 INFO - [mozharness: 2016-10-19 22:17:35.958390Z] Running populate-webroot step. 15:17:35 INFO - Running pre-action listener: _resource_record_pre_action 15:17:35 INFO - Running main action method: populate_webroot 15:17:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:17:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:17:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:17:35 INFO - '--tppagecycles', 15:17:35 INFO - '7'], 15:17:35 INFO - 'tests': ['tsvgm']}}, 15:17:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:17:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:17:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:17:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:17:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:35 INFO - 'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:35 INFO - 'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['damp', 'tps']}, 15:17:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:35 INFO - 'tests': ['damp', 'tps']}, 15:17:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['dromaeo_dom']}, 15:17:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:17:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['basic_compositor_video']}, 15:17:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:17:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['a11yr', 15:17:35 INFO - 'ts_paint', 15:17:35 INFO - 'tpaint', 15:17:35 INFO - 'sessionrestore', 15:17:35 INFO - 'sessionrestore_no_auto_restore', 15:17:35 INFO - 'tabpaint']}, 15:17:35 INFO - 'other-e10s': {'tests': ['a11yr', 15:17:35 INFO - 'ts_paint', 15:17:35 INFO - 'tpaint', 15:17:35 INFO - 'sessionrestore', 15:17:35 INFO - 'sessionrestore_no_auto_restore', 15:17:35 INFO - 'tabpaint']}, 15:17:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:17:35 INFO - 'ts_paint', 15:17:35 INFO - 'tpaint', 15:17:35 INFO - 'sessionrestore', 15:17:35 INFO - 'sessionrestore_no_auto_restore', 15:17:35 INFO - 'tabpaint']}, 15:17:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:17:35 INFO - 'ts_paint', 15:17:35 INFO - 'tpaint', 15:17:35 INFO - 'sessionrestore', 15:17:35 INFO - 'sessionrestore_no_auto_restore', 15:17:35 INFO - 'tabpaint']}, 15:17:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['a11yr', 15:17:35 INFO - 'ts_paint', 15:17:35 INFO - 'tpaint', 15:17:35 INFO - 'sessionrestore', 15:17:35 INFO - 'sessionrestore_no_auto_restore', 15:17:35 INFO - 'tabpaint']}, 15:17:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['a11yr', 15:17:35 INFO - 'ts_paint', 15:17:35 INFO - 'tpaint', 15:17:35 INFO - 'sessionrestore', 15:17:35 INFO - 'sessionrestore_no_auto_restore', 15:17:35 INFO - 'tabpaint']}, 15:17:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['tsvgx', 15:17:35 INFO - 'tsvgr_opacity', 15:17:35 INFO - 'tart', 15:17:35 INFO - 'tscrollx', 15:17:35 INFO - 'cart']}, 15:17:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:17:35 INFO - 'tsvgr_opacity', 15:17:35 INFO - 'tart', 15:17:35 INFO - 'tscrollx', 15:17:35 INFO - 'cart']}, 15:17:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:35 INFO - 'talos_options': ['--disable-e10s'], 15:17:35 INFO - 'tests': ['tp5o']}, 15:17:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:35 INFO - 'tests': ['tp5o']}, 15:17:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:35 INFO - 'talos_options': ['--disable-e10s', 15:17:35 INFO - '--xperf_path', 15:17:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:35 INFO - 'tests': ['tp5n']}, 15:17:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:35 INFO - 'talos_options': ['--xperf_path', 15:17:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:35 INFO - 'tests': ['tp5n']}}, 15:17:35 INFO - 'talos.zip': {'path': '', 15:17:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:17:35 INFO - Running post-action listener: _resource_record_post_action 15:17:35 INFO - [mozharness: 2016-10-19 22:17:35.980890Z] Finished populate-webroot step (success) 15:17:35 INFO - [mozharness: 2016-10-19 22:17:35.980978Z] Running create-virtualenv step. 15:17:35 INFO - Running pre-action listener: _resource_record_pre_action 15:17:35 INFO - Running main action method: create_virtualenv 15:17:35 INFO - Creating virtualenv /builds/slave/test/build/venv 15:17:35 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:17:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:17:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:17:36 INFO - Using real prefix '/usr' 15:17:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:17:36 INFO - Installing distribute.............................................................................................................................................................................................done. 15:17:38 INFO - Installing pip.................done. 15:17:38 INFO - Return code: 0 15:17:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:17: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:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:38 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, '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': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', '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:17:38 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:17:38 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:17:38 INFO - Using env: {'DISPLAY': ':0', 15:17:38 INFO - 'HOME': '/home/cltbld', 15:17:38 INFO - 'LANG': 'en_US.UTF-8', 15:17:38 INFO - 'LANGUAGE': 'en_US:en', 15:17:38 INFO - 'LOGNAME': 'cltbld', 15:17:38 INFO - 'MAIL': '/var/mail/cltbld', 15:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:38 INFO - 'MOZ_NO_REMOTE': '1', 15:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:38 INFO - 'NO_EM_RESTART': '1', 15:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:38 INFO - 'PWD': '/builds/slave/test', 15:17:38 INFO - 'SHELL': '/bin/bash', 15:17:38 INFO - 'SHLVL': '1', 15:17:38 INFO - 'TERM': 'linux', 15:17:38 INFO - 'TMOUT': '86400', 15:17:38 INFO - 'USER': 'cltbld', 15:17:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:38 INFO - '_': '/tools/buildbot/bin/python'} 15:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:38 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:17:38 INFO - Cleaning up... 15:17:38 INFO - Return code: 0 15:17:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:17: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:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:38 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, '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': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', '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:17:38 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:17:38 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:17:38 INFO - Using env: {'DISPLAY': ':0', 15:17:38 INFO - 'HOME': '/home/cltbld', 15:17:38 INFO - 'LANG': 'en_US.UTF-8', 15:17:38 INFO - 'LANGUAGE': 'en_US:en', 15:17:38 INFO - 'LOGNAME': 'cltbld', 15:17:38 INFO - 'MAIL': '/var/mail/cltbld', 15:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:38 INFO - 'MOZ_NO_REMOTE': '1', 15:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:38 INFO - 'NO_EM_RESTART': '1', 15:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:38 INFO - 'PWD': '/builds/slave/test', 15:17:38 INFO - 'SHELL': '/bin/bash', 15:17:38 INFO - 'SHLVL': '1', 15:17:38 INFO - 'TERM': 'linux', 15:17:38 INFO - 'TMOUT': '86400', 15:17:38 INFO - 'USER': 'cltbld', 15:17:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:38 INFO - '_': '/tools/buildbot/bin/python'} 15:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:38 INFO - Downloading/unpacking psutil>=3.1.1 15:17:38 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:17:38 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:17:38 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:17:38 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:17:38 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:17:38 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:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:17:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:41 INFO - Installing collected packages: psutil 15:17:41 INFO - Running setup.py install for psutil 15:17:41 INFO - building 'psutil._psutil_linux' extension 15:17:41 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:17:41 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:17:41 INFO - building 'psutil._psutil_posix' extension 15:17:41 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:17:41 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:17:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:41 INFO - Successfully installed psutil 15:17:41 INFO - Cleaning up... 15:17:41 INFO - Return code: 0 15:17:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:41 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, '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': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', '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:17:41 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:17:41 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:17:41 INFO - Using env: {'DISPLAY': ':0', 15:17:41 INFO - 'HOME': '/home/cltbld', 15:17:41 INFO - 'LANG': 'en_US.UTF-8', 15:17:41 INFO - 'LANGUAGE': 'en_US:en', 15:17:41 INFO - 'LOGNAME': 'cltbld', 15:17:41 INFO - 'MAIL': '/var/mail/cltbld', 15:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:41 INFO - 'MOZ_NO_REMOTE': '1', 15:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:41 INFO - 'NO_EM_RESTART': '1', 15:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:41 INFO - 'PWD': '/builds/slave/test', 15:17:41 INFO - 'SHELL': '/bin/bash', 15:17:41 INFO - 'SHLVL': '1', 15:17:41 INFO - 'TERM': 'linux', 15:17:41 INFO - 'TMOUT': '86400', 15:17:41 INFO - 'USER': 'cltbld', 15:17:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:41 INFO - '_': '/tools/buildbot/bin/python'} 15:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:17:41 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:17:41 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:17:41 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:17:41 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:17:41 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:17:41 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:17:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:17:43 INFO - Installing collected packages: mozsystemmonitor 15:17:43 INFO - Running setup.py install for mozsystemmonitor 15:17:43 INFO - Successfully installed mozsystemmonitor 15:17:43 INFO - Cleaning up... 15:17:43 INFO - Return code: 0 15:17:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:17:43 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:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:43 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:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:43 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, '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': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', '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:17:43 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:17:43 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:17:43 INFO - Using env: {'DISPLAY': ':0', 15:17:43 INFO - 'HOME': '/home/cltbld', 15:17:43 INFO - 'LANG': 'en_US.UTF-8', 15:17:43 INFO - 'LANGUAGE': 'en_US:en', 15:17:43 INFO - 'LOGNAME': 'cltbld', 15:17:43 INFO - 'MAIL': '/var/mail/cltbld', 15:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:43 INFO - 'MOZ_NO_REMOTE': '1', 15:17:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:43 INFO - 'NO_EM_RESTART': '1', 15:17:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:43 INFO - 'PWD': '/builds/slave/test', 15:17:43 INFO - 'SHELL': '/bin/bash', 15:17:43 INFO - 'SHLVL': '1', 15:17:43 INFO - 'TERM': 'linux', 15:17:43 INFO - 'TMOUT': '86400', 15:17:43 INFO - 'USER': 'cltbld', 15:17:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:43 INFO - '_': '/tools/buildbot/bin/python'} 15:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:44 INFO - Downloading/unpacking jsonschema==2.5.1 15:17:44 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:17:44 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:17:44 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:17:44 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:17:44 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:17:44 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:17:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:17:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:17:46 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:17:46 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:17:46 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:17:46 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:17:46 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:17:46 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:17:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:17:46 INFO - warning: no files found matching '*.txt' 15:17:46 INFO - no previously-included directories found matching 'build' 15:17:46 INFO - no previously-included directories found matching 'dist' 15:17:46 INFO - no previously-included directories found matching '.git*' 15:17:46 INFO - Installing collected packages: jsonschema, functools32 15:17:46 INFO - Running setup.py install for functools32 15:17:46 INFO - warning: no files found matching '*.txt' 15:17:46 INFO - no previously-included directories found matching 'build' 15:17:46 INFO - no previously-included directories found matching 'dist' 15:17:46 INFO - no previously-included directories found matching '.git*' 15:17:46 INFO - Successfully installed jsonschema functools32 15:17:46 INFO - Cleaning up... 15:17:46 INFO - Return code: 0 15:17:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:17: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:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, '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': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', '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:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:17:46 INFO - Using env: {'DISPLAY': ':0', 15:17:46 INFO - 'HOME': '/home/cltbld', 15:17:46 INFO - 'LANG': 'en_US.UTF-8', 15:17:46 INFO - 'LANGUAGE': 'en_US:en', 15:17:46 INFO - 'LOGNAME': 'cltbld', 15:17:46 INFO - 'MAIL': '/var/mail/cltbld', 15:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:46 INFO - 'MOZ_NO_REMOTE': '1', 15:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:46 INFO - 'NO_EM_RESTART': '1', 15:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:46 INFO - 'PWD': '/builds/slave/test', 15:17:46 INFO - 'SHELL': '/bin/bash', 15:17:46 INFO - 'SHLVL': '1', 15:17:46 INFO - 'TERM': 'linux', 15:17:46 INFO - 'TMOUT': '86400', 15:17:46 INFO - 'USER': 'cltbld', 15:17:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:46 INFO - '_': '/tools/buildbot/bin/python'} 15:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:17:46 INFO - Cleaning up... 15:17:46 INFO - Return code: 0 15:17:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:17: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:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17: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:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, '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': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', '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:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:17:46 INFO - Using env: {'DISPLAY': ':0', 15:17:46 INFO - 'HOME': '/home/cltbld', 15:17:46 INFO - 'LANG': 'en_US.UTF-8', 15:17:46 INFO - 'LANGUAGE': 'en_US:en', 15:17:46 INFO - 'LOGNAME': 'cltbld', 15:17:46 INFO - 'MAIL': '/var/mail/cltbld', 15:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:46 INFO - 'MOZ_NO_REMOTE': '1', 15:17:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:46 INFO - 'NO_EM_RESTART': '1', 15:17:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:46 INFO - 'PWD': '/builds/slave/test', 15:17:46 INFO - 'SHELL': '/bin/bash', 15:17:46 INFO - 'SHLVL': '1', 15:17:46 INFO - 'TERM': 'linux', 15:17:46 INFO - 'TMOUT': '86400', 15:17:46 INFO - 'USER': 'cltbld', 15:17:46 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:46 INFO - '_': '/tools/buildbot/bin/python'} 15:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:46 INFO - Downloading/unpacking blobuploader==1.2.4 15:17:46 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:17:46 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:17:46 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:17:46 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:17:46 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:17:46 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:17:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:17:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:17:48 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:17:48 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:17:48 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:17:48 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:17:48 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:17:48 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:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:17:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:17:49 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:17:49 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:17:49 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:17:49 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:17:49 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:17:49 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:17:49 INFO - Downloading docopt-0.6.1.tar.gz 15:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:17:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:17:49 INFO - Running setup.py install for blobuploader 15:17:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:17:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:17:49 INFO - Running setup.py install for requests 15:17:50 INFO - Running setup.py install for docopt 15:17:50 INFO - Successfully installed blobuploader requests docopt 15:17:50 INFO - Cleaning up... 15:17:50 INFO - Return code: 0 15:17:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:50 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:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:50 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:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:50 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, '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': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', '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:17:50 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:17:50 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:17:50 INFO - Using env: {'DISPLAY': ':0', 15:17:50 INFO - 'HOME': '/home/cltbld', 15:17:50 INFO - 'LANG': 'en_US.UTF-8', 15:17:50 INFO - 'LANGUAGE': 'en_US:en', 15:17:50 INFO - 'LOGNAME': 'cltbld', 15:17:50 INFO - 'MAIL': '/var/mail/cltbld', 15:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:50 INFO - 'MOZ_NO_REMOTE': '1', 15:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:50 INFO - 'NO_EM_RESTART': '1', 15:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:50 INFO - 'PWD': '/builds/slave/test', 15:17:50 INFO - 'SHELL': '/bin/bash', 15:17:50 INFO - 'SHLVL': '1', 15:17:50 INFO - 'TERM': 'linux', 15:17:50 INFO - 'TMOUT': '86400', 15:17:50 INFO - 'USER': 'cltbld', 15:17:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:50 INFO - '_': '/tools/buildbot/bin/python'} 15:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:50 INFO - Running setup.py (path:/tmp/pip-WNFYCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:50 INFO - Running setup.py (path:/tmp/pip-R5akBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:50 INFO - Running setup.py (path:/tmp/pip-XJHqCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:50 INFO - Running setup.py (path:/tmp/pip-yvn4nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:50 INFO - Running setup.py (path:/tmp/pip-U0kxPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:50 INFO - Running setup.py (path:/tmp/pip-QroK4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:50 INFO - Running setup.py (path:/tmp/pip-Kxz9WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:50 INFO - Running setup.py (path:/tmp/pip-gtyXF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:51 INFO - Running setup.py (path:/tmp/pip-jbQMe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:51 INFO - Running setup.py (path:/tmp/pip-TUYLZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:51 INFO - Running setup.py (path:/tmp/pip-ZvraZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:51 INFO - Running setup.py (path:/tmp/pip-ylu9WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:51 INFO - Running setup.py (path:/tmp/pip-z8uDrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:51 INFO - Running setup.py (path:/tmp/pip-J8nh3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:51 INFO - Running setup.py (path:/tmp/pip-4UO7SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:51 INFO - Running setup.py (path:/tmp/pip-Ih5PJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:51 INFO - Running setup.py (path:/tmp/pip-FKQpPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:17:51 INFO - Running setup.py install for manifestparser 15:17:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:51 INFO - Running setup.py install for mozcrash 15:17:51 INFO - Running setup.py install for mozdebug 15:17:52 INFO - Running setup.py install for mozdevice 15:17:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for mozfile 15:17:52 INFO - Running setup.py install for mozhttpd 15:17:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for mozinfo 15:17:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for mozInstall 15:17:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for mozleak 15:17:52 INFO - Running setup.py install for mozlog 15:17:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for moznetwork 15:17:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:52 INFO - Running setup.py install for mozprocess 15:17:52 INFO - Running setup.py install for mozprofile 15:17:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Running setup.py install for mozrunner 15:17:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Running setup.py install for mozscreenshot 15:17:53 INFO - Running setup.py install for moztest 15:17:53 INFO - Running setup.py install for mozversion 15:17:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:53 INFO - Cleaning up... 15:17:53 INFO - Return code: 0 15:17:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:53 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:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:53 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:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:53 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, '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': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', '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:17:53 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:17:53 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:17:53 INFO - Using env: {'DISPLAY': ':0', 15:17:53 INFO - 'HOME': '/home/cltbld', 15:17:53 INFO - 'LANG': 'en_US.UTF-8', 15:17:53 INFO - 'LANGUAGE': 'en_US:en', 15:17:53 INFO - 'LOGNAME': 'cltbld', 15:17:53 INFO - 'MAIL': '/var/mail/cltbld', 15:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:53 INFO - 'MOZ_NO_REMOTE': '1', 15:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:53 INFO - 'NO_EM_RESTART': '1', 15:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:53 INFO - 'PWD': '/builds/slave/test', 15:17:53 INFO - 'SHELL': '/bin/bash', 15:17:53 INFO - 'SHLVL': '1', 15:17:53 INFO - 'TERM': 'linux', 15:17:53 INFO - 'TMOUT': '86400', 15:17:53 INFO - 'USER': 'cltbld', 15:17:53 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:53 INFO - '_': '/tools/buildbot/bin/python'} 15:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:53 INFO - Running setup.py (path:/tmp/pip-2IE9bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:53 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:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:53 INFO - Running setup.py (path:/tmp/pip-Lsd515-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:53 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:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:53 INFO - Running setup.py (path:/tmp/pip-pVmPdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:53 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:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:53 INFO - Running setup.py (path:/tmp/pip-pl4d35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:54 INFO - Running setup.py (path:/tmp/pip-03TYBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:54 INFO - Running setup.py (path:/tmp/pip-hsCoOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:54 INFO - Running setup.py (path:/tmp/pip-ywz9vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:54 INFO - Running setup.py (path:/tmp/pip-D1vLPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:54 INFO - Running setup.py (path:/tmp/pip-DpXAsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:54 INFO - Running setup.py (path:/tmp/pip-B9vBFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:54 INFO - Running setup.py (path:/tmp/pip-_vFE2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:54 INFO - Running setup.py (path:/tmp/pip-Fy4Dxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:54 INFO - Running setup.py (path:/tmp/pip-j4ixvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:54 INFO - Running setup.py (path:/tmp/pip-LxieRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:54 INFO - Running setup.py (path:/tmp/pip-jywquE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:54 INFO - Running setup.py (path:/tmp/pip-Qre6FT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:54 INFO - Running setup.py (path:/tmp/pip-XRsS4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:54 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:17:54 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:17:54 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:17:55 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:17:55 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:17:55 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:17:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:56 INFO - Downloading blessings-1.6.tar.gz 15:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:17:56 INFO - Installing collected packages: blessings 15:17:56 INFO - Running setup.py install for blessings 15:17:57 INFO - Successfully installed blessings 15:17:57 INFO - Cleaning up... 15:17:57 INFO - Return code: 0 15:17:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:57 INFO - Reading from file tmpfile_stdout 15:17:57 INFO - Current package versions: 15:17:57 INFO - argparse == 1.2.1 15:17:57 INFO - blessings == 1.6 15:17:57 INFO - blobuploader == 1.2.4 15:17:57 INFO - docopt == 0.6.1 15:17:57 INFO - functools32 == 3.2.3-2 15:17:57 INFO - jsonschema == 2.5.1 15:17:57 INFO - manifestparser == 1.1 15:17:57 INFO - mozInstall == 1.12 15:17:57 INFO - mozcrash == 0.17 15:17:57 INFO - mozdebug == 0.1 15:17:57 INFO - mozdevice == 0.48 15:17:57 INFO - mozfile == 1.2 15:17:57 INFO - mozhttpd == 0.7 15:17:57 INFO - mozinfo == 0.9 15:17:57 INFO - mozleak == 0.1 15:17:57 INFO - mozlog == 3.3 15:17:57 INFO - moznetwork == 0.27 15:17:57 INFO - mozprocess == 0.23 15:17:57 INFO - mozprofile == 0.28 15:17:57 INFO - mozrunner == 6.12 15:17:57 INFO - mozscreenshot == 0.1 15:17:57 INFO - mozsystemmonitor == 0.3 15:17:57 INFO - moztest == 0.7 15:17:57 INFO - mozversion == 1.4 15:17:57 INFO - psutil == 3.1.1 15:17:57 INFO - requests == 1.2.3 15:17:57 INFO - wsgiref == 0.1.2 15:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:57 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:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:57 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:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:57 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, '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': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', '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:17:57 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:17:57 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:17:57 INFO - Using env: {'DISPLAY': ':0', 15:17:57 INFO - 'HOME': '/home/cltbld', 15:17:57 INFO - 'LANG': 'en_US.UTF-8', 15:17:57 INFO - 'LANGUAGE': 'en_US:en', 15:17:57 INFO - 'LOGNAME': 'cltbld', 15:17:57 INFO - 'MAIL': '/var/mail/cltbld', 15:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:57 INFO - 'MOZ_NO_REMOTE': '1', 15:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:57 INFO - 'NO_EM_RESTART': '1', 15:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:57 INFO - 'PWD': '/builds/slave/test', 15:17:57 INFO - 'SHELL': '/bin/bash', 15:17:57 INFO - 'SHLVL': '1', 15:17:57 INFO - 'TERM': 'linux', 15:17:57 INFO - 'TMOUT': '86400', 15:17:57 INFO - 'USER': 'cltbld', 15:17:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:57 INFO - '_': '/tools/buildbot/bin/python'} 15:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 INFO - Cleaning up... 15:17:57 INFO - Return code: 0 15:17:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:17:57 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:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:57 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:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:57 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 0x23e3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2612400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, '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': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', '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:17:57 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:17:57 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:17:57 INFO - Using env: {'DISPLAY': ':0', 15:17:57 INFO - 'HOME': '/home/cltbld', 15:17:57 INFO - 'LANG': 'en_US.UTF-8', 15:17:57 INFO - 'LANGUAGE': 'en_US:en', 15:17:57 INFO - 'LOGNAME': 'cltbld', 15:17:57 INFO - 'MAIL': '/var/mail/cltbld', 15:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:57 INFO - 'MOZ_NO_REMOTE': '1', 15:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:17:57 INFO - 'NO_EM_RESTART': '1', 15:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:57 INFO - 'PWD': '/builds/slave/test', 15:17:57 INFO - 'SHELL': '/bin/bash', 15:17:57 INFO - 'SHLVL': '1', 15:17:57 INFO - 'TERM': 'linux', 15:17:57 INFO - 'TMOUT': '86400', 15:17:57 INFO - 'USER': 'cltbld', 15:17:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:57 INFO - '_': '/tools/buildbot/bin/python'} 15:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:17:57 INFO - Cleaning up... 15:17:57 INFO - Return code: 0 15:17:57 INFO - Running post-action listener: _resource_record_post_action 15:17:57 INFO - Running post-action listener: _start_resource_monitoring 15:17:57 INFO - Starting resource monitoring. 15:17:57 INFO - [mozharness: 2016-10-19 22:17:57.841118Z] Finished create-virtualenv step (success) 15:17:57 INFO - [mozharness: 2016-10-19 22:17:57.841550Z] Running install step. 15:17:57 INFO - Running pre-action listener: _resource_record_pre_action 15:17:57 INFO - Running main action method: install 15:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:58 INFO - Reading from file tmpfile_stdout 15:17:58 INFO - Detecting whether we're running mozinstall >=1.0... 15:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:17:58 INFO - Reading from file tmpfile_stdout 15:17:58 INFO - Output received: 15:17:58 INFO - Usage: mozinstall [options] installer 15:17:58 INFO - Options: 15:17:58 INFO - -h, --help show this help message and exit 15:17:58 INFO - -d DEST, --destination=DEST 15:17:58 INFO - Directory to install application into. [default: 15:17:58 INFO - "/builds/slave/test"] 15:17:58 INFO - --app=APP Application being installed. [default: firefox] 15:17:58 INFO - mkdir: /builds/slave/test/build/application 15:17:58 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:17:58 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:18:11 INFO - Reading from file tmpfile_stdout 15:18:11 INFO - Output received: 15:18:11 INFO - /builds/slave/test/build/application/firefox/firefox 15:18:11 INFO - Running post-action listener: _resource_record_post_action 15:18:11 INFO - [mozharness: 2016-10-19 22:18:11.651409Z] Finished install step (success) 15:18:11 INFO - [mozharness: 2016-10-19 22:18:11.651748Z] Running run-tests step. 15:18:11 INFO - Running pre-action listener: _resource_record_pre_action 15:18:11 INFO - Running main action method: run_tests 15:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:11 INFO - Python 2.7.3 15:18:11 INFO - Return code: 0 15:18:11 INFO - grabbing minidump binary from tooltool 15:18:11 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:18:11 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 0x26a1570>, '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 0x26a2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a2900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18:11 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:18:11 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:18:11 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:18:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:11 INFO - Return code: 0 15:18:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:18:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:18:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:18:11 INFO - Using env: {'DISPLAY': ':0', 15:18:11 INFO - 'HOME': '/home/cltbld', 15:18:11 INFO - 'LANG': 'en_US.UTF-8', 15:18:11 INFO - 'LANGUAGE': 'en_US:en', 15:18:11 INFO - 'LOGNAME': 'cltbld', 15:18:11 INFO - 'MAIL': '/var/mail/cltbld', 15:18:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:11 INFO - 'MOZ_NO_REMOTE': '1', 15:18:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:11 INFO - 'NO_EM_RESTART': '1', 15:18:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:11 INFO - 'PWD': '/builds/slave/test', 15:18:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:11 INFO - 'SHELL': '/bin/bash', 15:18:11 INFO - 'SHLVL': '1', 15:18:11 INFO - 'TERM': 'linux', 15:18:11 INFO - 'TMOUT': '86400', 15:18:11 INFO - 'USER': 'cltbld', 15:18:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971', 15:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:11 INFO - '_': '/tools/buildbot/bin/python'} 15:18:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:18:11 INFO - mozversion application_buildid: 20161019122823 15:18:11 INFO - mozversion application_changeset: 60d80f10cbadd3b2299701021bd9beab53a47ce8 15:18:11 INFO - mozversion application_display_name: Firefox 15:18:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:11 INFO - mozversion application_name: Firefox 15:18:11 INFO - mozversion application_remotingname: firefox 15:18:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:18:11 INFO - mozversion application_vendor: Mozilla 15:18:11 INFO - mozversion application_version: 50.0 15:18:11 INFO - mozversion platform_buildid: 20161019122823 15:18:11 INFO - mozversion platform_changeset: 60d80f10cbadd3b2299701021bd9beab53a47ce8 15:18:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:18:11 INFO - mozversion platform_version: 50.0 15:18:11 INFO - using testdate: 1476915491 15:18:11 INFO - actual date: 1476915491 15:18:11 INFO - starting webserver on 'localhost:58581' 15:18:11 INFO - SUITE-START | Running 2 tests 15:18:11 INFO - TEST-START | dromaeo_css 15:18:11 INFO - operating with platform_type : linux_ 15:18:11 INFO - Initialising browser for dromaeo_css test... 15:18:11 INFO - TEST-INFO | started process 360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmHC8Uu/profile http://localhost:58581/getInfo.html) 15:18:16 INFO - PROCESS | 360 | __metrics Screen width/height:1600/1200 15:18:16 INFO - PROCESS | 360 | colorDepth:24 15:18:16 INFO - PROCESS | 360 | Browser inner width/height: 1024/697 15:18:16 INFO - PROCESS | 360 | __metrics 15:18:16 ERROR - PROCESS | 360 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:18:17 INFO - TEST-INFO | 360: exit 0 15:18:17 INFO - Browser initialized. 15:18:17 INFO - Running cycle 1/1 for dromaeo_css test... 15:18:17 INFO - TEST-INFO | started process 487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmHC8Uu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:29 INFO - PROCESS | 487 | RSS: Main: 150130688 15:18:29 INFO - PROCESS | 487 | 15:19:19 INFO - PROCESS | 487 | 1476915559193 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:21:27 INFO - PROCESS | 487 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58581/tests/dromaeo/cssquery-ext.html) 15:21:28 INFO - PROCESS | 487 | RSS: Main: 158240768 15:21:28 INFO - PROCESS | 487 | 15:24:30 INFO - PROCESS | 487 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-ext.html (next: http://localhost:58581/tests/dromaeo/cssquery-jquery.html) 15:24:31 INFO - PROCESS | 487 | RSS: Main: 155639808 15:24:31 INFO - PROCESS | 487 | 15:27:33 INFO - PROCESS | 487 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58581/tests/dromaeo/cssquery-mootools.html) 15:27:33 INFO - PROCESS | 487 | RSS: Main: 155009024 15:27:33 INFO - PROCESS | 487 | 15:30:35 INFO - PROCESS | 487 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58581/tests/dromaeo/cssquery-prototype.html) 15:30:36 INFO - PROCESS | 487 | RSS: Main: 156422144 15:30:36 INFO - PROCESS | 487 | 15:33:38 INFO - PROCESS | 487 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58581/tests/dromaeo/cssquery-yui.html) 15:33:39 INFO - PROCESS | 487 | RSS: Main: 157233152 15:33:39 INFO - PROCESS | 487 | 15:36:41 INFO - PROCESS | 487 | Cycle 1(1): loaded http://localhost:58581/tests/dromaeo/cssquery-yui.html (next: http://localhost:58581/tests/dromaeo/cssquery-dojo.html) 15:36:41 INFO - PROCESS | 487 | RSS: Main: 157425664 15:36:41 INFO - PROCESS | 487 | 15:36:41 INFO - PROCESS | 487 | __start_tp_report 15:36:41 INFO - PROCESS | 487 | _x_x_mozilla_page_load 15:36:41 INFO - PROCESS | 487 | _x_x_mozilla_page_load_details 15:36:41 INFO - PROCESS | 487 | |i|pagename|runs| 15:36:41 INFO - PROCESS | 487 | |0;dojo.html;3271.2803183299675;3292.259241670624;3295.0773783340674;3308.52026456164;3320.136764441246;5698.658080515167;5722.2274992876055;5723.885522289552;5728.398518155596;5760.510356619682;5658.660480371181;5692.203091567184;5724.856878578038;5733.426657334265;5762.798302059428;5186.455422180683;5193.740312984336;5243.265942767996;5258.6581872178185;5302.655327403706;5290.418054014055;5294.788208471657;5296.417394086648;5296.443873393296;5324.387695415038;5072.061668591304;5210.791568337262;5256.42179360272;5271.130263506536;5283.445238249986;5235.55497782689;5376.166694162411;5385.919211211835;5389.191621256804;5408.648437851566;5249.737513124367;5303.310569625963;5307.310049693515;5310.522053015208;5315.7873685052555;5506.311711036121;5618.775248990036;5747.770089196427;5837.270341207349;5909;6124.050772130327;6208.348123447064;6215.56491045627;6227.097070924736;6233.750649973996;6243;6258.873402787496;6270.404311590391;6278.058291256302;6279.309275979638;5578.525825304854;5662.320521537442;5837.153612726173;5838.7080645967535;5867.647941123546;6201.782937597162;6342;6352.4918006559365;6354.142190804275;6384.138141350951;6033.215681961317;6056.091586262096;6083.178770865877;6091.208142941389;6093.390660933871;5939.10913362999;6025.367336429699;6121.173641558422;6168.599041062316;6192.287886892975;6064.0297552392285;6161.322254551996;6193.628382296986;6194.566380353332;6196.628202307876;6101.60339577926;6149.600275982047;6153.8461538461;6174.043023331391;6182.69086545671;4498.21281275782;4671.556202160789;4719.551642593948;4743.31221972812;4745.976270118696;4179.435776170239;4204.3903633972905;4215.051613387025;4236.682248831288;4256.914861702749;5934.495567876693;5938.138969849348;5950.7917222896995;5952.369054876522;5955.34491205967;5913.46778789911;6139.785107521216;6226.40849119333;6234.438900498977;6239.095331176954;5945.940540594539;5965.850853728692;5976.252968378953;5983.850403739942;6030.125631783367;5361.27622770921;5365.38298095724;5373.516383525502;5385.676859388449;5388.515033646991;6131.162586540582;6333.619982801047;6342.365763423621;6521.250056243498;6533.607983521004;6256.687165641791;6279.277883043508;6287.654179020014;6290.654014029273;6299.055141728777;6474.482041436768;6530.346965303432;6531.183602049744;6531.575447595891;6555.049517819984;5758;6037.849053773691;6056.121862329849;6140.877182456236;6160.845978850564;6272.2159730033745;6291.213598300213;6291.748330066929;6292.622442653455;6309.211348581427;6127.693615319127;6145.754169833157;6166.691665416801;6170.660613666112;6174.66039367839;5766.250387449605;6032.969835150796;6076.422739839708;6147.323794382525;6167.044108163242;6111.908321375094;6135.478484328882;6142.9078563820685;6143.447089761943;6145.832291864532;6135.325114237341;6138.951482641021;6166.2600487939935;6175.907361389673;6219.626822390671;5760.251167348218;5878.2358293421585;5968.955432799329;6061.36355682647;6091.695415229132 15:36:41 INFO - PROCESS | 487 | |1;ext.html;580.373196947297;630.4893036640321;643.1767337807607;651.5536857252782;686.8729285082263;39942.600573994285;45200;45279.547204527946;45403.77298113509;45451;45299;45999;46006.769966150205;46007.769961150145;46034.76982615082;8983.416077954944;9090.818183636324;9099.04460031697;9104.45373277602;9119.817603647924;9139.177474027336;9201.95399023004;9208.125228103352;9217.032211617785;9251.44491330519;9299.814003719921;9329.860052099224;9342.2526197904;9347.719568412958;9349.252059835197;9245.676401325922;9257.305702072337;9283.978762336137;9290.95354523223;9297.72106836796;8956.865647015235;9031.187193152582;9039.141281578306;9057.32070094739;9080.455172689593;43418.34872476915;43513;43760.78119609413;43765.34351984723;43831.34252986208;3849.961500384988;4120.876373708794;4235.788210589489;4319.330503771889;4647.34937108805;34856.47715284273;34874.128146796276;34922;35163.82418087893;36098.63901360979;4603.700759450625;4611.169989401907;4651.651126165551;4660.300954856764;4676.228422310314;360876;366973;368070;368346;369132;61584;61640.38359616436;61767;61847.9999999991;61934;38268.80865595654;39485.80257098754;39559.80220098881;64326.67836660787;64415;15939.681206376039;16029.438969636007;16059.598510037109;16088.597785055466;16101.919490402473;13746.518871839638;13781.793273100711;13879.583612491642;13881.444742210198;13896.51362202318;20551.4862128445;20598.485037874172;20709.0680919359;20716.378508644764;20729.170833166503;7525.24747525254;7662.3487003604205;7720.266574675396;7725.575093369806;7839.372850172087;1088.9455527223606;1090.9890901091046;1163.3252713426193;1164.3130552973787;1174.0959461214816;34208.48687269693;34516.482252766225;37538.62461375406;37543.436848447294;37933.43099853504;1207.873173316789;1226.7853125702966;1229.551213806954;1235.567551357018;1243.564752336675;17362.305507779547;17459;17461.563460913578;17494;17722.113894305232;547689;551514;552379;553735;553746;61914.38085619176;62277.37722622806;62281;62498.0625290621;62660;1457.846926072747;1469.2727100085312;1476.2544914817947;1477.165401548122;1483.2954346685237;33094.83452582722;33385.49921751127;33661.83169084139;33769.83115084507;33817.661823382434;55234.171487428524;58357.416425835196;60236.69881650564;60354.69822650859;66743;529258;530492;536284;536548;539304;47581.524184759095;47900.76049619869;48104.759476202395;48507.27239091487;48755;53395.19907201473;53637.731811340695;53743.731281343345;53961;54265.45734542604;44160.77919610382;44946.3258051123;45072.77463612661;46055.309170361805;46788.7660561695;44372.77813610911;45466.54533454623;49378;49736;49953;45850.312245317014;47471.76264118657;47706.28440573464;48266;48782.75608621934;38833.41749873698;39594.60405396025;39860.80069599633;39971.80014099911;40788.79605601953;28658.14025579236;30615.846920765252;30653.693463065974;32065.51901721523;32719.34561308808 15:36:41 INFO - PROCESS | 487 | |2;jquery.html;414.2150624566445;418.7654913248579;424.3931178414867;427.9978600106999;441.1661958897684;18956.715649265272;20740.377788666345;20749.896250518763;20987.37037888862;21595;19962;20177.899110504462;20639.896800516013;20706.68939965898;20715.37853864383;5928.2293301870695;6144.6006009609455;6171.321154672983;6176.691165441733;6183.381661833803;6022.488088512459;6053.636781793084;6074.271087469488;6132.294786099589;6160.969195154018;5891.086881533369;6062.696865156725;6064.211652485193;6071.605345652519;6073.908891366633;5981.192539007222;5984.102384642317;6014.609050411709;6056.4851987581105;6058.1518587397795;5343.7328133593555;5436.972815135899;5480.177973303997;5492.258545096401;5498.532624726903;24272.63591046118;24373.756262437328;24554.140605078737;24581.87709061443;24696.25911222666;2485.888135033928;2527.84832910026;2694.973050269492;2771.016289217319;2950.3656713806636;15629.609259768484;15748.606284842856;15924.920375398166;16050.839491605051;16315.918420407941;2079.2202923903537;2080.761946641746;2086.54096098858;2118.4280244333945;2159.546495236002;81184.59407702983;84713.57643211745;84726.3624646045;84749;85543.14456855477;10702.357858528514;10731.785364292671;10893.400862952456;11055.06031987274;11163.609273675545;14908.403663853542;14933;15000;15000.474983375529;15011.624709382353;7994.280514753584;8485.278751306085;8502.872456913152;8634.395592308603;8640.13598640131;8091.352691784643;8230.341572674171;8260.091389947102;8386.87419688705;8445.746627601182;6829.419499342612;6885.655717214119;6962.199347075049;7017.333353331425;7135.4648401370105;1966.8623196376116;1999.7900220476931;2022.8381729461607;2023.6559784836613;2033.745781777278;1008.1569972676981;1013.5388398278766;1043.7181960870523;1051.1013083813382;1155.7457359380924;21295.8935205323;21352.893235533724;21439.78560214409;21601.56796864054;21622.35132946014;1009.8636684047707;1043.8121138195197;1059.5073290919606;1077.886821883691;1135.8012347839094;11831;11944.462499187557;12016.33910134951;12084.395780210954;12096.697582560506;550431;552884;567482;571608;572933;97132;104315;106145.46927265314;108868;109243;496.51589700042894;514.3827407111481;517.9352580927384;523.0402211941131;524.1534921102468;11505;11526.654200374001;11781.528738850693;12090.153689241668;12096.939515302367;40780.18439631131;41794;42067;43021;43601.56398435975;61870.69064654648;62051.379486206366;62616;62937.68531157315;63799.04301435389;8530.74407767768;8870.86693699582;8927.24118449939;8931.821363572562;8980.506072165832;12241.387930603256;13208.603741887759;13309.866901330863;13596.728065438834;13649.38577763983;11539.653810385702;11700;11861.525538978343;12030.518779248732;12151.513939442324;11662.241954272946;11894.583689571169;11907.702307442036;12065.215760975509;12076.21504602198;11372.772544549229;11384.544618215179;11433.771324573296;11641.825372619587;12326.445309960895;8741.781455463664;8793.648254069765;8932.687355942511;8938.910610893809;8945.73162805117;11489.597864074718;11496.712582185177;11601.767964640829;11969.281843089442;11997.76004479888 15:36:41 INFO - PROCESS | 487 | |3;mootools.html;1538.1309560098543;1575.6376033512292;1734.930602775889;1872.8220819022188;1877.7183422486635;8476;9396.765080872972;9562.904370956288;10009.44948027859;10096.444695541752;9602.135807777298;9892.653757118502;9925.900740992587;9948.502574871263;10036.749081272954;2522.180291405296;2544.2875994721508;2559.245022718293;2566.576514875053;2572.987135064322;2480.3923038855505;2592.338953566847;2597.1559243245924;2599.246218596614;2603;2542.618607208924;2545.9618105728337;2548.4011257354505;2579.509893120301;2583.651207087047;2445.74319696432;2459.495803360307;2466.506698660266;2491.6262560615874;2503.3366157968153;2419.588669926117;2436.074291769134;2442.1208364988765;2442.218490083174;2478.1202673051166;9945;9976.95011524945;9987.250956178315;10008.049235322633;10016.148627366683;5821.767129314822;5973.850653733648;5976.7908123215475;5979.1031345298115;6004.159417681528;3582.462630605404;3606.531150950386;3641;3665.4501824726503;3753.4932784074344;1138.8007098757685;1142.2404101272643;1161.9302841829433;1167.2412931594447;1189.5479717707303;14228.92885535576;14280.85719142816;14306.928465357607;14388.856111438961;14418.351174197187;4971.751412429437;5108.233764935215;5206.193040078794;5266.789328426897;5294.7352632369;12034.097442691833;12035.819462708067;12093.697657558456;12154.63536093901;12209;5954.85112872173;5974.3428222895445;5983.820485385445;5985.6408615483215;5990.011648078018;4670.556297151765;5236.083685355047;5357.812476563302;5377.435369286169;5496.5053145217125;4422.646188304928;4483.103379324149;4501.842435514807;4523.095380923763;4671.8364857229835;1318.0575888239955;1322.285965578596;1323.7021670124145;1332.0875200487696;1342.5837990223063;1003.7039073473343;1078.250615822012;1098.0885864732254;1098.2806261898309;1100.0649447969322;6636.30318816527;6646.468282537386;6777.627230502271;6945.756898508528;7002.334778196063;470.47072043950556;482.86238422049547;487.4467479410894;488.3407400009958;488.42853860982734;4378.934315985262;4456.197884380843;4503.324501324828;4553.749543775058;4657.790399432034;12037.87962120385;12486.063545234143;12602.11785175029;12607.873921260854;12638.115331926861;11743.236689615147;12325.383730813424;12494.937525312314;12513.436895339732;12527.749445011048;9139.680111196076;9309.44143351401;9346.158845703783;9365.78244828168;9365.812683746422;6688.2977287386075;6728.7308507659145;6892.689828957809;6941.236463989058;7027.22700502934;10979;11477.196596238184;11534.365609891536;11565.653030409101;11570.132240082195;11537.365444900612;11585.478653460446;11765.647030589096;11779.823302650639;11866;7638.656260468403;8621.310295176496;8747.212750852454;8919.331050171133;9018.09819018093;9693;9699.272554558578;9782.31523793356;9801.705948821547;9847.753806154904;8708.69519566812;8734.956325218332;8796.340274479311;8812.16284452976;8926.285897128084;8563.486190828571;8601.82796344082;8650.826983460422;8700.782480437787;8843.51360675169;7942.404319675932;8122.268995790408;8122.472039317426;8123.26890579827;8134.674613015413;5539.224508568723;5546.639468434539;5659.6321239119325;5702.002149623716;5781.884362312646;5957;5992.550558708027;6012.939870601238;6047.667378294236;6055.636661800306 15:36:41 INFO - PROCESS | 487 | |4;prototype.html;343.1079194095352;347.30885537779824;348.22519893237563;348.2661110284268;349.6852832450794;5778.884422311557;5906.350301466835;5930.229070220866;5934.851628709273;5961.970190149043;5742.39704830993;5763.596548241625;5777.45114214149;5855.180274761527;5868.325142608602;4009.699272554563;4393.846215382462;4419.624331931774;4434.246178149706;4491.955080449203;4435.778211089449;4440.245158323093;4452;4462.174497717916;4477.10457908418;4402.415130552999;4457.153140903234;4472.8881777955485;4492.326151077348;4506.52681468446;4298.78506074695;4386;4441.200583894898;4464.866054018385;4469.994251293466;3870.9612903870884;3877.6122387760997;3893.124047089382;3900.4539364488996;3904.7852368119743;5570.6657600544095;5579.46995035471;5612;5644.943550564524;5671.631343962629;5008.9499105008845;5107.387113546361;5108.4125325587665;5129.974350128263;5142.408623008327;5984.640921544721;6017.368176341509;6037.969810150921;6038.818835434944;6042.516598672096;4265.274903266452;4293.892652683677;4298.204832106039;4332.198543269474;4338.349247612883;5935.228420305376;6247.156633854417;6257.812265632038;6266.248050233956;6266.49868010558;4370.650347972155;4381.605655491021;4390.648748100144;4400.713953593006;4409.9559004410185;4333.696641235147;4448.288273876229;4455.643548516111;4459.799309031101;4462.397576327219;5047.570956468668;5055.823046193365;5069.898602027939;5103.260027296095;5139.8458046258675;6023.578349515579;6075.1191077294425;6077.878442431127;6093.354794205628;6162.969185154046;1477.940882364715;1500.8724258437937;1530.8316085230615;1554.8211955625247;1555.5799934017753;958.7938593202495;971.3977334052933;1005.8843233028149;1043.6138628707427;1062.946852657364;5901.760630267692;5912.556558258148;5917.792877249276;5935.109733539917;5936.614120082181;6215.223097112861;6224.751009959641;6272;6287.20814567846;6321.209848768904;5707.543396528268;5880.941190588125;5907.911381329283;5934.525237980951;5946.43508866657;3273.492608645664;3289.8355082245794;3305.3224089061687;3320.7841490303053;3324.2188085799817;6161.026138140874;6477.481801455872;6487.545871789024;6492.64290464029;6502.439414540476;6368.840778980562;6424;6426.196725409324;6458.38645328693;6486.513511486657;6349.127007532789;6492.480601551864;6571.178602674666;6581.243157037002;6601;6260.685256096271;6271.435570798468;6284.74861005573;6298;6312.936870631235;6130.938690613037;6206.348333424925;6214.533909956862;6220.724751425856;6224.221972253468;6280.340564240689;6506.707198175999;6526.67366631657;6541.34586541342;6549.96725016391;4396.560343965578;4437.689361744647;4445.977770111129;4466.57567531097;4477.507474177903;6240.563160578716;6264.843378915563;6366.204224471941;6374.139491168633;6397.96801015992;6057.969710151421;6118.388161184024;6143.907841382294;6146.846328841814;6177.938220617736;5879.412058794086;6105.3894610540365;6164.291106522807;6194.194754682043;6222.408871157233;5920.082387229986;6049.304330002106;6069.817905462844;6085.391460854056;6098.573099882966;6133.601315914451;6136.907946380898;6138.987067133873;6146.692665366624;6153.723082461211;5866.882662346815;5970.9701451492465;5984.521238300838;5985.431384018511;5985.670788106696 15:36:41 INFO - PROCESS | 487 | |5;yui.html;797.6131576185549;799.1728560939429;847.7075408983906;874.1389731114853;921.5993630414769;15705.057696538215;17028.65942681147;17151.056691881942;17611.82388176118;17964.64070718588;16158.919205403956;16374.181290935465;16431.17844107793;16484.917575412135;16489.0930998795;869.070094998352;871.1897934920521;890.7105190812979;891.4339394484484;891.5408564589242;892.7277180459957;902.9006809250977;903.2818908967387;906.9047749986255;907.2424525521164;929.0894922975455;932.2495391210073;933.2254228989956;934.72425634438;936.6581197862765;921.7419122645637;926.5182105305204;934.3599634250526;934.8691183234284;935.0649350649351;678.1489231015094;684.1858188755365;685.8388278754488;685.8388278754488;687.4534744877834;17022.489325320137;17085.743713844302;17140.14299285031;17176.22706978189;17195.054272015033;14422.206778627171;14468;14718;14800.851991480164;14822.925885370612;14113.64715882101;14255.572332829928;14514.6601730316;14537.78193327101;14541.854581454156;4846.927296090562;4848.418189817209;4873.025394920995;4929.186684197103;4954.3063971044085;71452.28547714508;73299.26700732978;73310.26689733088;81646.59176704078;82682.58658706729;12764.744705106032;12787.488500459878;12942.676433089247;13038.934805325913;13085.803712944313;22568.0972761091;22759.31722048341;22778.544429111655;22800.201992930168;23331.416714582272;8668.60991255395;8727.519986400808;8847.911520884838;8946.194842464209;9297.953510232406;4863.8540843774745;5015.322931404214;5037.19404895215;5042.747862606855;5050.04049230645;3984.7210695251633;4126.504819421689;4151;4163.437935878678;4164.583541645872;729.4747781597241;729.4747781597241;762.1578156137389;776.7126163319494;781.980450488731;732.9413646908234;761.3832795435715;807.8505476486752;820.6266148902235;833.1793183714037;9995.850062249072;10348.637797677045;10426.426546539862;10570.207234457293;10875.78248435027;743.761996161234;756.3797685897621;760.9467337286447;786.4534148766667;819.8647223208104;4796.352492413549;5016.523430274191;5075.467075956972;5085.847424577269;5088.974555127201;131672;135140;135513;136391.31804341113;136744;89445;92435;109303.45348273207;111296;113980;90192;90380.54809726041;93563.53218233865;95194.52402737942;96168.51915740517;10556.208284378856;10566.841497377392;10704.197185210984;10894.50974706156;11019.944900275448;54924.72537637446;55022.17466737922;55112;56212;56683.43316566782;72754.63622681853;75452.62273688817;80532;82240;82360.58819705863;13738.86261137376;14079.788803167756;14614.707705846036;15308.846911531187;15507.534773956799;15006.474773382879;15750.212489375257;16336.428225012543;16670.416535421686;17004.744928826323;15774.526764197093;15973.20133993319;16161;16222.91888540597;16476.752848707038;15500.92249538745;15917.840821592099;16368.345266189219;16508.42220522276;16869;14309.713805724035;14496.565103046925;14963.925180374028;15169.696606067597;15208.391664333303;12489.250644961332;12497.687557811127;12813.295268760308;13171.934140329236;13332.133411328232;12460.190087644274;12809.167404118702;12871.678208044874;12975.156614820007;12988.675283117998 15:36:41 INFO - PROCESS | 487 | __end_tp_report 15:36:41 INFO - PROCESS | 487 | __start_cc_report 15:36:41 INFO - PROCESS | 487 | _x_x_mozilla_cycle_collect,338 15:36:41 INFO - PROCESS | 487 | __end_cc_report 15:36:41 INFO - PROCESS | 487 | __startTimestamp1476916601834__endTimestamp 15:36:41 INFO - PROCESS | 487 | 15:36:41 INFO - PROCESS | 487 | ------- Summary: start ------- 15:36:41 INFO - PROCESS | 487 | Number of tests: 6 15:36:41 INFO - PROCESS | 487 | 15:36:41 INFO - PROCESS | 487 | [#0] dojo.html Cycles:165 Average:5763.64 Median:6030.13 stddev:671.54 (11.1%) stddev-sans-first:644.50 15:36:41 INFO - PROCESS | 487 | Values: 3271.3 3292.3 3295.1 3308.5 3320.1 5698.7 5722.2 5723.9 5728.4 5760.5 5658.7 5692.2 5724.9 5733.4 5762.8 5186.5 5193.7 5243.3 5258.7 5302.7 5290.4 5294.8 5296.4 5296.4 5324.4 5072.1 5210.8 5256.4 5271.1 5283.4 5235.6 5376.2 5385.9 5389.2 5408.6 5249.7 5303.3 5307.3 5310.5 5315.8 5506.3 5618.8 5747.8 5837.3 5909.0 6124.1 6208.3 6215.6 6227.1 6233.8 6243.0 6258.9 6270.4 6278.1 6279.3 5578.5 5662.3 5837.2 5838.7 5867.6 6201.8 6342.0 6352.5 6354.1 6384.1 6033.2 6056.1 6083.2 6091.2 6093.4 5939.1 6025.4 6121.2 6168.6 6192.3 6064.0 6161.3 6193.6 6194.6 6196.6 6101.6 6149.6 6153.8 6174.0 6182.7 4498.2 4671.6 4719.6 4743.3 4746.0 4179.4 4204.4 4215.1 4236.7 4256.9 5934.5 5938.1 5950.8 5952.4 5955.3 5913.5 6139.8 6226.4 6234.4 6239.1 5945.9 5965.9 5976.3 5983.9 6030.1 5361.3 5365.4 5373.5 5385.7 5388.5 6131.2 6333.6 6342.4 6521.3 6533.6 6256.7 6279.3 6287.7 6290.7 6299.1 6474.5 6530.3 6531.2 6531.6 6555.0 5758.0 6037.8 6056.1 6140.9 6160.8 6272.2 6291.2 6291.7 6292.6 6309.2 6127.7 6145.8 6166.7 6170.7 6174.7 5766.3 6033.0 6076.4 6147.3 6167.0 6111.9 6135.5 6142.9 6143.4 6145.8 6135.3 6139.0 6166.3 6175.9 6219.6 5760.3 5878.2 5969.0 6061.4 6091.7 15:36:41 INFO - PROCESS | 487 | 15:36:41 INFO - PROCESS | 487 | [#1] ext.html Cycles:180 Average:65937.31 Median:46007.27 stddev:130285.24 (283.2%) stddev-sans-first:130558.31 15:36:41 INFO - PROCESS | 487 | Values: 580.4 630.5 643.2 651.6 686.9 39942.6 45200.0 45279.5 45403.8 45451.0 45299.0 45999.0 46006.8 46007.8 46034.8 8983.4 9090.8 9099.0 9104.5 9119.8 9139.2 9202.0 9208.1 9217.0 9251.4 9299.8 9329.9 9342.3 9347.7 9349.3 9245.7 9257.3 9284.0 9291.0 9297.7 8956.9 9031.2 9039.1 9057.3 9080.5 43418.3 43513.0 43760.8 43765.3 43831.3 3850.0 4120.9 4235.8 4319.3 4647.3 34856.5 34874.1 34922.0 35163.8 36098.6 4603.7 4611.2 4651.7 4660.3 4676.2 360876.0 366973.0 368070.0 368346.0 369132.0 61584.0 61640.4 61767.0 61848.0 61934.0 38268.8 39485.8 39559.8 64326.7 64415.0 15939.7 16029.4 16059.6 16088.6 16101.9 13746.5 13781.8 13879.6 13881.4 13896.5 20551.5 20598.5 20709.1 20716.4 20729.2 7525.2 7662.3 7720.3 7725.6 7839.4 1088.9 1091.0 1163.3 1164.3 1174.1 34208.5 34516.5 37538.6 37543.4 37933.4 1207.9 1226.8 1229.6 1235.6 1243.6 17362.3 17459.0 17461.6 17494.0 17722.1 547689.0 551514.0 552379.0 553735.0 553746.0 61914.4 62277.4 62281.0 62498.1 62660.0 1457.8 1469.3 1476.3 1477.2 1483.3 33094.8 33385.5 33661.8 33769.8 33817.7 55234.2 58357.4 60236.7 60354.7 66743.0 529258.0 530492.0 536284.0 536548.0 539304.0 47581.5 47900.8 48104.8 48507.3 48755.0 53395.2 53637.7 53743.7 53961.0 54265.5 44160.8 44946.3 45072.8 46055.3 46788.8 44372.8 45466.5 49378.0 49736.0 49953.0 45850.3 47471.8 47706.3 48266.0 48782.8 38833.4 39594.6 39860.8 39971.8 40788.8 28658.1 30615.8 30653.7 32065.5 32719.3 15:36:41 INFO - PROCESS | 487 | 15:36:41 INFO - PROCESS | 487 | [#2] jquery.html Cycles:180 Average:31978.49 Median:24463.95 stddev:92792.18 (379.3%) stddev-sans-first:93022.22 15:36:41 INFO - PROCESS | 487 | Values: 414.2 418.8 424.4 428.0 441.2 18956.7 20740.4 20749.9 20987.4 21595.0 19962.0 20177.9 20639.9 20706.7 20715.4 5928.2 6144.6 6171.3 6176.7 6183.4 6022.5 6053.6 6074.3 6132.3 6161.0 5891.1 6062.7 6064.2 6071.6 6073.9 5981.2 5984.1 6014.6 6056.5 6058.2 5343.7 5437.0 5480.2 5492.3 5498.5 24272.6 24373.8 24554.1 24581.9 24696.3 2485.9 2527.8 2695.0 2771.0 2950.4 15629.6 15748.6 15924.9 16050.8 16315.9 2079.2 2080.8 2086.5 2118.4 2159.5 81184.6 84713.6 84726.4 84749.0 85543.1 10702.4 10731.8 10893.4 11055.1 11163.6 14908.4 14933.0 15000.0 15000.5 15011.6 7994.3 8485.3 8502.9 8634.4 8640.1 8091.4 8230.3 8260.1 8386.9 8445.7 6829.4 6885.7 6962.2 7017.3 7135.5 1966.9 1999.8 2022.8 2023.7 2033.7 1008.2 1013.5 1043.7 1051.1 1155.7 21295.9 21352.9 21439.8 21601.6 21622.4 1009.9 1043.8 1059.5 1077.9 1135.8 11831.0 11944.5 12016.3 12084.4 12096.7 550431.0 552884.0 567482.0 571608.0 572933.0 97132.0 104315.0 106145.5 108868.0 109243.0 496.5 514.4 517.9 523.0 524.2 11505.0 11526.7 11781.5 12090.2 12096.9 40780.2 41794.0 42067.0 43021.0 43601.6 61870.7 62051.4 62616.0 62937.7 63799.0 8530.7 8870.9 8927.2 8931.8 8980.5 12241.4 13208.6 13309.9 13596.7 13649.4 11539.7 11700.0 11861.5 12030.5 12151.5 11662.2 11894.6 11907.7 12065.2 12076.2 11372.8 11384.5 11433.8 11641.8 12326.4 8741.8 8793.6 8932.7 8938.9 8945.7 11489.6 11496.7 11601.8 11969.3 11997.8 15:36:41 INFO - PROCESS | 487 | 15:36:41 INFO - PROCESS | 487 | [#3] mootools.html Cycles:180 Average:6545.66 Median:4513.21 stddev:3835.59 (85.0%) stddev-sans-first:3827.89 15:36:41 INFO - PROCESS | 487 | Values: 1538.1 1575.6 1734.9 1872.8 1877.7 8476.0 9396.8 9562.9 10009.4 10096.4 9602.1 9892.7 9925.9 9948.5 10036.7 2522.2 2544.3 2559.2 2566.6 2573.0 2480.4 2592.3 2597.2 2599.2 2603.0 2542.6 2546.0 2548.4 2579.5 2583.7 2445.7 2459.5 2466.5 2491.6 2503.3 2419.6 2436.1 2442.1 2442.2 2478.1 9945.0 9977.0 9987.3 10008.0 10016.1 5821.8 5973.9 5976.8 5979.1 6004.2 3582.5 3606.5 3641.0 3665.5 3753.5 1138.8 1142.2 1161.9 1167.2 1189.5 14228.9 14280.9 14306.9 14388.9 14418.4 4971.8 5108.2 5206.2 5266.8 5294.7 12034.1 12035.8 12093.7 12154.6 12209.0 5954.9 5974.3 5983.8 5985.6 5990.0 4670.6 5236.1 5357.8 5377.4 5496.5 4422.6 4483.1 4501.8 4523.1 4671.8 1318.1 1322.3 1323.7 1332.1 1342.6 1003.7 1078.3 1098.1 1098.3 1100.1 6636.3 6646.5 6777.6 6945.8 7002.3 470.5 482.9 487.4 488.3 488.4 4378.9 4456.2 4503.3 4553.7 4657.8 12037.9 12486.1 12602.1 12607.9 12638.1 11743.2 12325.4 12494.9 12513.4 12527.7 9139.7 9309.4 9346.2 9365.8 9365.8 6688.3 6728.7 6892.7 6941.2 7027.2 10979.0 11477.2 11534.4 11565.7 11570.1 11537.4 11585.5 11765.6 11779.8 11866.0 7638.7 8621.3 8747.2 8919.3 9018.1 9693.0 9699.3 9782.3 9801.7 9847.8 8708.7 8735.0 8796.3 8812.2 8926.3 8563.5 8601.8 8650.8 8700.8 8843.5 7942.4 8122.3 8122.5 8123.3 8134.7 5539.2 5546.6 5659.6 5702.0 5781.9 5957.0 5992.6 6012.9 6047.7 6055.6 15:36:41 INFO - PROCESS | 487 | 15:36:41 INFO - PROCESS | 487 | [#4] prototype.html Cycles:180 Average:5118.14 Median:5910.23 stddev:1534.04 (26.0%) stddev-sans-first:1495.89 15:36:41 INFO - PROCESS | 487 | Values: 343.1 347.3 348.2 348.3 349.7 5778.9 5906.4 5930.2 5934.9 5962.0 5742.4 5763.6 5777.5 5855.2 5868.3 4009.7 4393.8 4419.6 4434.2 4492.0 4435.8 4440.2 4452.0 4462.2 4477.1 4402.4 4457.2 4472.9 4492.3 4506.5 4298.8 4386.0 4441.2 4464.9 4470.0 3871.0 3877.6 3893.1 3900.5 3904.8 5570.7 5579.5 5612.0 5644.9 5671.6 5008.9 5107.4 5108.4 5130.0 5142.4 5984.6 6017.4 6038.0 6038.8 6042.5 4265.3 4293.9 4298.2 4332.2 4338.3 5935.2 6247.2 6257.8 6266.2 6266.5 4370.7 4381.6 4390.6 4400.7 4410.0 4333.7 4448.3 4455.6 4459.8 4462.4 5047.6 5055.8 5069.9 5103.3 5139.8 6023.6 6075.1 6077.9 6093.4 6163.0 1477.9 1500.9 1530.8 1554.8 1555.6 958.8 971.4 1005.9 1043.6 1062.9 5901.8 5912.6 5917.8 5935.1 5936.6 6215.2 6224.8 6272.0 6287.2 6321.2 5707.5 5880.9 5907.9 5934.5 5946.4 3273.5 3289.8 3305.3 3320.8 3324.2 6161.0 6477.5 6487.5 6492.6 6502.4 6368.8 6424.0 6426.2 6458.4 6486.5 6349.1 6492.5 6571.2 6581.2 6601.0 6260.7 6271.4 6284.7 6298.0 6312.9 6130.9 6206.3 6214.5 6220.7 6224.2 6280.3 6506.7 6526.7 6541.3 6550.0 4396.6 4437.7 4446.0 4466.6 4477.5 6240.6 6264.8 6366.2 6374.1 6398.0 6058.0 6118.4 6143.9 6146.8 6177.9 5879.4 6105.4 6164.3 6194.2 6222.4 5920.1 6049.3 6069.8 6085.4 6098.6 6133.6 6136.9 6139.0 6146.7 6153.7 5866.9 5971.0 5984.5 5985.4 5985.7 15:36:41 INFO - PROCESS | 487 | 15:36:41 INFO - PROCESS | 487 | [#5] yui.html Cycles:180 Average:22719.98 Median:4164.01 stddev:32665.59 (784.5%) stddev-sans-first:32715.75 15:36:41 INFO - PROCESS | 487 | Values: 797.6 799.2 847.7 874.1 921.6 15705.1 17028.7 17151.1 17611.8 17964.6 16158.9 16374.2 16431.2 16484.9 16489.1 869.1 871.2 890.7 891.4 891.5 892.7 902.9 903.3 906.9 907.2 929.1 932.2 933.2 934.7 936.7 921.7 926.5 934.4 934.9 935.1 678.1 684.2 685.8 685.8 687.5 17022.5 17085.7 17140.1 17176.2 17195.1 14422.2 14468.0 14718.0 14800.9 14822.9 14113.6 14255.6 14514.7 14537.8 14541.9 4846.9 4848.4 4873.0 4929.2 4954.3 71452.3 73299.3 73310.3 81646.6 82682.6 12764.7 12787.5 12942.7 13038.9 13085.8 22568.1 22759.3 22778.5 22800.2 23331.4 8668.6 8727.5 8847.9 8946.2 9298.0 4863.9 5015.3 5037.2 5042.7 5050.0 3984.7 4126.5 4151.0 4163.4 4164.6 729.5 729.5 762.2 776.7 782.0 732.9 761.4 807.9 820.6 833.2 9995.9 10348.6 10426.4 10570.2 10875.8 743.8 756.4 760.9 786.5 819.9 4796.4 5016.5 5075.5 5085.8 5089.0 131672.0 135140.0 135513.0 136391.3 136744.0 89445.0 92435.0 109303.5 111296.0 113980.0 90192.0 90380.5 93563.5 95194.5 96168.5 10556.2 10566.8 10704.2 10894.5 11019.9 54924.7 55022.2 55112.0 56212.0 56683.4 72754.6 75452.6 80532.0 82240.0 82360.6 13738.9 14079.8 14614.7 15308.8 15507.5 15006.5 15750.2 16336.4 16670.4 17004.7 15774.5 15973.2 16161.0 16222.9 16476.8 15500.9 15917.8 16368.3 16508.4 16869.0 14309.7 14496.6 14963.9 15169.7 15208.4 12489.3 12497.7 12813.3 13171.9 13332.1 12460.2 12809.2 12871.7 12975.2 12988.7 15:36:41 INFO - PROCESS | 487 | -------- Summary: end -------- 15:36:41 INFO - PROCESS | 487 | 15:36:42 INFO - TEST-INFO | 487: exit 0 15:36:42 INFO - TEST-OK | dromaeo_css | took 1110581ms 15:36:42 INFO - TEST-START | kraken 15:36:42 INFO - operating with platform_type : linux_ 15:36:42 INFO - Initialising browser for kraken test... 15:36:42 INFO - TEST-INFO | started process 729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH1cyuI/profile http://localhost:58581/getInfo.html) 15:36:46 INFO - PROCESS | 729 | __metrics Screen width/height:1600/1200 15:36:46 INFO - PROCESS | 729 | colorDepth:24 15:36:46 INFO - PROCESS | 729 | Browser inner width/height: 1024/697 15:36:46 INFO - PROCESS | 729 | __metrics 15:36:47 ERROR - PROCESS | 729 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:36:48 INFO - TEST-INFO | 729: exit 0 15:36:48 INFO - Browser initialized. 15:36:48 INFO - Running cycle 1/1 for kraken test... 15:36:48 INFO - TEST-INFO | started process 860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH1cyuI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:00 INFO - PROCESS | 860 | RSS: Main: 149684224 15:37:00 INFO - PROCESS | 860 | 15:37:02 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58581/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:03 INFO - PROCESS | 860 | RSS: Main: 156483584 15:37:03 INFO - PROCESS | 860 | 15:37:05 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58581/tests/kraken/driver.html?testName=audio-dft) 15:37:06 INFO - PROCESS | 860 | RSS: Main: 155062272 15:37:06 INFO - PROCESS | 860 | 15:37:09 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58581/tests/kraken/driver.html?testName=audio-fft) 15:37:10 INFO - PROCESS | 860 | RSS: Main: 155754496 15:37:10 INFO - PROCESS | 860 | 15:37:12 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58581/tests/kraken/driver.html?testName=audio-oscillator) 15:37:12 INFO - PROCESS | 860 | RSS: Main: 155635712 15:37:12 INFO - PROCESS | 860 | 15:37:14 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:37:15 INFO - PROCESS | 860 | RSS: Main: 155332608 15:37:15 INFO - PROCESS | 860 | 15:37:18 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58581/tests/kraken/driver.html?testName=imaging-darkroom) 15:37:19 INFO - PROCESS | 860 | RSS: Main: 155357184 15:37:19 INFO - PROCESS | 860 | 15:37:22 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58581/tests/kraken/driver.html?testName=imaging-desaturate) 15:37:23 INFO - PROCESS | 860 | RSS: Main: 153653248 15:37:23 INFO - PROCESS | 860 | 15:37:26 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58581/tests/kraken/driver.html?testName=json-parse-financial) 15:37:26 INFO - PROCESS | 860 | RSS: Main: 155541504 15:37:26 INFO - PROCESS | 860 | 15:37:28 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:37:28 INFO - PROCESS | 860 | RSS: Main: 155127808 15:37:28 INFO - PROCESS | 860 | 15:37:30 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:37:31 INFO - PROCESS | 860 | RSS: Main: 155267072 15:37:31 INFO - PROCESS | 860 | 15:37:33 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:37:33 INFO - PROCESS | 860 | RSS: Main: 155836416 15:37:33 INFO - PROCESS | 860 | 15:37:36 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:37:37 INFO - PROCESS | 860 | RSS: Main: 156008448 15:37:37 INFO - PROCESS | 860 | 15:37:39 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:37:40 INFO - PROCESS | 860 | RSS: Main: 156925952 15:37:40 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | Cycle 1(1): loaded http://localhost:58581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58581/tests/kraken/driver.html?testName=ai-astar) 15:37:42 INFO - PROCESS | 860 | RSS: Main: 158191616 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | __start_tp_report 15:37:42 INFO - PROCESS | 860 | _x_x_mozilla_page_load 15:37:42 INFO - PROCESS | 860 | _x_x_mozilla_page_load_details 15:37:42 INFO - PROCESS | 860 | |i|pagename|runs| 15:37:42 INFO - PROCESS | 860 | |0;ai-astar;102;115;104;111;111;112;110;110;111;111 15:37:42 INFO - PROCESS | 860 | |1;audio-beat-detection;150;117;140;167;118;148;148;119;172;117 15:37:42 INFO - PROCESS | 860 | |2;audio-dft;163;165;163;163;162;163;163;161;161;164 15:37:42 INFO - PROCESS | 860 | |3;audio-fft;75;75;76;171;75;76;78;75;175;75 15:37:42 INFO - PROCESS | 860 | |4;audio-oscillator;85;83;141;84;84;83;148;84;84;145 15:37:42 INFO - PROCESS | 860 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;117;118 15:37:42 INFO - PROCESS | 860 | |6;imaging-darkroom;148;147;148;149;149;148;147;146;147;147 15:37:42 INFO - PROCESS | 860 | |7;imaging-desaturate;95;95;97;95;100;100;96;95;95;95 15:37:42 INFO - PROCESS | 860 | |8;json-parse-financial;50;52;52;51;52;51;51;51;51;61 15:37:42 INFO - PROCESS | 860 | |9;json-stringify-tinderbox;63;59;60;60;60;60;60;67;61;68 15:37:42 INFO - PROCESS | 860 | |10;stanford-crypto-aes;76;78;76;73;73;72;73;75;72;74 15:37:42 INFO - PROCESS | 860 | |11;stanford-crypto-ccm;139;132;118;119;117;124;130;117;152;130 15:37:42 INFO - PROCESS | 860 | |12;stanford-crypto-pbkdf2;153;152;153;152;157;154;152;151;154;159 15:37:42 INFO - PROCESS | 860 | |13;stanford-crypto-sha256-iterative;62;62;62;65;68;65;60;61;61;64 15:37:42 INFO - PROCESS | 860 | __end_tp_report 15:37:42 INFO - PROCESS | 860 | __start_cc_report 15:37:42 INFO - PROCESS | 860 | _x_x_mozilla_cycle_collect,900 15:37:42 INFO - PROCESS | 860 | __end_cc_report 15:37:42 INFO - PROCESS | 860 | __startTimestamp1476916662347__endTimestamp 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | ------- Summary: start ------- 15:37:42 INFO - PROCESS | 860 | Number of tests: 14 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.83 (3.5%) stddev-sans-first:2.88 15:37:42 INFO - PROCESS | 860 | Values: 102.0 115.0 104.0 111.0 111.0 112.0 110.0 110.0 111.0 111.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:148.00 stddev:20.98 (14.2%) stddev-sans-first:21.92 15:37:42 INFO - PROCESS | 860 | Values: 150.0 117.0 140.0 167.0 118.0 148.0 148.0 119.0 172.0 117.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 15:37:42 INFO - PROCESS | 860 | Values: 163.0 165.0 163.0 163.0 162.0 163.0 163.0 161.0 161.0 164.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#3] audio-fft Cycles:10 Average:95.10 Median:75.00 stddev:41.08 (54.8%) stddev-sans-first:42.92 15:37:42 INFO - PROCESS | 860 | Values: 75.0 75.0 76.0 171.0 75.0 76.0 78.0 75.0 175.0 75.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:84.00 stddev:29.43 (35.0%) stddev-sans-first:30.55 15:37:42 INFO - PROCESS | 860 | Values: 85.0 83.0 141.0 84.0 84.0 83.0 148.0 84.0 84.0 145.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:37:42 INFO - PROCESS | 860 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 15:37:42 INFO - PROCESS | 860 | Values: 148.0 147.0 148.0 149.0 149.0 148.0 147.0 146.0 147.0 147.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:95.00 stddev:2.06 (2.2%) stddev-sans-first:2.13 15:37:42 INFO - PROCESS | 860 | Values: 95.0 95.0 97.0 95.0 100.0 100.0 96.0 95.0 95.0 95.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:51.50 stddev:3.16 (6.1%) stddev-sans-first:3.24 15:37:42 INFO - PROCESS | 860 | Values: 50.0 52.0 52.0 51.0 52.0 51.0 51.0 51.0 51.0 61.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:60.50 stddev:3.19 (5.3%) stddev-sans-first:3.35 15:37:42 INFO - PROCESS | 860 | Values: 63.0 59.0 60.0 60.0 60.0 60.0 60.0 67.0 61.0 68.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.50 stddev:1.99 (2.7%) stddev-sans-first:2.00 15:37:42 INFO - PROCESS | 860 | Values: 76.0 78.0 76.0 73.0 73.0 72.0 73.0 75.0 72.0 74.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:130.00 stddev:11.35 (8.7%) stddev-sans-first:11.29 15:37:42 INFO - PROCESS | 860 | Values: 139.0 132.0 118.0 119.0 117.0 124.0 130.0 117.0 152.0 130.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:153.50 stddev:2.50 (1.6%) stddev-sans-first:2.64 15:37:42 INFO - PROCESS | 860 | Values: 153.0 152.0 153.0 152.0 157.0 154.0 152.0 151.0 154.0 159.0 15:37:42 INFO - PROCESS | 860 | 15:37:42 INFO - PROCESS | 860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:2.45 (3.9%) stddev-sans-first:2.57 15:37:42 INFO - PROCESS | 860 | Values: 62.0 62.0 62.0 65.0 68.0 65.0 60.0 61.0 61.0 64.0 15:37:42 INFO - PROCESS | 860 | -------- Summary: end -------- 15:37:42 INFO - PROCESS | 860 | 15:37:43 INFO - TEST-INFO | 860: exit 0 15:37:43 INFO - TEST-OK | kraken | took 60786ms 15:37:43 INFO - SUITE-END | took 1171s 15:37:43 INFO - Completed test suite (00:19:31) 15:37:43 INFO - javascript benchmark 15:37:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7860.540794896229, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3271.2803183299675, 3292.259241670624, 3295.0773783340674, 3308.52026456164, 3320.136764441246, 5698.658080515167, 5722.2274992876055, 5723.885522289552, 5728.398518155596, 5760.510356619682, 5658.660480371181, 5692.203091567184, 5724.856878578038, 5733.426657334265, 5762.798302059428, 5186.455422180683, 5193.740312984336, 5243.265942767996, 5258.6581872178185, 5302.655327403706, 5290.418054014055, 5294.788208471657, 5296.417394086648, 5296.443873393296, 5324.387695415038, 5072.061668591304, 5210.791568337262, 5256.42179360272, 5271.130263506536, 5283.445238249986, 5235.55497782689, 5376.166694162411, 5385.919211211835, 5389.191621256804, 5408.648437851566, 5249.737513124367, 5303.310569625963, 5307.310049693515, 5310.522053015208, 5315.7873685052555, 5506.311711036121, 5618.775248990036, 5747.770089196427, 5837.270341207349, 5909.0, 6124.050772130327, 6208.348123447064, 6215.56491045627, 6227.097070924736, 6233.750649973996, 6243.0, 6258.873402787496, 6270.404311590391, 6278.058291256302, 6279.309275979638, 5578.525825304854, 5662.320521537442, 5837.153612726173, 5838.7080645967535, 5867.647941123546, 6201.782937597162, 6342.0, 6352.4918006559365, 6354.142190804275, 6384.138141350951, 6033.215681961317, 6056.091586262096, 6083.178770865877, 6091.208142941389, 6093.390660933871, 5939.10913362999, 6025.367336429699, 6121.173641558422, 6168.599041062316, 6192.287886892975, 6064.0297552392285, 6161.322254551996, 6193.628382296986, 6194.566380353332, 6196.628202307876, 6101.60339577926, 6149.600275982047, 6153.8461538461, 6174.043023331391, 6182.69086545671, 4498.21281275782, 4671.556202160789, 4719.551642593948, 4743.31221972812, 4745.976270118696, 4179.435776170239, 4204.3903633972905, 4215.051613387025, 4236.682248831288, 4256.914861702749, 5934.495567876693, 5938.138969849348, 5950.7917222896995, 5952.369054876522, 5955.34491205967, 5913.46778789911, 6139.785107521216, 6226.40849119333, 6234.438900498977, 6239.095331176954, 5945.940540594539, 5965.850853728692, 5976.252968378953, 5983.850403739942, 6030.125631783367, 5361.27622770921, 5365.38298095724, 5373.516383525502, 5385.676859388449, 5388.515033646991, 6131.162586540582, 6333.619982801047, 6342.365763423621, 6521.250056243498, 6533.607983521004, 6256.687165641791, 6279.277883043508, 6287.654179020014, 6290.654014029273, 6299.055141728777, 6474.482041436768, 6530.346965303432, 6531.183602049744, 6531.575447595891, 6555.049517819984, 5758.0, 6037.849053773691, 6056.121862329849, 6140.877182456236, 6160.845978850564, 6272.2159730033745, 6291.213598300213, 6291.748330066929, 6292.622442653455, 6309.211348581427, 6127.693615319127, 6145.754169833157, 6166.691665416801, 6170.660613666112, 6174.66039367839, 5766.250387449605, 6032.969835150796, 6076.422739839708, 6147.323794382525, 6167.044108163242, 6111.908321375094, 6135.478484328882, 6142.9078563820685, 6143.447089761943, 6145.832291864532, 6135.325114237341, 6138.951482641021, 6166.2600487939935, 6175.907361389673, 6219.626822390671, 5760.251167348218, 5878.2358293421585, 5968.955432799329, 6061.36355682647, 6091.695415229132], "value": 5717.047921159812, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.373196947297, 630.4893036640321, 643.1767337807607, 651.5536857252782, 686.8729285082263, 39942.600573994285, 45200.0, 45279.547204527946, 45403.77298113509, 45451.0, 45299.0, 45999.0, 46006.769966150205, 46007.769961150145, 46034.76982615082, 8983.416077954944, 9090.818183636324, 9099.04460031697, 9104.45373277602, 9119.817603647924, 9139.177474027336, 9201.95399023004, 9208.125228103352, 9217.032211617785, 9251.44491330519, 9299.814003719921, 9329.860052099224, 9342.2526197904, 9347.719568412958, 9349.252059835197, 9245.676401325922, 9257.305702072337, 9283.978762336137, 9290.95354523223, 9297.72106836796, 8956.865647015235, 9031.187193152582, 9039.141281578306, 9057.32070094739, 9080.455172689593, 43418.34872476915, 43513.0, 43760.78119609413, 43765.34351984723, 43831.34252986208, 3849.961500384988, 4120.876373708794, 4235.788210589489, 4319.330503771889, 4647.34937108805, 34856.47715284273, 34874.128146796276, 34922.0, 35163.82418087893, 36098.63901360979, 4603.700759450625, 4611.169989401907, 4651.651126165551, 4660.300954856764, 4676.228422310314, 360876.0, 366973.0, 368070.0, 368346.0, 369132.0, 61584.0, 61640.38359616436, 61767.0, 61847.9999999991, 61934.0, 38268.80865595654, 39485.80257098754, 39559.80220098881, 64326.67836660787, 64415.0, 15939.681206376039, 16029.438969636007, 16059.598510037109, 16088.597785055466, 16101.919490402473, 13746.518871839638, 13781.793273100711, 13879.583612491642, 13881.444742210198, 13896.51362202318, 20551.4862128445, 20598.485037874172, 20709.0680919359, 20716.378508644764, 20729.170833166503, 7525.24747525254, 7662.3487003604205, 7720.266574675396, 7725.575093369806, 7839.372850172087, 1088.9455527223606, 1090.9890901091046, 1163.3252713426193, 1164.3130552973787, 1174.0959461214816, 34208.48687269693, 34516.482252766225, 37538.62461375406, 37543.436848447294, 37933.43099853504, 1207.873173316789, 1226.7853125702966, 1229.551213806954, 1235.567551357018, 1243.564752336675, 17362.305507779547, 17459.0, 17461.563460913578, 17494.0, 17722.113894305232, 547689.0, 551514.0, 552379.0, 553735.0, 553746.0, 61914.38085619176, 62277.37722622806, 62281.0, 62498.0625290621, 62660.0, 1457.846926072747, 1469.2727100085312, 1476.2544914817947, 1477.165401548122, 1483.2954346685237, 33094.83452582722, 33385.49921751127, 33661.83169084139, 33769.83115084507, 33817.661823382434, 55234.171487428524, 58357.416425835196, 60236.69881650564, 60354.69822650859, 66743.0, 529258.0, 530492.0, 536284.0, 536548.0, 539304.0, 47581.524184759095, 47900.76049619869, 48104.759476202395, 48507.27239091487, 48755.0, 53395.19907201473, 53637.731811340695, 53743.731281343345, 53961.0, 54265.45734542604, 44160.77919610382, 44946.3258051123, 45072.77463612661, 46055.309170361805, 46788.7660561695, 44372.77813610911, 45466.54533454623, 49378.0, 49736.0, 49953.0, 45850.312245317014, 47471.76264118657, 47706.28440573464, 48266.0, 48782.75608621934, 38833.41749873698, 39594.60405396025, 39860.80069599633, 39971.80014099911, 40788.79605601953, 28658.14025579236, 30615.846920765252, 30653.693463065974, 32065.51901721523, 32719.34561308808], "value": 21833.40349244928, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.2150624566445, 418.7654913248579, 424.3931178414867, 427.9978600106999, 441.1661958897684, 18956.715649265272, 20740.377788666345, 20749.896250518763, 20987.37037888862, 21595.0, 19962.0, 20177.899110504462, 20639.896800516013, 20706.68939965898, 20715.37853864383, 5928.2293301870695, 6144.6006009609455, 6171.321154672983, 6176.691165441733, 6183.381661833803, 6022.488088512459, 6053.636781793084, 6074.271087469488, 6132.294786099589, 6160.969195154018, 5891.086881533369, 6062.696865156725, 6064.211652485193, 6071.605345652519, 6073.908891366633, 5981.192539007222, 5984.102384642317, 6014.609050411709, 6056.4851987581105, 6058.1518587397795, 5343.7328133593555, 5436.972815135899, 5480.177973303997, 5492.258545096401, 5498.532624726903, 24272.63591046118, 24373.756262437328, 24554.140605078737, 24581.87709061443, 24696.25911222666, 2485.888135033928, 2527.84832910026, 2694.973050269492, 2771.016289217319, 2950.3656713806636, 15629.609259768484, 15748.606284842856, 15924.920375398166, 16050.839491605051, 16315.918420407941, 2079.2202923903537, 2080.761946641746, 2086.54096098858, 2118.4280244333945, 2159.546495236002, 81184.59407702983, 84713.57643211745, 84726.3624646045, 84749.0, 85543.14456855477, 10702.357858528514, 10731.785364292671, 10893.400862952456, 11055.06031987274, 11163.609273675545, 14908.403663853542, 14933.0, 15000.0, 15000.474983375529, 15011.624709382353, 7994.280514753584, 8485.278751306085, 8502.872456913152, 8634.395592308603, 8640.13598640131, 8091.352691784643, 8230.341572674171, 8260.091389947102, 8386.87419688705, 8445.746627601182, 6829.419499342612, 6885.655717214119, 6962.199347075049, 7017.333353331425, 7135.4648401370105, 1966.8623196376116, 1999.7900220476931, 2022.8381729461607, 2023.6559784836613, 2033.745781777278, 1008.1569972676981, 1013.5388398278766, 1043.7181960870523, 1051.1013083813382, 1155.7457359380924, 21295.8935205323, 21352.893235533724, 21439.78560214409, 21601.56796864054, 21622.35132946014, 1009.8636684047707, 1043.8121138195197, 1059.5073290919606, 1077.886821883691, 1135.8012347839094, 11831.0, 11944.462499187557, 12016.33910134951, 12084.395780210954, 12096.697582560506, 550431.0, 552884.0, 567482.0, 571608.0, 572933.0, 97132.0, 104315.0, 106145.46927265314, 108868.0, 109243.0, 496.51589700042894, 514.3827407111481, 517.9352580927384, 523.0402211941131, 524.1534921102468, 11505.0, 11526.654200374001, 11781.528738850693, 12090.153689241668, 12096.939515302367, 40780.18439631131, 41794.0, 42067.0, 43021.0, 43601.56398435975, 61870.69064654648, 62051.379486206366, 62616.0, 62937.68531157315, 63799.04301435389, 8530.74407767768, 8870.86693699582, 8927.24118449939, 8931.821363572562, 8980.506072165832, 12241.387930603256, 13208.603741887759, 13309.866901330863, 13596.728065438834, 13649.38577763983, 11539.653810385702, 11700.0, 11861.525538978343, 12030.518779248732, 12151.513939442324, 11662.241954272946, 11894.583689571169, 11907.702307442036, 12065.215760975509, 12076.21504602198, 11372.772544549229, 11384.544618215179, 11433.771324573296, 11641.825372619587, 12326.445309960895, 8741.781455463664, 8793.648254069765, 8932.687355942511, 8938.910610893809, 8945.73162805117, 11489.597864074718, 11496.712582185177, 11601.767964640829, 11969.281843089442, 11997.76004479888], "value": 9584.816061741305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1538.1309560098543, 1575.6376033512292, 1734.930602775889, 1872.8220819022188, 1877.7183422486635, 8476.0, 9396.765080872972, 9562.904370956288, 10009.44948027859, 10096.444695541752, 9602.135807777298, 9892.653757118502, 9925.900740992587, 9948.502574871263, 10036.749081272954, 2522.180291405296, 2544.2875994721508, 2559.245022718293, 2566.576514875053, 2572.987135064322, 2480.3923038855505, 2592.338953566847, 2597.1559243245924, 2599.246218596614, 2603.0, 2542.618607208924, 2545.9618105728337, 2548.4011257354505, 2579.509893120301, 2583.651207087047, 2445.74319696432, 2459.495803360307, 2466.506698660266, 2491.6262560615874, 2503.3366157968153, 2419.588669926117, 2436.074291769134, 2442.1208364988765, 2442.218490083174, 2478.1202673051166, 9945.0, 9976.95011524945, 9987.250956178315, 10008.049235322633, 10016.148627366683, 5821.767129314822, 5973.850653733648, 5976.7908123215475, 5979.1031345298115, 6004.159417681528, 3582.462630605404, 3606.531150950386, 3641.0, 3665.4501824726503, 3753.4932784074344, 1138.8007098757685, 1142.2404101272643, 1161.9302841829433, 1167.2412931594447, 1189.5479717707303, 14228.92885535576, 14280.85719142816, 14306.928465357607, 14388.856111438961, 14418.351174197187, 4971.751412429437, 5108.233764935215, 5206.193040078794, 5266.789328426897, 5294.7352632369, 12034.097442691833, 12035.819462708067, 12093.697657558456, 12154.63536093901, 12209.0, 5954.85112872173, 5974.3428222895445, 5983.820485385445, 5985.6408615483215, 5990.011648078018, 4670.556297151765, 5236.083685355047, 5357.812476563302, 5377.435369286169, 5496.5053145217125, 4422.646188304928, 4483.103379324149, 4501.842435514807, 4523.095380923763, 4671.8364857229835, 1318.0575888239955, 1322.285965578596, 1323.7021670124145, 1332.0875200487696, 1342.5837990223063, 1003.7039073473343, 1078.250615822012, 1098.0885864732254, 1098.2806261898309, 1100.0649447969322, 6636.30318816527, 6646.468282537386, 6777.627230502271, 6945.756898508528, 7002.334778196063, 470.47072043950556, 482.86238422049547, 487.4467479410894, 488.3407400009958, 488.42853860982734, 4378.934315985262, 4456.197884380843, 4503.324501324828, 4553.749543775058, 4657.790399432034, 12037.87962120385, 12486.063545234143, 12602.11785175029, 12607.873921260854, 12638.115331926861, 11743.236689615147, 12325.383730813424, 12494.937525312314, 12513.436895339732, 12527.749445011048, 9139.680111196076, 9309.44143351401, 9346.158845703783, 9365.78244828168, 9365.812683746422, 6688.2977287386075, 6728.7308507659145, 6892.689828957809, 6941.236463989058, 7027.22700502934, 10979.0, 11477.196596238184, 11534.365609891536, 11565.653030409101, 11570.132240082195, 11537.365444900612, 11585.478653460446, 11765.647030589096, 11779.823302650639, 11866.0, 7638.656260468403, 8621.310295176496, 8747.212750852454, 8919.331050171133, 9018.09819018093, 9693.0, 9699.272554558578, 9782.31523793356, 9801.705948821547, 9847.753806154904, 8708.69519566812, 8734.956325218332, 8796.340274479311, 8812.16284452976, 8926.285897128084, 8563.486190828571, 8601.82796344082, 8650.826983460422, 8700.782480437787, 8843.51360675169, 7942.404319675932, 8122.268995790408, 8122.472039317426, 8123.26890579827, 8134.674613015413, 5539.224508568723, 5546.639468434539, 5659.6321239119325, 5702.002149623716, 5781.884362312646, 5957.0, 5992.550558708027, 6012.939870601238, 6047.667378294236, 6055.636661800306], "value": 5079.332982179581, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.1079194095352, 347.30885537779824, 348.22519893237563, 348.2661110284268, 349.6852832450794, 5778.884422311557, 5906.350301466835, 5930.229070220866, 5934.851628709273, 5961.970190149043, 5742.39704830993, 5763.596548241625, 5777.45114214149, 5855.180274761527, 5868.325142608602, 4009.699272554563, 4393.846215382462, 4419.624331931774, 4434.246178149706, 4491.955080449203, 4435.778211089449, 4440.245158323093, 4452.0, 4462.174497717916, 4477.10457908418, 4402.415130552999, 4457.153140903234, 4472.8881777955485, 4492.326151077348, 4506.52681468446, 4298.78506074695, 4386.0, 4441.200583894898, 4464.866054018385, 4469.994251293466, 3870.9612903870884, 3877.6122387760997, 3893.124047089382, 3900.4539364488996, 3904.7852368119743, 5570.6657600544095, 5579.46995035471, 5612.0, 5644.943550564524, 5671.631343962629, 5008.9499105008845, 5107.387113546361, 5108.4125325587665, 5129.974350128263, 5142.408623008327, 5984.640921544721, 6017.368176341509, 6037.969810150921, 6038.818835434944, 6042.516598672096, 4265.274903266452, 4293.892652683677, 4298.204832106039, 4332.198543269474, 4338.349247612883, 5935.228420305376, 6247.156633854417, 6257.812265632038, 6266.248050233956, 6266.49868010558, 4370.650347972155, 4381.605655491021, 4390.648748100144, 4400.713953593006, 4409.9559004410185, 4333.696641235147, 4448.288273876229, 4455.643548516111, 4459.799309031101, 4462.397576327219, 5047.570956468668, 5055.823046193365, 5069.898602027939, 5103.260027296095, 5139.8458046258675, 6023.578349515579, 6075.1191077294425, 6077.878442431127, 6093.354794205628, 6162.969185154046, 1477.940882364715, 1500.8724258437937, 1530.8316085230615, 1554.8211955625247, 1555.5799934017753, 958.7938593202495, 971.3977334052933, 1005.8843233028149, 1043.6138628707427, 1062.946852657364, 5901.760630267692, 5912.556558258148, 5917.792877249276, 5935.109733539917, 5936.614120082181, 6215.223097112861, 6224.751009959641, 6272.0, 6287.20814567846, 6321.209848768904, 5707.543396528268, 5880.941190588125, 5907.911381329283, 5934.525237980951, 5946.43508866657, 3273.492608645664, 3289.8355082245794, 3305.3224089061687, 3320.7841490303053, 3324.2188085799817, 6161.026138140874, 6477.481801455872, 6487.545871789024, 6492.64290464029, 6502.439414540476, 6368.840778980562, 6424.0, 6426.196725409324, 6458.38645328693, 6486.513511486657, 6349.127007532789, 6492.480601551864, 6571.178602674666, 6581.243157037002, 6601.0, 6260.685256096271, 6271.435570798468, 6284.74861005573, 6298.0, 6312.936870631235, 6130.938690613037, 6206.348333424925, 6214.533909956862, 6220.724751425856, 6224.221972253468, 6280.340564240689, 6506.707198175999, 6526.67366631657, 6541.34586541342, 6549.96725016391, 4396.560343965578, 4437.689361744647, 4445.977770111129, 4466.57567531097, 4477.507474177903, 6240.563160578716, 6264.843378915563, 6366.204224471941, 6374.139491168633, 6397.96801015992, 6057.969710151421, 6118.388161184024, 6143.907841382294, 6146.846328841814, 6177.938220617736, 5879.412058794086, 6105.3894610540365, 6164.291106522807, 6194.194754682043, 6222.408871157233, 5920.082387229986, 6049.304330002106, 6069.817905462844, 6085.391460854056, 6098.573099882966, 6133.601315914451, 6136.907946380898, 6138.987067133873, 6146.692665366624, 6153.723082461211, 5866.882662346815, 5970.9701451492465, 5984.521238300838, 5985.431384018511, 5985.670788106696], "value": 4622.32146838216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.6131576185549, 799.1728560939429, 847.7075408983906, 874.1389731114853, 921.5993630414769, 15705.057696538215, 17028.65942681147, 17151.056691881942, 17611.82388176118, 17964.64070718588, 16158.919205403956, 16374.181290935465, 16431.17844107793, 16484.917575412135, 16489.0930998795, 869.070094998352, 871.1897934920521, 890.7105190812979, 891.4339394484484, 891.5408564589242, 892.7277180459957, 902.9006809250977, 903.2818908967387, 906.9047749986255, 907.2424525521164, 929.0894922975455, 932.2495391210073, 933.2254228989956, 934.72425634438, 936.6581197862765, 921.7419122645637, 926.5182105305204, 934.3599634250526, 934.8691183234284, 935.0649350649351, 678.1489231015094, 684.1858188755365, 685.8388278754488, 685.8388278754488, 687.4534744877834, 17022.489325320137, 17085.743713844302, 17140.14299285031, 17176.22706978189, 17195.054272015033, 14422.206778627171, 14468.0, 14718.0, 14800.851991480164, 14822.925885370612, 14113.64715882101, 14255.572332829928, 14514.6601730316, 14537.78193327101, 14541.854581454156, 4846.927296090562, 4848.418189817209, 4873.025394920995, 4929.186684197103, 4954.3063971044085, 71452.28547714508, 73299.26700732978, 73310.26689733088, 81646.59176704078, 82682.58658706729, 12764.744705106032, 12787.488500459878, 12942.676433089247, 13038.934805325913, 13085.803712944313, 22568.0972761091, 22759.31722048341, 22778.544429111655, 22800.201992930168, 23331.416714582272, 8668.60991255395, 8727.519986400808, 8847.911520884838, 8946.194842464209, 9297.953510232406, 4863.8540843774745, 5015.322931404214, 5037.19404895215, 5042.747862606855, 5050.04049230645, 3984.7210695251633, 4126.504819421689, 4151.0, 4163.437935878678, 4164.583541645872, 729.4747781597241, 729.4747781597241, 762.1578156137389, 776.7126163319494, 781.980450488731, 732.9413646908234, 761.3832795435715, 807.8505476486752, 820.6266148902235, 833.1793183714037, 9995.850062249072, 10348.637797677045, 10426.426546539862, 10570.207234457293, 10875.78248435027, 743.761996161234, 756.3797685897621, 760.9467337286447, 786.4534148766667, 819.8647223208104, 4796.352492413549, 5016.523430274191, 5075.467075956972, 5085.847424577269, 5088.974555127201, 131672.0, 135140.0, 135513.0, 136391.31804341113, 136744.0, 89445.0, 92435.0, 109303.45348273207, 111296.0, 113980.0, 90192.0, 90380.54809726041, 93563.53218233865, 95194.52402737942, 96168.51915740517, 10556.208284378856, 10566.841497377392, 10704.197185210984, 10894.50974706156, 11019.944900275448, 54924.72537637446, 55022.17466737922, 55112.0, 56212.0, 56683.43316566782, 72754.63622681853, 75452.62273688817, 80532.0, 82240.0, 82360.58819705863, 13738.86261137376, 14079.788803167756, 14614.707705846036, 15308.846911531187, 15507.534773956799, 15006.474773382879, 15750.212489375257, 16336.428225012543, 16670.416535421686, 17004.744928826323, 15774.526764197093, 15973.20133993319, 16161.0, 16222.91888540597, 16476.752848707038, 15500.92249538745, 15917.840821592099, 16368.345266189219, 16508.42220522276, 16869.0, 14309.713805724035, 14496.565103046925, 14963.925180374028, 15169.696606067597, 15208.391664333303, 12489.250644961332, 12497.687557811127, 12813.295268760308, 13171.934140329236, 13332.133411328232, 12460.190087644274, 12809.167404118702, 12871.678208044874, 12975.156614820007, 12988.675283117998], "value": 8397.109840903764, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 104.0, 111.0, 111.0, 112.0, 110.0, 110.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 140.0, 167.0, 118.0, 148.0, 148.0, 119.0, 172.0, 117.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 163.0, 162.0, 163.0, 163.0, 161.0, 161.0, 164.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 171.0, 75.0, 76.0, 78.0, 75.0, 175.0, 75.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 141.0, 84.0, 84.0, 83.0, 148.0, 84.0, 84.0, 145.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 149.0, 149.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 100.0, 100.0, 96.0, 95.0, 95.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 52.0, 51.0, 52.0, 51.0, 51.0, 51.0, 51.0, 61.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 67.0, 61.0, 68.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 73.0, 73.0, 72.0, 73.0, 75.0, 72.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 132.0, 118.0, 119.0, 117.0, 124.0, 130.0, 117.0, 152.0, 130.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 153.0, 152.0, 157.0, 154.0, 152.0, 151.0, 154.0, 159.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 65.0, 68.0, 65.0, 60.0, 61.0, 61.0, 64.0], "value": 63.0, "unit": "score"}]}]} 15:37:43 INFO - Return code: 0 15:37:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:37:43 ERROR - # TBPL SUCCESS # 15:37:43 INFO - Running post-action listener: _resource_record_post_action 15:37:43 INFO - [mozharness: 2016-10-19 22:37:43.643641Z] Finished run-tests step (success) 15:37:43 INFO - Running post-run listener: _resource_record_post_run 15:37:43 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290066432; Read time: 36; Write time: 123388 15:37:43 INFO - TinderboxPrint: CPU usage
13.1% 15:37:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 36 15:37:43 INFO - TinderboxPrint: I/O write bytes / time
290,066,432 / 123,388 15:37:43 INFO - TinderboxPrint: CPU idle
8,212.9 (86.9%) 15:37:43 INFO - TinderboxPrint: CPU user
1,191.5 (12.6%) 15:37:43 INFO - TinderboxPrint: Swap in / out
0 / 0 15:37:43 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70361088; Read time: 0; Write time: 44804 15:37:43 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219705344; Read time: 36; Write time: 78584 15:37:44 INFO - Running post-run listener: _upload_blobber_files 15:37:44 INFO - Blob upload gear active. 15:37:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:37:44 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 15:37:44 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'] 15:37:44 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 15:37:44 INFO - (blobuploader) - INFO - Open directory for files ... 15:37:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:37:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:37:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:45 INFO - (blobuploader) - INFO - Done attempting. 15:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:37:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:48 INFO - (blobuploader) - INFO - Done attempting. 15:37:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:37:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:37:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:49 INFO - (blobuploader) - INFO - Done attempting. 15:37:49 INFO - (blobuploader) - INFO - Iteration through files over. 15:37:49 INFO - Return code: 0 15:37:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:37:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:37:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3055ec93948d04d25ef5e20571c51fc126aa40e0385feaa2a07685912b62d96e5413facfebe1f4aedd1e203c7c0949ea975cda4e6bfcb69d4587d86594273b89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2140e2c75b7dea7120ed3e303c583231663735f07f37bc4632d5424f0f187b2ff2cb1020de4c87080a54b63a312fa65fa1fb6351b390eca45ea7c4ac7e40728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fd6fb6409f3f4a364373c2992fc7eb8f4f2c91536e575c226cdc3be612bef79e20d36b5cb3938804ba65ad2e2a2680827f172d282b715f9fcabeee7b0de57e1"} 15:37:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:37:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:37:49 INFO - Contents: 15:37:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3055ec93948d04d25ef5e20571c51fc126aa40e0385feaa2a07685912b62d96e5413facfebe1f4aedd1e203c7c0949ea975cda4e6bfcb69d4587d86594273b89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2140e2c75b7dea7120ed3e303c583231663735f07f37bc4632d5424f0f187b2ff2cb1020de4c87080a54b63a312fa65fa1fb6351b390eca45ea7c4ac7e40728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fd6fb6409f3f4a364373c2992fc7eb8f4f2c91536e575c226cdc3be612bef79e20d36b5cb3938804ba65ad2e2a2680827f172d282b715f9fcabeee7b0de57e1"} 15:37:49 INFO - Running post-run listener: copy_logs_to_upload_dir 15:37:49 INFO - Copying logs to upload dir... 15:37:49 INFO - mkdir: /builds/slave/test/build/upload/logs 15:37:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.469119 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-10-19 15:37:48.947980) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:48.951147) ========= 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=6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3055ec93948d04d25ef5e20571c51fc126aa40e0385feaa2a07685912b62d96e5413facfebe1f4aedd1e203c7c0949ea975cda4e6bfcb69d4587d86594273b89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2140e2c75b7dea7120ed3e303c583231663735f07f37bc4632d5424f0f187b2ff2cb1020de4c87080a54b63a312fa65fa1fb6351b390eca45ea7c4ac7e40728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fd6fb6409f3f4a364373c2992fc7eb8f4f2c91536e575c226cdc3be612bef79e20d36b5cb3938804ba65ad2e2a2680827f172d282b715f9fcabeee7b0de57e1"} build_url:https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/JcuE4AmxQtedTnxs2qiCxQ/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3055ec93948d04d25ef5e20571c51fc126aa40e0385feaa2a07685912b62d96e5413facfebe1f4aedd1e203c7c0949ea975cda4e6bfcb69d4587d86594273b89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a2140e2c75b7dea7120ed3e303c583231663735f07f37bc4632d5424f0f187b2ff2cb1020de4c87080a54b63a312fa65fa1fb6351b390eca45ea7c4ac7e40728", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fd6fb6409f3f4a364373c2992fc7eb8f4f2c91536e575c226cdc3be612bef79e20d36b5cb3938804ba65ad2e2a2680827f172d282b715f9fcabeee7b0de57e1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:48.976696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:48.977084) ========= 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=6dbc10da6d83fee962c624be000001a8-1476914990.429829-447263971 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:37:49.060364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 15:37:49.060890) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 15:37:49.061297) ========= ========= Total master_lag: 0.15 =========