builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1472382346.47 results: success (0) buildid: 20160826110814 builduid: 0dbeb50956e042d4ac8dadee4f76f40d revision: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.466030) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.466491) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.466766) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.481397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.481750) ========= 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=4300f881736b422476174874000001bc-1472382346.584979-960572220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-28 04:05:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.0M=0.001s 2016-08-28 04:05:47 (21.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124954 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.620664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.621018) ========= 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=4300f881736b422476174874000001bc-1472382346.584979-960572220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020092 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.671349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.671724) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f --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 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f --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=4300f881736b422476174874000001bc-1472382346.584979-960572220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-28 04:05:47,461 truncating revision to first 12 chars 2016-08-28 04:05:47,461 Setting DEBUG logging. 2016-08-28 04:05:47,461 attempt 1/10 2016-08-28 04:05:47,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6d0c7b6a6ae1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-28 04:05:47,960 unpacking tar archive at: mozilla-beta-6d0c7b6a6ae1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.808753 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.493963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.494337) ========= script_repo_revision: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.494726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.495002) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.504156) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 50 secs) (at 2016-08-28 04:05:47.504533) ========= /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=4300f881736b422476174874000001bc-1472382346.584979-960572220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:48 INFO - MultiFileLogger online at 20160828 04:05:48 in /builds/slave/test 04:05:48 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 04:05:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:48 INFO - {'append_to_log': False, 04:05:48 INFO - 'base_work_dir': '/builds/slave/test', 04:05:48 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:05:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:48 INFO - 'branch': 'Mozilla-Beta', 04:05:48 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:48 INFO - 'config_files': ('talos/linux_config.py',), 04:05:48 INFO - 'default_actions': ('clobber', 04:05:48 INFO - 'read-buildbot-config', 04:05:48 INFO - 'download-and-extract', 04:05:48 INFO - 'populate-webroot', 04:05:48 INFO - 'create-virtualenv', 04:05:48 INFO - 'install', 04:05:48 INFO - 'run-tests'), 04:05:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:48 INFO - 'download_minidump_stackwalk': True, 04:05:48 INFO - 'download_symbols': 'ondemand', 04:05:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:48 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:48 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:48 INFO - 'installer_path': 'installer.exe', 04:05:48 INFO - 'log_level': 'info', 04:05:48 INFO - 'log_name': 'talos', 04:05:48 INFO - 'log_to_console': True, 04:05:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:48 INFO - 'opt_config_files': (), 04:05:48 INFO - 'pip_index': False, 04:05:48 INFO - 'sps_profile': False, 04:05:48 INFO - 'sps_profile_interval': 0, 04:05:48 INFO - 'suite': 'dromaeojs-e10s', 04:05:48 INFO - 'system_bits': '32', 04:05:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:48 INFO - 'title': 'talos-linux64-ix-045', 04:05:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:48 INFO - 'use_talos_json': True, 04:05:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:48 INFO - 'work_dir': 'build'} 04:05:48 INFO - ##### 04:05:48 INFO - ##### Running clobber step. 04:05:48 INFO - ##### 04:05:48 INFO - Running pre-action listener: _resource_record_pre_action 04:05:48 INFO - Running main action method: clobber 04:05:48 INFO - rmtree: /builds/slave/test/build 04:05:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:49 INFO - Running post-action listener: _resource_record_post_action 04:05:49 INFO - ##### 04:05:49 INFO - ##### Finished clobber step (success) 04:05:49 INFO - ##### 04:05:49 INFO - ##### 04:05:49 INFO - ##### Running read-buildbot-config step. 04:05:49 INFO - ##### 04:05:49 INFO - Running pre-action listener: _resource_record_pre_action 04:05:49 INFO - Running main action method: read_buildbot_config 04:05:49 INFO - Using buildbot properties: 04:05:49 INFO - { 04:05:49 INFO - "project": "", 04:05:49 INFO - "product": "firefox", 04:05:49 INFO - "script_repo_revision": "production", 04:05:49 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:05:49 INFO - "repository": "", 04:05:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 04:05:49 INFO - "buildid": "20160826110814", 04:05:49 INFO - "pgo_build": "True", 04:05:49 INFO - "basedir": "/builds/slave/test", 04:05:49 INFO - "buildnumber": 89, 04:05:49 INFO - "slavename": "talos-linux64-ix-045", 04:05:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:05:49 INFO - "platform": "ubuntu64_hw", 04:05:49 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:05:49 INFO - "branch": "mozilla-beta", 04:05:49 INFO - "repo_path": "releases/mozilla-beta", 04:05:49 INFO - "revision": "6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f", 04:05:49 INFO - "stage_platform": "linux64-pgo", 04:05:49 INFO - "builduid": "0dbeb50956e042d4ac8dadee4f76f40d", 04:05:49 INFO - "slavebuilddir": "test" 04:05:49 INFO - } 04:05:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 04:05:49 INFO - Running post-action listener: _resource_record_post_action 04:05:49 INFO - ##### 04:05:49 INFO - ##### Finished read-buildbot-config step (success) 04:05:49 INFO - ##### 04:05:49 INFO - ##### 04:05:49 INFO - ##### Running download-and-extract step. 04:05:49 INFO - ##### 04:05:49 INFO - Running pre-action listener: _resource_record_pre_action 04:05:49 INFO - Running main action method: download_and_extract 04:05:49 INFO - mkdir: /builds/slave/test/build/tests 04:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:49 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:05:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:05:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:05:49 INFO - retry: Failed, sleeping 30 seconds before retrying 04:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 04:06:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:06:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:06:19 INFO - retry: Failed, sleeping 60 seconds before retrying 04:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 04:07:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:07:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:07:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json! 04:07:19 INFO - Caught exception: HTTP Error 404: Not Found 04:07:19 INFO - Caught exception: HTTP Error 404: Not Found 04:07:19 INFO - Caught exception: HTTP Error 404: Not Found 04:07:19 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:07:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:07:20 INFO - Downloaded 1327 bytes. 04:07:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:07:20 INFO - Using the following test package requirements: 04:07:20 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 04:07:20 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:07:20 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 04:07:20 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:20 INFO - u'jsshell-linux-x86_64.zip'], 04:07:20 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:07:20 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 04:07:20 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 04:07:20 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 04:07:20 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:07:20 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:07:20 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:07:20 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:07:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07:20 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:07:20 INFO - retry: Failed, sleeping 30 seconds before retrying 04:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 04:07:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07:50 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:07:50 INFO - retry: Failed, sleeping 60 seconds before retrying 04:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 04:08:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:50 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:08:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip! 04:08:50 INFO - Caught exception: HTTP Error 404: Not Found 04:08:50 INFO - Caught exception: HTTP Error 404: Not Found 04:08:50 INFO - Caught exception: HTTP Error 404: Not Found 04:08:50 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:50 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:50 INFO - Downloaded 21969046 bytes. 04:08:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:08:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:08:52 INFO - Return code: 0 04:08:52 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:52 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:08:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:08:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:08:52 INFO - retry: Failed, sleeping 30 seconds before retrying 04:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 04:09:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:09:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:09:22 INFO - retry: Failed, sleeping 60 seconds before retrying 04:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 04:10:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:10:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:10:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip! 04:10:22 INFO - Caught exception: HTTP Error 404: Not Found 04:10:22 INFO - Caught exception: HTTP Error 404: Not Found 04:10:22 INFO - Caught exception: HTTP Error 404: Not Found 04:10:22 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:10:22 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:10:23 INFO - Downloaded 21969046 bytes. 04:10:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:10:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:10:24 INFO - Return code: 0 04:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:24 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:10:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:10:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:10:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:10:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:10:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:10:24 INFO - retry: Failed, sleeping 30 seconds before retrying 04:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 04:10:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:10:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:10:54 INFO - retry: Failed, sleeping 60 seconds before retrying 04:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 04:11:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:11:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:11:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip! 04:11:54 INFO - Caught exception: HTTP Error 404: Not Found 04:11:54 INFO - Caught exception: HTTP Error 404: Not Found 04:11:54 INFO - Caught exception: HTTP Error 404: Not Found 04:11:54 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:11:54 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 04:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:11:55 INFO - Downloaded 10833369 bytes. 04:11:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:11:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:11:55 INFO - Return code: 0 04:11:55 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')]} 04:11:55 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:11:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:11:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:11:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:11:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:11:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:11:55 INFO - retry: Failed, sleeping 30 seconds before retrying 04:12:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 04:12:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:12:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:12:25 INFO - retry: Failed, sleeping 60 seconds before retrying 04:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 04:13:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:13:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:13:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2! 04:13:25 INFO - Caught exception: HTTP Error 404: Not Found 04:13:25 INFO - Caught exception: HTTP Error 404: Not Found 04:13:25 INFO - Caught exception: HTTP Error 404: Not Found 04:13:25 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:13:25 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:13:26 INFO - Downloaded 55208267 bytes. 04:13:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:13:26 INFO - mkdir: /builds/slave/test/properties 04:13:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:26 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:26 INFO - Contents: 04:13:26 INFO - build_url:https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 04:13:27 INFO - Running post-action listener: _resource_record_post_action 04:13:27 INFO - Running post-action listener: set_extra_try_arguments 04:13:27 INFO - ##### 04:13:27 INFO - ##### Finished download-and-extract step (success) 04:13:27 INFO - ##### 04:13:27 INFO - ##### 04:13:27 INFO - ##### Running populate-webroot step. 04:13:27 INFO - ##### 04:13:27 INFO - Running pre-action listener: _resource_record_pre_action 04:13:27 INFO - Running main action method: populate_webroot 04:13:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:27 INFO - '--tppagecycles', 04:13:27 INFO - '7'], 04:13:27 INFO - 'tests': ['tsvgm']}}, 04:13:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:27 INFO - 'talos_options': ['--disable-e10s'], 04:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:27 INFO - 'talos_options': ['--disable-e10s'], 04:13:27 INFO - 'tests': ['damp', 'tps']}, 04:13:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:27 INFO - 'tests': ['damp', 'tps']}, 04:13:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:27 INFO - 'tests': ['dromaeo_dom']}, 04:13:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:27 INFO - 'tests': ['a11yr', 04:13:27 INFO - 'ts_paint', 04:13:27 INFO - 'tpaint', 04:13:27 INFO - 'sessionrestore', 04:13:27 INFO - 'sessionrestore_no_auto_restore', 04:13:27 INFO - 'tabpaint']}, 04:13:27 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:27 INFO - 'ts_paint', 04:13:27 INFO - 'tpaint', 04:13:27 INFO - 'sessionrestore', 04:13:27 INFO - 'sessionrestore_no_auto_restore', 04:13:27 INFO - 'tabpaint']}, 04:13:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:27 INFO - 'ts_paint', 04:13:27 INFO - 'tpaint', 04:13:27 INFO - 'sessionrestore', 04:13:27 INFO - 'sessionrestore_no_auto_restore', 04:13:27 INFO - 'tabpaint']}, 04:13:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:27 INFO - 'ts_paint', 04:13:27 INFO - 'tpaint', 04:13:27 INFO - 'sessionrestore', 04:13:27 INFO - 'sessionrestore_no_auto_restore', 04:13:27 INFO - 'tabpaint']}, 04:13:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:27 INFO - 'tests': ['a11yr', 04:13:27 INFO - 'ts_paint', 04:13:27 INFO - 'tpaint', 04:13:27 INFO - 'sessionrestore', 04:13:27 INFO - 'sessionrestore_no_auto_restore', 04:13:27 INFO - 'tabpaint']}, 04:13:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:27 INFO - 'tests': ['a11yr', 04:13:27 INFO - 'ts_paint', 04:13:27 INFO - 'tpaint', 04:13:27 INFO - 'sessionrestore', 04:13:27 INFO - 'sessionrestore_no_auto_restore', 04:13:27 INFO - 'tabpaint']}, 04:13:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:27 INFO - 'tests': ['tsvgx', 04:13:27 INFO - 'tsvgr_opacity', 04:13:27 INFO - 'tart', 04:13:27 INFO - 'tscrollx', 04:13:27 INFO - 'cart']}, 04:13:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:27 INFO - 'tsvgr_opacity', 04:13:27 INFO - 'tart', 04:13:27 INFO - 'tscrollx', 04:13:27 INFO - 'cart']}, 04:13:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:27 INFO - 'talos_options': ['--disable-e10s'], 04:13:27 INFO - 'tests': ['tp5o']}, 04:13:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:27 INFO - 'tests': ['tp5o']}, 04:13:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:27 INFO - 'talos_options': ['--disable-e10s', 04:13:27 INFO - '--xperf_path', 04:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:27 INFO - 'tests': ['tp5n']}, 04:13:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:27 INFO - 'talos_options': ['--xperf_path', 04:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:27 INFO - 'tests': ['tp5n']}}, 04:13:27 INFO - 'talos.zip': {'path': '', 04:13:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:27 INFO - Running post-action listener: _resource_record_post_action 04:13:27 INFO - ##### 04:13:27 INFO - ##### Finished populate-webroot step (success) 04:13:27 INFO - ##### 04:13:27 INFO - ##### 04:13:27 INFO - ##### Running create-virtualenv step. 04:13:27 INFO - ##### 04:13:27 INFO - Running pre-action listener: _resource_record_pre_action 04:13:27 INFO - Running main action method: create_virtualenv 04:13:27 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:27 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 04:13:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:27 INFO - Using real prefix '/usr' 04:13:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:28 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:30 INFO - Installing pip.................done. 04:13:30 INFO - Return code: 0 04:13:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:30 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')]} 04:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 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')]} 04:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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 04:13:30 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 04:13:30 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 04:13:30 INFO - Using env: {'DISPLAY': ':0', 04:13:30 INFO - 'HOME': '/home/cltbld', 04:13:30 INFO - 'LANG': 'en_US.UTF-8', 04:13:30 INFO - 'LANGUAGE': 'en_US:en', 04:13:30 INFO - 'LOGNAME': 'cltbld', 04:13:30 INFO - 'MAIL': '/var/mail/cltbld', 04:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:30 INFO - 'MOZ_NO_REMOTE': '1', 04:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:30 INFO - 'NO_EM_RESTART': '1', 04:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:30 INFO - 'PWD': '/builds/slave/test', 04:13:30 INFO - 'SHELL': '/bin/bash', 04:13:30 INFO - 'SHLVL': '1', 04:13:30 INFO - 'TERM': 'linux', 04:13:30 INFO - 'TMOUT': '86400', 04:13:30 INFO - 'USER': 'cltbld', 04:13:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:30 INFO - '_': '/tools/buildbot/bin/python'} 04:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:30 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 04:13:30 INFO - Cleaning up... 04:13:30 INFO - Return code: 0 04:13:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:30 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')]} 04:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 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')]} 04:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:30 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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 04:13:30 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 04:13:30 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 04:13:30 INFO - Using env: {'DISPLAY': ':0', 04:13:30 INFO - 'HOME': '/home/cltbld', 04:13:30 INFO - 'LANG': 'en_US.UTF-8', 04:13:30 INFO - 'LANGUAGE': 'en_US:en', 04:13:30 INFO - 'LOGNAME': 'cltbld', 04:13:30 INFO - 'MAIL': '/var/mail/cltbld', 04:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:30 INFO - 'MOZ_NO_REMOTE': '1', 04:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:30 INFO - 'NO_EM_RESTART': '1', 04:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:30 INFO - 'PWD': '/builds/slave/test', 04:13:30 INFO - 'SHELL': '/bin/bash', 04:13:30 INFO - 'SHLVL': '1', 04:13:30 INFO - 'TERM': 'linux', 04:13:30 INFO - 'TMOUT': '86400', 04:13:30 INFO - 'USER': 'cltbld', 04:13:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:30 INFO - '_': '/tools/buildbot/bin/python'} 04:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:30 INFO - Downloading/unpacking psutil>=3.1.1 04:13:30 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 04:13:30 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 04:13:30 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 04:13:30 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 04:13:30 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 04:13:30 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 04:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:32 INFO - Installing collected packages: psutil 04:13:32 INFO - Running setup.py install for psutil 04:13:32 INFO - building 'psutil._psutil_linux' extension 04:13:32 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 04:13: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 04:13:32 INFO - building 'psutil._psutil_posix' extension 04:13: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 04:13: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 04:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:32 INFO - Successfully installed psutil 04:13:32 INFO - Cleaning up... 04:13:33 INFO - Return code: 0 04:13:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:33 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')]} 04:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:33 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')]} 04:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:33 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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 04:13:33 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 04:13:33 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 04:13:33 INFO - Using env: {'DISPLAY': ':0', 04:13:33 INFO - 'HOME': '/home/cltbld', 04:13:33 INFO - 'LANG': 'en_US.UTF-8', 04:13:33 INFO - 'LANGUAGE': 'en_US:en', 04:13:33 INFO - 'LOGNAME': 'cltbld', 04:13:33 INFO - 'MAIL': '/var/mail/cltbld', 04:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:33 INFO - 'MOZ_NO_REMOTE': '1', 04:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:33 INFO - 'NO_EM_RESTART': '1', 04:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:33 INFO - 'PWD': '/builds/slave/test', 04:13:33 INFO - 'SHELL': '/bin/bash', 04:13:33 INFO - 'SHLVL': '1', 04:13:33 INFO - 'TERM': 'linux', 04:13:33 INFO - 'TMOUT': '86400', 04:13:33 INFO - 'USER': 'cltbld', 04:13:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:33 INFO - '_': '/tools/buildbot/bin/python'} 04:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:33 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 04:13:33 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 04:13:33 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 04:13:33 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 04:13:33 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 04:13:33 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 04:13:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:13:35 INFO - Installing collected packages: mozsystemmonitor 04:13:35 INFO - Running setup.py install for mozsystemmonitor 04:13:35 INFO - Successfully installed mozsystemmonitor 04:13:35 INFO - Cleaning up... 04:13:35 INFO - Return code: 0 04:13:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:35 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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 04:13:35 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 04:13:35 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 04:13:35 INFO - Using env: {'DISPLAY': ':0', 04:13:35 INFO - 'HOME': '/home/cltbld', 04:13:35 INFO - 'LANG': 'en_US.UTF-8', 04:13:35 INFO - 'LANGUAGE': 'en_US:en', 04:13:35 INFO - 'LOGNAME': 'cltbld', 04:13:35 INFO - 'MAIL': '/var/mail/cltbld', 04:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:35 INFO - 'MOZ_NO_REMOTE': '1', 04:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:35 INFO - 'NO_EM_RESTART': '1', 04:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:35 INFO - 'PWD': '/builds/slave/test', 04:13:35 INFO - 'SHELL': '/bin/bash', 04:13:35 INFO - 'SHLVL': '1', 04:13:35 INFO - 'TERM': 'linux', 04:13:35 INFO - 'TMOUT': '86400', 04:13:35 INFO - 'USER': 'cltbld', 04:13:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:35 INFO - '_': '/tools/buildbot/bin/python'} 04:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:35 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:35 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 04:13:35 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 04:13:35 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 04:13:35 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 04:13:35 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 04:13:35 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 04:13:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:37 INFO - warning: no files found matching '*.txt' 04:13:37 INFO - no previously-included directories found matching 'build' 04:13:37 INFO - no previously-included directories found matching 'dist' 04:13:37 INFO - no previously-included directories found matching '.git*' 04:13:37 INFO - Installing collected packages: jsonschema, functools32 04:13:37 INFO - Running setup.py install for functools32 04:13:37 INFO - warning: no files found matching '*.txt' 04:13:37 INFO - no previously-included directories found matching 'build' 04:13:37 INFO - no previously-included directories found matching 'dist' 04:13:37 INFO - no previously-included directories found matching '.git*' 04:13:37 INFO - Successfully installed jsonschema functools32 04:13:37 INFO - Cleaning up... 04:13:37 INFO - Return code: 0 04:13:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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 04:13: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 04:13: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 04:13:37 INFO - Using env: {'DISPLAY': ':0', 04:13:37 INFO - 'HOME': '/home/cltbld', 04:13:37 INFO - 'LANG': 'en_US.UTF-8', 04:13:37 INFO - 'LANGUAGE': 'en_US:en', 04:13:37 INFO - 'LOGNAME': 'cltbld', 04:13:37 INFO - 'MAIL': '/var/mail/cltbld', 04:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:37 INFO - 'MOZ_NO_REMOTE': '1', 04:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:37 INFO - 'NO_EM_RESTART': '1', 04:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:37 INFO - 'PWD': '/builds/slave/test', 04:13:37 INFO - 'SHELL': '/bin/bash', 04:13:37 INFO - 'SHLVL': '1', 04:13:37 INFO - 'TERM': 'linux', 04:13:37 INFO - 'TMOUT': '86400', 04:13:37 INFO - 'USER': 'cltbld', 04:13:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:37 INFO - '_': '/tools/buildbot/bin/python'} 04:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:39 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:40 INFO - Downloading docopt-0.6.1.tar.gz 04:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:40 INFO - Running setup.py install for blobuploader 04:13:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:40 INFO - Running setup.py install for requests 04:13:41 INFO - Running setup.py install for docopt 04:13:41 INFO - Successfully installed blobuploader requests docopt 04:13:41 INFO - Cleaning up... 04:13:41 INFO - Return code: 0 04:13:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:41 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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 04:13:41 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 04:13:41 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 04:13:41 INFO - Using env: {'DISPLAY': ':0', 04:13:41 INFO - 'HOME': '/home/cltbld', 04:13:41 INFO - 'LANG': 'en_US.UTF-8', 04:13:41 INFO - 'LANGUAGE': 'en_US:en', 04:13:41 INFO - 'LOGNAME': 'cltbld', 04:13:41 INFO - 'MAIL': '/var/mail/cltbld', 04:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:41 INFO - 'MOZ_NO_REMOTE': '1', 04:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:41 INFO - 'NO_EM_RESTART': '1', 04:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:41 INFO - 'PWD': '/builds/slave/test', 04:13:41 INFO - 'SHELL': '/bin/bash', 04:13:41 INFO - 'SHLVL': '1', 04:13:41 INFO - 'TERM': 'linux', 04:13:41 INFO - 'TMOUT': '86400', 04:13:41 INFO - 'USER': 'cltbld', 04:13:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:41 INFO - '_': '/tools/buildbot/bin/python'} 04:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:41 INFO - Running setup.py (path:/tmp/pip-OgdgsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:41 INFO - Running setup.py (path:/tmp/pip-FOyM0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:41 INFO - Running setup.py (path:/tmp/pip-RA__XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:41 INFO - Running setup.py (path:/tmp/pip-e3fjBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:41 INFO - Running setup.py (path:/tmp/pip-zhWNDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:41 INFO - Running setup.py (path:/tmp/pip-Qss_yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:41 INFO - Running setup.py (path:/tmp/pip-rX18EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:42 INFO - Running setup.py (path:/tmp/pip-NU5muU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:42 INFO - Running setup.py (path:/tmp/pip-5BusCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:42 INFO - Running setup.py (path:/tmp/pip-GCWxxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:42 INFO - Running setup.py (path:/tmp/pip-uNAEMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:42 INFO - Running setup.py (path:/tmp/pip-sEV8MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:42 INFO - Running setup.py (path:/tmp/pip-0TCWlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:42 INFO - Running setup.py (path:/tmp/pip-sjvr6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:42 INFO - Running setup.py (path:/tmp/pip-W1ahyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:42 INFO - Running setup.py (path:/tmp/pip-qzpMMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:42 INFO - Running setup.py (path:/tmp/pip-ERyr86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:42 INFO - Running setup.py install for manifestparser 04:13:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:42 INFO - Running setup.py install for mozcrash 04:13:42 INFO - Running setup.py install for mozdebug 04:13:43 INFO - Running setup.py install for mozdevice 04:13:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:43 INFO - Running setup.py install for mozfile 04:13:43 INFO - Running setup.py install for mozhttpd 04:13:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:43 INFO - Running setup.py install for mozinfo 04:13:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:43 INFO - Running setup.py install for mozInstall 04:13:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:43 INFO - Running setup.py install for mozleak 04:13:43 INFO - Running setup.py install for mozlog 04:13:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:43 INFO - Running setup.py install for moznetwork 04:13:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:43 INFO - Running setup.py install for mozprocess 04:13:43 INFO - Running setup.py install for mozprofile 04:13:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:44 INFO - Running setup.py install for mozrunner 04:13:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:44 INFO - Running setup.py install for mozscreenshot 04:13:44 INFO - Running setup.py install for moztest 04:13:44 INFO - Running setup.py install for mozversion 04:13:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:44 INFO - Cleaning up... 04:13:44 INFO - Return code: 0 04:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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 04:13: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 04:13: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 04:13:44 INFO - Using env: {'DISPLAY': ':0', 04:13:44 INFO - 'HOME': '/home/cltbld', 04:13:44 INFO - 'LANG': 'en_US.UTF-8', 04:13:44 INFO - 'LANGUAGE': 'en_US:en', 04:13:44 INFO - 'LOGNAME': 'cltbld', 04:13:44 INFO - 'MAIL': '/var/mail/cltbld', 04:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:44 INFO - 'MOZ_NO_REMOTE': '1', 04:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:44 INFO - 'NO_EM_RESTART': '1', 04:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:44 INFO - 'PWD': '/builds/slave/test', 04:13:44 INFO - 'SHELL': '/bin/bash', 04:13:44 INFO - 'SHLVL': '1', 04:13:44 INFO - 'TERM': 'linux', 04:13:44 INFO - 'TMOUT': '86400', 04:13:44 INFO - 'USER': 'cltbld', 04:13:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:44 INFO - '_': '/tools/buildbot/bin/python'} 04:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:44 INFO - Running setup.py (path:/tmp/pip-Tn7CzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13: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)) 04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:44 INFO - Running setup.py (path:/tmp/pip-_C3XE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13: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)) 04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:44 INFO - Running setup.py (path:/tmp/pip-mwUcuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13: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)) 04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:44 INFO - Running setup.py (path:/tmp/pip-WRr9cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:45 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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:45 INFO - Running setup.py (path:/tmp/pip-GLMltM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:45 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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:45 INFO - Running setup.py (path:/tmp/pip-RIxvzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:45 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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:45 INFO - Running setup.py (path:/tmp/pip-blHfml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:45 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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:45 INFO - Running setup.py (path:/tmp/pip-wUUyX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:45 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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:45 INFO - Running setup.py (path:/tmp/pip-LTu5Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13: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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:45 INFO - Running setup.py (path:/tmp/pip-2QlzyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:45 INFO - Running setup.py (path:/tmp/pip-6SBVvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13: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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:45 INFO - Running setup.py (path:/tmp/pip-pynrnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13: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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:45 INFO - Running setup.py (path:/tmp/pip-plZuUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13: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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:45 INFO - Running setup.py (path:/tmp/pip-9gvGlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13: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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:45 INFO - Running setup.py (path:/tmp/pip-WTIATj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13: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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:45 INFO - Running setup.py (path:/tmp/pip-YAGZUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13: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)) 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:45 INFO - Running setup.py (path:/tmp/pip-fFYE7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13: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 04:13:47 INFO - Downloading blessings-1.6.tar.gz 04:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:47 INFO - Installing collected packages: blessings 04:13:47 INFO - Running setup.py install for blessings 04:13:48 INFO - Successfully installed blessings 04:13:48 INFO - Cleaning up... 04:13:48 INFO - Return code: 0 04:13:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:48 INFO - Reading from file tmpfile_stdout 04:13:48 INFO - Current package versions: 04:13:48 INFO - argparse == 1.2.1 04:13:48 INFO - blessings == 1.6 04:13:48 INFO - blobuploader == 1.2.4 04:13:48 INFO - docopt == 0.6.1 04:13:48 INFO - functools32 == 3.2.3-2 04:13:48 INFO - jsonschema == 2.5.1 04:13:48 INFO - manifestparser == 1.1 04:13:48 INFO - mozInstall == 1.12 04:13:48 INFO - mozcrash == 0.17 04:13:48 INFO - mozdebug == 0.1 04:13:48 INFO - mozdevice == 0.48 04:13:48 INFO - mozfile == 1.2 04:13:48 INFO - mozhttpd == 0.7 04:13:48 INFO - mozinfo == 0.9 04:13:48 INFO - mozleak == 0.1 04:13:48 INFO - mozlog == 3.2 04:13:48 INFO - moznetwork == 0.27 04:13:48 INFO - mozprocess == 0.23 04:13:48 INFO - mozprofile == 0.28 04:13:48 INFO - mozrunner == 6.12 04:13:48 INFO - mozscreenshot == 0.1 04:13:48 INFO - mozsystemmonitor == 0.3 04:13:48 INFO - moztest == 0.7 04:13:48 INFO - mozversion == 1.4 04:13:48 INFO - psutil == 3.1.1 04:13:48 INFO - requests == 1.2.3 04:13:48 INFO - wsgiref == 0.1.2 04:13:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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 04:13: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 04:13: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 04:13:48 INFO - Using env: {'DISPLAY': ':0', 04:13:48 INFO - 'HOME': '/home/cltbld', 04:13:48 INFO - 'LANG': 'en_US.UTF-8', 04:13:48 INFO - 'LANGUAGE': 'en_US:en', 04:13:48 INFO - 'LOGNAME': 'cltbld', 04:13:48 INFO - 'MAIL': '/var/mail/cltbld', 04:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:48 INFO - 'MOZ_NO_REMOTE': '1', 04:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:48 INFO - 'NO_EM_RESTART': '1', 04:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:48 INFO - 'PWD': '/builds/slave/test', 04:13:48 INFO - 'SHELL': '/bin/bash', 04:13:48 INFO - 'SHLVL': '1', 04:13:48 INFO - 'TERM': 'linux', 04:13:48 INFO - 'TMOUT': '86400', 04:13:48 INFO - 'USER': 'cltbld', 04:13:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:48 INFO - '_': '/tools/buildbot/bin/python'} 04:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13: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)) 04:13:48 INFO - Cleaning up... 04:13:48 INFO - Return code: 0 04:13:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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 04:13: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 04:13: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 04:13:48 INFO - Using env: {'DISPLAY': ':0', 04:13:48 INFO - 'HOME': '/home/cltbld', 04:13:48 INFO - 'LANG': 'en_US.UTF-8', 04:13:48 INFO - 'LANGUAGE': 'en_US:en', 04:13:48 INFO - 'LOGNAME': 'cltbld', 04:13:48 INFO - 'MAIL': '/var/mail/cltbld', 04:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:48 INFO - 'MOZ_NO_REMOTE': '1', 04:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:48 INFO - 'NO_EM_RESTART': '1', 04:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:48 INFO - 'PWD': '/builds/slave/test', 04:13:48 INFO - 'SHELL': '/bin/bash', 04:13:48 INFO - 'SHLVL': '1', 04:13:48 INFO - 'TERM': 'linux', 04:13:48 INFO - 'TMOUT': '86400', 04:13:48 INFO - 'USER': 'cltbld', 04:13:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:48 INFO - '_': '/tools/buildbot/bin/python'} 04:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:48 INFO - Cleaning up... 04:13:48 INFO - Return code: 0 04:13:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:13: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')]} 04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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')]} 04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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 04:13: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', 'flake8'] in /builds/slave/test/build 04:13: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 flake8 04:13:48 INFO - Using env: {'DISPLAY': ':0', 04:13:48 INFO - 'HOME': '/home/cltbld', 04:13:48 INFO - 'LANG': 'en_US.UTF-8', 04:13:48 INFO - 'LANGUAGE': 'en_US:en', 04:13:48 INFO - 'LOGNAME': 'cltbld', 04:13:48 INFO - 'MAIL': '/var/mail/cltbld', 04:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:48 INFO - 'MOZ_NO_REMOTE': '1', 04:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:48 INFO - 'NO_EM_RESTART': '1', 04:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:48 INFO - 'PWD': '/builds/slave/test', 04:13:48 INFO - 'SHELL': '/bin/bash', 04:13:48 INFO - 'SHLVL': '1', 04:13:48 INFO - 'TERM': 'linux', 04:13:48 INFO - 'TMOUT': '86400', 04:13:48 INFO - 'USER': 'cltbld', 04:13:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:48 INFO - '_': '/tools/buildbot/bin/python'} 04:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:48 INFO - Downloading/unpacking flake8 04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:13:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:13:50 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 04:13:50 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 04:13:50 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 04:13:50 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 04:13:50 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 04:13:50 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 04:13:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:13:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 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 04:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:51 INFO - no previously-included directories found matching 'docs/_build' 04:13:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:13:51 INFO - Running setup.py install for pep8 04:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:51 INFO - no previously-included directories found matching 'docs/_build' 04:13:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:13:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:13:51 INFO - Cleaning up... 04:13:51 INFO - Return code: 0 04:13:51 INFO - Running post-action listener: _resource_record_post_action 04:13:51 INFO - Running post-action listener: _start_resource_monitoring 04:13:51 INFO - Starting resource monitoring. 04:13:51 INFO - ##### 04:13:51 INFO - ##### Finished create-virtualenv step (success) 04:13:51 INFO - ##### 04:13:51 INFO - ##### 04:13:51 INFO - ##### Running install step. 04:13:51 INFO - ##### 04:13:51 INFO - Running pre-action listener: _resource_record_pre_action 04:13:51 INFO - Running main action method: install 04:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:52 INFO - Reading from file tmpfile_stdout 04:13:52 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:52 INFO - Reading from file tmpfile_stdout 04:13:52 INFO - Output received: 04:13:52 INFO - Usage: mozinstall [options] installer 04:13:52 INFO - Options: 04:13:52 INFO - -h, --help show this help message and exit 04:13:52 INFO - -d DEST, --destination=DEST 04:13:52 INFO - Directory to install application into. [default: 04:13:52 INFO - "/builds/slave/test"] 04:13:52 INFO - --app=APP Application being installed. [default: firefox] 04:13:52 INFO - mkdir: /builds/slave/test/build/application 04:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:14:05 INFO - Reading from file tmpfile_stdout 04:14:05 INFO - Output received: 04:14:05 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:05 INFO - Running post-action listener: _resource_record_post_action 04:14:05 INFO - ##### 04:14:05 INFO - ##### Finished install step (success) 04:14:05 INFO - ##### 04:14:05 INFO - ##### 04:14:05 INFO - ##### Running run-tests step. 04:14:05 INFO - ##### 04:14:05 INFO - Running pre-action listener: _resource_record_pre_action 04:14:05 INFO - Running main action method: run_tests 04:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:05 INFO - Python 2.7.3 04:14:05 INFO - Return code: 0 04:14:05 INFO - grabbing minidump binary from tooltool 04:14:05 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')]} 04:14:05 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 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:05 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 04:14:05 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 04:14:05 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 04:14:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:05 INFO - Return code: 0 04:14:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:06 INFO - Return code: 0 04:14:06 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/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 04:14:06 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/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 04:14:06 INFO - Using env: {'DISPLAY': ':0', 04:14:06 INFO - 'HOME': '/home/cltbld', 04:14:06 INFO - 'LANG': 'en_US.UTF-8', 04:14:06 INFO - 'LANGUAGE': 'en_US:en', 04:14:06 INFO - 'LOGNAME': 'cltbld', 04:14:06 INFO - 'MAIL': '/var/mail/cltbld', 04:14:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:06 INFO - 'MOZ_NO_REMOTE': '1', 04:14:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:06 INFO - 'NO_EM_RESTART': '1', 04:14:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:06 INFO - 'PWD': '/builds/slave/test', 04:14:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:06 INFO - 'SHELL': '/bin/bash', 04:14:06 INFO - 'SHLVL': '1', 04:14:06 INFO - 'TERM': 'linux', 04:14:06 INFO - 'TMOUT': '86400', 04:14:06 INFO - 'USER': 'cltbld', 04:14:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220', 04:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:06 INFO - '_': '/tools/buildbot/bin/python'} 04:14:06 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/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 04:14:06 INFO - mozversion application_buildid: 20160826110814 04:14:06 INFO - mozversion application_changeset: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f 04:14:06 INFO - mozversion application_display_name: Firefox 04:14:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:06 INFO - mozversion application_name: Firefox 04:14:06 INFO - mozversion application_remotingname: firefox 04:14:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:14:06 INFO - mozversion application_vendor: Mozilla 04:14:06 INFO - mozversion application_version: 49.0 04:14:06 INFO - mozversion platform_buildid: 20160826110814 04:14:06 INFO - mozversion platform_changeset: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f 04:14:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:14:06 INFO - mozversion platform_version: 49.0 04:14:06 INFO - using testdate: 1472382846 04:14:06 INFO - actual date: 1472382846 04:14:06 INFO - starting webserver on 'localhost:55038' 04:14:06 INFO - SUITE-START | Running 2 tests 04:14:06 INFO - TEST-START | dromaeo_css 04:14:06 INFO - operating with platform_type : linux_ 04:14:06 INFO - Initialising browser for dromaeo_css test... 04:14:06 INFO - TEST-INFO | started process 5222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptbmVMk/profile http://localhost:55038/getInfo.html) 04:14:11 INFO - PROCESS | 5222 | __metrics Screen width/height:1600/1200 04:14:11 INFO - PROCESS | 5222 | colorDepth:24 04:14:11 INFO - PROCESS | 5222 | Browser inner width/height: 1024/697 04:14:11 INFO - PROCESS | 5222 | __metrics 04:14:11 ERROR - PROCESS | 5222 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:14:12 INFO - TEST-INFO | 5222: exit 0 04:14:12 INFO - Browser initialized. 04:14:12 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:12 INFO - TEST-INFO | started process 5351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptbmVMk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:24 INFO - PROCESS | 5351 | RSS: Main: 152518656 04:14:24 INFO - PROCESS | 5351 | 04:15:13 INFO - PROCESS | 5351 | 1472382913887 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] 04:17:21 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55038/tests/dromaeo/cssquery-ext.html) 04:17:22 INFO - PROCESS | 5351 | RSS: Main: 157192192 04:17:22 INFO - PROCESS | 5351 | 04:20:24 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-ext.html (next: http://localhost:55038/tests/dromaeo/cssquery-jquery.html) 04:20:25 INFO - PROCESS | 5351 | RSS: Main: 155164672 04:20:25 INFO - PROCESS | 5351 | 04:23:27 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55038/tests/dromaeo/cssquery-mootools.html) 04:23:27 INFO - PROCESS | 5351 | RSS: Main: 154959872 04:23:27 INFO - PROCESS | 5351 | 04:26:29 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55038/tests/dromaeo/cssquery-prototype.html) 04:26:30 INFO - PROCESS | 5351 | RSS: Main: 156102656 04:26:30 INFO - PROCESS | 5351 | 04:29:32 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55038/tests/dromaeo/cssquery-yui.html) 04:29:33 INFO - PROCESS | 5351 | RSS: Main: 155000832 04:29:33 INFO - PROCESS | 5351 | 04:32:35 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-yui.html (next: http://localhost:55038/tests/dromaeo/cssquery-dojo.html) 04:32:35 INFO - PROCESS | 5351 | RSS: Main: 159145984 04:32:35 INFO - PROCESS | 5351 | 04:32:35 INFO - PROCESS | 5351 | __start_tp_report 04:32:35 INFO - PROCESS | 5351 | _x_x_mozilla_page_load 04:32:35 INFO - PROCESS | 5351 | _x_x_mozilla_page_load_details 04:32:35 INFO - PROCESS | 5351 | |i|pagename|runs| 04:32:35 INFO - PROCESS | 5351 | |0;dojo.html;3335.8832440864576;3379.7127244184244;3396.354692608404;3405.4040542904986;3421.5380923575326;5619.3818679945225;5651.2935883014625;5664.376918538957;5699;5702.885942281152;5568.638038527503;5705.629134106281;5712.314522257325;5716.799912003081;5724.742386592603;5010.073136469756;5091.592672586203;5094.363204599425;5113.718745468997;5115.360579927509;5018.824341148061;5087.5421212090905;5093.465186155456;5138.922916156261;5167.199084141964;5104.106781313274;5125.871853203663;5137.717425541594;5139.306193663845;5142.04872098663;5170.45710200431;5170.586353091744;5179.326687530634;5192.428832828386;5195.168772996302;4921.286413470027;4951.950480495185;4983.25251212321;5089.44016158226;5094.7197904115255;5514.972425137848;5533.142362933751;5554.527865131468;5573.6098473106895;5582.078956972095;5982.581219314649;6009.128676341906;6011.57918945674;6015.398460153993;6030.306514750772;5818.970905145489;5842.532597392198;5921.171036054912;5949.791757288474;6062.96968515159;5545.861353466155;5549.084401073818;5554.750036248338;5559.444055594448;5559.833205003856;6018.608790428608;6030.065339872327;6055.909161362583;6073.058675905242;6092.299385570716;5673.801416950387;5804.854878628068;5805.10020946754;5833.88332233353;5880.676562789087;5966.642001479925;5985.970070149621;6005.969970150209;6007.669578173155;6013.669248191304;5838.970805146032;5997.100434934708;5998.580099393088;6010.188624535719;6020.307664618537;5938.495227905676;5973.701314934323;5976.073708575178;5984;5989.850253743604;4653.744044077608;4657.5575320344515;4660.603848672833;4663.906721865612;4694.36626055485;4074.348104303297;4105.69207309447;4175.728577642443;4181.435506206684;4219.767912764827;5599.300087489064;5690.174924635905;5708.0581704019205;5760.3951585083805;5823.737931793079;6053.878922421527;6062.636241825505;6067;6085.604435711664;6104.969475152596;5557.249771280906;5662.292213473316;5774.855628609234;5799.130130480462;5839.124131380327;5192.273081768555;5201.245819356248;5221;5225.529702326809;5282.920756188661;6240.7503699852405;6243.469305109116;6276.309605943343;6277.2153480814895;6277.937220627735;5770.105633626795;5955.255593050869;6010.068439391901;6047.818565443044;6069.2110025696375;6239.78160764371;6276.058591211355;6294.0558916162945;6301.8109456716375;6306.936930630635;5913.34953155144;5927.881442371215;5937.703114844154;5942.346341902301;5954.345022047484;5897.292324920865;5998.640081595118;6008.429199226067;6041.063635136561;6051;5957.046872500379;5974.372690867396;5978.432048955342;5979.192808970907;5986.790462333797;5898.734556945034;5937.228160339301;5939.07944268639;5947.821565353046;5973.850653733692;5665.206871037975;5741.110127930177;5755.165501002248;5795.130730390307;5839.737211825393;5933.614315069507;5968.671723055274;5976.372480889618;5977.551683623658;5984.640921544721;5826.271716035496;5860.355360910211;5887.970560147171;5897.174395584708;5898.587098903035 04:32:35 INFO - PROCESS | 5351 | |1;ext.html;582.1820342418903;638.0110828216264;650.3691419323255;657.9342065793418;665.8468552232986;45432.77283613582;47101.29348059782;47102.293465598;47167.52832471678;50630;48325.516744832545;49109.50890491094;49197.75401122998;49229.52311430654;49282.75358623211;9031.819363612723;9106.817863642756;9179.082091790835;9184.311176661744;9197.126273004054;9074.455532668027;9108;9108.544572771369;9110.817783644356;9123.224525915271;9141.131592498736;9169.724908252763;9222.631094756236;9223.631054757801;9224.262059035262;9137.177654011137;9145.268378529701;9155.954220228923;9162.587683554222;9165.220956218729;8857.291416686714;8878.067802880734;8934.195922367018;8942.105789421072;8946.373753837233;44719.55280447187;45127.32309015367;45156.77421612904;45224.54775452236;45230.32154517685;3769.736118471708;3809.942850857239;3827;3848.5289137666705;3871.361225397806;33788.6621133788;33831;34174.31651366959;34341.656583434095;34605.30789384223;4024.55729869717;4109.97945010276;4111.5477297497255;4117.279476091672;4168.312228482297;360301;361135;361228.9999999974;362145;362727;38056.61943380531;63106;63211.683941580915;63266;63566.682166589795;39593.20813583712;41135.7943210282;41259.1748165041;41335;41406;16851.241694123793;17232.741508877378;17279.827201728072;17360.305587776347;17372.47882563525;14250.857491424953;14379.568612941628;14398.85601143996;14464.493742719165;14466.27668616586;9354.391964522285;9360.297977651704;9384.765380865396;9446.527673616292;9450.149486546106;3556.608773034964;3625.782453052825;3636.127329440915;3667.6332366763645;3692.5753538342897;1088.586337191862;1129.5770572122915;1134.4838098665089;1187.2342339191346;1225.4607972492254;33173.668263317544;33229;33389;33630.99107026793;34043.14892127667;1150.0626989003936;1155.930644161353;1168.1764356129079;1276.3809552367095;1330.388021510097;17326.826731732774;17363.739543906853;17388.217530211172;17409.47771566855;17568.824311756973;566462;597121;810479;841618;842277;59938.10092848611;60591.69704151539;60605.39394605997;60654;60771.6961415199;1501.8347981722002;1504.3832028868112;1511.7127745728276;1521.5815650695927;1522.7868098466224;32003.679963201;32385.51421728723;32864;34525.65474345325;37117.62882371142;62115.689421552604;62690.37309626846;62976.685116574125;63102.68448657727;63167.684161578894;515700;533817;535812;537922.2415551746;538891;47932.5206747928;49244.26133607927;49644;49913.251301231234;50139.74930125472;53753;54212.728936355066;54223.18665219946;54379.18431223614;55295.72352138213;44852.10295794131;45568;45612.24591819465;45716.31425528686;46126.30810537912;43902.56097439113;44180.337294939956;44682.3297650529;45325.18699252125;45707;44274.604184899814;45085;45598.54401456076;45630.771846141884;45789.77105114453;37674;38280.80859595684;38615;39532.80233598813;39617.60382396139;29961.250968725955;30312.973749302302;30342.84828575843;30532.389352212387;30701.846490767402 04:32:35 INFO - PROCESS | 5351 | |2;jquery.html;425.8999135203227;428.2291874625673;428.5200575355602;433.96094351508356;443.66281625964257;18347.082645867704;19341.129649165767;20080.196792128314;20471.488212794688;20471.488212794688;18587.628247435045;18769.155388007537;19027.429177124675;19439.611207775837;19498.805011949877;5839.153322768207;5985.760569577234;6015.578909476339;6018.578699491016;6021.849453763647;4882.41411030675;5879.353271140171;5948.315943666469;6316.178896743417;6340.936590634081;5362;6338.714757835908;6370.522210834206;6402.519811014193;6414.679266036703;5624.831255062334;5754.367019627858;5760.193572899798;5761.539076873861;5767.740451679684;5492.725363731837;5701.315842098975;5704.429557044304;5704.515116215127;5716.428357164292;13028.609141725763;13320.467181312735;13433;13528.25594592297;13633.590992270249;2153.720016397874;2232.609293373653;2258.4930726893135;2391.497785465037;2485.254423672909;10099.091081802673;10315.658964334589;10368.740781480448;10374.429406382646;10476.371417714885;1962.0876292523901;1965.7247985281929;1985.3150663021236;2003.8597298188986;2025.473376921996;73073;75581;76102;82984;85572.57213713953;10857.565697372174;11322.37726925027;11327.660170194908;11453.427328633701;11469.139814513945;15829.287682054335;15949.920250398905;15996.200189990454;16075;16165.4342098026;8305.211004954519;8357.791055223546;8729.432586881832;8760.386772925962;8801.427907186013;8382.036065852382;8463;8597.269232115215;8879.156480134377;8965.148310910454;4464.374987501752;4537.818487260539;4545.749983750926;4554.43069616298;4566.862994110115;1909.627622613577;1921.8654694171273;1926.5857840564347;1938.6413513500047;1958.177565422526;436.6245029274821;448.9842855500042;983.4984158079288;1050.721558786922;1087.065123993365;11536.192466527431;11841.763164736829;11926.105542084379;11988.460519276654;12103.213291136048;459.34084588615445;464.7374233558029;470.901110766736;471.9174144524695;476.49253544974493;6200.193974783339;6321.589096708699;6397.648129352837;10504.42225677595;10992.230543862013;524800;527652;527757;534980;541334;61098.69450652718;86875.56562217275;88061;90261.54869225743;98832.50583747035;1099.2195541165702;1124.4321617583068;1134.6539305511733;1136.5283407386007;1146.0487795130023;17322.39371621987;17720;17886.28454861843;17900.10499474995;18258.543536411697;42206.78896605497;42283;42413.57586424219;42564.36153457639;45188;54699.17951230655;55507;56294.43705562892;62267.443313917516;63526.36473635204;8571.4000019998;8889.866652000355;9055.049219831822;9117.452952822852;9125.087491250822;12341.50633974631;13091.476340946256;13268.071235013456;13562.389692463665;13576.93211533936;11583;11691.707707307385;12001.339926304137;12108.878911210775;12109.152359334763;9886.357386769838;11713.648590542298;11732.354720490455;11824.940875295568;11888.28670279786;12007.879921201025;12134.641238858807;12142.271463712206;12210;12247.755044898873;8604.82790344177;8632.870506942276;8647.697330593399;8797.296216302553;9008.099190080939;9145.725628231165;10596.735081622714;11694.239874408137;11801.881981180079;12030.218035827644 04:32:35 INFO - PROCESS | 5351 | |3;mootools.html;1569.6814675672433;1603.3426295218958;1834.1562881074706;1884.9528761780962;1941.3981665683648;8380;9300.209482194014;9419.811603767937;10018.54916528757;10038.498075096244;9492.857607135882;9776.657816976407;9781.7554561136;9841.114299713025;9884.555195016224;2457.8771061446946;2490.7260201377835;2491.6137998610243;2491.9409251068314;2496.4383013821835;2384.666146739458;2469.4814089041233;2470.086068154776;2476.6408870713826;2476.7647073527987;2460.1143588308196;2465.6301554766837;2480.1443501991785;2492.152668092848;2494.8627825469594;2180.4439867833757;2219.6115679755976;2220.555888822234;2243.8204943604474;2264.9433764155865;2352.788249057593;2372.5847976604027;2390.7848293653483;2398.124684490166;2400.699912510936;9675.806483870283;9722.854157187649;9755.36590121647;9767.218622510181;9783.217342612574;5638.35158956717;5813.6802475863815;5817.476427121579;5821.796237131723;5822.82531524055;3611.747177697562;3647.81760911956;3649.6897763689853;3651.634836516327;3723.2367364690444;1154.1805318224071;1210.9273443593413;1217.7077501399601;1235.4008305971597;1238.2137342787305;13838.515651952133;13863.475017747938;13928.233947132903;13938.651533711636;13971.930140349335;5032.748362581856;5060.240963855377;5070.619703522177;5111.3355263815465;5254.868628284247;11395.829062564067;11418.143639227092;11458.083353331713;11469.942650286695;11474.48364823585;5774.855628609234;5776.595638305278;5789.160571717078;5796.8550786229835;5805.680687562224;4359.956400435955;5075.137226671474;5211.088059589557;5247.134222853263;5382.381026182039;4364.41080454141;4376.978115109404;4401.6698747594055;4427.712198707074;4510;1390.075599726191;1392.470861072786;1406.310907655262;1415.985840141606;1418.3121186224673;891.4364777387901;901.396064636695;957.090763774417;970.1365784451843;991.3902949685892;5887.175795388649;6222.719977601018;6419.101325814389;6546.509011824132;6582.341765823379;985.4530735441755;1002.4987506246877;1023.9129673977646;1039.0804138337473;1057.6383055918654;4006.138680183716;4049.088954985105;4097.733647312915;4100.2619528484565;4104.486939132608;12029.819552706716;12304.81542776859;12401;12405.193662412095;12420.130590858553;11899.88100119005;12192.573259936036;12214.694632634255;12263.448144833505;12425.37873106341;8544.102869198645;8557.657693692183;8697.826043479095;8699.608517616722;8744.213020828156;5795.39148389413;5817.447342502455;5841.795537156179;5852.502537284378;6003.699815009145;10492.160627149657;10505.89688082771;10513.579456821948;10641.89358106409;10765.946170269099;11328.716782080513;11474.713132171762;11528.769424611628;11546.59586914454;11634.418279085843;8392.328613710766;8507.064222935349;8628.611712473079;8695.304375649806;8843.646254149762;9430.905690943002;9529.237660987243;9608.95195524018;9633.470159141314;9727.951360243154;8373.748787536384;8412.87380689278;8509.149085091442;8534.530600817016;8615.22462978335;8107.959460202661;8339.666413343399;8385.790355241168;8417;8501.532415717194;7420.888686669597;7434.702611895464;7497.400207983457;7497.737579184703;7510.737124200627;5119.385673719177;5200.115980283285;5286.550643195218;5304.23088652151;5338.813141540028;5138.922916156335;5172.224166375074;5235.1623740201385;5239.895202096013;5266.78932842682 04:32:35 INFO - PROCESS | 5351 | |4;prototype.html;345.78906866811246;348.35901940429613;348.808155514467;353.2299586900556;355.9003479025872;5726.284214473191;5804.82585522434;5807.186993820868;5807.332156801964;5836.9124463132985;5656.688882111483;5673;5687.146927960808;5697.77208911643;5739.397363276858;4032.193561287747;4368.541303163154;4407.360932664762;4410.867673969786;4411.6250118739945;4405.581469760367;4426.601605855472;4462.219111655448;4465.106978604276;4466.97766511167;4418.293073108303;4440.955590444087;4461.531539188387;4462.1968045751755;4474.619657329131;4292.892677683068;4400.8215933113315;4408.779561021936;4418.491873434532;4450.821967121327;3871.9225615487812;3874.4575759393706;3891.0466935600675;3904.06302487401;3908.7654740715648;5523.453433038715;5526.618345413646;5543.528800052;5545.916811247835;5559.471850174227;4910.558049775537;5045.167547354718;5075.629580013413;5093.770780314895;5115.360579927509;6010.939890601082;6011.57918945674;6016.2479690038745;6022.879542409171;6091.177691011701;4276.66921527765;4293.763842988635;4296;4306.20335237982;4310.547392523803;6104.175936248594;6260;6279.686015699197;6294.9685251574365;6306.527010474187;4285.892852678646;4307.7415355078165;4310.374995625617;4313.317806055641;4322.891927701832;4308.612224899712;4323.891902702395;4363.498197707304;4372.213001659668;4376.65848770906;4893.266010098514;5010.223415370623;5016.648834581544;5022.096022715873;5034.899302014012;5997.460228579362;6000;6008.969955150284;6052.789442111595;6109.5112391008615;1456.1190479759805;1478.7560052591416;1519.080956021613;1525.7482515385059;1527.2974431761513;963.8554216867526;970.8009857979098;1013.690824298596;1040.1314902056715;1042.9426381548935;5804.65172089676;5882.823515294548;5896.941030589725;5900.203472531153;5949.137375080676;6168.753249869955;6215.844603884939;6224.190855188796;6234;6266.905996410058;5722.341930677942;5791.652500849878;5802.535797136219;5828.6211396259105;5856.677882716406;3309.9573634305116;3344.6488118747666;3352.1619595101224;3356.0938546592283;3358.177246574605;6180.165677633552;6436.195475565554;6470.547061705635;6568.967155164193;6570.310117437601;6378.234611846516;6453.4189123665;6456.322086180978;6458.418742313214;6473.805785826433;6335.651539165298;6536.705848236936;6581.539292249592;6587.835304117435;6592.5055620828625;6270.655113968775;6277.717502712298;6295.716692748746;6297.4647154992335;6341.904871427025;6158.7228574715145;6169.259688837368;6214.13575927211;6243.532769799002;6261.3112557617715;6217.041631885942;6507.446867016357;6523.575967562093;6529.563496030865;6579.80260592183;4432.091421258569;4444.599986001275;4452.443444569429;4481.910361792811;4499.842505512292;6213.788311279257;6274.592151510137;6306;6310.5267104968225;6326.905096423466;6150.7539698411565;6180.721867515883;6190.566660333733;6194.969025154845;6206.410391012847;5901.734421950937;6108.389161083856;6131.4860907027905;6136.662483563447;6180.505559555135;5907.852303692442;6013.301819381137;6043.576949613661;6055.6063855849225;6056.36408177135;6199.969000154971;6206.875862482815;6211.223597050369;6216.849882771702;6220.409061139185;5977.22296101504;6020.909686354796;6049.939500604937;6052.425019623305;6053.910296146736 04:32:35 INFO - PROCESS | 5351 | |5;yui.html;723.6851969393314;723.8805597076486;733.8238822682555;757.3373298363931;775.1202385292692;14235.786463203047;14792.556223313319;14825.629359266024;14858.182799945998;14889.329980150906;14880;14912.701745965102;15029.248537573105;15049.322780474877;16225.107619080945;872.8647059705739;881.3610132653806;881.6120906801019;882.0341725810227;885.4642941020654;869.1135042256926;877.5656050255133;878.8198419324024;879.3053487744706;879.7448739865431;914.8444764390069;915.0209276074603;918.9908100918972;919.9586018629178;920.1350730313484;907.9228265597433;909.2498688581913;909.3725329522608;909.9727008189765;911.3347256502724;668.234871072624;668.2849351194224;669.9916625478623;670.0318040431579;670.9396154346083;15343.4629787958;15400.614984625361;15410;15435.922820385938;15442.150681712501;13218.801717974238;13581.864181358258;13815.102018368774;13878.583642490741;13885.305734713224;12323.322217278046;12350.814737778941;12414.193077450027;12831.422585983653;12871.549495767696;3661.707063434919;3799.6580307772433;3893.299206142893;4839.346688197119;4902.142125128088;71898.64050679766;75450;84470;84585.15414845834;86393.56803216007;12333.69165770845;12543.435545400478;12701.872981270253;12813.871861281454;12872.16330938486;22789.31632051041;22969.655455168187;23001;23244.3026709199;23713.644295335584;8504.829903401896;8612.138786121337;8617.224449799549;8622.396432249809;8646.524441155796;4638.0955713636195;4668.50980647034;4724.622030237572;4944.9258261126115;5043.420006699203;3658.63413658632;3740.7194460415035;3740.8877733668032;3762.435634654824;3766.642168993941;655.9770408035696;659.4493597845757;662.059874977533;673.9022841687928;678.1082876018021;550.7246376811594;581.2182614383647;596.749365266589;654.6072356586105;701.529974916807;9070.954645226864;9229.307801914749;9299.628014879465;9489.193418559362;9535.2371810255;597.4205021129497;714.3856283596103;770.2374649097466;814.816666250089;820.5609998650693;4574.5882870541145;4845.055214233261;4851.805927762921;4851.95148048515;4856.781444834991;115621.42189289;117727.41136294264;117914.41042794731;119302.40348798201;120190;72260;73679.63160184165;97772;99770;104070.4796476028;88426;90927;91165.5441722787;92575;92585.53707231421;8960.845992913628;9117.77205569866;9313.487758173094;9331.86002209981;9369.859452108087;52736.47263527469;54042.459575403744;54542;54597.454025459236;55668.721656391455;70910.29089709037;76672.61663691868;77591;77896.01400270588;78379.60810195912;12318;12333.93833030829;12437.689057773629;12566.434510446868;12943.417546210632;13648.014413481513;13896.51362202318;14010.929945350208;14044.78932815988;14421.134731916118;13021.9582433407;13060.151090179108;13240.073194876266;13248.735025299633;13393.531226407029;12205.816912746493;12216.877831221575;12363.62909112728;12428;12458.688532786753;12341.197822141532;12425;13416.932915335361;13657.317134143452;13966;11736.354500502553;12015.12631068884;12138.75722485563;12339.383030848601;12412.875871241173;11924.403779811148;11956.521739130685;12020.879791201976;12025.939870300943;12115.333656648969 04:32:35 INFO - PROCESS | 5351 | __end_tp_report 04:32:35 INFO - PROCESS | 5351 | __start_cc_report 04:32:35 INFO - PROCESS | 5351 | _x_x_mozilla_cycle_collect,329 04:32:35 INFO - PROCESS | 5351 | __end_cc_report 04:32:35 INFO - PROCESS | 5351 | __startTimestamp1472383955458__endTimestamp 04:32:35 INFO - PROCESS | 5351 | 04:32:35 INFO - PROCESS | 5351 | ------- Summary: start ------- 04:32:35 INFO - PROCESS | 5351 | Number of tests: 6 04:32:35 INFO - PROCESS | 5351 | 04:32:35 INFO - PROCESS | 5351 | [#0] dojo.html Cycles:165 Average:5594.04 Median:5823.74 stddev:614.11 (10.5%) stddev-sans-first:589.89 04:32:35 INFO - PROCESS | 5351 | Values: 3335.9 3379.7 3396.4 3405.4 3421.5 5619.4 5651.3 5664.4 5699.0 5702.9 5568.6 5705.6 5712.3 5716.8 5724.7 5010.1 5091.6 5094.4 5113.7 5115.4 5018.8 5087.5 5093.5 5138.9 5167.2 5104.1 5125.9 5137.7 5139.3 5142.0 5170.5 5170.6 5179.3 5192.4 5195.2 4921.3 4952.0 4983.3 5089.4 5094.7 5515.0 5533.1 5554.5 5573.6 5582.1 5982.6 6009.1 6011.6 6015.4 6030.3 5819.0 5842.5 5921.2 5949.8 6063.0 5545.9 5549.1 5554.8 5559.4 5559.8 6018.6 6030.1 6055.9 6073.1 6092.3 5673.8 5804.9 5805.1 5833.9 5880.7 5966.6 5986.0 6006.0 6007.7 6013.7 5839.0 5997.1 5998.6 6010.2 6020.3 5938.5 5973.7 5976.1 5984.0 5989.9 4653.7 4657.6 4660.6 4663.9 4694.4 4074.3 4105.7 4175.7 4181.4 4219.8 5599.3 5690.2 5708.1 5760.4 5823.7 6053.9 6062.6 6067.0 6085.6 6105.0 5557.2 5662.3 5774.9 5799.1 5839.1 5192.3 5201.2 5221.0 5225.5 5282.9 6240.8 6243.5 6276.3 6277.2 6277.9 5770.1 5955.3 6010.1 6047.8 6069.2 6239.8 6276.1 6294.1 6301.8 6306.9 5913.3 5927.9 5937.7 5942.3 5954.3 5897.3 5998.6 6008.4 6041.1 6051.0 5957.0 5974.4 5978.4 5979.2 5986.8 5898.7 5937.2 5939.1 5947.8 5973.9 5665.2 5741.1 5755.2 5795.1 5839.7 5933.6 5968.7 5976.4 5977.6 5984.6 5826.3 5860.4 5888.0 5897.2 5898.6 04:32:35 INFO - PROCESS | 5351 | 04:32:35 INFO - PROCESS | 5351 | [#1] ext.html Cycles:180 Average:69987.59 Median:45227.43 stddev:151945.67 (336.0%) stddev-sans-first:152282.56 04:32:35 INFO - PROCESS | 5351 | Values: 582.2 638.0 650.4 657.9 665.8 45432.8 47101.3 47102.3 47167.5 50630.0 48325.5 49109.5 49197.8 49229.5 49282.8 9031.8 9106.8 9179.1 9184.3 9197.1 9074.5 9108.0 9108.5 9110.8 9123.2 9141.1 9169.7 9222.6 9223.6 9224.3 9137.2 9145.3 9156.0 9162.6 9165.2 8857.3 8878.1 8934.2 8942.1 8946.4 44719.6 45127.3 45156.8 45224.5 45230.3 3769.7 3809.9 3827.0 3848.5 3871.4 33788.7 33831.0 34174.3 34341.7 34605.3 4024.6 4110.0 4111.5 4117.3 4168.3 360301.0 361135.0 361229.0 362145.0 362727.0 38056.6 63106.0 63211.7 63266.0 63566.7 39593.2 41135.8 41259.2 41335.0 41406.0 16851.2 17232.7 17279.8 17360.3 17372.5 14250.9 14379.6 14398.9 14464.5 14466.3 9354.4 9360.3 9384.8 9446.5 9450.1 3556.6 3625.8 3636.1 3667.6 3692.6 1088.6 1129.6 1134.5 1187.2 1225.5 33173.7 33229.0 33389.0 33631.0 34043.1 1150.1 1155.9 1168.2 1276.4 1330.4 17326.8 17363.7 17388.2 17409.5 17568.8 566462.0 597121.0 810479.0 841618.0 842277.0 59938.1 60591.7 60605.4 60654.0 60771.7 1501.8 1504.4 1511.7 1521.6 1522.8 32003.7 32385.5 32864.0 34525.7 37117.6 62115.7 62690.4 62976.7 63102.7 63167.7 515700.0 533817.0 535812.0 537922.2 538891.0 47932.5 49244.3 49644.0 49913.3 50139.7 53753.0 54212.7 54223.2 54379.2 55295.7 44852.1 45568.0 45612.2 45716.3 46126.3 43902.6 44180.3 44682.3 45325.2 45707.0 44274.6 45085.0 45598.5 45630.8 45789.8 37674.0 38280.8 38615.0 39532.8 39617.6 29961.3 30313.0 30342.8 30532.4 30701.8 04:32:35 INFO - PROCESS | 5351 | 04:32:35 INFO - PROCESS | 5351 | [#2] jquery.html Cycles:180 Average:29488.99 Median:21495.13 stddev:87337.36 (406.3%) stddev-sans-first:87555.10 04:32:35 INFO - PROCESS | 5351 | Values: 425.9 428.2 428.5 434.0 443.7 18347.1 19341.1 20080.2 20471.5 20471.5 18587.6 18769.2 19027.4 19439.6 19498.8 5839.2 5985.8 6015.6 6018.6 6021.8 4882.4 5879.4 5948.3 6316.2 6340.9 5362.0 6338.7 6370.5 6402.5 6414.7 5624.8 5754.4 5760.2 5761.5 5767.7 5492.7 5701.3 5704.4 5704.5 5716.4 13028.6 13320.5 13433.0 13528.3 13633.6 2153.7 2232.6 2258.5 2391.5 2485.3 10099.1 10315.7 10368.7 10374.4 10476.4 1962.1 1965.7 1985.3 2003.9 2025.5 73073.0 75581.0 76102.0 82984.0 85572.6 10857.6 11322.4 11327.7 11453.4 11469.1 15829.3 15949.9 15996.2 16075.0 16165.4 8305.2 8357.8 8729.4 8760.4 8801.4 8382.0 8463.0 8597.3 8879.2 8965.1 4464.4 4537.8 4545.7 4554.4 4566.9 1909.6 1921.9 1926.6 1938.6 1958.2 436.6 449.0 983.5 1050.7 1087.1 11536.2 11841.8 11926.1 11988.5 12103.2 459.3 464.7 470.9 471.9 476.5 6200.2 6321.6 6397.6 10504.4 10992.2 524800.0 527652.0 527757.0 534980.0 541334.0 61098.7 86875.6 88061.0 90261.5 98832.5 1099.2 1124.4 1134.7 1136.5 1146.0 17322.4 17720.0 17886.3 17900.1 18258.5 42206.8 42283.0 42413.6 42564.4 45188.0 54699.2 55507.0 56294.4 62267.4 63526.4 8571.4 8889.9 9055.0 9117.5 9125.1 12341.5 13091.5 13268.1 13562.4 13576.9 11583.0 11691.7 12001.3 12108.9 12109.2 9886.4 11713.6 11732.4 11824.9 11888.3 12007.9 12134.6 12142.3 12210.0 12247.8 8604.8 8632.9 8647.7 8797.3 9008.1 9145.7 10596.7 11694.2 11801.9 12030.2 04:32:35 INFO - PROCESS | 5351 | 04:32:35 INFO - PROCESS | 5351 | [#3] mootools.html Cycles:180 Average:6303.99 Median:4468.86 stddev:3705.08 (82.9%) stddev-sans-first:3698.39 04:32:35 INFO - PROCESS | 5351 | Values: 1569.7 1603.3 1834.2 1885.0 1941.4 8380.0 9300.2 9419.8 10018.5 10038.5 9492.9 9776.7 9781.8 9841.1 9884.6 2457.9 2490.7 2491.6 2491.9 2496.4 2384.7 2469.5 2470.1 2476.6 2476.8 2460.1 2465.6 2480.1 2492.2 2494.9 2180.4 2219.6 2220.6 2243.8 2264.9 2352.8 2372.6 2390.8 2398.1 2400.7 9675.8 9722.9 9755.4 9767.2 9783.2 5638.4 5813.7 5817.5 5821.8 5822.8 3611.7 3647.8 3649.7 3651.6 3723.2 1154.2 1210.9 1217.7 1235.4 1238.2 13838.5 13863.5 13928.2 13938.7 13971.9 5032.7 5060.2 5070.6 5111.3 5254.9 11395.8 11418.1 11458.1 11469.9 11474.5 5774.9 5776.6 5789.2 5796.9 5805.7 4360.0 5075.1 5211.1 5247.1 5382.4 4364.4 4377.0 4401.7 4427.7 4510.0 1390.1 1392.5 1406.3 1416.0 1418.3 891.4 901.4 957.1 970.1 991.4 5887.2 6222.7 6419.1 6546.5 6582.3 985.5 1002.5 1023.9 1039.1 1057.6 4006.1 4049.1 4097.7 4100.3 4104.5 12029.8 12304.8 12401.0 12405.2 12420.1 11899.9 12192.6 12214.7 12263.4 12425.4 8544.1 8557.7 8697.8 8699.6 8744.2 5795.4 5817.4 5841.8 5852.5 6003.7 10492.2 10505.9 10513.6 10641.9 10765.9 11328.7 11474.7 11528.8 11546.6 11634.4 8392.3 8507.1 8628.6 8695.3 8843.6 9430.9 9529.2 9609.0 9633.5 9728.0 8373.7 8412.9 8509.1 8534.5 8615.2 8108.0 8339.7 8385.8 8417.0 8501.5 7420.9 7434.7 7497.4 7497.7 7510.7 5119.4 5200.1 5286.6 5304.2 5338.8 5138.9 5172.2 5235.2 5239.9 5266.8 04:32:35 INFO - PROCESS | 5351 | 04:32:35 INFO - PROCESS | 5351 | [#4] prototype.html Cycles:180 Average:5100.90 Median:5817.98 stddev:1534.45 (26.4%) stddev-sans-first:1496.67 04:32:35 INFO - PROCESS | 5351 | Values: 345.8 348.4 348.8 353.2 355.9 5726.3 5804.8 5807.2 5807.3 5836.9 5656.7 5673.0 5687.1 5697.8 5739.4 4032.2 4368.5 4407.4 4410.9 4411.6 4405.6 4426.6 4462.2 4465.1 4467.0 4418.3 4441.0 4461.5 4462.2 4474.6 4292.9 4400.8 4408.8 4418.5 4450.8 3871.9 3874.5 3891.0 3904.1 3908.8 5523.5 5526.6 5543.5 5545.9 5559.5 4910.6 5045.2 5075.6 5093.8 5115.4 6010.9 6011.6 6016.2 6022.9 6091.2 4276.7 4293.8 4296.0 4306.2 4310.5 6104.2 6260.0 6279.7 6295.0 6306.5 4285.9 4307.7 4310.4 4313.3 4322.9 4308.6 4323.9 4363.5 4372.2 4376.7 4893.3 5010.2 5016.6 5022.1 5034.9 5997.5 6000.0 6009.0 6052.8 6109.5 1456.1 1478.8 1519.1 1525.7 1527.3 963.9 970.8 1013.7 1040.1 1042.9 5804.7 5882.8 5896.9 5900.2 5949.1 6168.8 6215.8 6224.2 6234.0 6266.9 5722.3 5791.7 5802.5 5828.6 5856.7 3310.0 3344.6 3352.2 3356.1 3358.2 6180.2 6436.2 6470.5 6569.0 6570.3 6378.2 6453.4 6456.3 6458.4 6473.8 6335.7 6536.7 6581.5 6587.8 6592.5 6270.7 6277.7 6295.7 6297.5 6341.9 6158.7 6169.3 6214.1 6243.5 6261.3 6217.0 6507.4 6523.6 6529.6 6579.8 4432.1 4444.6 4452.4 4481.9 4499.8 6213.8 6274.6 6306.0 6310.5 6326.9 6150.8 6180.7 6190.6 6195.0 6206.4 5901.7 6108.4 6131.5 6136.7 6180.5 5907.9 6013.3 6043.6 6055.6 6056.4 6200.0 6206.9 6211.2 6216.8 6220.4 5977.2 6020.9 6049.9 6052.4 6053.9 04:32:35 INFO - PROCESS | 5351 | 04:32:35 INFO - PROCESS | 5351 | [#5] yui.html Cycles:180 Average:21067.00 Median:4851.88 stddev:30358.37 (625.7%) stddev-sans-first:30405.10 04:32:35 INFO - PROCESS | 5351 | Values: 723.7 723.9 733.8 757.3 775.1 14235.8 14792.6 14825.6 14858.2 14889.3 14880.0 14912.7 15029.2 15049.3 16225.1 872.9 881.4 881.6 882.0 885.5 869.1 877.6 878.8 879.3 879.7 914.8 915.0 919.0 920.0 920.1 907.9 909.2 909.4 910.0 911.3 668.2 668.3 670.0 670.0 670.9 15343.5 15400.6 15410.0 15435.9 15442.2 13218.8 13581.9 13815.1 13878.6 13885.3 12323.3 12350.8 12414.2 12831.4 12871.5 3661.7 3799.7 3893.3 4839.3 4902.1 71898.6 75450.0 84470.0 84585.2 86393.6 12333.7 12543.4 12701.9 12813.9 12872.2 22789.3 22969.7 23001.0 23244.3 23713.6 8504.8 8612.1 8617.2 8622.4 8646.5 4638.1 4668.5 4724.6 4944.9 5043.4 3658.6 3740.7 3740.9 3762.4 3766.6 656.0 659.4 662.1 673.9 678.1 550.7 581.2 596.7 654.6 701.5 9071.0 9229.3 9299.6 9489.2 9535.2 597.4 714.4 770.2 814.8 820.6 4574.6 4845.1 4851.8 4852.0 4856.8 115621.4 117727.4 117914.4 119302.4 120190.0 72260.0 73679.6 97772.0 99770.0 104070.5 88426.0 90927.0 91165.5 92575.0 92585.5 8960.8 9117.8 9313.5 9331.9 9369.9 52736.5 54042.5 54542.0 54597.5 55668.7 70910.3 76672.6 77591.0 77896.0 78379.6 12318.0 12333.9 12437.7 12566.4 12943.4 13648.0 13896.5 14010.9 14044.8 14421.1 13022.0 13060.2 13240.1 13248.7 13393.5 12205.8 12216.9 12363.6 12428.0 12458.7 12341.2 12425.0 13416.9 13657.3 13966.0 11736.4 12015.1 12138.8 12339.4 12412.9 11924.4 11956.5 12020.9 12025.9 12115.3 04:32:35 INFO - PROCESS | 5351 | -------- Summary: end -------- 04:32:35 INFO - PROCESS | 5351 | 04:32:36 INFO - TEST-INFO | 5351: exit 0 04:32:36 INFO - TEST-OK | dromaeo_css | took 1109727ms 04:32:36 INFO - TEST-START | kraken 04:32:36 INFO - operating with platform_type : linux_ 04:32:36 INFO - Initialising browser for kraken test... 04:32:36 INFO - TEST-INFO | started process 5593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7qsRke/profile http://localhost:55038/getInfo.html) 04:32:40 INFO - PROCESS | 5593 | __metrics Screen width/height:1600/1200 04:32:40 INFO - PROCESS | 5593 | colorDepth:24 04:32:40 INFO - PROCESS | 5593 | Browser inner width/height: 1024/697 04:32:40 INFO - PROCESS | 5593 | __metrics 04:32:41 ERROR - PROCESS | 5593 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:32:42 INFO - TEST-INFO | 5593: exit 0 04:32:42 INFO - Browser initialized. 04:32:42 INFO - Running cycle 1/1 for kraken test... 04:32:42 INFO - TEST-INFO | started process 5718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7qsRke/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:53 INFO - PROCESS | 5718 | RSS: Main: 153071616 04:32:53 INFO - PROCESS | 5718 | 04:32:56 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55038/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:57 INFO - PROCESS | 5718 | RSS: Main: 158023680 04:32:57 INFO - PROCESS | 5718 | 04:32:59 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55038/tests/kraken/driver.html?testName=audio-dft) 04:33:00 INFO - PROCESS | 5718 | RSS: Main: 156991488 04:33:00 INFO - PROCESS | 5718 | 04:33:03 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55038/tests/kraken/driver.html?testName=audio-fft) 04:33:04 INFO - PROCESS | 5718 | RSS: Main: 157761536 04:33:04 INFO - PROCESS | 5718 | 04:33:06 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55038/tests/kraken/driver.html?testName=audio-oscillator) 04:33:06 INFO - PROCESS | 5718 | RSS: Main: 157569024 04:33:06 INFO - PROCESS | 5718 | 04:33:08 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55038/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:09 INFO - PROCESS | 5718 | RSS: Main: 157306880 04:33:09 INFO - PROCESS | 5718 | 04:33:12 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55038/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:13 INFO - PROCESS | 5718 | RSS: Main: 157212672 04:33:13 INFO - PROCESS | 5718 | 04:33:16 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55038/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:17 INFO - PROCESS | 5718 | RSS: Main: 157478912 04:33:17 INFO - PROCESS | 5718 | 04:33:20 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55038/tests/kraken/driver.html?testName=json-parse-financial) 04:33:20 INFO - PROCESS | 5718 | RSS: Main: 158195712 04:33:20 INFO - PROCESS | 5718 | 04:33:22 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55038/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:22 INFO - PROCESS | 5718 | RSS: Main: 157765632 04:33:22 INFO - PROCESS | 5718 | 04:33:24 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:25 INFO - PROCESS | 5718 | RSS: Main: 157671424 04:33:25 INFO - PROCESS | 5718 | 04:33:27 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:27 INFO - PROCESS | 5718 | RSS: Main: 157888512 04:33:27 INFO - PROCESS | 5718 | 04:33:30 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:31 INFO - PROCESS | 5718 | RSS: Main: 158158848 04:33:31 INFO - PROCESS | 5718 | 04:33:33 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:34 INFO - PROCESS | 5718 | RSS: Main: 157970432 04:33:34 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55038/tests/kraken/driver.html?testName=ai-astar) 04:33:36 INFO - PROCESS | 5718 | RSS: Main: 158564352 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | __start_tp_report 04:33:36 INFO - PROCESS | 5718 | _x_x_mozilla_page_load 04:33:36 INFO - PROCESS | 5718 | _x_x_mozilla_page_load_details 04:33:36 INFO - PROCESS | 5718 | |i|pagename|runs| 04:33:36 INFO - PROCESS | 5718 | |0;ai-astar;112;106;111;110;112;112;111;113;111;110 04:33:36 INFO - PROCESS | 5718 | |1;audio-beat-detection;151;130;156;172;126;159;155;132;182;127 04:33:36 INFO - PROCESS | 5718 | |2;audio-dft;165;164;163;162;164;162;162;165;163;161 04:33:36 INFO - PROCESS | 5718 | |3;audio-fft;76;76;76;170;75;76;76;76;163;75 04:33:36 INFO - PROCESS | 5718 | |4;audio-oscillator;85;85;148;84;84;87;143;84;85;144 04:33:36 INFO - PROCESS | 5718 | |5;imaging-gaussian-blur;117;117;118;116;117;117;117;121;117;117 04:33:36 INFO - PROCESS | 5718 | |6;imaging-darkroom;146;148;148;147;146;148;147;147;147;147 04:33:36 INFO - PROCESS | 5718 | |7;imaging-desaturate;95;97;95;95;95;95;95;95;95;95 04:33:36 INFO - PROCESS | 5718 | |8;json-parse-financial;57;53;53;55;54;55;53;53;53;58 04:33:36 INFO - PROCESS | 5718 | |9;json-stringify-tinderbox;62;61;62;61;63;61;61;62;62;62 04:33:36 INFO - PROCESS | 5718 | |10;stanford-crypto-aes;78;81;81;77;76;78;80;78;115;77 04:33:36 INFO - PROCESS | 5718 | |11;stanford-crypto-ccm;125;127;123;122;121;128;132;130;125;136 04:33:36 INFO - PROCESS | 5718 | |12;stanford-crypto-pbkdf2;154;156;159;155;155;156;153;155;161;152 04:33:36 INFO - PROCESS | 5718 | |13;stanford-crypto-sha256-iterative;63;62;65;61;63;61;61;62;61;62 04:33:36 INFO - PROCESS | 5718 | __end_tp_report 04:33:36 INFO - PROCESS | 5718 | __start_cc_report 04:33:36 INFO - PROCESS | 5718 | _x_x_mozilla_cycle_collect,865 04:33:36 INFO - PROCESS | 5718 | __end_cc_report 04:33:36 INFO - PROCESS | 5718 | __startTimestamp1472384016269__endTimestamp 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | ------- Summary: start ------- 04:33:36 INFO - PROCESS | 5718 | Number of tests: 14 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:1.93 (1.7%) stddev-sans-first:2.00 04:33:36 INFO - PROCESS | 5718 | Values: 112.0 106.0 111.0 110.0 112.0 112.0 111.0 113.0 111.0 110.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:155.50 stddev:19.64 (12.6%) stddev-sans-first:20.81 04:33:36 INFO - PROCESS | 5718 | Values: 151.0 130.0 156.0 172.0 126.0 159.0 155.0 132.0 182.0 127.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:1.37 (0.8%) stddev-sans-first:1.27 04:33:36 INFO - PROCESS | 5718 | Values: 165.0 164.0 163.0 162.0 164.0 162.0 162.0 165.0 163.0 161.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:38.30 (50.4%) stddev-sans-first:40.07 04:33:36 INFO - PROCESS | 5718 | Values: 76.0 76.0 76.0 170.0 75.0 76.0 76.0 76.0 163.0 75.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:84.50 stddev:29.09 (34.4%) stddev-sans-first:30.13 04:33:36 INFO - PROCESS | 5718 | Values: 85.0 85.0 148.0 84.0 84.0 87.0 143.0 84.0 85.0 144.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 04:33:36 INFO - PROCESS | 5718 | Values: 117.0 117.0 118.0 116.0 117.0 117.0 117.0 121.0 117.0 117.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 04:33:36 INFO - PROCESS | 5718 | Values: 146.0 148.0 148.0 147.0 146.0 148.0 147.0 147.0 147.0 147.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:33:36 INFO - PROCESS | 5718 | Values: 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.84 (3.4%) stddev-sans-first:1.69 04:33:36 INFO - PROCESS | 5718 | Values: 57.0 53.0 53.0 55.0 54.0 55.0 53.0 53.0 53.0 58.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 04:33:36 INFO - PROCESS | 5718 | Values: 62.0 61.0 62.0 61.0 63.0 61.0 61.0 62.0 62.0 62.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:78.00 stddev:11.69 (15.0%) stddev-sans-first:12.30 04:33:36 INFO - PROCESS | 5718 | Values: 78.0 81.0 81.0 77.0 76.0 78.0 80.0 78.0 115.0 77.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:127.50 stddev:4.72 (3.7%) stddev-sans-first:4.96 04:33:36 INFO - PROCESS | 5718 | Values: 125.0 127.0 123.0 122.0 121.0 128.0 132.0 130.0 125.0 136.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:155.50 stddev:2.67 (1.7%) stddev-sans-first:2.77 04:33:36 INFO - PROCESS | 5718 | Values: 154.0 156.0 159.0 155.0 155.0 156.0 153.0 155.0 161.0 152.0 04:33:36 INFO - PROCESS | 5718 | 04:33:36 INFO - PROCESS | 5718 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.29 (2.1%) stddev-sans-first:1.32 04:33:36 INFO - PROCESS | 5718 | Values: 63.0 62.0 65.0 61.0 63.0 61.0 61.0 62.0 61.0 62.0 04:33:36 INFO - PROCESS | 5718 | -------- Summary: end -------- 04:33:36 INFO - PROCESS | 5718 | 04:33:37 INFO - TEST-INFO | 5718: exit 0 04:33:37 INFO - TEST-OK | kraken | took 61037ms 04:33:37 INFO - SUITE-END | took 1170s 04:33:37 INFO - Completed test suite (00:19:30) 04:33:37 INFO - javascript benchmark 04:33:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7515.9272769571435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.8832440864576, 3379.7127244184244, 3396.354692608404, 3405.4040542904986, 3421.5380923575326, 5619.3818679945225, 5651.2935883014625, 5664.376918538957, 5699.0, 5702.885942281152, 5568.638038527503, 5705.629134106281, 5712.314522257325, 5716.799912003081, 5724.742386592603, 5010.073136469756, 5091.592672586203, 5094.363204599425, 5113.718745468997, 5115.360579927509, 5018.824341148061, 5087.5421212090905, 5093.465186155456, 5138.922916156261, 5167.199084141964, 5104.106781313274, 5125.871853203663, 5137.717425541594, 5139.306193663845, 5142.04872098663, 5170.45710200431, 5170.586353091744, 5179.326687530634, 5192.428832828386, 5195.168772996302, 4921.286413470027, 4951.950480495185, 4983.25251212321, 5089.44016158226, 5094.7197904115255, 5514.972425137848, 5533.142362933751, 5554.527865131468, 5573.6098473106895, 5582.078956972095, 5982.581219314649, 6009.128676341906, 6011.57918945674, 6015.398460153993, 6030.306514750772, 5818.970905145489, 5842.532597392198, 5921.171036054912, 5949.791757288474, 6062.96968515159, 5545.861353466155, 5549.084401073818, 5554.750036248338, 5559.444055594448, 5559.833205003856, 6018.608790428608, 6030.065339872327, 6055.909161362583, 6073.058675905242, 6092.299385570716, 5673.801416950387, 5804.854878628068, 5805.10020946754, 5833.88332233353, 5880.676562789087, 5966.642001479925, 5985.970070149621, 6005.969970150209, 6007.669578173155, 6013.669248191304, 5838.970805146032, 5997.100434934708, 5998.580099393088, 6010.188624535719, 6020.307664618537, 5938.495227905676, 5973.701314934323, 5976.073708575178, 5984.0, 5989.850253743604, 4653.744044077608, 4657.5575320344515, 4660.603848672833, 4663.906721865612, 4694.36626055485, 4074.348104303297, 4105.69207309447, 4175.728577642443, 4181.435506206684, 4219.767912764827, 5599.300087489064, 5690.174924635905, 5708.0581704019205, 5760.3951585083805, 5823.737931793079, 6053.878922421527, 6062.636241825505, 6067.0, 6085.604435711664, 6104.969475152596, 5557.249771280906, 5662.292213473316, 5774.855628609234, 5799.130130480462, 5839.124131380327, 5192.273081768555, 5201.245819356248, 5221.0, 5225.529702326809, 5282.920756188661, 6240.7503699852405, 6243.469305109116, 6276.309605943343, 6277.2153480814895, 6277.937220627735, 5770.105633626795, 5955.255593050869, 6010.068439391901, 6047.818565443044, 6069.2110025696375, 6239.78160764371, 6276.058591211355, 6294.0558916162945, 6301.8109456716375, 6306.936930630635, 5913.34953155144, 5927.881442371215, 5937.703114844154, 5942.346341902301, 5954.345022047484, 5897.292324920865, 5998.640081595118, 6008.429199226067, 6041.063635136561, 6051.0, 5957.046872500379, 5974.372690867396, 5978.432048955342, 5979.192808970907, 5986.790462333797, 5898.734556945034, 5937.228160339301, 5939.07944268639, 5947.821565353046, 5973.850653733692, 5665.206871037975, 5741.110127930177, 5755.165501002248, 5795.130730390307, 5839.737211825393, 5933.614315069507, 5968.671723055274, 5976.372480889618, 5977.551683623658, 5984.640921544721, 5826.271716035496, 5860.355360910211, 5887.970560147171, 5897.174395584708, 5898.587098903035], "value": 5554.623582353188, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.1820342418903, 638.0110828216264, 650.3691419323255, 657.9342065793418, 665.8468552232986, 45432.77283613582, 47101.29348059782, 47102.293465598, 47167.52832471678, 50630.0, 48325.516744832545, 49109.50890491094, 49197.75401122998, 49229.52311430654, 49282.75358623211, 9031.819363612723, 9106.817863642756, 9179.082091790835, 9184.311176661744, 9197.126273004054, 9074.455532668027, 9108.0, 9108.544572771369, 9110.817783644356, 9123.224525915271, 9141.131592498736, 9169.724908252763, 9222.631094756236, 9223.631054757801, 9224.262059035262, 9137.177654011137, 9145.268378529701, 9155.954220228923, 9162.587683554222, 9165.220956218729, 8857.291416686714, 8878.067802880734, 8934.195922367018, 8942.105789421072, 8946.373753837233, 44719.55280447187, 45127.32309015367, 45156.77421612904, 45224.54775452236, 45230.32154517685, 3769.736118471708, 3809.942850857239, 3827.0, 3848.5289137666705, 3871.361225397806, 33788.6621133788, 33831.0, 34174.31651366959, 34341.656583434095, 34605.30789384223, 4024.55729869717, 4109.97945010276, 4111.5477297497255, 4117.279476091672, 4168.312228482297, 360301.0, 361135.0, 361228.9999999974, 362145.0, 362727.0, 38056.61943380531, 63106.0, 63211.683941580915, 63266.0, 63566.682166589795, 39593.20813583712, 41135.7943210282, 41259.1748165041, 41335.0, 41406.0, 16851.241694123793, 17232.741508877378, 17279.827201728072, 17360.305587776347, 17372.47882563525, 14250.857491424953, 14379.568612941628, 14398.85601143996, 14464.493742719165, 14466.27668616586, 9354.391964522285, 9360.297977651704, 9384.765380865396, 9446.527673616292, 9450.149486546106, 3556.608773034964, 3625.782453052825, 3636.127329440915, 3667.6332366763645, 3692.5753538342897, 1088.586337191862, 1129.5770572122915, 1134.4838098665089, 1187.2342339191346, 1225.4607972492254, 33173.668263317544, 33229.0, 33389.0, 33630.99107026793, 34043.14892127667, 1150.0626989003936, 1155.930644161353, 1168.1764356129079, 1276.3809552367095, 1330.388021510097, 17326.826731732774, 17363.739543906853, 17388.217530211172, 17409.47771566855, 17568.824311756973, 566462.0, 597121.0, 810479.0, 841618.0, 842277.0, 59938.10092848611, 60591.69704151539, 60605.39394605997, 60654.0, 60771.6961415199, 1501.8347981722002, 1504.3832028868112, 1511.7127745728276, 1521.5815650695927, 1522.7868098466224, 32003.679963201, 32385.51421728723, 32864.0, 34525.65474345325, 37117.62882371142, 62115.689421552604, 62690.37309626846, 62976.685116574125, 63102.68448657727, 63167.684161578894, 515700.0, 533817.0, 535812.0, 537922.2415551746, 538891.0, 47932.5206747928, 49244.26133607927, 49644.0, 49913.251301231234, 50139.74930125472, 53753.0, 54212.728936355066, 54223.18665219946, 54379.18431223614, 55295.72352138213, 44852.10295794131, 45568.0, 45612.24591819465, 45716.31425528686, 46126.30810537912, 43902.56097439113, 44180.337294939956, 44682.3297650529, 45325.18699252125, 45707.0, 44274.604184899814, 45085.0, 45598.54401456076, 45630.771846141884, 45789.77105114453, 37674.0, 38280.80859595684, 38615.0, 39532.80233598813, 39617.60382396139, 29961.250968725955, 30312.973749302302, 30342.84828575843, 30532.389352212387, 30701.846490767402], "value": 20830.24119345028, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.8999135203227, 428.2291874625673, 428.5200575355602, 433.96094351508356, 443.66281625964257, 18347.082645867704, 19341.129649165767, 20080.196792128314, 20471.488212794688, 20471.488212794688, 18587.628247435045, 18769.155388007537, 19027.429177124675, 19439.611207775837, 19498.805011949877, 5839.153322768207, 5985.760569577234, 6015.578909476339, 6018.578699491016, 6021.849453763647, 4882.41411030675, 5879.353271140171, 5948.315943666469, 6316.178896743417, 6340.936590634081, 5362.0, 6338.714757835908, 6370.522210834206, 6402.519811014193, 6414.679266036703, 5624.831255062334, 5754.367019627858, 5760.193572899798, 5761.539076873861, 5767.740451679684, 5492.725363731837, 5701.315842098975, 5704.429557044304, 5704.515116215127, 5716.428357164292, 13028.609141725763, 13320.467181312735, 13433.0, 13528.25594592297, 13633.590992270249, 2153.720016397874, 2232.609293373653, 2258.4930726893135, 2391.497785465037, 2485.254423672909, 10099.091081802673, 10315.658964334589, 10368.740781480448, 10374.429406382646, 10476.371417714885, 1962.0876292523901, 1965.7247985281929, 1985.3150663021236, 2003.8597298188986, 2025.473376921996, 73073.0, 75581.0, 76102.0, 82984.0, 85572.57213713953, 10857.565697372174, 11322.37726925027, 11327.660170194908, 11453.427328633701, 11469.139814513945, 15829.287682054335, 15949.920250398905, 15996.200189990454, 16075.0, 16165.4342098026, 8305.211004954519, 8357.791055223546, 8729.432586881832, 8760.386772925962, 8801.427907186013, 8382.036065852382, 8463.0, 8597.269232115215, 8879.156480134377, 8965.148310910454, 4464.374987501752, 4537.818487260539, 4545.749983750926, 4554.43069616298, 4566.862994110115, 1909.627622613577, 1921.8654694171273, 1926.5857840564347, 1938.6413513500047, 1958.177565422526, 436.6245029274821, 448.9842855500042, 983.4984158079288, 1050.721558786922, 1087.065123993365, 11536.192466527431, 11841.763164736829, 11926.105542084379, 11988.460519276654, 12103.213291136048, 459.34084588615445, 464.7374233558029, 470.901110766736, 471.9174144524695, 476.49253544974493, 6200.193974783339, 6321.589096708699, 6397.648129352837, 10504.42225677595, 10992.230543862013, 524800.0, 527652.0, 527757.0, 534980.0, 541334.0, 61098.69450652718, 86875.56562217275, 88061.0, 90261.54869225743, 98832.50583747035, 1099.2195541165702, 1124.4321617583068, 1134.6539305511733, 1136.5283407386007, 1146.0487795130023, 17322.39371621987, 17720.0, 17886.28454861843, 17900.10499474995, 18258.543536411697, 42206.78896605497, 42283.0, 42413.57586424219, 42564.36153457639, 45188.0, 54699.17951230655, 55507.0, 56294.43705562892, 62267.443313917516, 63526.36473635204, 8571.4000019998, 8889.866652000355, 9055.049219831822, 9117.452952822852, 9125.087491250822, 12341.50633974631, 13091.476340946256, 13268.071235013456, 13562.389692463665, 13576.93211533936, 11583.0, 11691.707707307385, 12001.339926304137, 12108.878911210775, 12109.152359334763, 9886.357386769838, 11713.648590542298, 11732.354720490455, 11824.940875295568, 11888.28670279786, 12007.879921201025, 12134.641238858807, 12142.271463712206, 12210.0, 12247.755044898873, 8604.82790344177, 8632.870506942276, 8647.697330593399, 8797.296216302553, 9008.099190080939, 9145.725628231165, 10596.735081622714, 11694.239874408137, 11801.881981180079, 12030.218035827644], "value": 8809.452553928217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.6814675672433, 1603.3426295218958, 1834.1562881074706, 1884.9528761780962, 1941.3981665683648, 8380.0, 9300.209482194014, 9419.811603767937, 10018.54916528757, 10038.498075096244, 9492.857607135882, 9776.657816976407, 9781.7554561136, 9841.114299713025, 9884.555195016224, 2457.8771061446946, 2490.7260201377835, 2491.6137998610243, 2491.9409251068314, 2496.4383013821835, 2384.666146739458, 2469.4814089041233, 2470.086068154776, 2476.6408870713826, 2476.7647073527987, 2460.1143588308196, 2465.6301554766837, 2480.1443501991785, 2492.152668092848, 2494.8627825469594, 2180.4439867833757, 2219.6115679755976, 2220.555888822234, 2243.8204943604474, 2264.9433764155865, 2352.788249057593, 2372.5847976604027, 2390.7848293653483, 2398.124684490166, 2400.699912510936, 9675.806483870283, 9722.854157187649, 9755.36590121647, 9767.218622510181, 9783.217342612574, 5638.35158956717, 5813.6802475863815, 5817.476427121579, 5821.796237131723, 5822.82531524055, 3611.747177697562, 3647.81760911956, 3649.6897763689853, 3651.634836516327, 3723.2367364690444, 1154.1805318224071, 1210.9273443593413, 1217.7077501399601, 1235.4008305971597, 1238.2137342787305, 13838.515651952133, 13863.475017747938, 13928.233947132903, 13938.651533711636, 13971.930140349335, 5032.748362581856, 5060.240963855377, 5070.619703522177, 5111.3355263815465, 5254.868628284247, 11395.829062564067, 11418.143639227092, 11458.083353331713, 11469.942650286695, 11474.48364823585, 5774.855628609234, 5776.595638305278, 5789.160571717078, 5796.8550786229835, 5805.680687562224, 4359.956400435955, 5075.137226671474, 5211.088059589557, 5247.134222853263, 5382.381026182039, 4364.41080454141, 4376.978115109404, 4401.6698747594055, 4427.712198707074, 4510.0, 1390.075599726191, 1392.470861072786, 1406.310907655262, 1415.985840141606, 1418.3121186224673, 891.4364777387901, 901.396064636695, 957.090763774417, 970.1365784451843, 991.3902949685892, 5887.175795388649, 6222.719977601018, 6419.101325814389, 6546.509011824132, 6582.341765823379, 985.4530735441755, 1002.4987506246877, 1023.9129673977646, 1039.0804138337473, 1057.6383055918654, 4006.138680183716, 4049.088954985105, 4097.733647312915, 4100.2619528484565, 4104.486939132608, 12029.819552706716, 12304.81542776859, 12401.0, 12405.193662412095, 12420.130590858553, 11899.88100119005, 12192.573259936036, 12214.694632634255, 12263.448144833505, 12425.37873106341, 8544.102869198645, 8557.657693692183, 8697.826043479095, 8699.608517616722, 8744.213020828156, 5795.39148389413, 5817.447342502455, 5841.795537156179, 5852.502537284378, 6003.699815009145, 10492.160627149657, 10505.89688082771, 10513.579456821948, 10641.89358106409, 10765.946170269099, 11328.716782080513, 11474.713132171762, 11528.769424611628, 11546.59586914454, 11634.418279085843, 8392.328613710766, 8507.064222935349, 8628.611712473079, 8695.304375649806, 8843.646254149762, 9430.905690943002, 9529.237660987243, 9608.95195524018, 9633.470159141314, 9727.951360243154, 8373.748787536384, 8412.87380689278, 8509.149085091442, 8534.530600817016, 8615.22462978335, 8107.959460202661, 8339.666413343399, 8385.790355241168, 8417.0, 8501.532415717194, 7420.888686669597, 7434.702611895464, 7497.400207983457, 7497.737579184703, 7510.737124200627, 5119.385673719177, 5200.115980283285, 5286.550643195218, 5304.23088652151, 5338.813141540028, 5138.922916156335, 5172.224166375074, 5235.1623740201385, 5239.895202096013, 5266.78932842682], "value": 4987.016925154833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.78906866811246, 348.35901940429613, 348.808155514467, 353.2299586900556, 355.9003479025872, 5726.284214473191, 5804.82585522434, 5807.186993820868, 5807.332156801964, 5836.9124463132985, 5656.688882111483, 5673.0, 5687.146927960808, 5697.77208911643, 5739.397363276858, 4032.193561287747, 4368.541303163154, 4407.360932664762, 4410.867673969786, 4411.6250118739945, 4405.581469760367, 4426.601605855472, 4462.219111655448, 4465.106978604276, 4466.97766511167, 4418.293073108303, 4440.955590444087, 4461.531539188387, 4462.1968045751755, 4474.619657329131, 4292.892677683068, 4400.8215933113315, 4408.779561021936, 4418.491873434532, 4450.821967121327, 3871.9225615487812, 3874.4575759393706, 3891.0466935600675, 3904.06302487401, 3908.7654740715648, 5523.453433038715, 5526.618345413646, 5543.528800052, 5545.916811247835, 5559.471850174227, 4910.558049775537, 5045.167547354718, 5075.629580013413, 5093.770780314895, 5115.360579927509, 6010.939890601082, 6011.57918945674, 6016.2479690038745, 6022.879542409171, 6091.177691011701, 4276.66921527765, 4293.763842988635, 4296.0, 4306.20335237982, 4310.547392523803, 6104.175936248594, 6260.0, 6279.686015699197, 6294.9685251574365, 6306.527010474187, 4285.892852678646, 4307.7415355078165, 4310.374995625617, 4313.317806055641, 4322.891927701832, 4308.612224899712, 4323.891902702395, 4363.498197707304, 4372.213001659668, 4376.65848770906, 4893.266010098514, 5010.223415370623, 5016.648834581544, 5022.096022715873, 5034.899302014012, 5997.460228579362, 6000.0, 6008.969955150284, 6052.789442111595, 6109.5112391008615, 1456.1190479759805, 1478.7560052591416, 1519.080956021613, 1525.7482515385059, 1527.2974431761513, 963.8554216867526, 970.8009857979098, 1013.690824298596, 1040.1314902056715, 1042.9426381548935, 5804.65172089676, 5882.823515294548, 5896.941030589725, 5900.203472531153, 5949.137375080676, 6168.753249869955, 6215.844603884939, 6224.190855188796, 6234.0, 6266.905996410058, 5722.341930677942, 5791.652500849878, 5802.535797136219, 5828.6211396259105, 5856.677882716406, 3309.9573634305116, 3344.6488118747666, 3352.1619595101224, 3356.0938546592283, 3358.177246574605, 6180.165677633552, 6436.195475565554, 6470.547061705635, 6568.967155164193, 6570.310117437601, 6378.234611846516, 6453.4189123665, 6456.322086180978, 6458.418742313214, 6473.805785826433, 6335.651539165298, 6536.705848236936, 6581.539292249592, 6587.835304117435, 6592.5055620828625, 6270.655113968775, 6277.717502712298, 6295.716692748746, 6297.4647154992335, 6341.904871427025, 6158.7228574715145, 6169.259688837368, 6214.13575927211, 6243.532769799002, 6261.3112557617715, 6217.041631885942, 6507.446867016357, 6523.575967562093, 6529.563496030865, 6579.80260592183, 4432.091421258569, 4444.599986001275, 4452.443444569429, 4481.910361792811, 4499.842505512292, 6213.788311279257, 6274.592151510137, 6306.0, 6310.5267104968225, 6326.905096423466, 6150.7539698411565, 6180.721867515883, 6190.566660333733, 6194.969025154845, 6206.410391012847, 5901.734421950937, 6108.389161083856, 6131.4860907027905, 6136.662483563447, 6180.505559555135, 5907.852303692442, 6013.301819381137, 6043.576949613661, 6055.6063855849225, 6056.36408177135, 6199.969000154971, 6206.875862482815, 6211.223597050369, 6216.849882771702, 6220.409061139185, 5977.22296101504, 6020.909686354796, 6049.939500604937, 6052.425019623305, 6053.910296146736], "value": 4606.437611045951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.6851969393314, 723.8805597076486, 733.8238822682555, 757.3373298363931, 775.1202385292692, 14235.786463203047, 14792.556223313319, 14825.629359266024, 14858.182799945998, 14889.329980150906, 14880.0, 14912.701745965102, 15029.248537573105, 15049.322780474877, 16225.107619080945, 872.8647059705739, 881.3610132653806, 881.6120906801019, 882.0341725810227, 885.4642941020654, 869.1135042256926, 877.5656050255133, 878.8198419324024, 879.3053487744706, 879.7448739865431, 914.8444764390069, 915.0209276074603, 918.9908100918972, 919.9586018629178, 920.1350730313484, 907.9228265597433, 909.2498688581913, 909.3725329522608, 909.9727008189765, 911.3347256502724, 668.234871072624, 668.2849351194224, 669.9916625478623, 670.0318040431579, 670.9396154346083, 15343.4629787958, 15400.614984625361, 15410.0, 15435.922820385938, 15442.150681712501, 13218.801717974238, 13581.864181358258, 13815.102018368774, 13878.583642490741, 13885.305734713224, 12323.322217278046, 12350.814737778941, 12414.193077450027, 12831.422585983653, 12871.549495767696, 3661.707063434919, 3799.6580307772433, 3893.299206142893, 4839.346688197119, 4902.142125128088, 71898.64050679766, 75450.0, 84470.0, 84585.15414845834, 86393.56803216007, 12333.69165770845, 12543.435545400478, 12701.872981270253, 12813.871861281454, 12872.16330938486, 22789.31632051041, 22969.655455168187, 23001.0, 23244.3026709199, 23713.644295335584, 8504.829903401896, 8612.138786121337, 8617.224449799549, 8622.396432249809, 8646.524441155796, 4638.0955713636195, 4668.50980647034, 4724.622030237572, 4944.9258261126115, 5043.420006699203, 3658.63413658632, 3740.7194460415035, 3740.8877733668032, 3762.435634654824, 3766.642168993941, 655.9770408035696, 659.4493597845757, 662.059874977533, 673.9022841687928, 678.1082876018021, 550.7246376811594, 581.2182614383647, 596.749365266589, 654.6072356586105, 701.529974916807, 9070.954645226864, 9229.307801914749, 9299.628014879465, 9489.193418559362, 9535.2371810255, 597.4205021129497, 714.3856283596103, 770.2374649097466, 814.816666250089, 820.5609998650693, 4574.5882870541145, 4845.055214233261, 4851.805927762921, 4851.95148048515, 4856.781444834991, 115621.42189289, 117727.41136294264, 117914.41042794731, 119302.40348798201, 120190.0, 72260.0, 73679.63160184165, 97772.0, 99770.0, 104070.4796476028, 88426.0, 90927.0, 91165.5441722787, 92575.0, 92585.53707231421, 8960.845992913628, 9117.77205569866, 9313.487758173094, 9331.86002209981, 9369.859452108087, 52736.47263527469, 54042.459575403744, 54542.0, 54597.454025459236, 55668.721656391455, 70910.29089709037, 76672.61663691868, 77591.0, 77896.01400270588, 78379.60810195912, 12318.0, 12333.93833030829, 12437.689057773629, 12566.434510446868, 12943.417546210632, 13648.014413481513, 13896.51362202318, 14010.929945350208, 14044.78932815988, 14421.134731916118, 13021.9582433407, 13060.151090179108, 13240.073194876266, 13248.735025299633, 13393.531226407029, 12205.816912746493, 12216.877831221575, 12363.62909112728, 12428.0, 12458.688532786753, 12341.197822141532, 12425.0, 13416.932915335361, 13657.317134143452, 13966.0, 11736.354500502553, 12015.12631068884, 12138.75722485563, 12339.383030848601, 12412.875871241173, 11924.403779811148, 11956.521739130685, 12020.879791201976, 12025.939870300943, 12115.333656648969], "value": 7697.542885596994, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 110.0, 112.0, 112.0, 111.0, 113.0, 111.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 156.0, 172.0, 126.0, 159.0, 155.0, 132.0, 182.0, 127.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 162.0, 164.0, 162.0, 162.0, 165.0, 163.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 170.0, 75.0, 76.0, 76.0, 76.0, 163.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 148.0, 84.0, 84.0, 87.0, 143.0, 84.0, 85.0, 144.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 121.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 55.0, 54.0, 55.0, 53.0, 53.0, 53.0, 58.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 63.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 81.0, 77.0, 76.0, 78.0, 80.0, 78.0, 115.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 127.0, 123.0, 122.0, 121.0, 128.0, 132.0, 130.0, 125.0, 136.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 159.0, 155.0, 155.0, 156.0, 153.0, 155.0, 161.0, 152.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 65.0, 61.0, 63.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 62.1, "unit": "score"}]}]} 04:33:37 INFO - Return code: 0 04:33:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:37 ERROR - # TBPL SUCCESS # 04:33:37 INFO - Running post-action listener: _resource_record_post_action 04:33:37 INFO - ##### 04:33:37 INFO - ##### Finished run-tests step (success) 04:33:37 INFO - ##### 04:33:37 INFO - Running post-run listener: _resource_record_post_run 04:33:37 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 24576; Write bytes: 286199808; Read time: 16; Write time: 167796 04:33:37 INFO - TinderboxPrint: CPU usage
13.3% 04:33:37 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 16 04:33:37 INFO - TinderboxPrint: I/O write bytes / time
286,199,808 / 167,796 04:33:37 INFO - TinderboxPrint: CPU idle
8,201.4 (86.7%) 04:33:37 INFO - TinderboxPrint: CPU user
1,205.1 (12.7%) 04:33:37 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:37 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 68628480; Read time: 0; Write time: 64696 04:33:37 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 215265280; Read time: 0; Write time: 101812 04:33:38 INFO - Running post-run listener: _upload_blobber_files 04:33:38 INFO - Blob upload gear active. 04:33:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:38 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 04:33:38 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'] 04:33:38 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 04:33:38 INFO - Traceback (most recent call last): 04:33:38 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 04:33:38 INFO - main() 04:33:38 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 04:33:38 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 04:33:38 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 04:33:38 INFO - return set(response.json().get('whitelist', [])) 04:33:38 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 04:33:38 INFO - return json.loads(self.text or self.content, **kwargs) 04:33:38 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 04:33:38 INFO - return _default_decoder.decode(s) 04:33:38 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 04:33:38 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 04:33:38 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 04:33:38 INFO - raise ValueError("No JSON object could be decoded") 04:33:38 INFO - ValueError: No JSON object could be decoded 04:33:38 ERROR - Return code: 1 04:33:38 INFO - Setting buildbot property blobber_files to {} 04:33:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:38 INFO - Contents: 04:33:38 INFO - blobber_files:{} 04:33:38 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:38 INFO - Copying logs to upload dir... 04:33:38 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1670.388929 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 50 secs) (at 2016-08-28 04:33:37.908586) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:37.912528) ========= 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=4300f881736b422476174874000001bc-1472382346.584979-960572220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:37.965143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:37.965499) ========= 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=4300f881736b422476174874000001bc-1472382346.584979-960572220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004911 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:38.015656) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:33:38.016138) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:33:38.016619) ========= ========= Total master_lag: 0.16 =========