builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1476312075.2 results: success (0) buildid: 20161012123846 builduid: 9bb06a896f05404a996b58ea9abb0176 revision: 9f64850761cb6c55b53b379bfd125140e00033e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:15.201933) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:15.202338) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:15.202610) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:15.216874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:15.217134) ========= 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=1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 15:41:15-- 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% 32.5M=0s 2016-10-12 15:41:15 (32.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089748 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:15.321760) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:15.322073) ========= 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=1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022081 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:15.371446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 15:41:15.371807) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9f64850761cb6c55b53b379bfd125140e00033e9 --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 9f64850761cb6c55b53b379bfd125140e00033e9 --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=1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 15:41:15,666 truncating revision to first 12 chars 2016-10-12 15:41:15,666 Setting DEBUG logging. 2016-10-12 15:41:15,666 attempt 1/10 2016-10-12 15:41:15,666 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9f64850761cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 15:41:16,827 unpacking tar archive at: mozilla-beta-9f64850761cb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.510050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 15:41:16.895046) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:16.895378) ========= script_repo_revision: 9f64850761cb6c55b53b379bfd125140e00033e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:16.895800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:16.896076) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 15:41:16.903628) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-10-12 15:41:16.903913) ========= /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=1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:41:17 INFO - MultiFileLogger online at 20161012 15:41:17 in /builds/slave/test 15:41:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:41:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:41:17 INFO - {'append_to_log': False, 15:41:17 INFO - 'base_work_dir': '/builds/slave/test', 15:41:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:41:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:41:17 INFO - 'branch': 'Mozilla-Beta', 15:41:17 INFO - 'buildbot_json_path': 'buildprops.json', 15:41:17 INFO - 'config_files': ('talos/linux_config.py',), 15:41:17 INFO - 'default_actions': ('clobber', 15:41:17 INFO - 'read-buildbot-config', 15:41:17 INFO - 'download-and-extract', 15:41:17 INFO - 'populate-webroot', 15:41:17 INFO - 'create-virtualenv', 15:41:17 INFO - 'install', 15:41:17 INFO - 'run-tests'), 15:41:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:41:17 INFO - 'download_minidump_stackwalk': True, 15:41:17 INFO - 'download_symbols': 'ondemand', 15:41:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:41:17 INFO - 'tooltool.py': '/tools/tooltool.py', 15:41:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:41:17 INFO - '/tools/misc-python/virtualenv.py')}, 15:41:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:41:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:41:17 INFO - 'installer_path': 'installer.exe', 15:41:17 INFO - 'log_level': 'info', 15:41:17 INFO - 'log_name': 'talos', 15:41:17 INFO - 'log_to_console': True, 15:41:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:41:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:41:17 INFO - 'opt_config_files': (), 15:41:17 INFO - 'pip_index': False, 15:41:17 INFO - 'sps_profile': False, 15:41:17 INFO - 'sps_profile_interval': 0, 15:41:17 INFO - 'suite': 'dromaeojs-e10s', 15:41:17 INFO - 'system_bits': '32', 15:41:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:41:17 INFO - 'title': 'talos-linux64-ix-027', 15:41:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:41:17 INFO - 'use_talos_json': True, 15:41:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:41:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:41:17 INFO - 'work_dir': 'build'} 15:41:17 INFO - [mozharness: 2016-10-12 22:41:17.288606Z] Running clobber step. 15:41:17 INFO - Running pre-action listener: _resource_record_pre_action 15:41:17 INFO - Running main action method: clobber 15:41:17 INFO - rmtree: /builds/slave/test/build 15:41:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:41:17 INFO - Running post-action listener: _resource_record_post_action 15:41:17 INFO - [mozharness: 2016-10-12 22:41:17.751461Z] Finished clobber step (success) 15:41:17 INFO - [mozharness: 2016-10-12 22:41:17.751562Z] Running read-buildbot-config step. 15:41:17 INFO - Running pre-action listener: _resource_record_pre_action 15:41:17 INFO - Running main action method: read_buildbot_config 15:41:17 INFO - Using buildbot properties: 15:41:17 INFO - { 15:41:17 INFO - "project": "", 15:41:17 INFO - "product": "firefox", 15:41:17 INFO - "script_repo_revision": "production", 15:41:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:41:17 INFO - "repository": "", 15:41:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 15:41:17 INFO - "buildid": "20161012123846", 15:41:17 INFO - "pgo_build": "True", 15:41:17 INFO - "basedir": "/builds/slave/test", 15:41:17 INFO - "buildnumber": 151, 15:41:17 INFO - "slavename": "talos-linux64-ix-027", 15:41:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:41:17 INFO - "platform": "ubuntu64_hw", 15:41:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:41:17 INFO - "branch": "mozilla-beta", 15:41:17 INFO - "repo_path": "releases/mozilla-beta", 15:41:17 INFO - "revision": "9f64850761cb6c55b53b379bfd125140e00033e9", 15:41:17 INFO - "stage_platform": "linux64-pgo", 15:41:17 INFO - "builduid": "9bb06a896f05404a996b58ea9abb0176", 15:41:17 INFO - "slavebuilddir": "test" 15:41:17 INFO - } 15:41:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 15:41:17 INFO - Running post-action listener: _resource_record_post_action 15:41:17 INFO - [mozharness: 2016-10-12 22:41:17.753999Z] Finished read-buildbot-config step (success) 15:41:17 INFO - [mozharness: 2016-10-12 22:41:17.754088Z] Running download-and-extract step. 15:41:17 INFO - Running pre-action listener: _resource_record_pre_action 15:41:17 INFO - Running main action method: download_and_extract 15:41:17 INFO - mkdir: /builds/slave/test/build/tests 15:41: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')]} 15:41:17 INFO - https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:41:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:41:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:41:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:41:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:41:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:41:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:41:17 INFO - retry: Failed, sleeping 30 seconds before retrying 15:41:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 15:41:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:41:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:41:47 INFO - retry: Failed, sleeping 60 seconds before retrying 15:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 15:42:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:42:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:42:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 15:42:47 INFO - Caught exception: HTTP Error 404: Not Found 15:42:47 INFO - Caught exception: HTTP Error 404: Not Found 15:42:47 INFO - Caught exception: HTTP Error 404: Not Found 15:42:47 INFO - trying https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:42:47 INFO - Downloading https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:42:48 INFO - Downloaded 1327 bytes. 15:42:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 15:42:48 INFO - Using the following test package requirements: 15:42:48 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:42:48 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:42:48 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:42:48 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:42:48 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 15:42:48 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:42:48 INFO - u'jsshell-linux-x86_64.zip'], 15:42:48 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:42:48 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:42:48 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 15:42:48 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:42:48 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 15:42:48 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:42:48 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 15:42:48 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:42:48 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:42:48 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 15:42:48 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:42:48 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:42:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:48 INFO - https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:42:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:42:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:42:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:42:48 INFO - retry: Failed, sleeping 30 seconds before retrying 15:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 15:43:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:43:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:43:18 INFO - retry: Failed, sleeping 60 seconds before retrying 15:44:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 15:44:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:44:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:44:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 15:44:18 INFO - Caught exception: HTTP Error 404: Not Found 15:44:18 INFO - Caught exception: HTTP Error 404: Not Found 15:44:18 INFO - Caught exception: HTTP Error 404: Not Found 15:44:18 INFO - trying https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:44:18 INFO - Downloading https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:44:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:44:19 INFO - Downloaded 21774066 bytes. 15:44:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:44:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:44:20 INFO - Return code: 0 15:44:20 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:44:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:20 INFO - https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:44:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:44:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:44:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:44:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:44:20 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:44:20 INFO - retry: Failed, sleeping 30 seconds before retrying 15:44:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 15:44:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:44:50 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:44:50 INFO - retry: Failed, sleeping 60 seconds before retrying 15:45:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 15:45:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:45:50 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:45:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 15:45:50 INFO - Caught exception: HTTP Error 404: Not Found 15:45:50 INFO - Caught exception: HTTP Error 404: Not Found 15:45:50 INFO - Caught exception: HTTP Error 404: Not Found 15:45:50 INFO - trying https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:45:50 INFO - Downloading https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 15:45:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:45:51 INFO - Downloaded 21774066 bytes. 15:45:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:45:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:45:53 INFO - Return code: 0 15:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:53 INFO - https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:45:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:45:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:45:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:45:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:45:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:45:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:45:53 INFO - retry: Failed, sleeping 30 seconds before retrying 15:46:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 15:46:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:46:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:46:23 INFO - retry: Failed, sleeping 60 seconds before retrying 15:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 15:47:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:47:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:47:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 15:47:23 INFO - Caught exception: HTTP Error 404: Not Found 15:47:23 INFO - Caught exception: HTTP Error 404: Not Found 15:47:23 INFO - Caught exception: HTTP Error 404: Not Found 15:47:23 INFO - trying https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:47:23 INFO - Downloading https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 15:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:47:24 INFO - Downloaded 14413740 bytes. 15:47:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:47:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:47:24 INFO - Return code: 0 15:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:47:24 INFO - https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:47:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:47:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:47:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:47:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:47:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:47:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:47:24 INFO - retry: Failed, sleeping 30 seconds before retrying 15:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 15:47:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:47:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:47:54 INFO - retry: Failed, sleeping 60 seconds before retrying 15:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 15:48:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:48:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:48:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 15:48:54 INFO - Caught exception: HTTP Error 404: Not Found 15:48:54 INFO - Caught exception: HTTP Error 404: Not Found 15:48:54 INFO - Caught exception: HTTP Error 404: Not Found 15:48:54 INFO - trying https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:48:54 INFO - Downloading https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:48:55 INFO - Downloaded 56797497 bytes. 15:48:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:48:55 INFO - mkdir: /builds/slave/test/properties 15:48:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:55 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:55 INFO - Contents: 15:48:55 INFO - build_url:https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 15:48:56 INFO - Running post-action listener: _resource_record_post_action 15:48:56 INFO - Running post-action listener: set_extra_try_arguments 15:48:56 INFO - [mozharness: 2016-10-12 22:48:56.182377Z] Finished download-and-extract step (success) 15:48:56 INFO - [mozharness: 2016-10-12 22:48:56.182609Z] Running populate-webroot step. 15:48:56 INFO - Running pre-action listener: _resource_record_pre_action 15:48:56 INFO - Running main action method: populate_webroot 15:48:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:48:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:48:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:48:56 INFO - '--tppagecycles', 15:48:56 INFO - '7'], 15:48:56 INFO - 'tests': ['tsvgm']}}, 15:48:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:48:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:48:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:56 INFO - 'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:56 INFO - 'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['damp', 'tps']}, 15:48:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:56 INFO - 'tests': ['damp', 'tps']}, 15:48:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['dromaeo_dom']}, 15:48:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['basic_compositor_video']}, 15:48:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:48:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['a11yr', 15:48:56 INFO - 'ts_paint', 15:48:56 INFO - 'tpaint', 15:48:56 INFO - 'sessionrestore', 15:48:56 INFO - 'sessionrestore_no_auto_restore', 15:48:56 INFO - 'tabpaint']}, 15:48:56 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:56 INFO - 'ts_paint', 15:48:56 INFO - 'tpaint', 15:48:56 INFO - 'sessionrestore', 15:48:56 INFO - 'sessionrestore_no_auto_restore', 15:48:56 INFO - 'tabpaint']}, 15:48:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:48:56 INFO - 'ts_paint', 15:48:56 INFO - 'tpaint', 15:48:56 INFO - 'sessionrestore', 15:48:56 INFO - 'sessionrestore_no_auto_restore', 15:48:56 INFO - 'tabpaint']}, 15:48:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:48:56 INFO - 'ts_paint', 15:48:56 INFO - 'tpaint', 15:48:56 INFO - 'sessionrestore', 15:48:56 INFO - 'sessionrestore_no_auto_restore', 15:48:56 INFO - 'tabpaint']}, 15:48:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['a11yr', 15:48:56 INFO - 'ts_paint', 15:48:56 INFO - 'tpaint', 15:48:56 INFO - 'sessionrestore', 15:48:56 INFO - 'sessionrestore_no_auto_restore', 15:48:56 INFO - 'tabpaint']}, 15:48:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['a11yr', 15:48:56 INFO - 'ts_paint', 15:48:56 INFO - 'tpaint', 15:48:56 INFO - 'sessionrestore', 15:48:56 INFO - 'sessionrestore_no_auto_restore', 15:48:56 INFO - 'tabpaint']}, 15:48:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['tsvgx', 15:48:56 INFO - 'tsvgr_opacity', 15:48:56 INFO - 'tart', 15:48:56 INFO - 'tscrollx', 15:48:56 INFO - 'cart']}, 15:48:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:56 INFO - 'tsvgr_opacity', 15:48:56 INFO - 'tart', 15:48:56 INFO - 'tscrollx', 15:48:56 INFO - 'cart']}, 15:48:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:56 INFO - 'talos_options': ['--disable-e10s'], 15:48:56 INFO - 'tests': ['tp5o']}, 15:48:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:56 INFO - 'tests': ['tp5o']}, 15:48:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:56 INFO - 'talos_options': ['--disable-e10s', 15:48:56 INFO - '--xperf_path', 15:48:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:56 INFO - 'tests': ['tp5n']}, 15:48:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:56 INFO - 'talos_options': ['--xperf_path', 15:48:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:56 INFO - 'tests': ['tp5n']}}, 15:48:56 INFO - 'talos.zip': {'path': '', 15:48:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:48:56 INFO - Running post-action listener: _resource_record_post_action 15:48:56 INFO - [mozharness: 2016-10-12 22:48:56.201884Z] Finished populate-webroot step (success) 15:48:56 INFO - [mozharness: 2016-10-12 22:48:56.201973Z] Running create-virtualenv step. 15:48:56 INFO - Running pre-action listener: _resource_record_pre_action 15:48:56 INFO - Running main action method: create_virtualenv 15:48:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:48:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:48:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:56 INFO - Using real prefix '/usr' 15:48:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:56 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:58 INFO - Installing pip.................done. 15:48:58 INFO - Return code: 0 15:48:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:58 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, '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': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:48:58 INFO - Using env: {'DISPLAY': ':0', 15:48:58 INFO - 'HOME': '/home/cltbld', 15:48:58 INFO - 'LANG': 'en_US.UTF-8', 15:48:58 INFO - 'LANGUAGE': 'en_US:en', 15:48:58 INFO - 'LOGNAME': 'cltbld', 15:48:58 INFO - 'MAIL': '/var/mail/cltbld', 15:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:58 INFO - 'MOZ_NO_REMOTE': '1', 15:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:58 INFO - 'NO_EM_RESTART': '1', 15:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:58 INFO - 'PWD': '/builds/slave/test', 15:48:58 INFO - 'SHELL': '/bin/bash', 15:48:58 INFO - 'SHLVL': '1', 15:48:58 INFO - 'TERM': 'linux', 15:48:58 INFO - 'TMOUT': '86400', 15:48:58 INFO - 'USER': 'cltbld', 15:48:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:58 INFO - '_': '/tools/buildbot/bin/python'} 15:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:48:58 INFO - Cleaning up... 15:48:58 INFO - Return code: 0 15:48:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:58 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, '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': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:48:58 INFO - Using env: {'DISPLAY': ':0', 15:48:58 INFO - 'HOME': '/home/cltbld', 15:48:58 INFO - 'LANG': 'en_US.UTF-8', 15:48:58 INFO - 'LANGUAGE': 'en_US:en', 15:48:58 INFO - 'LOGNAME': 'cltbld', 15:48:58 INFO - 'MAIL': '/var/mail/cltbld', 15:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:58 INFO - 'MOZ_NO_REMOTE': '1', 15:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:58 INFO - 'NO_EM_RESTART': '1', 15:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:58 INFO - 'PWD': '/builds/slave/test', 15:48:58 INFO - 'SHELL': '/bin/bash', 15:48:58 INFO - 'SHLVL': '1', 15:48:58 INFO - 'TERM': 'linux', 15:48:58 INFO - 'TMOUT': '86400', 15:48:58 INFO - 'USER': 'cltbld', 15:48:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:58 INFO - '_': '/tools/buildbot/bin/python'} 15:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:59 INFO - Downloading/unpacking psutil>=3.1.1 15:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:01 INFO - Installing collected packages: psutil 15:49:01 INFO - Running setup.py install for psutil 15:49:01 INFO - building 'psutil._psutil_linux' extension 15:49:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:49:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:49:01 INFO - building 'psutil._psutil_posix' extension 15:49:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:49:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:49:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:01 INFO - Successfully installed psutil 15:49:01 INFO - Cleaning up... 15:49:01 INFO - Return code: 0 15:49:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:01 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, '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': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:49:01 INFO - Using env: {'DISPLAY': ':0', 15:49:01 INFO - 'HOME': '/home/cltbld', 15:49:01 INFO - 'LANG': 'en_US.UTF-8', 15:49:01 INFO - 'LANGUAGE': 'en_US:en', 15:49:01 INFO - 'LOGNAME': 'cltbld', 15:49:01 INFO - 'MAIL': '/var/mail/cltbld', 15:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:01 INFO - 'MOZ_NO_REMOTE': '1', 15:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:01 INFO - 'NO_EM_RESTART': '1', 15:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:01 INFO - 'PWD': '/builds/slave/test', 15:49:01 INFO - 'SHELL': '/bin/bash', 15:49:01 INFO - 'SHLVL': '1', 15:49:01 INFO - 'TERM': 'linux', 15:49:01 INFO - 'TMOUT': '86400', 15:49:01 INFO - 'USER': 'cltbld', 15:49:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:01 INFO - '_': '/tools/buildbot/bin/python'} 15:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:03 INFO - Installing collected packages: mozsystemmonitor 15:49:03 INFO - Running setup.py install for mozsystemmonitor 15:49:04 INFO - Successfully installed mozsystemmonitor 15:49:04 INFO - Cleaning up... 15:49:04 INFO - Return code: 0 15:49:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:04 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, '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': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:49:04 INFO - Using env: {'DISPLAY': ':0', 15:49:04 INFO - 'HOME': '/home/cltbld', 15:49:04 INFO - 'LANG': 'en_US.UTF-8', 15:49:04 INFO - 'LANGUAGE': 'en_US:en', 15:49:04 INFO - 'LOGNAME': 'cltbld', 15:49:04 INFO - 'MAIL': '/var/mail/cltbld', 15:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:04 INFO - 'MOZ_NO_REMOTE': '1', 15:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:04 INFO - 'NO_EM_RESTART': '1', 15:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:04 INFO - 'PWD': '/builds/slave/test', 15:49:04 INFO - 'SHELL': '/bin/bash', 15:49:04 INFO - 'SHLVL': '1', 15:49:04 INFO - 'TERM': 'linux', 15:49:04 INFO - 'TMOUT': '86400', 15:49:04 INFO - 'USER': 'cltbld', 15:49:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:04 INFO - '_': '/tools/buildbot/bin/python'} 15:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:04 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:06 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:06 INFO - warning: no files found matching '*.txt' 15:49:06 INFO - no previously-included directories found matching 'build' 15:49:06 INFO - no previously-included directories found matching 'dist' 15:49:06 INFO - no previously-included directories found matching '.git*' 15:49:06 INFO - Installing collected packages: jsonschema, functools32 15:49:06 INFO - Running setup.py install for functools32 15:49:06 INFO - warning: no files found matching '*.txt' 15:49:06 INFO - no previously-included directories found matching 'build' 15:49:06 INFO - no previously-included directories found matching 'dist' 15:49:06 INFO - no previously-included directories found matching '.git*' 15:49:06 INFO - Successfully installed jsonschema functools32 15:49:06 INFO - Cleaning up... 15:49:06 INFO - Return code: 0 15:49:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:06 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, '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': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:49:06 INFO - Using env: {'DISPLAY': ':0', 15:49:06 INFO - 'HOME': '/home/cltbld', 15:49:06 INFO - 'LANG': 'en_US.UTF-8', 15:49:06 INFO - 'LANGUAGE': 'en_US:en', 15:49:06 INFO - 'LOGNAME': 'cltbld', 15:49:06 INFO - 'MAIL': '/var/mail/cltbld', 15:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:06 INFO - 'MOZ_NO_REMOTE': '1', 15:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:06 INFO - 'NO_EM_RESTART': '1', 15:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:06 INFO - 'PWD': '/builds/slave/test', 15:49:06 INFO - 'SHELL': '/bin/bash', 15:49:06 INFO - 'SHLVL': '1', 15:49:06 INFO - 'TERM': 'linux', 15:49:06 INFO - 'TMOUT': '86400', 15:49:06 INFO - 'USER': 'cltbld', 15:49:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:06 INFO - '_': '/tools/buildbot/bin/python'} 15:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:06 INFO - Cleaning up... 15:49:06 INFO - Return code: 0 15:49:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:06 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, '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': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:49:06 INFO - Using env: {'DISPLAY': ':0', 15:49:06 INFO - 'HOME': '/home/cltbld', 15:49:06 INFO - 'LANG': 'en_US.UTF-8', 15:49:06 INFO - 'LANGUAGE': 'en_US:en', 15:49:06 INFO - 'LOGNAME': 'cltbld', 15:49:06 INFO - 'MAIL': '/var/mail/cltbld', 15:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:06 INFO - 'MOZ_NO_REMOTE': '1', 15:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:06 INFO - 'NO_EM_RESTART': '1', 15:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:06 INFO - 'PWD': '/builds/slave/test', 15:49:06 INFO - 'SHELL': '/bin/bash', 15:49:06 INFO - 'SHLVL': '1', 15:49:06 INFO - 'TERM': 'linux', 15:49:06 INFO - 'TMOUT': '86400', 15:49:06 INFO - 'USER': 'cltbld', 15:49:06 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:06 INFO - '_': '/tools/buildbot/bin/python'} 15:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:07 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:09 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:09 INFO - Downloading docopt-0.6.1.tar.gz 15:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:09 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:09 INFO - Running setup.py install for blobuploader 15:49:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:09 INFO - Running setup.py install for requests 15:49:10 INFO - Running setup.py install for docopt 15:49:10 INFO - Successfully installed blobuploader requests docopt 15:49:10 INFO - Cleaning up... 15:49:10 INFO - Return code: 0 15:49:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:10 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, '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': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:49:10 INFO - Using env: {'DISPLAY': ':0', 15:49:10 INFO - 'HOME': '/home/cltbld', 15:49:10 INFO - 'LANG': 'en_US.UTF-8', 15:49:10 INFO - 'LANGUAGE': 'en_US:en', 15:49:10 INFO - 'LOGNAME': 'cltbld', 15:49:10 INFO - 'MAIL': '/var/mail/cltbld', 15:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:10 INFO - 'MOZ_NO_REMOTE': '1', 15:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:10 INFO - 'NO_EM_RESTART': '1', 15:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:10 INFO - 'PWD': '/builds/slave/test', 15:49:10 INFO - 'SHELL': '/bin/bash', 15:49:10 INFO - 'SHLVL': '1', 15:49:10 INFO - 'TERM': 'linux', 15:49:10 INFO - 'TMOUT': '86400', 15:49:10 INFO - 'USER': 'cltbld', 15:49:10 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:10 INFO - '_': '/tools/buildbot/bin/python'} 15:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:10 INFO - Running setup.py (path:/tmp/pip-FYzr81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:10 INFO - Running setup.py (path:/tmp/pip-lxv1B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:10 INFO - Running setup.py (path:/tmp/pip-67GUVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:10 INFO - Running setup.py (path:/tmp/pip-BDEUhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:10 INFO - Running setup.py (path:/tmp/pip-5kSB6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:11 INFO - Running setup.py (path:/tmp/pip-fTDLgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:11 INFO - Running setup.py (path:/tmp/pip-Yo0uHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:11 INFO - Running setup.py (path:/tmp/pip-Gsn_pA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:11 INFO - Running setup.py (path:/tmp/pip-_oJ_ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:11 INFO - Running setup.py (path:/tmp/pip-PivqXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:11 INFO - Running setup.py (path:/tmp/pip-PF3LBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:11 INFO - Running setup.py (path:/tmp/pip-h21n8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:11 INFO - Running setup.py (path:/tmp/pip-PwztGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:11 INFO - Running setup.py (path:/tmp/pip-REseWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:11 INFO - Running setup.py (path:/tmp/pip-zWKlg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:11 INFO - Running setup.py (path:/tmp/pip-xldC9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:11 INFO - Running setup.py (path:/tmp/pip-7kMcoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:11 INFO - Running setup.py install for manifestparser 15:49:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Running setup.py install for mozcrash 15:49:12 INFO - Running setup.py install for mozdebug 15:49:12 INFO - Running setup.py install for mozdevice 15:49:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Running setup.py install for mozfile 15:49:12 INFO - Running setup.py install for mozhttpd 15:49:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Running setup.py install for mozinfo 15:49:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Running setup.py install for mozInstall 15:49:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Running setup.py install for mozleak 15:49:12 INFO - Running setup.py install for mozlog 15:49:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:12 INFO - Running setup.py install for moznetwork 15:49:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:13 INFO - Running setup.py install for mozprocess 15:49:13 INFO - Running setup.py install for mozprofile 15:49:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:13 INFO - Running setup.py install for mozrunner 15:49:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:13 INFO - Running setup.py install for mozscreenshot 15:49:13 INFO - Running setup.py install for moztest 15:49:13 INFO - Running setup.py install for mozversion 15:49:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:13 INFO - Cleaning up... 15:49:13 INFO - Return code: 0 15:49:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:13 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, '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': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:49:13 INFO - Using env: {'DISPLAY': ':0', 15:49:13 INFO - 'HOME': '/home/cltbld', 15:49:13 INFO - 'LANG': 'en_US.UTF-8', 15:49:13 INFO - 'LANGUAGE': 'en_US:en', 15:49:13 INFO - 'LOGNAME': 'cltbld', 15:49:13 INFO - 'MAIL': '/var/mail/cltbld', 15:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:13 INFO - 'MOZ_NO_REMOTE': '1', 15:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:13 INFO - 'NO_EM_RESTART': '1', 15:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:13 INFO - 'PWD': '/builds/slave/test', 15:49:13 INFO - 'SHELL': '/bin/bash', 15:49:13 INFO - 'SHLVL': '1', 15:49:13 INFO - 'TERM': 'linux', 15:49:13 INFO - 'TMOUT': '86400', 15:49:13 INFO - 'USER': 'cltbld', 15:49:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:13 INFO - '_': '/tools/buildbot/bin/python'} 15:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:13 INFO - Running setup.py (path:/tmp/pip-hgd5q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:13 INFO - Running setup.py (path:/tmp/pip-70t220-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:14 INFO - Running setup.py (path:/tmp/pip-MmZQum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:14 INFO - Running setup.py (path:/tmp/pip-sdUfAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:14 INFO - Running setup.py (path:/tmp/pip-KDPe9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:14 INFO - Running setup.py (path:/tmp/pip-2oQ6AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:14 INFO - Running setup.py (path:/tmp/pip-Fh4xmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:14 INFO - Running setup.py (path:/tmp/pip-VHm5gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:14 INFO - Running setup.py (path:/tmp/pip-X8W7Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:14 INFO - Running setup.py (path:/tmp/pip-H8uDKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:14 INFO - Running setup.py (path:/tmp/pip-Gq6Aok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:14 INFO - Running setup.py (path:/tmp/pip-zxdEXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:14 INFO - Running setup.py (path:/tmp/pip-MQOaf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:14 INFO - Running setup.py (path:/tmp/pip-r767ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:14 INFO - Running setup.py (path:/tmp/pip-iALyoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:14 INFO - Running setup.py (path:/tmp/pip-Uw9ghm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:15 INFO - Running setup.py (path:/tmp/pip-7Zaru1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:17 INFO - Downloading blessings-1.6.tar.gz 15:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:17 INFO - Installing collected packages: blessings 15:49:17 INFO - Running setup.py install for blessings 15:49:17 INFO - Successfully installed blessings 15:49:17 INFO - Cleaning up... 15:49:17 INFO - Return code: 0 15:49:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:17 INFO - Reading from file tmpfile_stdout 15:49:17 INFO - Current package versions: 15:49:17 INFO - argparse == 1.2.1 15:49:17 INFO - blessings == 1.6 15:49:17 INFO - blobuploader == 1.2.4 15:49:17 INFO - docopt == 0.6.1 15:49:17 INFO - functools32 == 3.2.3-2 15:49:17 INFO - jsonschema == 2.5.1 15:49:17 INFO - manifestparser == 1.1 15:49:17 INFO - mozInstall == 1.12 15:49:17 INFO - mozcrash == 0.17 15:49:17 INFO - mozdebug == 0.1 15:49:17 INFO - mozdevice == 0.48 15:49:17 INFO - mozfile == 1.2 15:49:17 INFO - mozhttpd == 0.7 15:49:17 INFO - mozinfo == 0.9 15:49:17 INFO - mozleak == 0.1 15:49:17 INFO - mozlog == 3.3 15:49:17 INFO - moznetwork == 0.27 15:49:17 INFO - mozprocess == 0.23 15:49:17 INFO - mozprofile == 0.28 15:49:17 INFO - mozrunner == 6.12 15:49:17 INFO - mozscreenshot == 0.1 15:49:17 INFO - mozsystemmonitor == 0.3 15:49:17 INFO - moztest == 0.7 15:49:17 INFO - mozversion == 1.4 15:49:17 INFO - psutil == 3.1.1 15:49:17 INFO - requests == 1.2.3 15:49:17 INFO - wsgiref == 0.1.2 15:49:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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')]} 15:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:17 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, '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': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:49:17 INFO - Using env: {'DISPLAY': ':0', 15:49:17 INFO - 'HOME': '/home/cltbld', 15:49:17 INFO - 'LANG': 'en_US.UTF-8', 15:49:17 INFO - 'LANGUAGE': 'en_US:en', 15:49:17 INFO - 'LOGNAME': 'cltbld', 15:49:17 INFO - 'MAIL': '/var/mail/cltbld', 15:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:17 INFO - 'MOZ_NO_REMOTE': '1', 15:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:17 INFO - 'NO_EM_RESTART': '1', 15:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:17 INFO - 'PWD': '/builds/slave/test', 15:49:17 INFO - 'SHELL': '/bin/bash', 15:49:17 INFO - 'SHLVL': '1', 15:49:17 INFO - 'TERM': 'linux', 15:49:17 INFO - 'TMOUT': '86400', 15:49:17 INFO - 'USER': 'cltbld', 15:49:17 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:17 INFO - '_': '/tools/buildbot/bin/python'} 15:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:49:17 INFO - Cleaning up... 15:49:17 INFO - Return code: 0 15:49:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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')]} 15:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:17 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 0x1fb3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, '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': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:49:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:49:17 INFO - Using env: {'DISPLAY': ':0', 15:49:17 INFO - 'HOME': '/home/cltbld', 15:49:17 INFO - 'LANG': 'en_US.UTF-8', 15:49:17 INFO - 'LANGUAGE': 'en_US:en', 15:49:17 INFO - 'LOGNAME': 'cltbld', 15:49:17 INFO - 'MAIL': '/var/mail/cltbld', 15:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:17 INFO - 'MOZ_NO_REMOTE': '1', 15:49:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:17 INFO - 'NO_EM_RESTART': '1', 15:49:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:17 INFO - 'PWD': '/builds/slave/test', 15:49:17 INFO - 'SHELL': '/bin/bash', 15:49:17 INFO - 'SHLVL': '1', 15:49:17 INFO - 'TERM': 'linux', 15:49:17 INFO - 'TMOUT': '86400', 15:49:17 INFO - 'USER': 'cltbld', 15:49:17 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:17 INFO - '_': '/tools/buildbot/bin/python'} 15:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:17 INFO - Cleaning up... 15:49:17 INFO - Return code: 0 15:49:17 INFO - Running post-action listener: _resource_record_post_action 15:49:17 INFO - Running post-action listener: _start_resource_monitoring 15:49:17 INFO - Starting resource monitoring. 15:49:17 INFO - [mozharness: 2016-10-12 22:49:17.991005Z] Finished create-virtualenv step (success) 15:49:17 INFO - [mozharness: 2016-10-12 22:49:17.991482Z] Running install step. 15:49:17 INFO - Running pre-action listener: _resource_record_pre_action 15:49:17 INFO - Running main action method: install 15:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:18 INFO - Reading from file tmpfile_stdout 15:49:18 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:18 INFO - Reading from file tmpfile_stdout 15:49:18 INFO - Output received: 15:49:18 INFO - Usage: mozinstall [options] installer 15:49:18 INFO - Options: 15:49:18 INFO - -h, --help show this help message and exit 15:49:18 INFO - -d DEST, --destination=DEST 15:49:18 INFO - Directory to install application into. [default: 15:49:18 INFO - "/builds/slave/test"] 15:49:18 INFO - --app=APP Application being installed. [default: firefox] 15:49:18 INFO - mkdir: /builds/slave/test/build/application 15:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:49:31 INFO - Reading from file tmpfile_stdout 15:49:31 INFO - Output received: 15:49:31 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:31 INFO - Running post-action listener: _resource_record_post_action 15:49:31 INFO - [mozharness: 2016-10-12 22:49:31.764098Z] Finished install step (success) 15:49:31 INFO - [mozharness: 2016-10-12 22:49:31.764385Z] Running run-tests step. 15:49:31 INFO - Running pre-action listener: _resource_record_pre_action 15:49:31 INFO - Running main action method: run_tests 15:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:31 INFO - Python 2.7.3 15:49:31 INFO - Return code: 0 15:49:31 INFO - grabbing minidump binary from tooltool 15:49: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')]} 15:49:31 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 0x2271570>, '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 0x2272470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2272900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:49:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:49:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:49:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:31 INFO - Return code: 0 15:49:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:31 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/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:49:31 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/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:49:31 INFO - Using env: {'DISPLAY': ':0', 15:49:31 INFO - 'HOME': '/home/cltbld', 15:49:31 INFO - 'LANG': 'en_US.UTF-8', 15:49:31 INFO - 'LANGUAGE': 'en_US:en', 15:49:31 INFO - 'LOGNAME': 'cltbld', 15:49:31 INFO - 'MAIL': '/var/mail/cltbld', 15:49:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:31 INFO - 'MOZ_NO_REMOTE': '1', 15:49:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:31 INFO - 'NO_EM_RESTART': '1', 15:49:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:31 INFO - 'PWD': '/builds/slave/test', 15:49:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:31 INFO - 'SHELL': '/bin/bash', 15:49:31 INFO - 'SHLVL': '1', 15:49:31 INFO - 'TERM': 'linux', 15:49:31 INFO - 'TMOUT': '86400', 15:49:31 INFO - 'USER': 'cltbld', 15:49:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768', 15:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:31 INFO - '_': '/tools/buildbot/bin/python'} 15:49:31 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/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:49:32 INFO - mozversion application_buildid: 20161012123846 15:49:32 INFO - mozversion application_changeset: 9f64850761cb6c55b53b379bfd125140e00033e9 15:49:32 INFO - mozversion application_display_name: Firefox 15:49:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:32 INFO - mozversion application_name: Firefox 15:49:32 INFO - mozversion application_remotingname: firefox 15:49:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:49:32 INFO - mozversion application_vendor: Mozilla 15:49:32 INFO - mozversion application_version: 50.0 15:49:32 INFO - mozversion platform_buildid: 20161012123846 15:49:32 INFO - mozversion platform_changeset: 9f64850761cb6c55b53b379bfd125140e00033e9 15:49:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:49:32 INFO - mozversion platform_version: 50.0 15:49:32 INFO - using testdate: 1476312572 15:49:32 INFO - actual date: 1476312572 15:49:32 INFO - starting webserver on 'localhost:34602' 15:49:32 INFO - SUITE-START | Running 2 tests 15:49:32 INFO - TEST-START | dromaeo_css 15:49:32 INFO - operating with platform_type : linux_ 15:49:32 INFO - Initialising browser for dromaeo_css test... 15:49:32 INFO - TEST-INFO | started process 31035 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQmyuvx/profile http://localhost:34602/getInfo.html) 15:49:36 INFO - PROCESS | 31035 | __metrics Screen width/height:1600/1200 15:49:36 INFO - PROCESS | 31035 | colorDepth:24 15:49:36 INFO - PROCESS | 31035 | Browser inner width/height: 1024/697 15:49:36 INFO - PROCESS | 31035 | __metrics 15:49:37 ERROR - PROCESS | 31035 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:49:37 INFO - TEST-INFO | 31035: exit 0 15:49:37 INFO - Browser initialized. 15:49:37 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:37 INFO - TEST-INFO | started process 31158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQmyuvx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:49 INFO - PROCESS | 31158 | RSS: Main: 150102016 15:49:49 INFO - PROCESS | 31158 | 15:50:39 INFO - PROCESS | 31158 | 1476312639276 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:52:47 INFO - PROCESS | 31158 | Cycle 1(1): loaded http://localhost:34602/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34602/tests/dromaeo/cssquery-ext.html) 15:52:48 INFO - PROCESS | 31158 | RSS: Main: 158957568 15:52:48 INFO - PROCESS | 31158 | 15:55:50 INFO - PROCESS | 31158 | Cycle 1(1): loaded http://localhost:34602/tests/dromaeo/cssquery-ext.html (next: http://localhost:34602/tests/dromaeo/cssquery-jquery.html) 15:55:51 INFO - PROCESS | 31158 | RSS: Main: 155660288 15:55:51 INFO - PROCESS | 31158 | 15:58:53 INFO - PROCESS | 31158 | Cycle 1(1): loaded http://localhost:34602/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34602/tests/dromaeo/cssquery-mootools.html) 15:58:53 INFO - PROCESS | 31158 | RSS: Main: 154992640 15:58:53 INFO - PROCESS | 31158 | 16:01:55 INFO - PROCESS | 31158 | Cycle 1(1): loaded http://localhost:34602/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34602/tests/dromaeo/cssquery-prototype.html) 16:01:56 INFO - PROCESS | 31158 | RSS: Main: 156659712 16:01:56 INFO - PROCESS | 31158 | 16:04:58 INFO - PROCESS | 31158 | Cycle 1(1): loaded http://localhost:34602/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34602/tests/dromaeo/cssquery-yui.html) 16:04:59 INFO - PROCESS | 31158 | RSS: Main: 157650944 16:04:59 INFO - PROCESS | 31158 | 16:08:01 INFO - PROCESS | 31158 | Cycle 1(1): loaded http://localhost:34602/tests/dromaeo/cssquery-yui.html (next: http://localhost:34602/tests/dromaeo/cssquery-dojo.html) 16:08:01 INFO - PROCESS | 31158 | RSS: Main: 157679616 16:08:01 INFO - PROCESS | 31158 | 16:08:01 INFO - PROCESS | 31158 | __start_tp_report 16:08:01 INFO - PROCESS | 31158 | _x_x_mozilla_page_load 16:08:01 INFO - PROCESS | 31158 | _x_x_mozilla_page_load_details 16:08:01 INFO - PROCESS | 31158 | |i|pagename|runs| 16:08:01 INFO - PROCESS | 31158 | |0;dojo.html;3300.306935543534;3313.453280208765;3328.816915069671;3332.250243695169;3341.816200108993;5721.914171287434;5783.739731712072;5826.359100498942;5827.271591051119;5827.912581311279;5883.382244864292;5898.852528686785;5907.966105931467;5925.200097986771;5960.5529585281065;5283.788648454067;5324.600654950894;5375.274337964383;5440.102383106782;5483.616146869721;5397;5398.974194902976;5403.297571315743;5406.297181366436;5413.485718856702;5212.270282160501;5250.212468129773;5382.6232163748555;5409.377921539034;5414.945850541503;5322.2282768998475;5396.10964190908;5405.054115529767;5407.351117865862;5445.537129343971;5273.446288139767;5341.408868810718;5358.624896257264;5368.382635996872;5396.568274538066;5676.091825307931;5744.454276843693;5799.652020878761;5892.440218179266;5998.790042348497;6168.321484636686;6296.1500197473215;6301.905471417932;6302.779402720928;6312.463440607554;6381;6382.6170429774365;6389.201349831271;6398.712057957403;6404;5695.202671625976;5796.478316951495;5849.38581448946;5869.178315035899;5875.618084824516;6369.904451433232;6488.28628850826;6500.739970401226;6508.284088750233;6518.413342799171;6125.601835880653;6211.81364559064;6212.223472065992;6213.068039794067;6232;6051.334353221142;6203.0075187969705;6261.7182226799905;6287.371262873676;6317.747290108344;6181.690915454299;6282.591631543935;6297.086922396318;6319.842003949938;6331.461825744771;6345.302016778151;6352.936470635327;6355.904661430082;6381.202349706286;6381.361863813674;4688.882777930579;4727.692699974491;4784.593309568726;4827.179379505493;4863.513648635108;4218.641415479658;4254.170436764801;4270.914581708411;4306.0957198987935;4311.137772445523;6032.607880487754;6049.697515124226;6076.179715738407;6087.208662873887;6087.878242435215;6107.603005804608;6231.3145553989025;6314.242290925026;6385.648789316632;6397.136386587844;6041.305249896318;6108.858142493628;6109.375932520363;6109.42868935195;6126.151269885628;5471.042567550663;5477.67133971963;5487.204355368529;5499.670019798825;5506.724663766796;6331.68341582919;6485.254195767453;6518.44593209573;6623.205215374186;6648.833779155463;6368.904466432915;6386.457151142205;6395.392437718409;6407.231132264158;6412.326705695835;6623.602583844985;6625.900611490928;6671.766488172891;6689.030090636733;6692.063111164343;5966.910496342645;6065.120557519223;6120.8775824484155;6169.598976066721;6225.782097626561;6303.275123360689;6332.176817013758;6333.1766870306565;6348.174737284124;6349.555531112777;6194.81415557534;6199.070139479114;6203.069539569101;6207.379262073937;6209.565330426827;5945.613535120204;6056.091586262096;6112.510999120149;6198.101275315144;6214.25428948529;6153.046277826944;6155.415235552616;6195.318514963441;6198.907016394667;6226.844328891814;6183.288921774054;6241.78153764616;6265.122882796321;6292.559520833498;6296.653684047421;5833.737481813413;5972.193753843176;6079.787207447895;6099;6113.266408031065 16:08:01 INFO - PROCESS | 31158 | |1;ext.html;584.1967294969417;640.7212862404854;652.3118110393533;675.1965161457865;695.1519146641102;42409.57590424095;47347.05305893884;47428.52571474284;47493;47543.573692789185;47637.761811190896;47972.52027479724;48041.039179216394;48221.27668084981;48274.27588586174;9130.22393096586;9175.99064102948;9295.76760580984;9302.25581953442;9302.348835581512;9071.773205669844;9208.769780755467;9213.539323033856;9260.722178334661;9268.814623707556;9305.25557955362;9314.347995640308;9322.25421966241;9342.859857102116;9348.906510934905;9225.354225204239;9309.069093090704;9311.487868167249;9339.392939458947;9361.110694484014;9127.26981841451;9147.131022552914;9211.907880921171;9267.67563135287;9273.582688778954;44349.77825110854;44820.55179448229;44883.77558112189;44912.550874491164;45095.32357014647;3623.601403845575;3785.0715980363407;3837.067006318518;3874.670652994499;3886.3393223152134;35495.4675679865;35580;35660.82169589162;36028;37420.06449838749;4760.119377915063;4779.115863565252;4804.495527969582;4810;4886.340344053543;374170;377096.1145194284;377391;377775;380558;64167;64448;64462.35537644564;64470.67764661241;64474.6776266125;39368.80315598461;40103.59896401057;40397.19205615871;42098.36852447216;42184;19554.120064597126;19604;19771.50571235702;19776.802231977497;19785.901070494554;14926.776098358534;14954.70090598182;14966.70066598662;15013.69972600542;15039.624009399633;20933.79066209349;21099.050542725614;21130.78869211319;21161;21255.893720531298;7332.7039595601655;7586.962065189638;7675.462717609826;7679.347255483235;7790.454668173287;977.4672803322206;1021.5045702834119;1032.2670903658486;1041.723833423956;1062.0229388962173;33683;34041.48937765935;35284.82357588247;38057;38760;1123.9494222759995;1127.0983213429224;1135.2223726747204;1137.2323681514945;1141.1213365708359;16569.42007029748;17677.7348339775;17754.289828406978;17826.91086544559;18289.451316460527;585918;588017;588409;593150;594036;66615.66692166508;67192.65614687777;67434;67552;67574.32425675681;1427.6930459950952;1442.5672298310465;1452.3319273134477;1453.6075259679826;1475.7122361139475;33073.31520635492;35056.64943350636;35577.82211088928;35630.465543016355;35794.64205357913;55995.440045599025;56779.71610141923;56933.43066569281;56952;57045.42954570567;407848;410732;412273;413375;414539;30498.3087491716;31131.68868311288;31854;31854.36291274208;31991.520127197644;52569;52631.73684131708;52805.20792188197;53323;54717.1792423106;43423.34864977091;44074.33888491611;44483.33275000813;44838.775806120764;45887.54112458833;45087;45559.77220113878;46179.25611009656;46418.53581464142;46505;44786.55213447954;45218.54781452144;46140;46178.76910615426;48584.514154858;40476.190476189724;40612.59387406206;40763.592364077165;41114;41296.38055429111;30504.84747576248;30638.84680576583;31032;31121.53317700191;31305.37389252248 16:08:01 INFO - PROCESS | 31158 | |2;jquery.html;412.48233466998914;427.02530247625583;435.4839515174518;439.27958148636225;442.27687730560547;18894.811051889494;20194.89902550487;20356.59286814265;20381.28665496708;21054.263100791475;20078.397648070582;20200;20747.792522074775;20823.791762082375;21089.367318980418;5895.9705201473935;6049.818505444844;6103.755849766027;6113.327533971282;6120;6001.9699901500435;6045.33501314855;6062;6087.695615219243;6095.969520152393;6028.336882942873;6045.879082418349;6064.393560643923;6074.787382441616;6083.513318934497;5982.312034116088;6022;6038.969805150968;6068.878622427526;6080.543959203077;5360.088784906575;5372.677639341613;5396.64921780083;5414.7021913795115;5414.78167412333;23688;23813.880930595235;24262.878685606458;24510;24657.5068498629;2501.7498250175017;2519.1812660885284;2765.4883846488265;2860.556613724876;2950.985245073782;14838.554843354717;15208.08751474915;15682.294296756674;15720.29258683362;15757.212139392985;1898.0414890480356;1914.712793081035;1938.4863011302016;1940.5439721665398;1965.0174912543728;81885;83526.58236708838;84131.5793421035;84981.15018849856;86149.56925215333;11174.497147628375;11229.213955023233;11421.885781142082;11625.88374116248;11678;16662.916685416738;16669.49991500257;16717.749233761504;16813.579660508585;16825.15874206285;9032.8645070324;9059.501727405055;9093.090690930854;9237.491937943343;9338.533073346305;8683.392162548562;8775.561221939006;8870.955645221733;8952.910470895338;9197.95401023004;7044.661514312264;7107.92892071083;7114.608696521637;7151.390937039125;7276.308750668678;2011.3563659629071;2082.937511874646;2088.6423824514186;2112.2184791627196;2148.828093752496;858.6307887608264;925.2320573923628;964.7781010367514;1035.6064695415694;1118.105515587543;20785.688214676793;20931.267405641032;21413.250536231157;21414.25050123238;21533.244158466074;1015.4922538730634;1061.2147011211648;1100.9669709908715;1142.457332766929;1181.3325471108797;11387.487563059682;11967.773340486037;11975.341356225492;11996.460159292852;12215.450304736309;610743;614324;622383;632498;633039;87764;87927;88300.55849720711;88522;91683;1034.4103860799273;1089.3463921646949;1099.373357186412;1104.9668509944715;1108.5621179634;18013.2794688211;18293.451196464128;18826.435206943814;18866.811331887053;19110.426687199408;36752;42836.14327713366;42850.357244640734;42862.57137428711;44040;54980.17529736977;55358;55562;56322.43677563336;56538.1519277203;8793.780155496164;8833.734987950373;8909.287257019552;8920.107989201028;8927.553622318988;7674.846503069795;11861.347625880659;12749.681257968254;13982.650433739238;14597.343119559433;11862.466189021343;11874.52501899949;12203.75592488163;12270.87729122733;12312.938435307766;11778.587749428729;12137.69655758613;12187.268763874195;12212.633620991384;12522.87477125217;12293.262404255773;12340;12426.254424734545;12616.306103164046;12749.87250127487;8247.9587602064;8537.103604121727;8700.434471759316;8799.208071273617;8978.236849867835;11854.822177667515;11962.700932476757;12366.443510042249;12417.19288246261;12622.55821046259 16:08:01 INFO - PROCESS | 31158 | |3;mootools.html;1545.4745386568563;1567.764835274709;1748.0997286397508;1863.3943968210326;1881.8964956927364;9290.86063709044;9450.291228157881;9845.704628861145;9938.254630902675;9950.353227040247;10009.899901000988;10122.69631911042;10181.236407269447;10231.028052335036;10237.078662920336;2539.8349107307968;2578.6905571331467;2586.159498163095;2586.3534116470883;2587.417830988022;2517.987410062947;2587.3272949033294;2590.9093181738644;2611.6082587611913;2613.7255588163157;2551.553478141327;2559.5008973250224;2574.909878154265;2592.1445922845414;2594.2736033910537;2521.382261345973;2528.0772518030876;2530.177692250026;2545.9434334751054;2552.221572420411;2494.1519883239603;2496.950060998788;2513.0576033987254;2561.129216066546;2591.5205686947975;9853.90146098537;9956.701298961043;9971.40171589707;10000.94999525005;10030.648927287582;5888.646681199099;5936.257967754031;6018.638881667071;6043.033114701627;6050.96974515129;3540.7521473496868;3620.7827530348263;3640.7815531068222;3670.9816450917842;3688.4098544232793;1174.3775798826637;1245.1408528115571;1262.1480500662017;1269.7016201192712;1280.1295119318952;13031.543895963596;13423.798643020362;13480.797788033187;13878.514252001232;13904.443822247098;4928.531789479994;4931.457539670633;5035.77339019745;5089.9745501273;5113.923291150636;10750.569977200981;10836.024757771838;10848.403337816495;10869.347839129678;10873.510692018877;5572.164175373645;5619.8595035123635;5641.464060914206;5643.887122257532;5652.830415087554;5186.948130518722;5189.922151167735;5293.973530132402;5387.919181212285;5397.568194544427;4240.469941257343;4320.006398528356;4349.978250108792;4355.1289742051085;4397.472303323621;1302.5375991522874;1314.5399110311505;1320.5378117658934;1323.0540163782941;1329.862967163081;989.4014121456559;995.3977843404635;1019.2661283875598;1038.3147122899002;1056.7886422715487;6247.5939063960695;6348.143000694847;6448.516361272923;6529.706163222666;6694.230163531159;494.4659767451144;494.7204829271522;497.46025562265345;498.608592255078;511.36079900124844;4275.87172384829;4404.493483249404;4426.535213802505;4501.594856462869;4547.408836851188;11952.880471195176;12260.835220654024;12267.202631828903;12282.570110046105;12292.569760058355;11495.655130346104;12149.878501215051;12181.573644922386;12292.754144917231;12479.313637749829;8562.828743425096;9036.322275829207;9044.909550904538;9072.04743501936;9091.909080909238;6359.395857393541;6375.649339286384;6447.9355206447335;6482.54622176462;6609.834754131185;11102.2783519071;11271.7745645085;11320.660380188607;11529.365884876412;11585.131115166228;11506.884931150582;11609.3614851184;11641.185117041725;11698.415079246173;11723.472443739882;7753.224677532202;8377.874331884905;8549.615267313111;8612.267957223707;8753.868691969497;9462.14840664316;9499.097585729345;9511.286653500876;9539.09378609031;9540.904590954002;8456.450330728729;8571.40000200005;8674.566271686264;8693.174148455886;8747.825043499222;7556.65995030214;7780.299773020455;7831.2560306770765;7892.0924093729955;8016.398770092383;7075.469339799432;7111.82220444493;7364.484486085923;7403.481756277009;7417.962910185414;5418.756155972912;5487.670739755627;5521.558275337883;5560.97219513916;5646.576506762091;5681.403452637579;5681.602287839812;5789.8263052108505;5803.129530570448;5886.558508111823 16:08:01 INFO - PROCESS | 31158 | |4;prototype.html;355.68344173685426;369.1214908517728;370.5738400839035;374.7770076804301;375.56622101472806;5668.68822214778;5676.176954341623;5711.714414279285;5754.1944127822135;5832.650040997543;5616.297962754656;5680.573956953234;5700.116481945295;5706.631747824647;5729.255196824417;4473.418455600768;4476.239039363316;4478.417805685256;4479.104179164164;4481.955180448186;4292.399064131024;4459.866204013885;4473.239549276631;4501.807021139384;4518.457785065797;4401.867943961686;4418.270985287424;4421.557844215585;4435.534268901767;4435.866923992286;4429.33559966006;4430.800613972379;4434.556544345572;4443.355713421536;4456.799444025027;3726.9627303727157;3836.232753449321;3934.504888142516;3935.4490371348033;3935.6851451884068;5526.696031718254;5540.252065971083;5541.639793413456;5558.249636299089;5572.192032155355;5060.9493905060845;5061.215511595708;5064;5067.923981140286;5075.187969924795;5741.3110426748635;5953.678065554437;5955.166276721263;5969.791057312973;5998.220231369937;4301.376300436419;4313.547077556874;4313.892152696208;4313.935290970638;4330.328799036154;6204.379562043805;6221.782237621706;6230.252369715663;6239.87520249597;6247.406496382881;4276.636485898671;4375.365571992043;4399;4418.911621767546;4418.977905110454;4442.555744425532;4449.798554390297;4457.554244575581;4469.217886869785;4469.4636643602325;5074.517920797518;5079.374600127923;5096.261042148942;5102.489751024942;5111.488851114858;5817.2257461474655;5884.881872444222;5926.947621974687;5969.671668058299;5989.550783691154;1532.831388547259;1550.9612259693597;1552.751559750457;1555.4244929376202;1559.2203898050975;941.9293552983554;986.3736527305069;987.4124895687055;997.5560875410517;1006.4967516241879;5175.327207463006;5202.76587553561;5208.401033881152;5210.270562121306;5221.973890130601;5397.3523177218985;5429.095433942822;5451.236826844245;5454.7272636368025;5457.399686034533;4955.677880937727;5026.773795179226;5089.440161582223;5131.25596788471;5134.768935397841;2909.316310667034;2914.329704168053;2926.941461170765;2932.252275669691;2932.2815910101735;5606.719664016783;5617.410171931889;5620.835978148442;5650.74571644277;5673.290838645169;5308.30991971049;5502.2296878437055;5508.55931525477;5522.420145884705;5542.695151766691;5556.499915007668;5634.549236061105;5658.292713410824;5659.547236221175;5687.146927960756;5206.047732100463;5418.399168399112;5438.063445739256;5445.53712934405;5461.426550212171;5341.848309497415;5343.412224655207;5362.441924364259;5362.758675859518;5374.596905232045;5560.916586251128;5595.384507704231;5597.63615365;5608.803691870765;5620.110503861666;3772.415895111857;3882.7864467453433;3980.900477488086;3987.4018897165656;4028.6978476613785;5377.8117765878005;5396.9460305398015;5437.933585237584;5994.820155395345;6209.472194863307;6077.604955677867;6079.665618391031;6082.330943596289;6090.634561926298;6090.847728806815;6067.54493412987;6087.239095113111;6094.969525152346;6102.633841969496;6105.938940610537;5781.161731548817;6022.638641681513;6064.423879731418;6084.847878802888;6086.482648974887;6058.303295120942;6073.514118870568;6106.389361063858;6116.66358350295;6133.202683651097;5661.886762264814;5947.851303717442;5968.671723055274;5975.820725378072;5995.910061348996 16:08:01 INFO - PROCESS | 31158 | |5;yui.html;811.1563973467594;815.8205194857129;851.672106239098;869.8869147010888;904.5386852705127;15995;16664.500064998054;17139.571510712238;17274.2226599803;17608.47174584761;16200.75698864518;16247.918760406212;16399.508014759576;16444.75332870008;16457.91771041146;847.0978407995481;848.5629900601195;848.9448185867899;849.452103393311;850.9914900850974;842.473454091193;870.6996086350231;872.489593587752;874.4097734029536;875.5840975536632;907.7140700679265;911.8541033434652;911.9498427586481;913.830941275866;917.0829170829171;909.60432211988;909.7316291693966;910.1444642036531;910.544727636182;912.5665308978248;665.6239224837951;669.3674477618604;669.5346734019859;670.9664516774142;673.6800019990466;16808.57978550534;16819.243134058997;16851.74722379165;16897.831021689748;16906.492805215865;13278.867211327859;13560.45758169672;14417.85582144186;16235.756463653055;16317.428889988794;13356.86643133566;13484.595462136152;13584.93207533956;13710.588682339447;13783.655408614764;4032.475778148851;4071.3689378146437;4071.6335529802163;4131.669466442708;4226.049138943744;87257;87359.56320218422;88178;88915;89305.55347223287;11619.244749091282;11753.294802311888;11888.346140962158;11902.285862848257;12114.575989840314;22950.540989180125;22964.65553016706;22998.770012299996;23077.76922230756;23754.64368034481;8667.263282620921;9102.954485227532;9129.771755706028;9163.03788102253;9229.123233292827;5133.332666753298;5240.135377662643;5266.34170728659;5329.200619906967;5336.893262134736;4093.5906409358827;4194.475690538683;4221;4225.007123326016;4226.809793559297;624.7844493649684;708.2810946888912;715.1168307140678;719.162176064889;720.1034711783863;752.1650967426152;792.2908996448147;807.4186585658434;827.8509868223657;845.9703910363107;9767.804643907082;10184.592616295413;10285.9485702571;10852.837207441895;11033.227674062899;612.8284080457479;684.387473211473;693.5353313280115;753.8315610803234;812.5977641067591;5217.7912883485;5235.083860324428;5296.682199068068;5316.255724198615;5404.378496472956;74254.62872685603;77478.2252177471;78040;78775.21224787793;105280;102893;103295;103552.48223758832;103563.4821825886;104088;91950.54024729968;95705;95972;100831.49584252032;101131;10479.79040419172;10770.73073173177;10841.249244727878;10882.945585272022;11035.39305338214;54282.45717542932;54945;55930.161047585134;56160;56871.146932795215;71953.28046719467;81432;81591.18408815836;82769.58615206885;84374;12437.813432798695;12725.490980360682;12727.872721272668;12819.423125959167;12860.485580576673;15988.760168597713;16254.593635159215;16351.836481635031;16502;16606.086665233528;14305.57083287503;14569.271536423348;14586.708265834835;14602.707945840812;15231.16228607393;13379.264140472367;13441.932790335986;13757.656058598615;13863.65340866446;14338.426462941365;14047.157170569799;14288.071275367069;14524.901460125773;14717.33771980242;15353.07881527112;11454.599089031844;11764.58823941158;11788.587399440978;12155.57455489089;12668.809967850306;12202.938985305016;12278.75442491163;12512.687182820502;12888.613341599766;12895.677608059874 16:08:01 INFO - PROCESS | 31158 | __end_tp_report 16:08:01 INFO - PROCESS | 31158 | __start_cc_report 16:08:01 INFO - PROCESS | 31158 | _x_x_mozilla_cycle_collect,341 16:08:01 INFO - PROCESS | 31158 | __end_cc_report 16:08:01 INFO - PROCESS | 31158 | __startTimestamp1476313681524__endTimestamp 16:08:01 INFO - PROCESS | 31158 | 16:08:01 INFO - PROCESS | 31158 | ------- Summary: start ------- 16:08:01 INFO - PROCESS | 31158 | Number of tests: 6 16:08:01 INFO - PROCESS | 31158 | 16:08:01 INFO - PROCESS | 31158 | [#0] dojo.html Cycles:165 Average:5864.59 Median:6109.38 stddev:687.40 (11.3%) stddev-sans-first:659.42 16:08:01 INFO - PROCESS | 31158 | Values: 3300.3 3313.5 3328.8 3332.3 3341.8 5721.9 5783.7 5826.4 5827.3 5827.9 5883.4 5898.9 5908.0 5925.2 5960.6 5283.8 5324.6 5375.3 5440.1 5483.6 5397.0 5399.0 5403.3 5406.3 5413.5 5212.3 5250.2 5382.6 5409.4 5414.9 5322.2 5396.1 5405.1 5407.4 5445.5 5273.4 5341.4 5358.6 5368.4 5396.6 5676.1 5744.5 5799.7 5892.4 5998.8 6168.3 6296.2 6301.9 6302.8 6312.5 6381.0 6382.6 6389.2 6398.7 6404.0 5695.2 5796.5 5849.4 5869.2 5875.6 6369.9 6488.3 6500.7 6508.3 6518.4 6125.6 6211.8 6212.2 6213.1 6232.0 6051.3 6203.0 6261.7 6287.4 6317.7 6181.7 6282.6 6297.1 6319.8 6331.5 6345.3 6352.9 6355.9 6381.2 6381.4 4688.9 4727.7 4784.6 4827.2 4863.5 4218.6 4254.2 4270.9 4306.1 4311.1 6032.6 6049.7 6076.2 6087.2 6087.9 6107.6 6231.3 6314.2 6385.6 6397.1 6041.3 6108.9 6109.4 6109.4 6126.2 5471.0 5477.7 5487.2 5499.7 5506.7 6331.7 6485.3 6518.4 6623.2 6648.8 6368.9 6386.5 6395.4 6407.2 6412.3 6623.6 6625.9 6671.8 6689.0 6692.1 5966.9 6065.1 6120.9 6169.6 6225.8 6303.3 6332.2 6333.2 6348.2 6349.6 6194.8 6199.1 6203.1 6207.4 6209.6 5945.6 6056.1 6112.5 6198.1 6214.3 6153.0 6155.4 6195.3 6198.9 6226.8 6183.3 6241.8 6265.1 6292.6 6296.7 5833.7 5972.2 6079.8 6099.0 6113.3 16:08:01 INFO - PROCESS | 31158 | 16:08:01 INFO - PROCESS | 31158 | [#1] ext.html Cycles:180 Average:63553.66 Median:44829.66 stddev:124286.98 (277.2%) stddev-sans-first:124545.72 16:08:01 INFO - PROCESS | 31158 | Values: 584.2 640.7 652.3 675.2 695.2 42409.6 47347.1 47428.5 47493.0 47543.6 47637.8 47972.5 48041.0 48221.3 48274.3 9130.2 9176.0 9295.8 9302.3 9302.3 9071.8 9208.8 9213.5 9260.7 9268.8 9305.3 9314.3 9322.3 9342.9 9348.9 9225.4 9309.1 9311.5 9339.4 9361.1 9127.3 9147.1 9211.9 9267.7 9273.6 44349.8 44820.6 44883.8 44912.6 45095.3 3623.6 3785.1 3837.1 3874.7 3886.3 35495.5 35580.0 35660.8 36028.0 37420.1 4760.1 4779.1 4804.5 4810.0 4886.3 374170.0 377096.1 377391.0 377775.0 380558.0 64167.0 64448.0 64462.4 64470.7 64474.7 39368.8 40103.6 40397.2 42098.4 42184.0 19554.1 19604.0 19771.5 19776.8 19785.9 14926.8 14954.7 14966.7 15013.7 15039.6 20933.8 21099.1 21130.8 21161.0 21255.9 7332.7 7587.0 7675.5 7679.3 7790.5 977.5 1021.5 1032.3 1041.7 1062.0 33683.0 34041.5 35284.8 38057.0 38760.0 1123.9 1127.1 1135.2 1137.2 1141.1 16569.4 17677.7 17754.3 17826.9 18289.5 585918.0 588017.0 588409.0 593150.0 594036.0 66615.7 67192.7 67434.0 67552.0 67574.3 1427.7 1442.6 1452.3 1453.6 1475.7 33073.3 35056.6 35577.8 35630.5 35794.6 55995.4 56779.7 56933.4 56952.0 57045.4 407848.0 410732.0 412273.0 413375.0 414539.0 30498.3 31131.7 31854.0 31854.4 31991.5 52569.0 52631.7 52805.2 53323.0 54717.2 43423.3 44074.3 44483.3 44838.8 45887.5 45087.0 45559.8 46179.3 46418.5 46505.0 44786.6 45218.5 46140.0 46178.8 48584.5 40476.2 40612.6 40763.6 41114.0 41296.4 30504.8 30638.8 31032.0 31121.5 31305.4 16:08:01 INFO - PROCESS | 31158 | 16:08:01 INFO - PROCESS | 31158 | [#2] jquery.html Cycles:180 Average:33259.18 Median:13579.63 stddev:101943.99 (750.7%) stddev-sans-first:102200.14 16:08:01 INFO - PROCESS | 31158 | Values: 412.5 427.0 435.5 439.3 442.3 18894.8 20194.9 20356.6 20381.3 21054.3 20078.4 20200.0 20747.8 20823.8 21089.4 5896.0 6049.8 6103.8 6113.3 6120.0 6002.0 6045.3 6062.0 6087.7 6096.0 6028.3 6045.9 6064.4 6074.8 6083.5 5982.3 6022.0 6039.0 6068.9 6080.5 5360.1 5372.7 5396.6 5414.7 5414.8 23688.0 23813.9 24262.9 24510.0 24657.5 2501.7 2519.2 2765.5 2860.6 2951.0 14838.6 15208.1 15682.3 15720.3 15757.2 1898.0 1914.7 1938.5 1940.5 1965.0 81885.0 83526.6 84131.6 84981.2 86149.6 11174.5 11229.2 11421.9 11625.9 11678.0 16662.9 16669.5 16717.7 16813.6 16825.2 9032.9 9059.5 9093.1 9237.5 9338.5 8683.4 8775.6 8871.0 8952.9 9198.0 7044.7 7107.9 7114.6 7151.4 7276.3 2011.4 2082.9 2088.6 2112.2 2148.8 858.6 925.2 964.8 1035.6 1118.1 20785.7 20931.3 21413.3 21414.3 21533.2 1015.5 1061.2 1101.0 1142.5 1181.3 11387.5 11967.8 11975.3 11996.5 12215.5 610743.0 614324.0 622383.0 632498.0 633039.0 87764.0 87927.0 88300.6 88522.0 91683.0 1034.4 1089.3 1099.4 1105.0 1108.6 18013.3 18293.5 18826.4 18866.8 19110.4 36752.0 42836.1 42850.4 42862.6 44040.0 54980.2 55358.0 55562.0 56322.4 56538.2 8793.8 8833.7 8909.3 8920.1 8927.6 7674.8 11861.3 12749.7 13982.7 14597.3 11862.5 11874.5 12203.8 12270.9 12312.9 11778.6 12137.7 12187.3 12212.6 12522.9 12293.3 12340.0 12426.3 12616.3 12749.9 8248.0 8537.1 8700.4 8799.2 8978.2 11854.8 11962.7 12366.4 12417.2 12622.6 16:08:01 INFO - PROCESS | 31158 | 16:08:01 INFO - PROCESS | 31158 | [#3] mootools.html Cycles:180 Average:6368.17 Median:4400.98 stddev:3692.74 (83.9%) stddev-sans-first:3685.32 16:08:01 INFO - PROCESS | 31158 | Values: 1545.5 1567.8 1748.1 1863.4 1881.9 9290.9 9450.3 9845.7 9938.3 9950.4 10009.9 10122.7 10181.2 10231.0 10237.1 2539.8 2578.7 2586.2 2586.4 2587.4 2518.0 2587.3 2590.9 2611.6 2613.7 2551.6 2559.5 2574.9 2592.1 2594.3 2521.4 2528.1 2530.2 2545.9 2552.2 2494.2 2497.0 2513.1 2561.1 2591.5 9853.9 9956.7 9971.4 10000.9 10030.6 5888.6 5936.3 6018.6 6043.0 6051.0 3540.8 3620.8 3640.8 3671.0 3688.4 1174.4 1245.1 1262.1 1269.7 1280.1 13031.5 13423.8 13480.8 13878.5 13904.4 4928.5 4931.5 5035.8 5090.0 5113.9 10750.6 10836.0 10848.4 10869.3 10873.5 5572.2 5619.9 5641.5 5643.9 5652.8 5186.9 5189.9 5294.0 5387.9 5397.6 4240.5 4320.0 4350.0 4355.1 4397.5 1302.5 1314.5 1320.5 1323.1 1329.9 989.4 995.4 1019.3 1038.3 1056.8 6247.6 6348.1 6448.5 6529.7 6694.2 494.5 494.7 497.5 498.6 511.4 4275.9 4404.5 4426.5 4501.6 4547.4 11952.9 12260.8 12267.2 12282.6 12292.6 11495.7 12149.9 12181.6 12292.8 12479.3 8562.8 9036.3 9044.9 9072.0 9091.9 6359.4 6375.6 6447.9 6482.5 6609.8 11102.3 11271.8 11320.7 11529.4 11585.1 11506.9 11609.4 11641.2 11698.4 11723.5 7753.2 8377.9 8549.6 8612.3 8753.9 9462.1 9499.1 9511.3 9539.1 9540.9 8456.5 8571.4 8674.6 8693.2 8747.8 7556.7 7780.3 7831.3 7892.1 8016.4 7075.5 7111.8 7364.5 7403.5 7418.0 5418.8 5487.7 5521.6 5561.0 5646.6 5681.4 5681.6 5789.8 5803.1 5886.6 16:08:01 INFO - PROCESS | 31158 | 16:08:01 INFO - PROCESS | 31158 | [#4] prototype.html Cycles:180 Average:4845.62 Median:5407.88 stddev:1400.88 (25.9%) stddev-sans-first:1363.67 16:08:01 INFO - PROCESS | 31158 | Values: 355.7 369.1 370.6 374.8 375.6 5668.7 5676.2 5711.7 5754.2 5832.7 5616.3 5680.6 5700.1 5706.6 5729.3 4473.4 4476.2 4478.4 4479.1 4482.0 4292.4 4459.9 4473.2 4501.8 4518.5 4401.9 4418.3 4421.6 4435.5 4435.9 4429.3 4430.8 4434.6 4443.4 4456.8 3727.0 3836.2 3934.5 3935.4 3935.7 5526.7 5540.3 5541.6 5558.2 5572.2 5060.9 5061.2 5064.0 5067.9 5075.2 5741.3 5953.7 5955.2 5969.8 5998.2 4301.4 4313.5 4313.9 4313.9 4330.3 6204.4 6221.8 6230.3 6239.9 6247.4 4276.6 4375.4 4399.0 4418.9 4419.0 4442.6 4449.8 4457.6 4469.2 4469.5 5074.5 5079.4 5096.3 5102.5 5111.5 5817.2 5884.9 5926.9 5969.7 5989.6 1532.8 1551.0 1552.8 1555.4 1559.2 941.9 986.4 987.4 997.6 1006.5 5175.3 5202.8 5208.4 5210.3 5222.0 5397.4 5429.1 5451.2 5454.7 5457.4 4955.7 5026.8 5089.4 5131.3 5134.8 2909.3 2914.3 2926.9 2932.3 2932.3 5606.7 5617.4 5620.8 5650.7 5673.3 5308.3 5502.2 5508.6 5522.4 5542.7 5556.5 5634.5 5658.3 5659.5 5687.1 5206.0 5418.4 5438.1 5445.5 5461.4 5341.8 5343.4 5362.4 5362.8 5374.6 5560.9 5595.4 5597.6 5608.8 5620.1 3772.4 3882.8 3980.9 3987.4 4028.7 5377.8 5396.9 5437.9 5994.8 6209.5 6077.6 6079.7 6082.3 6090.6 6090.8 6067.5 6087.2 6095.0 6102.6 6105.9 5781.2 6022.6 6064.4 6084.8 6086.5 6058.3 6073.5 6106.4 6116.7 6133.2 5661.9 5947.9 5968.7 5975.8 5995.9 16:08:01 INFO - PROCESS | 31158 | 16:08:01 INFO - PROCESS | 31158 | [#5] yui.html Cycles:180 Average:21503.13 Median:4112.63 stddev:29672.06 (721.5%) stddev-sans-first:29714.62 16:08:01 INFO - PROCESS | 31158 | Values: 811.2 815.8 851.7 869.9 904.5 15995.0 16664.5 17139.6 17274.2 17608.5 16200.8 16247.9 16399.5 16444.8 16457.9 847.1 848.6 848.9 849.5 851.0 842.5 870.7 872.5 874.4 875.6 907.7 911.9 911.9 913.8 917.1 909.6 909.7 910.1 910.5 912.6 665.6 669.4 669.5 671.0 673.7 16808.6 16819.2 16851.7 16897.8 16906.5 13278.9 13560.5 14417.9 16235.8 16317.4 13356.9 13484.6 13584.9 13710.6 13783.7 4032.5 4071.4 4071.6 4131.7 4226.0 87257.0 87359.6 88178.0 88915.0 89305.6 11619.2 11753.3 11888.3 11902.3 12114.6 22950.5 22964.7 22998.8 23077.8 23754.6 8667.3 9103.0 9129.8 9163.0 9229.1 5133.3 5240.1 5266.3 5329.2 5336.9 4093.6 4194.5 4221.0 4225.0 4226.8 624.8 708.3 715.1 719.2 720.1 752.2 792.3 807.4 827.9 846.0 9767.8 10184.6 10285.9 10852.8 11033.2 612.8 684.4 693.5 753.8 812.6 5217.8 5235.1 5296.7 5316.3 5404.4 74254.6 77478.2 78040.0 78775.2 105280.0 102893.0 103295.0 103552.5 103563.5 104088.0 91950.5 95705.0 95972.0 100831.5 101131.0 10479.8 10770.7 10841.2 10882.9 11035.4 54282.5 54945.0 55930.2 56160.0 56871.1 71953.3 81432.0 81591.2 82769.6 84374.0 12437.8 12725.5 12727.9 12819.4 12860.5 15988.8 16254.6 16351.8 16502.0 16606.1 14305.6 14569.3 14586.7 14602.7 15231.2 13379.3 13441.9 13757.7 13863.7 14338.4 14047.2 14288.1 14524.9 14717.3 15353.1 11454.6 11764.6 11788.6 12155.6 12668.8 12202.9 12278.8 12512.7 12888.6 12895.7 16:08:01 INFO - PROCESS | 31158 | -------- Summary: end -------- 16:08:01 INFO - PROCESS | 31158 | 16:08:02 INFO - TEST-INFO | 31158: exit 0 16:08:02 INFO - TEST-OK | dromaeo_css | took 1110140ms 16:08:02 INFO - TEST-START | kraken 16:08:02 INFO - operating with platform_type : linux_ 16:08:02 INFO - Initialising browser for kraken test... 16:08:02 INFO - TEST-INFO | started process 31399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp18HInV/profile http://localhost:34602/getInfo.html) 16:08:06 INFO - PROCESS | 31399 | __metrics Screen width/height:1600/1200 16:08:06 INFO - PROCESS | 31399 | colorDepth:24 16:08:06 INFO - PROCESS | 31399 | Browser inner width/height: 1024/697 16:08:06 INFO - PROCESS | 31399 | __metrics 16:08:06 ERROR - PROCESS | 31399 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:08:07 INFO - TEST-INFO | 31399: exit 0 16:08:07 INFO - Browser initialized. 16:08:07 INFO - Running cycle 1/1 for kraken test... 16:08:07 INFO - TEST-INFO | started process 31522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp18HInV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:19 INFO - PROCESS | 31522 | RSS: Main: 150396928 16:08:19 INFO - PROCESS | 31522 | 16:08:21 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34602/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:22 INFO - PROCESS | 31522 | RSS: Main: 156508160 16:08:22 INFO - PROCESS | 31522 | 16:08:25 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34602/tests/kraken/driver.html?testName=audio-dft) 16:08:26 INFO - PROCESS | 31522 | RSS: Main: 154877952 16:08:26 INFO - PROCESS | 31522 | 16:08:28 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34602/tests/kraken/driver.html?testName=audio-fft) 16:08:29 INFO - PROCESS | 31522 | RSS: Main: 156037120 16:08:29 INFO - PROCESS | 31522 | 16:08:31 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34602/tests/kraken/driver.html?testName=audio-oscillator) 16:08:32 INFO - PROCESS | 31522 | RSS: Main: 155824128 16:08:32 INFO - PROCESS | 31522 | 16:08:34 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34602/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:34 INFO - PROCESS | 31522 | RSS: Main: 155836416 16:08:34 INFO - PROCESS | 31522 | 16:08:38 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34602/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:38 INFO - PROCESS | 31522 | RSS: Main: 155705344 16:08:38 INFO - PROCESS | 31522 | 16:08:42 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34602/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:42 INFO - PROCESS | 31522 | RSS: Main: 156614656 16:08:42 INFO - PROCESS | 31522 | 16:08:45 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34602/tests/kraken/driver.html?testName=json-parse-financial) 16:08:46 INFO - PROCESS | 31522 | RSS: Main: 156315648 16:08:46 INFO - PROCESS | 31522 | 16:08:47 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34602/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:48 INFO - PROCESS | 31522 | RSS: Main: 155860992 16:08:48 INFO - PROCESS | 31522 | 16:08:49 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34602/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:50 INFO - PROCESS | 31522 | RSS: Main: 156872704 16:08:50 INFO - PROCESS | 31522 | 16:08:52 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34602/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:08:53 INFO - PROCESS | 31522 | RSS: Main: 156676096 16:08:53 INFO - PROCESS | 31522 | 16:08:55 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:56 INFO - PROCESS | 31522 | RSS: Main: 157093888 16:08:56 INFO - PROCESS | 31522 | 16:08:59 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:59 INFO - PROCESS | 31522 | RSS: Main: 156954624 16:08:59 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | Cycle 1(1): loaded http://localhost:34602/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34602/tests/kraken/driver.html?testName=ai-astar) 16:09:01 INFO - PROCESS | 31522 | RSS: Main: 158552064 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | __start_tp_report 16:09:01 INFO - PROCESS | 31522 | _x_x_mozilla_page_load 16:09:01 INFO - PROCESS | 31522 | _x_x_mozilla_page_load_details 16:09:01 INFO - PROCESS | 31522 | |i|pagename|runs| 16:09:01 INFO - PROCESS | 31522 | |0;ai-astar;101;113;108;112;112;110;110;113;112;112 16:09:01 INFO - PROCESS | 31522 | |1;audio-beat-detection;143;116;138;166;116;154;143;118;167;121 16:09:01 INFO - PROCESS | 31522 | |2;audio-dft;164;162;161;162;163;163;163;162;162;161 16:09:01 INFO - PROCESS | 31522 | |3;audio-fft;74;76;75;184;76;75;76;75;170;75 16:09:01 INFO - PROCESS | 31522 | |4;audio-oscillator;85;84;143;83;84;83;135;86;84;141 16:09:01 INFO - PROCESS | 31522 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;117;117;117 16:09:01 INFO - PROCESS | 31522 | |6;imaging-darkroom;147;146;148;146;148;148;146;146;147;146 16:09:01 INFO - PROCESS | 31522 | |7;imaging-desaturate;100;96;96;96;95;95;94;95;95;95 16:09:01 INFO - PROCESS | 31522 | |8;json-parse-financial;55;54;53;52;53;53;52;51;53;52 16:09:01 INFO - PROCESS | 31522 | |9;json-stringify-tinderbox;62;59;59;60;60;60;60;59;62;60 16:09:01 INFO - PROCESS | 31522 | |10;stanford-crypto-aes;83;73;72;81;73;78;73;73;72;75 16:09:01 INFO - PROCESS | 31522 | |11;stanford-crypto-ccm;128;121;120;126;137;121;126;121;152;123 16:09:01 INFO - PROCESS | 31522 | |12;stanford-crypto-pbkdf2;156;153;154;160;153;152;153;159;156;157 16:09:01 INFO - PROCESS | 31522 | |13;stanford-crypto-sha256-iterative;64;63;63;63;63;62;65;62;60;61 16:09:01 INFO - PROCESS | 31522 | __end_tp_report 16:09:01 INFO - PROCESS | 31522 | __start_cc_report 16:09:01 INFO - PROCESS | 31522 | _x_x_mozilla_cycle_collect,868 16:09:01 INFO - PROCESS | 31522 | __end_cc_report 16:09:01 INFO - PROCESS | 31522 | __startTimestamp1476313741660__endTimestamp 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | ------- Summary: start ------- 16:09:01 INFO - PROCESS | 31522 | Number of tests: 14 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.62 (3.2%) stddev-sans-first:1.66 16:09:01 INFO - PROCESS | 31522 | Values: 101.0 113.0 108.0 112.0 112.0 110.0 110.0 113.0 112.0 112.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:143.00 stddev:19.97 (14.0%) stddev-sans-first:21.10 16:09:01 INFO - PROCESS | 31522 | Values: 143.0 116.0 138.0 166.0 116.0 154.0 143.0 118.0 167.0 121.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 16:09:01 INFO - PROCESS | 31522 | Values: 164.0 162.0 161.0 162.0 163.0 163.0 163.0 162.0 162.0 161.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#3] audio-fft Cycles:10 Average:95.60 Median:75.00 stddev:43.03 (57.4%) stddev-sans-first:44.93 16:09:01 INFO - PROCESS | 31522 | Values: 74.0 76.0 75.0 184.0 76.0 75.0 76.0 75.0 170.0 75.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:84.00 stddev:26.91 (32.0%) stddev-sans-first:27.92 16:09:01 INFO - PROCESS | 31522 | Values: 85.0 84.0 143.0 83.0 84.0 83.0 135.0 86.0 84.0 141.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 16:09:01 INFO - PROCESS | 31522 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 16:09:01 INFO - PROCESS | 31522 | Values: 147.0 146.0 148.0 146.0 148.0 148.0 146.0 146.0 147.0 146.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:1.64 (1.7%) stddev-sans-first:0.67 16:09:01 INFO - PROCESS | 31522 | Values: 100.0 96.0 96.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.14 (2.1%) stddev-sans-first:0.88 16:09:01 INFO - PROCESS | 31522 | Values: 55.0 54.0 53.0 52.0 53.0 53.0 52.0 51.0 53.0 52.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:1.10 (1.8%) stddev-sans-first:0.93 16:09:01 INFO - PROCESS | 31522 | Values: 62.0 59.0 59.0 60.0 60.0 60.0 60.0 59.0 62.0 60.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:74.00 stddev:3.97 (5.4%) stddev-sans-first:3.09 16:09:01 INFO - PROCESS | 31522 | Values: 83.0 73.0 72.0 81.0 73.0 78.0 73.0 73.0 72.0 75.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:126.00 stddev:9.99 (7.9%) stddev-sans-first:10.60 16:09:01 INFO - PROCESS | 31522 | Values: 128.0 121.0 120.0 126.0 137.0 121.0 126.0 121.0 152.0 123.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:156.00 stddev:2.75 (1.8%) stddev-sans-first:2.91 16:09:01 INFO - PROCESS | 31522 | Values: 156.0 153.0 154.0 160.0 153.0 152.0 153.0 159.0 156.0 157.0 16:09:01 INFO - PROCESS | 31522 | 16:09:01 INFO - PROCESS | 31522 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.43 (2.3%) stddev-sans-first:1.42 16:09:01 INFO - PROCESS | 31522 | Values: 64.0 63.0 63.0 63.0 63.0 62.0 65.0 62.0 60.0 61.0 16:09:01 INFO - PROCESS | 31522 | -------- Summary: end -------- 16:09:01 INFO - PROCESS | 31522 | 16:09:02 INFO - TEST-INFO | 31522: exit 0 16:09:02 INFO - TEST-OK | kraken | took 60396ms 16:09:02 INFO - SUITE-END | took 1170s 16:09:02 INFO - Completed test suite (00:19:30) 16:09:02 INFO - javascript benchmark 16:09:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7776.979512891996, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.306935543534, 3313.453280208765, 3328.816915069671, 3332.250243695169, 3341.816200108993, 5721.914171287434, 5783.739731712072, 5826.359100498942, 5827.271591051119, 5827.912581311279, 5883.382244864292, 5898.852528686785, 5907.966105931467, 5925.200097986771, 5960.5529585281065, 5283.788648454067, 5324.600654950894, 5375.274337964383, 5440.102383106782, 5483.616146869721, 5397.0, 5398.974194902976, 5403.297571315743, 5406.297181366436, 5413.485718856702, 5212.270282160501, 5250.212468129773, 5382.6232163748555, 5409.377921539034, 5414.945850541503, 5322.2282768998475, 5396.10964190908, 5405.054115529767, 5407.351117865862, 5445.537129343971, 5273.446288139767, 5341.408868810718, 5358.624896257264, 5368.382635996872, 5396.568274538066, 5676.091825307931, 5744.454276843693, 5799.652020878761, 5892.440218179266, 5998.790042348497, 6168.321484636686, 6296.1500197473215, 6301.905471417932, 6302.779402720928, 6312.463440607554, 6381.0, 6382.6170429774365, 6389.201349831271, 6398.712057957403, 6404.0, 5695.202671625976, 5796.478316951495, 5849.38581448946, 5869.178315035899, 5875.618084824516, 6369.904451433232, 6488.28628850826, 6500.739970401226, 6508.284088750233, 6518.413342799171, 6125.601835880653, 6211.81364559064, 6212.223472065992, 6213.068039794067, 6232.0, 6051.334353221142, 6203.0075187969705, 6261.7182226799905, 6287.371262873676, 6317.747290108344, 6181.690915454299, 6282.591631543935, 6297.086922396318, 6319.842003949938, 6331.461825744771, 6345.302016778151, 6352.936470635327, 6355.904661430082, 6381.202349706286, 6381.361863813674, 4688.882777930579, 4727.692699974491, 4784.593309568726, 4827.179379505493, 4863.513648635108, 4218.641415479658, 4254.170436764801, 4270.914581708411, 4306.0957198987935, 4311.137772445523, 6032.607880487754, 6049.697515124226, 6076.179715738407, 6087.208662873887, 6087.878242435215, 6107.603005804608, 6231.3145553989025, 6314.242290925026, 6385.648789316632, 6397.136386587844, 6041.305249896318, 6108.858142493628, 6109.375932520363, 6109.42868935195, 6126.151269885628, 5471.042567550663, 5477.67133971963, 5487.204355368529, 5499.670019798825, 5506.724663766796, 6331.68341582919, 6485.254195767453, 6518.44593209573, 6623.205215374186, 6648.833779155463, 6368.904466432915, 6386.457151142205, 6395.392437718409, 6407.231132264158, 6412.326705695835, 6623.602583844985, 6625.900611490928, 6671.766488172891, 6689.030090636733, 6692.063111164343, 5966.910496342645, 6065.120557519223, 6120.8775824484155, 6169.598976066721, 6225.782097626561, 6303.275123360689, 6332.176817013758, 6333.1766870306565, 6348.174737284124, 6349.555531112777, 6194.81415557534, 6199.070139479114, 6203.069539569101, 6207.379262073937, 6209.565330426827, 5945.613535120204, 6056.091586262096, 6112.510999120149, 6198.101275315144, 6214.25428948529, 6153.046277826944, 6155.415235552616, 6195.318514963441, 6198.907016394667, 6226.844328891814, 6183.288921774054, 6241.78153764616, 6265.122882796321, 6292.559520833498, 6296.653684047421, 5833.737481813413, 5972.193753843176, 6079.787207447895, 6099.0, 6113.266408031065], "value": 5816.240977189781, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.1967294969417, 640.7212862404854, 652.3118110393533, 675.1965161457865, 695.1519146641102, 42409.57590424095, 47347.05305893884, 47428.52571474284, 47493.0, 47543.573692789185, 47637.761811190896, 47972.52027479724, 48041.039179216394, 48221.27668084981, 48274.27588586174, 9130.22393096586, 9175.99064102948, 9295.76760580984, 9302.25581953442, 9302.348835581512, 9071.773205669844, 9208.769780755467, 9213.539323033856, 9260.722178334661, 9268.814623707556, 9305.25557955362, 9314.347995640308, 9322.25421966241, 9342.859857102116, 9348.906510934905, 9225.354225204239, 9309.069093090704, 9311.487868167249, 9339.392939458947, 9361.110694484014, 9127.26981841451, 9147.131022552914, 9211.907880921171, 9267.67563135287, 9273.582688778954, 44349.77825110854, 44820.55179448229, 44883.77558112189, 44912.550874491164, 45095.32357014647, 3623.601403845575, 3785.0715980363407, 3837.067006318518, 3874.670652994499, 3886.3393223152134, 35495.4675679865, 35580.0, 35660.82169589162, 36028.0, 37420.06449838749, 4760.119377915063, 4779.115863565252, 4804.495527969582, 4810.0, 4886.340344053543, 374170.0, 377096.1145194284, 377391.0, 377775.0, 380558.0, 64167.0, 64448.0, 64462.35537644564, 64470.67764661241, 64474.6776266125, 39368.80315598461, 40103.59896401057, 40397.19205615871, 42098.36852447216, 42184.0, 19554.120064597126, 19604.0, 19771.50571235702, 19776.802231977497, 19785.901070494554, 14926.776098358534, 14954.70090598182, 14966.70066598662, 15013.69972600542, 15039.624009399633, 20933.79066209349, 21099.050542725614, 21130.78869211319, 21161.0, 21255.893720531298, 7332.7039595601655, 7586.962065189638, 7675.462717609826, 7679.347255483235, 7790.454668173287, 977.4672803322206, 1021.5045702834119, 1032.2670903658486, 1041.723833423956, 1062.0229388962173, 33683.0, 34041.48937765935, 35284.82357588247, 38057.0, 38760.0, 1123.9494222759995, 1127.0983213429224, 1135.2223726747204, 1137.2323681514945, 1141.1213365708359, 16569.42007029748, 17677.7348339775, 17754.289828406978, 17826.91086544559, 18289.451316460527, 585918.0, 588017.0, 588409.0, 593150.0, 594036.0, 66615.66692166508, 67192.65614687777, 67434.0, 67552.0, 67574.32425675681, 1427.6930459950952, 1442.5672298310465, 1452.3319273134477, 1453.6075259679826, 1475.7122361139475, 33073.31520635492, 35056.64943350636, 35577.82211088928, 35630.465543016355, 35794.64205357913, 55995.440045599025, 56779.71610141923, 56933.43066569281, 56952.0, 57045.42954570567, 407848.0, 410732.0, 412273.0, 413375.0, 414539.0, 30498.3087491716, 31131.68868311288, 31854.0, 31854.36291274208, 31991.520127197644, 52569.0, 52631.73684131708, 52805.20792188197, 53323.0, 54717.1792423106, 43423.34864977091, 44074.33888491611, 44483.33275000813, 44838.775806120764, 45887.54112458833, 45087.0, 45559.77220113878, 46179.25611009656, 46418.53581464142, 46505.0, 44786.55213447954, 45218.54781452144, 46140.0, 46178.76910615426, 48584.514154858, 40476.190476189724, 40612.59387406206, 40763.592364077165, 41114.0, 41296.38055429111, 30504.84747576248, 30638.84680576583, 31032.0, 31121.53317700191, 31305.37389252248], "value": 21516.468404286396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.48233466998914, 427.02530247625583, 435.4839515174518, 439.27958148636225, 442.27687730560547, 18894.811051889494, 20194.89902550487, 20356.59286814265, 20381.28665496708, 21054.263100791475, 20078.397648070582, 20200.0, 20747.792522074775, 20823.791762082375, 21089.367318980418, 5895.9705201473935, 6049.818505444844, 6103.755849766027, 6113.327533971282, 6120.0, 6001.9699901500435, 6045.33501314855, 6062.0, 6087.695615219243, 6095.969520152393, 6028.336882942873, 6045.879082418349, 6064.393560643923, 6074.787382441616, 6083.513318934497, 5982.312034116088, 6022.0, 6038.969805150968, 6068.878622427526, 6080.543959203077, 5360.088784906575, 5372.677639341613, 5396.64921780083, 5414.7021913795115, 5414.78167412333, 23688.0, 23813.880930595235, 24262.878685606458, 24510.0, 24657.5068498629, 2501.7498250175017, 2519.1812660885284, 2765.4883846488265, 2860.556613724876, 2950.985245073782, 14838.554843354717, 15208.08751474915, 15682.294296756674, 15720.29258683362, 15757.212139392985, 1898.0414890480356, 1914.712793081035, 1938.4863011302016, 1940.5439721665398, 1965.0174912543728, 81885.0, 83526.58236708838, 84131.5793421035, 84981.15018849856, 86149.56925215333, 11174.497147628375, 11229.213955023233, 11421.885781142082, 11625.88374116248, 11678.0, 16662.916685416738, 16669.49991500257, 16717.749233761504, 16813.579660508585, 16825.15874206285, 9032.8645070324, 9059.501727405055, 9093.090690930854, 9237.491937943343, 9338.533073346305, 8683.392162548562, 8775.561221939006, 8870.955645221733, 8952.910470895338, 9197.95401023004, 7044.661514312264, 7107.92892071083, 7114.608696521637, 7151.390937039125, 7276.308750668678, 2011.3563659629071, 2082.937511874646, 2088.6423824514186, 2112.2184791627196, 2148.828093752496, 858.6307887608264, 925.2320573923628, 964.7781010367514, 1035.6064695415694, 1118.105515587543, 20785.688214676793, 20931.267405641032, 21413.250536231157, 21414.25050123238, 21533.244158466074, 1015.4922538730634, 1061.2147011211648, 1100.9669709908715, 1142.457332766929, 1181.3325471108797, 11387.487563059682, 11967.773340486037, 11975.341356225492, 11996.460159292852, 12215.450304736309, 610743.0, 614324.0, 622383.0, 632498.0, 633039.0, 87764.0, 87927.0, 88300.55849720711, 88522.0, 91683.0, 1034.4103860799273, 1089.3463921646949, 1099.373357186412, 1104.9668509944715, 1108.5621179634, 18013.2794688211, 18293.451196464128, 18826.435206943814, 18866.811331887053, 19110.426687199408, 36752.0, 42836.14327713366, 42850.357244640734, 42862.57137428711, 44040.0, 54980.17529736977, 55358.0, 55562.0, 56322.43677563336, 56538.1519277203, 8793.780155496164, 8833.734987950373, 8909.287257019552, 8920.107989201028, 8927.553622318988, 7674.846503069795, 11861.347625880659, 12749.681257968254, 13982.650433739238, 14597.343119559433, 11862.466189021343, 11874.52501899949, 12203.75592488163, 12270.87729122733, 12312.938435307766, 11778.587749428729, 12137.69655758613, 12187.268763874195, 12212.633620991384, 12522.87477125217, 12293.262404255773, 12340.0, 12426.254424734545, 12616.306103164046, 12749.87250127487, 8247.9587602064, 8537.103604121727, 8700.434471759316, 8799.208071273617, 8978.236849867835, 11854.822177667515, 11962.700932476757, 12366.443510042249, 12417.19288246261, 12622.55821046259], "value": 9920.265668274626, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1545.4745386568563, 1567.764835274709, 1748.0997286397508, 1863.3943968210326, 1881.8964956927364, 9290.86063709044, 9450.291228157881, 9845.704628861145, 9938.254630902675, 9950.353227040247, 10009.899901000988, 10122.69631911042, 10181.236407269447, 10231.028052335036, 10237.078662920336, 2539.8349107307968, 2578.6905571331467, 2586.159498163095, 2586.3534116470883, 2587.417830988022, 2517.987410062947, 2587.3272949033294, 2590.9093181738644, 2611.6082587611913, 2613.7255588163157, 2551.553478141327, 2559.5008973250224, 2574.909878154265, 2592.1445922845414, 2594.2736033910537, 2521.382261345973, 2528.0772518030876, 2530.177692250026, 2545.9434334751054, 2552.221572420411, 2494.1519883239603, 2496.950060998788, 2513.0576033987254, 2561.129216066546, 2591.5205686947975, 9853.90146098537, 9956.701298961043, 9971.40171589707, 10000.94999525005, 10030.648927287582, 5888.646681199099, 5936.257967754031, 6018.638881667071, 6043.033114701627, 6050.96974515129, 3540.7521473496868, 3620.7827530348263, 3640.7815531068222, 3670.9816450917842, 3688.4098544232793, 1174.3775798826637, 1245.1408528115571, 1262.1480500662017, 1269.7016201192712, 1280.1295119318952, 13031.543895963596, 13423.798643020362, 13480.797788033187, 13878.514252001232, 13904.443822247098, 4928.531789479994, 4931.457539670633, 5035.77339019745, 5089.9745501273, 5113.923291150636, 10750.569977200981, 10836.024757771838, 10848.403337816495, 10869.347839129678, 10873.510692018877, 5572.164175373645, 5619.8595035123635, 5641.464060914206, 5643.887122257532, 5652.830415087554, 5186.948130518722, 5189.922151167735, 5293.973530132402, 5387.919181212285, 5397.568194544427, 4240.469941257343, 4320.006398528356, 4349.978250108792, 4355.1289742051085, 4397.472303323621, 1302.5375991522874, 1314.5399110311505, 1320.5378117658934, 1323.0540163782941, 1329.862967163081, 989.4014121456559, 995.3977843404635, 1019.2661283875598, 1038.3147122899002, 1056.7886422715487, 6247.5939063960695, 6348.143000694847, 6448.516361272923, 6529.706163222666, 6694.230163531159, 494.4659767451144, 494.7204829271522, 497.46025562265345, 498.608592255078, 511.36079900124844, 4275.87172384829, 4404.493483249404, 4426.535213802505, 4501.594856462869, 4547.408836851188, 11952.880471195176, 12260.835220654024, 12267.202631828903, 12282.570110046105, 12292.569760058355, 11495.655130346104, 12149.878501215051, 12181.573644922386, 12292.754144917231, 12479.313637749829, 8562.828743425096, 9036.322275829207, 9044.909550904538, 9072.04743501936, 9091.909080909238, 6359.395857393541, 6375.649339286384, 6447.9355206447335, 6482.54622176462, 6609.834754131185, 11102.2783519071, 11271.7745645085, 11320.660380188607, 11529.365884876412, 11585.131115166228, 11506.884931150582, 11609.3614851184, 11641.185117041725, 11698.415079246173, 11723.472443739882, 7753.224677532202, 8377.874331884905, 8549.615267313111, 8612.267957223707, 8753.868691969497, 9462.14840664316, 9499.097585729345, 9511.286653500876, 9539.09378609031, 9540.904590954002, 8456.450330728729, 8571.40000200005, 8674.566271686264, 8693.174148455886, 8747.825043499222, 7556.65995030214, 7780.299773020455, 7831.2560306770765, 7892.0924093729955, 8016.398770092383, 7075.469339799432, 7111.82220444493, 7364.484486085923, 7403.481756277009, 7417.962910185414, 5418.756155972912, 5487.670739755627, 5521.558275337883, 5560.97219513916, 5646.576506762091, 5681.403452637579, 5681.602287839812, 5789.8263052108505, 5803.129530570448, 5886.558508111823], "value": 4984.850412421826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.68344173685426, 369.1214908517728, 370.5738400839035, 374.7770076804301, 375.56622101472806, 5668.68822214778, 5676.176954341623, 5711.714414279285, 5754.1944127822135, 5832.650040997543, 5616.297962754656, 5680.573956953234, 5700.116481945295, 5706.631747824647, 5729.255196824417, 4473.418455600768, 4476.239039363316, 4478.417805685256, 4479.104179164164, 4481.955180448186, 4292.399064131024, 4459.866204013885, 4473.239549276631, 4501.807021139384, 4518.457785065797, 4401.867943961686, 4418.270985287424, 4421.557844215585, 4435.534268901767, 4435.866923992286, 4429.33559966006, 4430.800613972379, 4434.556544345572, 4443.355713421536, 4456.799444025027, 3726.9627303727157, 3836.232753449321, 3934.504888142516, 3935.4490371348033, 3935.6851451884068, 5526.696031718254, 5540.252065971083, 5541.639793413456, 5558.249636299089, 5572.192032155355, 5060.9493905060845, 5061.215511595708, 5064.0, 5067.923981140286, 5075.187969924795, 5741.3110426748635, 5953.678065554437, 5955.166276721263, 5969.791057312973, 5998.220231369937, 4301.376300436419, 4313.547077556874, 4313.892152696208, 4313.935290970638, 4330.328799036154, 6204.379562043805, 6221.782237621706, 6230.252369715663, 6239.87520249597, 6247.406496382881, 4276.636485898671, 4375.365571992043, 4399.0, 4418.911621767546, 4418.977905110454, 4442.555744425532, 4449.798554390297, 4457.554244575581, 4469.217886869785, 4469.4636643602325, 5074.517920797518, 5079.374600127923, 5096.261042148942, 5102.489751024942, 5111.488851114858, 5817.2257461474655, 5884.881872444222, 5926.947621974687, 5969.671668058299, 5989.550783691154, 1532.831388547259, 1550.9612259693597, 1552.751559750457, 1555.4244929376202, 1559.2203898050975, 941.9293552983554, 986.3736527305069, 987.4124895687055, 997.5560875410517, 1006.4967516241879, 5175.327207463006, 5202.76587553561, 5208.401033881152, 5210.270562121306, 5221.973890130601, 5397.3523177218985, 5429.095433942822, 5451.236826844245, 5454.7272636368025, 5457.399686034533, 4955.677880937727, 5026.773795179226, 5089.440161582223, 5131.25596788471, 5134.768935397841, 2909.316310667034, 2914.329704168053, 2926.941461170765, 2932.252275669691, 2932.2815910101735, 5606.719664016783, 5617.410171931889, 5620.835978148442, 5650.74571644277, 5673.290838645169, 5308.30991971049, 5502.2296878437055, 5508.55931525477, 5522.420145884705, 5542.695151766691, 5556.499915007668, 5634.549236061105, 5658.292713410824, 5659.547236221175, 5687.146927960756, 5206.047732100463, 5418.399168399112, 5438.063445739256, 5445.53712934405, 5461.426550212171, 5341.848309497415, 5343.412224655207, 5362.441924364259, 5362.758675859518, 5374.596905232045, 5560.916586251128, 5595.384507704231, 5597.63615365, 5608.803691870765, 5620.110503861666, 3772.415895111857, 3882.7864467453433, 3980.900477488086, 3987.4018897165656, 4028.6978476613785, 5377.8117765878005, 5396.9460305398015, 5437.933585237584, 5994.820155395345, 6209.472194863307, 6077.604955677867, 6079.665618391031, 6082.330943596289, 6090.634561926298, 6090.847728806815, 6067.54493412987, 6087.239095113111, 6094.969525152346, 6102.633841969496, 6105.938940610537, 5781.161731548817, 6022.638641681513, 6064.423879731418, 6084.847878802888, 6086.482648974887, 6058.303295120942, 6073.514118870568, 6106.389361063858, 6116.66358350295, 6133.202683651097, 5661.886762264814, 5947.851303717442, 5968.671723055274, 5975.820725378072, 5995.910061348996], "value": 4407.358995703807, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.1563973467594, 815.8205194857129, 851.672106239098, 869.8869147010888, 904.5386852705127, 15995.0, 16664.500064998054, 17139.571510712238, 17274.2226599803, 17608.47174584761, 16200.75698864518, 16247.918760406212, 16399.508014759576, 16444.75332870008, 16457.91771041146, 847.0978407995481, 848.5629900601195, 848.9448185867899, 849.452103393311, 850.9914900850974, 842.473454091193, 870.6996086350231, 872.489593587752, 874.4097734029536, 875.5840975536632, 907.7140700679265, 911.8541033434652, 911.9498427586481, 913.830941275866, 917.0829170829171, 909.60432211988, 909.7316291693966, 910.1444642036531, 910.544727636182, 912.5665308978248, 665.6239224837951, 669.3674477618604, 669.5346734019859, 670.9664516774142, 673.6800019990466, 16808.57978550534, 16819.243134058997, 16851.74722379165, 16897.831021689748, 16906.492805215865, 13278.867211327859, 13560.45758169672, 14417.85582144186, 16235.756463653055, 16317.428889988794, 13356.86643133566, 13484.595462136152, 13584.93207533956, 13710.588682339447, 13783.655408614764, 4032.475778148851, 4071.3689378146437, 4071.6335529802163, 4131.669466442708, 4226.049138943744, 87257.0, 87359.56320218422, 88178.0, 88915.0, 89305.55347223287, 11619.244749091282, 11753.294802311888, 11888.346140962158, 11902.285862848257, 12114.575989840314, 22950.540989180125, 22964.65553016706, 22998.770012299996, 23077.76922230756, 23754.64368034481, 8667.263282620921, 9102.954485227532, 9129.771755706028, 9163.03788102253, 9229.123233292827, 5133.332666753298, 5240.135377662643, 5266.34170728659, 5329.200619906967, 5336.893262134736, 4093.5906409358827, 4194.475690538683, 4221.0, 4225.007123326016, 4226.809793559297, 624.7844493649684, 708.2810946888912, 715.1168307140678, 719.162176064889, 720.1034711783863, 752.1650967426152, 792.2908996448147, 807.4186585658434, 827.8509868223657, 845.9703910363107, 9767.804643907082, 10184.592616295413, 10285.9485702571, 10852.837207441895, 11033.227674062899, 612.8284080457479, 684.387473211473, 693.5353313280115, 753.8315610803234, 812.5977641067591, 5217.7912883485, 5235.083860324428, 5296.682199068068, 5316.255724198615, 5404.378496472956, 74254.62872685603, 77478.2252177471, 78040.0, 78775.21224787793, 105280.0, 102893.0, 103295.0, 103552.48223758832, 103563.4821825886, 104088.0, 91950.54024729968, 95705.0, 95972.0, 100831.49584252032, 101131.0, 10479.79040419172, 10770.73073173177, 10841.249244727878, 10882.945585272022, 11035.39305338214, 54282.45717542932, 54945.0, 55930.161047585134, 56160.0, 56871.146932795215, 71953.28046719467, 81432.0, 81591.18408815836, 82769.58615206885, 84374.0, 12437.813432798695, 12725.490980360682, 12727.872721272668, 12819.423125959167, 12860.485580576673, 15988.760168597713, 16254.593635159215, 16351.836481635031, 16502.0, 16606.086665233528, 14305.57083287503, 14569.271536423348, 14586.708265834835, 14602.707945840812, 15231.16228607393, 13379.264140472367, 13441.932790335986, 13757.656058598615, 13863.65340866446, 14338.426462941365, 14047.157170569799, 14288.071275367069, 14524.901460125773, 14717.33771980242, 15353.07881527112, 11454.599089031844, 11764.58823941158, 11788.587399440978, 12155.57455489089, 12668.809967850306, 12202.938985305016, 12278.75442491163, 12512.687182820502, 12888.613341599766, 12895.677608059874], "value": 8110.651108980969, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 108.0, 112.0, 112.0, 110.0, 110.0, 113.0, 112.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 138.0, 166.0, 116.0, 154.0, 143.0, 118.0, 167.0, 121.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 161.0, 162.0, 163.0, 163.0, 163.0, 162.0, 162.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 184.0, 76.0, 75.0, 76.0, 75.0, 170.0, 75.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 143.0, 83.0, 84.0, 83.0, 135.0, 86.0, 84.0, 141.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 146.0, 148.0, 148.0, 146.0, 146.0, 147.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 52.0, 53.0, 53.0, 52.0, 51.0, 53.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 62.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 73.0, 72.0, 81.0, 73.0, 78.0, 73.0, 73.0, 72.0, 75.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 121.0, 120.0, 126.0, 137.0, 121.0, 126.0, 121.0, 152.0, 123.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 154.0, 160.0, 153.0, 152.0, 153.0, 159.0, 156.0, 157.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 62.0, 65.0, 62.0, 60.0, 61.0], "value": 62.6, "unit": "score"}]}]} 16:09:02 INFO - Return code: 0 16:09:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:02 ERROR - # TBPL SUCCESS # 16:09:02 INFO - Running post-action listener: _resource_record_post_action 16:09:02 INFO - [mozharness: 2016-10-12 23:09:02.950582Z] Finished run-tests step (success) 16:09:02 INFO - Running post-run listener: _resource_record_post_run 16:09:03 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 1736704; Write bytes: 290873344; Read time: 52; Write time: 186352 16:09:03 INFO - TinderboxPrint: CPU usage
13.2% 16:09:03 INFO - TinderboxPrint: I/O read bytes / time
1,736,704 / 52 16:09:03 INFO - TinderboxPrint: I/O write bytes / time
290,873,344 / 186,352 16:09:03 INFO - TinderboxPrint: CPU idle
8,195.5 (86.7%) 16:09:03 INFO - TinderboxPrint: CPU user
1,196.7 (12.7%) 16:09:03 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:03 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70123520; Read time: 0; Write time: 62844 16:09:03 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220749824; Read time: 16; Write time: 123508 16:09:03 INFO - Running post-run listener: _upload_blobber_files 16:09:03 INFO - Blob upload gear active. 16:09:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:09:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:09:03 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:07 INFO - (blobuploader) - INFO - Done attempting. 16:09:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:09:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:09 INFO - (blobuploader) - INFO - Done attempting. 16:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:09 INFO - (blobuploader) - INFO - Done attempting. 16:09:09 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:09 INFO - Return code: 0 16:09:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b27e045a7ef4d8d5ffd4459a014678604d4b8417d7a03e184ffead2af5d5a37b719bfdb7885e35d524b9e3c8ca2bfeba23bf5f47c6b2e72718a0f12275a6ea59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b6202f8d8615f81ae154480fa3ef294eb47d3bb4c9c376d8d9027b4a3b2df17bda0092b9d9e33a133f87ef778c21e4a4aa276ae96d9d38a1a5723aad9df7613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4dd106b8b47d40d99bf8720da6cfc94661f429d9932f9878a9c2d677b9a7f14e825dd1edc07e8b811f11dacf13b39981ed492e89a6fbf211216eb98a7f69bfbe"} 16:09:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:09 INFO - Contents: 16:09:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b27e045a7ef4d8d5ffd4459a014678604d4b8417d7a03e184ffead2af5d5a37b719bfdb7885e35d524b9e3c8ca2bfeba23bf5f47c6b2e72718a0f12275a6ea59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b6202f8d8615f81ae154480fa3ef294eb47d3bb4c9c376d8d9027b4a3b2df17bda0092b9d9e33a133f87ef778c21e4a4aa276ae96d9d38a1a5723aad9df7613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4dd106b8b47d40d99bf8720da6cfc94661f429d9932f9878a9c2d677b9a7f14e825dd1edc07e8b811f11dacf13b39981ed492e89a6fbf211216eb98a7f69bfbe"} 16:09:09 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:09 INFO - Copying logs to upload dir... 16:09:09 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1672.643741 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-10-12 16:09:09.561439) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 16:09:09.565147) ========= 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=1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768 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/b27e045a7ef4d8d5ffd4459a014678604d4b8417d7a03e184ffead2af5d5a37b719bfdb7885e35d524b9e3c8ca2bfeba23bf5f47c6b2e72718a0f12275a6ea59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b6202f8d8615f81ae154480fa3ef294eb47d3bb4c9c376d8d9027b4a3b2df17bda0092b9d9e33a133f87ef778c21e4a4aa276ae96d9d38a1a5723aad9df7613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4dd106b8b47d40d99bf8720da6cfc94661f429d9932f9878a9c2d677b9a7f14e825dd1edc07e8b811f11dacf13b39981ed492e89a6fbf211216eb98a7f69bfbe"} build_url:https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011468 build_url: 'https://queue.taskcluster.net/v1/task/VjZaOLD6RPGyJuynRWndag/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/b27e045a7ef4d8d5ffd4459a014678604d4b8417d7a03e184ffead2af5d5a37b719bfdb7885e35d524b9e3c8ca2bfeba23bf5f47c6b2e72718a0f12275a6ea59", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b6202f8d8615f81ae154480fa3ef294eb47d3bb4c9c376d8d9027b4a3b2df17bda0092b9d9e33a133f87ef778c21e4a4aa276ae96d9d38a1a5723aad9df7613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4dd106b8b47d40d99bf8720da6cfc94661f429d9932f9878a9c2d677b9a7f14e825dd1edc07e8b811f11dacf13b39981ed492e89a6fbf211216eb98a7f69bfbe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 16:09:09.590520) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 16:09:09.590865) ========= 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=1f5564757af27664ca02d71f000001b0-1476312074.480175-1801322768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 16:09:09.674742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 16:09:09.675066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 16:09:09.675393) ========= ========= Total master_lag: 0.16 =========