builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1477573904.72 results: success (0) buildid: 20161027030534 builduid: 6e7ad2fab64c421cbec0a5c217abc13b revision: 30092cd6645ff14c7714da97e177f82fee34caf1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:44.716491) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:44.716916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:44.717186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:44.740303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:44.740885) ========= 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=41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 06:11:45-- 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% 68.8M=0s 2016-10-27 06:11:45 (68.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:44.869437) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:44.869754) ========= 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=41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017665 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:44.919357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:44.919734) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 30092cd6645ff14c7714da97e177f82fee34caf1 --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 30092cd6645ff14c7714da97e177f82fee34caf1 --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=41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 06:11:45,222 truncating revision to first 12 chars 2016-10-27 06:11:45,222 Setting DEBUG logging. 2016-10-27 06:11:45,222 attempt 1/10 2016-10-27 06:11:45,222 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/30092cd6645f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 06:11:45,661 unpacking tar archive at: mozilla-beta-30092cd6645f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.773626 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:45.706810) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:45.707125) ========= script_repo_revision: 30092cd6645ff14c7714da97e177f82fee34caf1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:45.707586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:45.707852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 06:11:45.718068) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-10-27 06:11:45.720118) ========= /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=41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:11:46 INFO - MultiFileLogger online at 20161027 06:11:46 in /builds/slave/test 06:11:46 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 06:11:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:11:46 INFO - {'append_to_log': False, 06:11:46 INFO - 'base_work_dir': '/builds/slave/test', 06:11:46 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:11:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:11:46 INFO - 'branch': 'Mozilla-Beta', 06:11:46 INFO - 'buildbot_json_path': 'buildprops.json', 06:11:46 INFO - 'config_files': ('talos/linux_config.py',), 06:11:46 INFO - 'default_actions': ('clobber', 06:11:46 INFO - 'read-buildbot-config', 06:11:46 INFO - 'download-and-extract', 06:11:46 INFO - 'populate-webroot', 06:11:46 INFO - 'create-virtualenv', 06:11:46 INFO - 'install', 06:11:46 INFO - 'run-tests'), 06:11:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:11:46 INFO - 'download_minidump_stackwalk': True, 06:11:46 INFO - 'download_symbols': 'ondemand', 06:11:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:11:46 INFO - 'tooltool.py': '/tools/tooltool.py', 06:11:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:11:46 INFO - '/tools/misc-python/virtualenv.py')}, 06:11:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:11:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:11:46 INFO - 'installer_path': 'installer.exe', 06:11:46 INFO - 'log_level': 'info', 06:11:46 INFO - 'log_name': 'talos', 06:11:46 INFO - 'log_to_console': True, 06:11:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:11:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:11:46 INFO - 'opt_config_files': (), 06:11:46 INFO - 'pip_index': False, 06:11:46 INFO - 'sps_profile': False, 06:11:46 INFO - 'sps_profile_interval': 0, 06:11:46 INFO - 'suite': 'dromaeojs-e10s', 06:11:46 INFO - 'system_bits': '32', 06:11:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:11:46 INFO - 'title': 'talos-linux64-ix-024', 06:11:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:11:46 INFO - 'use_talos_json': True, 06:11:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:11:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:11:46 INFO - 'work_dir': 'build'} 06:11:46 INFO - [mozharness: 2016-10-27 13:11:46.114538Z] Running clobber step. 06:11:46 INFO - Running pre-action listener: _resource_record_pre_action 06:11:46 INFO - Running main action method: clobber 06:11:46 INFO - rmtree: /builds/slave/test/build 06:11:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:11:46 INFO - Running post-action listener: _resource_record_post_action 06:11:46 INFO - [mozharness: 2016-10-27 13:11:46.575088Z] Finished clobber step (success) 06:11:46 INFO - [mozharness: 2016-10-27 13:11:46.575190Z] Running read-buildbot-config step. 06:11:46 INFO - Running pre-action listener: _resource_record_pre_action 06:11:46 INFO - Running main action method: read_buildbot_config 06:11:46 INFO - Using buildbot properties: 06:11:46 INFO - { 06:11:46 INFO - "project": "", 06:11:46 INFO - "product": "firefox", 06:11:46 INFO - "script_repo_revision": "production", 06:11:46 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 06:11:46 INFO - "repository": "", 06:11:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 06:11:46 INFO - "buildid": "20161027030534", 06:11:46 INFO - "pgo_build": "True", 06:11:46 INFO - "basedir": "/builds/slave/test", 06:11:46 INFO - "buildnumber": 306, 06:11:46 INFO - "slavename": "talos-linux64-ix-024", 06:11:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:11:46 INFO - "platform": "ubuntu64_hw", 06:11:46 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:11:46 INFO - "branch": "mozilla-beta", 06:11:46 INFO - "repo_path": "releases/mozilla-beta", 06:11:46 INFO - "revision": "30092cd6645ff14c7714da97e177f82fee34caf1", 06:11:46 INFO - "stage_platform": "linux64-pgo", 06:11:46 INFO - "builduid": "6e7ad2fab64c421cbec0a5c217abc13b", 06:11:46 INFO - "slavebuilddir": "test" 06:11:46 INFO - } 06:11:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 06:11:46 INFO - Running post-action listener: _resource_record_post_action 06:11:46 INFO - [mozharness: 2016-10-27 13:11:46.577672Z] Finished read-buildbot-config step (success) 06:11:46 INFO - [mozharness: 2016-10-27 13:11:46.577763Z] Running download-and-extract step. 06:11:46 INFO - Running pre-action listener: _resource_record_pre_action 06:11:46 INFO - Running main action method: download_and_extract 06:11:46 INFO - mkdir: /builds/slave/test/build/tests 06:11: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')]} 06:11:46 INFO - https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:11:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:11:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:11:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:11:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:11:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:11:46 INFO - retry: Failed, sleeping 30 seconds before retrying 06:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:12:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:12:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:12:16 INFO - retry: Failed, sleeping 60 seconds before retrying 06:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:13:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:13:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:13:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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! 06:13:16 INFO - Caught exception: HTTP Error 404: Not Found 06:13:16 INFO - Caught exception: HTTP Error 404: Not Found 06:13:16 INFO - Caught exception: HTTP Error 404: Not Found 06:13:16 INFO - trying https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:13:16 INFO - Downloading https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:13:17 INFO - Downloaded 1327 bytes. 06:13:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:13:17 INFO - Using the following test package requirements: 06:13:17 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 06:13:17 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:13:17 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:13:17 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:13:17 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 06:13:17 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:13:17 INFO - u'jsshell-linux-x86_64.zip'], 06:13:17 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:13:17 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:13:17 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 06:13:17 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:13:17 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 06:13:17 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:13:17 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 06:13:17 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:13:17 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:13:17 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:13:17 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:13:17 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:13:17 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')]} 06:13:17 INFO - https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:13:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:13:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:13:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:13:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:13:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:13:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:13:17 INFO - retry: Failed, sleeping 30 seconds before retrying 06:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:13:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:13:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:13:47 INFO - retry: Failed, sleeping 60 seconds before retrying 06:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:14:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:14:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:14:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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! 06:14:47 INFO - Caught exception: HTTP Error 404: Not Found 06:14:47 INFO - Caught exception: HTTP Error 404: Not Found 06:14:47 INFO - Caught exception: HTTP Error 404: Not Found 06:14:47 INFO - trying https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:14:47 INFO - Downloading https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:14:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:14:48 INFO - Downloaded 21856967 bytes. 06:14:48 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'] 06:14:48 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 06:14:49 INFO - Return code: 0 06:14:49 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 06:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:14:49 INFO - https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:14:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:14:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:14:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:14:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:14:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:14:50 INFO - retry: Failed, sleeping 30 seconds before retrying 06:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:15:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:15:20 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:15:20 INFO - retry: Failed, sleeping 60 seconds before retrying 06:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:16:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:16:20 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:16:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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! 06:16:20 INFO - Caught exception: HTTP Error 404: Not Found 06:16:20 INFO - Caught exception: HTTP Error 404: Not Found 06:16:20 INFO - Caught exception: HTTP Error 404: Not Found 06:16:20 INFO - trying https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:16:20 INFO - Downloading https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:16:21 INFO - Downloaded 21856967 bytes. 06:16:21 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'] 06:16:21 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 06:16:22 INFO - Return code: 0 06:16:22 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')]} 06:16:22 INFO - https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:16:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:16:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:16:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:16:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:16:22 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:16:22 INFO - retry: Failed, sleeping 30 seconds before retrying 06:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:16:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:16:52 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:16:52 INFO - retry: Failed, sleeping 60 seconds before retrying 06:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:17:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:17:52 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:17:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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! 06:17:52 INFO - Caught exception: HTTP Error 404: Not Found 06:17:52 INFO - Caught exception: HTTP Error 404: Not Found 06:17:52 INFO - Caught exception: HTTP Error 404: Not Found 06:17:52 INFO - trying https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:17:52 INFO - Downloading https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:17:54 INFO - Downloaded 14413762 bytes. 06:17:54 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'] 06:17:54 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 06:17:54 INFO - Return code: 0 06:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:54 INFO - https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:17:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:17:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:17:54 INFO - retry: Failed, sleeping 30 seconds before retrying 06:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:18:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:18:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:18:24 INFO - retry: Failed, sleeping 60 seconds before retrying 06:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:19:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:19:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:19:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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! 06:19:24 INFO - Caught exception: HTTP Error 404: Not Found 06:19:24 INFO - Caught exception: HTTP Error 404: Not Found 06:19:24 INFO - Caught exception: HTTP Error 404: Not Found 06:19:24 INFO - trying https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:19:24 INFO - Downloading https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:19:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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 06:19:25 INFO - Downloaded 56832419 bytes. 06:19:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:19:25 INFO - mkdir: /builds/slave/test/properties 06:19:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:19:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:19:25 INFO - Contents: 06:19:25 INFO - build_url:https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:19:26 INFO - Running post-action listener: _resource_record_post_action 06:19:26 INFO - Running post-action listener: set_extra_try_arguments 06:19:26 INFO - [mozharness: 2016-10-27 13:19:26.168082Z] Finished download-and-extract step (success) 06:19:26 INFO - [mozharness: 2016-10-27 13:19:26.168318Z] Running populate-webroot step. 06:19:26 INFO - Running pre-action listener: _resource_record_pre_action 06:19:26 INFO - Running main action method: populate_webroot 06:19:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:19:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:19:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:19:26 INFO - '--tppagecycles', 06:19:26 INFO - '7'], 06:19:26 INFO - 'tests': ['tsvgm']}}, 06:19:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:19:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:19:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:19:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:19:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:26 INFO - 'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:19:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:26 INFO - 'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['damp', 'tps']}, 06:19:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:26 INFO - 'tests': ['damp', 'tps']}, 06:19:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['dromaeo_dom']}, 06:19:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:19:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['basic_compositor_video']}, 06:19:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:19:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['a11yr', 06:19:26 INFO - 'ts_paint', 06:19:26 INFO - 'tpaint', 06:19:26 INFO - 'sessionrestore', 06:19:26 INFO - 'sessionrestore_no_auto_restore', 06:19:26 INFO - 'tabpaint']}, 06:19:26 INFO - 'other-e10s': {'tests': ['a11yr', 06:19:26 INFO - 'ts_paint', 06:19:26 INFO - 'tpaint', 06:19:26 INFO - 'sessionrestore', 06:19:26 INFO - 'sessionrestore_no_auto_restore', 06:19:26 INFO - 'tabpaint']}, 06:19:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:19:26 INFO - 'ts_paint', 06:19:26 INFO - 'tpaint', 06:19:26 INFO - 'sessionrestore', 06:19:26 INFO - 'sessionrestore_no_auto_restore', 06:19:26 INFO - 'tabpaint']}, 06:19:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:19:26 INFO - 'ts_paint', 06:19:26 INFO - 'tpaint', 06:19:26 INFO - 'sessionrestore', 06:19:26 INFO - 'sessionrestore_no_auto_restore', 06:19:26 INFO - 'tabpaint']}, 06:19:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['a11yr', 06:19:26 INFO - 'ts_paint', 06:19:26 INFO - 'tpaint', 06:19:26 INFO - 'sessionrestore', 06:19:26 INFO - 'sessionrestore_no_auto_restore', 06:19:26 INFO - 'tabpaint']}, 06:19:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['a11yr', 06:19:26 INFO - 'ts_paint', 06:19:26 INFO - 'tpaint', 06:19:26 INFO - 'sessionrestore', 06:19:26 INFO - 'sessionrestore_no_auto_restore', 06:19:26 INFO - 'tabpaint']}, 06:19:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['tsvgx', 06:19:26 INFO - 'tsvgr_opacity', 06:19:26 INFO - 'tart', 06:19:26 INFO - 'tscrollx', 06:19:26 INFO - 'cart']}, 06:19:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:19:26 INFO - 'tsvgr_opacity', 06:19:26 INFO - 'tart', 06:19:26 INFO - 'tscrollx', 06:19:26 INFO - 'cart']}, 06:19:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:26 INFO - 'talos_options': ['--disable-e10s'], 06:19:26 INFO - 'tests': ['tp5o']}, 06:19:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:26 INFO - 'tests': ['tp5o']}, 06:19:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:26 INFO - 'talos_options': ['--disable-e10s', 06:19:26 INFO - '--xperf_path', 06:19:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:26 INFO - 'tests': ['tp5n']}, 06:19:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:19:26 INFO - 'talos_options': ['--xperf_path', 06:19:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:19:26 INFO - 'tests': ['tp5n']}}, 06:19:26 INFO - 'talos.zip': {'path': '', 06:19:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:19:26 INFO - Running post-action listener: _resource_record_post_action 06:19:26 INFO - [mozharness: 2016-10-27 13:19:26.187738Z] Finished populate-webroot step (success) 06:19:26 INFO - [mozharness: 2016-10-27 13:19:26.187828Z] Running create-virtualenv step. 06:19:26 INFO - Running pre-action listener: _resource_record_pre_action 06:19:26 INFO - Running main action method: create_virtualenv 06:19:26 INFO - Creating virtualenv /builds/slave/test/build/venv 06:19:26 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 06:19:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:19:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:19:26 INFO - Using real prefix '/usr' 06:19:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:19:26 INFO - Installing distribute.............................................................................................................................................................................................done. 06:19:28 INFO - Installing pip.................done. 06:19:28 INFO - Return code: 0 06:19:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:28 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 0x146a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, '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': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', '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 06:19:28 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 06:19:28 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 06:19:28 INFO - Using env: {'DISPLAY': ':0', 06:19:28 INFO - 'HOME': '/home/cltbld', 06:19:28 INFO - 'LANG': 'en_US.UTF-8', 06:19:28 INFO - 'LANGUAGE': 'en_US:en', 06:19:28 INFO - 'LOGNAME': 'cltbld', 06:19:28 INFO - 'MAIL': '/var/mail/cltbld', 06:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:28 INFO - 'MOZ_NO_REMOTE': '1', 06:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:28 INFO - 'NO_EM_RESTART': '1', 06:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:28 INFO - 'PWD': '/builds/slave/test', 06:19:28 INFO - 'SHELL': '/bin/bash', 06:19:28 INFO - 'SHLVL': '1', 06:19:28 INFO - 'TERM': 'linux', 06:19:28 INFO - 'TMOUT': '86400', 06:19:28 INFO - 'USER': 'cltbld', 06:19:28 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:28 INFO - '_': '/tools/buildbot/bin/python'} 06:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:28 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 06:19:28 INFO - Cleaning up... 06:19:28 INFO - Return code: 0 06:19:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:28 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 0x146a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, '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': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', '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 06:19:28 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 06:19:28 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 06:19:28 INFO - Using env: {'DISPLAY': ':0', 06:19:28 INFO - 'HOME': '/home/cltbld', 06:19:28 INFO - 'LANG': 'en_US.UTF-8', 06:19:28 INFO - 'LANGUAGE': 'en_US:en', 06:19:28 INFO - 'LOGNAME': 'cltbld', 06:19:28 INFO - 'MAIL': '/var/mail/cltbld', 06:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:28 INFO - 'MOZ_NO_REMOTE': '1', 06:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:28 INFO - 'NO_EM_RESTART': '1', 06:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:28 INFO - 'PWD': '/builds/slave/test', 06:19:28 INFO - 'SHELL': '/bin/bash', 06:19:28 INFO - 'SHLVL': '1', 06:19:28 INFO - 'TERM': 'linux', 06:19:28 INFO - 'TMOUT': '86400', 06:19:28 INFO - 'USER': 'cltbld', 06:19:28 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:28 INFO - '_': '/tools/buildbot/bin/python'} 06:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:29 INFO - Downloading/unpacking psutil>=3.1.1 06:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:19:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:31 INFO - Installing collected packages: psutil 06:19:31 INFO - Running setup.py install for psutil 06:19:31 INFO - building 'psutil._psutil_linux' extension 06:19:31 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 06:19:31 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 06:19:31 INFO - building 'psutil._psutil_posix' extension 06:19:31 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 06:19:31 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 06:19:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:19:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:19:31 INFO - Successfully installed psutil 06:19:31 INFO - Cleaning up... 06:19:31 INFO - Return code: 0 06:19:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:19:31 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')]} 06:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:31 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')]} 06:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:31 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 0x146a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, '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': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', '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 06:19:31 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 06:19:31 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 06:19:31 INFO - Using env: {'DISPLAY': ':0', 06:19:31 INFO - 'HOME': '/home/cltbld', 06:19:31 INFO - 'LANG': 'en_US.UTF-8', 06:19:31 INFO - 'LANGUAGE': 'en_US:en', 06:19:31 INFO - 'LOGNAME': 'cltbld', 06:19:31 INFO - 'MAIL': '/var/mail/cltbld', 06:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:31 INFO - 'MOZ_NO_REMOTE': '1', 06:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:31 INFO - 'NO_EM_RESTART': '1', 06:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:31 INFO - 'PWD': '/builds/slave/test', 06:19:31 INFO - 'SHELL': '/bin/bash', 06:19:31 INFO - 'SHLVL': '1', 06:19:31 INFO - 'TERM': 'linux', 06:19:31 INFO - 'TMOUT': '86400', 06:19:31 INFO - 'USER': 'cltbld', 06:19:31 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:31 INFO - '_': '/tools/buildbot/bin/python'} 06:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:19:31 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 06:19:31 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 06:19:31 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 06:19:31 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 06:19:31 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 06:19:31 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 06:19:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:19:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:19:33 INFO - Installing collected packages: mozsystemmonitor 06:19:33 INFO - Running setup.py install for mozsystemmonitor 06:19:34 INFO - Successfully installed mozsystemmonitor 06:19:34 INFO - Cleaning up... 06:19:34 INFO - Return code: 0 06:19:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:19:34 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')]} 06:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:34 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')]} 06:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:34 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 0x146a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, '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': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', '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 06:19:34 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 06:19:34 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 06:19:34 INFO - Using env: {'DISPLAY': ':0', 06:19:34 INFO - 'HOME': '/home/cltbld', 06:19:34 INFO - 'LANG': 'en_US.UTF-8', 06:19:34 INFO - 'LANGUAGE': 'en_US:en', 06:19:34 INFO - 'LOGNAME': 'cltbld', 06:19:34 INFO - 'MAIL': '/var/mail/cltbld', 06:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:34 INFO - 'MOZ_NO_REMOTE': '1', 06:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:34 INFO - 'NO_EM_RESTART': '1', 06:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:34 INFO - 'PWD': '/builds/slave/test', 06:19:34 INFO - 'SHELL': '/bin/bash', 06:19:34 INFO - 'SHLVL': '1', 06:19:34 INFO - 'TERM': 'linux', 06:19:34 INFO - 'TMOUT': '86400', 06:19:34 INFO - 'USER': 'cltbld', 06:19:34 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:34 INFO - '_': '/tools/buildbot/bin/python'} 06:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:34 INFO - Downloading/unpacking jsonschema==2.5.1 06:19:34 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 06:19:34 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 06:19:34 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 06:19:34 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 06:19:34 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 06:19:34 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 06:19:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:19:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:19:36 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 06:19:36 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 06:19:36 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 06:19:36 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 06:19:36 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 06:19:36 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 06:19:36 INFO - Downloading functools32-3.2.3-2.tar.gz 06:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:19:36 INFO - warning: no files found matching '*.txt' 06:19:36 INFO - no previously-included directories found matching 'build' 06:19:36 INFO - no previously-included directories found matching 'dist' 06:19:36 INFO - no previously-included directories found matching '.git*' 06:19:36 INFO - Installing collected packages: jsonschema, functools32 06:19:36 INFO - Running setup.py install for functools32 06:19:36 INFO - warning: no files found matching '*.txt' 06:19:36 INFO - no previously-included directories found matching 'build' 06:19:36 INFO - no previously-included directories found matching 'dist' 06:19:36 INFO - no previously-included directories found matching '.git*' 06:19:36 INFO - Successfully installed jsonschema functools32 06:19:36 INFO - Cleaning up... 06:19:36 INFO - Return code: 0 06:19:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:36 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 0x146a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, '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': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', '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 06:19:36 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 06:19:36 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 06:19:36 INFO - Using env: {'DISPLAY': ':0', 06:19:36 INFO - 'HOME': '/home/cltbld', 06:19:36 INFO - 'LANG': 'en_US.UTF-8', 06:19:36 INFO - 'LANGUAGE': 'en_US:en', 06:19:36 INFO - 'LOGNAME': 'cltbld', 06:19:36 INFO - 'MAIL': '/var/mail/cltbld', 06:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:36 INFO - 'MOZ_NO_REMOTE': '1', 06:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:36 INFO - 'NO_EM_RESTART': '1', 06:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:36 INFO - 'PWD': '/builds/slave/test', 06:19:36 INFO - 'SHELL': '/bin/bash', 06:19:36 INFO - 'SHLVL': '1', 06:19:36 INFO - 'TERM': 'linux', 06:19:36 INFO - 'TMOUT': '86400', 06:19:36 INFO - 'USER': 'cltbld', 06:19:36 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:36 INFO - '_': '/tools/buildbot/bin/python'} 06:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:19:36 INFO - Cleaning up... 06:19:36 INFO - Return code: 0 06:19:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:36 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 0x146a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, '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': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', '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 06:19:36 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 06:19:36 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 06:19:36 INFO - Using env: {'DISPLAY': ':0', 06:19:36 INFO - 'HOME': '/home/cltbld', 06:19:36 INFO - 'LANG': 'en_US.UTF-8', 06:19:36 INFO - 'LANGUAGE': 'en_US:en', 06:19:36 INFO - 'LOGNAME': 'cltbld', 06:19:36 INFO - 'MAIL': '/var/mail/cltbld', 06:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:36 INFO - 'MOZ_NO_REMOTE': '1', 06:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:36 INFO - 'NO_EM_RESTART': '1', 06:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:36 INFO - 'PWD': '/builds/slave/test', 06:19:36 INFO - 'SHELL': '/bin/bash', 06:19:36 INFO - 'SHLVL': '1', 06:19:36 INFO - 'TERM': 'linux', 06:19:36 INFO - 'TMOUT': '86400', 06:19:36 INFO - 'USER': 'cltbld', 06:19:36 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:36 INFO - '_': '/tools/buildbot/bin/python'} 06:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:37 INFO - Downloading/unpacking blobuploader==1.2.4 06:19:37 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 06:19:37 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 06:19:37 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 06:19:37 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 06:19:37 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 06:19:37 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 06:19:39 INFO - Downloading blobuploader-1.2.4.tar.gz 06:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:19:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:19:39 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 06:19:39 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 06:19:39 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 06:19:39 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 06:19:39 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 06:19:39 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 06:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:19:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:19:39 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 06:19:39 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 06:19:39 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 06:19:39 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 06:19:39 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 06:19:39 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 06:19:39 INFO - Downloading docopt-0.6.1.tar.gz 06:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:19:39 INFO - Installing collected packages: blobuploader, requests, docopt 06:19:39 INFO - Running setup.py install for blobuploader 06:19:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:19:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:19:39 INFO - Running setup.py install for requests 06:19:40 INFO - Running setup.py install for docopt 06:19:40 INFO - Successfully installed blobuploader requests docopt 06:19:40 INFO - Cleaning up... 06:19:40 INFO - Return code: 0 06:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:40 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')]} 06:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:40 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')]} 06:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:40 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 0x146a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, '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': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', '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 06:19:40 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 06:19:40 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 06:19:40 INFO - Using env: {'DISPLAY': ':0', 06:19:40 INFO - 'HOME': '/home/cltbld', 06:19:40 INFO - 'LANG': 'en_US.UTF-8', 06:19:40 INFO - 'LANGUAGE': 'en_US:en', 06:19:40 INFO - 'LOGNAME': 'cltbld', 06:19:40 INFO - 'MAIL': '/var/mail/cltbld', 06:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:40 INFO - 'MOZ_NO_REMOTE': '1', 06:19:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:40 INFO - 'NO_EM_RESTART': '1', 06:19:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:40 INFO - 'PWD': '/builds/slave/test', 06:19:40 INFO - 'SHELL': '/bin/bash', 06:19:40 INFO - 'SHLVL': '1', 06:19:40 INFO - 'TERM': 'linux', 06:19:40 INFO - 'TMOUT': '86400', 06:19:40 INFO - 'USER': 'cltbld', 06:19:40 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:40 INFO - '_': '/tools/buildbot/bin/python'} 06:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:40 INFO - Running setup.py (path:/tmp/pip-W4qoCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:40 INFO - Running setup.py (path:/tmp/pip-Dqe2FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:40 INFO - Running setup.py (path:/tmp/pip-lEpqNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:40 INFO - Running setup.py (path:/tmp/pip-tWikqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:40 INFO - Running setup.py (path:/tmp/pip-CdHxr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:41 INFO - Running setup.py (path:/tmp/pip-wmTq_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:41 INFO - Running setup.py (path:/tmp/pip-AxznHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:41 INFO - Running setup.py (path:/tmp/pip-Xbc_JF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:41 INFO - Running setup.py (path:/tmp/pip-5FwC_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:41 INFO - Running setup.py (path:/tmp/pip-kgmDbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:41 INFO - Running setup.py (path:/tmp/pip-HvqAb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:41 INFO - Running setup.py (path:/tmp/pip-57hPQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:41 INFO - Running setup.py (path:/tmp/pip-EGlXat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:41 INFO - Running setup.py (path:/tmp/pip-SGq2fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:41 INFO - Running setup.py (path:/tmp/pip-qVUl6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:41 INFO - Running setup.py (path:/tmp/pip-7Nrati-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:41 INFO - Running setup.py (path:/tmp/pip-YhB3HO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:19:41 INFO - Running setup.py install for manifestparser 06:19:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:19:41 INFO - Running setup.py install for mozcrash 06:19:42 INFO - Running setup.py install for mozdebug 06:19:42 INFO - Running setup.py install for mozdevice 06:19:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Running setup.py install for mozfile 06:19:42 INFO - Running setup.py install for mozhttpd 06:19:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Running setup.py install for mozinfo 06:19:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Running setup.py install for mozInstall 06:19:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Running setup.py install for mozleak 06:19:42 INFO - Running setup.py install for mozlog 06:19:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:19:42 INFO - Running setup.py install for moznetwork 06:19:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Running setup.py install for mozprocess 06:19:43 INFO - Running setup.py install for mozprofile 06:19:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Running setup.py install for mozrunner 06:19:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Running setup.py install for mozscreenshot 06:19:43 INFO - Running setup.py install for moztest 06:19:43 INFO - Running setup.py install for mozversion 06:19:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:19:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:19:43 INFO - Cleaning up... 06:19:43 INFO - Return code: 0 06:19:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19: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')]} 06:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19: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')]} 06:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:43 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 0x146a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, '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': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', '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 06:19:43 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 06:19:43 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 06:19:43 INFO - Using env: {'DISPLAY': ':0', 06:19:43 INFO - 'HOME': '/home/cltbld', 06:19:43 INFO - 'LANG': 'en_US.UTF-8', 06:19:43 INFO - 'LANGUAGE': 'en_US:en', 06:19:43 INFO - 'LOGNAME': 'cltbld', 06:19:43 INFO - 'MAIL': '/var/mail/cltbld', 06:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:43 INFO - 'MOZ_NO_REMOTE': '1', 06:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:43 INFO - 'NO_EM_RESTART': '1', 06:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:43 INFO - 'PWD': '/builds/slave/test', 06:19:43 INFO - 'SHELL': '/bin/bash', 06:19:43 INFO - 'SHLVL': '1', 06:19:43 INFO - 'TERM': 'linux', 06:19:43 INFO - 'TMOUT': '86400', 06:19:43 INFO - 'USER': 'cltbld', 06:19:43 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:43 INFO - '_': '/tools/buildbot/bin/python'} 06:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:19:43 INFO - Running setup.py (path:/tmp/pip-Cto3lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:19:43 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)) 06:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:19:43 INFO - Running setup.py (path:/tmp/pip-wVsyKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:19:44 INFO - Running setup.py (path:/tmp/pip-wBBO3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:19:44 INFO - Running setup.py (path:/tmp/pip-oea6Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:19:44 INFO - Running setup.py (path:/tmp/pip-jRzngy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:19:44 INFO - Running setup.py (path:/tmp/pip-w3Hhqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:19:44 INFO - Running setup.py (path:/tmp/pip-Ieu7UT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:19:44 INFO - Running setup.py (path:/tmp/pip-i_5Ppt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:19:44 INFO - Running setup.py (path:/tmp/pip-z0SBIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:19:44 INFO - Running setup.py (path:/tmp/pip-uHzOg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:19:44 INFO - Running setup.py (path:/tmp/pip-f7JIPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:19:44 INFO - Running setup.py (path:/tmp/pip-YuPw9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:19:44 INFO - Running setup.py (path:/tmp/pip-ElGLlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:19:44 INFO - Running setup.py (path:/tmp/pip-jRwfn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:44 INFO - Running setup.py (path:/tmp/pip-8uSUM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:19:44 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)) 06:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:19:44 INFO - Running setup.py (path:/tmp/pip-fjcG29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:19:45 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)) 06:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:19:45 INFO - Running setup.py (path:/tmp/pip-V1B2TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:19:45 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)) 06:19:45 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)) 06:19:45 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)) 06:19:45 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)) 06:19:45 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)) 06:19:45 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)) 06:19:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:19:45 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 06:19:45 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 06:19:45 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 06:19:45 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 06:19:45 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 06:19:45 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 06:19:47 INFO - Downloading blessings-1.6.tar.gz 06:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:19:47 INFO - Installing collected packages: blessings 06:19:47 INFO - Running setup.py install for blessings 06:19:47 INFO - Successfully installed blessings 06:19:47 INFO - Cleaning up... 06:19:47 INFO - Return code: 0 06:19:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:19:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:19:47 INFO - Reading from file tmpfile_stdout 06:19:47 INFO - Current package versions: 06:19:47 INFO - argparse == 1.2.1 06:19:47 INFO - blessings == 1.6 06:19:47 INFO - blobuploader == 1.2.4 06:19:47 INFO - docopt == 0.6.1 06:19:47 INFO - functools32 == 3.2.3-2 06:19:47 INFO - jsonschema == 2.5.1 06:19:47 INFO - manifestparser == 1.1 06:19:47 INFO - mozInstall == 1.12 06:19:47 INFO - mozcrash == 0.17 06:19:47 INFO - mozdebug == 0.1 06:19:47 INFO - mozdevice == 0.48 06:19:47 INFO - mozfile == 1.2 06:19:47 INFO - mozhttpd == 0.7 06:19:47 INFO - mozinfo == 0.9 06:19:47 INFO - mozleak == 0.1 06:19:47 INFO - mozlog == 3.3 06:19:47 INFO - moznetwork == 0.27 06:19:47 INFO - mozprocess == 0.23 06:19:47 INFO - mozprofile == 0.28 06:19:47 INFO - mozrunner == 6.12 06:19:47 INFO - mozscreenshot == 0.1 06:19:47 INFO - mozsystemmonitor == 0.3 06:19:47 INFO - moztest == 0.7 06:19:47 INFO - mozversion == 1.4 06:19:47 INFO - psutil == 3.1.1 06:19:47 INFO - requests == 1.2.3 06:19:47 INFO - wsgiref == 0.1.2 06:19:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:47 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 0x146a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, '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': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', '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 06:19:47 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 06:19:47 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 06:19:47 INFO - Using env: {'DISPLAY': ':0', 06:19:47 INFO - 'HOME': '/home/cltbld', 06:19:47 INFO - 'LANG': 'en_US.UTF-8', 06:19:47 INFO - 'LANGUAGE': 'en_US:en', 06:19:47 INFO - 'LOGNAME': 'cltbld', 06:19:47 INFO - 'MAIL': '/var/mail/cltbld', 06:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:47 INFO - 'MOZ_NO_REMOTE': '1', 06:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:47 INFO - 'NO_EM_RESTART': '1', 06:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:47 INFO - 'PWD': '/builds/slave/test', 06:19:47 INFO - 'SHELL': '/bin/bash', 06:19:47 INFO - 'SHLVL': '1', 06:19:47 INFO - 'TERM': 'linux', 06:19:47 INFO - 'TMOUT': '86400', 06:19:47 INFO - 'USER': 'cltbld', 06:19:47 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:47 INFO - '_': '/tools/buildbot/bin/python'} 06:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 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)) 06:19:47 INFO - Cleaning up... 06:19:47 INFO - Return code: 0 06:19:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:19:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:19:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1699400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, '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': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', '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 06:19:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:19:47 INFO - Using env: {'DISPLAY': ':0', 06:19:47 INFO - 'HOME': '/home/cltbld', 06:19:47 INFO - 'LANG': 'en_US.UTF-8', 06:19:47 INFO - 'LANGUAGE': 'en_US:en', 06:19:47 INFO - 'LOGNAME': 'cltbld', 06:19:47 INFO - 'MAIL': '/var/mail/cltbld', 06:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:19:47 INFO - 'MOZ_NO_REMOTE': '1', 06:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:19:47 INFO - 'NO_EM_RESTART': '1', 06:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:19:47 INFO - 'PWD': '/builds/slave/test', 06:19:47 INFO - 'SHELL': '/bin/bash', 06:19:47 INFO - 'SHLVL': '1', 06:19:47 INFO - 'TERM': 'linux', 06:19:47 INFO - 'TMOUT': '86400', 06:19:47 INFO - 'USER': 'cltbld', 06:19:47 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:19:47 INFO - '_': '/tools/buildbot/bin/python'} 06:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:19:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:19:47 INFO - Cleaning up... 06:19:47 INFO - Return code: 0 06:19:47 INFO - Running post-action listener: _resource_record_post_action 06:19:47 INFO - Running post-action listener: _start_resource_monitoring 06:19:47 INFO - Starting resource monitoring. 06:19:47 INFO - [mozharness: 2016-10-27 13:19:47.998363Z] Finished create-virtualenv step (success) 06:19:47 INFO - [mozharness: 2016-10-27 13:19:47.998803Z] Running install step. 06:19:47 INFO - Running pre-action listener: _resource_record_pre_action 06:19:47 INFO - Running main action method: install 06:19:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:19:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:19:48 INFO - Reading from file tmpfile_stdout 06:19:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:19:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:19:48 INFO - Reading from file tmpfile_stdout 06:19:48 INFO - Output received: 06:19:48 INFO - Usage: mozinstall [options] installer 06:19:48 INFO - Options: 06:19:48 INFO - -h, --help show this help message and exit 06:19:48 INFO - -d DEST, --destination=DEST 06:19:48 INFO - Directory to install application into. [default: 06:19:48 INFO - "/builds/slave/test"] 06:19:48 INFO - --app=APP Application being installed. [default: firefox] 06:19:48 INFO - mkdir: /builds/slave/test/build/application 06:19:48 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'] 06:19:48 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 06:20:02 INFO - Reading from file tmpfile_stdout 06:20:02 INFO - Output received: 06:20:02 INFO - /builds/slave/test/build/application/firefox/firefox 06:20:02 INFO - Running post-action listener: _resource_record_post_action 06:20:02 INFO - [mozharness: 2016-10-27 13:20:02.262708Z] Finished install step (success) 06:20:02 INFO - [mozharness: 2016-10-27 13:20:02.262987Z] Running run-tests step. 06:20:02 INFO - Running pre-action listener: _resource_record_pre_action 06:20:02 INFO - Running main action method: run_tests 06:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:20:02 INFO - Python 2.7.3 06:20:02 INFO - Return code: 0 06:20:02 INFO - grabbing minidump binary from tooltool 06:20:02 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')]} 06:20:02 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 0x1728570>, '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 0x1729470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:20:02 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 06:20:02 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 06:20:02 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 06:20:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:20:02 INFO - Return code: 0 06:20:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:20:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:20:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:20:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:20:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:20:02 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/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 06:20:02 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/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 06:20:02 INFO - Using env: {'DISPLAY': ':0', 06:20:02 INFO - 'HOME': '/home/cltbld', 06:20:02 INFO - 'LANG': 'en_US.UTF-8', 06:20:02 INFO - 'LANGUAGE': 'en_US:en', 06:20:02 INFO - 'LOGNAME': 'cltbld', 06:20:02 INFO - 'MAIL': '/var/mail/cltbld', 06:20:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:20:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:02 INFO - 'MOZ_NO_REMOTE': '1', 06:20:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:02 INFO - 'NO_EM_RESTART': '1', 06:20:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:02 INFO - 'PWD': '/builds/slave/test', 06:20:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:20:02 INFO - 'SHELL': '/bin/bash', 06:20:02 INFO - 'SHLVL': '1', 06:20:02 INFO - 'TERM': 'linux', 06:20:02 INFO - 'TMOUT': '86400', 06:20:02 INFO - 'USER': 'cltbld', 06:20:02 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420', 06:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:02 INFO - '_': '/tools/buildbot/bin/python'} 06:20:02 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/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 06:20:02 INFO - mozversion application_buildid: 20161027030534 06:20:02 INFO - mozversion application_changeset: 30092cd6645ff14c7714da97e177f82fee34caf1 06:20:02 INFO - mozversion application_display_name: Firefox 06:20:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:20:02 INFO - mozversion application_name: Firefox 06:20:02 INFO - mozversion application_remotingname: firefox 06:20:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:20:02 INFO - mozversion application_vendor: Mozilla 06:20:02 INFO - mozversion application_version: 50.0 06:20:02 INFO - mozversion platform_buildid: 20161027030534 06:20:02 INFO - mozversion platform_changeset: 30092cd6645ff14c7714da97e177f82fee34caf1 06:20:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:20:02 INFO - mozversion platform_version: 50.0 06:20:02 INFO - using testdate: 1477574402 06:20:02 INFO - actual date: 1477574402 06:20:02 INFO - starting webserver on 'localhost:49706' 06:20:02 INFO - SUITE-START | Running 2 tests 06:20:02 INFO - TEST-START | dromaeo_css 06:20:02 INFO - operating with platform_type : linux_ 06:20:02 INFO - Initialising browser for dromaeo_css test... 06:20:02 INFO - TEST-INFO | started process 14901 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7WUSuT/profile http://localhost:49706/getInfo.html) 06:20:07 INFO - PROCESS | 14901 | __metrics Screen width/height:1600/1200 06:20:07 INFO - PROCESS | 14901 | colorDepth:24 06:20:07 INFO - PROCESS | 14901 | Browser inner width/height: 1024/697 06:20:07 INFO - PROCESS | 14901 | __metrics 06:20:07 ERROR - PROCESS | 14901 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:20:08 INFO - TEST-INFO | 14901: exit 0 06:20:08 INFO - Browser initialized. 06:20:08 INFO - Running cycle 1/1 for dromaeo_css test... 06:20:08 INFO - TEST-INFO | started process 15025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7WUSuT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:20:20 INFO - PROCESS | 15025 | RSS: Main: 149893120 06:20:20 INFO - PROCESS | 15025 | 06:21:10 INFO - PROCESS | 15025 | 1477574470055 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] 06:23:18 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49706/tests/dromaeo/cssquery-ext.html) 06:23:19 INFO - PROCESS | 15025 | RSS: Main: 158232576 06:23:19 INFO - PROCESS | 15025 | 06:26:21 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-ext.html (next: http://localhost:49706/tests/dromaeo/cssquery-jquery.html) 06:26:22 INFO - PROCESS | 15025 | RSS: Main: 155865088 06:26:22 INFO - PROCESS | 15025 | 06:29:23 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49706/tests/dromaeo/cssquery-mootools.html) 06:29:24 INFO - PROCESS | 15025 | RSS: Main: 155213824 06:29:24 INFO - PROCESS | 15025 | 06:32:26 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49706/tests/dromaeo/cssquery-prototype.html) 06:32:26 INFO - PROCESS | 15025 | RSS: Main: 156884992 06:32:26 INFO - PROCESS | 15025 | 06:35:29 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49706/tests/dromaeo/cssquery-yui.html) 06:35:29 INFO - PROCESS | 15025 | RSS: Main: 157671424 06:35:29 INFO - PROCESS | 15025 | 06:38:32 INFO - PROCESS | 15025 | Cycle 1(1): loaded http://localhost:49706/tests/dromaeo/cssquery-yui.html (next: http://localhost:49706/tests/dromaeo/cssquery-dojo.html) 06:38:32 INFO - PROCESS | 15025 | RSS: Main: 157716480 06:38:32 INFO - PROCESS | 15025 | 06:38:32 INFO - PROCESS | 15025 | __start_tp_report 06:38:32 INFO - PROCESS | 15025 | _x_x_mozilla_page_load 06:38:32 INFO - PROCESS | 15025 | _x_x_mozilla_page_load_details 06:38:32 INFO - PROCESS | 15025 | |i|pagename|runs| 06:38:32 INFO - PROCESS | 15025 | |0;dojo.html;3303.6035675718917;3314;3314.2874282029366;3319.8340082995846;3330.966690333096;5683.090705487123;5788.82633520994;5839.270091238595;5873.530117590588;5875.823725288237;5815.73829177687;5887.8233652990375;5892.175095486636;5892.3812999635065;5913.14259432382;5287.656302340345;5337.412884582693;5337.6797392156595;5344.946550534503;5379.246905433242;5400.594955378343;5405.270288511059;5405.648632838873;5410.161424979135;5411.594130440233;5153.793848246066;5295.602829787762;5393.460653934595;5404.7838086476495;5429.321334833146;5293.57651387888;5358.196270559409;5407.540359069484;5418.674879507243;5421.972890135564;5276.3140791697215;5346.786128554853;5374.677519348852;5374.811881584164;5387.4073851876265;5643.068893632546;5736.426357364272;5829.387914268983;5888.97055514724;5984.640921544721;6155.476784473325;6259.71831267594;6291.5281353898645;6304.7793327233785;6316.778912738078;6328.6835658216905;6331.113644089831;6331.55679102463;6332.018537126753;6338.651374174418;5756.856078598027;5810.680412577349;5882.999890018665;5886.823395298148;5900.557458190653;6375.968120159369;6432.549721519542;6480.351964803482;6493.512986525935;6495.7076931538195;6165.630062196283;6225.501959843202;6232.3144454110015;6234.189555357865;6239.96880015597;6121.112438696453;6146.323904370515;6254.906176407358;6329.620222786648;6330.905036424458;6124.991279909952;6180.351063138396;6205.968970155121;6208.906866397007;6208.906866397007;6201.751929922752;6210.534209934273;6210.72051757672;6246.593971391845;6264.373562643699;4670.859874203779;4698.718076915327;4728.668993170514;4729.787159577759;4734.19518681825;4180.16396720651;4229.365595160751;4246.426732391088;4271.829126834954;4288.5711428857485;6047.274327080779;6062.878742425127;6085.817425477243;6094.994325936171;6106.694665266719;6186.381361863778;6224.62652240867;6318.336574659686;6386.489080873519;6395.328490508523;6047.78832740852;6111.625222643455;6130.6467468051915;6132.110769107974;6141.578063794062;5273.235380869753;5285.180796976475;5305.098133317269;5305.151175811929;5323.3611966563485;6335.588186767845;6447.548671593037;6507.577007494498;6602.10871532337;6633.170853643294;6302.149209856702;6379.979203327445;6381.8723625528155;6382.457491113308;6383.042543618494;6531.444827189552;6552.541322107407;6557.803265902031;6584.209894812653;6600.966995165186;6046.455818976313;6108.645631960618;6152.323244443197;6177.81466556004;6230.937690623217;6321.936780632135;6346.904796427965;6353.396427339396;6359.20509936258;6367.713452894538;6183.474404675653;6192.102145188832;6194.287656919512;6197.938020619736;6241.687915604292;5965;6037.184980027816;6090.695465226632;6143.447089761943;6152.446279834837;6050.394960503914;6089.056196289582;6114.908276375769;6116.694165291807;6124.14262003311;6104.20645316106;6137.877242455215;6138.815835524942;6152.538559608137;6228.28374736893;5918.319393269829;5971.581989260884;6027.306859711014;6072.969635151796;6088.634681919099 06:38:32 INFO - PROCESS | 15025 | |1;ext.html;586.988260234795;632.4181752787435;657.6875983907642;658.0556900847284;719.8092505486044;42438.15123697528;47482.762586187106;47602.285965710544;47654;47709.52290477094;46773;47325.76337118318;47371.763141184245;47392.28911566329;47490.76254618731;9247.982721900586;9405.529723513831;9412.294077944147;9421.104995025496;9434.622615095388;9391.201747851406;9485.81028379432;9492.430454172772;9495.667651632195;9506.619735210583;9487.81024379512;9496.762580935498;9497.192738617226;9506.762330941747;9510.239180865514;9429.339946203769;9430.339876208702;9435.43387396755;9464.952675236615;9481.573329200202;9255.953720231422;9365.063493650649;9374.85937710935;9420.057994200593;9422.340436169403;44088.77955610202;44207.55792442099;44373.33439998403;44455.77772111151;44531.77734111341;3835.5780864104927;3853.9229215415817;3866.149447121629;3882.2623701496627;4038.818253178614;34910.650893490994;35120;35654;36243.16878639782;36345.63654363449;4864.173090574575;4869.926951095701;4923.089228492705;5070.112730272224;5146.408163061258;362523;362870;362990;363989;365772;38847.22305553873;39898;65145;65509;65562.67218663971;41435;41516;41539.58460415357;41561.58438415638;41608.79195604063;17176.398826041277;17219.827801722073;17318.307267709402;17318.65362692739;17352.219150138022;13407.262600556867;13445.932770336085;13478.460861565427;13484.730305393838;13487.460501580023;9196.448213107235;9407.670731524364;9466.95266523663;9479.526023698925;9530.857037144448;3586.9103272418397;3594.7663401879317;3660.139867131222;3663.432168013962;3671.9816400918357;1117.9664610061711;1149.844770955927;1162.773259214445;1167.9735658632267;1201.4053043743404;34418.655813441546;34997.300053999286;35460.82269588687;35535.644643553234;36234;1185.5731936502852;1200.8979236764974;1211.4064108586729;1272.4592048379402;1272.8345315109161;17663.11684415774;17954;18476.722849157275;18556.628867422845;18711.438656840317;606912;618729;620154;621252;625669;43426;43428.3485747714;43474.782626086664;43631.56368436275;43704;1477.4533422633478;1489.3670190169134;1489.8212214534108;1515.5680631020327;1518.468536012409;33979.32041359208;34047.319053619285;34345.48481772726;34385.312293753486;34684.30631387408;58998.705006474695;59105.40894591171;59341;59386;59463.405365945786;495764;496640;496740;501316;502941;31691.366172676877;31954.520682189323;32021.519677204393;32285.51571726379;32438.675613243566;53403.19895201497;53755.19367209417;54268;54364.184537232766;55255.72372138114;44906.326405104606;45477.54522454733;46733.766331169485;47510;47526;44718.77640611776;45881;46164.7691761539;46323;46922.53077469182;45064;48489.5151048485;48631.75684121557;49053;49169.50830491792;38487.422688659135;38497.6150238494;39640.40539391854;39743.40384894171;40217.79891100526;30312.393752125274;30784;30927.536086959164;31325;31412 06:38:32 INFO - PROCESS | 15025 | |2;jquery.html;421.19124503163783;430.61890227149;436.18651215483123;438.16310846283596;441.5804985263998;19159.904200478995;20185.49536261596;20885.37343879682;20905.686414703774;21031.158753649837;19523.5119122022;19569;19630.312939047137;19749.50626234345;19765.40703778889;5885.32318783339;6080.878382432349;6081.574289799716;6094.481969032638;6114.296855861566;5995;6018.458338749511;6032.547558933075;6051.515878729691;6082.604630699013;5806.303243610772;5977.432143946318;5983.311919129291;5991.85020374492;5994.820155395345;5880.970595147019;5953.732082056296;5962.552808539355;5977.850553736148;5984.491318237955;5361.51746342831;5400.135978243501;5404.648697834628;5406.91889621656;5416.7020813855615;24527;24577.38556536083;25152.748472515406;25208.36979075538;25721.485570288678;2518.609615509599;2525.848449093042;2536.5687833068237;2730.5358089124898;3081.568580398746;15121.621959450991;15174.165420901845;15636;15856.207189640587;15964.121973291465;2060.577581595769;2098.4963608733947;2131.1475409836034;2135.9252426165167;2155.5473350596394;84191;86996.56501717515;87072;87527;88391;11028.062614677681;11392;11696.532138714527;11761.411929403495;11899.583514576949;16341.428050018192;16371.672566548841;16375.181240937905;16386.590335241715;16389.0166590005;8188.549629770419;8209.302209312274;8310.376721745894;8361.707340243183;8380.958095209608;7738.61306934651;7816.06207255133;7904.4071694623135;8257.42198046143;8265.380096492787;6983.546069505567;7100.680469378787;7139.357457828821;7171.677274522659;7271.709131634781;2056.8505911322704;2111.546017606222;2113.725215721977;2114.1966052900107;2159.2010955946084;1025.6307729217476;1056.6565866093551;1098.7692584557333;1108.695108845058;1150.039716836451;20879.478013049797;21227.78772212289;21309.041093150845;21370.679439808417;21729.782702173092;1068.3643232276784;1098.132475344469;1102.5699977008974;1123.1295745797072;1153.3253046967618;11237.157213209042;11781.293122412682;11887;11914.046876249879;11919.70200744971;561652;568656;576366;578120;578372;46506.534934650896;83896.58051709825;86435;86958;88615;1105.1159072741614;1109.8557187565564;1114.2367478277245;1125.606037886733;1129.785340785248;16988.66022679564;18704.7194292083;18789.154488048345;18818.341358052403;18958.90739187761;31668.208294792814;41785;41846;41981.79009104935;42354.152916942105;52714.47285527096;55089.72455137699;55211.723941380034;56122.71938640281;57331;9150.633974641207;9289;9362.625494980124;9504.95247523758;9568.61725530971;14151.858481415466;14152.009359344747;14390.640233994234;14458.06022608527;14604.12375257488;12375.133740638068;12678.746425071631;12696.873031269939;12773.297468639314;12795.61613151607;12438.067144963983;12470;12488.937555312164;12567.057470689917;12613.49546018149;12629.2422454653;12792.872071279167;12841;12863.035272354424;13271.469141234242;9128.589213485542;9131.908680913106;9183.219426348835;9215.86176207344;9296.163345298955;12611.30637814929;12622.55821046259;12681.23912565212;12725.681857953625;12768.297743624189 06:38:32 INFO - PROCESS | 15025 | |3;mootools.html;1508.8340282568915;1580.5179420276816;1745.9912700436496;1846.1323178106302;1878.7651543557065;7901.960490197541;8581.570921453933;9143.679971201009;9196.218321442686;9221.35450518464;9275.628974841014;9586.281028922842;9605.855912161305;9615.567299471522;9652.903470965306;2373.501564671421;2420.1408499982517;2422.6608274841537;2424.1757802347197;2425.1148330859287;2515.2705715342527;2523.1295203154973;2570.9742902571015;2573.2794817451145;2579.1746641074865;2465.716442609105;2472.8887200076038;2547.426828963487;2548.7706106450414;2550.1457011901034;2471.789897858684;2474.6288056791536;2486.477839653675;2503.5869081601513;2506.0727530813533;2455.3616059824394;2460.5447992121517;2461.679981602398;2468.148488771371;2507.185164821422;9685.612575496973;9747.61009559624;9750.366226195345;9752.219822414261;9762.36544624597;5609.1305847593685;5657.010023245956;5721.599488035839;5729.28383952006;5740.052891272935;3532.205253817896;3566.375884220251;3602.1174812171184;3691.5570131584113;3719.962800372016;1172.3434876469119;1207.5290636651712;1224.7856625090574;1241.30486927321;1254.6236129161216;12808.807867881897;12915.160514566523;12950.611481655566;12972.091953563255;12983.480660773557;4855.393075865517;5025.648204625714;5031.4213865405945;5162.767675454614;5181.611379146504;10707.892921070845;10714.089302409227;10764.40795756241;10778.299410538446;10817.188710846718;5737.168110624019;5747.195392645033;5754.223179870748;5754.971225143931;5755.050416681284;5151.407588127338;5324.387695414999;5366.892662146735;5367.892642147213;5412.83761487156;4095.8102581162634;4119.670426365884;4130.153318569686;4171.249175148502;4178.791060446965;1210.1045226532478;1219.969500762488;1224.0391292835081;1226.791445454275;1236.7031912341154;1021.9846702299471;1032.4115254305125;1032.7882784029407;1043.446973104256;1054.1408751867357;6488.67556622167;6527.673616319165;6533.575317604341;6548.508861835287;6607.041978913031;487.75855951304334;496.33491121896833;504.7274471785268;507.05181310948024;512.4337606944347;4407.669424793089;4508.864734057984;4551.908961820745;4636.652251081183;4639.280911458729;11370.94314528422;11691.064714822964;12137.211081279866;12140.089493288038;12182.086343524272;11818.527258909719;12076.758464830655;12104.697382565506;12111.454984525717;12164.2701437914;8826.823463530693;8908.599113039929;8935.955320223487;8986.640534378683;8988.011318754932;6277.30949595535;6558.80323590293;6687.431568316748;6720.495962802907;6780.72877084911;10837.945810271214;10999.560017599206;11050.226484146033;11050.889491104987;11159.944200278947;10836.67489975302;10928.617498387519;11065.170112241452;11254.94372528132;11385.089192864385;7463.813404664927;8149.266566009088;8334.49993000422;8346.749597512084;8503.787405314917;9227.953860230657;9251.444913305224;9262.16640502358;9281.39670921388;9293.814123717622;8284.544350060805;8299.751007469786;8381.413301068867;8412.116727743498;8448.366372522209;8035.758927232192;8088.9595552021865;8111.269985701315;8121.837563248584;8166.4283500154415;7386.704531818882;7482.326590606872;7638.8090297743;7730.18833022547;7731.342835859015;5630.380658127685;5687.800926967537;5714.457126572969;5733.168690539765;5815.982203114522;5751.137329400456;5818.738156782871;5828.912566311594;5924.407559244041;5928.525717942641 06:38:32 INFO - PROCESS | 15025 | |4;prototype.html;355.8380936673813;356.44750636513396;359.8146954318528;365.05997057576747;366.6718287133016;5754.4533269339345;5770.624909380887;5802.303723553175;5809.796657117002;5839.153322768207;5616.438356164382;5655.321361436623;5702.54379649628;5721.5708821838425;5731.45551172639;4495;4500.797464114106;4541.978819425357;4548.476260452752;4571.839985600504;4543.136804007228;4552.521985191557;4559.088182363524;4569.469227808688;4589;4431.88920276994;4495.887602809923;4535.909281814362;4555.111753208126;4556.521565235652;4476.462824461053;4496.572825581581;4516.774161291923;4529.026259354222;4532.818687252539;4042.151148258869;4043.2317859606874;4053.2906741320153;4060.4112403701592;4068.5524592294823;5601.551875849922;5668.26312579362;5677.176809362661;5677.290338707661;5698.743556539925;4885.951140488585;5149.742512874342;5178.275041494194;5201.687898726089;5214.791408343662;6030.246219222598;6079.300880398767;6096;6114.724837382329;6126.724297406583;4156.418101465797;4413.249747542925;4419.4033805436175;4424.424824772759;4425.15921974827;6033.547483938678;6191.226096737908;6235.7505699771955;6299;6315.957866951948;4435.935375509919;4471.530489298577;4478.888027799331;4507.301368287921;4508.616767574793;4548.818047278071;4572.6739245619065;4572.97713511437;4583.089738016383;4584.17484852723;5001.89996200074;5178.585713142939;5206.140986737221;5237.502437268529;5251.396089449686;6062.696865156725;6073.6659483727935;6074.696265186723;6081.27024757032;6082.817515474543;1554.3083327919194;1567.1694002178863;1577.7081239970641;1579.9052056876624;1581.8734501239874;963.3978763272954;1003.3895597565802;1003.909648131657;1004.638330201127;1018.2414101494286;5200.3878797572115;5203.895922081537;5215.634905556651;5231.686098834082;5248.60635452335;5411.594130440233;5433.293671822637;5490.654789576579;5491.697956612425;5521.889562208733;4936.728479933567;5220.947790522122;5244.868878278074;5245.895082098336;5263.868268322252;2903.3015685823607;2920.693327200656;2926.6049083373896;2933.398653276073;2945.911622651324;5595.7057606382;5610.87782443513;5622.28520301312;5646.2377579027125;5662.405447428043;5866.941330586725;6350.936490635127;6370.642862141038;6397.552171348054;6398.392152745481;6495.64273964927;6520.250171230275;6523.575967562093;6528.37980391862;6569.408753212234;6057.848553786191;6184.196054513064;6271.874562508816;6302.180716506825;6325;6170.81487555374;6231.416935262333;6236.314005459487;6284.591501552384;6300.243970723543;6321.462675672619;6527.640979746159;6538.215414150142;6547.544670748469;6587.736490540325;4512.9097418052115;4537.319402089713;4549.431321084864;4559.566841150086;4578.6108180805;6190.473809726043;6263.029230469285;6324.177856878577;6375.8204732124705;6403.8399040022505;6107.175531303395;6109;6119.959606866754;6141.631502109888;6149.41580549847;5891.823245302648;6128.9693551531955;6136.754529818936;6156.230471191101;6219.284782249918;6078.3921607838865;6095.420935011167;6132.78535251264;6136.631802091889;6143.139960405636;6070.544709146743;6154.507639388748;6161;6172;6215.627062376272;5813.372255768391;6004.189434426296;6007.008843540767;6013.849653758691;6040.365761595145 06:38:32 INFO - PROCESS | 15025 | |5;yui.html;813.7843471480063;823.0781524692342;878.6968495868925;891.7235656946345;916.042735341568;16698.415555455562;17210.39763608274;17550.297988080492;17704.82295177048;17802.28790848366;17467.213975371105;17579.56051098723;17584.824151758512;17605.471835844946;17634.559136021606;862.9439086459391;881.0968757024069;881.1144799476517;881.1364862434817;881.378628067211;858.7252079334615;888.4314039015036;891.2513488669516;893.0712059458156;893.3746377535718;923.4690053219392;929.0384452092086;936.1574582875398;937.1612406895824;937.9108984646448;930.6510058727944;931.9394239374453;933.8272419602396;933.9206167475738;934.1312579301247;686.9622170780605;687.4946914018193;688.5455599304435;689.2659317826499;690.0787448755917;15758.76361854573;15799.684006319923;15802.288896999662;15851.841481585267;15891.443799467079;15882.523524294289;16053.277602507915;16238.512844614681;16337.34650613974;16564.171791410383;12952;13085.607431777062;13120.343982800821;13262.3368831559;13424.328783560783;4102.958970410287;4139.151473947833;4143.7928103594695;4150.252954468195;4235.02594403289;71449.28550714478;74108.99999999946;84797.57601212016;86306;86474.56762716209;13166.47334106625;13170.670733231746;13197.406116724771;13329.333533323295;13372.058207078237;23544;23710.644340334908;23811.880940595533;23834.40413989664;23839.52320953606;9308.90691093094;9318.39430437033;9328.486933218603;9399.34204605671;9436.150746432853;4829.782659780319;5050.924236136461;5066.012127635149;5113.744312784346;5114.105031619451;4174.519930208005;4458.108378324348;4458.219811532968;4502.954970450253;4505;749.1160430691835;754.9358304544065;757.3373298363931;764.5833021003566;765.1124695353363;714.2250658036089;731.3454458259934;734.4051318432087;738.6306846576712;741.5439504704568;10157.492125393848;10557.788844223072;10565.9471702641;10767.676969690921;10778.568857245622;688.9621070841051;787.2481779900181;792.8969233999659;802.2579114319232;824.4970567953544;4888.437829649564;4999.900101896045;5011.086033586187;5087.236914462786;5104.668196567211;78426.21573784303;78498;79097.60451197707;100566;118626.40686796511;111230.44384778025;112416;118922;119805;121949;100594.4970275144;100825.47110851231;100956;101409;101865;9413.48225847585;9440.716778496657;9684.612615495302;9726.221902247662;9803;58028.70985645045;58386.708066459396;58958;59255.40744592499;59691.70154149202;78329.60835195788;79657.60171199107;88245.35263942092;90075.54962225146;91183.54408227916;12953.352332383154;13155.934220328838;13177.93411032977;13604.387802549107;13916.615689141523;14603.123812571279;14663.193524356262;14686.779698304748;14915.552533424014;15026;13600.795988060385;13761;13821.516246931309;14242.216678082805;14365.209913454442;13354.198748075147;13756.931215343859;14614.19621920762;14751.409943602135;14785.852141478448;13234.602961910772;13304.401301941629;13811.309434528433;13982.720345593234;14207.644808879448;9723.756906077404;10234.283600147919;10387.636432724817;10418.114460270961;10448.843267350843;10685.679429617125;10891.346519208873;10977.12183025372;11073;11108.888911110786 06:38:32 INFO - PROCESS | 15025 | __end_tp_report 06:38:32 INFO - PROCESS | 15025 | __start_cc_report 06:38:32 INFO - PROCESS | 15025 | _x_x_mozilla_cycle_collect,344 06:38:32 INFO - PROCESS | 15025 | __end_cc_report 06:38:32 INFO - PROCESS | 15025 | __startTimestamp1477575512442__endTimestamp 06:38:32 INFO - PROCESS | 15025 | 06:38:32 INFO - PROCESS | 15025 | ------- Summary: start ------- 06:38:32 INFO - PROCESS | 15025 | Number of tests: 6 06:38:32 INFO - PROCESS | 15025 | 06:38:32 INFO - PROCESS | 15025 | [#0] dojo.html Cycles:165 Average:5837.33 Median:6106.69 stddev:685.72 (11.2%) stddev-sans-first:658.38 06:38:32 INFO - PROCESS | 15025 | Values: 3303.6 3314.0 3314.3 3319.8 3331.0 5683.1 5788.8 5839.3 5873.5 5875.8 5815.7 5887.8 5892.2 5892.4 5913.1 5287.7 5337.4 5337.7 5344.9 5379.2 5400.6 5405.3 5405.6 5410.2 5411.6 5153.8 5295.6 5393.5 5404.8 5429.3 5293.6 5358.2 5407.5 5418.7 5422.0 5276.3 5346.8 5374.7 5374.8 5387.4 5643.1 5736.4 5829.4 5889.0 5984.6 6155.5 6259.7 6291.5 6304.8 6316.8 6328.7 6331.1 6331.6 6332.0 6338.7 5756.9 5810.7 5883.0 5886.8 5900.6 6376.0 6432.5 6480.4 6493.5 6495.7 6165.6 6225.5 6232.3 6234.2 6240.0 6121.1 6146.3 6254.9 6329.6 6330.9 6125.0 6180.4 6206.0 6208.9 6208.9 6201.8 6210.5 6210.7 6246.6 6264.4 4670.9 4698.7 4728.7 4729.8 4734.2 4180.2 4229.4 4246.4 4271.8 4288.6 6047.3 6062.9 6085.8 6095.0 6106.7 6186.4 6224.6 6318.3 6386.5 6395.3 6047.8 6111.6 6130.6 6132.1 6141.6 5273.2 5285.2 5305.1 5305.2 5323.4 6335.6 6447.5 6507.6 6602.1 6633.2 6302.1 6380.0 6381.9 6382.5 6383.0 6531.4 6552.5 6557.8 6584.2 6601.0 6046.5 6108.6 6152.3 6177.8 6230.9 6321.9 6346.9 6353.4 6359.2 6367.7 6183.5 6192.1 6194.3 6197.9 6241.7 5965.0 6037.2 6090.7 6143.4 6152.4 6050.4 6089.1 6114.9 6116.7 6124.1 6104.2 6137.9 6138.8 6152.5 6228.3 5918.3 5971.6 6027.3 6073.0 6088.6 06:38:32 INFO - PROCESS | 15025 | 06:38:32 INFO - PROCESS | 15025 | [#1] ext.html Cycles:180 Average:65092.67 Median:44414.56 stddev:134317.36 (302.4%) stddev-sans-first:134606.84 06:38:32 INFO - PROCESS | 15025 | Values: 587.0 632.4 657.7 658.1 719.8 42438.2 47482.8 47602.3 47654.0 47709.5 46773.0 47325.8 47371.8 47392.3 47490.8 9248.0 9405.5 9412.3 9421.1 9434.6 9391.2 9485.8 9492.4 9495.7 9506.6 9487.8 9496.8 9497.2 9506.8 9510.2 9429.3 9430.3 9435.4 9465.0 9481.6 9256.0 9365.1 9374.9 9420.1 9422.3 44088.8 44207.6 44373.3 44455.8 44531.8 3835.6 3853.9 3866.1 3882.3 4038.8 34910.7 35120.0 35654.0 36243.2 36345.6 4864.2 4869.9 4923.1 5070.1 5146.4 362523.0 362870.0 362990.0 363989.0 365772.0 38847.2 39898.0 65145.0 65509.0 65562.7 41435.0 41516.0 41539.6 41561.6 41608.8 17176.4 17219.8 17318.3 17318.7 17352.2 13407.3 13445.9 13478.5 13484.7 13487.5 9196.4 9407.7 9467.0 9479.5 9530.9 3586.9 3594.8 3660.1 3663.4 3672.0 1118.0 1149.8 1162.8 1168.0 1201.4 34418.7 34997.3 35460.8 35535.6 36234.0 1185.6 1200.9 1211.4 1272.5 1272.8 17663.1 17954.0 18476.7 18556.6 18711.4 606912.0 618729.0 620154.0 621252.0 625669.0 43426.0 43428.3 43474.8 43631.6 43704.0 1477.5 1489.4 1489.8 1515.6 1518.5 33979.3 34047.3 34345.5 34385.3 34684.3 58998.7 59105.4 59341.0 59386.0 59463.4 495764.0 496640.0 496740.0 501316.0 502941.0 31691.4 31954.5 32021.5 32285.5 32438.7 53403.2 53755.2 54268.0 54364.2 55255.7 44906.3 45477.5 46733.8 47510.0 47526.0 44718.8 45881.0 46164.8 46323.0 46922.5 45064.0 48489.5 48631.8 49053.0 49169.5 38487.4 38497.6 39640.4 39743.4 40217.8 30312.4 30784.0 30927.5 31325.0 31412.0 06:38:32 INFO - PROCESS | 15025 | 06:38:32 INFO - PROCESS | 15025 | [#2] jquery.html Cycles:180 Average:31677.56 Median:24552.19 stddev:93782.11 (382.0%) stddev-sans-first:94015.82 06:38:32 INFO - PROCESS | 15025 | Values: 421.2 430.6 436.2 438.2 441.6 19159.9 20185.5 20885.4 20905.7 21031.2 19523.5 19569.0 19630.3 19749.5 19765.4 5885.3 6080.9 6081.6 6094.5 6114.3 5995.0 6018.5 6032.5 6051.5 6082.6 5806.3 5977.4 5983.3 5991.9 5994.8 5881.0 5953.7 5962.6 5977.9 5984.5 5361.5 5400.1 5404.6 5406.9 5416.7 24527.0 24577.4 25152.7 25208.4 25721.5 2518.6 2525.8 2536.6 2730.5 3081.6 15121.6 15174.2 15636.0 15856.2 15964.1 2060.6 2098.5 2131.1 2135.9 2155.5 84191.0 86996.6 87072.0 87527.0 88391.0 11028.1 11392.0 11696.5 11761.4 11899.6 16341.4 16371.7 16375.2 16386.6 16389.0 8188.5 8209.3 8310.4 8361.7 8381.0 7738.6 7816.1 7904.4 8257.4 8265.4 6983.5 7100.7 7139.4 7171.7 7271.7 2056.9 2111.5 2113.7 2114.2 2159.2 1025.6 1056.7 1098.8 1108.7 1150.0 20879.5 21227.8 21309.0 21370.7 21729.8 1068.4 1098.1 1102.6 1123.1 1153.3 11237.2 11781.3 11887.0 11914.0 11919.7 561652.0 568656.0 576366.0 578120.0 578372.0 46506.5 83896.6 86435.0 86958.0 88615.0 1105.1 1109.9 1114.2 1125.6 1129.8 16988.7 18704.7 18789.2 18818.3 18958.9 31668.2 41785.0 41846.0 41981.8 42354.2 52714.5 55089.7 55211.7 56122.7 57331.0 9150.6 9289.0 9362.6 9505.0 9568.6 14151.9 14152.0 14390.6 14458.1 14604.1 12375.1 12678.7 12696.9 12773.3 12795.6 12438.1 12470.0 12488.9 12567.1 12613.5 12629.2 12792.9 12841.0 12863.0 13271.5 9128.6 9131.9 9183.2 9215.9 9296.2 12611.3 12622.6 12681.2 12725.7 12768.3 06:38:32 INFO - PROCESS | 15025 | 06:38:32 INFO - PROCESS | 15025 | [#3] mootools.html Cycles:180 Average:6256.77 Median:2671.58 stddev:3571.35 (133.7%) stddev-sans-first:3563.55 06:38:32 INFO - PROCESS | 15025 | Values: 1508.8 1580.5 1746.0 1846.1 1878.8 7902.0 8581.6 9143.7 9196.2 9221.4 9275.6 9586.3 9605.9 9615.6 9652.9 2373.5 2420.1 2422.7 2424.2 2425.1 2515.3 2523.1 2571.0 2573.3 2579.2 2465.7 2472.9 2547.4 2548.8 2550.1 2471.8 2474.6 2486.5 2503.6 2506.1 2455.4 2460.5 2461.7 2468.1 2507.2 9685.6 9747.6 9750.4 9752.2 9762.4 5609.1 5657.0 5721.6 5729.3 5740.1 3532.2 3566.4 3602.1 3691.6 3720.0 1172.3 1207.5 1224.8 1241.3 1254.6 12808.8 12915.2 12950.6 12972.1 12983.5 4855.4 5025.6 5031.4 5162.8 5181.6 10707.9 10714.1 10764.4 10778.3 10817.2 5737.2 5747.2 5754.2 5755.0 5755.1 5151.4 5324.4 5366.9 5367.9 5412.8 4095.8 4119.7 4130.2 4171.2 4178.8 1210.1 1220.0 1224.0 1226.8 1236.7 1022.0 1032.4 1032.8 1043.4 1054.1 6488.7 6527.7 6533.6 6548.5 6607.0 487.8 496.3 504.7 507.1 512.4 4407.7 4508.9 4551.9 4636.7 4639.3 11370.9 11691.1 12137.2 12140.1 12182.1 11818.5 12076.8 12104.7 12111.5 12164.3 8826.8 8908.6 8936.0 8986.6 8988.0 6277.3 6558.8 6687.4 6720.5 6780.7 10837.9 10999.6 11050.2 11050.9 11159.9 10836.7 10928.6 11065.2 11254.9 11385.1 7463.8 8149.3 8334.5 8346.7 8503.8 9228.0 9251.4 9262.2 9281.4 9293.8 8284.5 8299.8 8381.4 8412.1 8448.4 8035.8 8089.0 8111.3 8121.8 8166.4 7386.7 7482.3 7638.8 7730.2 7731.3 5630.4 5687.8 5714.5 5733.2 5816.0 5751.1 5818.7 5828.9 5924.4 5928.5 06:38:32 INFO - PROCESS | 15025 | 06:38:32 INFO - PROCESS | 15025 | [#4] prototype.html Cycles:180 Average:5052.72 Median:5606.21 stddev:1491.35 (26.6%) stddev-sans-first:1453.27 06:38:32 INFO - PROCESS | 15025 | Values: 355.8 356.4 359.8 365.1 366.7 5754.5 5770.6 5802.3 5809.8 5839.2 5616.4 5655.3 5702.5 5721.6 5731.5 4495.0 4500.8 4542.0 4548.5 4571.8 4543.1 4552.5 4559.1 4569.5 4589.0 4431.9 4495.9 4535.9 4555.1 4556.5 4476.5 4496.6 4516.8 4529.0 4532.8 4042.2 4043.2 4053.3 4060.4 4068.6 5601.6 5668.3 5677.2 5677.3 5698.7 4886.0 5149.7 5178.3 5201.7 5214.8 6030.2 6079.3 6096.0 6114.7 6126.7 4156.4 4413.2 4419.4 4424.4 4425.2 6033.5 6191.2 6235.8 6299.0 6316.0 4435.9 4471.5 4478.9 4507.3 4508.6 4548.8 4572.7 4573.0 4583.1 4584.2 5001.9 5178.6 5206.1 5237.5 5251.4 6062.7 6073.7 6074.7 6081.3 6082.8 1554.3 1567.2 1577.7 1579.9 1581.9 963.4 1003.4 1003.9 1004.6 1018.2 5200.4 5203.9 5215.6 5231.7 5248.6 5411.6 5433.3 5490.7 5491.7 5521.9 4936.7 5220.9 5244.9 5245.9 5263.9 2903.3 2920.7 2926.6 2933.4 2945.9 5595.7 5610.9 5622.3 5646.2 5662.4 5866.9 6350.9 6370.6 6397.6 6398.4 6495.6 6520.3 6523.6 6528.4 6569.4 6057.8 6184.2 6271.9 6302.2 6325.0 6170.8 6231.4 6236.3 6284.6 6300.2 6321.5 6527.6 6538.2 6547.5 6587.7 4512.9 4537.3 4549.4 4559.6 4578.6 6190.5 6263.0 6324.2 6375.8 6403.8 6107.2 6109.0 6120.0 6141.6 6149.4 5891.8 6129.0 6136.8 6156.2 6219.3 6078.4 6095.4 6132.8 6136.6 6143.1 6070.5 6154.5 6161.0 6172.0 6215.6 5813.4 6004.2 6007.0 6013.8 6040.4 06:38:32 INFO - PROCESS | 15025 | 06:38:32 INFO - PROCESS | 15025 | [#5] yui.html Cycles:180 Average:22168.31 Median:4204.77 stddev:31596.74 (751.4%) stddev-sans-first:31644.69 06:38:32 INFO - PROCESS | 15025 | Values: 813.8 823.1 878.7 891.7 916.0 16698.4 17210.4 17550.3 17704.8 17802.3 17467.2 17579.6 17584.8 17605.5 17634.6 862.9 881.1 881.1 881.1 881.4 858.7 888.4 891.3 893.1 893.4 923.5 929.0 936.2 937.2 937.9 930.7 931.9 933.8 933.9 934.1 687.0 687.5 688.5 689.3 690.1 15758.8 15799.7 15802.3 15851.8 15891.4 15882.5 16053.3 16238.5 16337.3 16564.2 12952.0 13085.6 13120.3 13262.3 13424.3 4103.0 4139.2 4143.8 4150.3 4235.0 71449.3 74109.0 84797.6 86306.0 86474.6 13166.5 13170.7 13197.4 13329.3 13372.1 23544.0 23710.6 23811.9 23834.4 23839.5 9308.9 9318.4 9328.5 9399.3 9436.2 4829.8 5050.9 5066.0 5113.7 5114.1 4174.5 4458.1 4458.2 4503.0 4505.0 749.1 754.9 757.3 764.6 765.1 714.2 731.3 734.4 738.6 741.5 10157.5 10557.8 10565.9 10767.7 10778.6 689.0 787.2 792.9 802.3 824.5 4888.4 4999.9 5011.1 5087.2 5104.7 78426.2 78498.0 79097.6 100566.0 118626.4 111230.4 112416.0 118922.0 119805.0 121949.0 100594.5 100825.5 100956.0 101409.0 101865.0 9413.5 9440.7 9684.6 9726.2 9803.0 58028.7 58386.7 58958.0 59255.4 59691.7 78329.6 79657.6 88245.4 90075.5 91183.5 12953.4 13155.9 13177.9 13604.4 13916.6 14603.1 14663.2 14686.8 14915.6 15026.0 13600.8 13761.0 13821.5 14242.2 14365.2 13354.2 13756.9 14614.2 14751.4 14785.9 13234.6 13304.4 13811.3 13982.7 14207.6 9723.8 10234.3 10387.6 10418.1 10448.8 10685.7 10891.3 10977.1 11073.0 11108.9 06:38:32 INFO - PROCESS | 15025 | -------- Summary: end -------- 06:38:32 INFO - PROCESS | 15025 | 06:38:33 INFO - TEST-INFO | 15025: exit 0 06:38:33 INFO - TEST-OK | dromaeo_css | took 1110694ms 06:38:33 INFO - TEST-START | kraken 06:38:33 INFO - operating with platform_type : linux_ 06:38:33 INFO - Initialising browser for kraken test... 06:38:33 INFO - TEST-INFO | started process 15267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX82p0_/profile http://localhost:49706/getInfo.html) 06:38:37 INFO - PROCESS | 15267 | __metrics Screen width/height:1600/1200 06:38:37 INFO - PROCESS | 15267 | colorDepth:24 06:38:37 INFO - PROCESS | 15267 | Browser inner width/height: 1024/697 06:38:37 INFO - PROCESS | 15267 | __metrics 06:38:38 ERROR - PROCESS | 15267 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:38:39 INFO - TEST-INFO | 15267: exit 0 06:38:39 INFO - Browser initialized. 06:38:39 INFO - Running cycle 1/1 for kraken test... 06:38:39 INFO - TEST-INFO | started process 15393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX82p0_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:38:50 INFO - PROCESS | 15393 | RSS: Main: 149819392 06:38:50 INFO - PROCESS | 15393 | 06:38:53 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-beat-detection) 06:38:54 INFO - PROCESS | 15393 | RSS: Main: 156815360 06:38:54 INFO - PROCESS | 15393 | 06:38:56 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-dft) 06:38:57 INFO - PROCESS | 15393 | RSS: Main: 155033600 06:38:57 INFO - PROCESS | 15393 | 06:39:00 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-fft) 06:39:00 INFO - PROCESS | 15393 | RSS: Main: 155783168 06:39:00 INFO - PROCESS | 15393 | 06:39:03 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49706/tests/kraken/driver.html?testName=audio-oscillator) 06:39:03 INFO - PROCESS | 15393 | RSS: Main: 155578368 06:39:03 INFO - PROCESS | 15393 | 06:39:05 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49706/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:39:06 INFO - PROCESS | 15393 | RSS: Main: 155951104 06:39:06 INFO - PROCESS | 15393 | 06:39:09 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49706/tests/kraken/driver.html?testName=imaging-darkroom) 06:39:10 INFO - PROCESS | 15393 | RSS: Main: 156221440 06:39:10 INFO - PROCESS | 15393 | 06:39:13 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49706/tests/kraken/driver.html?testName=imaging-desaturate) 06:39:14 INFO - PROCESS | 15393 | RSS: Main: 156217344 06:39:14 INFO - PROCESS | 15393 | 06:39:16 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49706/tests/kraken/driver.html?testName=json-parse-financial) 06:39:17 INFO - PROCESS | 15393 | RSS: Main: 156229632 06:39:17 INFO - PROCESS | 15393 | 06:39:19 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49706/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:39:19 INFO - PROCESS | 15393 | RSS: Main: 155332608 06:39:19 INFO - PROCESS | 15393 | 06:39:21 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:39:22 INFO - PROCESS | 15393 | RSS: Main: 155815936 06:39:22 INFO - PROCESS | 15393 | 06:39:23 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:39:24 INFO - PROCESS | 15393 | RSS: Main: 155742208 06:39:24 INFO - PROCESS | 15393 | 06:39:27 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:39:27 INFO - PROCESS | 15393 | RSS: Main: 156684288 06:39:27 INFO - PROCESS | 15393 | 06:39:30 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:39:31 INFO - PROCESS | 15393 | RSS: Main: 156897280 06:39:31 INFO - PROCESS | 15393 | 06:39:32 INFO - PROCESS | 15393 | Cycle 1(1): loaded http://localhost:49706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49706/tests/kraken/driver.html?testName=ai-astar) 06:39:32 INFO - PROCESS | 15393 | RSS: Main: 158400512 06:39:32 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | __start_tp_report 06:39:33 INFO - PROCESS | 15393 | _x_x_mozilla_page_load 06:39:33 INFO - PROCESS | 15393 | _x_x_mozilla_page_load_details 06:39:33 INFO - PROCESS | 15393 | |i|pagename|runs| 06:39:33 INFO - PROCESS | 15393 | |0;ai-astar;100;111;106;110;110;111;110;111;110;111 06:39:33 INFO - PROCESS | 15393 | |1;audio-beat-detection;146;118;160;169;119;147;142;120;171;114 06:39:33 INFO - PROCESS | 15393 | |2;audio-dft;161;161;161;161;161;161;164;162;163;162 06:39:33 INFO - PROCESS | 15393 | |3;audio-fft;75;74;78;165;76;75;75;76;177;77 06:39:33 INFO - PROCESS | 15393 | |4;audio-oscillator;83;83;153;84;84;83;147;83;83;139 06:39:33 INFO - PROCESS | 15393 | |5;imaging-gaussian-blur;118;117;117;118;119;117;117;116;117;118 06:39:33 INFO - PROCESS | 15393 | |6;imaging-darkroom;148;147;146;146;147;146;150;147;146;147 06:39:33 INFO - PROCESS | 15393 | |7;imaging-desaturate;95;95;95;96;96;96;96;96;95;95 06:39:33 INFO - PROCESS | 15393 | |8;json-parse-financial;52;51;51;51;51;51;51;50;51;53 06:39:33 INFO - PROCESS | 15393 | |9;json-stringify-tinderbox;60;61;60;60;61;60;60;60;61;59 06:39:33 INFO - PROCESS | 15393 | |10;stanford-crypto-aes;73;73;73;73;72;73;73;72;76;73 06:39:33 INFO - PROCESS | 15393 | |11;stanford-crypto-ccm;125;120;122;122;122;130;119;120;159;132 06:39:33 INFO - PROCESS | 15393 | |12;stanford-crypto-pbkdf2;153;155;158;149;152;154;153;153;151;153 06:39:33 INFO - PROCESS | 15393 | |13;stanford-crypto-sha256-iterative;61;61;68;64;61;62;62;61;62;66 06:39:33 INFO - PROCESS | 15393 | __end_tp_report 06:39:33 INFO - PROCESS | 15393 | __start_cc_report 06:39:33 INFO - PROCESS | 15393 | _x_x_mozilla_cycle_collect,857 06:39:33 INFO - PROCESS | 15393 | __end_cc_report 06:39:33 INFO - PROCESS | 15393 | __startTimestamp1477575572999__endTimestamp 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | ------- Summary: start ------- 06:39:33 INFO - PROCESS | 15393 | Number of tests: 14 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.50 (3.2%) stddev-sans-first:1.58 06:39:33 INFO - PROCESS | 15393 | Values: 100.0 111.0 106.0 110.0 110.0 111.0 110.0 111.0 110.0 111.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:146.50 stddev:21.83 (14.9%) stddev-sans-first:23.07 06:39:33 INFO - PROCESS | 15393 | Values: 146.0 118.0 160.0 169.0 119.0 147.0 142.0 120.0 171.0 114.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 06:39:33 INFO - PROCESS | 15393 | Values: 161.0 161.0 161.0 161.0 161.0 161.0 164.0 162.0 163.0 162.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.50 stddev:40.28 (53.3%) stddev-sans-first:42.08 06:39:33 INFO - PROCESS | 15393 | Values: 75.0 74.0 78.0 165.0 76.0 75.0 75.0 76.0 177.0 77.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:83.00 stddev:30.64 (36.9%) stddev-sans-first:31.70 06:39:33 INFO - PROCESS | 15393 | Values: 83.0 83.0 153.0 84.0 84.0 83.0 147.0 83.0 83.0 139.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 06:39:33 INFO - PROCESS | 15393 | Values: 118.0 117.0 117.0 118.0 119.0 117.0 117.0 116.0 117.0 118.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 06:39:33 INFO - PROCESS | 15393 | Values: 148.0 147.0 146.0 146.0 147.0 146.0 150.0 147.0 146.0 147.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:39:33 INFO - PROCESS | 15393 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 06:39:33 INFO - PROCESS | 15393 | Values: 52.0 51.0 51.0 51.0 51.0 51.0 51.0 50.0 51.0 53.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 06:39:33 INFO - PROCESS | 15393 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 60.0 60.0 61.0 59.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:1.10 (1.5%) stddev-sans-first:1.17 06:39:33 INFO - PROCESS | 15393 | Values: 73.0 73.0 73.0 73.0 72.0 73.0 73.0 72.0 76.0 73.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:123.50 stddev:12.01 (9.7%) stddev-sans-first:12.72 06:39:33 INFO - PROCESS | 15393 | Values: 125.0 120.0 122.0 122.0 122.0 130.0 119.0 120.0 159.0 132.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:153.00 stddev:2.38 (1.6%) stddev-sans-first:2.52 06:39:33 INFO - PROCESS | 15393 | Values: 153.0 155.0 158.0 149.0 152.0 154.0 153.0 153.0 151.0 153.0 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - PROCESS | 15393 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.00 stddev:2.44 (3.9%) stddev-sans-first:2.50 06:39:33 INFO - PROCESS | 15393 | Values: 61.0 61.0 68.0 64.0 61.0 62.0 62.0 61.0 62.0 66.0 06:39:33 INFO - PROCESS | 15393 | -------- Summary: end -------- 06:39:33 INFO - PROCESS | 15393 | 06:39:33 INFO - TEST-INFO | 15393: exit 0 06:39:34 INFO - TEST-OK | kraken | took 60775ms 06:39:34 INFO - SUITE-END | took 1171s 06:39:34 INFO - Completed test suite (00:19:31) 06:39:34 INFO - javascript benchmark 06:39:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7753.603492706001, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3303.6035675718917, 3314.0, 3314.2874282029366, 3319.8340082995846, 3330.966690333096, 5683.090705487123, 5788.82633520994, 5839.270091238595, 5873.530117590588, 5875.823725288237, 5815.73829177687, 5887.8233652990375, 5892.175095486636, 5892.3812999635065, 5913.14259432382, 5287.656302340345, 5337.412884582693, 5337.6797392156595, 5344.946550534503, 5379.246905433242, 5400.594955378343, 5405.270288511059, 5405.648632838873, 5410.161424979135, 5411.594130440233, 5153.793848246066, 5295.602829787762, 5393.460653934595, 5404.7838086476495, 5429.321334833146, 5293.57651387888, 5358.196270559409, 5407.540359069484, 5418.674879507243, 5421.972890135564, 5276.3140791697215, 5346.786128554853, 5374.677519348852, 5374.811881584164, 5387.4073851876265, 5643.068893632546, 5736.426357364272, 5829.387914268983, 5888.97055514724, 5984.640921544721, 6155.476784473325, 6259.71831267594, 6291.5281353898645, 6304.7793327233785, 6316.778912738078, 6328.6835658216905, 6331.113644089831, 6331.55679102463, 6332.018537126753, 6338.651374174418, 5756.856078598027, 5810.680412577349, 5882.999890018665, 5886.823395298148, 5900.557458190653, 6375.968120159369, 6432.549721519542, 6480.351964803482, 6493.512986525935, 6495.7076931538195, 6165.630062196283, 6225.501959843202, 6232.3144454110015, 6234.189555357865, 6239.96880015597, 6121.112438696453, 6146.323904370515, 6254.906176407358, 6329.620222786648, 6330.905036424458, 6124.991279909952, 6180.351063138396, 6205.968970155121, 6208.906866397007, 6208.906866397007, 6201.751929922752, 6210.534209934273, 6210.72051757672, 6246.593971391845, 6264.373562643699, 4670.859874203779, 4698.718076915327, 4728.668993170514, 4729.787159577759, 4734.19518681825, 4180.16396720651, 4229.365595160751, 4246.426732391088, 4271.829126834954, 4288.5711428857485, 6047.274327080779, 6062.878742425127, 6085.817425477243, 6094.994325936171, 6106.694665266719, 6186.381361863778, 6224.62652240867, 6318.336574659686, 6386.489080873519, 6395.328490508523, 6047.78832740852, 6111.625222643455, 6130.6467468051915, 6132.110769107974, 6141.578063794062, 5273.235380869753, 5285.180796976475, 5305.098133317269, 5305.151175811929, 5323.3611966563485, 6335.588186767845, 6447.548671593037, 6507.577007494498, 6602.10871532337, 6633.170853643294, 6302.149209856702, 6379.979203327445, 6381.8723625528155, 6382.457491113308, 6383.042543618494, 6531.444827189552, 6552.541322107407, 6557.803265902031, 6584.209894812653, 6600.966995165186, 6046.455818976313, 6108.645631960618, 6152.323244443197, 6177.81466556004, 6230.937690623217, 6321.936780632135, 6346.904796427965, 6353.396427339396, 6359.20509936258, 6367.713452894538, 6183.474404675653, 6192.102145188832, 6194.287656919512, 6197.938020619736, 6241.687915604292, 5965.0, 6037.184980027816, 6090.695465226632, 6143.447089761943, 6152.446279834837, 6050.394960503914, 6089.056196289582, 6114.908276375769, 6116.694165291807, 6124.14262003311, 6104.20645316106, 6137.877242455215, 6138.815835524942, 6152.538559608137, 6228.28374736893, 5918.319393269829, 5971.581989260884, 6027.306859711014, 6072.969635151796, 6088.634681919099], "value": 5788.925558800906, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.988260234795, 632.4181752787435, 657.6875983907642, 658.0556900847284, 719.8092505486044, 42438.15123697528, 47482.762586187106, 47602.285965710544, 47654.0, 47709.52290477094, 46773.0, 47325.76337118318, 47371.763141184245, 47392.28911566329, 47490.76254618731, 9247.982721900586, 9405.529723513831, 9412.294077944147, 9421.104995025496, 9434.622615095388, 9391.201747851406, 9485.81028379432, 9492.430454172772, 9495.667651632195, 9506.619735210583, 9487.81024379512, 9496.762580935498, 9497.192738617226, 9506.762330941747, 9510.239180865514, 9429.339946203769, 9430.339876208702, 9435.43387396755, 9464.952675236615, 9481.573329200202, 9255.953720231422, 9365.063493650649, 9374.85937710935, 9420.057994200593, 9422.340436169403, 44088.77955610202, 44207.55792442099, 44373.33439998403, 44455.77772111151, 44531.77734111341, 3835.5780864104927, 3853.9229215415817, 3866.149447121629, 3882.2623701496627, 4038.818253178614, 34910.650893490994, 35120.0, 35654.0, 36243.16878639782, 36345.63654363449, 4864.173090574575, 4869.926951095701, 4923.089228492705, 5070.112730272224, 5146.408163061258, 362523.0, 362870.0, 362990.0, 363989.0, 365772.0, 38847.22305553873, 39898.0, 65145.0, 65509.0, 65562.67218663971, 41435.0, 41516.0, 41539.58460415357, 41561.58438415638, 41608.79195604063, 17176.398826041277, 17219.827801722073, 17318.307267709402, 17318.65362692739, 17352.219150138022, 13407.262600556867, 13445.932770336085, 13478.460861565427, 13484.730305393838, 13487.460501580023, 9196.448213107235, 9407.670731524364, 9466.95266523663, 9479.526023698925, 9530.857037144448, 3586.9103272418397, 3594.7663401879317, 3660.139867131222, 3663.432168013962, 3671.9816400918357, 1117.9664610061711, 1149.844770955927, 1162.773259214445, 1167.9735658632267, 1201.4053043743404, 34418.655813441546, 34997.300053999286, 35460.82269588687, 35535.644643553234, 36234.0, 1185.5731936502852, 1200.8979236764974, 1211.4064108586729, 1272.4592048379402, 1272.8345315109161, 17663.11684415774, 17954.0, 18476.722849157275, 18556.628867422845, 18711.438656840317, 606912.0, 618729.0, 620154.0, 621252.0, 625669.0, 43426.0, 43428.3485747714, 43474.782626086664, 43631.56368436275, 43704.0, 1477.4533422633478, 1489.3670190169134, 1489.8212214534108, 1515.5680631020327, 1518.468536012409, 33979.32041359208, 34047.319053619285, 34345.48481772726, 34385.312293753486, 34684.30631387408, 58998.705006474695, 59105.40894591171, 59341.0, 59386.0, 59463.405365945786, 495764.0, 496640.0, 496740.0, 501316.0, 502941.0, 31691.366172676877, 31954.520682189323, 32021.519677204393, 32285.51571726379, 32438.675613243566, 53403.19895201497, 53755.19367209417, 54268.0, 54364.184537232766, 55255.72372138114, 44906.326405104606, 45477.54522454733, 46733.766331169485, 47510.0, 47526.0, 44718.77640611776, 45881.0, 46164.7691761539, 46323.0, 46922.53077469182, 45064.0, 48489.5151048485, 48631.75684121557, 49053.0, 49169.50830491792, 38487.422688659135, 38497.6150238494, 39640.40539391854, 39743.40384894171, 40217.79891100526, 30312.393752125274, 30784.0, 30927.536086959164, 31325.0, 31412.0], "value": 20536.075078842692, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.19124503163783, 430.61890227149, 436.18651215483123, 438.16310846283596, 441.5804985263998, 19159.904200478995, 20185.49536261596, 20885.37343879682, 20905.686414703774, 21031.158753649837, 19523.5119122022, 19569.0, 19630.312939047137, 19749.50626234345, 19765.40703778889, 5885.32318783339, 6080.878382432349, 6081.574289799716, 6094.481969032638, 6114.296855861566, 5995.0, 6018.458338749511, 6032.547558933075, 6051.515878729691, 6082.604630699013, 5806.303243610772, 5977.432143946318, 5983.311919129291, 5991.85020374492, 5994.820155395345, 5880.970595147019, 5953.732082056296, 5962.552808539355, 5977.850553736148, 5984.491318237955, 5361.51746342831, 5400.135978243501, 5404.648697834628, 5406.91889621656, 5416.7020813855615, 24527.0, 24577.38556536083, 25152.748472515406, 25208.36979075538, 25721.485570288678, 2518.609615509599, 2525.848449093042, 2536.5687833068237, 2730.5358089124898, 3081.568580398746, 15121.621959450991, 15174.165420901845, 15636.0, 15856.207189640587, 15964.121973291465, 2060.577581595769, 2098.4963608733947, 2131.1475409836034, 2135.9252426165167, 2155.5473350596394, 84191.0, 86996.56501717515, 87072.0, 87527.0, 88391.0, 11028.062614677681, 11392.0, 11696.532138714527, 11761.411929403495, 11899.583514576949, 16341.428050018192, 16371.672566548841, 16375.181240937905, 16386.590335241715, 16389.0166590005, 8188.549629770419, 8209.302209312274, 8310.376721745894, 8361.707340243183, 8380.958095209608, 7738.61306934651, 7816.06207255133, 7904.4071694623135, 8257.42198046143, 8265.380096492787, 6983.546069505567, 7100.680469378787, 7139.357457828821, 7171.677274522659, 7271.709131634781, 2056.8505911322704, 2111.546017606222, 2113.725215721977, 2114.1966052900107, 2159.2010955946084, 1025.6307729217476, 1056.6565866093551, 1098.7692584557333, 1108.695108845058, 1150.039716836451, 20879.478013049797, 21227.78772212289, 21309.041093150845, 21370.679439808417, 21729.782702173092, 1068.3643232276784, 1098.132475344469, 1102.5699977008974, 1123.1295745797072, 1153.3253046967618, 11237.157213209042, 11781.293122412682, 11887.0, 11914.046876249879, 11919.70200744971, 561652.0, 568656.0, 576366.0, 578120.0, 578372.0, 46506.534934650896, 83896.58051709825, 86435.0, 86958.0, 88615.0, 1105.1159072741614, 1109.8557187565564, 1114.2367478277245, 1125.606037886733, 1129.785340785248, 16988.66022679564, 18704.7194292083, 18789.154488048345, 18818.341358052403, 18958.90739187761, 31668.208294792814, 41785.0, 41846.0, 41981.79009104935, 42354.152916942105, 52714.47285527096, 55089.72455137699, 55211.723941380034, 56122.71938640281, 57331.0, 9150.633974641207, 9289.0, 9362.625494980124, 9504.95247523758, 9568.61725530971, 14151.858481415466, 14152.009359344747, 14390.640233994234, 14458.06022608527, 14604.12375257488, 12375.133740638068, 12678.746425071631, 12696.873031269939, 12773.297468639314, 12795.61613151607, 12438.067144963983, 12470.0, 12488.937555312164, 12567.057470689917, 12613.49546018149, 12629.2422454653, 12792.872071279167, 12841.0, 12863.035272354424, 13271.469141234242, 9128.589213485542, 9131.908680913106, 9183.219426348835, 9215.86176207344, 9296.163345298955, 12611.30637814929, 12622.55821046259, 12681.23912565212, 12725.681857953625, 12768.297743624189], "value": 9962.769276414308, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.8340282568915, 1580.5179420276816, 1745.9912700436496, 1846.1323178106302, 1878.7651543557065, 7901.960490197541, 8581.570921453933, 9143.679971201009, 9196.218321442686, 9221.35450518464, 9275.628974841014, 9586.281028922842, 9605.855912161305, 9615.567299471522, 9652.903470965306, 2373.501564671421, 2420.1408499982517, 2422.6608274841537, 2424.1757802347197, 2425.1148330859287, 2515.2705715342527, 2523.1295203154973, 2570.9742902571015, 2573.2794817451145, 2579.1746641074865, 2465.716442609105, 2472.8887200076038, 2547.426828963487, 2548.7706106450414, 2550.1457011901034, 2471.789897858684, 2474.6288056791536, 2486.477839653675, 2503.5869081601513, 2506.0727530813533, 2455.3616059824394, 2460.5447992121517, 2461.679981602398, 2468.148488771371, 2507.185164821422, 9685.612575496973, 9747.61009559624, 9750.366226195345, 9752.219822414261, 9762.36544624597, 5609.1305847593685, 5657.010023245956, 5721.599488035839, 5729.28383952006, 5740.052891272935, 3532.205253817896, 3566.375884220251, 3602.1174812171184, 3691.5570131584113, 3719.962800372016, 1172.3434876469119, 1207.5290636651712, 1224.7856625090574, 1241.30486927321, 1254.6236129161216, 12808.807867881897, 12915.160514566523, 12950.611481655566, 12972.091953563255, 12983.480660773557, 4855.393075865517, 5025.648204625714, 5031.4213865405945, 5162.767675454614, 5181.611379146504, 10707.892921070845, 10714.089302409227, 10764.40795756241, 10778.299410538446, 10817.188710846718, 5737.168110624019, 5747.195392645033, 5754.223179870748, 5754.971225143931, 5755.050416681284, 5151.407588127338, 5324.387695414999, 5366.892662146735, 5367.892642147213, 5412.83761487156, 4095.8102581162634, 4119.670426365884, 4130.153318569686, 4171.249175148502, 4178.791060446965, 1210.1045226532478, 1219.969500762488, 1224.0391292835081, 1226.791445454275, 1236.7031912341154, 1021.9846702299471, 1032.4115254305125, 1032.7882784029407, 1043.446973104256, 1054.1408751867357, 6488.67556622167, 6527.673616319165, 6533.575317604341, 6548.508861835287, 6607.041978913031, 487.75855951304334, 496.33491121896833, 504.7274471785268, 507.05181310948024, 512.4337606944347, 4407.669424793089, 4508.864734057984, 4551.908961820745, 4636.652251081183, 4639.280911458729, 11370.94314528422, 11691.064714822964, 12137.211081279866, 12140.089493288038, 12182.086343524272, 11818.527258909719, 12076.758464830655, 12104.697382565506, 12111.454984525717, 12164.2701437914, 8826.823463530693, 8908.599113039929, 8935.955320223487, 8986.640534378683, 8988.011318754932, 6277.30949595535, 6558.80323590293, 6687.431568316748, 6720.495962802907, 6780.72877084911, 10837.945810271214, 10999.560017599206, 11050.226484146033, 11050.889491104987, 11159.944200278947, 10836.67489975302, 10928.617498387519, 11065.170112241452, 11254.94372528132, 11385.089192864385, 7463.813404664927, 8149.266566009088, 8334.49993000422, 8346.749597512084, 8503.787405314917, 9227.953860230657, 9251.444913305224, 9262.16640502358, 9281.39670921388, 9293.814123717622, 8284.544350060805, 8299.751007469786, 8381.413301068867, 8412.116727743498, 8448.366372522209, 8035.758927232192, 8088.9595552021865, 8111.269985701315, 8121.837563248584, 8166.4283500154415, 7386.704531818882, 7482.326590606872, 7638.8090297743, 7730.18833022547, 7731.342835859015, 5630.380658127685, 5687.800926967537, 5714.457126572969, 5733.168690539765, 5815.982203114522, 5751.137329400456, 5818.738156782871, 5828.912566311594, 5924.407559244041, 5928.525717942641], "value": 4911.6339160378675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.8380936673813, 356.44750636513396, 359.8146954318528, 365.05997057576747, 366.6718287133016, 5754.4533269339345, 5770.624909380887, 5802.303723553175, 5809.796657117002, 5839.153322768207, 5616.438356164382, 5655.321361436623, 5702.54379649628, 5721.5708821838425, 5731.45551172639, 4495.0, 4500.797464114106, 4541.978819425357, 4548.476260452752, 4571.839985600504, 4543.136804007228, 4552.521985191557, 4559.088182363524, 4569.469227808688, 4589.0, 4431.88920276994, 4495.887602809923, 4535.909281814362, 4555.111753208126, 4556.521565235652, 4476.462824461053, 4496.572825581581, 4516.774161291923, 4529.026259354222, 4532.818687252539, 4042.151148258869, 4043.2317859606874, 4053.2906741320153, 4060.4112403701592, 4068.5524592294823, 5601.551875849922, 5668.26312579362, 5677.176809362661, 5677.290338707661, 5698.743556539925, 4885.951140488585, 5149.742512874342, 5178.275041494194, 5201.687898726089, 5214.791408343662, 6030.246219222598, 6079.300880398767, 6096.0, 6114.724837382329, 6126.724297406583, 4156.418101465797, 4413.249747542925, 4419.4033805436175, 4424.424824772759, 4425.15921974827, 6033.547483938678, 6191.226096737908, 6235.7505699771955, 6299.0, 6315.957866951948, 4435.935375509919, 4471.530489298577, 4478.888027799331, 4507.301368287921, 4508.616767574793, 4548.818047278071, 4572.6739245619065, 4572.97713511437, 4583.089738016383, 4584.17484852723, 5001.89996200074, 5178.585713142939, 5206.140986737221, 5237.502437268529, 5251.396089449686, 6062.696865156725, 6073.6659483727935, 6074.696265186723, 6081.27024757032, 6082.817515474543, 1554.3083327919194, 1567.1694002178863, 1577.7081239970641, 1579.9052056876624, 1581.8734501239874, 963.3978763272954, 1003.3895597565802, 1003.909648131657, 1004.638330201127, 1018.2414101494286, 5200.3878797572115, 5203.895922081537, 5215.634905556651, 5231.686098834082, 5248.60635452335, 5411.594130440233, 5433.293671822637, 5490.654789576579, 5491.697956612425, 5521.889562208733, 4936.728479933567, 5220.947790522122, 5244.868878278074, 5245.895082098336, 5263.868268322252, 2903.3015685823607, 2920.693327200656, 2926.6049083373896, 2933.398653276073, 2945.911622651324, 5595.7057606382, 5610.87782443513, 5622.28520301312, 5646.2377579027125, 5662.405447428043, 5866.941330586725, 6350.936490635127, 6370.642862141038, 6397.552171348054, 6398.392152745481, 6495.64273964927, 6520.250171230275, 6523.575967562093, 6528.37980391862, 6569.408753212234, 6057.848553786191, 6184.196054513064, 6271.874562508816, 6302.180716506825, 6325.0, 6170.81487555374, 6231.416935262333, 6236.314005459487, 6284.591501552384, 6300.243970723543, 6321.462675672619, 6527.640979746159, 6538.215414150142, 6547.544670748469, 6587.736490540325, 4512.9097418052115, 4537.319402089713, 4549.431321084864, 4559.566841150086, 4578.6108180805, 6190.473809726043, 6263.029230469285, 6324.177856878577, 6375.8204732124705, 6403.8399040022505, 6107.175531303395, 6109.0, 6119.959606866754, 6141.631502109888, 6149.41580549847, 5891.823245302648, 6128.9693551531955, 6136.754529818936, 6156.230471191101, 6219.284782249918, 6078.3921607838865, 6095.420935011167, 6132.78535251264, 6136.631802091889, 6143.139960405636, 6070.544709146743, 6154.507639388748, 6161.0, 6172.0, 6215.627062376272, 5813.372255768391, 6004.189434426296, 6007.008843540767, 6013.849653758691, 6040.365761595145], "value": 4576.712143617209, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.7843471480063, 823.0781524692342, 878.6968495868925, 891.7235656946345, 916.042735341568, 16698.415555455562, 17210.39763608274, 17550.297988080492, 17704.82295177048, 17802.28790848366, 17467.213975371105, 17579.56051098723, 17584.824151758512, 17605.471835844946, 17634.559136021606, 862.9439086459391, 881.0968757024069, 881.1144799476517, 881.1364862434817, 881.378628067211, 858.7252079334615, 888.4314039015036, 891.2513488669516, 893.0712059458156, 893.3746377535718, 923.4690053219392, 929.0384452092086, 936.1574582875398, 937.1612406895824, 937.9108984646448, 930.6510058727944, 931.9394239374453, 933.8272419602396, 933.9206167475738, 934.1312579301247, 686.9622170780605, 687.4946914018193, 688.5455599304435, 689.2659317826499, 690.0787448755917, 15758.76361854573, 15799.684006319923, 15802.288896999662, 15851.841481585267, 15891.443799467079, 15882.523524294289, 16053.277602507915, 16238.512844614681, 16337.34650613974, 16564.171791410383, 12952.0, 13085.607431777062, 13120.343982800821, 13262.3368831559, 13424.328783560783, 4102.958970410287, 4139.151473947833, 4143.7928103594695, 4150.252954468195, 4235.02594403289, 71449.28550714478, 74108.99999999946, 84797.57601212016, 86306.0, 86474.56762716209, 13166.47334106625, 13170.670733231746, 13197.406116724771, 13329.333533323295, 13372.058207078237, 23544.0, 23710.644340334908, 23811.880940595533, 23834.40413989664, 23839.52320953606, 9308.90691093094, 9318.39430437033, 9328.486933218603, 9399.34204605671, 9436.150746432853, 4829.782659780319, 5050.924236136461, 5066.012127635149, 5113.744312784346, 5114.105031619451, 4174.519930208005, 4458.108378324348, 4458.219811532968, 4502.954970450253, 4505.0, 749.1160430691835, 754.9358304544065, 757.3373298363931, 764.5833021003566, 765.1124695353363, 714.2250658036089, 731.3454458259934, 734.4051318432087, 738.6306846576712, 741.5439504704568, 10157.492125393848, 10557.788844223072, 10565.9471702641, 10767.676969690921, 10778.568857245622, 688.9621070841051, 787.2481779900181, 792.8969233999659, 802.2579114319232, 824.4970567953544, 4888.437829649564, 4999.900101896045, 5011.086033586187, 5087.236914462786, 5104.668196567211, 78426.21573784303, 78498.0, 79097.60451197707, 100566.0, 118626.40686796511, 111230.44384778025, 112416.0, 118922.0, 119805.0, 121949.0, 100594.4970275144, 100825.47110851231, 100956.0, 101409.0, 101865.0, 9413.48225847585, 9440.716778496657, 9684.612615495302, 9726.221902247662, 9803.0, 58028.70985645045, 58386.708066459396, 58958.0, 59255.40744592499, 59691.70154149202, 78329.60835195788, 79657.60171199107, 88245.35263942092, 90075.54962225146, 91183.54408227916, 12953.352332383154, 13155.934220328838, 13177.93411032977, 13604.387802549107, 13916.615689141523, 14603.123812571279, 14663.193524356262, 14686.779698304748, 14915.552533424014, 15026.0, 13600.795988060385, 13761.0, 13821.516246931309, 14242.216678082805, 14365.209913454442, 13354.198748075147, 13756.931215343859, 14614.19621920762, 14751.409943602135, 14785.852141478448, 13234.602961910772, 13304.401301941629, 13811.309434528433, 13982.720345593234, 14207.644808879448, 9723.756906077404, 10234.283600147919, 10387.636432724817, 10418.114460270961, 10448.843267350843, 10685.679429617125, 10891.346519208873, 10977.12183025372, 11073.0, 11108.888911110786], "value": 8160.302275446899, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1495.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 106.0, 110.0, 110.0, 111.0, 110.0, 111.0, 110.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 118.0, 160.0, 169.0, 119.0, 147.0, 142.0, 120.0, 171.0, 114.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 164.0, 162.0, 163.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 165.0, 76.0, 75.0, 75.0, 76.0, 177.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 153.0, 84.0, 84.0, 83.0, 147.0, 83.0, 83.0, 139.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 150.0, 147.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0, 50.0, 51.0, 53.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 59.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 72.0, 73.0, 73.0, 72.0, 76.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 120.0, 122.0, 122.0, 122.0, 130.0, 119.0, 120.0, 159.0, 132.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 158.0, 149.0, 152.0, 154.0, 153.0, 153.0, 151.0, 153.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 68.0, 64.0, 61.0, 62.0, 62.0, 61.0, 62.0, 66.0], "value": 62.8, "unit": "score"}]}]} 06:39:34 INFO - Return code: 0 06:39:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:39:34 ERROR - # TBPL SUCCESS # 06:39:34 INFO - Running post-action listener: _resource_record_post_action 06:39:34 INFO - [mozharness: 2016-10-27 13:39:34.302319Z] Finished run-tests step (success) 06:39:34 INFO - Running post-run listener: _resource_record_post_run 06:39:34 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288378880; Read time: 16; Write time: 160440 06:39:34 INFO - TinderboxPrint: CPU usage
13.2% 06:39:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:39:34 INFO - TinderboxPrint: I/O write bytes / time
288,378,880 / 160,440 06:39:34 INFO - TinderboxPrint: CPU idle
8,216.2 (86.8%) 06:39:34 INFO - TinderboxPrint: CPU user
1,195.0 (12.6%) 06:39:34 INFO - TinderboxPrint: Swap in / out
0 / 0 06:39:34 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70135808; Read time: 0; Write time: 50884 06:39:34 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 218243072; Read time: 0; Write time: 109556 06:39:34 INFO - Running post-run listener: _upload_blobber_files 06:39:34 INFO - Blob upload gear active. 06:39:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:39:34 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 06:39:34 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'] 06:39:34 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 06:39:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:39:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:39:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:39:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:36 INFO - (blobuploader) - INFO - Done attempting. 06:39:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:39:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:40 INFO - (blobuploader) - INFO - Done attempting. 06:39:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:39:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:39:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:39:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:39:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:39:41 INFO - (blobuploader) - INFO - Done attempting. 06:39:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:39:41 INFO - Return code: 0 06:39:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:39:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:39:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9accec101937d3b9131810f425190455e46ce1d405bbd2ab82d5cf7445bea6edd8a1f40581bcec9f30accd344f786321513bdf5d1ff53f9ba4e0661aa1473733", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffd9be3f23c50510d68573fcf86b57910f2b53a3bf1c40f7977eb5aadfdb1618ac67d5fca908ae1be0454dfedac6bec28c2f76b7257d5a5673931ba3f83f75f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f82daa6afcf33db3a8a30390316a9081c86f380818dbe9ec1b9b300605e1ef513476b6069939626d1705fea47ffcfc3450d8de115d64b0ab7e00fb8c27d6651"} 06:39:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:39:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:39:41 INFO - Contents: 06:39:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9accec101937d3b9131810f425190455e46ce1d405bbd2ab82d5cf7445bea6edd8a1f40581bcec9f30accd344f786321513bdf5d1ff53f9ba4e0661aa1473733", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffd9be3f23c50510d68573fcf86b57910f2b53a3bf1c40f7977eb5aadfdb1618ac67d5fca908ae1be0454dfedac6bec28c2f76b7257d5a5673931ba3f83f75f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f82daa6afcf33db3a8a30390316a9081c86f380818dbe9ec1b9b300605e1ef513476b6069939626d1705fea47ffcfc3450d8de115d64b0ab7e00fb8c27d6651"} 06:39:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:39:41 INFO - Copying logs to upload dir... 06:39:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:39:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.616298 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-10-27 06:39:41.357006) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 06:39:41.360752) ========= 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=41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420 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/9accec101937d3b9131810f425190455e46ce1d405bbd2ab82d5cf7445bea6edd8a1f40581bcec9f30accd344f786321513bdf5d1ff53f9ba4e0661aa1473733", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffd9be3f23c50510d68573fcf86b57910f2b53a3bf1c40f7977eb5aadfdb1618ac67d5fca908ae1be0454dfedac6bec28c2f76b7257d5a5673931ba3f83f75f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f82daa6afcf33db3a8a30390316a9081c86f380818dbe9ec1b9b300605e1ef513476b6069939626d1705fea47ffcfc3450d8de115d64b0ab7e00fb8c27d6651"} build_url:https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/NUMy7VlYR3WKCZ7HISXUUw/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/9accec101937d3b9131810f425190455e46ce1d405bbd2ab82d5cf7445bea6edd8a1f40581bcec9f30accd344f786321513bdf5d1ff53f9ba4e0661aa1473733", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ffd9be3f23c50510d68573fcf86b57910f2b53a3bf1c40f7977eb5aadfdb1618ac67d5fca908ae1be0454dfedac6bec28c2f76b7257d5a5673931ba3f83f75f0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f82daa6afcf33db3a8a30390316a9081c86f380818dbe9ec1b9b300605e1ef513476b6069939626d1705fea47ffcfc3450d8de115d64b0ab7e00fb8c27d6651"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-27 06:39:41.385766) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 06:39:41.386098) ========= 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=41a7e32711b8e08598a63237000001d6-1477573886.574018-1941828420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 06:39:41.470237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 06:39:41.470553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-27 06:39:41.470888) ========= ========= Total master_lag: 0.17 =========