builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1472382350.97 results: success (0) buildid: 20160826110814 builduid: 0dbeb50956e042d4ac8dadee4f76f40d revision: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:50.968251) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:50.968709) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:50.968995) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:50.984283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:50.984685) ========= 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=af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-28 04:05:52-- 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% 46.2M=0s 2016-08-28 04:05:52 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123260 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:51.122069) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:51.122381) ========= 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=af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013735 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:51.171959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:51.172324) ========= 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=af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-28 04:05:52,227 truncating revision to first 12 chars 2016-08-28 04:05:52,228 Setting DEBUG logging. 2016-08-28 04:05:52,228 attempt 1/10 2016-08-28 04:05:52,228 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:52,492 unpacking tar archive at: mozilla-beta-6d0c7b6a6ae1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559570 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:51.745692) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:51.746015) ========= script_repo_revision: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:51.746562) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:51.746881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:51.756330) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 50 secs) (at 2016-08-28 04:05:51.756838) ========= /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=af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:52 INFO - MultiFileLogger online at 20160828 04:05:52 in /builds/slave/test 04:05:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:05:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:52 INFO - {'append_to_log': False, 04:05:52 INFO - 'base_work_dir': '/builds/slave/test', 04:05:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:05:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:52 INFO - 'branch': 'Mozilla-Beta', 04:05:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:52 INFO - 'config_files': ('talos/linux_config.py',), 04:05:52 INFO - 'default_actions': ('clobber', 04:05:52 INFO - 'read-buildbot-config', 04:05:52 INFO - 'download-and-extract', 04:05:52 INFO - 'populate-webroot', 04:05:52 INFO - 'create-virtualenv', 04:05:52 INFO - 'install', 04:05:52 INFO - 'run-tests'), 04:05:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:52 INFO - 'download_minidump_stackwalk': True, 04:05:52 INFO - 'download_symbols': 'ondemand', 04:05:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:52 INFO - 'installer_path': 'installer.exe', 04:05:52 INFO - 'log_level': 'info', 04:05:52 INFO - 'log_name': 'talos', 04:05:52 INFO - 'log_to_console': True, 04:05:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:52 INFO - 'opt_config_files': (), 04:05:52 INFO - 'pip_index': False, 04:05:52 INFO - 'sps_profile': False, 04:05:52 INFO - 'sps_profile_interval': 0, 04:05:52 INFO - 'suite': 'dromaeojs-e10s', 04:05:52 INFO - 'system_bits': '32', 04:05:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:52 INFO - 'title': 'talos-linux64-ix-020', 04:05:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:52 INFO - 'use_talos_json': True, 04:05:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:52 INFO - 'work_dir': 'build'} 04:05:52 INFO - ##### 04:05:52 INFO - ##### Running clobber step. 04:05:52 INFO - ##### 04:05:52 INFO - Running pre-action listener: _resource_record_pre_action 04:05:52 INFO - Running main action method: clobber 04:05:52 INFO - rmtree: /builds/slave/test/build 04:05:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:53 INFO - Running post-action listener: _resource_record_post_action 04:05:53 INFO - ##### 04:05:53 INFO - ##### Finished clobber step (success) 04:05:53 INFO - ##### 04:05:53 INFO - ##### 04:05:53 INFO - ##### Running read-buildbot-config step. 04:05:53 INFO - ##### 04:05:53 INFO - Running pre-action listener: _resource_record_pre_action 04:05:53 INFO - Running main action method: read_buildbot_config 04:05:53 INFO - Using buildbot properties: 04:05:53 INFO - { 04:05:53 INFO - "project": "", 04:05:53 INFO - "product": "firefox", 04:05:53 INFO - "script_repo_revision": "production", 04:05:53 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:05:53 INFO - "repository": "", 04:05:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 04:05:53 INFO - "buildid": "20160826110814", 04:05:53 INFO - "pgo_build": "True", 04:05:53 INFO - "basedir": "/builds/slave/test", 04:05:53 INFO - "buildnumber": 156, 04:05:53 INFO - "slavename": "talos-linux64-ix-020", 04:05:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:05:53 INFO - "platform": "ubuntu64_hw", 04:05:53 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:05:53 INFO - "branch": "mozilla-beta", 04:05:53 INFO - "repo_path": "releases/mozilla-beta", 04:05:53 INFO - "revision": "6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f", 04:05:53 INFO - "stage_platform": "linux64-pgo", 04:05:53 INFO - "builduid": "0dbeb50956e042d4ac8dadee4f76f40d", 04:05:53 INFO - "slavebuilddir": "test" 04:05:53 INFO - } 04:05:53 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:53 INFO - Running post-action listener: _resource_record_post_action 04:05:53 INFO - ##### 04:05:53 INFO - ##### Finished read-buildbot-config step (success) 04:05:53 INFO - ##### 04:05:53 INFO - ##### 04:05:53 INFO - ##### Running download-and-extract step. 04:05:53 INFO - ##### 04:05:53 INFO - Running pre-action listener: _resource_record_pre_action 04:05:53 INFO - Running main action method: download_and_extract 04:05:53 INFO - mkdir: /builds/slave/test/build/tests 04:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:05:53 INFO - retry: Failed, sleeping 30 seconds before retrying 04:06:23 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:23 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:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:06:23 INFO - retry: Failed, sleeping 60 seconds before retrying 04:07:23 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:23 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:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:07:23 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:23 INFO - Caught exception: HTTP Error 404: Not Found 04:07:23 INFO - Caught exception: HTTP Error 404: Not Found 04:07:23 INFO - Caught exception: HTTP Error 404: Not Found 04:07:23 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:23 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:23 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:24 INFO - Downloaded 1327 bytes. 04:07:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 04:07:24 INFO - Using the following test package requirements: 04:07:24 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 04:07:24 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:24 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:07:24 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:24 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 04:07:24 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:24 INFO - u'jsshell-linux-x86_64.zip'], 04:07:24 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:24 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:07:24 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 04:07:24 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:24 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 04:07:24 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:24 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 04:07:24 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:24 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:07:24 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 04:07:24 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:07:24 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:07: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:07:24 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: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.common.tests.zip 04:07: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.common.tests.zip 04:07: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.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 04:07: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.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: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.common.tests.zip 04:07:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:07:24 INFO - retry: Failed, sleeping 30 seconds before retrying 04:07: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.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: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.common.tests.zip 04:07:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:07:54 INFO - retry: Failed, sleeping 60 seconds before retrying 04:08: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.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: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.common.tests.zip 04:08:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:08: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.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip! 04:08:54 INFO - Caught exception: HTTP Error 404: Not Found 04:08:54 INFO - Caught exception: HTTP Error 404: Not Found 04:08:54 INFO - Caught exception: HTTP Error 404: Not Found 04:08:54 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:54 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: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.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:55 INFO - Downloaded 21969046 bytes. 04:08:55 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:55 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:56 INFO - Return code: 0 04:08:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:08:56 INFO - retry: Failed, sleeping 30 seconds before retrying 04:09:26 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:26 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:26 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:09:26 INFO - retry: Failed, sleeping 60 seconds before retrying 04:10:26 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:26 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:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:10:26 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:26 INFO - Caught exception: HTTP Error 404: Not Found 04:10:26 INFO - Caught exception: HTTP Error 404: Not Found 04:10:26 INFO - Caught exception: HTTP Error 404: Not Found 04:10:26 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:26 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:26 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:27 INFO - Downloaded 21969046 bytes. 04:10:27 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:27 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:28 INFO - Return code: 0 04:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:10:28 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:28 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:28 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:28 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:28 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:28 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:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:10:28 INFO - retry: Failed, sleeping 30 seconds before retrying 04:10:58 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:58 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:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:10:58 INFO - retry: Failed, sleeping 60 seconds before retrying 04:11:58 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:58 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:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:11:58 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:58 INFO - Caught exception: HTTP Error 404: Not Found 04:11:58 INFO - Caught exception: HTTP Error 404: Not Found 04:11:58 INFO - Caught exception: HTTP Error 404: Not Found 04:11:58 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:58 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:58 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:59 INFO - Downloaded 10833369 bytes. 04:11:59 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:59 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:59 INFO - Return code: 0 04:11:59 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:59 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:59 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:59 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:59 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:59 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:59 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:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 04:11:59 INFO - retry: Failed, sleeping 30 seconds before retrying 04:12:29 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:29 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:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 04:12:29 INFO - retry: Failed, sleeping 60 seconds before retrying 04:13:29 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:29 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:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 04:13:29 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:29 INFO - Caught exception: HTTP Error 404: Not Found 04:13:29 INFO - Caught exception: HTTP Error 404: Not Found 04:13:29 INFO - Caught exception: HTTP Error 404: Not Found 04:13:29 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:29 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:29 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:30 INFO - Downloaded 55208267 bytes. 04:13:30 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:30 INFO - mkdir: /builds/slave/test/properties 04:13:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:30 INFO - Contents: 04:13:30 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:31 INFO - Running post-action listener: _resource_record_post_action 04:13:31 INFO - Running post-action listener: set_extra_try_arguments 04:13:31 INFO - ##### 04:13:31 INFO - ##### Finished download-and-extract step (success) 04:13:31 INFO - ##### 04:13:31 INFO - ##### 04:13:31 INFO - ##### Running populate-webroot step. 04:13:31 INFO - ##### 04:13:31 INFO - Running pre-action listener: _resource_record_pre_action 04:13:31 INFO - Running main action method: populate_webroot 04:13:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:31 INFO - '--tppagecycles', 04:13:31 INFO - '7'], 04:13:31 INFO - 'tests': ['tsvgm']}}, 04:13:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:31 INFO - 'talos_options': ['--disable-e10s'], 04:13:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:31 INFO - 'talos_options': ['--disable-e10s'], 04:13:31 INFO - 'tests': ['damp', 'tps']}, 04:13:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:31 INFO - 'tests': ['damp', 'tps']}, 04:13:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:31 INFO - 'tests': ['dromaeo_dom']}, 04:13:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:31 INFO - 'tests': ['a11yr', 04:13:31 INFO - 'ts_paint', 04:13:31 INFO - 'tpaint', 04:13:31 INFO - 'sessionrestore', 04:13:31 INFO - 'sessionrestore_no_auto_restore', 04:13:31 INFO - 'tabpaint']}, 04:13:31 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:31 INFO - 'ts_paint', 04:13:31 INFO - 'tpaint', 04:13:31 INFO - 'sessionrestore', 04:13:31 INFO - 'sessionrestore_no_auto_restore', 04:13:31 INFO - 'tabpaint']}, 04:13:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:31 INFO - 'ts_paint', 04:13:31 INFO - 'tpaint', 04:13:31 INFO - 'sessionrestore', 04:13:31 INFO - 'sessionrestore_no_auto_restore', 04:13:31 INFO - 'tabpaint']}, 04:13:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:31 INFO - 'ts_paint', 04:13:31 INFO - 'tpaint', 04:13:31 INFO - 'sessionrestore', 04:13:31 INFO - 'sessionrestore_no_auto_restore', 04:13:31 INFO - 'tabpaint']}, 04:13:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:31 INFO - 'tests': ['a11yr', 04:13:31 INFO - 'ts_paint', 04:13:31 INFO - 'tpaint', 04:13:31 INFO - 'sessionrestore', 04:13:31 INFO - 'sessionrestore_no_auto_restore', 04:13:31 INFO - 'tabpaint']}, 04:13:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:31 INFO - 'tests': ['a11yr', 04:13:31 INFO - 'ts_paint', 04:13:31 INFO - 'tpaint', 04:13:31 INFO - 'sessionrestore', 04:13:31 INFO - 'sessionrestore_no_auto_restore', 04:13:31 INFO - 'tabpaint']}, 04:13:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:31 INFO - 'tests': ['tsvgx', 04:13:31 INFO - 'tsvgr_opacity', 04:13:31 INFO - 'tart', 04:13:31 INFO - 'tscrollx', 04:13:31 INFO - 'cart']}, 04:13:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:31 INFO - 'tsvgr_opacity', 04:13:31 INFO - 'tart', 04:13:31 INFO - 'tscrollx', 04:13:31 INFO - 'cart']}, 04:13:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:31 INFO - 'talos_options': ['--disable-e10s'], 04:13:31 INFO - 'tests': ['tp5o']}, 04:13:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:31 INFO - 'tests': ['tp5o']}, 04:13:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:31 INFO - 'talos_options': ['--disable-e10s', 04:13:31 INFO - '--xperf_path', 04:13:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:31 INFO - 'tests': ['tp5n']}, 04:13:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:31 INFO - 'talos_options': ['--xperf_path', 04:13:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:31 INFO - 'tests': ['tp5n']}}, 04:13:31 INFO - 'talos.zip': {'path': '', 04:13:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:31 INFO - Running post-action listener: _resource_record_post_action 04:13:31 INFO - ##### 04:13:31 INFO - ##### Finished populate-webroot step (success) 04:13:31 INFO - ##### 04:13:31 INFO - ##### 04:13:31 INFO - ##### Running create-virtualenv step. 04:13:31 INFO - ##### 04:13:31 INFO - Running pre-action listener: _resource_record_pre_action 04:13:31 INFO - Running main action method: create_virtualenv 04:13:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:31 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:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:31 INFO - Using real prefix '/usr' 04:13:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:34 INFO - Installing pip.................done. 04:13:34 INFO - Return code: 0 04:13:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2375d62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, '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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', '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:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:13:34 INFO - Using env: {'DISPLAY': ':0', 04:13:34 INFO - 'HOME': '/home/cltbld', 04:13:34 INFO - 'LANG': 'en_US.UTF-8', 04:13:34 INFO - 'LANGUAGE': 'en_US:en', 04:13:34 INFO - 'LOGNAME': 'cltbld', 04:13:34 INFO - 'MAIL': '/var/mail/cltbld', 04:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:34 INFO - 'MOZ_NO_REMOTE': '1', 04:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:34 INFO - 'NO_EM_RESTART': '1', 04:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:34 INFO - 'PWD': '/builds/slave/test', 04:13:34 INFO - 'SHELL': '/bin/bash', 04:13:34 INFO - 'SHLVL': '1', 04:13:34 INFO - 'TERM': 'linux', 04:13:34 INFO - 'TMOUT': '86400', 04:13:34 INFO - 'USER': 'cltbld', 04:13:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 04:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:34 INFO - '_': '/tools/buildbot/bin/python'} 04:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:34 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:34 INFO - Cleaning up... 04:13:34 INFO - Return code: 0 04:13:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2375d62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, '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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', '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:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:13:34 INFO - Using env: {'DISPLAY': ':0', 04:13:34 INFO - 'HOME': '/home/cltbld', 04:13:34 INFO - 'LANG': 'en_US.UTF-8', 04:13:34 INFO - 'LANGUAGE': 'en_US:en', 04:13:34 INFO - 'LOGNAME': 'cltbld', 04:13:34 INFO - 'MAIL': '/var/mail/cltbld', 04:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:34 INFO - 'MOZ_NO_REMOTE': '1', 04:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:34 INFO - 'NO_EM_RESTART': '1', 04:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:34 INFO - 'PWD': '/builds/slave/test', 04:13:34 INFO - 'SHELL': '/bin/bash', 04:13:34 INFO - 'SHLVL': '1', 04:13:34 INFO - 'TERM': 'linux', 04:13:34 INFO - 'TMOUT': '86400', 04:13:34 INFO - 'USER': 'cltbld', 04:13:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 04:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:34 INFO - '_': '/tools/buildbot/bin/python'} 04:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:34 INFO - Downloading/unpacking psutil>=3.1.1 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:36 INFO - Installing collected packages: psutil 04:13:36 INFO - Running setup.py install for psutil 04:13:36 INFO - building 'psutil._psutil_linux' extension 04:13:36 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:36 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:36 INFO - building 'psutil._psutil_posix' extension 04:13:36 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:36 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:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:36 INFO - Successfully installed psutil 04:13:36 INFO - Cleaning up... 04:13:36 INFO - Return code: 0 04:13:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2375d62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, '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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', '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:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:13:36 INFO - Using env: {'DISPLAY': ':0', 04:13:36 INFO - 'HOME': '/home/cltbld', 04:13:36 INFO - 'LANG': 'en_US.UTF-8', 04:13:36 INFO - 'LANGUAGE': 'en_US:en', 04:13:36 INFO - 'LOGNAME': 'cltbld', 04:13:36 INFO - 'MAIL': '/var/mail/cltbld', 04:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:36 INFO - 'MOZ_NO_REMOTE': '1', 04:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:36 INFO - 'NO_EM_RESTART': '1', 04:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:36 INFO - 'PWD': '/builds/slave/test', 04:13:36 INFO - 'SHELL': '/bin/bash', 04:13:36 INFO - 'SHLVL': '1', 04:13:36 INFO - 'TERM': 'linux', 04:13:36 INFO - 'TMOUT': '86400', 04:13:36 INFO - 'USER': 'cltbld', 04:13:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 04:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:36 INFO - '_': '/tools/buildbot/bin/python'} 04:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 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:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:39 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:39 INFO - Installing collected packages: mozsystemmonitor 04:13:39 INFO - Running setup.py install for mozsystemmonitor 04:13:39 INFO - Successfully installed mozsystemmonitor 04:13:39 INFO - Cleaning up... 04:13:39 INFO - Return code: 0 04:13:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:39 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:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:39 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:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:39 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 0x7f2375d62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, '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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 04:13:39 INFO - 'HOME': '/home/cltbld', 04:13:39 INFO - 'LANG': 'en_US.UTF-8', 04:13:39 INFO - 'LANGUAGE': 'en_US:en', 04:13:39 INFO - 'LOGNAME': 'cltbld', 04:13:39 INFO - 'MAIL': '/var/mail/cltbld', 04:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:39 INFO - 'MOZ_NO_REMOTE': '1', 04:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:39 INFO - 'NO_EM_RESTART': '1', 04:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:39 INFO - 'PWD': '/builds/slave/test', 04:13:39 INFO - 'SHELL': '/bin/bash', 04:13:39 INFO - 'SHLVL': '1', 04:13:39 INFO - 'TERM': 'linux', 04:13:39 INFO - 'TMOUT': '86400', 04:13:39 INFO - 'USER': 'cltbld', 04:13:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 04:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:39 INFO - '_': '/tools/buildbot/bin/python'} 04:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:39 INFO - Downloading/unpacking jsonschema==2.5.1 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:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:41 INFO - warning: no files found matching '*.txt' 04:13:41 INFO - no previously-included directories found matching 'build' 04:13:41 INFO - no previously-included directories found matching 'dist' 04:13:41 INFO - no previously-included directories found matching '.git*' 04:13:41 INFO - Installing collected packages: jsonschema, functools32 04:13:41 INFO - Running setup.py install for functools32 04:13:41 INFO - warning: no files found matching '*.txt' 04:13:41 INFO - no previously-included directories found matching 'build' 04:13:41 INFO - no previously-included directories found matching 'dist' 04:13:41 INFO - no previously-included directories found matching '.git*' 04:13:41 INFO - Successfully installed jsonschema functools32 04:13:41 INFO - Cleaning up... 04:13:41 INFO - Return code: 0 04:13:41 INFO - Installing blobuploader==1.2.4 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', '--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 0x7f2375d62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, '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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', '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', '--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:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 04:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:41 INFO - '_': '/tools/buildbot/bin/python'} 04:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:13:42 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:42 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:42 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:42 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:42 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:42 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:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:13:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:13:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:44 INFO - Downloading docopt-0.6.1.tar.gz 04:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:13:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:13:44 INFO - Running setup.py install for blobuploader 04:13:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:13:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:13:44 INFO - Running setup.py install for requests 04:13:45 INFO - Running setup.py install for docopt 04:13:45 INFO - Successfully installed blobuploader requests docopt 04:13:45 INFO - Cleaning up... 04:13:45 INFO - Return code: 0 04:13:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:45 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 0x7f2375d62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, '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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', '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:45 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:45 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:45 INFO - Using env: {'DISPLAY': ':0', 04:13:45 INFO - 'HOME': '/home/cltbld', 04:13:45 INFO - 'LANG': 'en_US.UTF-8', 04:13:45 INFO - 'LANGUAGE': 'en_US:en', 04:13:45 INFO - 'LOGNAME': 'cltbld', 04:13:45 INFO - 'MAIL': '/var/mail/cltbld', 04:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:45 INFO - 'MOZ_NO_REMOTE': '1', 04:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:45 INFO - 'NO_EM_RESTART': '1', 04:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:45 INFO - 'PWD': '/builds/slave/test', 04:13:45 INFO - 'SHELL': '/bin/bash', 04:13:45 INFO - 'SHLVL': '1', 04:13:45 INFO - 'TERM': 'linux', 04:13:45 INFO - 'TMOUT': '86400', 04:13:45 INFO - 'USER': 'cltbld', 04:13:45 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 04:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:45 INFO - '_': '/tools/buildbot/bin/python'} 04:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:45 INFO - Running setup.py (path:/tmp/pip-FsqoSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:45 INFO - Running setup.py (path:/tmp/pip-IpGrWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:45 INFO - Running setup.py (path:/tmp/pip-aoLIfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:45 INFO - Running setup.py (path:/tmp/pip-qTtJnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:45 INFO - Running setup.py (path:/tmp/pip-gW02QV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:45 INFO - Running setup.py (path:/tmp/pip-ne3t6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:46 INFO - Running setup.py (path:/tmp/pip-FO8abV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:46 INFO - Running setup.py (path:/tmp/pip-f0a0aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:46 INFO - Running setup.py (path:/tmp/pip-mKSCgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:46 INFO - Running setup.py (path:/tmp/pip-_Zp42_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:46 INFO - Running setup.py (path:/tmp/pip-E4KJZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:46 INFO - Running setup.py (path:/tmp/pip-8abe_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:46 INFO - Running setup.py (path:/tmp/pip-saepN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:46 INFO - Running setup.py (path:/tmp/pip-nno37j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:46 INFO - Running setup.py (path:/tmp/pip-Iwbgc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:46 INFO - Running setup.py (path:/tmp/pip-Fux0M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:46 INFO - Running setup.py (path:/tmp/pip-gONvYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:13:46 INFO - Running setup.py install for manifestparser 04:13:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:13:46 INFO - Running setup.py install for mozcrash 04:13:47 INFO - Running setup.py install for mozdebug 04:13:47 INFO - Running setup.py install for mozdevice 04:13:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:13:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:13:47 INFO - Running setup.py install for mozfile 04:13:47 INFO - Running setup.py install for mozhttpd 04:13:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:13:47 INFO - Running setup.py install for mozinfo 04:13:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:13:47 INFO - Running setup.py install for mozInstall 04:13:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:13:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:13:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:13:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:13:47 INFO - Running setup.py install for mozleak 04:13:47 INFO - Running setup.py install for mozlog 04:13:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:13:47 INFO - Running setup.py install for moznetwork 04:13:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:13:47 INFO - Running setup.py install for mozprocess 04:13:48 INFO - Running setup.py install for mozprofile 04:13:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:13:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:13:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:13:48 INFO - Running setup.py install for mozrunner 04:13:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:13:48 INFO - Running setup.py install for mozscreenshot 04:13:48 INFO - Running setup.py install for moztest 04:13:48 INFO - Running setup.py install for mozversion 04:13:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:13:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:13:48 INFO - Cleaning up... 04:13:48 INFO - Return code: 0 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/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 0x7f2375d62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, '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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', '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/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:48 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: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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:13:48 INFO - Running setup.py (path:/tmp/pip-CxJCMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:13:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:13:48 INFO - Running setup.py (path:/tmp/pip-x5hXvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:13:48 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:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:13:48 INFO - Running setup.py (path:/tmp/pip-2Y9UdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:13:49 INFO - Running setup.py (path:/tmp/pip-0aMZ2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:13:49 INFO - Running setup.py (path:/tmp/pip-1acsbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:13:49 INFO - Running setup.py (path:/tmp/pip-tsj6A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:13:49 INFO - Running setup.py (path:/tmp/pip-GHfmxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:13:49 INFO - Running setup.py (path:/tmp/pip-YU59eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:13:49 INFO - Running setup.py (path:/tmp/pip-hyfZvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:13:49 INFO - Running setup.py (path:/tmp/pip-xYr7dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:13:49 INFO - Running setup.py (path:/tmp/pip-i7gs76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:13:49 INFO - Running setup.py (path:/tmp/pip-Xi6_6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:13:49 INFO - Running setup.py (path:/tmp/pip-56XN1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:13:49 INFO - Running setup.py (path:/tmp/pip-IKg_TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:49 INFO - Running setup.py (path:/tmp/pip-02UI2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:13:49 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:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:13:49 INFO - Running setup.py (path:/tmp/pip-1E4r9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:13:50 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:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:13:50 INFO - Running setup.py (path:/tmp/pip-cfaKZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:13:50 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:50 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:50 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:50 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:50 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:50 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:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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 blessings-1.6.tar.gz 04:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:52 INFO - Installing collected packages: blessings 04:13:52 INFO - Running setup.py install for blessings 04:13:52 INFO - Successfully installed blessings 04:13:52 INFO - Cleaning up... 04:13:52 INFO - Return code: 0 04:13:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:52 INFO - Reading from file tmpfile_stdout 04:13:52 INFO - Current package versions: 04:13:52 INFO - argparse == 1.2.1 04:13:52 INFO - blessings == 1.6 04:13:52 INFO - blobuploader == 1.2.4 04:13:52 INFO - docopt == 0.6.1 04:13:52 INFO - functools32 == 3.2.3-2 04:13:52 INFO - jsonschema == 2.5.1 04:13:52 INFO - manifestparser == 1.1 04:13:52 INFO - mozInstall == 1.12 04:13:52 INFO - mozcrash == 0.17 04:13:52 INFO - mozdebug == 0.1 04:13:52 INFO - mozdevice == 0.48 04:13:52 INFO - mozfile == 1.2 04:13:52 INFO - mozhttpd == 0.7 04:13:52 INFO - mozinfo == 0.9 04:13:52 INFO - mozleak == 0.1 04:13:52 INFO - mozlog == 3.2 04:13:52 INFO - moznetwork == 0.27 04:13:52 INFO - mozprocess == 0.23 04:13:52 INFO - mozprofile == 0.28 04:13:52 INFO - mozrunner == 6.12 04:13:52 INFO - mozscreenshot == 0.1 04:13:52 INFO - mozsystemmonitor == 0.3 04:13:52 INFO - moztest == 0.7 04:13:52 INFO - mozversion == 1.4 04:13:52 INFO - psutil == 3.1.1 04:13:52 INFO - requests == 1.2.3 04:13:52 INFO - wsgiref == 0.1.2 04:13:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13: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:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 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 0x7f2375d62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, '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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 04:13:52 INFO - 'HOME': '/home/cltbld', 04:13:52 INFO - 'LANG': 'en_US.UTF-8', 04:13:52 INFO - 'LANGUAGE': 'en_US:en', 04:13:52 INFO - 'LOGNAME': 'cltbld', 04:13:52 INFO - 'MAIL': '/var/mail/cltbld', 04:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:52 INFO - 'MOZ_NO_REMOTE': '1', 04:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:52 INFO - 'NO_EM_RESTART': '1', 04:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:52 INFO - 'PWD': '/builds/slave/test', 04:13:52 INFO - 'SHELL': '/bin/bash', 04:13:52 INFO - 'SHLVL': '1', 04:13:52 INFO - 'TERM': 'linux', 04:13:52 INFO - 'TMOUT': '86400', 04:13:52 INFO - 'USER': 'cltbld', 04:13:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 04:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:52 INFO - '_': '/tools/buildbot/bin/python'} 04:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:52 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:52 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:52 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:52 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:52 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:52 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:52 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:52 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:52 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:52 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:52 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:52 INFO - Cleaning up... 04:13:52 INFO - Return code: 0 04:13:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13: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:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 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 0x7f2375d62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, '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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 04:13:52 INFO - 'HOME': '/home/cltbld', 04:13:52 INFO - 'LANG': 'en_US.UTF-8', 04:13:52 INFO - 'LANGUAGE': 'en_US:en', 04:13:52 INFO - 'LOGNAME': 'cltbld', 04:13:52 INFO - 'MAIL': '/var/mail/cltbld', 04:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:52 INFO - 'MOZ_NO_REMOTE': '1', 04:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:52 INFO - 'NO_EM_RESTART': '1', 04:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:52 INFO - 'PWD': '/builds/slave/test', 04:13:52 INFO - 'SHELL': '/bin/bash', 04:13:52 INFO - 'SHLVL': '1', 04:13:52 INFO - 'TERM': 'linux', 04:13:52 INFO - 'TMOUT': '86400', 04:13:52 INFO - 'USER': 'cltbld', 04:13:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 04:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:52 INFO - '_': '/tools/buildbot/bin/python'} 04:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:13:52 INFO - Cleaning up... 04:13:52 INFO - Return code: 0 04:13:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:13: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:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13: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:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 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 0x7f2375d62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, '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': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', '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:52 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:52 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:52 INFO - Using env: {'DISPLAY': ':0', 04:13:52 INFO - 'HOME': '/home/cltbld', 04:13:52 INFO - 'LANG': 'en_US.UTF-8', 04:13:52 INFO - 'LANGUAGE': 'en_US:en', 04:13:52 INFO - 'LOGNAME': 'cltbld', 04:13:52 INFO - 'MAIL': '/var/mail/cltbld', 04:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:52 INFO - 'MOZ_NO_REMOTE': '1', 04:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:52 INFO - 'NO_EM_RESTART': '1', 04:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:52 INFO - 'PWD': '/builds/slave/test', 04:13:52 INFO - 'SHELL': '/bin/bash', 04:13:52 INFO - 'SHLVL': '1', 04:13:52 INFO - 'TERM': 'linux', 04:13:52 INFO - 'TMOUT': '86400', 04:13:52 INFO - 'USER': 'cltbld', 04:13:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 04:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:52 INFO - '_': '/tools/buildbot/bin/python'} 04:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:53 INFO - Downloading/unpacking flake8 04:13:53 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:53 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:53 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:53 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:53 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:53 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:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:13:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:13:54 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:54 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:54 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:54 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:54 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:54 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:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:13:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:13:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:55 INFO - no previously-included directories found matching 'docs/_build' 04:13:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:13:55 INFO - Running setup.py install for pep8 04:13:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:55 INFO - no previously-included directories found matching 'docs/_build' 04:13:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:13:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:13:55 INFO - Cleaning up... 04:13:55 INFO - Return code: 0 04:13:55 INFO - Running post-action listener: _resource_record_post_action 04:13:55 INFO - Running post-action listener: _start_resource_monitoring 04:13:55 INFO - Starting resource monitoring. 04:13:55 INFO - ##### 04:13:55 INFO - ##### Finished create-virtualenv step (success) 04:13:55 INFO - ##### 04:13:55 INFO - ##### 04:13:55 INFO - ##### Running install step. 04:13:55 INFO - ##### 04:13:55 INFO - Running pre-action listener: _resource_record_pre_action 04:13:55 INFO - Running main action method: install 04:13:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:56 INFO - Reading from file tmpfile_stdout 04:13:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:56 INFO - Reading from file tmpfile_stdout 04:13:56 INFO - Output received: 04:13:56 INFO - Usage: mozinstall [options] installer 04:13:56 INFO - Options: 04:13:56 INFO - -h, --help show this help message and exit 04:13:56 INFO - -d DEST, --destination=DEST 04:13:56 INFO - Directory to install application into. [default: 04:13:56 INFO - "/builds/slave/test"] 04:13:56 INFO - --app=APP Application being installed. [default: firefox] 04:13:56 INFO - mkdir: /builds/slave/test/build/application 04:13:56 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:56 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:09 INFO - Reading from file tmpfile_stdout 04:14:09 INFO - Output received: 04:14:09 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:09 INFO - Running post-action listener: _resource_record_post_action 04:14:09 INFO - ##### 04:14:09 INFO - ##### Finished install step (success) 04:14:09 INFO - ##### 04:14:09 INFO - ##### 04:14:09 INFO - ##### Running run-tests step. 04:14:09 INFO - ##### 04:14:09 INFO - Running pre-action listener: _resource_record_pre_action 04:14:09 INFO - Running main action method: run_tests 04:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:09 INFO - Python 2.7.3 04:14:09 INFO - Return code: 0 04:14:09 INFO - grabbing minidump binary from tooltool 04:14:09 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:09 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 0x2b781c0>, '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 0x2b790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b79550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:09 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:09 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:09 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:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:09 INFO - Return code: 0 04:14:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:10 INFO - Return code: 0 04:14:10 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-020', '--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:10 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-020 --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:10 INFO - Using env: {'DISPLAY': ':0', 04:14:10 INFO - 'HOME': '/home/cltbld', 04:14:10 INFO - 'LANG': 'en_US.UTF-8', 04:14:10 INFO - 'LANGUAGE': 'en_US:en', 04:14:10 INFO - 'LOGNAME': 'cltbld', 04:14:10 INFO - 'MAIL': '/var/mail/cltbld', 04:14:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:10 INFO - 'MOZ_NO_REMOTE': '1', 04:14:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:10 INFO - 'NO_EM_RESTART': '1', 04:14:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:10 INFO - 'PWD': '/builds/slave/test', 04:14:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:10 INFO - 'SHELL': '/bin/bash', 04:14:10 INFO - 'SHLVL': '1', 04:14:10 INFO - 'TERM': 'linux', 04:14:10 INFO - 'TMOUT': '86400', 04:14:10 INFO - 'USER': 'cltbld', 04:14:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252', 04:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:10 INFO - '_': '/tools/buildbot/bin/python'} 04:14:10 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-020', '--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:10 INFO - mozversion application_buildid: 20160826110814 04:14:10 INFO - mozversion application_changeset: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f 04:14:10 INFO - mozversion application_display_name: Firefox 04:14:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:10 INFO - mozversion application_name: Firefox 04:14:10 INFO - mozversion application_remotingname: firefox 04:14:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:14:10 INFO - mozversion application_vendor: Mozilla 04:14:10 INFO - mozversion application_version: 49.0 04:14:10 INFO - mozversion platform_buildid: 20160826110814 04:14:10 INFO - mozversion platform_changeset: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f 04:14:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:14:10 INFO - mozversion platform_version: 49.0 04:14:10 INFO - using testdate: 1472382850 04:14:10 INFO - actual date: 1472382850 04:14:10 INFO - starting webserver on 'localhost:52822' 04:14:10 INFO - SUITE-START | Running 2 tests 04:14:10 INFO - TEST-START | dromaeo_css 04:14:10 INFO - operating with platform_type : linux_ 04:14:10 INFO - Initialising browser for dromaeo_css test... 04:14:10 INFO - TEST-INFO | started process 19092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphmLrCW/profile http://localhost:52822/getInfo.html) 04:14:15 INFO - PROCESS | 19092 | __metrics Screen width/height:1600/1200 04:14:15 INFO - PROCESS | 19092 | colorDepth:24 04:14:15 INFO - PROCESS | 19092 | Browser inner width/height: 1024/697 04:14:15 INFO - PROCESS | 19092 | __metrics 04:14:15 ERROR - PROCESS | 19092 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:14:16 INFO - TEST-INFO | 19092: exit 0 04:14:16 INFO - Browser initialized. 04:14:16 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:16 INFO - TEST-INFO | started process 19218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphmLrCW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:28 INFO - PROCESS | 19218 | RSS: Main: 152756224 04:14:28 INFO - PROCESS | 19218 | 04:15:18 INFO - PROCESS | 19218 | 1472382918025 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:26 INFO - PROCESS | 19218 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52822/tests/dromaeo/cssquery-ext.html) 04:17:27 INFO - PROCESS | 19218 | RSS: Main: 157356032 04:17:27 INFO - PROCESS | 19218 | 04:20:29 INFO - PROCESS | 19218 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-ext.html (next: http://localhost:52822/tests/dromaeo/cssquery-jquery.html) 04:20:29 INFO - PROCESS | 19218 | RSS: Main: 154685440 04:20:29 INFO - PROCESS | 19218 | 04:23:31 INFO - PROCESS | 19218 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52822/tests/dromaeo/cssquery-mootools.html) 04:23:31 INFO - PROCESS | 19218 | RSS: Main: 154804224 04:23:31 INFO - PROCESS | 19218 | 04:26:33 INFO - PROCESS | 19218 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52822/tests/dromaeo/cssquery-prototype.html) 04:26:34 INFO - PROCESS | 19218 | RSS: Main: 156164096 04:26:34 INFO - PROCESS | 19218 | 04:29:36 INFO - PROCESS | 19218 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52822/tests/dromaeo/cssquery-yui.html) 04:29:37 INFO - PROCESS | 19218 | RSS: Main: 154533888 04:29:37 INFO - PROCESS | 19218 | 04:32:39 INFO - PROCESS | 19218 | Cycle 1(1): loaded http://localhost:52822/tests/dromaeo/cssquery-yui.html (next: http://localhost:52822/tests/dromaeo/cssquery-dojo.html) 04:32:39 INFO - PROCESS | 19218 | RSS: Main: 158412800 04:32:39 INFO - PROCESS | 19218 | 04:32:39 INFO - PROCESS | 19218 | __start_tp_report 04:32:39 INFO - PROCESS | 19218 | _x_x_mozilla_page_load 04:32:39 INFO - PROCESS | 19218 | _x_x_mozilla_page_load_details 04:32:39 INFO - PROCESS | 19218 | |i|pagename|runs| 04:32:39 INFO - PROCESS | 19218 | |0;dojo.html;3341.5488908997286;3358.3451227010714;3401.965980340196;3413.573303337083;3425.9143521411947;5603.1595260710865;5626.015447296722;5639.323281206251;5672.234248376468;5727.198192253088;5642.7178641067985;5700.572457065716;5708.971455142719;5709.457601527859;5725.828225153242;5065.316182315377;5116.295295859023;5164.819231326905;5181.9740901295445;5208.427073021964;5096.210087436435;5104.872378190538;5194;5211.270422140903;5213.139831927728;5102.056119617864;5132.153194722885;5132.204508301201;5145.588352931756;5147.330846989905;5182.248573956793;5188.118019936601;5198.402183748861;5218.217267409881;5219.660722053054;4876.902461950776;4981.60515055785;4996.050750357421;5110.2590124431745;5120.871978200537;5507.752151153208;5509.090999984997;5516.393196748354;5543.501084902337;5550.72246387683;5998.610090344114;5999.580029397944;6011.609245399035;6014.7594096236535;6018.187544681456;5905.261842269716;5955.34491205967;5995.040793473067;6008.6094403864045;6075.696215189223;5622.297212848353;5635.436456354373;5637.661740295595;5638.859028524279;5651.180578816049;6135.846603834851;6161.599496032743;6179.598326108789;6198.256209254918;6199.690015499207;5767.480926716616;5840.941590584125;5889.234399528034;5919;5955.880882382415;5983.222181116427;6023.488003519662;6044.1840351552855;6066.787662431793;6086.178365920633;5754.280714910637;6017.669028203491;6024.3072046714315;6042.637441753509;6069.848253793602;5975.551833612496;6003.729832157564;6018.946684330224;6052.152698622196;6054.031354983182;4653.069386122789;4653.7207767534055;4662.860114196512;4667.883302917454;4695.131400690883;4110.691698122653;4111.09555897702;4163.604457576525;4169.583041695806;4200.663946884242;5641.323041235078;5732.971335143381;5754.539636829044;5766.163906233573;5813.273340832396;6083.5741498095595;6111.663858487826;6114.38856114385;6122.816315510542;6135.32511423743;5580.107182850725;5788.18965344852;5837.795677151279;5865.3254875689845;5866.794662186889;5240.9475905241225;5253.054450198924;5289.18017707256;5327.920081198785;5347.465253474699;6364.331745166691;6364.522660800459;6378.2346118466085;6380.521460890452;6414;5939.198208241832;6014.518838492822;6023.1868697726995;6155.938440615626;6166.969165154325;6255.343188965275;6261.123442718114;6267.2165979252595;6320.304766475592;6337.112804207507;5958.612690175125;5960.731767070579;5969.761209551743;5975.25309336333;6007.459328660441;5930.970345148246;5977.3424923257535;5990.760369585168;6024.548158888013;6109.419605137505;5842.883142337215;5862.736176872137;5899.439553242435;5906.497947674324;5907.438793314628;5855.063189889597;5896.027155519291;5900.055991041413;5900.085486749561;5907.113932910098;5709.486146246858;5778.046622307273;5781.219535362672;5840.357560668238;5907;5985.670788106696;6000.039993601003;6024.0662697282;6045.183900173421;6045.183900173596;5683.062294721325;5903.085021821625;5903.321118071477;5906.911396328973;5918.3489816121055 04:32:39 INFO - PROCESS | 19218 | |1;ext.html;577.5321989188758;620.8944479438495;641.0832509511398;646.6572716460278;653.2977049671604;44600.10799784002;45791;45910.540894591;50397.24404133941;50770;46097.76951115248;46593.76703116488;46718.766406168004;46746.53253467464;46867.76566117173;8740.781480463007;8973.77565560863;8978.28173746102;8980.146886045815;9001.909980900205;8906.777330566723;8952.507612081365;8969.865452018224;8972.50651214183;8978.775530611754;8991.955040224822;9016.729498115066;9055.411398259124;9083.364164508486;9103.54482275887;8916.687915922945;8971.372003959725;8974.371793974424;8980.730578082668;9011.864822027675;8715.346349023848;8882.822343553093;8905.332100092453;8910.376273660846;8955.865662015074;42745;42936.57063429357;43022.56977430217;43336.56663433357;43454.78272608649;3667.15655399257;3685.6682898538993;3861.594532574067;3878.45701601776;3938.6258305460933;33386.21013039612;33615;33674.49488257678;33950.151246219044;34235.657643423496;4044.474218351625;4080.2451546463703;4081.4694089768436;4160.83356665733;4229.72506787061;296879;297136.5143174292;298163;300630;300828;60481.69759151176;60551;60917;60919.69540152271;60938.69530652407;41352.58647413487;42174.57825421768;42360.36459453111;42481.36277955833;65249;19477.707834382494;19615.411537653894;19693;19716.40850774479;19763.703544446846;14648.12111273327;14657.48698795537;14659.34032968519;14728.484503042342;14764.48324308644;21173.15307387718;21221.36335909925;21495;21517.13931442756;21621;7423.369013633902;7500.924990750132;7567;7580.9620951894885;7789.298963093349;980.4117529482396;1103.475848971748;1117.586492997596;1143.5940241214416;1245.0662003497378;32564.511532327033;33625;33882;34914.47628285578;36877.446838297445;1112.6050252160528;1188.6909403555137;1189.8869607387285;1193.2244041373176;1262.50762202741;17147.389817064053;17252.051137187576;17378.47864564065;17575.560610984572;17715.379961701277;549712;603701;605167;611237;614093;58443.41556584465;63618.68190659017;64457;64560.35439645637;64725.35274647193;1474.2702362330715;1501.9549413517611;1517.3172072567388;1522.6726253855695;1536.9385224590892;33328.33343333168;34161.963251199486;34181.48727769036;34244.14389640279;34393.656063440045;56447.15329269982;56533.15200271917;57114.42885571091;57242.7137864308;57280.713596433416;486460;492062;493295;496510;499405;31285.687143129187;31732.524012139376;31753;31766.364672706877;31784.523232151074;51922.48077519176;52364.21453678122;52782.736086319324;52983.470165297855;53008.73495632497;43052.78473607612;43287.350689740306;44227;44379.77810110929;45549;42698.14603707971;42860.78569607132;43120.56879431291;43220.00976183109;43481.34777978269;43451.565484346014;43911;44218.557814421445;44565.777171113936;44702.552974469836;37428;37482.43776343302;37760.2447951034;38417.4237386445;38725;28163;29297.560536592395;30536.389272214874;30932.381352372377;30970.225744356572 04:32:39 INFO - PROCESS | 19218 | |2;jquery.html;433.59025720693916;438.6574303805006;440.37027051316613;444.08961628661257;445.9509453960062;18518.814811851877;19788;19967.60064798705;21166.365009049754;21190.364289071353;19416.902915485403;19562.678013112727;19741.111649975748;20278.49303767403;20352;5862.413758624136;6019.277686677583;6035.3059398169335;6083.057126145432;6085.969570152143;5783.595148339597;5886.617369870966;5953.928292907275;5955.136505206764;6005.249343832021;5903.763849446017;5927.911081333784;5937.079752638327;5943;5966.045432730764;5662.094064949609;5877.471027607536;5884.323302820188;5900.321463031763;5904.645721256717;5264.8683782905355;5307.389650190239;5309.920351194735;5314.468553144693;5315.973420132913;23341;23712.64431033536;24102;24170.637440438408;24395.390115247083;2356.5404746074523;2391.72495163055;2406;2450.718167410753;2460.4463995601027;14989.625259368495;15246.923765381212;15454.690906181926;15635.983661061995;15720.29258683362;2006.2276023730822;2039.58188571344;2049.354453347206;2052.784457631942;2068.9482762930897;76141.23858761397;79236.60381698054;81424.59287703583;81594.9999999994;82675.5866220671;10991.890081099087;11400.144989125849;11624.360660163773;11628.244164129474;11798.233114847508;16249;16291.674166516603;16292.918535407247;16341.101239431708;16356.83643163577;8845.336599754915;9064.365494415328;9087.863682044775;9138.567794619605;9201.30990175726;8792.208701216921;8859.601317940707;9022.323325750594;9054.728358149267;9103.954480227689;6907.965460172767;7072.575645461186;7077.7168913242895;7146.2496437874315;7213.511338588179;2025.6455120353878;2066.772655007948;2108.1040557763195;2112.704221409004;2153.644648632989;993.8558908958305;1078.1536493852288;1080.3140006096185;1138.9772204555863;1208.6857417071449;19267.51831204203;19686.803131968783;19731.112099955248;20254.594908101757;20543.28098516545;1069.3316677076828;1116.3469370418395;1129.2264798612812;1138.886111388871;1158.2934410009887;11254.21220514556;11467.139964502696;11484.88515114838;11652.53389864396;11724.706882327839;514984;516478;521495;542991;547870;80730.59634701788;82916;83714;84311.57844210739;84571.57714211389;1076.5855145768935;1097.040089921319;1101.5869049106584;1112.265904503024;1120.383788916093;17882.5529361767;18092.185851636445;18203.908980455013;18423.263069477605;18531.722024169918;38852.2229555413;39333.606663932995;39641.60358396379;40935;41206;53855;54069.45930540644;54183.45816541784;54262.45737542574;54639.45360546344;9137.360384773003;9179.990201077742;9204.125608067223;9204.125608067223;9300.767480812763;13315.26766027839;13394.464221431033;13401.195928244337;13488.797668035184;13762.862371376157;11636.12729045308;11970.461329240032;12014.939925300318;12284.01727861751;12292.569760058355;11641.825372619249;11700.590479333183;11867;12062.879371206176;12434.689132771753;11866.644000679993;12041.698957526132;12186.146969712036;12189.573364932185;12310.630681079581;8868.556572171494;8920.955395222982;8928.285737141143;8972.551372431222;9396;11810;11917.463714133059;11978.700532486757;11979.520819167135;12151.878481215075 04:32:39 INFO - PROCESS | 19218 | |3;mootools.html;1590.181056755771;1596.8802339824515;1811.3660218923378;1898.5763171809685;1908.4751693284345;8573.57132143392;9623;9713.125818676317;10356.948215258923;10362.740931476717;9707.174890134347;10037.548310326034;10070.345427547205;10077.69766906994;10102.545385457654;2320.5590937721777;2358.1864256831363;2361.2680069178523;2364.1489063937056;2369.490559529701;2426.259990702835;2447.229122826304;2465.90136394544;2481.4044629288933;2488.340589743719;2411.3489357873364;2443.535728211643;2481.4540801023745;2507.04732201764;2507.8746062696882;2339.3099035784485;2358.870262135582;2365.4795944892267;2366.5858474766933;2383.809295256375;2400.627902675088;2419.5644783938883;2436.281297017384;2451.5464639041834;2454.2514533067406;9915.206783457306;9980.05189507003;10028.64899728506;10046.69859904204;10050.89949100507;5822.767089316465;5938.554608404387;5953.880922381528;5954.374790647006;5971.283445986466;3644.9271014579826;3662.8717994870053;3673.430618254175;3693.9630603693886;3743.5507739071213;1162.0703437250165;1182.072073422368;1229.1334609100652;1238.0714464151886;1246.1214843535286;14375.496857610038;14554.272286385743;14556.927215363961;14571.854281457261;14573.125612463286;5077.111505486525;5142.6400151989;5219.530242278213;5223.738813059332;5259.8422047338645;12017.519299228108;12025.939870300592;12072.517099316105;12079.396030198455;12096.879031209752;5807.419258074159;5848.210491583582;5878.412158784087;5886.8822623547285;5892.558058145656;4488.820447182076;5017.096922553976;5125.077486052472;5145.639805213599;5380.085385484399;4387.8244870204835;4421.093675796454;4460.643148548108;4467.73193608378;4471.463424389029;1409.2460533614467;1414.6675531250148;1421.8364888038009;1436.7844823276591;1442.9855701443062;896.2426749396749;986.329296078659;1000.7097941596855;1003.2726273451835;1012.8075665623508;6194.473469755121;6253.749850005949;6308.873822523524;6344.841378965562;6609.702563384659;980.4362491567377;1047.2878442658912;1059.5496913811598;1073.683263437288;1073.909981368911;4023.738457000344;4027.8993025174605;4100.5489396166395;4168.937465938014;4212.431321771583;12248.81626775599;12396.31820249877;12616.936915315548;12625;12629.43167557462;12400.441980110916;12453.564125255754;12458.875411245952;12471.75056498865;12473.064520160842;8892.955535222283;8943.329250306253;9244.44533327989;9255;9459.668911588062;6516.6415847128865;6623.801285961429;6755.256921738703;6879.071325371011;6916.619585922823;10851.131909447384;11630.53477860876;11680.47437865281;11688.766224675628;11696.941515292368;11612.187146899636;11775.882241177822;11874.584389546324;11889.82165267539;11919.940400297943;8668.956655216683;8688.609012594576;8824.602892869709;8924.732258032269;8954.641814327353;9893.318135916767;9917.65288214909;9935.751606209902;9948.154406875497;9995.500224988868;8195.426320157532;8436.45163064399;8546.914530854861;8679.652813887375;8755.781105472413;8556.957215213884;8618.698345557876;8722.433041852513;8733.737987860375;8831.91168088311;7571.962140189484;7579.54522728638;7580.128285247047;7600.923990760021;7636.923630763621;5216.165413533817;5319.707416092152;5332.68003919766;5353.54494867925;5474.972625136849;5319.281896943863;5326.467353264643;5353.2505449237915;5365.061114304903;5386.811461598825 04:32:39 INFO - PROCESS | 19218 | |4;prototype.html;349.1985892376993;351.8346377202715;352.50649091272226;354.8296817527587;357.4870061461801;5712.428757124286;5803.332616749075;5816.243888294521;5852.239208902847;5860.677662728548;5724.2558467399285;5735.455131762486;5752.568557358204;5758.827235182941;5768.769249230026;4052.594740525946;4233.8094785734565;4327.221100201962;4423.911521769563;4435.268180750172;4415.249407600716;4428.092241090569;4437.5784300491405;4440.778785833889;4467.262901621229;4415;4419.182451246514;4421.159979603881;4429.667774916878;4456.153330867141;4334.154839806255;4405.722340521245;4412.823487060514;4418.9337159942625;4475.28395456727;3873.2447172801317;3905.9804700976597;3909.6676782473523;3911.5306163260307;3912.8043597819997;5507.284053073075;5507.972460137714;5546.833594992157;5578.856334451469;5581.939431508041;4974.9155523575255;5040.621953353513;5040.924386134211;5041.924371134436;5109.310243117206;5928.051511758141;5938.10928360745;5942.8811423771285;5957.225560677084;6046.486048685867;4309.78451077448;4333.501647310568;4338.067315527177;4341.370501277329;4350.543192964757;6024.819255422344;6149.938500615026;6168.87662246757;6218.751249949996;6226.2839773426185;4295.742255464682;4304.5910638489295;4328;4345.847895323648;4348.565143485689;4380.737155770664;4401.6478681705385;4424.535423780457;4434.534373890695;4443.400140980926;4905.533974272438;5035.697858128524;5081.72050537224;5093.796248150106;5100.744962751847;5933.317668468181;5999.880002399927;6029.698515074228;6033.879322413527;6039.577229593886;1478.1279045363287;1484.7253258147277;1486.8736157426524;1489.5680252726804;1492.7387707151206;926.3839546701369;962.5668449197749;966.8501382285757;973.8490533967247;976.8095221431895;5285.497877701612;5307.575393968474;5352.839414817562;5361.008213480519;5368.7047212403695;5549.7533942644;5598.804041858597;5606.411326810626;5615.943840561542;5619.286117734048;4899.452284811878;5180.886109486479;5232.2674825524455;5257.78968841242;5277.973610132001;2910.8399038052685;2939.2357986923125;2966.6143401358117;2972.7621790256726;2977.5087110626505;5719.7140142992685;5783.190353350535;5787.94212057874;5794.88410231793;5799.971000144972;5942.168096466498;6327.525435592349;6371.872562548816;6397.488200943913;6406.487481001602;6425.710843012076;6488.448481878999;6495.447886929664;6506.284308726036;6515.6742162892615;6017.368176341596;6188.659623720739;6227.595206311576;6269.404406581368;6294.433500984934;5937.881242375042;6128.693565321627;6172.382761723792;6177.135201071944;6190.442860142609;6480.675966201766;6481.967590162019;6482.611043337415;6490.675466226764;6509.707063182263;4317.913641727211;4344.869653910388;4377.037051848588;4378.277584198571;4404.185225733249;6167.167432396569;6167.383261673796;6258.463967858145;6313.684315784284;6329.386006568296;5957.8680050791945;6005.879882402415;6037.516998640186;6126.326104128631;6139.938600614116;5958.19564358806;6002.279726432681;6021.518278537619;6037.426444487766;6043.879122417615;5933.554983376178;5970.253718285215;5996.610220335664;6000.87998240024;6034.63792172471;6095.725692343766;6104.145419641165;6121.9390304847575;6129.509639228761;6138.263408391022;5641.5204707600315;5951.196588460502;5977.252843394575;5994.602159136381;6012.398760123952 04:32:39 INFO - PROCESS | 19218 | |5;yui.html;661.5170925224583;729.1468981291888;734.9306758666141;803.9678412863486;829.91700829917;15447;15948.68102637948;15963.600909977227;15992.640625546814;16145.11201883896;14747.48383806567;14798.704025919475;14824.110553366805;14831.629209269773;14863.554093377188;839.5214727605282;863.4430792139067;865.731623196811;867.535868310454;868.7089824908663;849.668629234599;851.642310229705;853.9316854651644;854.4531499840107;855.5380094748829;897.3090720145484;905.2983937448497;906.0893801729253;908.3323757038604;908.4776253654143;893.714011516315;894.217559635319;895.9104089591054;896.5114012863005;898.2454738020061;656.8423578341163;658.2989116590816;658.7035833874728;659.8119535932236;661.7882277671147;15318.617034574114;15319.617009574738;15394.076355418598;15428.537143885702;15451;15595.1422671753;15622.218889055503;15628.374865005386;15634.671052960512;15920.601984950354;11705.882941170565;11705.941470292679;11771.117166212483;12074.210762555449;12089.637310880687;3634.9818250908575;3648.41625339947;3702.2595480903656;3722.9069273268115;3757.1922036762226;78365.60817195878;79510;81096;81391;81712.59143704243;11057.723556911142;11059.502322395512;11217.551297948154;11309.886901131047;11357.659270221906;20292;20304.79695203029;20366;20388.490287742927;20445.48886277855;8126.10612832588;8131.796705082302;8254.504729716236;8262.628181731836;8282.378821588285;4999.450060493343;5006.4743201963265;5128.358955130609;5212.921806172911;5213.7393130343335;3465.8440370183403;3566.375884220251;3576.40989236773;3579.803110828929;3587.802670853076;650.2262307853639;657.8289644692414;664.6078813500059;668.8929771236578;682.4676752133344;735.3675838778646;775.1434664695543;788.5465857132172;803.6905791270403;807.1444269074799;9402.623895044122;9838.754031149136;9853.50732463374;9860.605575777032;9915.504224788732;574.954003679713;591.1782622155208;660.6366498425847;667.9866402671919;725.1769241910364;4234.301340278819;4273.18809426208;4316.43886294786;4389.40742999691;4519.796609152596;74824.62587687136;76564.61717691488;77054.61472692601;90401.54799226094;118562.4071879635;66411.33588664148;89542.55228723814;105493.47253263838;105679;109691;92213.5389323049;92432.53783731039;94262;95319;98408;8243.134470880472;8261.504309741435;8313.459625124347;8346.374021948257;8444.704435344733;52737.20894186667;53354.73322633362;53672.194917075496;55402.72298638481;55870;51197;79510.6024469874;80472.19527804646;81242;81251.5937420309;13001.284929328978;13569.457221711022;13641;13746.518871839839;14494.927525362305;14905.850941490446;14985.925070374578;15908.602284942968;16166.191690415668;16250.26873790706;14606.926965365104;14759.335829887466;15065.322060507084;15439.768403473732;15707.136107514196;14477.638059048608;14920.850791492381;15277.708343748081;15312.310946007234;15967.68064638724;14284.857151428352;14486.130832150106;14826.62933426673;15743.842561574238;15753.054816710575;12712.110152289251;12732.23606583608;12765.234085954873;13045.217286962812;13334.39995200199;12104.939475302566;12241.69395765113;12425.44085516172;12457.377131143588;12628.494860205856 04:32:39 INFO - PROCESS | 19218 | __end_tp_report 04:32:39 INFO - PROCESS | 19218 | __start_cc_report 04:32:39 INFO - PROCESS | 19218 | _x_x_mozilla_cycle_collect,337 04:32:39 INFO - PROCESS | 19218 | __end_cc_report 04:32:39 INFO - PROCESS | 19218 | __startTimestamp1472383959718__endTimestamp 04:32:39 INFO - PROCESS | 19218 | 04:32:39 INFO - PROCESS | 19218 | ------- Summary: start ------- 04:32:39 INFO - PROCESS | 19218 | Number of tests: 6 04:32:39 INFO - PROCESS | 19218 | 04:32:39 INFO - PROCESS | 19218 | [#0] dojo.html Cycles:165 Average:5623.53 Median:5855.06 stddev:623.96 (10.7%) stddev-sans-first:599.65 04:32:39 INFO - PROCESS | 19218 | Values: 3341.5 3358.3 3402.0 3413.6 3425.9 5603.2 5626.0 5639.3 5672.2 5727.2 5642.7 5700.6 5709.0 5709.5 5725.8 5065.3 5116.3 5164.8 5182.0 5208.4 5096.2 5104.9 5194.0 5211.3 5213.1 5102.1 5132.2 5132.2 5145.6 5147.3 5182.2 5188.1 5198.4 5218.2 5219.7 4876.9 4981.6 4996.1 5110.3 5120.9 5507.8 5509.1 5516.4 5543.5 5550.7 5998.6 5999.6 6011.6 6014.8 6018.2 5905.3 5955.3 5995.0 6008.6 6075.7 5622.3 5635.4 5637.7 5638.9 5651.2 6135.8 6161.6 6179.6 6198.3 6199.7 5767.5 5840.9 5889.2 5919.0 5955.9 5983.2 6023.5 6044.2 6066.8 6086.2 5754.3 6017.7 6024.3 6042.6 6069.8 5975.6 6003.7 6018.9 6052.2 6054.0 4653.1 4653.7 4662.9 4667.9 4695.1 4110.7 4111.1 4163.6 4169.6 4200.7 5641.3 5733.0 5754.5 5766.2 5813.3 6083.6 6111.7 6114.4 6122.8 6135.3 5580.1 5788.2 5837.8 5865.3 5866.8 5240.9 5253.1 5289.2 5327.9 5347.5 6364.3 6364.5 6378.2 6380.5 6414.0 5939.2 6014.5 6023.2 6155.9 6167.0 6255.3 6261.1 6267.2 6320.3 6337.1 5958.6 5960.7 5969.8 5975.3 6007.5 5931.0 5977.3 5990.8 6024.5 6109.4 5842.9 5862.7 5899.4 5906.5 5907.4 5855.1 5896.0 5900.1 5900.1 5907.1 5709.5 5778.0 5781.2 5840.4 5907.0 5985.7 6000.0 6024.1 6045.2 6045.2 5683.1 5903.1 5903.3 5906.9 5918.3 04:32:39 INFO - PROCESS | 19218 | 04:32:39 INFO - PROCESS | 19218 | [#1] ext.html Cycles:180 Average:63263.58 Median:43253.68 stddev:127522.58 (294.8%) stddev-sans-first:127793.46 04:32:39 INFO - PROCESS | 19218 | Values: 577.5 620.9 641.1 646.7 653.3 44600.1 45791.0 45910.5 50397.2 50770.0 46097.8 46593.8 46718.8 46746.5 46867.8 8740.8 8973.8 8978.3 8980.1 9001.9 8906.8 8952.5 8969.9 8972.5 8978.8 8992.0 9016.7 9055.4 9083.4 9103.5 8916.7 8971.4 8974.4 8980.7 9011.9 8715.3 8882.8 8905.3 8910.4 8955.9 42745.0 42936.6 43022.6 43336.6 43454.8 3667.2 3685.7 3861.6 3878.5 3938.6 33386.2 33615.0 33674.5 33950.2 34235.7 4044.5 4080.2 4081.5 4160.8 4229.7 296879.0 297136.5 298163.0 300630.0 300828.0 60481.7 60551.0 60917.0 60919.7 60938.7 41352.6 42174.6 42360.4 42481.4 65249.0 19477.7 19615.4 19693.0 19716.4 19763.7 14648.1 14657.5 14659.3 14728.5 14764.5 21173.2 21221.4 21495.0 21517.1 21621.0 7423.4 7500.9 7567.0 7581.0 7789.3 980.4 1103.5 1117.6 1143.6 1245.1 32564.5 33625.0 33882.0 34914.5 36877.4 1112.6 1188.7 1189.9 1193.2 1262.5 17147.4 17252.1 17378.5 17575.6 17715.4 549712.0 603701.0 605167.0 611237.0 614093.0 58443.4 63618.7 64457.0 64560.4 64725.4 1474.3 1502.0 1517.3 1522.7 1536.9 33328.3 34162.0 34181.5 34244.1 34393.7 56447.2 56533.2 57114.4 57242.7 57280.7 486460.0 492062.0 493295.0 496510.0 499405.0 31285.7 31732.5 31753.0 31766.4 31784.5 51922.5 52364.2 52782.7 52983.5 53008.7 43052.8 43287.4 44227.0 44379.8 45549.0 42698.1 42860.8 43120.6 43220.0 43481.3 43451.6 43911.0 44218.6 44565.8 44702.6 37428.0 37482.4 37760.2 38417.4 38725.0 28163.0 29297.6 30536.4 30932.4 30970.2 04:32:39 INFO - PROCESS | 19218 | 04:32:39 INFO - PROCESS | 19218 | [#2] jquery.html Cycles:180 Average:30206.12 Median:13034.59 stddev:86690.07 (665.1%) stddev-sans-first:86904.43 04:32:39 INFO - PROCESS | 19218 | Values: 433.6 438.7 440.4 444.1 446.0 18518.8 19788.0 19967.6 21166.4 21190.4 19416.9 19562.7 19741.1 20278.5 20352.0 5862.4 6019.3 6035.3 6083.1 6086.0 5783.6 5886.6 5953.9 5955.1 6005.2 5903.8 5927.9 5937.1 5943.0 5966.0 5662.1 5877.5 5884.3 5900.3 5904.6 5264.9 5307.4 5309.9 5314.5 5316.0 23341.0 23712.6 24102.0 24170.6 24395.4 2356.5 2391.7 2406.0 2450.7 2460.4 14989.6 15246.9 15454.7 15636.0 15720.3 2006.2 2039.6 2049.4 2052.8 2068.9 76141.2 79236.6 81424.6 81595.0 82675.6 10991.9 11400.1 11624.4 11628.2 11798.2 16249.0 16291.7 16292.9 16341.1 16356.8 8845.3 9064.4 9087.9 9138.6 9201.3 8792.2 8859.6 9022.3 9054.7 9104.0 6908.0 7072.6 7077.7 7146.2 7213.5 2025.6 2066.8 2108.1 2112.7 2153.6 993.9 1078.2 1080.3 1139.0 1208.7 19267.5 19686.8 19731.1 20254.6 20543.3 1069.3 1116.3 1129.2 1138.9 1158.3 11254.2 11467.1 11484.9 11652.5 11724.7 514984.0 516478.0 521495.0 542991.0 547870.0 80730.6 82916.0 83714.0 84311.6 84571.6 1076.6 1097.0 1101.6 1112.3 1120.4 17882.6 18092.2 18203.9 18423.3 18531.7 38852.2 39333.6 39641.6 40935.0 41206.0 53855.0 54069.5 54183.5 54262.5 54639.5 9137.4 9180.0 9204.1 9204.1 9300.8 13315.3 13394.5 13401.2 13488.8 13762.9 11636.1 11970.5 12014.9 12284.0 12292.6 11641.8 11700.6 11867.0 12062.9 12434.7 11866.6 12041.7 12186.1 12189.6 12310.6 8868.6 8921.0 8928.3 8972.6 9396.0 11810.0 11917.5 11978.7 11979.5 12151.9 04:32:39 INFO - PROCESS | 19218 | 04:32:39 INFO - PROCESS | 19218 | [#3] mootools.html Cycles:180 Average:6495.21 Median:3883.64 stddev:3866.93 (99.6%) stddev-sans-first:3860.21 04:32:39 INFO - PROCESS | 19218 | Values: 1590.2 1596.9 1811.4 1898.6 1908.5 8573.6 9623.0 9713.1 10356.9 10362.7 9707.2 10037.5 10070.3 10077.7 10102.5 2320.6 2358.2 2361.3 2364.1 2369.5 2426.3 2447.2 2465.9 2481.4 2488.3 2411.3 2443.5 2481.5 2507.0 2507.9 2339.3 2358.9 2365.5 2366.6 2383.8 2400.6 2419.6 2436.3 2451.5 2454.3 9915.2 9980.1 10028.6 10046.7 10050.9 5822.8 5938.6 5953.9 5954.4 5971.3 3644.9 3662.9 3673.4 3694.0 3743.6 1162.1 1182.1 1229.1 1238.1 1246.1 14375.5 14554.3 14556.9 14571.9 14573.1 5077.1 5142.6 5219.5 5223.7 5259.8 12017.5 12025.9 12072.5 12079.4 12096.9 5807.4 5848.2 5878.4 5886.9 5892.6 4488.8 5017.1 5125.1 5145.6 5380.1 4387.8 4421.1 4460.6 4467.7 4471.5 1409.2 1414.7 1421.8 1436.8 1443.0 896.2 986.3 1000.7 1003.3 1012.8 6194.5 6253.7 6308.9 6344.8 6609.7 980.4 1047.3 1059.5 1073.7 1073.9 4023.7 4027.9 4100.5 4168.9 4212.4 12248.8 12396.3 12616.9 12625.0 12629.4 12400.4 12453.6 12458.9 12471.8 12473.1 8893.0 8943.3 9244.4 9255.0 9459.7 6516.6 6623.8 6755.3 6879.1 6916.6 10851.1 11630.5 11680.5 11688.8 11696.9 11612.2 11775.9 11874.6 11889.8 11919.9 8669.0 8688.6 8824.6 8924.7 8954.6 9893.3 9917.7 9935.8 9948.2 9995.5 8195.4 8436.5 8546.9 8679.7 8755.8 8557.0 8618.7 8722.4 8733.7 8831.9 7572.0 7579.5 7580.1 7600.9 7636.9 5216.2 5319.7 5332.7 5353.5 5475.0 5319.3 5326.5 5353.3 5365.1 5386.8 04:32:39 INFO - PROCESS | 19218 | 04:32:39 INFO - PROCESS | 19218 | [#4] prototype.html Cycles:180 Average:4993.91 Median:5676.97 stddev:1498.21 (26.4%) stddev-sans-first:1461.29 04:32:39 INFO - PROCESS | 19218 | Values: 349.2 351.8 352.5 354.8 357.5 5712.4 5803.3 5816.2 5852.2 5860.7 5724.3 5735.5 5752.6 5758.8 5768.8 4052.6 4233.8 4327.2 4423.9 4435.3 4415.2 4428.1 4437.6 4440.8 4467.3 4415.0 4419.2 4421.2 4429.7 4456.2 4334.2 4405.7 4412.8 4418.9 4475.3 3873.2 3906.0 3909.7 3911.5 3912.8 5507.3 5508.0 5546.8 5578.9 5581.9 4974.9 5040.6 5040.9 5041.9 5109.3 5928.1 5938.1 5942.9 5957.2 6046.5 4309.8 4333.5 4338.1 4341.4 4350.5 6024.8 6149.9 6168.9 6218.8 6226.3 4295.7 4304.6 4328.0 4345.8 4348.6 4380.7 4401.6 4424.5 4434.5 4443.4 4905.5 5035.7 5081.7 5093.8 5100.7 5933.3 5999.9 6029.7 6033.9 6039.6 1478.1 1484.7 1486.9 1489.6 1492.7 926.4 962.6 966.9 973.8 976.8 5285.5 5307.6 5352.8 5361.0 5368.7 5549.8 5598.8 5606.4 5615.9 5619.3 4899.5 5180.9 5232.3 5257.8 5278.0 2910.8 2939.2 2966.6 2972.8 2977.5 5719.7 5783.2 5787.9 5794.9 5800.0 5942.2 6327.5 6371.9 6397.5 6406.5 6425.7 6488.4 6495.4 6506.3 6515.7 6017.4 6188.7 6227.6 6269.4 6294.4 5937.9 6128.7 6172.4 6177.1 6190.4 6480.7 6482.0 6482.6 6490.7 6509.7 4317.9 4344.9 4377.0 4378.3 4404.2 6167.2 6167.4 6258.5 6313.7 6329.4 5957.9 6005.9 6037.5 6126.3 6139.9 5958.2 6002.3 6021.5 6037.4 6043.9 5933.6 5970.3 5996.6 6000.9 6034.6 6095.7 6104.1 6121.9 6129.5 6138.3 5641.5 5951.2 5977.3 5994.6 6012.4 04:32:39 INFO - PROCESS | 19218 | 04:32:39 INFO - PROCESS | 19218 | [#5] yui.html Cycles:180 Average:20608.72 Median:28101.74 stddev:28678.07 (102.1%) stddev-sans-first:28719.41 04:32:39 INFO - PROCESS | 19218 | Values: 661.5 729.1 734.9 804.0 829.9 15447.0 15948.7 15963.6 15992.6 16145.1 14747.5 14798.7 14824.1 14831.6 14863.6 839.5 863.4 865.7 867.5 868.7 849.7 851.6 853.9 854.5 855.5 897.3 905.3 906.1 908.3 908.5 893.7 894.2 895.9 896.5 898.2 656.8 658.3 658.7 659.8 661.8 15318.6 15319.6 15394.1 15428.5 15451.0 15595.1 15622.2 15628.4 15634.7 15920.6 11705.9 11705.9 11771.1 12074.2 12089.6 3635.0 3648.4 3702.3 3722.9 3757.2 78365.6 79510.0 81096.0 81391.0 81712.6 11057.7 11059.5 11217.6 11309.9 11357.7 20292.0 20304.8 20366.0 20388.5 20445.5 8126.1 8131.8 8254.5 8262.6 8282.4 4999.5 5006.5 5128.4 5212.9 5213.7 3465.8 3566.4 3576.4 3579.8 3587.8 650.2 657.8 664.6 668.9 682.5 735.4 775.1 788.5 803.7 807.1 9402.6 9838.8 9853.5 9860.6 9915.5 575.0 591.2 660.6 668.0 725.2 4234.3 4273.2 4316.4 4389.4 4519.8 74824.6 76564.6 77054.6 90401.5 118562.4 66411.3 89542.6 105493.5 105679.0 109691.0 92213.5 92432.5 94262.0 95319.0 98408.0 8243.1 8261.5 8313.5 8346.4 8444.7 52737.2 53354.7 53672.2 55402.7 55870.0 51197.0 79510.6 80472.2 81242.0 81251.6 13001.3 13569.5 13641.0 13746.5 14494.9 14905.9 14985.9 15908.6 16166.2 16250.3 14606.9 14759.3 15065.3 15439.8 15707.1 14477.6 14920.9 15277.7 15312.3 15967.7 14284.9 14486.1 14826.6 15743.8 15753.1 12712.1 12732.2 12765.2 13045.2 13334.4 12104.9 12241.7 12425.4 12457.4 12628.5 04:32:39 INFO - PROCESS | 19218 | -------- Summary: end -------- 04:32:39 INFO - PROCESS | 19218 | 04:32:40 INFO - TEST-INFO | 19218: exit 0 04:32:40 INFO - TEST-OK | dromaeo_css | took 1109881ms 04:32:40 INFO - TEST-START | kraken 04:32:40 INFO - operating with platform_type : linux_ 04:32:40 INFO - Initialising browser for kraken test... 04:32:40 INFO - TEST-INFO | started process 19462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYHnMF5/profile http://localhost:52822/getInfo.html) 04:32:45 INFO - PROCESS | 19462 | __metrics Screen width/height:1600/1200 04:32:45 INFO - PROCESS | 19462 | colorDepth:24 04:32:45 INFO - PROCESS | 19462 | Browser inner width/height: 1024/697 04:32:45 INFO - PROCESS | 19462 | __metrics 04:32:45 ERROR - PROCESS | 19462 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 04:32:46 INFO - TEST-INFO | 19462: exit 0 04:32:46 INFO - Browser initialized. 04:32:46 INFO - Running cycle 1/1 for kraken test... 04:32:46 INFO - TEST-INFO | started process 19587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYHnMF5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:58 INFO - PROCESS | 19587 | RSS: Main: 152883200 04:32:58 INFO - PROCESS | 19587 | 04:33:00 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52822/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:01 INFO - PROCESS | 19587 | RSS: Main: 157700096 04:33:01 INFO - PROCESS | 19587 | 04:33:04 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52822/tests/kraken/driver.html?testName=audio-dft) 04:33:05 INFO - PROCESS | 19587 | RSS: Main: 157016064 04:33:05 INFO - PROCESS | 19587 | 04:33:07 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52822/tests/kraken/driver.html?testName=audio-fft) 04:33:08 INFO - PROCESS | 19587 | RSS: Main: 158031872 04:33:08 INFO - PROCESS | 19587 | 04:33:10 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52822/tests/kraken/driver.html?testName=audio-oscillator) 04:33:11 INFO - PROCESS | 19587 | RSS: Main: 157286400 04:33:11 INFO - PROCESS | 19587 | 04:33:13 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:13 INFO - PROCESS | 19587 | RSS: Main: 157249536 04:33:13 INFO - PROCESS | 19587 | 04:33:17 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52822/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:17 INFO - PROCESS | 19587 | RSS: Main: 157376512 04:33:17 INFO - PROCESS | 19587 | 04:33:21 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52822/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:21 INFO - PROCESS | 19587 | RSS: Main: 157155328 04:33:21 INFO - PROCESS | 19587 | 04:33:24 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52822/tests/kraken/driver.html?testName=json-parse-financial) 04:33:25 INFO - PROCESS | 19587 | RSS: Main: 157704192 04:33:25 INFO - PROCESS | 19587 | 04:33:26 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:27 INFO - PROCESS | 19587 | RSS: Main: 157380608 04:33:27 INFO - PROCESS | 19587 | 04:33:29 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:29 INFO - PROCESS | 19587 | RSS: Main: 157642752 04:33:29 INFO - PROCESS | 19587 | 04:33:31 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:32 INFO - PROCESS | 19587 | RSS: Main: 157499392 04:33:32 INFO - PROCESS | 19587 | 04:33:34 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:33:35 INFO - PROCESS | 19587 | RSS: Main: 158248960 04:33:35 INFO - PROCESS | 19587 | 04:33:38 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:33:38 INFO - PROCESS | 19587 | RSS: Main: 157958144 04:33:38 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | Cycle 1(1): loaded http://localhost:52822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52822/tests/kraken/driver.html?testName=ai-astar) 04:33:40 INFO - PROCESS | 19587 | RSS: Main: 158404608 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | __start_tp_report 04:33:40 INFO - PROCESS | 19587 | _x_x_mozilla_page_load 04:33:40 INFO - PROCESS | 19587 | _x_x_mozilla_page_load_details 04:33:40 INFO - PROCESS | 19587 | |i|pagename|runs| 04:33:40 INFO - PROCESS | 19587 | |0;ai-astar;110;106;112;113;112;113;113;110;110;110 04:33:40 INFO - PROCESS | 19587 | |1;audio-beat-detection;157;127;160;186;130;153;156;125;183;130 04:33:40 INFO - PROCESS | 19587 | |2;audio-dft;170;163;164;163;162;166;162;162;161;162 04:33:40 INFO - PROCESS | 19587 | |3;audio-fft;75;75;76;173;76;76;75;76;185;76 04:33:40 INFO - PROCESS | 19587 | |4;audio-oscillator;86;85;149;85;85;85;140;87;84;139 04:33:40 INFO - PROCESS | 19587 | |5;imaging-gaussian-blur;118;117;117;117;119;117;117;118;118;117 04:33:40 INFO - PROCESS | 19587 | |6;imaging-darkroom;146;147;147;146;146;148;147;147;147;147 04:33:40 INFO - PROCESS | 19587 | |7;imaging-desaturate;95;96;97;96;95;96;95;97;95;95 04:33:40 INFO - PROCESS | 19587 | |8;json-parse-financial;53;56;58;54;54;55;56;54;56;55 04:33:40 INFO - PROCESS | 19587 | |9;json-stringify-tinderbox;61;63;62;62;61;61;61;61;65;64 04:33:40 INFO - PROCESS | 19587 | |10;stanford-crypto-aes;77;77;78;78;82;78;76;78;103;77 04:33:40 INFO - PROCESS | 19587 | |11;stanford-crypto-ccm;125;124;126;118;132;130;127;132;129;130 04:33:40 INFO - PROCESS | 19587 | |12;stanford-crypto-pbkdf2;157;157;157;153;152;155;153;155;155;159 04:33:40 INFO - PROCESS | 19587 | |13;stanford-crypto-sha256-iterative;65;63;67;61;66;63;62;63;66;66 04:33:40 INFO - PROCESS | 19587 | __end_tp_report 04:33:40 INFO - PROCESS | 19587 | __start_cc_report 04:33:40 INFO - PROCESS | 19587 | _x_x_mozilla_cycle_collect,861 04:33:40 INFO - PROCESS | 19587 | __end_cc_report 04:33:40 INFO - PROCESS | 19587 | __startTimestamp1472384020692__endTimestamp 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | ------- Summary: start ------- 04:33:40 INFO - PROCESS | 19587 | Number of tests: 14 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.18 (1.9%) stddev-sans-first:2.29 04:33:40 INFO - PROCESS | 19587 | Values: 110.0 106.0 112.0 113.0 112.0 113.0 113.0 110.0 110.0 110.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:156.50 stddev:22.43 (14.3%) stddev-sans-first:23.67 04:33:40 INFO - PROCESS | 19587 | Values: 157.0 127.0 160.0 186.0 130.0 153.0 156.0 125.0 183.0 130.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.68 (1.6%) stddev-sans-first:1.48 04:33:40 INFO - PROCESS | 19587 | Values: 170.0 163.0 164.0 163.0 162.0 166.0 162.0 162.0 161.0 162.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#3] audio-fft Cycles:10 Average:96.30 Median:76.00 stddev:43.68 (57.5%) stddev-sans-first:45.65 04:33:40 INFO - PROCESS | 19587 | Values: 75.0 75.0 76.0 173.0 76.0 76.0 75.0 76.0 185.0 76.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.00 stddev:27.85 (32.8%) stddev-sans-first:28.89 04:33:40 INFO - PROCESS | 19587 | Values: 86.0 85.0 149.0 85.0 85.0 85.0 140.0 87.0 84.0 139.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 04:33:40 INFO - PROCESS | 19587 | Values: 118.0 117.0 117.0 117.0 119.0 117.0 117.0 118.0 118.0 117.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 04:33:40 INFO - PROCESS | 19587 | Values: 146.0 147.0 147.0 146.0 146.0 148.0 147.0 147.0 147.0 147.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 04:33:40 INFO - PROCESS | 19587 | Values: 95.0 96.0 97.0 96.0 95.0 96.0 95.0 97.0 95.0 95.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.45 (2.6%) stddev-sans-first:1.32 04:33:40 INFO - PROCESS | 19587 | Values: 53.0 56.0 58.0 54.0 54.0 55.0 56.0 54.0 56.0 55.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.45 (2.3%) stddev-sans-first:1.48 04:33:40 INFO - PROCESS | 19587 | Values: 61.0 63.0 62.0 62.0 61.0 61.0 61.0 61.0 65.0 64.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:78.00 stddev:8.10 (10.4%) stddev-sans-first:8.50 04:33:40 INFO - PROCESS | 19587 | Values: 77.0 77.0 78.0 78.0 82.0 78.0 76.0 78.0 103.0 77.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:129.50 stddev:4.30 (3.3%) stddev-sans-first:4.48 04:33:40 INFO - PROCESS | 19587 | Values: 125.0 124.0 126.0 118.0 132.0 130.0 127.0 132.0 129.0 130.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:156.00 stddev:2.21 (1.4%) stddev-sans-first:2.26 04:33:40 INFO - PROCESS | 19587 | Values: 157.0 157.0 157.0 153.0 152.0 155.0 153.0 155.0 155.0 159.0 04:33:40 INFO - PROCESS | 19587 | 04:33:40 INFO - PROCESS | 19587 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:65.50 stddev:2.04 (3.1%) stddev-sans-first:2.15 04:33:40 INFO - PROCESS | 19587 | Values: 65.0 63.0 67.0 61.0 66.0 63.0 62.0 63.0 66.0 66.0 04:33:40 INFO - PROCESS | 19587 | -------- Summary: end -------- 04:33:40 INFO - PROCESS | 19587 | 04:33:41 INFO - TEST-INFO | 19587: exit 0 04:33:41 INFO - TEST-OK | kraken | took 61211ms 04:33:41 INFO - SUITE-END | took 1171s 04:33:41 INFO - Completed test suite (00:19:31) 04:33:41 INFO - javascript benchmark 04:33:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7683.532291616651, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3341.5488908997286, 3358.3451227010714, 3401.965980340196, 3413.573303337083, 3425.9143521411947, 5603.1595260710865, 5626.015447296722, 5639.323281206251, 5672.234248376468, 5727.198192253088, 5642.7178641067985, 5700.572457065716, 5708.971455142719, 5709.457601527859, 5725.828225153242, 5065.316182315377, 5116.295295859023, 5164.819231326905, 5181.9740901295445, 5208.427073021964, 5096.210087436435, 5104.872378190538, 5194.0, 5211.270422140903, 5213.139831927728, 5102.056119617864, 5132.153194722885, 5132.204508301201, 5145.588352931756, 5147.330846989905, 5182.248573956793, 5188.118019936601, 5198.402183748861, 5218.217267409881, 5219.660722053054, 4876.902461950776, 4981.60515055785, 4996.050750357421, 5110.2590124431745, 5120.871978200537, 5507.752151153208, 5509.090999984997, 5516.393196748354, 5543.501084902337, 5550.72246387683, 5998.610090344114, 5999.580029397944, 6011.609245399035, 6014.7594096236535, 6018.187544681456, 5905.261842269716, 5955.34491205967, 5995.040793473067, 6008.6094403864045, 6075.696215189223, 5622.297212848353, 5635.436456354373, 5637.661740295595, 5638.859028524279, 5651.180578816049, 6135.846603834851, 6161.599496032743, 6179.598326108789, 6198.256209254918, 6199.690015499207, 5767.480926716616, 5840.941590584125, 5889.234399528034, 5919.0, 5955.880882382415, 5983.222181116427, 6023.488003519662, 6044.1840351552855, 6066.787662431793, 6086.178365920633, 5754.280714910637, 6017.669028203491, 6024.3072046714315, 6042.637441753509, 6069.848253793602, 5975.551833612496, 6003.729832157564, 6018.946684330224, 6052.152698622196, 6054.031354983182, 4653.069386122789, 4653.7207767534055, 4662.860114196512, 4667.883302917454, 4695.131400690883, 4110.691698122653, 4111.09555897702, 4163.604457576525, 4169.583041695806, 4200.663946884242, 5641.323041235078, 5732.971335143381, 5754.539636829044, 5766.163906233573, 5813.273340832396, 6083.5741498095595, 6111.663858487826, 6114.38856114385, 6122.816315510542, 6135.32511423743, 5580.107182850725, 5788.18965344852, 5837.795677151279, 5865.3254875689845, 5866.794662186889, 5240.9475905241225, 5253.054450198924, 5289.18017707256, 5327.920081198785, 5347.465253474699, 6364.331745166691, 6364.522660800459, 6378.2346118466085, 6380.521460890452, 6414.0, 5939.198208241832, 6014.518838492822, 6023.1868697726995, 6155.938440615626, 6166.969165154325, 6255.343188965275, 6261.123442718114, 6267.2165979252595, 6320.304766475592, 6337.112804207507, 5958.612690175125, 5960.731767070579, 5969.761209551743, 5975.25309336333, 6007.459328660441, 5930.970345148246, 5977.3424923257535, 5990.760369585168, 6024.548158888013, 6109.419605137505, 5842.883142337215, 5862.736176872137, 5899.439553242435, 5906.497947674324, 5907.438793314628, 5855.063189889597, 5896.027155519291, 5900.055991041413, 5900.085486749561, 5907.113932910098, 5709.486146246858, 5778.046622307273, 5781.219535362672, 5840.357560668238, 5907.0, 5985.670788106696, 6000.039993601003, 6024.0662697282, 6045.183900173421, 6045.183900173596, 5683.062294721325, 5903.085021821625, 5903.321118071477, 5906.911396328973, 5918.3489816121055], "value": 5583.031991530048, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.5321989188758, 620.8944479438495, 641.0832509511398, 646.6572716460278, 653.2977049671604, 44600.10799784002, 45791.0, 45910.540894591, 50397.24404133941, 50770.0, 46097.76951115248, 46593.76703116488, 46718.766406168004, 46746.53253467464, 46867.76566117173, 8740.781480463007, 8973.77565560863, 8978.28173746102, 8980.146886045815, 9001.909980900205, 8906.777330566723, 8952.507612081365, 8969.865452018224, 8972.50651214183, 8978.775530611754, 8991.955040224822, 9016.729498115066, 9055.411398259124, 9083.364164508486, 9103.54482275887, 8916.687915922945, 8971.372003959725, 8974.371793974424, 8980.730578082668, 9011.864822027675, 8715.346349023848, 8882.822343553093, 8905.332100092453, 8910.376273660846, 8955.865662015074, 42745.0, 42936.57063429357, 43022.56977430217, 43336.56663433357, 43454.78272608649, 3667.15655399257, 3685.6682898538993, 3861.594532574067, 3878.45701601776, 3938.6258305460933, 33386.21013039612, 33615.0, 33674.49488257678, 33950.151246219044, 34235.657643423496, 4044.474218351625, 4080.2451546463703, 4081.4694089768436, 4160.83356665733, 4229.72506787061, 296879.0, 297136.5143174292, 298163.0, 300630.0, 300828.0, 60481.69759151176, 60551.0, 60917.0, 60919.69540152271, 60938.69530652407, 41352.58647413487, 42174.57825421768, 42360.36459453111, 42481.36277955833, 65249.0, 19477.707834382494, 19615.411537653894, 19693.0, 19716.40850774479, 19763.703544446846, 14648.12111273327, 14657.48698795537, 14659.34032968519, 14728.484503042342, 14764.48324308644, 21173.15307387718, 21221.36335909925, 21495.0, 21517.13931442756, 21621.0, 7423.369013633902, 7500.924990750132, 7567.0, 7580.9620951894885, 7789.298963093349, 980.4117529482396, 1103.475848971748, 1117.586492997596, 1143.5940241214416, 1245.0662003497378, 32564.511532327033, 33625.0, 33882.0, 34914.47628285578, 36877.446838297445, 1112.6050252160528, 1188.6909403555137, 1189.8869607387285, 1193.2244041373176, 1262.50762202741, 17147.389817064053, 17252.051137187576, 17378.47864564065, 17575.560610984572, 17715.379961701277, 549712.0, 603701.0, 605167.0, 611237.0, 614093.0, 58443.41556584465, 63618.68190659017, 64457.0, 64560.35439645637, 64725.35274647193, 1474.2702362330715, 1501.9549413517611, 1517.3172072567388, 1522.6726253855695, 1536.9385224590892, 33328.33343333168, 34161.963251199486, 34181.48727769036, 34244.14389640279, 34393.656063440045, 56447.15329269982, 56533.15200271917, 57114.42885571091, 57242.7137864308, 57280.713596433416, 486460.0, 492062.0, 493295.0, 496510.0, 499405.0, 31285.687143129187, 31732.524012139376, 31753.0, 31766.364672706877, 31784.523232151074, 51922.48077519176, 52364.21453678122, 52782.736086319324, 52983.470165297855, 53008.73495632497, 43052.78473607612, 43287.350689740306, 44227.0, 44379.77810110929, 45549.0, 42698.14603707971, 42860.78569607132, 43120.56879431291, 43220.00976183109, 43481.34777978269, 43451.565484346014, 43911.0, 44218.557814421445, 44565.777171113936, 44702.552974469836, 37428.0, 37482.43776343302, 37760.2447951034, 38417.4237386445, 38725.0, 28163.0, 29297.560536592395, 30536.389272214874, 30932.381352372377, 30970.225744356572], "value": 21136.863355797825, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.59025720693916, 438.6574303805006, 440.37027051316613, 444.08961628661257, 445.9509453960062, 18518.814811851877, 19788.0, 19967.60064798705, 21166.365009049754, 21190.364289071353, 19416.902915485403, 19562.678013112727, 19741.111649975748, 20278.49303767403, 20352.0, 5862.413758624136, 6019.277686677583, 6035.3059398169335, 6083.057126145432, 6085.969570152143, 5783.595148339597, 5886.617369870966, 5953.928292907275, 5955.136505206764, 6005.249343832021, 5903.763849446017, 5927.911081333784, 5937.079752638327, 5943.0, 5966.045432730764, 5662.094064949609, 5877.471027607536, 5884.323302820188, 5900.321463031763, 5904.645721256717, 5264.8683782905355, 5307.389650190239, 5309.920351194735, 5314.468553144693, 5315.973420132913, 23341.0, 23712.64431033536, 24102.0, 24170.637440438408, 24395.390115247083, 2356.5404746074523, 2391.72495163055, 2406.0, 2450.718167410753, 2460.4463995601027, 14989.625259368495, 15246.923765381212, 15454.690906181926, 15635.983661061995, 15720.29258683362, 2006.2276023730822, 2039.58188571344, 2049.354453347206, 2052.784457631942, 2068.9482762930897, 76141.23858761397, 79236.60381698054, 81424.59287703583, 81594.9999999994, 82675.5866220671, 10991.890081099087, 11400.144989125849, 11624.360660163773, 11628.244164129474, 11798.233114847508, 16249.0, 16291.674166516603, 16292.918535407247, 16341.101239431708, 16356.83643163577, 8845.336599754915, 9064.365494415328, 9087.863682044775, 9138.567794619605, 9201.30990175726, 8792.208701216921, 8859.601317940707, 9022.323325750594, 9054.728358149267, 9103.954480227689, 6907.965460172767, 7072.575645461186, 7077.7168913242895, 7146.2496437874315, 7213.511338588179, 2025.6455120353878, 2066.772655007948, 2108.1040557763195, 2112.704221409004, 2153.644648632989, 993.8558908958305, 1078.1536493852288, 1080.3140006096185, 1138.9772204555863, 1208.6857417071449, 19267.51831204203, 19686.803131968783, 19731.112099955248, 20254.594908101757, 20543.28098516545, 1069.3316677076828, 1116.3469370418395, 1129.2264798612812, 1138.886111388871, 1158.2934410009887, 11254.21220514556, 11467.139964502696, 11484.88515114838, 11652.53389864396, 11724.706882327839, 514984.0, 516478.0, 521495.0, 542991.0, 547870.0, 80730.59634701788, 82916.0, 83714.0, 84311.57844210739, 84571.57714211389, 1076.5855145768935, 1097.040089921319, 1101.5869049106584, 1112.265904503024, 1120.383788916093, 17882.5529361767, 18092.185851636445, 18203.908980455013, 18423.263069477605, 18531.722024169918, 38852.2229555413, 39333.606663932995, 39641.60358396379, 40935.0, 41206.0, 53855.0, 54069.45930540644, 54183.45816541784, 54262.45737542574, 54639.45360546344, 9137.360384773003, 9179.990201077742, 9204.125608067223, 9204.125608067223, 9300.767480812763, 13315.26766027839, 13394.464221431033, 13401.195928244337, 13488.797668035184, 13762.862371376157, 11636.12729045308, 11970.461329240032, 12014.939925300318, 12284.01727861751, 12292.569760058355, 11641.825372619249, 11700.590479333183, 11867.0, 12062.879371206176, 12434.689132771753, 11866.644000679993, 12041.698957526132, 12186.146969712036, 12189.573364932185, 12310.630681079581, 8868.556572171494, 8920.955395222982, 8928.285737141143, 8972.551372431222, 9396.0, 11810.0, 11917.463714133059, 11978.700532486757, 11979.520819167135, 12151.878481215075], "value": 9800.02368786509, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1590.181056755771, 1596.8802339824515, 1811.3660218923378, 1898.5763171809685, 1908.4751693284345, 8573.57132143392, 9623.0, 9713.125818676317, 10356.948215258923, 10362.740931476717, 9707.174890134347, 10037.548310326034, 10070.345427547205, 10077.69766906994, 10102.545385457654, 2320.5590937721777, 2358.1864256831363, 2361.2680069178523, 2364.1489063937056, 2369.490559529701, 2426.259990702835, 2447.229122826304, 2465.90136394544, 2481.4044629288933, 2488.340589743719, 2411.3489357873364, 2443.535728211643, 2481.4540801023745, 2507.04732201764, 2507.8746062696882, 2339.3099035784485, 2358.870262135582, 2365.4795944892267, 2366.5858474766933, 2383.809295256375, 2400.627902675088, 2419.5644783938883, 2436.281297017384, 2451.5464639041834, 2454.2514533067406, 9915.206783457306, 9980.05189507003, 10028.64899728506, 10046.69859904204, 10050.89949100507, 5822.767089316465, 5938.554608404387, 5953.880922381528, 5954.374790647006, 5971.283445986466, 3644.9271014579826, 3662.8717994870053, 3673.430618254175, 3693.9630603693886, 3743.5507739071213, 1162.0703437250165, 1182.072073422368, 1229.1334609100652, 1238.0714464151886, 1246.1214843535286, 14375.496857610038, 14554.272286385743, 14556.927215363961, 14571.854281457261, 14573.125612463286, 5077.111505486525, 5142.6400151989, 5219.530242278213, 5223.738813059332, 5259.8422047338645, 12017.519299228108, 12025.939870300592, 12072.517099316105, 12079.396030198455, 12096.879031209752, 5807.419258074159, 5848.210491583582, 5878.412158784087, 5886.8822623547285, 5892.558058145656, 4488.820447182076, 5017.096922553976, 5125.077486052472, 5145.639805213599, 5380.085385484399, 4387.8244870204835, 4421.093675796454, 4460.643148548108, 4467.73193608378, 4471.463424389029, 1409.2460533614467, 1414.6675531250148, 1421.8364888038009, 1436.7844823276591, 1442.9855701443062, 896.2426749396749, 986.329296078659, 1000.7097941596855, 1003.2726273451835, 1012.8075665623508, 6194.473469755121, 6253.749850005949, 6308.873822523524, 6344.841378965562, 6609.702563384659, 980.4362491567377, 1047.2878442658912, 1059.5496913811598, 1073.683263437288, 1073.909981368911, 4023.738457000344, 4027.8993025174605, 4100.5489396166395, 4168.937465938014, 4212.431321771583, 12248.81626775599, 12396.31820249877, 12616.936915315548, 12625.0, 12629.43167557462, 12400.441980110916, 12453.564125255754, 12458.875411245952, 12471.75056498865, 12473.064520160842, 8892.955535222283, 8943.329250306253, 9244.44533327989, 9255.0, 9459.668911588062, 6516.6415847128865, 6623.801285961429, 6755.256921738703, 6879.071325371011, 6916.619585922823, 10851.131909447384, 11630.53477860876, 11680.47437865281, 11688.766224675628, 11696.941515292368, 11612.187146899636, 11775.882241177822, 11874.584389546324, 11889.82165267539, 11919.940400297943, 8668.956655216683, 8688.609012594576, 8824.602892869709, 8924.732258032269, 8954.641814327353, 9893.318135916767, 9917.65288214909, 9935.751606209902, 9948.154406875497, 9995.500224988868, 8195.426320157532, 8436.45163064399, 8546.914530854861, 8679.652813887375, 8755.781105472413, 8556.957215213884, 8618.698345557876, 8722.433041852513, 8733.737987860375, 8831.91168088311, 7571.962140189484, 7579.54522728638, 7580.128285247047, 7600.923990760021, 7636.923630763621, 5216.165413533817, 5319.707416092152, 5332.68003919766, 5353.54494867925, 5474.972625136849, 5319.281896943863, 5326.467353264643, 5353.2505449237915, 5365.061114304903, 5386.811461598825], "value": 5106.929627142515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.1985892376993, 351.8346377202715, 352.50649091272226, 354.8296817527587, 357.4870061461801, 5712.428757124286, 5803.332616749075, 5816.243888294521, 5852.239208902847, 5860.677662728548, 5724.2558467399285, 5735.455131762486, 5752.568557358204, 5758.827235182941, 5768.769249230026, 4052.594740525946, 4233.8094785734565, 4327.221100201962, 4423.911521769563, 4435.268180750172, 4415.249407600716, 4428.092241090569, 4437.5784300491405, 4440.778785833889, 4467.262901621229, 4415.0, 4419.182451246514, 4421.159979603881, 4429.667774916878, 4456.153330867141, 4334.154839806255, 4405.722340521245, 4412.823487060514, 4418.9337159942625, 4475.28395456727, 3873.2447172801317, 3905.9804700976597, 3909.6676782473523, 3911.5306163260307, 3912.8043597819997, 5507.284053073075, 5507.972460137714, 5546.833594992157, 5578.856334451469, 5581.939431508041, 4974.9155523575255, 5040.621953353513, 5040.924386134211, 5041.924371134436, 5109.310243117206, 5928.051511758141, 5938.10928360745, 5942.8811423771285, 5957.225560677084, 6046.486048685867, 4309.78451077448, 4333.501647310568, 4338.067315527177, 4341.370501277329, 4350.543192964757, 6024.819255422344, 6149.938500615026, 6168.87662246757, 6218.751249949996, 6226.2839773426185, 4295.742255464682, 4304.5910638489295, 4328.0, 4345.847895323648, 4348.565143485689, 4380.737155770664, 4401.6478681705385, 4424.535423780457, 4434.534373890695, 4443.400140980926, 4905.533974272438, 5035.697858128524, 5081.72050537224, 5093.796248150106, 5100.744962751847, 5933.317668468181, 5999.880002399927, 6029.698515074228, 6033.879322413527, 6039.577229593886, 1478.1279045363287, 1484.7253258147277, 1486.8736157426524, 1489.5680252726804, 1492.7387707151206, 926.3839546701369, 962.5668449197749, 966.8501382285757, 973.8490533967247, 976.8095221431895, 5285.497877701612, 5307.575393968474, 5352.839414817562, 5361.008213480519, 5368.7047212403695, 5549.7533942644, 5598.804041858597, 5606.411326810626, 5615.943840561542, 5619.286117734048, 4899.452284811878, 5180.886109486479, 5232.2674825524455, 5257.78968841242, 5277.973610132001, 2910.8399038052685, 2939.2357986923125, 2966.6143401358117, 2972.7621790256726, 2977.5087110626505, 5719.7140142992685, 5783.190353350535, 5787.94212057874, 5794.88410231793, 5799.971000144972, 5942.168096466498, 6327.525435592349, 6371.872562548816, 6397.488200943913, 6406.487481001602, 6425.710843012076, 6488.448481878999, 6495.447886929664, 6506.284308726036, 6515.6742162892615, 6017.368176341596, 6188.659623720739, 6227.595206311576, 6269.404406581368, 6294.433500984934, 5937.881242375042, 6128.693565321627, 6172.382761723792, 6177.135201071944, 6190.442860142609, 6480.675966201766, 6481.967590162019, 6482.611043337415, 6490.675466226764, 6509.707063182263, 4317.913641727211, 4344.869653910388, 4377.037051848588, 4378.277584198571, 4404.185225733249, 6167.167432396569, 6167.383261673796, 6258.463967858145, 6313.684315784284, 6329.386006568296, 5957.8680050791945, 6005.879882402415, 6037.516998640186, 6126.326104128631, 6139.938600614116, 5958.19564358806, 6002.279726432681, 6021.518278537619, 6037.426444487766, 6043.879122417615, 5933.554983376178, 5970.253718285215, 5996.610220335664, 6000.87998240024, 6034.63792172471, 6095.725692343766, 6104.145419641165, 6121.9390304847575, 6129.509639228761, 6138.263408391022, 5641.5204707600315, 5951.196588460502, 5977.252843394575, 5994.602159136381, 6012.398760123952], "value": 4511.564916782857, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.5170925224583, 729.1468981291888, 734.9306758666141, 803.9678412863486, 829.91700829917, 15447.0, 15948.68102637948, 15963.600909977227, 15992.640625546814, 16145.11201883896, 14747.48383806567, 14798.704025919475, 14824.110553366805, 14831.629209269773, 14863.554093377188, 839.5214727605282, 863.4430792139067, 865.731623196811, 867.535868310454, 868.7089824908663, 849.668629234599, 851.642310229705, 853.9316854651644, 854.4531499840107, 855.5380094748829, 897.3090720145484, 905.2983937448497, 906.0893801729253, 908.3323757038604, 908.4776253654143, 893.714011516315, 894.217559635319, 895.9104089591054, 896.5114012863005, 898.2454738020061, 656.8423578341163, 658.2989116590816, 658.7035833874728, 659.8119535932236, 661.7882277671147, 15318.617034574114, 15319.617009574738, 15394.076355418598, 15428.537143885702, 15451.0, 15595.1422671753, 15622.218889055503, 15628.374865005386, 15634.671052960512, 15920.601984950354, 11705.882941170565, 11705.941470292679, 11771.117166212483, 12074.210762555449, 12089.637310880687, 3634.9818250908575, 3648.41625339947, 3702.2595480903656, 3722.9069273268115, 3757.1922036762226, 78365.60817195878, 79510.0, 81096.0, 81391.0, 81712.59143704243, 11057.723556911142, 11059.502322395512, 11217.551297948154, 11309.886901131047, 11357.659270221906, 20292.0, 20304.79695203029, 20366.0, 20388.490287742927, 20445.48886277855, 8126.10612832588, 8131.796705082302, 8254.504729716236, 8262.628181731836, 8282.378821588285, 4999.450060493343, 5006.4743201963265, 5128.358955130609, 5212.921806172911, 5213.7393130343335, 3465.8440370183403, 3566.375884220251, 3576.40989236773, 3579.803110828929, 3587.802670853076, 650.2262307853639, 657.8289644692414, 664.6078813500059, 668.8929771236578, 682.4676752133344, 735.3675838778646, 775.1434664695543, 788.5465857132172, 803.6905791270403, 807.1444269074799, 9402.623895044122, 9838.754031149136, 9853.50732463374, 9860.605575777032, 9915.504224788732, 574.954003679713, 591.1782622155208, 660.6366498425847, 667.9866402671919, 725.1769241910364, 4234.301340278819, 4273.18809426208, 4316.43886294786, 4389.40742999691, 4519.796609152596, 74824.62587687136, 76564.61717691488, 77054.61472692601, 90401.54799226094, 118562.4071879635, 66411.33588664148, 89542.55228723814, 105493.47253263838, 105679.0, 109691.0, 92213.5389323049, 92432.53783731039, 94262.0, 95319.0, 98408.0, 8243.134470880472, 8261.504309741435, 8313.459625124347, 8346.374021948257, 8444.704435344733, 52737.20894186667, 53354.73322633362, 53672.194917075496, 55402.72298638481, 55870.0, 51197.0, 79510.6024469874, 80472.19527804646, 81242.0, 81251.5937420309, 13001.284929328978, 13569.457221711022, 13641.0, 13746.518871839839, 14494.927525362305, 14905.850941490446, 14985.925070374578, 15908.602284942968, 16166.191690415668, 16250.26873790706, 14606.926965365104, 14759.335829887466, 15065.322060507084, 15439.768403473732, 15707.136107514196, 14477.638059048608, 14920.850791492381, 15277.708343748081, 15312.310946007234, 15967.68064638724, 14284.857151428352, 14486.130832150106, 14826.62933426673, 15743.842561574238, 15753.054816710575, 12712.110152289251, 12732.23606583608, 12765.234085954873, 13045.217286962812, 13334.39995200199, 12104.939475302566, 12241.69395765113, 12425.44085516172, 12457.377131143588, 12628.494860205856], "value": 7721.463225656993, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 112.0, 113.0, 112.0, 113.0, 113.0, 110.0, 110.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 160.0, 186.0, 130.0, 153.0, 156.0, 125.0, 183.0, 130.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 163.0, 164.0, 163.0, 162.0, 166.0, 162.0, 162.0, 161.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 173.0, 76.0, 76.0, 75.0, 76.0, 185.0, 76.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 149.0, 85.0, 85.0, 85.0, 140.0, 87.0, 84.0, 139.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 97.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 58.0, 54.0, 54.0, 55.0, 56.0, 54.0, 56.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 65.0, 64.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 78.0, 82.0, 78.0, 76.0, 78.0, 103.0, 77.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 124.0, 126.0, 118.0, 132.0, 130.0, 127.0, 132.0, 129.0, 130.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 157.0, 153.0, 152.0, 155.0, 153.0, 155.0, 155.0, 159.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 67.0, 61.0, 66.0, 63.0, 62.0, 63.0, 66.0, 66.0], "value": 64.2, "unit": "score"}]}]} 04:33:41 INFO - Return code: 0 04:33:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:42 ERROR - # TBPL SUCCESS # 04:33:42 INFO - Running post-action listener: _resource_record_post_action 04:33:42 INFO - ##### 04:33:42 INFO - ##### Finished run-tests step (success) 04:33:42 INFO - ##### 04:33:42 INFO - Running post-run listener: _resource_record_post_run 04:33:42 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284409856; Read time: 72; Write time: 224428 04:33:42 INFO - TinderboxPrint: CPU usage
13.3% 04:33:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 72 04:33:42 INFO - TinderboxPrint: I/O write bytes / time
284,409,856 / 224,428 04:33:42 INFO - TinderboxPrint: CPU idle
8,195.8 (86.7%) 04:33:42 INFO - TinderboxPrint: CPU user
1,206.4 (12.8%) 04:33:42 INFO - TinderboxPrint: Swap in / out
0 / 0 04:33:42 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 4096; Write bytes: 68648960; Read time: 32; Write time: 73404 04:33:42 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 213016576; Read time: 40; Write time: 150764 04:33:42 INFO - Running post-run listener: _upload_blobber_files 04:33:42 INFO - Blob upload gear active. 04:33:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:42 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:42 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:42 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:43 INFO - Traceback (most recent call last): 04:33:43 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 04:33:43 INFO - main() 04:33:43 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 04:33:43 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 04:33:43 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 04:33:43 INFO - return set(response.json().get('whitelist', [])) 04:33:43 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 04:33:43 INFO - return json.loads(self.text or self.content, **kwargs) 04:33:43 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 04:33:43 INFO - return _default_decoder.decode(s) 04:33:43 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 04:33:43 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 04:33:43 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 04:33:43 INFO - raise ValueError("No JSON object could be decoded") 04:33:43 INFO - ValueError: No JSON object could be decoded 04:33:43 ERROR - Return code: 1 04:33:43 INFO - Setting buildbot property blobber_files to {} 04:33:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:43 INFO - Contents: 04:33:43 INFO - blobber_files:{} 04:33:43 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:43 INFO - Copying logs to upload dir... 04:33:43 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1670.337777 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 50 secs) (at 2016-08-28 04:33:42.105115) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:42.108410) ========= 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=af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252 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:42.159437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:42.159738) ========= 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=af724c981e2a0f424dbabf99000001e7-1472382351.326633-896071252 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004554 ========= master_lag: 0.92 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:43.083957) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:33:43.085195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:33:43.085629) ========= ========= Total master_lag: 1.03 =========