builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1475119665.42 results: success (0) buildid: 20160928172420 builduid: e0f252a43d7d4af08fab12944d009060 revision: 5d980c0c1885844a8604e203ee5ad49628f90de8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:45.424941) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:45.425650) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:45.426098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:45.442222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:45.442749) ========= 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-1475119665.296833-1362112107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 20:27:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.3M=0s 2016-09-28 20:27:46 (88.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125296 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:45.611082) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:45.611447) ========= 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-1475119665.296833-1362112107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016422 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:45.737695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 20:27:45.738168) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5d980c0c1885844a8604e203ee5ad49628f90de8 --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 5d980c0c1885844a8604e203ee5ad49628f90de8 --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-1475119665.296833-1362112107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 20:27:46,483 truncating revision to first 12 chars 2016-09-28 20:27:46,483 Setting DEBUG logging. 2016-09-28 20:27:46,483 attempt 1/10 2016-09-28 20:27:46,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5d980c0c1885?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 20:27:47,290 unpacking tar archive at: mozilla-beta-5d980c0c1885/testing/mozharness/ program finished with exit code 0 elapsedTime=1.229382 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 20:27:46.981506) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:46.981898) ========= script_repo_revision: 5d980c0c1885844a8604e203ee5ad49628f90de8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:46.982356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:46.982689) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 20:27:46.991936) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-09-28 20:27:46.992263) ========= /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-1475119665.296833-1362112107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:27:47 INFO - MultiFileLogger online at 20160928 20:27:47 in /builds/slave/test 20:27:47 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 20:27:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:27:47 INFO - {'append_to_log': False, 20:27:47 INFO - 'base_work_dir': '/builds/slave/test', 20:27:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:27:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:27:47 INFO - 'branch': 'Mozilla-Beta', 20:27:47 INFO - 'buildbot_json_path': 'buildprops.json', 20:27:47 INFO - 'config_files': ('talos/linux_config.py',), 20:27:47 INFO - 'default_actions': ('clobber', 20:27:47 INFO - 'read-buildbot-config', 20:27:47 INFO - 'download-and-extract', 20:27:47 INFO - 'populate-webroot', 20:27:47 INFO - 'create-virtualenv', 20:27:47 INFO - 'install', 20:27:47 INFO - 'run-tests'), 20:27:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:27:47 INFO - 'download_minidump_stackwalk': True, 20:27:47 INFO - 'download_symbols': 'ondemand', 20:27:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:27:47 INFO - 'tooltool.py': '/tools/tooltool.py', 20:27:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:27:47 INFO - '/tools/misc-python/virtualenv.py')}, 20:27:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:27:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:27:47 INFO - 'installer_path': 'installer.exe', 20:27:47 INFO - 'log_level': 'info', 20:27:47 INFO - 'log_name': 'talos', 20:27:47 INFO - 'log_to_console': True, 20:27:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:27:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:27:47 INFO - 'opt_config_files': (), 20:27:47 INFO - 'pip_index': False, 20:27:47 INFO - 'sps_profile': False, 20:27:47 INFO - 'sps_profile_interval': 0, 20:27:47 INFO - 'suite': 'dromaeojs-e10s', 20:27:47 INFO - 'system_bits': '32', 20:27:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:27:47 INFO - 'title': 'talos-linux64-ix-027', 20:27:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:27:47 INFO - 'use_talos_json': True, 20:27:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:27:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:27:47 INFO - 'work_dir': 'build'} 20:27:47 INFO - [mozharness: 2016-09-29 03:27:47.828771Z] Running clobber step. 20:27:47 INFO - Running pre-action listener: _resource_record_pre_action 20:27:47 INFO - Running main action method: clobber 20:27:47 INFO - rmtree: /builds/slave/test/build 20:27:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:27:48 INFO - Running post-action listener: _resource_record_post_action 20:27:48 INFO - [mozharness: 2016-09-29 03:27:48.290850Z] Finished clobber step (success) 20:27:48 INFO - [mozharness: 2016-09-29 03:27:48.290950Z] Running read-buildbot-config step. 20:27:48 INFO - Running pre-action listener: _resource_record_pre_action 20:27:48 INFO - Running main action method: read_buildbot_config 20:27:48 INFO - Using buildbot properties: 20:27:48 INFO - { 20:27:48 INFO - "project": "", 20:27:48 INFO - "product": "firefox", 20:27:48 INFO - "script_repo_revision": "production", 20:27:48 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 20:27:48 INFO - "repository": "", 20:27:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 20:27:48 INFO - "buildid": "20160928172420", 20:27:48 INFO - "pgo_build": "True", 20:27:48 INFO - "basedir": "/builds/slave/test", 20:27:48 INFO - "buildnumber": 133, 20:27:48 INFO - "slavename": "talos-linux64-ix-027", 20:27:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:27:48 INFO - "platform": "ubuntu64_hw", 20:27:48 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 20:27:48 INFO - "branch": "mozilla-beta", 20:27:48 INFO - "repo_path": "releases/mozilla-beta", 20:27:48 INFO - "revision": "5d980c0c1885844a8604e203ee5ad49628f90de8", 20:27:48 INFO - "stage_platform": "linux64-pgo", 20:27:48 INFO - "builduid": "e0f252a43d7d4af08fab12944d009060", 20:27:48 INFO - "slavebuilddir": "test" 20:27:48 INFO - } 20:27:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 20:27:48 INFO - Running post-action listener: _resource_record_post_action 20:27:48 INFO - [mozharness: 2016-09-29 03:27:48.293389Z] Finished read-buildbot-config step (success) 20:27:48 INFO - [mozharness: 2016-09-29 03:27:48.293478Z] Running download-and-extract step. 20:27:48 INFO - Running pre-action listener: _resource_record_pre_action 20:27:48 INFO - Running main action method: download_and_extract 20:27:48 INFO - mkdir: /builds/slave/test/build/tests 20:27: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')]} 20:27:48 INFO - https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:27:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 20:27:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 20:27:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:27:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 20:27:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:27:48 INFO - retry: Failed, sleeping 30 seconds before retrying 20:28:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:28:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 20:28:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:28:18 INFO - retry: Failed, sleeping 60 seconds before retrying 20:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:29:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 20:29:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:29:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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! 20:29:18 INFO - Caught exception: HTTP Error 404: Not Found 20:29:18 INFO - Caught exception: HTTP Error 404: Not Found 20:29:18 INFO - Caught exception: HTTP Error 404: Not Found 20:29:18 INFO - trying https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 20:29:18 INFO - Downloading https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:29:19 INFO - Downloaded 1327 bytes. 20:29:19 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 20:29:19 INFO - Using the following test package requirements: 20:29:19 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 20:29:19 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 20:29:19 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 20:29:19 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 20:29:19 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 20:29:19 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 20:29:19 INFO - u'jsshell-linux-x86_64.zip'], 20:29:19 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 20:29:19 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 20:29:19 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 20:29:19 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 20:29:19 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 20:29:19 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 20:29:19 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 20:29:19 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 20:29:19 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 20:29:19 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 20:29:19 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 20:29:19 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:29:19 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')]} 20:29:19 INFO - https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:29:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:29:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:29:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:29:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:29:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:29:19 INFO - retry: Failed, sleeping 30 seconds before retrying 20:29:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:29:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:29:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:29:49 INFO - retry: Failed, sleeping 60 seconds before retrying 20:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:30:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:30:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:30:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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! 20:30:49 INFO - Caught exception: HTTP Error 404: Not Found 20:30:49 INFO - Caught exception: HTTP Error 404: Not Found 20:30:49 INFO - Caught exception: HTTP Error 404: Not Found 20:30:49 INFO - trying https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:30:49 INFO - Downloading https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:30:50 INFO - Downloaded 21772459 bytes. 20:30:50 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'] 20:30:50 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 20:30:51 INFO - Return code: 0 20:30:51 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 20:30:51 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')]} 20:30:51 INFO - https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:30:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:30:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:30:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:30:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:30:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:30:51 INFO - retry: Failed, sleeping 30 seconds before retrying 20:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:31:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:31:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:31:21 INFO - retry: Failed, sleeping 60 seconds before retrying 20:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:32:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:32:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:32:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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! 20:32:21 INFO - Caught exception: HTTP Error 404: Not Found 20:32:21 INFO - Caught exception: HTTP Error 404: Not Found 20:32:21 INFO - Caught exception: HTTP Error 404: Not Found 20:32:21 INFO - trying https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 20:32:21 INFO - Downloading https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:32:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:32:22 INFO - Downloaded 21772459 bytes. 20:32:22 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'] 20:32:22 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 20:32:23 INFO - Return code: 0 20:32:23 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')]} 20:32:23 INFO - https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:32:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 20:32:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 20:32:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:32:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:32:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 20:32:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:32:23 INFO - retry: Failed, sleeping 30 seconds before retrying 20:32:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:32:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 20:32:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:32:53 INFO - retry: Failed, sleeping 60 seconds before retrying 20:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:33:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 20:33:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:33:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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! 20:33:53 INFO - Caught exception: HTTP Error 404: Not Found 20:33:53 INFO - Caught exception: HTTP Error 404: Not Found 20:33:53 INFO - Caught exception: HTTP Error 404: Not Found 20:33:53 INFO - trying https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 20:33:53 INFO - Downloading https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:33:54 INFO - Downloaded 14413740 bytes. 20:33:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:33:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:33:54 INFO - Return code: 0 20:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:33:54 INFO - https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:33:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 20:33:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 20:33:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:33:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:33:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 20:33:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 20:33:54 INFO - retry: Failed, sleeping 30 seconds before retrying 20:34:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:34:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 20:34:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 20:34:24 INFO - retry: Failed, sleeping 60 seconds before retrying 20:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:35:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 20:35:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 20:35:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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! 20:35:25 INFO - Caught exception: HTTP Error 404: Not Found 20:35:25 INFO - Caught exception: HTTP Error 404: Not Found 20:35:25 INFO - Caught exception: HTTP Error 404: Not Found 20:35:25 INFO - trying https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 20:35:25 INFO - Downloading https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:35:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:35:26 INFO - Downloaded 56764023 bytes. 20:35:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 20:35:26 INFO - mkdir: /builds/slave/test/properties 20:35:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:35:26 INFO - Writing to file /builds/slave/test/properties/build_url 20:35:26 INFO - Contents: 20:35:26 INFO - build_url:https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 20:35:26 INFO - Running post-action listener: _resource_record_post_action 20:35:26 INFO - Running post-action listener: set_extra_try_arguments 20:35:26 INFO - [mozharness: 2016-09-29 03:35:26.792926Z] Finished download-and-extract step (success) 20:35:26 INFO - [mozharness: 2016-09-29 03:35:26.793157Z] Running populate-webroot step. 20:35:26 INFO - Running pre-action listener: _resource_record_pre_action 20:35:26 INFO - Running main action method: populate_webroot 20:35:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:35:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:35:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:35:26 INFO - '--tppagecycles', 20:35:26 INFO - '7'], 20:35:26 INFO - 'tests': ['tsvgm']}}, 20:35:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:35:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:35:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:35:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:35:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:35:26 INFO - 'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:35:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:35:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:35:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:35:26 INFO - 'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['damp', 'tps']}, 20:35:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:35:26 INFO - 'tests': ['damp', 'tps']}, 20:35:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['dromaeo_dom']}, 20:35:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:35:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['basic_compositor_video']}, 20:35:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:35:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['a11yr', 20:35:26 INFO - 'ts_paint', 20:35:26 INFO - 'tpaint', 20:35:26 INFO - 'sessionrestore', 20:35:26 INFO - 'sessionrestore_no_auto_restore', 20:35:26 INFO - 'tabpaint']}, 20:35:26 INFO - 'other-e10s': {'tests': ['a11yr', 20:35:26 INFO - 'ts_paint', 20:35:26 INFO - 'tpaint', 20:35:26 INFO - 'sessionrestore', 20:35:26 INFO - 'sessionrestore_no_auto_restore', 20:35:26 INFO - 'tabpaint']}, 20:35:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:35:26 INFO - 'ts_paint', 20:35:26 INFO - 'tpaint', 20:35:26 INFO - 'sessionrestore', 20:35:26 INFO - 'sessionrestore_no_auto_restore', 20:35:26 INFO - 'tabpaint']}, 20:35:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:35:26 INFO - 'ts_paint', 20:35:26 INFO - 'tpaint', 20:35:26 INFO - 'sessionrestore', 20:35:26 INFO - 'sessionrestore_no_auto_restore', 20:35:26 INFO - 'tabpaint']}, 20:35:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['a11yr', 20:35:26 INFO - 'ts_paint', 20:35:26 INFO - 'tpaint', 20:35:26 INFO - 'sessionrestore', 20:35:26 INFO - 'sessionrestore_no_auto_restore', 20:35:26 INFO - 'tabpaint']}, 20:35:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['a11yr', 20:35:26 INFO - 'ts_paint', 20:35:26 INFO - 'tpaint', 20:35:26 INFO - 'sessionrestore', 20:35:26 INFO - 'sessionrestore_no_auto_restore', 20:35:26 INFO - 'tabpaint']}, 20:35:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['tsvgx', 20:35:26 INFO - 'tsvgr_opacity', 20:35:26 INFO - 'tart', 20:35:26 INFO - 'tscrollx', 20:35:26 INFO - 'cart']}, 20:35:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:35:26 INFO - 'tsvgr_opacity', 20:35:26 INFO - 'tart', 20:35:26 INFO - 'tscrollx', 20:35:26 INFO - 'cart']}, 20:35:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:35:26 INFO - 'talos_options': ['--disable-e10s'], 20:35:26 INFO - 'tests': ['tp5o']}, 20:35:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:35:26 INFO - 'tests': ['tp5o']}, 20:35:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:35:26 INFO - 'talos_options': ['--disable-e10s', 20:35:26 INFO - '--xperf_path', 20:35:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:35:26 INFO - 'tests': ['tp5n']}, 20:35:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:35:26 INFO - 'talos_options': ['--xperf_path', 20:35:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:35:26 INFO - 'tests': ['tp5n']}}, 20:35:26 INFO - 'talos.zip': {'path': '', 20:35:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:35:26 INFO - Running post-action listener: _resource_record_post_action 20:35:26 INFO - [mozharness: 2016-09-29 03:35:26.813472Z] Finished populate-webroot step (success) 20:35:26 INFO - [mozharness: 2016-09-29 03:35:26.813571Z] Running create-virtualenv step. 20:35:26 INFO - Running pre-action listener: _resource_record_pre_action 20:35:26 INFO - Running main action method: create_virtualenv 20:35:26 INFO - Creating virtualenv /builds/slave/test/build/venv 20:35:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:35:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:35:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:35:26 INFO - Using real prefix '/usr' 20:35:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:35:27 INFO - Installing distribute.............................................................................................................................................................................................done. 20:35:29 INFO - Installing pip.................done. 20:35:29 INFO - Return code: 0 20:35:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:35:29 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')]} 20:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:29 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')]} 20:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:29 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 0x1467030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1696400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, '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-1475119665.296833-1362112107', '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 20:35:29 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 20:35:29 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 20:35:29 INFO - Using env: {'DISPLAY': ':0', 20:35:29 INFO - 'HOME': '/home/cltbld', 20:35:29 INFO - 'LANG': 'en_US.UTF-8', 20:35:29 INFO - 'LANGUAGE': 'en_US:en', 20:35:29 INFO - 'LOGNAME': 'cltbld', 20:35:29 INFO - 'MAIL': '/var/mail/cltbld', 20:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:29 INFO - 'MOZ_NO_REMOTE': '1', 20:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:29 INFO - 'NO_EM_RESTART': '1', 20:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:29 INFO - 'PWD': '/builds/slave/test', 20:35:29 INFO - 'SHELL': '/bin/bash', 20:35:29 INFO - 'SHLVL': '1', 20:35:29 INFO - 'TERM': 'linux', 20:35:29 INFO - 'TMOUT': '86400', 20:35:29 INFO - 'USER': 'cltbld', 20:35:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:29 INFO - '_': '/tools/buildbot/bin/python'} 20:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:29 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 20:35:29 INFO - Cleaning up... 20:35:29 INFO - Return code: 0 20:35:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:35:29 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')]} 20:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:29 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')]} 20:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:29 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 0x1467030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1696400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, '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-1475119665.296833-1362112107', '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 20:35:29 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 20:35:29 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 20:35:29 INFO - Using env: {'DISPLAY': ':0', 20:35:29 INFO - 'HOME': '/home/cltbld', 20:35:29 INFO - 'LANG': 'en_US.UTF-8', 20:35:29 INFO - 'LANGUAGE': 'en_US:en', 20:35:29 INFO - 'LOGNAME': 'cltbld', 20:35:29 INFO - 'MAIL': '/var/mail/cltbld', 20:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:29 INFO - 'MOZ_NO_REMOTE': '1', 20:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:29 INFO - 'NO_EM_RESTART': '1', 20:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:29 INFO - 'PWD': '/builds/slave/test', 20:35:29 INFO - 'SHELL': '/bin/bash', 20:35:29 INFO - 'SHLVL': '1', 20:35:29 INFO - 'TERM': 'linux', 20:35:29 INFO - 'TMOUT': '86400', 20:35:29 INFO - 'USER': 'cltbld', 20:35:29 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:29 INFO - '_': '/tools/buildbot/bin/python'} 20:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:29 INFO - Downloading/unpacking psutil>=3.1.1 20:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:35:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:35:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:35:31 INFO - Installing collected packages: psutil 20:35:31 INFO - Running setup.py install for psutil 20:35:31 INFO - building 'psutil._psutil_linux' extension 20:35:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:35:32 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 20:35:32 INFO - building 'psutil._psutil_posix' extension 20:35:32 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 20:35:32 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 20:35:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:35:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:35:32 INFO - Successfully installed psutil 20:35:32 INFO - Cleaning up... 20:35:32 INFO - Return code: 0 20:35:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1467030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1696400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, '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-1475119665.296833-1362112107', '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 20:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:35:32 INFO - Using env: {'DISPLAY': ':0', 20:35:32 INFO - 'HOME': '/home/cltbld', 20:35:32 INFO - 'LANG': 'en_US.UTF-8', 20:35:32 INFO - 'LANGUAGE': 'en_US:en', 20:35:32 INFO - 'LOGNAME': 'cltbld', 20:35:32 INFO - 'MAIL': '/var/mail/cltbld', 20:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:32 INFO - 'MOZ_NO_REMOTE': '1', 20:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:32 INFO - 'NO_EM_RESTART': '1', 20:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:32 INFO - 'PWD': '/builds/slave/test', 20:35:32 INFO - 'SHELL': '/bin/bash', 20:35:32 INFO - 'SHLVL': '1', 20:35:32 INFO - 'TERM': 'linux', 20:35:32 INFO - 'TMOUT': '86400', 20:35:32 INFO - 'USER': 'cltbld', 20:35:32 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:32 INFO - '_': '/tools/buildbot/bin/python'} 20:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:35:32 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 20:35:32 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 20:35:32 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 20:35:32 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 20:35:32 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 20:35:32 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 20:35:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:35:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:35:34 INFO - Installing collected packages: mozsystemmonitor 20:35:34 INFO - Running setup.py install for mozsystemmonitor 20:35:34 INFO - Successfully installed mozsystemmonitor 20:35:34 INFO - Cleaning up... 20:35:34 INFO - Return code: 0 20:35:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1467030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1696400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, '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-1475119665.296833-1362112107', '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 20:35:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:35:34 INFO - Using env: {'DISPLAY': ':0', 20:35:34 INFO - 'HOME': '/home/cltbld', 20:35:34 INFO - 'LANG': 'en_US.UTF-8', 20:35:34 INFO - 'LANGUAGE': 'en_US:en', 20:35:34 INFO - 'LOGNAME': 'cltbld', 20:35:34 INFO - 'MAIL': '/var/mail/cltbld', 20:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:34 INFO - 'MOZ_NO_REMOTE': '1', 20:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:34 INFO - 'NO_EM_RESTART': '1', 20:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:34 INFO - 'PWD': '/builds/slave/test', 20:35:34 INFO - 'SHELL': '/bin/bash', 20:35:34 INFO - 'SHLVL': '1', 20:35:34 INFO - 'TERM': 'linux', 20:35:34 INFO - 'TMOUT': '86400', 20:35:34 INFO - 'USER': 'cltbld', 20:35:34 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:34 INFO - '_': '/tools/buildbot/bin/python'} 20:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:34 INFO - Downloading/unpacking jsonschema==2.5.1 20:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:35:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:37 INFO - Downloading functools32-3.2.3-2.tar.gz 20:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:35:37 INFO - warning: no files found matching '*.txt' 20:35:37 INFO - no previously-included directories found matching 'build' 20:35:37 INFO - no previously-included directories found matching 'dist' 20:35:37 INFO - no previously-included directories found matching '.git*' 20:35:37 INFO - Installing collected packages: jsonschema, functools32 20:35:37 INFO - Running setup.py install for functools32 20:35:37 INFO - warning: no files found matching '*.txt' 20:35:37 INFO - no previously-included directories found matching 'build' 20:35:37 INFO - no previously-included directories found matching 'dist' 20:35:37 INFO - no previously-included directories found matching '.git*' 20:35:37 INFO - Successfully installed jsonschema functools32 20:35:37 INFO - Cleaning up... 20:35:37 INFO - Return code: 0 20:35:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:35:37 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')]} 20:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:37 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')]} 20:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:37 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 0x1467030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1696400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, '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-1475119665.296833-1362112107', '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 20:35:37 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 20:35:37 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 20:35:37 INFO - Using env: {'DISPLAY': ':0', 20:35:37 INFO - 'HOME': '/home/cltbld', 20:35:37 INFO - 'LANG': 'en_US.UTF-8', 20:35:37 INFO - 'LANGUAGE': 'en_US:en', 20:35:37 INFO - 'LOGNAME': 'cltbld', 20:35:37 INFO - 'MAIL': '/var/mail/cltbld', 20:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:37 INFO - 'MOZ_NO_REMOTE': '1', 20:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:37 INFO - 'NO_EM_RESTART': '1', 20:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:37 INFO - 'PWD': '/builds/slave/test', 20:35:37 INFO - 'SHELL': '/bin/bash', 20:35:37 INFO - 'SHLVL': '1', 20:35:37 INFO - 'TERM': 'linux', 20:35:37 INFO - 'TMOUT': '86400', 20:35:37 INFO - 'USER': 'cltbld', 20:35:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:37 INFO - '_': '/tools/buildbot/bin/python'} 20:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:35:37 INFO - Cleaning up... 20:35:37 INFO - Return code: 0 20:35:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:35:37 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')]} 20:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:37 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')]} 20:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:37 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 0x1467030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1696400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, '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-1475119665.296833-1362112107', '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 20:35:37 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 20:35:37 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 20:35:37 INFO - Using env: {'DISPLAY': ':0', 20:35:37 INFO - 'HOME': '/home/cltbld', 20:35:37 INFO - 'LANG': 'en_US.UTF-8', 20:35:37 INFO - 'LANGUAGE': 'en_US:en', 20:35:37 INFO - 'LOGNAME': 'cltbld', 20:35:37 INFO - 'MAIL': '/var/mail/cltbld', 20:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:37 INFO - 'MOZ_NO_REMOTE': '1', 20:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:37 INFO - 'NO_EM_RESTART': '1', 20:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:37 INFO - 'PWD': '/builds/slave/test', 20:35:37 INFO - 'SHELL': '/bin/bash', 20:35:37 INFO - 'SHLVL': '1', 20:35:37 INFO - 'TERM': 'linux', 20:35:37 INFO - 'TMOUT': '86400', 20:35:37 INFO - 'USER': 'cltbld', 20:35:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:37 INFO - '_': '/tools/buildbot/bin/python'} 20:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:37 INFO - Downloading/unpacking blobuploader==1.2.4 20:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:39 INFO - Downloading blobuploader-1.2.4.tar.gz 20:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:35:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:35:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:35:40 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 20:35:40 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 20:35:40 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 20:35:40 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 20:35:40 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 20:35:40 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 20:35:40 INFO - Downloading docopt-0.6.1.tar.gz 20:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:35:40 INFO - Installing collected packages: blobuploader, requests, docopt 20:35:40 INFO - Running setup.py install for blobuploader 20:35:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:35:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:35:40 INFO - Running setup.py install for requests 20:35:40 INFO - Running setup.py install for docopt 20:35:40 INFO - Successfully installed blobuploader requests docopt 20:35:40 INFO - Cleaning up... 20:35:40 INFO - Return code: 0 20:35:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1467030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1696400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, '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-1475119665.296833-1362112107', '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 20:35:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:35:40 INFO - Using env: {'DISPLAY': ':0', 20:35:40 INFO - 'HOME': '/home/cltbld', 20:35:40 INFO - 'LANG': 'en_US.UTF-8', 20:35:40 INFO - 'LANGUAGE': 'en_US:en', 20:35:40 INFO - 'LOGNAME': 'cltbld', 20:35:40 INFO - 'MAIL': '/var/mail/cltbld', 20:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:40 INFO - 'MOZ_NO_REMOTE': '1', 20:35:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:40 INFO - 'NO_EM_RESTART': '1', 20:35:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:40 INFO - 'PWD': '/builds/slave/test', 20:35:40 INFO - 'SHELL': '/bin/bash', 20:35:40 INFO - 'SHLVL': '1', 20:35:40 INFO - 'TERM': 'linux', 20:35:40 INFO - 'TMOUT': '86400', 20:35:40 INFO - 'USER': 'cltbld', 20:35:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:40 INFO - '_': '/tools/buildbot/bin/python'} 20:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:35:41 INFO - Running setup.py (path:/tmp/pip-flFUHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:35:41 INFO - Running setup.py (path:/tmp/pip-LXb6qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:35:41 INFO - Running setup.py (path:/tmp/pip-dgPJsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:35:41 INFO - Running setup.py (path:/tmp/pip-Axt1Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:35:41 INFO - Running setup.py (path:/tmp/pip-ar8CQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:35:41 INFO - Running setup.py (path:/tmp/pip-ebcHfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:35:41 INFO - Running setup.py (path:/tmp/pip-P8oNoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:35:41 INFO - Running setup.py (path:/tmp/pip-WU0Vly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:35:41 INFO - Running setup.py (path:/tmp/pip-HsOq0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:35:41 INFO - Running setup.py (path:/tmp/pip-F2URR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:35:41 INFO - Running setup.py (path:/tmp/pip-rfetro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:35:41 INFO - Running setup.py (path:/tmp/pip-4AyRgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:35:42 INFO - Running setup.py (path:/tmp/pip-qjkgd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:35:42 INFO - Running setup.py (path:/tmp/pip-xjR2tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:42 INFO - Running setup.py (path:/tmp/pip-DRqZBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:35:42 INFO - Running setup.py (path:/tmp/pip-poUkHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:35:42 INFO - Running setup.py (path:/tmp/pip-_WA9Oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:35:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:35:42 INFO - Running setup.py install for manifestparser 20:35:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:35:42 INFO - Running setup.py install for mozcrash 20:35:42 INFO - Running setup.py install for mozdebug 20:35:42 INFO - Running setup.py install for mozdevice 20:35:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:35:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:35:42 INFO - Running setup.py install for mozfile 20:35:42 INFO - Running setup.py install for mozhttpd 20:35:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Running setup.py install for mozinfo 20:35:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Running setup.py install for mozInstall 20:35:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Running setup.py install for mozleak 20:35:43 INFO - Running setup.py install for mozlog 20:35:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Running setup.py install for moznetwork 20:35:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Running setup.py install for mozprocess 20:35:43 INFO - Running setup.py install for mozprofile 20:35:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Running setup.py install for mozrunner 20:35:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:35:43 INFO - Running setup.py install for mozscreenshot 20:35:43 INFO - Running setup.py install for moztest 20:35:44 INFO - Running setup.py install for mozversion 20:35:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:35:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:35:44 INFO - Cleaning up... 20:35:44 INFO - Return code: 0 20:35:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35:44 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')]} 20:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:44 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')]} 20:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:44 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 0x1467030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1696400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, '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-1475119665.296833-1362112107', '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 20:35:44 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 20:35:44 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 20:35:44 INFO - Using env: {'DISPLAY': ':0', 20:35:44 INFO - 'HOME': '/home/cltbld', 20:35:44 INFO - 'LANG': 'en_US.UTF-8', 20:35:44 INFO - 'LANGUAGE': 'en_US:en', 20:35:44 INFO - 'LOGNAME': 'cltbld', 20:35:44 INFO - 'MAIL': '/var/mail/cltbld', 20:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:44 INFO - 'MOZ_NO_REMOTE': '1', 20:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:44 INFO - 'NO_EM_RESTART': '1', 20:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:44 INFO - 'PWD': '/builds/slave/test', 20:35:44 INFO - 'SHELL': '/bin/bash', 20:35:44 INFO - 'SHLVL': '1', 20:35:44 INFO - 'TERM': 'linux', 20:35:44 INFO - 'TMOUT': '86400', 20:35:44 INFO - 'USER': 'cltbld', 20:35:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:44 INFO - '_': '/tools/buildbot/bin/python'} 20:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:35:44 INFO - Running setup.py (path:/tmp/pip-yJjl2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:35:44 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)) 20:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:35:44 INFO - Running setup.py (path:/tmp/pip-mxfGxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:35:44 INFO - Running setup.py (path:/tmp/pip-rTqeLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:35:44 INFO - Running setup.py (path:/tmp/pip-OWQCg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:35:44 INFO - Running setup.py (path:/tmp/pip-4YI9h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:35:44 INFO - Running setup.py (path:/tmp/pip-3kGTrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:35:44 INFO - Running setup.py (path:/tmp/pip-rTgVTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:35:44 INFO - Running setup.py (path:/tmp/pip-cpGicN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:35:44 INFO - Running setup.py (path:/tmp/pip-AWSNRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:35:45 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)) 20:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:35:45 INFO - Running setup.py (path:/tmp/pip-AH__qS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:35:45 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)) 20:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:35:45 INFO - Running setup.py (path:/tmp/pip-xZidgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:35:45 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)) 20:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:35:45 INFO - Running setup.py (path:/tmp/pip-H5TvNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:35:45 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)) 20:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:35:45 INFO - Running setup.py (path:/tmp/pip-83RcNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:35:45 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)) 20:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:35:45 INFO - Running setup.py (path:/tmp/pip-pUXBmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:35:45 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)) 20:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:45 INFO - Running setup.py (path:/tmp/pip-erJKMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:35:45 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)) 20:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:35:45 INFO - Running setup.py (path:/tmp/pip-1mHlJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:35:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:35:45 INFO - Running setup.py (path:/tmp/pip-M7zoV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:35:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:35:47 INFO - Downloading blessings-1.6.tar.gz 20:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:35:47 INFO - Installing collected packages: blessings 20:35:47 INFO - Running setup.py install for blessings 20:35:47 INFO - Successfully installed blessings 20:35:47 INFO - Cleaning up... 20:35:47 INFO - Return code: 0 20:35:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:35:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:48 INFO - Reading from file tmpfile_stdout 20:35:48 INFO - Current package versions: 20:35:48 INFO - argparse == 1.2.1 20:35:48 INFO - blessings == 1.6 20:35:48 INFO - blobuploader == 1.2.4 20:35:48 INFO - docopt == 0.6.1 20:35:48 INFO - functools32 == 3.2.3-2 20:35:48 INFO - jsonschema == 2.5.1 20:35:48 INFO - manifestparser == 1.1 20:35:48 INFO - mozInstall == 1.12 20:35:48 INFO - mozcrash == 0.17 20:35:48 INFO - mozdebug == 0.1 20:35:48 INFO - mozdevice == 0.48 20:35:48 INFO - mozfile == 1.2 20:35:48 INFO - mozhttpd == 0.7 20:35:48 INFO - mozinfo == 0.9 20:35:48 INFO - mozleak == 0.1 20:35:48 INFO - mozlog == 3.3 20:35:48 INFO - moznetwork == 0.27 20:35:48 INFO - mozprocess == 0.23 20:35:48 INFO - mozprofile == 0.28 20:35:48 INFO - mozrunner == 6.12 20:35:48 INFO - mozscreenshot == 0.1 20:35:48 INFO - mozsystemmonitor == 0.3 20:35:48 INFO - moztest == 0.7 20:35:48 INFO - mozversion == 1.4 20:35:48 INFO - psutil == 3.1.1 20:35:48 INFO - requests == 1.2.3 20:35:48 INFO - wsgiref == 0.1.2 20:35:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:35: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')]} 20:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35: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')]} 20:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:48 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 0x1467030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1696400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, '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-1475119665.296833-1362112107', '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 20:35:48 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 20:35:48 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 20:35:48 INFO - Using env: {'DISPLAY': ':0', 20:35:48 INFO - 'HOME': '/home/cltbld', 20:35:48 INFO - 'LANG': 'en_US.UTF-8', 20:35:48 INFO - 'LANGUAGE': 'en_US:en', 20:35:48 INFO - 'LOGNAME': 'cltbld', 20:35:48 INFO - 'MAIL': '/var/mail/cltbld', 20:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:48 INFO - 'MOZ_NO_REMOTE': '1', 20:35:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:48 INFO - 'NO_EM_RESTART': '1', 20:35:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:48 INFO - 'PWD': '/builds/slave/test', 20:35:48 INFO - 'SHELL': '/bin/bash', 20:35:48 INFO - 'SHLVL': '1', 20:35:48 INFO - 'TERM': 'linux', 20:35:48 INFO - 'TMOUT': '86400', 20:35:48 INFO - 'USER': 'cltbld', 20:35:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:48 INFO - '_': '/tools/buildbot/bin/python'} 20:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:48 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)) 20:35:48 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)) 20:35:48 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)) 20:35:48 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)) 20:35:48 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)) 20:35:48 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)) 20:35:48 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)) 20:35:48 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)) 20:35:48 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)) 20:35:48 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)) 20:35:48 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)) 20:35:48 INFO - Cleaning up... 20:35:48 INFO - Return code: 0 20:35:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:35: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')]} 20:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35: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')]} 20:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:35:48 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 0x1467030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1696400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, '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-1475119665.296833-1362112107', '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 20:35:48 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 20:35:48 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 20:35:48 INFO - Using env: {'DISPLAY': ':0', 20:35:48 INFO - 'HOME': '/home/cltbld', 20:35:48 INFO - 'LANG': 'en_US.UTF-8', 20:35:48 INFO - 'LANGUAGE': 'en_US:en', 20:35:48 INFO - 'LOGNAME': 'cltbld', 20:35:48 INFO - 'MAIL': '/var/mail/cltbld', 20:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:35:48 INFO - 'MOZ_NO_REMOTE': '1', 20:35:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:35:48 INFO - 'NO_EM_RESTART': '1', 20:35:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:35:48 INFO - 'PWD': '/builds/slave/test', 20:35:48 INFO - 'SHELL': '/bin/bash', 20:35:48 INFO - 'SHLVL': '1', 20:35:48 INFO - 'TERM': 'linux', 20:35:48 INFO - 'TMOUT': '86400', 20:35:48 INFO - 'USER': 'cltbld', 20:35:48 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:35:48 INFO - '_': '/tools/buildbot/bin/python'} 20:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:35:48 INFO - Cleaning up... 20:35:48 INFO - Return code: 0 20:35:48 INFO - Running post-action listener: _resource_record_post_action 20:35:48 INFO - Running post-action listener: _start_resource_monitoring 20:35:48 INFO - Starting resource monitoring. 20:35:48 INFO - [mozharness: 2016-09-29 03:35:48.515202Z] Finished create-virtualenv step (success) 20:35:48 INFO - [mozharness: 2016-09-29 03:35:48.515777Z] Running install step. 20:35:48 INFO - Running pre-action listener: _resource_record_pre_action 20:35:48 INFO - Running main action method: install 20:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:35:48 INFO - Reading from file tmpfile_stdout 20:35:48 INFO - Detecting whether we're running mozinstall >=1.0... 20:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:35:48 INFO - Reading from file tmpfile_stdout 20:35:48 INFO - Output received: 20:35:48 INFO - Usage: mozinstall [options] installer 20:35:48 INFO - Options: 20:35:48 INFO - -h, --help show this help message and exit 20:35:48 INFO - -d DEST, --destination=DEST 20:35:48 INFO - Directory to install application into. [default: 20:35:48 INFO - "/builds/slave/test"] 20:35:48 INFO - --app=APP Application being installed. [default: firefox] 20:35:48 INFO - mkdir: /builds/slave/test/build/application 20:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:36:02 INFO - Reading from file tmpfile_stdout 20:36:02 INFO - Output received: 20:36:02 INFO - /builds/slave/test/build/application/firefox/firefox 20:36:02 INFO - Running post-action listener: _resource_record_post_action 20:36:02 INFO - [mozharness: 2016-09-29 03:36:02.854637Z] Finished install step (success) 20:36:02 INFO - [mozharness: 2016-09-29 03:36:02.854973Z] Running run-tests step. 20:36:02 INFO - Running pre-action listener: _resource_record_pre_action 20:36:02 INFO - Running main action method: run_tests 20:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:36:02 INFO - Python 2.7.3 20:36:02 INFO - Return code: 0 20:36:02 INFO - grabbing minidump binary from tooltool 20:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:36:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1725570>, '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 0x1726470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:36:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:36:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:36:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:36:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:36:02 INFO - Return code: 0 20:36:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:36:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:36:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:36:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:36:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:36:02 INFO - Using env: {'DISPLAY': ':0', 20:36:02 INFO - 'HOME': '/home/cltbld', 20:36:02 INFO - 'LANG': 'en_US.UTF-8', 20:36:02 INFO - 'LANGUAGE': 'en_US:en', 20:36:02 INFO - 'LOGNAME': 'cltbld', 20:36:02 INFO - 'MAIL': '/var/mail/cltbld', 20:36:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:36:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:02 INFO - 'MOZ_NO_REMOTE': '1', 20:36:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:36:02 INFO - 'NO_EM_RESTART': '1', 20:36:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:02 INFO - 'PWD': '/builds/slave/test', 20:36:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:36:02 INFO - 'SHELL': '/bin/bash', 20:36:02 INFO - 'SHLVL': '1', 20:36:02 INFO - 'TERM': 'linux', 20:36:02 INFO - 'TMOUT': '86400', 20:36:02 INFO - 'USER': 'cltbld', 20:36:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1475119665.296833-1362112107', 20:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:02 INFO - '_': '/tools/buildbot/bin/python'} 20:36:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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 20:36:03 INFO - mozversion application_buildid: 20160928172420 20:36:03 INFO - mozversion application_changeset: 5d980c0c1885844a8604e203ee5ad49628f90de8 20:36:03 INFO - mozversion application_display_name: Firefox 20:36:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:36:03 INFO - mozversion application_name: Firefox 20:36:03 INFO - mozversion application_remotingname: firefox 20:36:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:36:03 INFO - mozversion application_vendor: Mozilla 20:36:03 INFO - mozversion application_version: 50.0 20:36:03 INFO - mozversion platform_buildid: 20160928172420 20:36:03 INFO - mozversion platform_changeset: 5d980c0c1885844a8604e203ee5ad49628f90de8 20:36:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:36:03 INFO - mozversion platform_version: 50.0 20:36:03 INFO - using testdate: 1475120163 20:36:03 INFO - actual date: 1475120163 20:36:03 INFO - starting webserver on 'localhost:40269' 20:36:03 INFO - SUITE-START | Running 2 tests 20:36:03 INFO - TEST-START | dromaeo_css 20:36:03 INFO - operating with platform_type : linux_ 20:36:03 INFO - Initialising browser for dromaeo_css test... 20:36:03 INFO - TEST-INFO | started process 16215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfSwOF7/profile http://localhost:40269/getInfo.html) 20:36:07 INFO - PROCESS | 16215 | __metrics Screen width/height:1600/1200 20:36:07 INFO - PROCESS | 16215 | colorDepth:24 20:36:07 INFO - PROCESS | 16215 | Browser inner width/height: 1024/697 20:36:07 INFO - PROCESS | 16215 | __metrics 20:36:07 ERROR - PROCESS | 16215 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:36:08 INFO - TEST-INFO | 16215: exit 0 20:36:08 INFO - Browser initialized. 20:36:08 INFO - Running cycle 1/1 for dromaeo_css test... 20:36:08 INFO - TEST-INFO | started process 16338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfSwOF7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:36:20 INFO - PROCESS | 16338 | RSS: Main: 149815296 20:36:20 INFO - PROCESS | 16338 | 20:37:09 INFO - PROCESS | 16338 | 1475120229927 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] 20:39:18 INFO - PROCESS | 16338 | Cycle 1(1): loaded http://localhost:40269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40269/tests/dromaeo/cssquery-ext.html) 20:39:19 INFO - PROCESS | 16338 | RSS: Main: 158367744 20:39:19 INFO - PROCESS | 16338 | 20:42:21 INFO - PROCESS | 16338 | Cycle 1(1): loaded http://localhost:40269/tests/dromaeo/cssquery-ext.html (next: http://localhost:40269/tests/dromaeo/cssquery-jquery.html) 20:42:22 INFO - PROCESS | 16338 | RSS: Main: 155631616 20:42:22 INFO - PROCESS | 16338 | 20:45:24 INFO - PROCESS | 16338 | Cycle 1(1): loaded http://localhost:40269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40269/tests/dromaeo/cssquery-mootools.html) 20:45:24 INFO - PROCESS | 16338 | RSS: Main: 155033600 20:45:24 INFO - PROCESS | 16338 | 20:48:26 INFO - PROCESS | 16338 | Cycle 1(1): loaded http://localhost:40269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40269/tests/dromaeo/cssquery-prototype.html) 20:48:27 INFO - PROCESS | 16338 | RSS: Main: 156585984 20:48:27 INFO - PROCESS | 16338 | 20:51:29 INFO - PROCESS | 16338 | Cycle 1(1): loaded http://localhost:40269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40269/tests/dromaeo/cssquery-yui.html) 20:51:30 INFO - PROCESS | 16338 | RSS: Main: 157679616 20:51:30 INFO - PROCESS | 16338 | 20:54:32 INFO - PROCESS | 16338 | Cycle 1(1): loaded http://localhost:40269/tests/dromaeo/cssquery-yui.html (next: http://localhost:40269/tests/dromaeo/cssquery-dojo.html) 20:54:32 INFO - PROCESS | 16338 | RSS: Main: 157495296 20:54:32 INFO - PROCESS | 16338 | 20:54:32 INFO - PROCESS | 16338 | __start_tp_report 20:54:32 INFO - PROCESS | 16338 | _x_x_mozilla_page_load 20:54:32 INFO - PROCESS | 16338 | _x_x_mozilla_page_load_details 20:54:32 INFO - PROCESS | 16338 | |i|pagename|runs| 20:54:32 INFO - PROCESS | 16338 | |0;dojo.html;3277.5411442398063;3299.868005279789;3304.768666193366;3312;3328.034869887733;5794.884102317951;5835.299764028312;5866.442687944644;5872.148538461921;5874.823755287348;5800.303963524383;5870.354261031283;5871.383504732005;5881.764729410829;5883.588148829584;5234.162533994552;5327.493888080626;5345.732713364317;5375.19372094187;5434.728263586825;5391.973040134794;5392.865178370533;5393.946060539403;5394.541463975567;5412.702301373423;5199.896002079956;5282.3925248596515;5396.028714831329;5403.486668766461;5426.2674538937135;5284.048871203182;5374.6506477078865;5377.46225377463;5383.407825139231;5412.296401467824;5237.973810130925;5340.385855626614;5357.035733567956;5364.758585863607;5365.3293338332705;5579.302587176603;5694.9179655865255;5715.742791574389;5739.942600574024;5844.327902291248;6192.195014648067;6315.684215789192;6325.968370158166;6333.809985700436;6337.809865704036;6294.118823364733;6300.30696623371;6305.716242769086;6350.491960643138;6360.173177486897;5565.6104072714525;5661.065924122515;5862.589618726691;5871.089981052944;5914.053751399755;6064.4541991221;6215.595986260879;6217.409346112112;6236.563440559208;6238.594491358047;5952.434518720715;5955.225820643289;5976.252968378953;5978.820635380858;5979.910301345483;6018.578699491081;6058.969705151446;6095.725692343855;6095.8476038098515;6101.298350689639;6015.518758499309;6141.854248382324;6148.78479253224;6213;6220.440160385497;6196.752129914843;6203.503719702413;6203.596766210182;6214.098955651496;6218.160548325918;4607.308903664477;4657.953420465819;4741.83403580873;4744.4069491313585;4769.14155452022;4111.280525907954;4231.132617813341;4242.957570424318;4256.787160641956;4278.957210427918;5931.555133365015;6039.66781826995;6062.605930614496;6072.787452439144;6093.360197179321;6002.039673652194;6155.538334624921;6286.874262514724;6321.778737744157;6376.458001069868;5963;6024.668643224577;6026.367231440636;6038;6089.330173680892;5389.27244821944;5397.946020539823;5412.864678383072;5413.621046526784;5416.566674666017;6274.6548939808745;6348.650824204713;6412.903806442814;6500.154979852589;6514.804555863332;6330.905036424365;6335.936640633719;6343.873122537616;6345.936540634534;6355.237371515448;6472.449841763315;6530.183727034121;6559.836004099936;6568.310327415744;6572.309907459839;5945.613535120204;6083.878322433438;6114.114890844268;6252.5935814171935;6259.937400625936;6330.746770129143;6331.778387756591;6335.968320158369;6341.397567231105;6350.079238510482;6175.44421002094;6175.660338681416;6177.444030037318;6185.628862268279;6195.504359651127;5911.261092363455;6097.512199023979;6111.663858487648;6150.138980542817;6186.783462578788;6139.201903752483;6150.938490615036;6151.0773383992755;6186.4741496973265;6189.721462534287;6175.320714721287;6203.627782333075;6238.189035425366;6267.96866015667;6309.810705678837;5830.358660547252;5982.58121931478;6041.18444010053;6094.085887116968;6107.358727333566 20:54:32 INFO - PROCESS | 16338 | |1;ext.html;579.7391173971711;601.1943995046637;628.754785633603;702.4450683959672;702.6592102830126;44278.33582496261;45390.09219815602;48669.269960950616;48699.26951095736;48828.51171488284;49521.25718114231;50484.49515504844;50484.74757626207;50559.494405055935;50579.74710126453;9177.999999999984;11138.99999999996;11382.487788049557;11462.885371146307;11807.173497855154;11351.659450216506;11371.772564548704;11455.713607159805;11457.656270311862;11460.656180314603;11334.659960201207;11464;11475.311481311148;11479;11488.71278218047;11443.59947401841;11449.885501145049;11461.140414468948;11462.598809041685;11489.138314626436;11357.375344356056;11414.315141091562;11451.797561256031;11475;11476.655700329004;44303.77848110771;44865.77567112176;44880.10239795186;44902.32646510305;44953.10093798106;3945.8421663133727;3976.76139431635;4026.2148880968225;4097.96350594664;4325.84859529915;37116;37196.81401592975;37209.813950930074;37259.25481490382;37426.25147497062;4729.976350118227;4812.831550895702;4869.123557759602;4898.321216258645;4905.926411103801;395663;398743;399892;401354;405497.9725101385;66018.66990665112;66451;66499;66547.33452665411;66624.33375666181;72044;72254;72254.2774572258;72328;72337.6383118081;17592.73610895812;17897.642047158984;17899.552511187325;17911;17918.462446126636;12371;13004.349782510837;13476.797848032287;13526.256055916821;13839.100458470168;21377.25179618737;21536.676949845765;21587;21607.67588486174;21620.02709878028;7432.5134973005615;7479.700811967569;7554.924450755422;7666.8849967250535;7822;1050.5692666007053;1062.4793851012948;1084.642068117535;1084.8426978088291;1162.9302241865514;33976.83011584926;34331.4850277246;34495.31009379798;34497.31005379929;34660.48009279863;1167.7897978363976;1196.282230661596;1214.678110300771;1220.7558488302375;1271.1483306184878;17755.644887102444;18410.723839142425;18545.25818967253;18605.7209141863;18617.53456163607;661599;662425;669163;671709;672569;67062.66468667724;67304.6634766823;67744.6612766933;67867;67989.66005169942;1427.800107984883;1436.6982933584065;1448.3699590678088;1466.9633857914228;1468.3979568376915;33026;34358;34737.65262347344;34740;34848.65151348454;58955.11567326579;59650.70174649099;59691;59732.70133649304;59909.70045149921;475519;477139;483137;483497;484566;31173.8441307792;32089.67910320867;32157.678423215468;32701.672983269862;33716.49425258574;54123.458765411844;54315.18527222016;54438;54506.454935450136;55406.44593554174;46198.53801461942;46871.29693054675;47141;47965.280520791515;48549;43897.56102439063;46928.29607555958;47332;48533.5146648529;50405.74797125991;46049.53950460452;46719.29921051119;46863;46865.297020545404;47051;38762.41856372213;40934.18131637291;40982;40999.7950010248;41011;30122.24694382658;30374;30574;30724.385512289184;30933 20:54:32 INFO - PROCESS | 16338 | |2;jquery.html;417.46564397571103;417.7430880008792;429.41170596283087;430.9633681137103;439.4748275810406;19230.519237019063;20038;20904.372868813924;20909.37271881842;20949.58100837986;19795.20819167235;20430.2849400271;20634.89682551585;20836.89581552094;20935.95320233986;5843.474087332139;6052.334243233241;6059.242594675666;6061.333253342129;6068.362821903703;5629.831105066834;5824.504917082053;5860.882782344351;5913.379095195007;5997.070454079625;5837.941620583782;5859.0625499920025;5925.4963328117165;5941.7029148542615;5947.553933454987;5891.204687367193;6036.3661815509395;6146.6004709693725;6155.538334624921;6170.352113028112;5761.934042202164;5917.55618328627;5962.065017175296;5989.401059893976;6020.8494787630225;14596.854031459761;14759.926200369036;16671.6665666686;24554.631680524806;24895.875520622463;2594.0272397850804;2889.191026512559;2928.253295409657;3171.6035495563056;3210.06907996683;12020.63938081859;12681.936590317082;15038.624034399118;15083;15166.696666066728;2006.9297574584818;2054.311805545144;2057.567910738747;2074.8858812765293;2097.758757742864;85414;86310.56844715736;86808;88045.55977220136;90410;10039.849402258971;10476.842847357295;10562;10715.624953126604;11448.713782155513;14769.556913292618;14881.255937203097;14974.251287435585;14977.850221497863;14979.325930332943;7865.960670196612;7954.443188976716;7957.283844454027;8011.278984891271;8244.422890397735;7805.41459390548;7850.097238817609;7989.0812556555575;8009.919900801034;8033.357331413473;4411.426514553152;4515.729056256635;4522.932156017662;4575.611073058827;4663.137319595886;2115.661494160927;2172.7718589548185;2184.3010236724094;2204.7291289971035;2248.8650680959195;1027.8612387327764;1040.8238690279936;1067.9199060070525;1130.9547618095348;1169.4620474581789;21285.68071478929;21370.252041178795;21432.464188395414;21468.463288417603;21618.56762864734;1027.5119318323887;1036.6527213383602;1099.796537640523;1100.9339439633488;1120.943952802373;11524.59663911759;11800.88199118015;11829.822552661717;11858.466369013415;11973.820392694117;522202;539979;541150;555563;557173;93067.53466232626;93558.53220733853;93944;98813;111815.44092279486;1057.2018126314583;1089.8147314956477;1093.824988001916;1100.741325788439;1102.4542851288504;18430.815691843447;19030.238790448228;19201.32795352156;19314.613707726046;19536.60926781485;35983.64016359803;40943.795281023406;44112.77943610262;45104.323435147846;45293.86765330893;60669.69665151646;65948.67025664842;66081;67560.3243967554;68865;9030.729078127666;9060.773480663036;9118.726438206864;9176.35765496409;9358.485283309483;12384.876151238372;13364.933175334061;13393.19640821554;13548;14118.929405352908;12421.44103515362;12492.437840297027;12530.874691252971;12563.18339307942;12825.42285597169;11123;11995.220310679779;12340.074494412775;12580.685482863002;12940.547080852126;12715.029200270195;12738.108332416641;12841.357932103545;13085.41115649779;13123.54067607629;7907.683692652229;8296.958515207385;8346.791330216793;8895.243904268209;9203.309751768778;9692.41845489273;11940.940295298467;11947.701307467383;12072.939635301767;12107.213031152947 20:54:32 INFO - PROCESS | 16338 | |3;mootools.html;1579.2577488580366;1582.7625856121583;1762.3743571032282;1836.4490652804157;1878.5115869873837;8948.418352807063;9154.176124148826;9683.128518433348;9707.805843883118;9753.609855605777;9426;9900.702978910625;9905.900940990588;9915.305928585001;9931;2426.8907899144538;2485.142625794107;2488.2659615413495;2489.2905521926164;2489.850608963459;2412.360724408033;2508.347829564317;2509.636102765098;2513.522430738154;2516.937076573082;2444.6577479152934;2463.802895768343;2498.2130628851855;2498.5127900059497;2505.5114252720728;2435.0990133650484;2455.9754402455924;2461.692288463942;2465.0263146057205;2466.9753302466925;2436.1473484280536;2444.340028192396;2444.8899799508886;2445.902163913441;2474.1464194852747;9628.08533189353;9677.177439917616;9689.079537443931;9701.757456063655;9715.708528744079;5543.196236545718;5630.042892708249;5704.030314846486;5704.828855134353;5706.885862282731;3317.5189597508224;3410.0622328859513;3432.5194472773833;3446.276281980787;3481.077514458645;1062.7502536903821;1087.4671411008628;1090.0353187429182;1101.6750058732694;1119.1885882735032;13747.862521374758;13981.300934953313;13997.720045599133;13998.790018149633;14031.508897188549;4790.185668436374;4869.513048695102;4957.925631115536;5035.144025515598;5080.916824102101;11901.523939042514;11908.225965312227;11918.940405297919;11933.641990740292;11936.761264774656;5760.94239057604;5778.566607504454;5787.826365209051;5808.477237048686;5821.679807610622;4504.662150338738;5061.519155680205;5171.974140129275;5197.636165468381;5304.071787437183;4240.49114106303;4304.139172165579;4360.454943132108;4380.2772542530765;4382.452193475816;1241.075398827879;1253.185429470833;1258.7671280813079;1265.5633806336798;1266.1010682415404;966.4491239993278;1011.5751384418562;1039.9688009359731;1077.2190162132392;1077.9299345542515;6395.136656551399;6509.934900650933;6532.314107018789;6695.765648202289;6724.6301453419555;466.8482743108435;481.90602832447337;482.679018452732;483.61552565710343;509.67380876239235;4353.956460435355;4454.1982443159895;4480.708753930984;4562.954370456319;4583;11972;12449.564265250672;12464;12483.50065997368;12503.937480312541;11496.482658280398;11989.820152697717;11996.580119695944;12351.629451116482;12354.0734444917;8980.955095224614;9165.450072995774;9172.312076594282;9220.124088211609;9254.583543740548;6274.247090349188;6374.394432528902;6462.1599192106605;6491.642959637265;6548.508861835287;10969.286996345212;11387.715307117389;11452.94273528627;11522.020628246357;11597.76804463923;11447.599334023269;11531.019863311378;11593.594224202112;11645.88354116448;11651.12616553745;8300.501969881827;8631.180037896389;8636.568171591269;8648.697295594624;8897.644094236159;9504.04959504044;9650.179734722627;9704.175145112462;9733.513324333613;9739.464329461947;8604.741857744277;8640;8696.78258043554;8726.171013753683;8739.300855931637;8309.750707478785;8399.916000839914;8406;8461.830763384822;8563;7491.9625401872645;7728.420368472274;7755.302022817974;7756.457048006585;7770.650320735467;5592.356878958972;5630.60585758993;5664.150377443417;5748;5776.018076926848;5618.7190640467;5667.1782591524825;5696.886062278814;5736.340320862987;5767.307923049261 20:54:32 INFO - PROCESS | 16338 | |4;prototype.html;351.2938992624824;354.67015675421857;362.0821218211832;364.32963347440705;369.2246282806108;5849.853753656161;5857.502112320452;5888.823335299948;5894.646321220719;5906.5274778017765;5599.944000559994;5807.764010855819;5815.505682017034;5815.651060936347;5838.153467747175;4520.525344838794;4562.133194693014;4571.977140114294;4577.420789827504;4601.884952876188;4584.7478388688605;4591.793369298372;4598.333241679954;4609.746463944482;4618.97690511547;4519.457944765522;4570.862874113782;4573.291139873325;4587.977060114695;4625;4531.229690952546;4550.97724511377;4556.681032327739;4599.586037256646;4607.378003969471;4083.2854250506043;4089.2230476209725;4091.9590804091877;4105.178964207171;4113.8971525711795;5602.467765562305;5677.545796336283;5723.313202415695;5761.193432919395;5789.2763404574425;5174.7412629368755;5182.300389447414;5213;5246.527812496894;5261.368635763694;6019.879602407927;6079.787207447718;6090.208272924536;6129.509639228851;6142.447179753844;4383.627391671712;4463.308187230984;4472.338958319794;4501.009777848868;4510;6140.201773769381;6317.273513545955;6350.364963503659;6362.172917520739;6363.395477429637;4493.438320209973;4531.229690952546;4540.477845047862;4551.089782043605;4552.863414097516;4578.107269082563;4585.082983403333;4588.931166032512;4594.931076033862;4595.862124136282;5157.613179011589;5209.453007434165;5245.868853278698;5246.632735708464;5251.396089449686;6103.938960610426;6119.694015299217;6122.479589234965;6140.232470941132;6164.969175154096;1564.7887535182833;1585.6590832970967;1589.9506325825132;1591.7851090102688;1596.6806638672313;986.6053578568486;989.2531138990016;1027.9588816447408;1077.7844431113651;1089.4661615808197;5756.762296106357;5780.421957804186;5796.565257605696;5830.1343570058025;5842.503387212135;6203.534734894901;6246.718897649525;6250.312465628868;6268.717907694165;6299.937000630027;5707.914381284284;5744.253247077937;5781.942180578225;5846.503047241032;5912.615679980788;3320.3857286402094;3362.974292840707;3365.343757967222;3368.5620869286836;3373.4433818420175;6211.534134939807;6476.773312934025;6504.479641628658;6527.445167160749;6597;6386.552941294065;6460.935390646034;6461.160049193575;6465.838354041092;6489.286178520359;6303.684815759194;6480.449161821298;6546.70539825709;6554.115194448784;6561.475081993429;6247.875042499216;6254.937450625617;6263.467605253604;6269.655168965751;6275.560710750204;6105.419985101408;6226.85173615102;6268;6286.7799627014665;6335.271443784024;6481.675916204076;6541.6075035496115;6560.40956313934;6562.376574225441;6572.80281591553;4531.84138555149;4536.88657783558;4559.361689363425;4587.839425620087;4608.654350923627;6219.626822390671;6318.241810982711;6339.397757213057;6436.871262574628;6447.097406363207;6090.847728806815;6154.107654390178;6156.722947467285;6171.59884607499;6195.783147589813;5958.76164953397;6097.5731698780655;6202.41077097675;6202.697433539008;6225.346338634378;6081.604695694766;6105.755769769159;6119.877602448015;6125.969370153299;6129.172561704113;6241.375862413723;6249.375062493714;6260.530460215593;6278.183836101278;6322.178116844781;5778.768849245983;5955.451582588472;5982.521398288213;6044.365341639064;6069.907416665043 20:54:32 INFO - PROCESS | 16338 | |5;yui.html;729.2525161709251;766.0386215299798;813.9389545784068;822.338017895594;834.8705950577655;17179.82820171798;18043.81956180438;18192.45422637323;18256.269749210016;18276.634467310647;16731.916340418313;16860.241289141988;16891;16898.239579218935;16907.746383804253;725.8838585826282;864.5072308783996;876.2989608313355;880.9339299552527;892.085612247445;883.3772190605607;888.0852721696631;889.9021107678183;890.2166093837446;890.5057692980394;927.6289484206304;937.3063932689795;938.2353381993653;939.464505232018;940.252499263084;922.5986695787354;930.692871352452;931.222429271559;932.6036434515338;933.5472295936431;682.9931700682979;684.551618689759;684.5960883079007;687.2303020616891;689.021589343134;14751.852481475154;14896.8827337949;14903.925480372638;14945.103293802298;14958.551243462605;15457;15566.610834729108;15601.531954041284;15807.525774226791;15825.841741582552;13136.934315328363;13159.86840131596;13172.736545269041;13247.271400072992;13305.933470332684;4039.939400908989;4119.8970025749295;4146.688998325138;4189.455370801807;4294.656427485794;82963.9999999994;83315.5834220831;83749;84216;85205.57397212974;11264.605738799266;11336.43317834105;11402.0308273796;11435.542578296774;11615.419229038514;19042.238310467426;19181.32865349706;19193.424197274104;19197.424077277705;19233.61532769337;8693.174148455886;8829.514376709214;8881.289496840367;8995;9191.264698824078;4916.0905232532095;4984.102861484967;5002;5103.591712662978;5155.871103222375;4010.1578668479365;4127.607877251657;4165.166966606691;4172.415861779354;4174.352975288835;663.0617675988518;685.4674947747969;686.8763622547989;692.6121372031679;715.9355657990702;718.8526352097807;760.5778792769955;778.1712476212815;810.525842382213;815.7838172884191;10149.847752283722;10645.20160987929;11016.06363459099;11061.391623460626;11191;652.7845810882397;670.8557660103102;711.3846522757777;781.0861292288037;819.4837252530987;4800.927986080212;5082.898342033212;5359.678419294854;5378.2470454136455;5550.167474878801;119096.40451797859;123359;125659.37170314272;127115.36442317729;127783.36108319399;108475;109464;111120.44439777911;112108;112969.43515282372;92802.53598732098;95007;95605.52197239109;96246;97092;10142.849291249504;10253.897461025592;10307.484625768531;10667.733306667085;10732.463376831283;52962.73518632382;53338.4666153349;53439.46560534345;54752.45247547473;55723.72138139283;70280.64859675668;83201.16798831934;84606.57696711477;85022;85748;12671.746565068832;13325.267110309027;13424.93287533556;13497.797533037208;13709;15090.698186036438;15469.381224750883;15484;15546.533603991898;15792.60518487047;14160.858391415954;14509.201993890438;14519.709605808035;14737.926310368379;14762.852371476149;13774.173549587056;13932.2337271447;13956.162630242217;14112.858871411154;14778.408863645764;13795.517156899461;14264.286785660468;14441.205733684748;14873.405063797327;14962.925185374004;10959.671209863716;11113.666590002313;11204.775904482029;11953.820692689442;12180;12619.87380126187;13189.274589897648;13548.322583870964;13726.794098088736;13929 20:54:32 INFO - PROCESS | 16338 | __end_tp_report 20:54:32 INFO - PROCESS | 16338 | __start_cc_report 20:54:32 INFO - PROCESS | 16338 | _x_x_mozilla_cycle_collect,343 20:54:32 INFO - PROCESS | 16338 | __end_cc_report 20:54:32 INFO - PROCESS | 16338 | __startTimestamp1475121272590__endTimestamp 20:54:32 INFO - PROCESS | 16338 | 20:54:32 INFO - PROCESS | 16338 | ------- Summary: start ------- 20:54:32 INFO - PROCESS | 16338 | Number of tests: 6 20:54:32 INFO - PROCESS | 16338 | 20:54:32 INFO - PROCESS | 16338 | [#0] dojo.html Cycles:165 Average:5805.52 Median:6039.67 stddev:671.25 (11.1%) stddev-sans-first:643.35 20:54:32 INFO - PROCESS | 16338 | Values: 3277.5 3299.9 3304.8 3312.0 3328.0 5794.9 5835.3 5866.4 5872.1 5874.8 5800.3 5870.4 5871.4 5881.8 5883.6 5234.2 5327.5 5345.7 5375.2 5434.7 5392.0 5392.9 5393.9 5394.5 5412.7 5199.9 5282.4 5396.0 5403.5 5426.3 5284.0 5374.7 5377.5 5383.4 5412.3 5238.0 5340.4 5357.0 5364.8 5365.3 5579.3 5694.9 5715.7 5739.9 5844.3 6192.2 6315.7 6326.0 6333.8 6337.8 6294.1 6300.3 6305.7 6350.5 6360.2 5565.6 5661.1 5862.6 5871.1 5914.1 6064.5 6215.6 6217.4 6236.6 6238.6 5952.4 5955.2 5976.3 5978.8 5979.9 6018.6 6059.0 6095.7 6095.8 6101.3 6015.5 6141.9 6148.8 6213.0 6220.4 6196.8 6203.5 6203.6 6214.1 6218.2 4607.3 4658.0 4741.8 4744.4 4769.1 4111.3 4231.1 4243.0 4256.8 4279.0 5931.6 6039.7 6062.6 6072.8 6093.4 6002.0 6155.5 6286.9 6321.8 6376.5 5963.0 6024.7 6026.4 6038.0 6089.3 5389.3 5397.9 5412.9 5413.6 5416.6 6274.7 6348.7 6412.9 6500.2 6514.8 6330.9 6335.9 6343.9 6345.9 6355.2 6472.4 6530.2 6559.8 6568.3 6572.3 5945.6 6083.9 6114.1 6252.6 6259.9 6330.7 6331.8 6336.0 6341.4 6350.1 6175.4 6175.7 6177.4 6185.6 6195.5 5911.3 6097.5 6111.7 6150.1 6186.8 6139.2 6150.9 6151.1 6186.5 6189.7 6175.3 6203.6 6238.2 6268.0 6309.8 5830.4 5982.6 6041.2 6094.1 6107.4 20:54:32 INFO - PROCESS | 16338 | 20:54:32 INFO - PROCESS | 16338 | [#1] ext.html Cycles:180 Average:69743.61 Median:202690.11 stddev:140370.69 (69.3%) stddev-sans-first:140668.41 20:54:32 INFO - PROCESS | 16338 | Values: 579.7 601.2 628.8 702.4 702.7 44278.3 45390.1 48669.3 48699.3 48828.5 49521.3 50484.5 50484.7 50559.5 50579.7 9178.0 11139.0 11382.5 11462.9 11807.2 11351.7 11371.8 11455.7 11457.7 11460.7 11334.7 11464.0 11475.3 11479.0 11488.7 11443.6 11449.9 11461.1 11462.6 11489.1 11357.4 11414.3 11451.8 11475.0 11476.7 44303.8 44865.8 44880.1 44902.3 44953.1 3945.8 3976.8 4026.2 4098.0 4325.8 37116.0 37196.8 37209.8 37259.3 37426.3 4730.0 4812.8 4869.1 4898.3 4905.9 395663.0 398743.0 399892.0 401354.0 405498.0 66018.7 66451.0 66499.0 66547.3 66624.3 72044.0 72254.0 72254.3 72328.0 72337.6 17592.7 17897.6 17899.6 17911.0 17918.5 12371.0 13004.3 13476.8 13526.3 13839.1 21377.3 21536.7 21587.0 21607.7 21620.0 7432.5 7479.7 7554.9 7666.9 7822.0 1050.6 1062.5 1084.6 1084.8 1162.9 33976.8 34331.5 34495.3 34497.3 34660.5 1167.8 1196.3 1214.7 1220.8 1271.1 17755.6 18410.7 18545.3 18605.7 18617.5 661599.0 662425.0 669163.0 671709.0 672569.0 67062.7 67304.7 67744.7 67867.0 67989.7 1427.8 1436.7 1448.4 1467.0 1468.4 33026.0 34358.0 34737.7 34740.0 34848.7 58955.1 59650.7 59691.0 59732.7 59909.7 475519.0 477139.0 483137.0 483497.0 484566.0 31173.8 32089.7 32157.7 32701.7 33716.5 54123.5 54315.2 54438.0 54506.5 55406.4 46198.5 46871.3 47141.0 47965.3 48549.0 43897.6 46928.3 47332.0 48533.5 50405.7 46049.5 46719.3 46863.0 46865.3 47051.0 38762.4 40934.2 40982.0 40999.8 41011.0 30122.2 30374.0 30574.0 30724.4 30933.0 20:54:32 INFO - PROCESS | 16338 | 20:54:32 INFO - PROCESS | 16338 | [#2] jquery.html Cycles:180 Average:31396.85 Median:2194.52 stddev:89575.43 (4081.8%) stddev-sans-first:89796.51 20:54:32 INFO - PROCESS | 16338 | Values: 417.5 417.7 429.4 431.0 439.5 19230.5 20038.0 20904.4 20909.4 20949.6 19795.2 20430.3 20634.9 20836.9 20936.0 5843.5 6052.3 6059.2 6061.3 6068.4 5629.8 5824.5 5860.9 5913.4 5997.1 5837.9 5859.1 5925.5 5941.7 5947.6 5891.2 6036.4 6146.6 6155.5 6170.4 5761.9 5917.6 5962.1 5989.4 6020.8 14596.9 14759.9 16671.7 24554.6 24895.9 2594.0 2889.2 2928.3 3171.6 3210.1 12020.6 12681.9 15038.6 15083.0 15166.7 2006.9 2054.3 2057.6 2074.9 2097.8 85414.0 86310.6 86808.0 88045.6 90410.0 10039.8 10476.8 10562.0 10715.6 11448.7 14769.6 14881.3 14974.3 14977.9 14979.3 7866.0 7954.4 7957.3 8011.3 8244.4 7805.4 7850.1 7989.1 8009.9 8033.4 4411.4 4515.7 4522.9 4575.6 4663.1 2115.7 2172.8 2184.3 2204.7 2248.9 1027.9 1040.8 1067.9 1131.0 1169.5 21285.7 21370.3 21432.5 21468.5 21618.6 1027.5 1036.7 1099.8 1100.9 1120.9 11524.6 11800.9 11829.8 11858.5 11973.8 522202.0 539979.0 541150.0 555563.0 557173.0 93067.5 93558.5 93944.0 98813.0 111815.4 1057.2 1089.8 1093.8 1100.7 1102.5 18430.8 19030.2 19201.3 19314.6 19536.6 35983.6 40943.8 44112.8 45104.3 45293.9 60669.7 65948.7 66081.0 67560.3 68865.0 9030.7 9060.8 9118.7 9176.4 9358.5 12384.9 13364.9 13393.2 13548.0 14118.9 12421.4 12492.4 12530.9 12563.2 12825.4 11123.0 11995.2 12340.1 12580.7 12940.5 12715.0 12738.1 12841.4 13085.4 13123.5 7907.7 8297.0 8346.8 8895.2 9203.3 9692.4 11940.9 11947.7 12072.9 12107.2 20:54:32 INFO - PROCESS | 16338 | 20:54:32 INFO - PROCESS | 16338 | [#3] mootools.html Cycles:180 Average:6401.81 Median:2628.52 stddev:3786.52 (144.1%) stddev-sans-first:3779.80 20:54:32 INFO - PROCESS | 16338 | Values: 1579.3 1582.8 1762.4 1836.4 1878.5 8948.4 9154.2 9683.1 9707.8 9753.6 9426.0 9900.7 9905.9 9915.3 9931.0 2426.9 2485.1 2488.3 2489.3 2489.9 2412.4 2508.3 2509.6 2513.5 2516.9 2444.7 2463.8 2498.2 2498.5 2505.5 2435.1 2456.0 2461.7 2465.0 2467.0 2436.1 2444.3 2444.9 2445.9 2474.1 9628.1 9677.2 9689.1 9701.8 9715.7 5543.2 5630.0 5704.0 5704.8 5706.9 3317.5 3410.1 3432.5 3446.3 3481.1 1062.8 1087.5 1090.0 1101.7 1119.2 13747.9 13981.3 13997.7 13998.8 14031.5 4790.2 4869.5 4957.9 5035.1 5080.9 11901.5 11908.2 11918.9 11933.6 11936.8 5760.9 5778.6 5787.8 5808.5 5821.7 4504.7 5061.5 5172.0 5197.6 5304.1 4240.5 4304.1 4360.5 4380.3 4382.5 1241.1 1253.2 1258.8 1265.6 1266.1 966.4 1011.6 1040.0 1077.2 1077.9 6395.1 6509.9 6532.3 6695.8 6724.6 466.8 481.9 482.7 483.6 509.7 4354.0 4454.2 4480.7 4563.0 4583.0 11972.0 12449.6 12464.0 12483.5 12503.9 11496.5 11989.8 11996.6 12351.6 12354.1 8981.0 9165.5 9172.3 9220.1 9254.6 6274.2 6374.4 6462.2 6491.6 6548.5 10969.3 11387.7 11452.9 11522.0 11597.8 11447.6 11531.0 11593.6 11645.9 11651.1 8300.5 8631.2 8636.6 8648.7 8897.6 9504.0 9650.2 9704.2 9733.5 9739.5 8604.7 8640.0 8696.8 8726.2 8739.3 8309.8 8399.9 8406.0 8461.8 8563.0 7492.0 7728.4 7755.3 7756.5 7770.7 5592.4 5630.6 5664.2 5748.0 5776.0 5618.7 5667.2 5696.9 5736.3 5767.3 20:54:32 INFO - PROCESS | 16338 | 20:54:32 INFO - PROCESS | 16338 | [#4] prototype.html Cycles:180 Average:5181.54 Median:5840.33 stddev:1514.88 (25.9%) stddev-sans-first:1475.11 20:54:32 INFO - PROCESS | 16338 | Values: 351.3 354.7 362.1 364.3 369.2 5849.9 5857.5 5888.8 5894.6 5906.5 5599.9 5807.8 5815.5 5815.7 5838.2 4520.5 4562.1 4572.0 4577.4 4601.9 4584.7 4591.8 4598.3 4609.7 4619.0 4519.5 4570.9 4573.3 4588.0 4625.0 4531.2 4551.0 4556.7 4599.6 4607.4 4083.3 4089.2 4092.0 4105.2 4113.9 5602.5 5677.5 5723.3 5761.2 5789.3 5174.7 5182.3 5213.0 5246.5 5261.4 6019.9 6079.8 6090.2 6129.5 6142.4 4383.6 4463.3 4472.3 4501.0 4510.0 6140.2 6317.3 6350.4 6362.2 6363.4 4493.4 4531.2 4540.5 4551.1 4552.9 4578.1 4585.1 4588.9 4594.9 4595.9 5157.6 5209.5 5245.9 5246.6 5251.4 6103.9 6119.7 6122.5 6140.2 6165.0 1564.8 1585.7 1590.0 1591.8 1596.7 986.6 989.3 1028.0 1077.8 1089.5 5756.8 5780.4 5796.6 5830.1 5842.5 6203.5 6246.7 6250.3 6268.7 6299.9 5707.9 5744.3 5781.9 5846.5 5912.6 3320.4 3363.0 3365.3 3368.6 3373.4 6211.5 6476.8 6504.5 6527.4 6597.0 6386.6 6460.9 6461.2 6465.8 6489.3 6303.7 6480.4 6546.7 6554.1 6561.5 6247.9 6254.9 6263.5 6269.7 6275.6 6105.4 6226.9 6268.0 6286.8 6335.3 6481.7 6541.6 6560.4 6562.4 6572.8 4531.8 4536.9 4559.4 4587.8 4608.7 6219.6 6318.2 6339.4 6436.9 6447.1 6090.8 6154.1 6156.7 6171.6 6195.8 5958.8 6097.6 6202.4 6202.7 6225.3 6081.6 6105.8 6119.9 6126.0 6129.2 6241.4 6249.4 6260.5 6278.2 6322.2 5778.8 5955.5 5982.5 6044.4 6069.9 20:54:32 INFO - PROCESS | 16338 | 20:54:32 INFO - PROCESS | 16338 | [#5] yui.html Cycles:180 Average:22567.95 Median:4025.05 stddev:32901.79 (817.4%) stddev-sans-first:32953.23 20:54:32 INFO - PROCESS | 16338 | Values: 729.3 766.0 813.9 822.3 834.9 17179.8 18043.8 18192.5 18256.3 18276.6 16731.9 16860.2 16891.0 16898.2 16907.7 725.9 864.5 876.3 880.9 892.1 883.4 888.1 889.9 890.2 890.5 927.6 937.3 938.2 939.5 940.3 922.6 930.7 931.2 932.6 933.5 683.0 684.6 684.6 687.2 689.0 14751.9 14896.9 14903.9 14945.1 14958.6 15457.0 15566.6 15601.5 15807.5 15825.8 13136.9 13159.9 13172.7 13247.3 13305.9 4039.9 4119.9 4146.7 4189.5 4294.7 82964.0 83315.6 83749.0 84216.0 85205.6 11264.6 11336.4 11402.0 11435.5 11615.4 19042.2 19181.3 19193.4 19197.4 19233.6 8693.2 8829.5 8881.3 8995.0 9191.3 4916.1 4984.1 5002.0 5103.6 5155.9 4010.2 4127.6 4165.2 4172.4 4174.4 663.1 685.5 686.9 692.6 715.9 718.9 760.6 778.2 810.5 815.8 10149.8 10645.2 11016.1 11061.4 11191.0 652.8 670.9 711.4 781.1 819.5 4800.9 5082.9 5359.7 5378.2 5550.2 119096.4 123359.0 125659.4 127115.4 127783.4 108475.0 109464.0 111120.4 112108.0 112969.4 92802.5 95007.0 95605.5 96246.0 97092.0 10142.8 10253.9 10307.5 10667.7 10732.5 52962.7 53338.5 53439.5 54752.5 55723.7 70280.6 83201.2 84606.6 85022.0 85748.0 12671.7 13325.3 13424.9 13497.8 13709.0 15090.7 15469.4 15484.0 15546.5 15792.6 14160.9 14509.2 14519.7 14737.9 14762.9 13774.2 13932.2 13956.2 14112.9 14778.4 13795.5 14264.3 14441.2 14873.4 14962.9 10959.7 11113.7 11204.8 11953.8 12180.0 12619.9 13189.3 13548.3 13726.8 13929.0 20:54:32 INFO - PROCESS | 16338 | -------- Summary: end -------- 20:54:32 INFO - PROCESS | 16338 | 20:54:33 INFO - TEST-INFO | 16338: exit 0 20:54:33 INFO - TEST-OK | dromaeo_css | took 1110143ms 20:54:33 INFO - TEST-START | kraken 20:54:33 INFO - operating with platform_type : linux_ 20:54:33 INFO - Initialising browser for kraken test... 20:54:33 INFO - TEST-INFO | started process 16576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4mXlKH/profile http://localhost:40269/getInfo.html) 20:54:37 INFO - PROCESS | 16576 | __metrics Screen width/height:1600/1200 20:54:37 INFO - PROCESS | 16576 | colorDepth:24 20:54:37 INFO - PROCESS | 16576 | Browser inner width/height: 1024/697 20:54:37 INFO - PROCESS | 16576 | __metrics 20:54:37 ERROR - PROCESS | 16576 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:54:38 INFO - TEST-INFO | 16576: exit 0 20:54:38 INFO - Browser initialized. 20:54:38 INFO - Running cycle 1/1 for kraken test... 20:54:38 INFO - TEST-INFO | started process 16701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4mXlKH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:54:50 INFO - PROCESS | 16701 | RSS: Main: 150102016 20:54:50 INFO - PROCESS | 16701 | 20:54:53 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40269/tests/kraken/driver.html?testName=audio-beat-detection) 20:54:53 INFO - PROCESS | 16701 | RSS: Main: 157167616 20:54:53 INFO - PROCESS | 16701 | 20:54:56 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40269/tests/kraken/driver.html?testName=audio-dft) 20:54:57 INFO - PROCESS | 16701 | RSS: Main: 155475968 20:54:57 INFO - PROCESS | 16701 | 20:54:59 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40269/tests/kraken/driver.html?testName=audio-fft) 20:55:00 INFO - PROCESS | 16701 | RSS: Main: 156397568 20:55:00 INFO - PROCESS | 16701 | 20:55:02 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40269/tests/kraken/driver.html?testName=audio-oscillator) 20:55:03 INFO - PROCESS | 16701 | RSS: Main: 155983872 20:55:03 INFO - PROCESS | 16701 | 20:55:05 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:55:06 INFO - PROCESS | 16701 | RSS: Main: 155639808 20:55:06 INFO - PROCESS | 16701 | 20:55:09 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40269/tests/kraken/driver.html?testName=imaging-darkroom) 20:55:09 INFO - PROCESS | 16701 | RSS: Main: 155389952 20:55:09 INFO - PROCESS | 16701 | 20:55:13 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40269/tests/kraken/driver.html?testName=imaging-desaturate) 20:55:13 INFO - PROCESS | 16701 | RSS: Main: 156033024 20:55:13 INFO - PROCESS | 16701 | 20:55:16 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40269/tests/kraken/driver.html?testName=json-parse-financial) 20:55:17 INFO - PROCESS | 16701 | RSS: Main: 156606464 20:55:17 INFO - PROCESS | 16701 | 20:55:18 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:55:19 INFO - PROCESS | 16701 | RSS: Main: 156069888 20:55:19 INFO - PROCESS | 16701 | 20:55:21 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40269/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:55:21 INFO - PROCESS | 16701 | RSS: Main: 155983872 20:55:21 INFO - PROCESS | 16701 | 20:55:23 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:55:24 INFO - PROCESS | 16701 | RSS: Main: 156340224 20:55:24 INFO - PROCESS | 16701 | 20:55:26 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:55:27 INFO - PROCESS | 16701 | RSS: Main: 156291072 20:55:27 INFO - PROCESS | 16701 | 20:55:30 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:55:30 INFO - PROCESS | 16701 | RSS: Main: 157081600 20:55:30 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | Cycle 1(1): loaded http://localhost:40269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40269/tests/kraken/driver.html?testName=ai-astar) 20:55:32 INFO - PROCESS | 16701 | RSS: Main: 158912512 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | __start_tp_report 20:55:32 INFO - PROCESS | 16701 | _x_x_mozilla_page_load 20:55:32 INFO - PROCESS | 16701 | _x_x_mozilla_page_load_details 20:55:32 INFO - PROCESS | 16701 | |i|pagename|runs| 20:55:32 INFO - PROCESS | 16701 | |0;ai-astar;99;110;106;110;111;111;111;111;110;110 20:55:32 INFO - PROCESS | 16701 | |1;audio-beat-detection;145;121;149;173;119;141;146;118;167;122 20:55:32 INFO - PROCESS | 16701 | |2;audio-dft;162;161;164;163;162;161;164;161;161;162 20:55:32 INFO - PROCESS | 16701 | |3;audio-fft;76;76;76;181;76;75;76;76;168;75 20:55:32 INFO - PROCESS | 16701 | |4;audio-oscillator;85;83;150;84;84;84;132;83;83;151 20:55:32 INFO - PROCESS | 16701 | |5;imaging-gaussian-blur;117;117;117;119;117;117;117;119;117;117 20:55:32 INFO - PROCESS | 16701 | |6;imaging-darkroom;148;147;147;147;147;148;147;147;148;147 20:55:32 INFO - PROCESS | 16701 | |7;imaging-desaturate;95;96;96;96;96;96;96;95;95;95 20:55:32 INFO - PROCESS | 16701 | |8;json-parse-financial;50;51;51;50;51;51;50;53;51;50 20:55:32 INFO - PROCESS | 16701 | |9;json-stringify-tinderbox;64;62;60;60;61;60;60;60;64;60 20:55:32 INFO - PROCESS | 16701 | |10;stanford-crypto-aes;73;72;72;72;79;81;72;72;72;74 20:55:32 INFO - PROCESS | 16701 | |11;stanford-crypto-ccm;122;119;129;129;117;119;117;120;159;129 20:55:32 INFO - PROCESS | 16701 | |12;stanford-crypto-pbkdf2;149;156;154;155;149;149;150;152;156;155 20:55:32 INFO - PROCESS | 16701 | |13;stanford-crypto-sha256-iterative;61;62;62;64;62;60;60;60;61;63 20:55:32 INFO - PROCESS | 16701 | __end_tp_report 20:55:32 INFO - PROCESS | 16701 | __start_cc_report 20:55:32 INFO - PROCESS | 16701 | _x_x_mozilla_cycle_collect,887 20:55:32 INFO - PROCESS | 16701 | __end_cc_report 20:55:32 INFO - PROCESS | 16701 | __startTimestamp1475121332572__endTimestamp 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | ------- Summary: start ------- 20:55:32 INFO - PROCESS | 16701 | Number of tests: 14 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:3.78 (3.4%) stddev-sans-first:1.58 20:55:32 INFO - PROCESS | 16701 | Values: 99.0 110.0 106.0 110.0 111.0 111.0 111.0 111.0 110.0 110.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:145.50 stddev:19.92 (13.7%) stddev-sans-first:21.05 20:55:32 INFO - PROCESS | 16701 | Values: 145.0 121.0 149.0 173.0 119.0 141.0 146.0 118.0 167.0 122.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 20:55:32 INFO - PROCESS | 16701 | Values: 162.0 161.0 164.0 163.0 162.0 161.0 164.0 161.0 161.0 162.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#3] audio-fft Cycles:10 Average:95.50 Median:76.00 stddev:41.75 (54.9%) stddev-sans-first:43.68 20:55:32 INFO - PROCESS | 16701 | Values: 76.0 76.0 76.0 181.0 76.0 75.0 76.0 76.0 168.0 75.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:83.50 stddev:29.72 (35.6%) stddev-sans-first:30.89 20:55:32 INFO - PROCESS | 16701 | Values: 85.0 83.0 150.0 84.0 84.0 84.0 132.0 83.0 83.0 151.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.84 (0.7%) stddev-sans-first:0.88 20:55:32 INFO - PROCESS | 16701 | Values: 117.0 117.0 117.0 119.0 117.0 117.0 117.0 119.0 117.0 117.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 20:55:32 INFO - PROCESS | 16701 | Values: 148.0 147.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:55:32 INFO - PROCESS | 16701 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.92 (1.8%) stddev-sans-first:0.93 20:55:32 INFO - PROCESS | 16701 | Values: 50.0 51.0 51.0 50.0 51.0 51.0 50.0 53.0 51.0 50.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:60.50 stddev:1.66 (2.7%) stddev-sans-first:1.39 20:55:32 INFO - PROCESS | 16701 | Values: 64.0 62.0 60.0 60.0 61.0 60.0 60.0 60.0 64.0 60.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#10] stanford-crypto-aes Cycles:10 Average:73.90 Median:72.50 stddev:3.31 (4.6%) stddev-sans-first:3.50 20:55:32 INFO - PROCESS | 16701 | Values: 73.0 72.0 72.0 72.0 79.0 81.0 72.0 72.0 72.0 74.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:125.50 stddev:12.60 (10.0%) stddev-sans-first:13.28 20:55:32 INFO - PROCESS | 16701 | Values: 122.0 119.0 129.0 129.0 117.0 119.0 117.0 120.0 159.0 129.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:154.50 stddev:3.03 (2.0%) stddev-sans-first:2.93 20:55:32 INFO - PROCESS | 16701 | Values: 149.0 156.0 154.0 155.0 149.0 149.0 150.0 152.0 156.0 155.0 20:55:32 INFO - PROCESS | 16701 | 20:55:32 INFO - PROCESS | 16701 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:62.00 stddev:1.35 (2.2%) stddev-sans-first:1.42 20:55:32 INFO - PROCESS | 16701 | Values: 61.0 62.0 62.0 64.0 62.0 60.0 60.0 60.0 61.0 63.0 20:55:32 INFO - PROCESS | 16701 | -------- Summary: end -------- 20:55:32 INFO - PROCESS | 16701 | 20:55:33 INFO - TEST-INFO | 16701: exit 0 20:55:33 INFO - TEST-OK | kraken | took 60237ms 20:55:33 INFO - SUITE-END | took 1170s 20:55:33 INFO - Completed test suite (00:19:30) 20:55:33 INFO - javascript benchmark 20:55:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7901.3819345104075, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3277.5411442398063, 3299.868005279789, 3304.768666193366, 3312.0, 3328.034869887733, 5794.884102317951, 5835.299764028312, 5866.442687944644, 5872.148538461921, 5874.823755287348, 5800.303963524383, 5870.354261031283, 5871.383504732005, 5881.764729410829, 5883.588148829584, 5234.162533994552, 5327.493888080626, 5345.732713364317, 5375.19372094187, 5434.728263586825, 5391.973040134794, 5392.865178370533, 5393.946060539403, 5394.541463975567, 5412.702301373423, 5199.896002079956, 5282.3925248596515, 5396.028714831329, 5403.486668766461, 5426.2674538937135, 5284.048871203182, 5374.6506477078865, 5377.46225377463, 5383.407825139231, 5412.296401467824, 5237.973810130925, 5340.385855626614, 5357.035733567956, 5364.758585863607, 5365.3293338332705, 5579.302587176603, 5694.9179655865255, 5715.742791574389, 5739.942600574024, 5844.327902291248, 6192.195014648067, 6315.684215789192, 6325.968370158166, 6333.809985700436, 6337.809865704036, 6294.118823364733, 6300.30696623371, 6305.716242769086, 6350.491960643138, 6360.173177486897, 5565.6104072714525, 5661.065924122515, 5862.589618726691, 5871.089981052944, 5914.053751399755, 6064.4541991221, 6215.595986260879, 6217.409346112112, 6236.563440559208, 6238.594491358047, 5952.434518720715, 5955.225820643289, 5976.252968378953, 5978.820635380858, 5979.910301345483, 6018.578699491081, 6058.969705151446, 6095.725692343855, 6095.8476038098515, 6101.298350689639, 6015.518758499309, 6141.854248382324, 6148.78479253224, 6213.0, 6220.440160385497, 6196.752129914843, 6203.503719702413, 6203.596766210182, 6214.098955651496, 6218.160548325918, 4607.308903664477, 4657.953420465819, 4741.83403580873, 4744.4069491313585, 4769.14155452022, 4111.280525907954, 4231.132617813341, 4242.957570424318, 4256.787160641956, 4278.957210427918, 5931.555133365015, 6039.66781826995, 6062.605930614496, 6072.787452439144, 6093.360197179321, 6002.039673652194, 6155.538334624921, 6286.874262514724, 6321.778737744157, 6376.458001069868, 5963.0, 6024.668643224577, 6026.367231440636, 6038.0, 6089.330173680892, 5389.27244821944, 5397.946020539823, 5412.864678383072, 5413.621046526784, 5416.566674666017, 6274.6548939808745, 6348.650824204713, 6412.903806442814, 6500.154979852589, 6514.804555863332, 6330.905036424365, 6335.936640633719, 6343.873122537616, 6345.936540634534, 6355.237371515448, 6472.449841763315, 6530.183727034121, 6559.836004099936, 6568.310327415744, 6572.309907459839, 5945.613535120204, 6083.878322433438, 6114.114890844268, 6252.5935814171935, 6259.937400625936, 6330.746770129143, 6331.778387756591, 6335.968320158369, 6341.397567231105, 6350.079238510482, 6175.44421002094, 6175.660338681416, 6177.444030037318, 6185.628862268279, 6195.504359651127, 5911.261092363455, 6097.512199023979, 6111.663858487648, 6150.138980542817, 6186.783462578788, 6139.201903752483, 6150.938490615036, 6151.0773383992755, 6186.4741496973265, 6189.721462534287, 6175.320714721287, 6203.627782333075, 6238.189035425366, 6267.96866015667, 6309.810705678837, 5830.358660547252, 5982.58121931478, 6041.18444010053, 6094.085887116968, 6107.358727333566], "value": 5758.831643024488, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.7391173971711, 601.1943995046637, 628.754785633603, 702.4450683959672, 702.6592102830126, 44278.33582496261, 45390.09219815602, 48669.269960950616, 48699.26951095736, 48828.51171488284, 49521.25718114231, 50484.49515504844, 50484.74757626207, 50559.494405055935, 50579.74710126453, 9177.999999999984, 11138.99999999996, 11382.487788049557, 11462.885371146307, 11807.173497855154, 11351.659450216506, 11371.772564548704, 11455.713607159805, 11457.656270311862, 11460.656180314603, 11334.659960201207, 11464.0, 11475.311481311148, 11479.0, 11488.71278218047, 11443.59947401841, 11449.885501145049, 11461.140414468948, 11462.598809041685, 11489.138314626436, 11357.375344356056, 11414.315141091562, 11451.797561256031, 11475.0, 11476.655700329004, 44303.77848110771, 44865.77567112176, 44880.10239795186, 44902.32646510305, 44953.10093798106, 3945.8421663133727, 3976.76139431635, 4026.2148880968225, 4097.96350594664, 4325.84859529915, 37116.0, 37196.81401592975, 37209.813950930074, 37259.25481490382, 37426.25147497062, 4729.976350118227, 4812.831550895702, 4869.123557759602, 4898.321216258645, 4905.926411103801, 395663.0, 398743.0, 399892.0, 401354.0, 405497.9725101385, 66018.66990665112, 66451.0, 66499.0, 66547.33452665411, 66624.33375666181, 72044.0, 72254.0, 72254.2774572258, 72328.0, 72337.6383118081, 17592.73610895812, 17897.642047158984, 17899.552511187325, 17911.0, 17918.462446126636, 12371.0, 13004.349782510837, 13476.797848032287, 13526.256055916821, 13839.100458470168, 21377.25179618737, 21536.676949845765, 21587.0, 21607.67588486174, 21620.02709878028, 7432.5134973005615, 7479.700811967569, 7554.924450755422, 7666.8849967250535, 7822.0, 1050.5692666007053, 1062.4793851012948, 1084.642068117535, 1084.8426978088291, 1162.9302241865514, 33976.83011584926, 34331.4850277246, 34495.31009379798, 34497.31005379929, 34660.48009279863, 1167.7897978363976, 1196.282230661596, 1214.678110300771, 1220.7558488302375, 1271.1483306184878, 17755.644887102444, 18410.723839142425, 18545.25818967253, 18605.7209141863, 18617.53456163607, 661599.0, 662425.0, 669163.0, 671709.0, 672569.0, 67062.66468667724, 67304.6634766823, 67744.6612766933, 67867.0, 67989.66005169942, 1427.800107984883, 1436.6982933584065, 1448.3699590678088, 1466.9633857914228, 1468.3979568376915, 33026.0, 34358.0, 34737.65262347344, 34740.0, 34848.65151348454, 58955.11567326579, 59650.70174649099, 59691.0, 59732.70133649304, 59909.70045149921, 475519.0, 477139.0, 483137.0, 483497.0, 484566.0, 31173.8441307792, 32089.67910320867, 32157.678423215468, 32701.672983269862, 33716.49425258574, 54123.458765411844, 54315.18527222016, 54438.0, 54506.454935450136, 55406.44593554174, 46198.53801461942, 46871.29693054675, 47141.0, 47965.280520791515, 48549.0, 43897.56102439063, 46928.29607555958, 47332.0, 48533.5146648529, 50405.74797125991, 46049.53950460452, 46719.29921051119, 46863.0, 46865.297020545404, 47051.0, 38762.41856372213, 40934.18131637291, 40982.0, 40999.7950010248, 41011.0, 30122.24694382658, 30374.0, 30574.0, 30724.385512289184, 30933.0], "value": 22878.889382713543, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.46564397571103, 417.7430880008792, 429.41170596283087, 430.9633681137103, 439.4748275810406, 19230.519237019063, 20038.0, 20904.372868813924, 20909.37271881842, 20949.58100837986, 19795.20819167235, 20430.2849400271, 20634.89682551585, 20836.89581552094, 20935.95320233986, 5843.474087332139, 6052.334243233241, 6059.242594675666, 6061.333253342129, 6068.362821903703, 5629.831105066834, 5824.504917082053, 5860.882782344351, 5913.379095195007, 5997.070454079625, 5837.941620583782, 5859.0625499920025, 5925.4963328117165, 5941.7029148542615, 5947.553933454987, 5891.204687367193, 6036.3661815509395, 6146.6004709693725, 6155.538334624921, 6170.352113028112, 5761.934042202164, 5917.55618328627, 5962.065017175296, 5989.401059893976, 6020.8494787630225, 14596.854031459761, 14759.926200369036, 16671.6665666686, 24554.631680524806, 24895.875520622463, 2594.0272397850804, 2889.191026512559, 2928.253295409657, 3171.6035495563056, 3210.06907996683, 12020.63938081859, 12681.936590317082, 15038.624034399118, 15083.0, 15166.696666066728, 2006.9297574584818, 2054.311805545144, 2057.567910738747, 2074.8858812765293, 2097.758757742864, 85414.0, 86310.56844715736, 86808.0, 88045.55977220136, 90410.0, 10039.849402258971, 10476.842847357295, 10562.0, 10715.624953126604, 11448.713782155513, 14769.556913292618, 14881.255937203097, 14974.251287435585, 14977.850221497863, 14979.325930332943, 7865.960670196612, 7954.443188976716, 7957.283844454027, 8011.278984891271, 8244.422890397735, 7805.41459390548, 7850.097238817609, 7989.0812556555575, 8009.919900801034, 8033.357331413473, 4411.426514553152, 4515.729056256635, 4522.932156017662, 4575.611073058827, 4663.137319595886, 2115.661494160927, 2172.7718589548185, 2184.3010236724094, 2204.7291289971035, 2248.8650680959195, 1027.8612387327764, 1040.8238690279936, 1067.9199060070525, 1130.9547618095348, 1169.4620474581789, 21285.68071478929, 21370.252041178795, 21432.464188395414, 21468.463288417603, 21618.56762864734, 1027.5119318323887, 1036.6527213383602, 1099.796537640523, 1100.9339439633488, 1120.943952802373, 11524.59663911759, 11800.88199118015, 11829.822552661717, 11858.466369013415, 11973.820392694117, 522202.0, 539979.0, 541150.0, 555563.0, 557173.0, 93067.53466232626, 93558.53220733853, 93944.0, 98813.0, 111815.44092279486, 1057.2018126314583, 1089.8147314956477, 1093.824988001916, 1100.741325788439, 1102.4542851288504, 18430.815691843447, 19030.238790448228, 19201.32795352156, 19314.613707726046, 19536.60926781485, 35983.64016359803, 40943.795281023406, 44112.77943610262, 45104.323435147846, 45293.86765330893, 60669.69665151646, 65948.67025664842, 66081.0, 67560.3243967554, 68865.0, 9030.729078127666, 9060.773480663036, 9118.726438206864, 9176.35765496409, 9358.485283309483, 12384.876151238372, 13364.933175334061, 13393.19640821554, 13548.0, 14118.929405352908, 12421.44103515362, 12492.437840297027, 12530.874691252971, 12563.18339307942, 12825.42285597169, 11123.0, 11995.220310679779, 12340.074494412775, 12580.685482863002, 12940.547080852126, 12715.029200270195, 12738.108332416641, 12841.357932103545, 13085.41115649779, 13123.54067607629, 7907.683692652229, 8296.958515207385, 8346.791330216793, 8895.243904268209, 9203.309751768778, 9692.41845489273, 11940.940295298467, 11947.701307467383, 12072.939635301767, 12107.213031152947], "value": 9760.471159215342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1579.2577488580366, 1582.7625856121583, 1762.3743571032282, 1836.4490652804157, 1878.5115869873837, 8948.418352807063, 9154.176124148826, 9683.128518433348, 9707.805843883118, 9753.609855605777, 9426.0, 9900.702978910625, 9905.900940990588, 9915.305928585001, 9931.0, 2426.8907899144538, 2485.142625794107, 2488.2659615413495, 2489.2905521926164, 2489.850608963459, 2412.360724408033, 2508.347829564317, 2509.636102765098, 2513.522430738154, 2516.937076573082, 2444.6577479152934, 2463.802895768343, 2498.2130628851855, 2498.5127900059497, 2505.5114252720728, 2435.0990133650484, 2455.9754402455924, 2461.692288463942, 2465.0263146057205, 2466.9753302466925, 2436.1473484280536, 2444.340028192396, 2444.8899799508886, 2445.902163913441, 2474.1464194852747, 9628.08533189353, 9677.177439917616, 9689.079537443931, 9701.757456063655, 9715.708528744079, 5543.196236545718, 5630.042892708249, 5704.030314846486, 5704.828855134353, 5706.885862282731, 3317.5189597508224, 3410.0622328859513, 3432.5194472773833, 3446.276281980787, 3481.077514458645, 1062.7502536903821, 1087.4671411008628, 1090.0353187429182, 1101.6750058732694, 1119.1885882735032, 13747.862521374758, 13981.300934953313, 13997.720045599133, 13998.790018149633, 14031.508897188549, 4790.185668436374, 4869.513048695102, 4957.925631115536, 5035.144025515598, 5080.916824102101, 11901.523939042514, 11908.225965312227, 11918.940405297919, 11933.641990740292, 11936.761264774656, 5760.94239057604, 5778.566607504454, 5787.826365209051, 5808.477237048686, 5821.679807610622, 4504.662150338738, 5061.519155680205, 5171.974140129275, 5197.636165468381, 5304.071787437183, 4240.49114106303, 4304.139172165579, 4360.454943132108, 4380.2772542530765, 4382.452193475816, 1241.075398827879, 1253.185429470833, 1258.7671280813079, 1265.5633806336798, 1266.1010682415404, 966.4491239993278, 1011.5751384418562, 1039.9688009359731, 1077.2190162132392, 1077.9299345542515, 6395.136656551399, 6509.934900650933, 6532.314107018789, 6695.765648202289, 6724.6301453419555, 466.8482743108435, 481.90602832447337, 482.679018452732, 483.61552565710343, 509.67380876239235, 4353.956460435355, 4454.1982443159895, 4480.708753930984, 4562.954370456319, 4583.0, 11972.0, 12449.564265250672, 12464.0, 12483.50065997368, 12503.937480312541, 11496.482658280398, 11989.820152697717, 11996.580119695944, 12351.629451116482, 12354.0734444917, 8980.955095224614, 9165.450072995774, 9172.312076594282, 9220.124088211609, 9254.583543740548, 6274.247090349188, 6374.394432528902, 6462.1599192106605, 6491.642959637265, 6548.508861835287, 10969.286996345212, 11387.715307117389, 11452.94273528627, 11522.020628246357, 11597.76804463923, 11447.599334023269, 11531.019863311378, 11593.594224202112, 11645.88354116448, 11651.12616553745, 8300.501969881827, 8631.180037896389, 8636.568171591269, 8648.697295594624, 8897.644094236159, 9504.04959504044, 9650.179734722627, 9704.175145112462, 9733.513324333613, 9739.464329461947, 8604.741857744277, 8640.0, 8696.78258043554, 8726.171013753683, 8739.300855931637, 8309.750707478785, 8399.916000839914, 8406.0, 8461.830763384822, 8563.0, 7491.9625401872645, 7728.420368472274, 7755.302022817974, 7756.457048006585, 7770.650320735467, 5592.356878958972, 5630.60585758993, 5664.150377443417, 5748.0, 5776.018076926848, 5618.7190640467, 5667.1782591524825, 5696.886062278814, 5736.340320862987, 5767.307923049261], "value": 4952.579379817992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.2938992624824, 354.67015675421857, 362.0821218211832, 364.32963347440705, 369.2246282806108, 5849.853753656161, 5857.502112320452, 5888.823335299948, 5894.646321220719, 5906.5274778017765, 5599.944000559994, 5807.764010855819, 5815.505682017034, 5815.651060936347, 5838.153467747175, 4520.525344838794, 4562.133194693014, 4571.977140114294, 4577.420789827504, 4601.884952876188, 4584.7478388688605, 4591.793369298372, 4598.333241679954, 4609.746463944482, 4618.97690511547, 4519.457944765522, 4570.862874113782, 4573.291139873325, 4587.977060114695, 4625.0, 4531.229690952546, 4550.97724511377, 4556.681032327739, 4599.586037256646, 4607.378003969471, 4083.2854250506043, 4089.2230476209725, 4091.9590804091877, 4105.178964207171, 4113.8971525711795, 5602.467765562305, 5677.545796336283, 5723.313202415695, 5761.193432919395, 5789.2763404574425, 5174.7412629368755, 5182.300389447414, 5213.0, 5246.527812496894, 5261.368635763694, 6019.879602407927, 6079.787207447718, 6090.208272924536, 6129.509639228851, 6142.447179753844, 4383.627391671712, 4463.308187230984, 4472.338958319794, 4501.009777848868, 4510.0, 6140.201773769381, 6317.273513545955, 6350.364963503659, 6362.172917520739, 6363.395477429637, 4493.438320209973, 4531.229690952546, 4540.477845047862, 4551.089782043605, 4552.863414097516, 4578.107269082563, 4585.082983403333, 4588.931166032512, 4594.931076033862, 4595.862124136282, 5157.613179011589, 5209.453007434165, 5245.868853278698, 5246.632735708464, 5251.396089449686, 6103.938960610426, 6119.694015299217, 6122.479589234965, 6140.232470941132, 6164.969175154096, 1564.7887535182833, 1585.6590832970967, 1589.9506325825132, 1591.7851090102688, 1596.6806638672313, 986.6053578568486, 989.2531138990016, 1027.9588816447408, 1077.7844431113651, 1089.4661615808197, 5756.762296106357, 5780.421957804186, 5796.565257605696, 5830.1343570058025, 5842.503387212135, 6203.534734894901, 6246.718897649525, 6250.312465628868, 6268.717907694165, 6299.937000630027, 5707.914381284284, 5744.253247077937, 5781.942180578225, 5846.503047241032, 5912.615679980788, 3320.3857286402094, 3362.974292840707, 3365.343757967222, 3368.5620869286836, 3373.4433818420175, 6211.534134939807, 6476.773312934025, 6504.479641628658, 6527.445167160749, 6597.0, 6386.552941294065, 6460.935390646034, 6461.160049193575, 6465.838354041092, 6489.286178520359, 6303.684815759194, 6480.449161821298, 6546.70539825709, 6554.115194448784, 6561.475081993429, 6247.875042499216, 6254.937450625617, 6263.467605253604, 6269.655168965751, 6275.560710750204, 6105.419985101408, 6226.85173615102, 6268.0, 6286.7799627014665, 6335.271443784024, 6481.675916204076, 6541.6075035496115, 6560.40956313934, 6562.376574225441, 6572.80281591553, 4531.84138555149, 4536.88657783558, 4559.361689363425, 4587.839425620087, 4608.654350923627, 6219.626822390671, 6318.241810982711, 6339.397757213057, 6436.871262574628, 6447.097406363207, 6090.847728806815, 6154.107654390178, 6156.722947467285, 6171.59884607499, 6195.783147589813, 5958.76164953397, 6097.5731698780655, 6202.41077097675, 6202.697433539008, 6225.346338634378, 6081.604695694766, 6105.755769769159, 6119.877602448015, 6125.969370153299, 6129.172561704113, 6241.375862413723, 6249.375062493714, 6260.530460215593, 6278.183836101278, 6322.178116844781, 5778.768849245983, 5955.451582588472, 5982.521398288213, 6044.365341639064, 6069.907416665043], "value": 4695.047923702385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.2525161709251, 766.0386215299798, 813.9389545784068, 822.338017895594, 834.8705950577655, 17179.82820171798, 18043.81956180438, 18192.45422637323, 18256.269749210016, 18276.634467310647, 16731.916340418313, 16860.241289141988, 16891.0, 16898.239579218935, 16907.746383804253, 725.8838585826282, 864.5072308783996, 876.2989608313355, 880.9339299552527, 892.085612247445, 883.3772190605607, 888.0852721696631, 889.9021107678183, 890.2166093837446, 890.5057692980394, 927.6289484206304, 937.3063932689795, 938.2353381993653, 939.464505232018, 940.252499263084, 922.5986695787354, 930.692871352452, 931.222429271559, 932.6036434515338, 933.5472295936431, 682.9931700682979, 684.551618689759, 684.5960883079007, 687.2303020616891, 689.021589343134, 14751.852481475154, 14896.8827337949, 14903.925480372638, 14945.103293802298, 14958.551243462605, 15457.0, 15566.610834729108, 15601.531954041284, 15807.525774226791, 15825.841741582552, 13136.934315328363, 13159.86840131596, 13172.736545269041, 13247.271400072992, 13305.933470332684, 4039.939400908989, 4119.8970025749295, 4146.688998325138, 4189.455370801807, 4294.656427485794, 82963.9999999994, 83315.5834220831, 83749.0, 84216.0, 85205.57397212974, 11264.605738799266, 11336.43317834105, 11402.0308273796, 11435.542578296774, 11615.419229038514, 19042.238310467426, 19181.32865349706, 19193.424197274104, 19197.424077277705, 19233.61532769337, 8693.174148455886, 8829.514376709214, 8881.289496840367, 8995.0, 9191.264698824078, 4916.0905232532095, 4984.102861484967, 5002.0, 5103.591712662978, 5155.871103222375, 4010.1578668479365, 4127.607877251657, 4165.166966606691, 4172.415861779354, 4174.352975288835, 663.0617675988518, 685.4674947747969, 686.8763622547989, 692.6121372031679, 715.9355657990702, 718.8526352097807, 760.5778792769955, 778.1712476212815, 810.525842382213, 815.7838172884191, 10149.847752283722, 10645.20160987929, 11016.06363459099, 11061.391623460626, 11191.0, 652.7845810882397, 670.8557660103102, 711.3846522757777, 781.0861292288037, 819.4837252530987, 4800.927986080212, 5082.898342033212, 5359.678419294854, 5378.2470454136455, 5550.167474878801, 119096.40451797859, 123359.0, 125659.37170314272, 127115.36442317729, 127783.36108319399, 108475.0, 109464.0, 111120.44439777911, 112108.0, 112969.43515282372, 92802.53598732098, 95007.0, 95605.52197239109, 96246.0, 97092.0, 10142.849291249504, 10253.897461025592, 10307.484625768531, 10667.733306667085, 10732.463376831283, 52962.73518632382, 53338.4666153349, 53439.46560534345, 54752.45247547473, 55723.72138139283, 70280.64859675668, 83201.16798831934, 84606.57696711477, 85022.0, 85748.0, 12671.746565068832, 13325.267110309027, 13424.93287533556, 13497.797533037208, 13709.0, 15090.698186036438, 15469.381224750883, 15484.0, 15546.533603991898, 15792.60518487047, 14160.858391415954, 14509.201993890438, 14519.709605808035, 14737.926310368379, 14762.852371476149, 13774.173549587056, 13932.2337271447, 13956.162630242217, 14112.858871411154, 14778.408863645764, 13795.517156899461, 14264.286785660468, 14441.205733684748, 14873.405063797327, 14962.925185374004, 10959.671209863716, 11113.666590002313, 11204.775904482029, 11953.820692689442, 12180.0, 12619.87380126187, 13189.274589897648, 13548.322583870964, 13726.794098088736, 13929.0], "value": 8136.995839226936, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1494.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 106.0, 110.0, 111.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 149.0, 173.0, 119.0, 141.0, 146.0, 118.0, 167.0, 122.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 163.0, 162.0, 161.0, 164.0, 161.0, 161.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 181.0, 76.0, 75.0, 76.0, 76.0, 168.0, 75.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 150.0, 84.0, 84.0, 84.0, 132.0, 83.0, 83.0, 151.0], "value": 101.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 50.0, 51.0, 51.0, 50.0, 53.0, 51.0, 50.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 64.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 72.0, 72.0, 79.0, 81.0, 72.0, 72.0, 72.0, 74.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 129.0, 129.0, 117.0, 119.0, 117.0, 120.0, 159.0, 129.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 156.0, 154.0, 155.0, 149.0, 149.0, 150.0, 152.0, 156.0, 155.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 64.0, 62.0, 60.0, 60.0, 60.0, 61.0, 63.0], "value": 61.5, "unit": "score"}]}]} 20:55:33 INFO - Return code: 0 20:55:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:55:33 ERROR - # TBPL SUCCESS # 20:55:33 INFO - Running post-action listener: _resource_record_post_action 20:55:33 INFO - [mozharness: 2016-09-29 03:55:33.897007Z] Finished run-tests step (success) 20:55:33 INFO - Running post-run listener: _resource_record_post_run 20:55:33 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291872768; Read time: 8; Write time: 215172 20:55:33 INFO - TinderboxPrint: CPU usage
13.1% 20:55:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:55:33 INFO - TinderboxPrint: I/O write bytes / time
291,872,768 / 215,172 20:55:33 INFO - TinderboxPrint: CPU idle
8,211.7 (86.8%) 20:55:33 INFO - TinderboxPrint: CPU user
1,191.7 (12.6%) 20:55:33 INFO - TinderboxPrint: Swap in / out
0 / 0 20:55:33 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71905280; Read time: 0; Write time: 36732 20:55:33 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 219967488; Read time: 0; Write time: 178440 20:55:34 INFO - Running post-run listener: _upload_blobber_files 20:55:34 INFO - Blob upload gear active. 20:55:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:55:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:55:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:55:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:55:34 INFO - (blobuploader) - INFO - Open directory for files ... 20:55:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:55:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:55:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:38 INFO - (blobuploader) - INFO - Done attempting. 20:55:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:55:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:55:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:39 INFO - (blobuploader) - INFO - Done attempting. 20:55:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:55:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:55:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:55:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:55:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:55:39 INFO - (blobuploader) - INFO - Done attempting. 20:55:39 INFO - (blobuploader) - INFO - Iteration through files over. 20:55:39 INFO - Return code: 0 20:55:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:55:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:55:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/704b46e148f75f5a1489b27aa0b469d17577a65fb9d8b243306d63bd299357d48dbf882fca60068c512d6aadc6106340b8242f30e04d0bc3563bcce8725211ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0556941c22763f7fc414c68541fc25c8d3fe00f5455af83f78a3882ff22dcbcfc3013cdc9716c16b05e26bea5ecedf224135b5c8770e611430b5f5e46e81efc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1086f71fbf5be34bbe4c4ef7e7ea2f51a6962deb03c92d4fdaf992f89796e5abc90da14b8876d47ef732328f13af57168b2e0fcd1b8ea8caf0662ce6a87051f7"} 20:55:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:55:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:55:39 INFO - Contents: 20:55:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/704b46e148f75f5a1489b27aa0b469d17577a65fb9d8b243306d63bd299357d48dbf882fca60068c512d6aadc6106340b8242f30e04d0bc3563bcce8725211ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0556941c22763f7fc414c68541fc25c8d3fe00f5455af83f78a3882ff22dcbcfc3013cdc9716c16b05e26bea5ecedf224135b5c8770e611430b5f5e46e81efc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1086f71fbf5be34bbe4c4ef7e7ea2f51a6962deb03c92d4fdaf992f89796e5abc90da14b8876d47ef732328f13af57168b2e0fcd1b8ea8caf0662ce6a87051f7"} 20:55:39 INFO - Running post-run listener: copy_logs_to_upload_dir 20:55:39 INFO - Copying logs to upload dir... 20:55:39 INFO - mkdir: /builds/slave/test/build/upload/logs 20:55:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1672.153585 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 52 secs) (at 2016-09-28 20:55:39.169929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 20:55:39.173285) ========= 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-1475119665.296833-1362112107 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/704b46e148f75f5a1489b27aa0b469d17577a65fb9d8b243306d63bd299357d48dbf882fca60068c512d6aadc6106340b8242f30e04d0bc3563bcce8725211ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0556941c22763f7fc414c68541fc25c8d3fe00f5455af83f78a3882ff22dcbcfc3013cdc9716c16b05e26bea5ecedf224135b5c8770e611430b5f5e46e81efc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1086f71fbf5be34bbe4c4ef7e7ea2f51a6962deb03c92d4fdaf992f89796e5abc90da14b8876d47ef732328f13af57168b2e0fcd1b8ea8caf0662ce6a87051f7"} build_url:https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011496 build_url: 'https://queue.taskcluster.net/v1/task/J6JPVM9rRf6RRaq2UCAhvg/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/704b46e148f75f5a1489b27aa0b469d17577a65fb9d8b243306d63bd299357d48dbf882fca60068c512d6aadc6106340b8242f30e04d0bc3563bcce8725211ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0556941c22763f7fc414c68541fc25c8d3fe00f5455af83f78a3882ff22dcbcfc3013cdc9716c16b05e26bea5ecedf224135b5c8770e611430b5f5e46e81efc3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1086f71fbf5be34bbe4c4ef7e7ea2f51a6962deb03c92d4fdaf992f89796e5abc90da14b8876d47ef732328f13af57168b2e0fcd1b8ea8caf0662ce6a87051f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 20:55:39.204056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 20:55:39.204970) ========= 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-1475119665.296833-1362112107 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 20:55:39.284125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 20:55:39.284505) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 20:55:39.284890) ========= ========= Total master_lag: 0.28 =========