builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1472639570.78 results: success (0) buildid: 20160831004001 builduid: 55096374e91d4abab8eb48a17c414fcd revision: 7177e736768960cd807440961beee561ca7ce582 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:50.777758) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:50.779611) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:50.779965) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:50.806606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:50.806954) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 03:32:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2016-08-31 03:32:51 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103214 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:50.930379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:50.930932) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014896 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:50.980605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 03:32:50.980945) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7177e736768960cd807440961beee561ca7ce582 --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-aurora --rev 7177e736768960cd807440961beee561ca7ce582 --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=03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 03:32:51,408 truncating revision to first 12 chars 2016-08-31 03:32:51,408 Setting DEBUG logging. 2016-08-31 03:32:51,408 attempt 1/10 2016-08-31 03:32:51,408 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7177e7367689?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 03:32:52,548 unpacking tar archive at: mozilla-aurora-7177e7367689/testing/mozharness/ program finished with exit code 0 elapsedTime=1.435889 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-31 03:32:52.431181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:52.431826) ========= script_repo_revision: 7177e736768960cd807440961beee561ca7ce582 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:52.432373) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:52.432765) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 03:32:52.443769) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-31 03:32:52.444227) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:52 INFO - MultiFileLogger online at 20160831 03:32:52 in /builds/slave/test 03:32:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:32:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:52 INFO - {'append_to_log': False, 03:32:52 INFO - 'base_work_dir': '/builds/slave/test', 03:32:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:32:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:52 INFO - 'branch': 'Mozilla-Aurora', 03:32:52 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:52 INFO - 'config_files': ('talos/linux_config.py',), 03:32:52 INFO - 'default_actions': ('clobber', 03:32:52 INFO - 'read-buildbot-config', 03:32:52 INFO - 'download-and-extract', 03:32:52 INFO - 'populate-webroot', 03:32:52 INFO - 'create-virtualenv', 03:32:52 INFO - 'install', 03:32:52 INFO - 'run-tests'), 03:32:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:52 INFO - 'download_minidump_stackwalk': True, 03:32:52 INFO - 'download_symbols': 'ondemand', 03:32:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:52 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:52 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:52 INFO - 'installer_path': 'installer.exe', 03:32:52 INFO - 'log_level': 'info', 03:32:52 INFO - 'log_name': 'talos', 03:32:52 INFO - 'log_to_console': True, 03:32:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:52 INFO - 'opt_config_files': (), 03:32:52 INFO - 'pip_index': False, 03:32:52 INFO - 'sps_profile': False, 03:32:52 INFO - 'sps_profile_interval': 0, 03:32:52 INFO - 'suite': 'dromaeojs-e10s', 03:32:52 INFO - 'system_bits': '32', 03:32:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:52 INFO - 'title': 'talos-linux64-ix-047', 03:32:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:52 INFO - 'use_talos_json': True, 03:32:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:52 INFO - 'work_dir': 'build'} 03:32:52 INFO - [mozharness: 2016-08-31 10:32:52.955034Z] Running clobber step. 03:32:52 INFO - Running pre-action listener: _resource_record_pre_action 03:32:52 INFO - Running main action method: clobber 03:32:52 INFO - rmtree: /builds/slave/test/build 03:32:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:53 INFO - Running post-action listener: _resource_record_post_action 03:32:53 INFO - [mozharness: 2016-08-31 10:32:53.422033Z] Finished clobber step (success) 03:32:53 INFO - [mozharness: 2016-08-31 10:32:53.422136Z] Running read-buildbot-config step. 03:32:53 INFO - Running pre-action listener: _resource_record_pre_action 03:32:53 INFO - Running main action method: read_buildbot_config 03:32:53 INFO - Using buildbot properties: 03:32:53 INFO - { 03:32:53 INFO - "project": "", 03:32:53 INFO - "product": "firefox", 03:32:53 INFO - "script_repo_revision": "production", 03:32:53 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:32:53 INFO - "repository": "", 03:32:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:32:53 INFO - "buildid": "20160831004001", 03:32:53 INFO - "stage_platform": "linux64-pgo", 03:32:53 INFO - "basedir": "/builds/slave/test", 03:32:53 INFO - "nightly_build": "True", 03:32:53 INFO - "buildnumber": 529, 03:32:53 INFO - "slavename": "talos-linux64-ix-047", 03:32:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:32:53 INFO - "platform": "ubuntu64_hw", 03:32:53 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:32:53 INFO - "branch": "mozilla-aurora", 03:32:53 INFO - "repo_path": "releases/mozilla-aurora", 03:32:53 INFO - "revision": "7177e736768960cd807440961beee561ca7ce582", 03:32:53 INFO - "pgo_build": "True", 03:32:53 INFO - "builduid": "55096374e91d4abab8eb48a17c414fcd", 03:32:53 INFO - "slavebuilddir": "test" 03:32:53 INFO - } 03:32:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 03:32:53 INFO - Running post-action listener: _resource_record_post_action 03:32:53 INFO - [mozharness: 2016-08-31 10:32:53.424667Z] Finished read-buildbot-config step (success) 03:32:53 INFO - [mozharness: 2016-08-31 10:32:53.424758Z] Running download-and-extract step. 03:32:53 INFO - Running pre-action listener: _resource_record_pre_action 03:32:53 INFO - Running main action method: download_and_extract 03:32:53 INFO - mkdir: /builds/slave/test/build/tests 03:32: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')]} 03:32:53 INFO - https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:32:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:32:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:32:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:32:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:32:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:32:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:32:53 INFO - retry: Failed, sleeping 30 seconds before retrying 03:33:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 03:33:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:33:23 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:33:23 INFO - retry: Failed, sleeping 60 seconds before retrying 03:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 03:34:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:34:23 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:34:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 03:34:23 INFO - Caught exception: HTTP Error 404: Not Found 03:34:23 INFO - Caught exception: HTTP Error 404: Not Found 03:34:23 INFO - Caught exception: HTTP Error 404: Not Found 03:34:23 INFO - trying https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:34:23 INFO - Downloading https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:34:24 INFO - Downloaded 1361 bytes. 03:34:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 03:34:24 INFO - Using the following test package requirements: 03:34:24 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:24 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:34:24 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:34:24 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:24 INFO - u'jsshell-linux-x86_64.zip'], 03:34:24 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:34:24 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 03:34:24 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:34:24 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:34:24 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:34:24 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 03:34:24 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:34:24 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:34: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')]} 03:34:24 INFO - https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:34:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:34:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:34:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:34:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:34:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:34:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:34:24 INFO - retry: Failed, sleeping 30 seconds before retrying 03:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:34:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:34:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:34:54 INFO - retry: Failed, sleeping 60 seconds before retrying 03:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:35:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:35:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:35:54 INFO - Caught exception: HTTP Error 404: Not Found 03:35:54 INFO - Caught exception: HTTP Error 404: Not Found 03:35:54 INFO - Caught exception: HTTP Error 404: Not Found 03:35:54 INFO - trying https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:54 INFO - Downloading https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:35:55 INFO - Downloaded 21768656 bytes. 03:35:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:35:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:35:56 INFO - Return code: 0 03:35:56 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:35: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')]} 03:35:56 INFO - https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:35:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:35:56 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:35:56 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:35:56 INFO - retry: Failed, sleeping 30 seconds before retrying 03:36:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 03:36:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:36:26 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:36:26 INFO - retry: Failed, sleeping 60 seconds before retrying 03:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 03:37:26 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:37:26 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:37:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 03:37:26 INFO - Caught exception: HTTP Error 404: Not Found 03:37:26 INFO - Caught exception: HTTP Error 404: Not Found 03:37:26 INFO - Caught exception: HTTP Error 404: Not Found 03:37:26 INFO - trying https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:37:26 INFO - Downloading https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 03:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:37:27 INFO - Downloaded 21768656 bytes. 03:37:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:37:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:37:28 INFO - Return code: 0 03:37: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')]} 03:37:28 INFO - https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:37:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:37:28 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:28 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:37:28 INFO - retry: Failed, sleeping 30 seconds before retrying 03:37:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 03:37:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:37:58 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:37:58 INFO - retry: Failed, sleeping 60 seconds before retrying 03:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 03:38:58 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:58 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:38:58 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 03:38:58 INFO - Caught exception: HTTP Error 404: Not Found 03:38:58 INFO - Caught exception: HTTP Error 404: Not Found 03:38:58 INFO - Caught exception: HTTP Error 404: Not Found 03:38:58 INFO - trying https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:58 INFO - Downloading https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 03:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:38:59 INFO - Downloaded 14413740 bytes. 03:38:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:38:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:38:59 INFO - Return code: 0 03:38: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')]} 03:38:59 INFO - https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:38:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:38:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:38:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 03:38:59 INFO - retry: Failed, sleeping 30 seconds before retrying 03:39:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:39:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:39:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 03:39:29 INFO - retry: Failed, sleeping 60 seconds before retrying 03:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 03:40:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:40:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 03:40:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 03:40:29 INFO - Caught exception: HTTP Error 404: Not Found 03:40:29 INFO - Caught exception: HTTP Error 404: Not Found 03:40:29 INFO - Caught exception: HTTP Error 404: Not Found 03:40:29 INFO - trying https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:40:29 INFO - Downloading https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:40:30 INFO - Downloaded 63866068 bytes. 03:40:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:40:30 INFO - mkdir: /builds/slave/test/properties 03:40:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:40:30 INFO - Writing to file /builds/slave/test/properties/build_url 03:40:30 INFO - Contents: 03:40:30 INFO - build_url:https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 03:40:31 INFO - Running post-action listener: _resource_record_post_action 03:40:31 INFO - Running post-action listener: set_extra_try_arguments 03:40:31 INFO - [mozharness: 2016-08-31 10:40:31.661287Z] Finished download-and-extract step (success) 03:40:31 INFO - [mozharness: 2016-08-31 10:40:31.661564Z] Running populate-webroot step. 03:40:31 INFO - Running pre-action listener: _resource_record_pre_action 03:40:31 INFO - Running main action method: populate_webroot 03:40:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:40:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:40:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:40:31 INFO - '--tppagecycles', 03:40:31 INFO - '7'], 03:40:31 INFO - 'tests': ['tsvgm']}}, 03:40:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:40:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:40:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:40:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:40:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:31 INFO - 'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:40:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:31 INFO - 'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['damp', 'tps']}, 03:40:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:31 INFO - 'tests': ['damp', 'tps']}, 03:40:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['dromaeo_dom']}, 03:40:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:40:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['basic_compositor_video']}, 03:40:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:40:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['a11yr', 03:40:31 INFO - 'ts_paint', 03:40:31 INFO - 'tpaint', 03:40:31 INFO - 'sessionrestore', 03:40:31 INFO - 'sessionrestore_no_auto_restore', 03:40:31 INFO - 'tabpaint']}, 03:40:31 INFO - 'other-e10s': {'tests': ['a11yr', 03:40:31 INFO - 'ts_paint', 03:40:31 INFO - 'tpaint', 03:40:31 INFO - 'sessionrestore', 03:40:31 INFO - 'sessionrestore_no_auto_restore', 03:40:31 INFO - 'tabpaint']}, 03:40:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:40:31 INFO - 'ts_paint', 03:40:31 INFO - 'tpaint', 03:40:31 INFO - 'sessionrestore', 03:40:31 INFO - 'sessionrestore_no_auto_restore', 03:40:31 INFO - 'tabpaint']}, 03:40:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:40:31 INFO - 'ts_paint', 03:40:31 INFO - 'tpaint', 03:40:31 INFO - 'sessionrestore', 03:40:31 INFO - 'sessionrestore_no_auto_restore', 03:40:31 INFO - 'tabpaint']}, 03:40:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['a11yr', 03:40:31 INFO - 'ts_paint', 03:40:31 INFO - 'tpaint', 03:40:31 INFO - 'sessionrestore', 03:40:31 INFO - 'sessionrestore_no_auto_restore', 03:40:31 INFO - 'tabpaint']}, 03:40:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['a11yr', 03:40:31 INFO - 'ts_paint', 03:40:31 INFO - 'tpaint', 03:40:31 INFO - 'sessionrestore', 03:40:31 INFO - 'sessionrestore_no_auto_restore', 03:40:31 INFO - 'tabpaint']}, 03:40:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['tsvgx', 03:40:31 INFO - 'tsvgr_opacity', 03:40:31 INFO - 'tart', 03:40:31 INFO - 'tscrollx', 03:40:31 INFO - 'cart']}, 03:40:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:40:31 INFO - 'tsvgr_opacity', 03:40:31 INFO - 'tart', 03:40:31 INFO - 'tscrollx', 03:40:31 INFO - 'cart']}, 03:40:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:31 INFO - 'talos_options': ['--disable-e10s'], 03:40:31 INFO - 'tests': ['tp5o']}, 03:40:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:31 INFO - 'tests': ['tp5o']}, 03:40:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:31 INFO - 'talos_options': ['--disable-e10s', 03:40:31 INFO - '--xperf_path', 03:40:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:31 INFO - 'tests': ['tp5n']}, 03:40:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:40:31 INFO - 'talos_options': ['--xperf_path', 03:40:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:40:31 INFO - 'tests': ['tp5n']}}, 03:40:31 INFO - 'talos.zip': {'path': '', 03:40:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:40:31 INFO - Running post-action listener: _resource_record_post_action 03:40:31 INFO - [mozharness: 2016-08-31 10:40:31.677555Z] Finished populate-webroot step (success) 03:40:31 INFO - [mozharness: 2016-08-31 10:40:31.677651Z] Running create-virtualenv step. 03:40:31 INFO - Running pre-action listener: _resource_record_pre_action 03:40:31 INFO - Running main action method: create_virtualenv 03:40:31 INFO - Creating virtualenv /builds/slave/test/build/venv 03:40: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 03:40:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:40:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:40:31 INFO - Using real prefix '/usr' 03:40:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:40:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:40:34 INFO - Installing pip.................done. 03:40:34 INFO - Return code: 0 03:40:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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 0xebe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', '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 03:40: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 03:40: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 03:40:34 INFO - Using env: {'DISPLAY': ':0', 03:40:34 INFO - 'HOME': '/home/cltbld', 03:40:34 INFO - 'LANG': 'en_US.UTF-8', 03:40:34 INFO - 'LANGUAGE': 'en_US:en', 03:40:34 INFO - 'LOGNAME': 'cltbld', 03:40:34 INFO - 'MAIL': '/var/mail/cltbld', 03:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:34 INFO - 'MOZ_NO_REMOTE': '1', 03:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:34 INFO - 'NO_EM_RESTART': '1', 03:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:34 INFO - 'PWD': '/builds/slave/test', 03:40:34 INFO - 'SHELL': '/bin/bash', 03:40:34 INFO - 'SHLVL': '1', 03:40:34 INFO - 'TERM': 'linux', 03:40:34 INFO - 'TMOUT': '86400', 03:40:34 INFO - 'USER': 'cltbld', 03:40:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:34 INFO - '_': '/tools/buildbot/bin/python'} 03:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40: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 03:40:34 INFO - Cleaning up... 03:40:34 INFO - Return code: 0 03:40:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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 0xebe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', '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 03:40: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 03:40: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 03:40:34 INFO - Using env: {'DISPLAY': ':0', 03:40:34 INFO - 'HOME': '/home/cltbld', 03:40:34 INFO - 'LANG': 'en_US.UTF-8', 03:40:34 INFO - 'LANGUAGE': 'en_US:en', 03:40:34 INFO - 'LOGNAME': 'cltbld', 03:40:34 INFO - 'MAIL': '/var/mail/cltbld', 03:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:34 INFO - 'MOZ_NO_REMOTE': '1', 03:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:34 INFO - 'NO_EM_RESTART': '1', 03:40:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:34 INFO - 'PWD': '/builds/slave/test', 03:40:34 INFO - 'SHELL': '/bin/bash', 03:40:34 INFO - 'SHLVL': '1', 03:40:34 INFO - 'TERM': 'linux', 03:40:34 INFO - 'TMOUT': '86400', 03:40:34 INFO - 'USER': 'cltbld', 03:40:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:34 INFO - '_': '/tools/buildbot/bin/python'} 03:40:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:34 INFO - Downloading/unpacking psutil>=3.1.1 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:40:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:36 INFO - Installing collected packages: psutil 03:40:36 INFO - Running setup.py install for psutil 03:40:36 INFO - building 'psutil._psutil_linux' extension 03:40: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 03:40: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 03:40:36 INFO - building 'psutil._psutil_posix' extension 03:40: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 03:40:37 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 03:40:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:40:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:40:37 INFO - Successfully installed psutil 03:40:37 INFO - Cleaning up... 03:40:37 INFO - Return code: 0 03:40:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', '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 03:40:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:40:37 INFO - Using env: {'DISPLAY': ':0', 03:40:37 INFO - 'HOME': '/home/cltbld', 03:40:37 INFO - 'LANG': 'en_US.UTF-8', 03:40:37 INFO - 'LANGUAGE': 'en_US:en', 03:40:37 INFO - 'LOGNAME': 'cltbld', 03:40:37 INFO - 'MAIL': '/var/mail/cltbld', 03:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:37 INFO - 'MOZ_NO_REMOTE': '1', 03:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:37 INFO - 'NO_EM_RESTART': '1', 03:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:37 INFO - 'PWD': '/builds/slave/test', 03:40:37 INFO - 'SHELL': '/bin/bash', 03:40:37 INFO - 'SHLVL': '1', 03:40:37 INFO - 'TERM': 'linux', 03:40:37 INFO - 'TMOUT': '86400', 03:40:37 INFO - 'USER': 'cltbld', 03:40:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:37 INFO - '_': '/tools/buildbot/bin/python'} 03:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:40:39 INFO - Installing collected packages: mozsystemmonitor 03:40:39 INFO - Running setup.py install for mozsystemmonitor 03:40:39 INFO - Successfully installed mozsystemmonitor 03:40:39 INFO - Cleaning up... 03:40:39 INFO - Return code: 0 03:40:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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 0xebe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', '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 03:40: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 03:40: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 03:40:39 INFO - Using env: {'DISPLAY': ':0', 03:40:39 INFO - 'HOME': '/home/cltbld', 03:40:39 INFO - 'LANG': 'en_US.UTF-8', 03:40:39 INFO - 'LANGUAGE': 'en_US:en', 03:40:39 INFO - 'LOGNAME': 'cltbld', 03:40:39 INFO - 'MAIL': '/var/mail/cltbld', 03:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:39 INFO - 'MOZ_NO_REMOTE': '1', 03:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:39 INFO - 'NO_EM_RESTART': '1', 03:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:39 INFO - 'PWD': '/builds/slave/test', 03:40:39 INFO - 'SHELL': '/bin/bash', 03:40:39 INFO - 'SHLVL': '1', 03:40:39 INFO - 'TERM': 'linux', 03:40:39 INFO - 'TMOUT': '86400', 03:40:39 INFO - 'USER': 'cltbld', 03:40:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:39 INFO - '_': '/tools/buildbot/bin/python'} 03:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:39 INFO - Downloading/unpacking jsonschema==2.5.1 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:41 INFO - warning: no files found matching '*.txt' 03:40:41 INFO - no previously-included directories found matching 'build' 03:40:41 INFO - no previously-included directories found matching 'dist' 03:40:41 INFO - no previously-included directories found matching '.git*' 03:40:41 INFO - Installing collected packages: jsonschema, functools32 03:40:41 INFO - Running setup.py install for functools32 03:40:42 INFO - warning: no files found matching '*.txt' 03:40:42 INFO - no previously-included directories found matching 'build' 03:40:42 INFO - no previously-included directories found matching 'dist' 03:40:42 INFO - no previously-included directories found matching '.git*' 03:40:42 INFO - Successfully installed jsonschema functools32 03:40:42 INFO - Cleaning up... 03:40:42 INFO - Return code: 0 03:40:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:40:42 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')]} 03:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:42 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')]} 03:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xebe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', '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 03:40:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:40:42 INFO - Using env: {'DISPLAY': ':0', 03:40:42 INFO - 'HOME': '/home/cltbld', 03:40:42 INFO - 'LANG': 'en_US.UTF-8', 03:40:42 INFO - 'LANGUAGE': 'en_US:en', 03:40:42 INFO - 'LOGNAME': 'cltbld', 03:40:42 INFO - 'MAIL': '/var/mail/cltbld', 03:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:42 INFO - 'MOZ_NO_REMOTE': '1', 03:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:42 INFO - 'NO_EM_RESTART': '1', 03:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:42 INFO - 'PWD': '/builds/slave/test', 03:40:42 INFO - 'SHELL': '/bin/bash', 03:40:42 INFO - 'SHLVL': '1', 03:40:42 INFO - 'TERM': 'linux', 03:40:42 INFO - 'TMOUT': '86400', 03:40:42 INFO - 'USER': 'cltbld', 03:40:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:42 INFO - '_': '/tools/buildbot/bin/python'} 03:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:40:42 INFO - Cleaning up... 03:40:42 INFO - Return code: 0 03:40:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40:42 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')]} 03:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:42 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')]} 03:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:42 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 0xebe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', '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 03:40:42 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 03:40:42 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 03:40:42 INFO - Using env: {'DISPLAY': ':0', 03:40:42 INFO - 'HOME': '/home/cltbld', 03:40:42 INFO - 'LANG': 'en_US.UTF-8', 03:40:42 INFO - 'LANGUAGE': 'en_US:en', 03:40:42 INFO - 'LOGNAME': 'cltbld', 03:40:42 INFO - 'MAIL': '/var/mail/cltbld', 03:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:42 INFO - 'MOZ_NO_REMOTE': '1', 03:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:42 INFO - 'NO_EM_RESTART': '1', 03:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:42 INFO - 'PWD': '/builds/slave/test', 03:40:42 INFO - 'SHELL': '/bin/bash', 03:40:42 INFO - 'SHLVL': '1', 03:40:42 INFO - 'TERM': 'linux', 03:40:42 INFO - 'TMOUT': '86400', 03:40:42 INFO - 'USER': 'cltbld', 03:40:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:42 INFO - '_': '/tools/buildbot/bin/python'} 03:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:45 INFO - Downloading docopt-0.6.1.tar.gz 03:40:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:45 INFO - Running setup.py install for blobuploader 03:40:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:45 INFO - Running setup.py install for requests 03:40:45 INFO - Running setup.py install for docopt 03:40:45 INFO - Successfully installed blobuploader requests docopt 03:40:45 INFO - Cleaning up... 03:40:45 INFO - Return code: 0 03:40:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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 0xebe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', '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 03:40: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 03:40: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 03:40:45 INFO - Using env: {'DISPLAY': ':0', 03:40:45 INFO - 'HOME': '/home/cltbld', 03:40:45 INFO - 'LANG': 'en_US.UTF-8', 03:40:45 INFO - 'LANGUAGE': 'en_US:en', 03:40:45 INFO - 'LOGNAME': 'cltbld', 03:40:45 INFO - 'MAIL': '/var/mail/cltbld', 03:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:45 INFO - 'MOZ_NO_REMOTE': '1', 03:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:45 INFO - 'NO_EM_RESTART': '1', 03:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:45 INFO - 'PWD': '/builds/slave/test', 03:40:45 INFO - 'SHELL': '/bin/bash', 03:40:45 INFO - 'SHLVL': '1', 03:40:45 INFO - 'TERM': 'linux', 03:40:45 INFO - 'TMOUT': '86400', 03:40:45 INFO - 'USER': 'cltbld', 03:40:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:45 INFO - '_': '/tools/buildbot/bin/python'} 03:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:45 INFO - Running setup.py (path:/tmp/pip-ruDy3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:46 INFO - Running setup.py (path:/tmp/pip-_I3hUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:46 INFO - Running setup.py (path:/tmp/pip-Zy7vm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:46 INFO - Running setup.py (path:/tmp/pip-Wefoop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:46 INFO - Running setup.py (path:/tmp/pip-FzoHt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:46 INFO - Running setup.py (path:/tmp/pip-69DCZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:46 INFO - Running setup.py (path:/tmp/pip-B4YKgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:46 INFO - Running setup.py (path:/tmp/pip-USAnUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:46 INFO - Running setup.py (path:/tmp/pip-oVQsNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:46 INFO - Running setup.py (path:/tmp/pip-aYDZ5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:46 INFO - Running setup.py (path:/tmp/pip-_03tUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:46 INFO - Running setup.py (path:/tmp/pip-wLPrt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:46 INFO - Running setup.py (path:/tmp/pip-wA9vin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:46 INFO - Running setup.py (path:/tmp/pip-RbEK2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:46 INFO - Running setup.py (path:/tmp/pip-bXtjhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:47 INFO - Running setup.py (path:/tmp/pip-VlLP9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:47 INFO - Running setup.py (path:/tmp/pip-YdsQhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:47 INFO - Running setup.py install for manifestparser 03:40:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:47 INFO - Running setup.py install for mozcrash 03:40:47 INFO - Running setup.py install for mozdebug 03:40:47 INFO - Running setup.py install for mozdevice 03:40:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:47 INFO - Running setup.py install for mozfile 03:40:47 INFO - Running setup.py install for mozhttpd 03:40:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:47 INFO - Running setup.py install for mozinfo 03:40:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:47 INFO - Running setup.py install for mozInstall 03:40:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Running setup.py install for mozleak 03:40:48 INFO - Running setup.py install for mozlog 03:40:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Running setup.py install for moznetwork 03:40:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Running setup.py install for mozprocess 03:40:48 INFO - Running setup.py install for mozprofile 03:40:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Running setup.py install for mozrunner 03:40:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Running setup.py install for mozscreenshot 03:40:48 INFO - Running setup.py install for moztest 03:40:48 INFO - Running setup.py install for mozversion 03:40:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:48 INFO - Cleaning up... 03:40:49 INFO - Return code: 0 03:40:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:49 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 0xebe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', '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 03:40:49 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 03:40:49 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 03:40:49 INFO - Using env: {'DISPLAY': ':0', 03:40:49 INFO - 'HOME': '/home/cltbld', 03:40:49 INFO - 'LANG': 'en_US.UTF-8', 03:40:49 INFO - 'LANGUAGE': 'en_US:en', 03:40:49 INFO - 'LOGNAME': 'cltbld', 03:40:49 INFO - 'MAIL': '/var/mail/cltbld', 03:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:49 INFO - 'MOZ_NO_REMOTE': '1', 03:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:49 INFO - 'NO_EM_RESTART': '1', 03:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:49 INFO - 'PWD': '/builds/slave/test', 03:40:49 INFO - 'SHELL': '/bin/bash', 03:40:49 INFO - 'SHLVL': '1', 03:40:49 INFO - 'TERM': 'linux', 03:40:49 INFO - 'TMOUT': '86400', 03:40:49 INFO - 'USER': 'cltbld', 03:40:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:49 INFO - '_': '/tools/buildbot/bin/python'} 03:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:49 INFO - Running setup.py (path:/tmp/pip-MoHBN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:49 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)) 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:49 INFO - Running setup.py (path:/tmp/pip-e15IJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:49 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)) 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:49 INFO - Running setup.py (path:/tmp/pip-gzd8Su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40: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)) 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:49 INFO - Running setup.py (path:/tmp/pip-ERsp92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40: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)) 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:49 INFO - Running setup.py (path:/tmp/pip-_mLi2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40: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)) 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:49 INFO - Running setup.py (path:/tmp/pip-osXrEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40: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)) 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:49 INFO - Running setup.py (path:/tmp/pip-SQMMgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40: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)) 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:49 INFO - Running setup.py (path:/tmp/pip-BXc26T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40: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)) 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:49 INFO - Running setup.py (path:/tmp/pip-jG8iw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40: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)) 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:49 INFO - Running setup.py (path:/tmp/pip-ZXKZNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:49 INFO - Running setup.py (path:/tmp/pip-F2P7NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:50 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)) 03:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:50 INFO - Running setup.py (path:/tmp/pip-JrYpHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:50 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)) 03:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:50 INFO - Running setup.py (path:/tmp/pip-TZOfCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:50 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)) 03:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:50 INFO - Running setup.py (path:/tmp/pip-f_giIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:50 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)) 03:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:50 INFO - Running setup.py (path:/tmp/pip-uw2R5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:50 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)) 03:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:50 INFO - Running setup.py (path:/tmp/pip-DEUQSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40: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)) 03:40:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:50 INFO - Running setup.py (path:/tmp/pip-EiROeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40: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)) 03:40:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:52 INFO - Downloading blessings-1.6.tar.gz 03:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:52 INFO - Installing collected packages: blessings 03:40:52 INFO - Running setup.py install for blessings 03:40:52 INFO - Successfully installed blessings 03:40:52 INFO - Cleaning up... 03:40:52 INFO - Return code: 0 03:40:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:52 INFO - Reading from file tmpfile_stdout 03:40:52 INFO - Current package versions: 03:40:52 INFO - argparse == 1.2.1 03:40:52 INFO - blessings == 1.6 03:40:52 INFO - blobuploader == 1.2.4 03:40:52 INFO - docopt == 0.6.1 03:40:52 INFO - functools32 == 3.2.3-2 03:40:52 INFO - jsonschema == 2.5.1 03:40:52 INFO - manifestparser == 1.1 03:40:52 INFO - mozInstall == 1.12 03:40:52 INFO - mozcrash == 0.17 03:40:52 INFO - mozdebug == 0.1 03:40:52 INFO - mozdevice == 0.48 03:40:52 INFO - mozfile == 1.2 03:40:52 INFO - mozhttpd == 0.7 03:40:52 INFO - mozinfo == 0.9 03:40:52 INFO - mozleak == 0.1 03:40:52 INFO - mozlog == 3.3 03:40:52 INFO - moznetwork == 0.27 03:40:52 INFO - mozprocess == 0.23 03:40:52 INFO - mozprofile == 0.28 03:40:52 INFO - mozrunner == 6.12 03:40:52 INFO - mozscreenshot == 0.1 03:40:52 INFO - mozsystemmonitor == 0.3 03:40:52 INFO - moztest == 0.7 03:40:52 INFO - mozversion == 1.4 03:40:52 INFO - psutil == 3.1.1 03:40:52 INFO - requests == 1.2.3 03:40:52 INFO - wsgiref == 0.1.2 03:40:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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 0xebe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', '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 03:40: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 03:40: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 03:40:52 INFO - Using env: {'DISPLAY': ':0', 03:40:52 INFO - 'HOME': '/home/cltbld', 03:40:52 INFO - 'LANG': 'en_US.UTF-8', 03:40:52 INFO - 'LANGUAGE': 'en_US:en', 03:40:52 INFO - 'LOGNAME': 'cltbld', 03:40:52 INFO - 'MAIL': '/var/mail/cltbld', 03:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:52 INFO - 'MOZ_NO_REMOTE': '1', 03:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:52 INFO - 'NO_EM_RESTART': '1', 03:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:52 INFO - 'PWD': '/builds/slave/test', 03:40:52 INFO - 'SHELL': '/bin/bash', 03:40:52 INFO - 'SHLVL': '1', 03:40:52 INFO - 'TERM': 'linux', 03:40:52 INFO - 'TMOUT': '86400', 03:40:52 INFO - 'USER': 'cltbld', 03:40:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:52 INFO - '_': '/tools/buildbot/bin/python'} 03:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:53 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)) 03:40:53 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)) 03:40:53 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)) 03:40:53 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)) 03:40:53 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)) 03:40:53 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)) 03:40:53 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)) 03:40:53 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)) 03:40:53 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)) 03:40:53 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)) 03:40:53 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)) 03:40:53 INFO - Cleaning up... 03:40:53 INFO - Return code: 0 03:40:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:53 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 0xebe030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10218a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ed400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, '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': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', '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 03:40:53 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 03:40:53 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 03:40:53 INFO - Using env: {'DISPLAY': ':0', 03:40:53 INFO - 'HOME': '/home/cltbld', 03:40:53 INFO - 'LANG': 'en_US.UTF-8', 03:40:53 INFO - 'LANGUAGE': 'en_US:en', 03:40:53 INFO - 'LOGNAME': 'cltbld', 03:40:53 INFO - 'MAIL': '/var/mail/cltbld', 03:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:53 INFO - 'MOZ_NO_REMOTE': '1', 03:40:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:40:53 INFO - 'NO_EM_RESTART': '1', 03:40:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:53 INFO - 'PWD': '/builds/slave/test', 03:40:53 INFO - 'SHELL': '/bin/bash', 03:40:53 INFO - 'SHLVL': '1', 03:40:53 INFO - 'TERM': 'linux', 03:40:53 INFO - 'TMOUT': '86400', 03:40:53 INFO - 'USER': 'cltbld', 03:40:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:53 INFO - '_': '/tools/buildbot/bin/python'} 03:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:40:53 INFO - Cleaning up... 03:40:53 INFO - Return code: 0 03:40:53 INFO - Running post-action listener: _resource_record_post_action 03:40:53 INFO - Running post-action listener: _start_resource_monitoring 03:40:53 INFO - Starting resource monitoring. 03:40:53 INFO - [mozharness: 2016-08-31 10:40:53.272791Z] Finished create-virtualenv step (success) 03:40:53 INFO - [mozharness: 2016-08-31 10:40:53.273260Z] Running install step. 03:40:53 INFO - Running pre-action listener: _resource_record_pre_action 03:40:53 INFO - Running main action method: install 03:40:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:53 INFO - Reading from file tmpfile_stdout 03:40:53 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:53 INFO - Reading from file tmpfile_stdout 03:40:53 INFO - Output received: 03:40:53 INFO - Usage: mozinstall [options] installer 03:40:53 INFO - Options: 03:40:53 INFO - -h, --help show this help message and exit 03:40:53 INFO - -d DEST, --destination=DEST 03:40:53 INFO - Directory to install application into. [default: 03:40:53 INFO - "/builds/slave/test"] 03:40:53 INFO - --app=APP Application being installed. [default: firefox] 03:40:53 INFO - mkdir: /builds/slave/test/build/application 03:40:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:41:09 INFO - Reading from file tmpfile_stdout 03:41:09 INFO - Output received: 03:41:09 INFO - /builds/slave/test/build/application/firefox/firefox 03:41:09 INFO - Running post-action listener: _resource_record_post_action 03:41:09 INFO - [mozharness: 2016-08-31 10:41:09.570168Z] Finished install step (success) 03:41:09 INFO - [mozharness: 2016-08-31 10:41:09.570442Z] Running run-tests step. 03:41:09 INFO - Running pre-action listener: _resource_record_pre_action 03:41:09 INFO - Running main action method: run_tests 03:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:41:09 INFO - Python 2.7.3 03:41:09 INFO - Return code: 0 03:41:09 INFO - grabbing minidump binary from tooltool 03:41: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')]} 03:41: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 0x117c570>, '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 0x117d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:41: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 03:41: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 03:41: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 03:41:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:41:09 INFO - Return code: 0 03:41:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:41:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:41:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:41:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:41:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 03:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 03:41:09 INFO - Using env: {'DISPLAY': ':0', 03:41:09 INFO - 'HOME': '/home/cltbld', 03:41:09 INFO - 'LANG': 'en_US.UTF-8', 03:41:09 INFO - 'LANGUAGE': 'en_US:en', 03:41:09 INFO - 'LOGNAME': 'cltbld', 03:41:09 INFO - 'MAIL': '/var/mail/cltbld', 03:41:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:41:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:41:09 INFO - 'MOZ_NO_REMOTE': '1', 03:41:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:41:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:41:09 INFO - 'NO_EM_RESTART': '1', 03:41:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:41:09 INFO - 'PWD': '/builds/slave/test', 03:41:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:41:09 INFO - 'SHELL': '/bin/bash', 03:41:09 INFO - 'SHLVL': '1', 03:41:09 INFO - 'TERM': 'linux', 03:41:09 INFO - 'TMOUT': '86400', 03:41:09 INFO - 'USER': 'cltbld', 03:41:09 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060', 03:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:41:09 INFO - '_': '/tools/buildbot/bin/python'} 03:41:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 03:41:09 INFO - mozversion application_buildid: 20160831004001 03:41:09 INFO - mozversion application_changeset: 7177e736768960cd807440961beee561ca7ce582 03:41:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:41:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:41:09 INFO - mozversion application_name: Firefox 03:41:09 INFO - mozversion application_remotingname: firefox-dev 03:41:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:09 INFO - mozversion application_vendor: Mozilla 03:41:09 INFO - mozversion application_version: 50.0a2 03:41:09 INFO - mozversion platform_buildid: 20160831004001 03:41:09 INFO - mozversion platform_changeset: 7177e736768960cd807440961beee561ca7ce582 03:41:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:41:09 INFO - mozversion platform_version: 50.0a2 03:41:09 INFO - using testdate: 1472640069 03:41:09 INFO - actual date: 1472640069 03:41:09 INFO - starting webserver on 'localhost:60424' 03:41:09 INFO - SUITE-START | Running 2 tests 03:41:09 INFO - TEST-START | dromaeo_css 03:41:09 INFO - operating with platform_type : linux_ 03:41:09 INFO - Initialising browser for dromaeo_css test... 03:41:09 INFO - TEST-INFO | started process 28829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEamubi/profile http://localhost:60424/getInfo.html) 03:41:14 INFO - PROCESS | 28829 | __metrics Screen width/height:1600/1200 03:41:14 INFO - PROCESS | 28829 | colorDepth:24 03:41:14 INFO - PROCESS | 28829 | Browser inner width/height: 1024/697 03:41:14 INFO - PROCESS | 28829 | __metrics 03:41:15 ERROR - PROCESS | 28829 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:41:15 INFO - TEST-INFO | 28829: exit 0 03:41:15 INFO - Browser initialized. 03:41:15 INFO - Running cycle 1/1 for dromaeo_css test... 03:41:15 INFO - TEST-INFO | started process 28959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEamubi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:41:27 INFO - PROCESS | 28959 | RSS: Main: 152662016 03:41:27 INFO - PROCESS | 28959 | 03:42:17 INFO - PROCESS | 28959 | 1472640137145 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] 03:44:25 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:60424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60424/tests/dromaeo/cssquery-ext.html) 03:44:27 INFO - PROCESS | 28959 | RSS: Main: 158564352 03:44:27 INFO - PROCESS | 28959 | 03:47:29 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:60424/tests/dromaeo/cssquery-ext.html (next: http://localhost:60424/tests/dromaeo/cssquery-jquery.html) 03:47:29 INFO - PROCESS | 28959 | RSS: Main: 153665536 03:47:29 INFO - PROCESS | 28959 | 03:50:31 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:60424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60424/tests/dromaeo/cssquery-mootools.html) 03:50:32 INFO - PROCESS | 28959 | RSS: Main: 154222592 03:50:32 INFO - PROCESS | 28959 | 03:53:33 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:60424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60424/tests/dromaeo/cssquery-prototype.html) 03:53:34 INFO - PROCESS | 28959 | RSS: Main: 152309760 03:53:34 INFO - PROCESS | 28959 | 03:56:36 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:60424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60424/tests/dromaeo/cssquery-yui.html) 03:56:37 INFO - PROCESS | 28959 | RSS: Main: 155480064 03:56:37 INFO - PROCESS | 28959 | 03:59:39 INFO - PROCESS | 28959 | Cycle 1(1): loaded http://localhost:60424/tests/dromaeo/cssquery-yui.html (next: http://localhost:60424/tests/dromaeo/cssquery-dojo.html) 03:59:40 INFO - PROCESS | 28959 | RSS: Main: 155275264 03:59:40 INFO - PROCESS | 28959 | 03:59:40 INFO - PROCESS | 28959 | __start_tp_report 03:59:40 INFO - PROCESS | 28959 | _x_x_mozilla_page_load 03:59:40 INFO - PROCESS | 28959 | _x_x_mozilla_page_load_details 03:59:40 INFO - PROCESS | 28959 | |i|pagename|runs| 03:59:40 INFO - PROCESS | 28959 | |0;dojo.html;3279.360524697684;3332.0670212340538;3334.3831391192625;3342.4484959981605;3343.715784158346;5695.74369153388;5699.430056994299;5726.3700992890745;5752.0509115995865;5795.913061304073;5647.37878833328;5770.047942089561;5771.249737534125;5784.56615753818;5803.854903627412;5158.40678321994;5220.190870415092;5250.291210686547;5292.126799078167;5292.947070529303;5112.41207261166;5126;5185.585153187736;5202.193659982709;5272;5178.741062946857;5181.378234611833;5197.012567612161;5198.532132108109;5236.450172731866;5253.0544501989625;5257.737113144328;5258.947410525903;5260.579153667697;5298.708571028592;5023.924641130386;5096.490350964911;5138.948610513922;5152.407473140599;5152.587792976553;5720.342160651495;5752.741126649311;5761.366249712528;5778.711064446803;5809.099589563624;6164.476019538344;6164.568480206387;6204.565680402374;6210.378962103799;6216.564840461169;5934.43622855828;6100.908486372708;6141.232345956755;6262.436380725757;6271.905921411182;5743.45437183471;5747.051736463479;5759.942400576025;5764.855878603026;5788.392218817048;6322.620642761449;6328.050792381179;6338.334474880071;6356.141920840627;6356.332585078592;5813.157092221689;5976.163337132805;6014.548908831855;6016.2479690038745;6045.697715114315;6151.446369826737;6194.008958566697;6207.224096987877;6213.378662133841;6216.7824126155365;6134.079888016833;6146.815595532141;6150.876982460326;6155.045967874987;6161.44546990773;5901.203337549462;6008.819735407945;6053.3946605339115;6108.297545782292;6210.037444196157;4683.391159149289;4698.530146985342;4701.576858082789;4710.764461776897;4714.198586240347;4204.873853784391;4209.34755112958;4212.241796476603;4214.4310518079665;4234.449521562177;5658.292713410824;5780.624259423124;5855.912161317584;5871.412858714094;5877.177195192677;6204.3795620437595;6204.720787564571;6219.191505104398;6231.594946328474;6248.875022499616;5862.912056319158;5873.089671100986;5895.764169433174;5902.085176797603;5950.166976623276;5133.768980395891;5215.55667768244;5283.4452382499285;5330.093884039723;5345.625806193529;6373.139626150503;6407.615543067338;6442.291347951722;6449.290578036413;6455;6148.262208535004;6213.347598502092;6230.314665386894;6241;6269.185005949197;6121.908171377522;6307.7476900925285;6328.050792381179;6369.9681501592195;6407.199100112486;6092.390760923872;6092.543059270483;6095.451409373;6102.389761023862;6114.785982490592;6186.566940314135;6198.070289456437;6227.283862355887;6244.781432649836;6245.5628106032145;5796.333421656564;5965.105234214902;5971.611845230046;6098.603590766586;6109.877802443837;5982.042873140451;5989.520838332835;6006.039033754579;6057.273127224585;6064.241969753781;5875.559333049953;5935.910961335497;5981.431763982415;5998.130271110752;6002.399760023963;5866.94133058681;5874.089516125007;6035;6043.244594425697;6077.453029227391;5998.850028749316;6001.459868611846;6020.54845886569;6024.0662697282;6026.427489388501 03:59:40 INFO - PROCESS | 28959 | |1;ext.html;587.1896782440232;638.6838514935105;653.6176336842948;669.1234482827497;695.9860802783942;39489.4076588851;45317.77341113298;45372;45513.544864551346;45683.31475027873;45721.08557828842;45790.54209457905;45942.7702861486;46057.7697111514;46542.534574654244;9027.458352498837;9138.040505746867;9141.862872056925;9163.312751543628;9200.677976270832;8876.423032502867;8928.598213080428;8938.284937205008;8959;8990.820183596325;9024.503652299121;9036.68371606994;9076.092390760938;9107.089291070906;9141.222996045344;9027.909720902839;9053.411528250675;9091.727248182531;9118.726438206864;9131.36080474367;9016.504092274923;9105.544722763836;9139.314551408672;9150.176484116395;9171.128742769426;42878.57121428777;43480.13039739219;43480.347794783105;43535.34696979548;43535.78232108819;3180.6024246969127;3693.519842420468;3877.592852750477;4325.091730736549;4471.754053527055;32604.510932336034;32859;32891.17772055694;33074.66925330764;34004.14989625279;4392.758398288093;4482.282834746457;4521.480029796583;4527.096928219009;4568.954310456887;345869;348591;349318.2534087339;349415;349863;37477;37629.24741505155;37634.62365376311;37661.24677506435;37678.81160594234;39121.6087839118;39826.80086599549;40276.39585406221;42287.57712422898;42380.15239695189;18337.899726016483;18346.082695865152;18523.35168269104;18566.350177743716;18748.25006999732;15081.396744130332;15125.54623361301;15142.242887855784;15143.242837858063;15208.619784505476;20910.163593456396;20940.58118837645;21100.261490847748;21170.835604041924;21259.46851328729;7648.885266721004;7680.385569154454;7794.2985131338455;7842.686292548348;7944.6822127114265;1052.7894421115807;1121.8261169518737;1126.2285334545863;1128.2609890521721;1134.1777211521746;33936.32127357439;33981.66018339785;34039;34407.65592344094;34484;1152.5620264299512;1172.976540469186;1183.9526418943146;1279.9040071994452;1286.6526037969695;17321.04734239629;18022.819771802377;18024;18071.72892406615;18084.37240648348;610601;614914;615971;617483;618935;41441.1711765763;42160.57839421566;42210.57789422128;42223.1555368897;42313;1436.7772995185553;1445.949391771283;1470.4853301344444;1470.985290147085;1471.9852801472277;31375.529367059968;33753.64985400556;34020.65979340175;34182.487262690585;34223;56869;56900.430995689516;56993.43006570047;57058.7147064262;57220.71389643025;403576;404896;406275;408932;408983;30631;30801.537976929914;30898.227544311572;31034.224144396572;31274.687253127177;52723.736381317845;52790.73604631952;53320.2001969963;53466.46533534615;54393.45606544042;44696.55303446924;44943;45637.315440269085;45886.77056614696;46804.7659761699;43506.56493435025;44382.77808610936;44554.10891782211;44904.77547612241;45584.77207613941;44196.337054944845;45480.772596136805;45493;45957.540424595325;48422;37910;39262.01844953899;39420.40869386904;39615.603843962344;40311;30147.040442371177;30150.69849301479;30246.54630180505;30536.541951870295;30930.226744331572 03:59:40 INFO - PROCESS | 28959 | |2;jquery.html;395.76452011053414;405.98985025374344;415.85652949732344;416.3359441690504;431.70212553338195;18641.533961650966;20003.1998720051;20011;20039.499012524677;20568.794312056874;12903.354832258374;13210.537631182911;17461;20530.897345513287;20807.27174548891;5341.038613049659;5409.729513524328;5424.945750542503;5456.563474921997;5481.945180548203;5268.8155914542995;5389.299391079174;5414;5419.945800542003;5420.539254163401;5372.140457526796;5400.216968539559;5682.26130603021;5908.291005079396;5912.852178695524;5956.761729530814;5989.161517387569;6015.218021657157;6021.217241758565;6041.063635136539;5962.284525856881;6046.183765191687;6068.059450785136;6073.908891366633;6088.4520393164385;17965.910170449064;24410.511789764107;24439.755602443925;25082.24753257387;25162.370940726447;2378.5242951409787;2480.4790993891306;2549.9490010199693;2579.87100644967;3128.1866714654125;10251.948740256326;10872.891271087266;11319.094472442184;13753.449862005507;14139.717205655828;2028.5131568423471;2095.6018356512213;2106.147010460766;2120.5546835164632;2185.715856938604;85055;85900.57049714711;86728.56635716844;87090.56454717749;87982;11237.55049797999;11403.543858245743;11456.140789440826;11460.713482162846;11546.134039947037;16160.27278772458;16179.919100404422;16180.919095404683;16239.59401014984;16260.75608865868;7914.44598878073;7938.404619653549;8061.959690201512;8117.4317797754775;8120.431569790177;7358.190599034102;7399.890016497461;7423.703051877972;7474.70101195957;7490.966158705733;4870.14772414826;4923.286123512071;4947.233178857283;4961.603071754251;4997.85006449807;2008.8493362997833;2096.989515052415;2121.854198732667;2144.624690679125;2159.751628562704;949.6296444386695;996.0885789502524;1044.2951008069522;1057.7408534908843;1071.4803320389606;20743;20814.37556873296;21170.894145529175;21289.254876079263;21352.039158237916;1052.4106500359824;1069.588208539718;1076.8600081989448;1088.7985722641338;1130.2032067392468;11607.941960290145;11692;11786.351750653625;11920.10599205063;11925.34410607425;403643;403729;410709;514988;515595;97821.51089244508;98628;99012;100761;101186.49406752919;1039.880413752413;1049.4700176411015;1083.0360978728938;1085.4626959654863;1093.4642025407493;18637.347692830685;19007.42977710671;19049.71425428592;19313.710294345878;19328.4201473956;32919.83540082284;43659.56340436555;43884.78057609691;44307.77846110878;44889.32666009947;61977;64052.35947640464;65039.67480162569;65467.34532654612;65998.34001659922;8902.243309318781;9151.908480915106;9240.584173712334;9289.814203715752;9296.72109836706;10929.945350273516;13325.933370333087;13853.584392468241;13855.237961912191;13944.30278486092;10960;11151.776964460827;11227.831582526433;11293.37886416255;11671.59149429766;11859.881401185878;12052.578159764365;12389.380530973596;12443;12702.68243293888;11112.277701949348;11405.942970285096;11575.42122893835;11644.184907056764;11963.880361196276;8608.182222688834;8791.472511649066;8802.955985220033;8805.42764720291;9213.170814626716;11136.554537818396;11256.887431125584;11305.7738845221;11373.658790236306;11436.313821170756 03:59:40 INFO - PROCESS | 28959 | |3;mootools.html;1533.8389469105741;1552.9068255904647;1729.360136749403;1827.9908600456995;1867.7105048717444;8208.261256486914;8621.879155709757;8726.563671816415;9219.446833190004;9298.25613950884;8823.382363234576;9091.18179363857;9132.452052876832;9141.085891410856;9171.128742769442;2448.5959816630234;2488.489859578791;2494.052260141144;2497.463045445229;2503.561876671575;2410.385351735305;2486.6643003194517;2489.80081593473;2495.8128140389454;2496.588062969608;2423.4062654649547;2425.575524283252;2443.8778061096964;2446.412860913377;2453.1659235859806;2398.6162214045758;2411.565918134735;2417.62526808345;2478.1821998740375;2482.2056941778637;2353;2384.332386931662;2397.1250493569896;2409.807215422762;2414.746451622572;8970.910290897138;9100.180983711432;9111.908880911173;9115.680951166678;9150.908490915072;5312.495312945264;5470.781168753245;5493.258410114623;5502.862428439321;5506.366767821672;3562.7684200526883;3607;3688.4651725499652;3699.815009249554;3739.158689294914;1183.7514122034383;1214.7023979125083;1251.5744646820124;1256.1018871506826;1279.622511359142;12491.437885295183;12521.248725076433;12559.120861539695;12571.371431428484;12597.559085432058;4647.442306923191;4771.832985845479;4805.8558243252055;4842.6368022398465;4881.316615673809;10497.265191436527;10580.89419105799;10608.946955265328;10610.575576976835;10620.628278010232;5470.370907345627;5470.398256191816;5497.422770609029;5506.476884695948;5521.5306698931045;4435.2903535434825;4918.9508104919205;5104.03023425548;5114.181730923035;5170.6380553360905;4117.5676553962;4126.628603425706;4140.47803611193;4192.266353388145;4206.936895946563;1292.6186774901428;1307.607717684691;1309.7707901117458;1312.9474821007243;1323.4904561743606;941.4445477168504;1000.5447521377756;1069.6202847988852;1099.7085772270354;1101.372217835826;6021.488173505301;6256.343083976117;6389.393007664265;6394;6477.740890364427;1019.8572199891872;1070.6734445994045;1085.3270971997254;1099.1316859680921;1122.7810576937582;3577.3024260269517;3720.479132921393;4045.1707399982934;4212.53662097169;4337.8481753138485;10915.345079295268;11199.552017919355;11210.991010809066;11294.94352528232;11344.716382090513;10936.343819370863;11154.609588664358;11215;11238.325700458;11255.437228138724;8369;8484.19400156984;8493.915060849436;8526.190011948855;8545.48727076365;6314.810555683337;6357.586756860789;6366.2360516736435;6396.936030639634;6416.615003099829;10367.585296588353;10368.948155259175;10392.42841643717;10447.373157610567;10572.524236409534;10463.529141188817;10547.789044219226;10678.519466623866;10727.839082413613;10783.51474183648;6987.847005244281;7468.701251949861;7553.32020118192;7715.189905059888;7743.186965368781;8932.50871202064;9003.14470125337;9019.368644194843;9035.412698174598;9037.051109633394;7728.227177282227;7766.145723970246;7988.201179881965;8004.399670024888;8096.919030809852;7869.213078692085;7945.8410831784195;8008.039035315799;8106.918930810616;8202.343812494866;7037.542559733601;7208.56748595086;7303.817404564928;7325.706971721072;7340.2292759261645;5151.253068305;5200.063988481958;5215.113430716863;5263.973680131575;5310.9734451327495;5212.713300768494;5369.838904832861;5415.458454154553;5490.890182196254;5520.171974203901 03:59:40 INFO - PROCESS | 28959 | |4;prototype.html;333.56303242751994;345.8789423701704;349.3380044815075;356.6985896917104;359.76794967246144;5751.338596061454;5764.674124951263;5877.265341832271;5892.204552385427;5906.704664766766;5726.112452569848;5747.827565173041;5767.538596912247;5803.448672376117;5809.941900580993;4519.615832654228;4526.117407105616;4529.614982726473;4531.478879928801;4537.636989040869;4467.262901621229;4504.481984571767;4514.706544074641;4525.841595544157;4533.387992620987;4445.755483448409;4447.888802779924;4455.732656040648;4464.526706186951;4481.955180448186;4449.132419178278;4476.306172543261;4476.865694029184;4528.215147684184;4529.275315949465;3890.8832735017995;3913.6673382762215;3926.980365098185;4006.238814625212;4013;5628.212050312959;5640.492355687967;5648.74580643872;5690.089585666315;5744.540436765049;5132.948670513284;5167.715775632339;5204.9219261711105;5213.897730850138;5223.1642937130255;5874.706264686749;6068.180795592627;6068.453839154453;6077.149199112084;6094.725737341831;4313.805878735465;4345.1961387143165;4387.100644367897;4388.451443569554;4388.517263101056;6156.815295541096;6405.19935008124;6442.387973142544;6464.93535064648;6468.57954232978;4411.691181617321;4421.358902959053;4436.378906953029;4445.488768791631;4462.598366147063;4550.4301016149375;4555.863324100283;4560.153137979124;4566.452025756864;4573.862784116482;5187.351581052369;5191.273221748958;5208.765605547759;5243.134882744381;5255.63210575256;5895.20414744004;5931.1992880960515;6110.358412366726;6113.510919126459;6140.478059364915;1530.143119852886;1551.1158639575333;1553.4873491747696;1554.098622798774;1555.3312075807512;946.914777670013;973.2749101919115;986.4475893499663;993.2203220472039;1005.6580762540772;5071.54356107952;5193.714345710947;5244.396894357198;5246.396664383568;5255.239494769218;5432.70120143388;5457.154141108134;5503.642263252876;5538.473844984801;5541.695206763586;5100.69395836251;5250.369955605275;5285.920711189336;5286.017743346245;5305.522502974751;2938.765718398278;2971.465136275448;2981.38881529286;3005.5792189093545;3026.228311780482;5641.887162256732;5734.741936612862;5753.683547404933;5755.366909639936;5758.193852860602;5263.947360526346;5590.797978434574;5615.6630602164005;5622.662640241599;5663.725661726078;5575.972120139373;5673.914891276634;5707.800226992118;5734.426557344233;5739.282589676291;5148.716820574904;5484.8354549363585;5487.368952570346;5504.504594586507;5507.394186639546;5396.83809485716;5399.406065332889;5428.131498960305;5429.647072940246;5452.318460192476;5682.272509195526;5706.429357064427;5718.085106382959;5785.541145013269;5799.753053093606;3907.9413808792324;3948.8943095933187;4006.739561928582;4064.6748260138525;4077.4903137107863;5460.535854452416;5473.589480788877;5492.972535137299;6173.722182501888;6355.7457701693265;6168.167297414791;6213.658248796179;6236.438720515175;6249.187605611241;6252.687365631791;6051.848703782441;6204.7828326008375;6238.625682459067;6244.875102498016;6291.182146320949;6090.23872015998;6103.84740381494;6145;6155.876882462415;6180.165677633462;6208.286047104641;6210.937890621036;6212.720427580679;6218.378162183745;6271.3415091414745;5899.970500147472;6012;6027.397260273938;6049.546284028627;6077.726502307495 03:59:40 INFO - PROCESS | 28959 | |5;yui.html;824.0646865807311;830.8379865926144;861.9612117454714;915.7390143809014;940.5767404667902;15039.548813535597;17730.11349432528;17877.195526201318;18002.729959050626;18054.638907221848;15909.44316948907;15930.362785488567;16083.276252568634;16115.516534503955;16183.514494565152;837.1126605797843;881.5944665453899;882.0826340605762;884.385352180235;887.2724366019867;891.095538028898;894.2801045158644;896.2874514760748;897.3359713811798;897.3718397122008;918.5774543709902;923.9722808315728;931.3387494878644;932.9393589416666;934.0192797562567;919.3288899103625;919.5815903763805;920.2683866326253;920.9907900920972;923.3674932671141;675.8411773233287;679.178194384795;682.8839097353413;684.2541629623734;684.7295318349225;14924.62688432787;14974.775378369333;15049.322780474795;15054.698906021928;15121.395144194219;11857.94071029648;13543.255120968342;14599.416023359054;14699.559013229513;14849.628759280997;14124.50564230247;14277;14848;15024.699506009927;15398.769018464733;4760.238361862085;4800.135975524404;4821.059893320804;4834.564889159992;4960.801567937278;65339.3466065338;70411.64794176047;73283;73378.26621733821;92183.53908230484;12533.185342952678;12740.681482963;12778.68053298675;12896.097273190975;12962.611121666365;21711.240106596193;22567.661485077737;22701.318960430883;22708.432289192573;22967;9348.766280843034;9467.952660236655;9599.42403455781;9901.306908516335;10054.34646747959;5179.2749015137915;5201.271821944931;5209.583233341324;5303.496167864047;5306.416294207634;3825.7513261637905;3925.8822235332987;3935.252302062599;3946.1515774108702;3971.5035620547433;671.1007250284642;680.1939701453794;680.7685386968454;718.3175982816346;718.5616773767997;715.427657873699;763.267263427105;777.5101685937937;792.3423558446476;797.9281864632211;10494.527746251437;10969.341839489656;10974.341539507655;11114.499847506882;11231.831522527169;581.5492992930513;602.9517638588902;643.6009674002148;675.8341860291057;697.7976386847757;4892.143874821892;4922.556969872729;4997.525235102659;5008.048470790538;5025.974870125699;113822;135461;135653;140149;143273.28363358116;118127.40936295263;119191;120420.39789800995;122593.38703306427;122665;101029;102335.48832255791;103541;103976.48011760044;105418.94581054091;9118.84684541111;9464.384814987005;9536.952315238379;9581.856272155785;9633.036696330591;49534;60273;61036;61147;62414.68792656008;53644.73177634087;70985.29014709993;80849.59575202086;80900;83410;14023.929880350533;14197.716045678822;14393.64015899611;14422.423103076178;14576.344064517334;14522.709545809235;14770.852291476947;15240.390384384944;16174.67650646957;16464.259108340393;13421.865781342452;13999.930000349934;14130.15219086858;14145.858541414455;15092.471763488225;13756.243406612732;14261.572152835432;14495.855041449451;15199.544013679608;15420.537383878502;14962.850371496581;15006.549803505912;15025.549233523012;15101.622459438602;15340;10652.8934710655;11087.113030957342;11141.83287250708;11242.494087765906;11345.943270283597;12289.754204915673;12530.749385012066;12699.492020319083;12839.358032098171;13160.40778165004 03:59:40 INFO - PROCESS | 28959 | __end_tp_report 03:59:40 INFO - PROCESS | 28959 | __start_cc_report 03:59:40 INFO - PROCESS | 28959 | _x_x_mozilla_cycle_collect,320 03:59:40 INFO - PROCESS | 28959 | __end_cc_report 03:59:40 INFO - PROCESS | 28959 | __startTimestamp1472641180184__endTimestamp 03:59:40 INFO - PROCESS | 28959 | 03:59:40 INFO - PROCESS | 28959 | ------- Summary: start ------- 03:59:40 INFO - PROCESS | 28959 | Number of tests: 6 03:59:40 INFO - PROCESS | 28959 | 03:59:40 INFO - PROCESS | 28959 | [#0] dojo.html Cycles:165 Average:5719.08 Median:5950.17 stddev:658.89 (11.1%) stddev-sans-first:632.50 03:59:40 INFO - PROCESS | 28959 | Values: 3279.4 3332.1 3334.4 3342.4 3343.7 5695.7 5699.4 5726.4 5752.1 5795.9 5647.4 5770.0 5771.2 5784.6 5803.9 5158.4 5220.2 5250.3 5292.1 5292.9 5112.4 5126.0 5185.6 5202.2 5272.0 5178.7 5181.4 5197.0 5198.5 5236.5 5253.1 5257.7 5258.9 5260.6 5298.7 5023.9 5096.5 5138.9 5152.4 5152.6 5720.3 5752.7 5761.4 5778.7 5809.1 6164.5 6164.6 6204.6 6210.4 6216.6 5934.4 6100.9 6141.2 6262.4 6271.9 5743.5 5747.1 5759.9 5764.9 5788.4 6322.6 6328.1 6338.3 6356.1 6356.3 5813.2 5976.2 6014.5 6016.2 6045.7 6151.4 6194.0 6207.2 6213.4 6216.8 6134.1 6146.8 6150.9 6155.0 6161.4 5901.2 6008.8 6053.4 6108.3 6210.0 4683.4 4698.5 4701.6 4710.8 4714.2 4204.9 4209.3 4212.2 4214.4 4234.4 5658.3 5780.6 5855.9 5871.4 5877.2 6204.4 6204.7 6219.2 6231.6 6248.9 5862.9 5873.1 5895.8 5902.1 5950.2 5133.8 5215.6 5283.4 5330.1 5345.6 6373.1 6407.6 6442.3 6449.3 6455.0 6148.3 6213.3 6230.3 6241.0 6269.2 6121.9 6307.7 6328.1 6370.0 6407.2 6092.4 6092.5 6095.5 6102.4 6114.8 6186.6 6198.1 6227.3 6244.8 6245.6 5796.3 5965.1 5971.6 6098.6 6109.9 5982.0 5989.5 6006.0 6057.3 6064.2 5875.6 5935.9 5981.4 5998.1 6002.4 5866.9 5874.1 6035.0 6043.2 6077.5 5998.9 6001.5 6020.5 6024.1 6026.4 03:59:40 INFO - PROCESS | 28959 | 03:59:40 INFO - PROCESS | 28959 | [#1] ext.html Cycles:180 Average:61424.98 Median:42255.37 stddev:125256.61 (296.4%) stddev-sans-first:125524.70 03:59:40 INFO - PROCESS | 28959 | Values: 587.2 638.7 653.6 669.1 696.0 39489.4 45317.8 45372.0 45513.5 45683.3 45721.1 45790.5 45942.8 46057.8 46542.5 9027.5 9138.0 9141.9 9163.3 9200.7 8876.4 8928.6 8938.3 8959.0 8990.8 9024.5 9036.7 9076.1 9107.1 9141.2 9027.9 9053.4 9091.7 9118.7 9131.4 9016.5 9105.5 9139.3 9150.2 9171.1 42878.6 43480.1 43480.3 43535.3 43535.8 3180.6 3693.5 3877.6 4325.1 4471.8 32604.5 32859.0 32891.2 33074.7 34004.1 4392.8 4482.3 4521.5 4527.1 4569.0 345869.0 348591.0 349318.3 349415.0 349863.0 37477.0 37629.2 37634.6 37661.2 37678.8 39121.6 39826.8 40276.4 42287.6 42380.2 18337.9 18346.1 18523.4 18566.4 18748.3 15081.4 15125.5 15142.2 15143.2 15208.6 20910.2 20940.6 21100.3 21170.8 21259.5 7648.9 7680.4 7794.3 7842.7 7944.7 1052.8 1121.8 1126.2 1128.3 1134.2 33936.3 33981.7 34039.0 34407.7 34484.0 1152.6 1173.0 1184.0 1279.9 1286.7 17321.0 18022.8 18024.0 18071.7 18084.4 610601.0 614914.0 615971.0 617483.0 618935.0 41441.2 42160.6 42210.6 42223.2 42313.0 1436.8 1445.9 1470.5 1471.0 1472.0 31375.5 33753.6 34020.7 34182.5 34223.0 56869.0 56900.4 56993.4 57058.7 57220.7 403576.0 404896.0 406275.0 408932.0 408983.0 30631.0 30801.5 30898.2 31034.2 31274.7 52723.7 52790.7 53320.2 53466.5 54393.5 44696.6 44943.0 45637.3 45886.8 46804.8 43506.6 44382.8 44554.1 44904.8 45584.8 44196.3 45480.8 45493.0 45957.5 48422.0 37910.0 39262.0 39420.4 39615.6 40311.0 30147.0 30150.7 30246.5 30536.5 30930.2 03:59:40 INFO - PROCESS | 28959 | 03:59:40 INFO - PROCESS | 28959 | [#2] jquery.html Cycles:180 Average:28639.13 Median:2282.12 stddev:75279.35 (3298.7%) stddev-sans-first:75460.65 03:59:40 INFO - PROCESS | 28959 | Values: 395.8 406.0 415.9 416.3 431.7 18641.5 20003.2 20011.0 20039.5 20568.8 12903.4 13210.5 17461.0 20530.9 20807.3 5341.0 5409.7 5424.9 5456.6 5481.9 5268.8 5389.3 5414.0 5419.9 5420.5 5372.1 5400.2 5682.3 5908.3 5912.9 5956.8 5989.2 6015.2 6021.2 6041.1 5962.3 6046.2 6068.1 6073.9 6088.5 17965.9 24410.5 24439.8 25082.2 25162.4 2378.5 2480.5 2549.9 2579.9 3128.2 10251.9 10872.9 11319.1 13753.4 14139.7 2028.5 2095.6 2106.1 2120.6 2185.7 85055.0 85900.6 86728.6 87090.6 87982.0 11237.6 11403.5 11456.1 11460.7 11546.1 16160.3 16179.9 16180.9 16239.6 16260.8 7914.4 7938.4 8062.0 8117.4 8120.4 7358.2 7399.9 7423.7 7474.7 7491.0 4870.1 4923.3 4947.2 4961.6 4997.9 2008.8 2097.0 2121.9 2144.6 2159.8 949.6 996.1 1044.3 1057.7 1071.5 20743.0 20814.4 21170.9 21289.3 21352.0 1052.4 1069.6 1076.9 1088.8 1130.2 11607.9 11692.0 11786.4 11920.1 11925.3 403643.0 403729.0 410709.0 514988.0 515595.0 97821.5 98628.0 99012.0 100761.0 101186.5 1039.9 1049.5 1083.0 1085.5 1093.5 18637.3 19007.4 19049.7 19313.7 19328.4 32919.8 43659.6 43884.8 44307.8 44889.3 61977.0 64052.4 65039.7 65467.3 65998.3 8902.2 9151.9 9240.6 9289.8 9296.7 10929.9 13325.9 13853.6 13855.2 13944.3 10960.0 11151.8 11227.8 11293.4 11671.6 11859.9 12052.6 12389.4 12443.0 12702.7 11112.3 11405.9 11575.4 11644.2 11963.9 8608.2 8791.5 8803.0 8805.4 9213.2 11136.6 11256.9 11305.8 11373.7 11436.3 03:59:40 INFO - PROCESS | 28959 | 03:59:40 INFO - PROCESS | 28959 | [#3] mootools.html Cycles:180 Average:6002.61 Median:4199.60 stddev:3364.64 (80.1%) stddev-sans-first:3357.32 03:59:40 INFO - PROCESS | 28959 | Values: 1533.8 1552.9 1729.4 1828.0 1867.7 8208.3 8621.9 8726.6 9219.4 9298.3 8823.4 9091.2 9132.5 9141.1 9171.1 2448.6 2488.5 2494.1 2497.5 2503.6 2410.4 2486.7 2489.8 2495.8 2496.6 2423.4 2425.6 2443.9 2446.4 2453.2 2398.6 2411.6 2417.6 2478.2 2482.2 2353.0 2384.3 2397.1 2409.8 2414.7 8970.9 9100.2 9111.9 9115.7 9150.9 5312.5 5470.8 5493.3 5502.9 5506.4 3562.8 3607.0 3688.5 3699.8 3739.2 1183.8 1214.7 1251.6 1256.1 1279.6 12491.4 12521.2 12559.1 12571.4 12597.6 4647.4 4771.8 4805.9 4842.6 4881.3 10497.3 10580.9 10608.9 10610.6 10620.6 5470.4 5470.4 5497.4 5506.5 5521.5 4435.3 4919.0 5104.0 5114.2 5170.6 4117.6 4126.6 4140.5 4192.3 4206.9 1292.6 1307.6 1309.8 1312.9 1323.5 941.4 1000.5 1069.6 1099.7 1101.4 6021.5 6256.3 6389.4 6394.0 6477.7 1019.9 1070.7 1085.3 1099.1 1122.8 3577.3 3720.5 4045.2 4212.5 4337.8 10915.3 11199.6 11211.0 11294.9 11344.7 10936.3 11154.6 11215.0 11238.3 11255.4 8369.0 8484.2 8493.9 8526.2 8545.5 6314.8 6357.6 6366.2 6396.9 6416.6 10367.6 10368.9 10392.4 10447.4 10572.5 10463.5 10547.8 10678.5 10727.8 10783.5 6987.8 7468.7 7553.3 7715.2 7743.2 8932.5 9003.1 9019.4 9035.4 9037.1 7728.2 7766.1 7988.2 8004.4 8096.9 7869.2 7945.8 8008.0 8106.9 8202.3 7037.5 7208.6 7303.8 7325.7 7340.2 5151.3 5200.1 5215.1 5264.0 5311.0 5212.7 5369.8 5415.5 5490.9 5520.2 03:59:40 INFO - PROCESS | 28959 | 03:59:40 INFO - PROCESS | 28959 | [#4] prototype.html Cycles:180 Average:4927.87 Median:5467.06 stddev:1435.11 (26.3%) stddev-sans-first:1397.09 03:59:40 INFO - PROCESS | 28959 | Values: 333.6 345.9 349.3 356.7 359.8 5751.3 5764.7 5877.3 5892.2 5906.7 5726.1 5747.8 5767.5 5803.4 5809.9 4519.6 4526.1 4529.6 4531.5 4537.6 4467.3 4504.5 4514.7 4525.8 4533.4 4445.8 4447.9 4455.7 4464.5 4482.0 4449.1 4476.3 4476.9 4528.2 4529.3 3890.9 3913.7 3927.0 4006.2 4013.0 5628.2 5640.5 5648.7 5690.1 5744.5 5132.9 5167.7 5204.9 5213.9 5223.2 5874.7 6068.2 6068.5 6077.1 6094.7 4313.8 4345.2 4387.1 4388.5 4388.5 6156.8 6405.2 6442.4 6464.9 6468.6 4411.7 4421.4 4436.4 4445.5 4462.6 4550.4 4555.9 4560.2 4566.5 4573.9 5187.4 5191.3 5208.8 5243.1 5255.6 5895.2 5931.2 6110.4 6113.5 6140.5 1530.1 1551.1 1553.5 1554.1 1555.3 946.9 973.3 986.4 993.2 1005.7 5071.5 5193.7 5244.4 5246.4 5255.2 5432.7 5457.2 5503.6 5538.5 5541.7 5100.7 5250.4 5285.9 5286.0 5305.5 2938.8 2971.5 2981.4 3005.6 3026.2 5641.9 5734.7 5753.7 5755.4 5758.2 5263.9 5590.8 5615.7 5622.7 5663.7 5576.0 5673.9 5707.8 5734.4 5739.3 5148.7 5484.8 5487.4 5504.5 5507.4 5396.8 5399.4 5428.1 5429.6 5452.3 5682.3 5706.4 5718.1 5785.5 5799.8 3907.9 3948.9 4006.7 4064.7 4077.5 5460.5 5473.6 5493.0 6173.7 6355.7 6168.2 6213.7 6236.4 6249.2 6252.7 6051.8 6204.8 6238.6 6244.9 6291.2 6090.2 6103.8 6145.0 6155.9 6180.2 6208.3 6210.9 6212.7 6218.4 6271.3 5900.0 6012.0 6027.4 6049.5 6077.7 03:59:40 INFO - PROCESS | 28959 | 03:59:40 INFO - PROCESS | 28959 | [#5] yui.html Cycles:180 Average:23095.19 Median:13396.38 stddev:34415.34 (256.9%) stddev-sans-first:34471.25 03:59:40 INFO - PROCESS | 28959 | Values: 824.1 830.8 862.0 915.7 940.6 15039.5 17730.1 17877.2 18002.7 18054.6 15909.4 15930.4 16083.3 16115.5 16183.5 837.1 881.6 882.1 884.4 887.3 891.1 894.3 896.3 897.3 897.4 918.6 924.0 931.3 932.9 934.0 919.3 919.6 920.3 921.0 923.4 675.8 679.2 682.9 684.3 684.7 14924.6 14974.8 15049.3 15054.7 15121.4 11857.9 13543.3 14599.4 14699.6 14849.6 14124.5 14277.0 14848.0 15024.7 15398.8 4760.2 4800.1 4821.1 4834.6 4960.8 65339.3 70411.6 73283.0 73378.3 92183.5 12533.2 12740.7 12778.7 12896.1 12962.6 21711.2 22567.7 22701.3 22708.4 22967.0 9348.8 9468.0 9599.4 9901.3 10054.3 5179.3 5201.3 5209.6 5303.5 5306.4 3825.8 3925.9 3935.3 3946.2 3971.5 671.1 680.2 680.8 718.3 718.6 715.4 763.3 777.5 792.3 797.9 10494.5 10969.3 10974.3 11114.5 11231.8 581.5 603.0 643.6 675.8 697.8 4892.1 4922.6 4997.5 5008.0 5026.0 113822.0 135461.0 135653.0 140149.0 143273.3 118127.4 119191.0 120420.4 122593.4 122665.0 101029.0 102335.5 103541.0 103976.5 105418.9 9118.8 9464.4 9537.0 9581.9 9633.0 49534.0 60273.0 61036.0 61147.0 62414.7 53644.7 70985.3 80849.6 80900.0 83410.0 14023.9 14197.7 14393.6 14422.4 14576.3 14522.7 14770.9 15240.4 16174.7 16464.3 13421.9 13999.9 14130.2 14145.9 15092.5 13756.2 14261.6 14495.9 15199.5 15420.5 14962.9 15006.5 15025.5 15101.6 15340.0 10652.9 11087.1 11141.8 11242.5 11345.9 12289.8 12530.7 12699.5 12839.4 13160.4 03:59:40 INFO - PROCESS | 28959 | -------- Summary: end -------- 03:59:40 INFO - PROCESS | 28959 | 03:59:40 INFO - TEST-INFO | 28959: exit 0 03:59:40 INFO - TEST-OK | dromaeo_css | took 1111073ms 03:59:40 INFO - TEST-START | kraken 03:59:40 INFO - operating with platform_type : linux_ 03:59:40 INFO - Initialising browser for kraken test... 03:59:40 INFO - TEST-INFO | started process 29220 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbGukNK/profile http://localhost:60424/getInfo.html) 03:59:45 INFO - PROCESS | 29220 | __metrics Screen width/height:1600/1200 03:59:45 INFO - PROCESS | 29220 | colorDepth:24 03:59:45 INFO - PROCESS | 29220 | Browser inner width/height: 1024/697 03:59:45 INFO - PROCESS | 29220 | __metrics 03:59:45 ERROR - PROCESS | 29220 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 03:59:46 INFO - TEST-INFO | 29220: exit 0 03:59:46 INFO - Browser initialized. 03:59:46 INFO - Running cycle 1/1 for kraken test... 03:59:46 INFO - TEST-INFO | started process 29350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbGukNK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:58 INFO - PROCESS | 29350 | RSS: Main: 152645632 03:59:58 INFO - PROCESS | 29350 | 04:00:01 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60424/tests/kraken/driver.html?testName=audio-beat-detection) 04:00:01 INFO - PROCESS | 29350 | RSS: Main: 157851648 04:00:01 INFO - PROCESS | 29350 | 04:00:04 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60424/tests/kraken/driver.html?testName=audio-dft) 04:00:05 INFO - PROCESS | 29350 | RSS: Main: 156688384 04:00:05 INFO - PROCESS | 29350 | 04:00:08 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60424/tests/kraken/driver.html?testName=audio-fft) 04:00:08 INFO - PROCESS | 29350 | RSS: Main: 157270016 04:00:08 INFO - PROCESS | 29350 | 04:00:10 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60424/tests/kraken/driver.html?testName=audio-oscillator) 04:00:11 INFO - PROCESS | 29350 | RSS: Main: 156753920 04:00:11 INFO - PROCESS | 29350 | 04:00:13 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:00:14 INFO - PROCESS | 29350 | RSS: Main: 156471296 04:00:14 INFO - PROCESS | 29350 | 04:00:17 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60424/tests/kraken/driver.html?testName=imaging-darkroom) 04:00:17 INFO - PROCESS | 29350 | RSS: Main: 156356608 04:00:17 INFO - PROCESS | 29350 | 04:00:21 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60424/tests/kraken/driver.html?testName=imaging-desaturate) 04:00:21 INFO - PROCESS | 29350 | RSS: Main: 155168768 04:00:21 INFO - PROCESS | 29350 | 04:00:24 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60424/tests/kraken/driver.html?testName=json-parse-financial) 04:00:25 INFO - PROCESS | 29350 | RSS: Main: 156041216 04:00:25 INFO - PROCESS | 29350 | 04:00:26 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:27 INFO - PROCESS | 29350 | RSS: Main: 156176384 04:00:27 INFO - PROCESS | 29350 | 04:00:29 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60424/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:29 INFO - PROCESS | 29350 | RSS: Main: 156897280 04:00:29 INFO - PROCESS | 29350 | 04:00:31 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:32 INFO - PROCESS | 29350 | RSS: Main: 157093888 04:00:32 INFO - PROCESS | 29350 | 04:00:35 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:35 INFO - PROCESS | 29350 | RSS: Main: 156913664 04:00:35 INFO - PROCESS | 29350 | 04:00:38 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:39 INFO - PROCESS | 29350 | RSS: Main: 156958720 04:00:39 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | Cycle 1(1): loaded http://localhost:60424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60424/tests/kraken/driver.html?testName=ai-astar) 04:00:40 INFO - PROCESS | 29350 | RSS: Main: 157548544 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | __start_tp_report 04:00:40 INFO - PROCESS | 29350 | _x_x_mozilla_page_load 04:00:40 INFO - PROCESS | 29350 | _x_x_mozilla_page_load_details 04:00:40 INFO - PROCESS | 29350 | |i|pagename|runs| 04:00:40 INFO - PROCESS | 29350 | |0;ai-astar;102;113;106;110;112;111;111;111;110;111 04:00:40 INFO - PROCESS | 29350 | |1;audio-beat-detection;150;115;143;172;116;145;141;126;172;125 04:00:40 INFO - PROCESS | 29350 | |2;audio-dft;162;161;164;161;163;165;162;163;165;164 04:00:40 INFO - PROCESS | 29350 | |3;audio-fft;76;76;77;176;76;76;75;76;168;76 04:00:40 INFO - PROCESS | 29350 | |4;audio-oscillator;83;83;152;82;84;84;138;83;83;158 04:00:40 INFO - PROCESS | 29350 | |5;imaging-gaussian-blur;116;120;121;117;117;118;118;117;118;117 04:00:40 INFO - PROCESS | 29350 | |6;imaging-darkroom;148;148;146;148;147;147;146;147;147;146 04:00:40 INFO - PROCESS | 29350 | |7;imaging-desaturate;95;96;96;97;96;95;95;96;95;96 04:00:40 INFO - PROCESS | 29350 | |8;json-parse-financial;56;58;55;53;54;55;53;52;53;53 04:00:40 INFO - PROCESS | 29350 | |9;json-stringify-tinderbox;60;63;58;59;59;59;59;59;58;59 04:00:40 INFO - PROCESS | 29350 | |10;stanford-crypto-aes;74;73;71;79;75;73;72;72;73;72 04:00:40 INFO - PROCESS | 29350 | |11;stanford-crypto-ccm;133;122;117;118;119;118;118;124;154;123 04:00:40 INFO - PROCESS | 29350 | |12;stanford-crypto-pbkdf2;154;155;154;159;154;152;159;162;157;153 04:00:40 INFO - PROCESS | 29350 | |13;stanford-crypto-sha256-iterative;62;62;63;64;62;62;61;61;63;63 04:00:40 INFO - PROCESS | 29350 | __end_tp_report 04:00:40 INFO - PROCESS | 29350 | __start_cc_report 04:00:40 INFO - PROCESS | 29350 | _x_x_mozilla_cycle_collect,846 04:00:40 INFO - PROCESS | 29350 | __end_cc_report 04:00:40 INFO - PROCESS | 29350 | __startTimestamp1472641240944__endTimestamp 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | ------- Summary: start ------- 04:00:40 INFO - PROCESS | 29350 | Number of tests: 14 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.27 (2.9%) stddev-sans-first:1.94 04:00:40 INFO - PROCESS | 29350 | Values: 102.0 113.0 106.0 110.0 112.0 111.0 111.0 111.0 110.0 111.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:144.00 stddev:20.55 (14.3%) stddev-sans-first:21.51 04:00:40 INFO - PROCESS | 29350 | Values: 150.0 115.0 143.0 172.0 116.0 145.0 141.0 126.0 172.0 125.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.50 stddev:1.49 (0.9%) stddev-sans-first:1.54 04:00:40 INFO - PROCESS | 29350 | Values: 162.0 161.0 164.0 161.0 163.0 165.0 162.0 163.0 165.0 164.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:40.52 (53.3%) stddev-sans-first:42.38 04:00:40 INFO - PROCESS | 29350 | Values: 76.0 76.0 77.0 176.0 76.0 76.0 75.0 76.0 168.0 76.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:83.00 stddev:32.34 (39.0%) stddev-sans-first:33.48 04:00:40 INFO - PROCESS | 29350 | Values: 83.0 83.0 152.0 82.0 84.0 84.0 138.0 83.0 83.0 158.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.45 04:00:40 INFO - PROCESS | 29350 | Values: 116.0 120.0 121.0 117.0 117.0 118.0 118.0 117.0 118.0 117.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 04:00:40 INFO - PROCESS | 29350 | Values: 148.0 148.0 146.0 148.0 147.0 147.0 146.0 147.0 147.0 146.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 04:00:40 INFO - PROCESS | 29350 | Values: 95.0 96.0 96.0 97.0 96.0 95.0 95.0 96.0 95.0 96.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.81 (3.3%) stddev-sans-first:1.80 04:00:40 INFO - PROCESS | 29350 | Values: 56.0 58.0 55.0 53.0 54.0 55.0 53.0 52.0 53.0 53.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:1.42 (2.4%) stddev-sans-first:1.48 04:00:40 INFO - PROCESS | 29350 | Values: 60.0 63.0 58.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:73.00 stddev:2.27 (3.1%) stddev-sans-first:2.40 04:00:40 INFO - PROCESS | 29350 | Values: 74.0 73.0 71.0 79.0 75.0 73.0 72.0 72.0 73.0 72.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:122.50 stddev:11.37 (9.3%) stddev-sans-first:11.65 04:00:40 INFO - PROCESS | 29350 | Values: 133.0 122.0 117.0 118.0 119.0 118.0 118.0 124.0 154.0 123.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.00 stddev:3.21 (2.1%) stddev-sans-first:3.33 04:00:40 INFO - PROCESS | 29350 | Values: 154.0 155.0 154.0 159.0 154.0 152.0 159.0 162.0 157.0 153.0 04:00:40 INFO - PROCESS | 29350 | 04:00:40 INFO - PROCESS | 29350 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 04:00:40 INFO - PROCESS | 29350 | Values: 62.0 62.0 63.0 64.0 62.0 62.0 61.0 61.0 63.0 63.0 04:00:40 INFO - PROCESS | 29350 | -------- Summary: end -------- 04:00:40 INFO - PROCESS | 29350 | 04:00:41 INFO - TEST-INFO | 29350: exit 0 04:00:41 INFO - TEST-OK | kraken | took 60982ms 04:00:41 INFO - SUITE-END | took 1172s 04:00:42 INFO - Completed test suite (00:19:32) 04:00:42 INFO - javascript benchmark 04:00:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7640.82149134485, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.360524697684, 3332.0670212340538, 3334.3831391192625, 3342.4484959981605, 3343.715784158346, 5695.74369153388, 5699.430056994299, 5726.3700992890745, 5752.0509115995865, 5795.913061304073, 5647.37878833328, 5770.047942089561, 5771.249737534125, 5784.56615753818, 5803.854903627412, 5158.40678321994, 5220.190870415092, 5250.291210686547, 5292.126799078167, 5292.947070529303, 5112.41207261166, 5126.0, 5185.585153187736, 5202.193659982709, 5272.0, 5178.741062946857, 5181.378234611833, 5197.012567612161, 5198.532132108109, 5236.450172731866, 5253.0544501989625, 5257.737113144328, 5258.947410525903, 5260.579153667697, 5298.708571028592, 5023.924641130386, 5096.490350964911, 5138.948610513922, 5152.407473140599, 5152.587792976553, 5720.342160651495, 5752.741126649311, 5761.366249712528, 5778.711064446803, 5809.099589563624, 6164.476019538344, 6164.568480206387, 6204.565680402374, 6210.378962103799, 6216.564840461169, 5934.43622855828, 6100.908486372708, 6141.232345956755, 6262.436380725757, 6271.905921411182, 5743.45437183471, 5747.051736463479, 5759.942400576025, 5764.855878603026, 5788.392218817048, 6322.620642761449, 6328.050792381179, 6338.334474880071, 6356.141920840627, 6356.332585078592, 5813.157092221689, 5976.163337132805, 6014.548908831855, 6016.2479690038745, 6045.697715114315, 6151.446369826737, 6194.008958566697, 6207.224096987877, 6213.378662133841, 6216.7824126155365, 6134.079888016833, 6146.815595532141, 6150.876982460326, 6155.045967874987, 6161.44546990773, 5901.203337549462, 6008.819735407945, 6053.3946605339115, 6108.297545782292, 6210.037444196157, 4683.391159149289, 4698.530146985342, 4701.576858082789, 4710.764461776897, 4714.198586240347, 4204.873853784391, 4209.34755112958, 4212.241796476603, 4214.4310518079665, 4234.449521562177, 5658.292713410824, 5780.624259423124, 5855.912161317584, 5871.412858714094, 5877.177195192677, 6204.3795620437595, 6204.720787564571, 6219.191505104398, 6231.594946328474, 6248.875022499616, 5862.912056319158, 5873.089671100986, 5895.764169433174, 5902.085176797603, 5950.166976623276, 5133.768980395891, 5215.55667768244, 5283.4452382499285, 5330.093884039723, 5345.625806193529, 6373.139626150503, 6407.615543067338, 6442.291347951722, 6449.290578036413, 6455.0, 6148.262208535004, 6213.347598502092, 6230.314665386894, 6241.0, 6269.185005949197, 6121.908171377522, 6307.7476900925285, 6328.050792381179, 6369.9681501592195, 6407.199100112486, 6092.390760923872, 6092.543059270483, 6095.451409373, 6102.389761023862, 6114.785982490592, 6186.566940314135, 6198.070289456437, 6227.283862355887, 6244.781432649836, 6245.5628106032145, 5796.333421656564, 5965.105234214902, 5971.611845230046, 6098.603590766586, 6109.877802443837, 5982.042873140451, 5989.520838332835, 6006.039033754579, 6057.273127224585, 6064.241969753781, 5875.559333049953, 5935.910961335497, 5981.431763982415, 5998.130271110752, 6002.399760023963, 5866.94133058681, 5874.089516125007, 6035.0, 6043.244594425697, 6077.453029227391, 5998.850028749316, 6001.459868611846, 6020.54845886569, 6024.0662697282, 6026.427489388501], "value": 5674.116893531035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.1896782440232, 638.6838514935105, 653.6176336842948, 669.1234482827497, 695.9860802783942, 39489.4076588851, 45317.77341113298, 45372.0, 45513.544864551346, 45683.31475027873, 45721.08557828842, 45790.54209457905, 45942.7702861486, 46057.7697111514, 46542.534574654244, 9027.458352498837, 9138.040505746867, 9141.862872056925, 9163.312751543628, 9200.677976270832, 8876.423032502867, 8928.598213080428, 8938.284937205008, 8959.0, 8990.820183596325, 9024.503652299121, 9036.68371606994, 9076.092390760938, 9107.089291070906, 9141.222996045344, 9027.909720902839, 9053.411528250675, 9091.727248182531, 9118.726438206864, 9131.36080474367, 9016.504092274923, 9105.544722763836, 9139.314551408672, 9150.176484116395, 9171.128742769426, 42878.57121428777, 43480.13039739219, 43480.347794783105, 43535.34696979548, 43535.78232108819, 3180.6024246969127, 3693.519842420468, 3877.592852750477, 4325.091730736549, 4471.754053527055, 32604.510932336034, 32859.0, 32891.17772055694, 33074.66925330764, 34004.14989625279, 4392.758398288093, 4482.282834746457, 4521.480029796583, 4527.096928219009, 4568.954310456887, 345869.0, 348591.0, 349318.2534087339, 349415.0, 349863.0, 37477.0, 37629.24741505155, 37634.62365376311, 37661.24677506435, 37678.81160594234, 39121.6087839118, 39826.80086599549, 40276.39585406221, 42287.57712422898, 42380.15239695189, 18337.899726016483, 18346.082695865152, 18523.35168269104, 18566.350177743716, 18748.25006999732, 15081.396744130332, 15125.54623361301, 15142.242887855784, 15143.242837858063, 15208.619784505476, 20910.163593456396, 20940.58118837645, 21100.261490847748, 21170.835604041924, 21259.46851328729, 7648.885266721004, 7680.385569154454, 7794.2985131338455, 7842.686292548348, 7944.6822127114265, 1052.7894421115807, 1121.8261169518737, 1126.2285334545863, 1128.2609890521721, 1134.1777211521746, 33936.32127357439, 33981.66018339785, 34039.0, 34407.65592344094, 34484.0, 1152.5620264299512, 1172.976540469186, 1183.9526418943146, 1279.9040071994452, 1286.6526037969695, 17321.04734239629, 18022.819771802377, 18024.0, 18071.72892406615, 18084.37240648348, 610601.0, 614914.0, 615971.0, 617483.0, 618935.0, 41441.1711765763, 42160.57839421566, 42210.57789422128, 42223.1555368897, 42313.0, 1436.7772995185553, 1445.949391771283, 1470.4853301344444, 1470.985290147085, 1471.9852801472277, 31375.529367059968, 33753.64985400556, 34020.65979340175, 34182.487262690585, 34223.0, 56869.0, 56900.430995689516, 56993.43006570047, 57058.7147064262, 57220.71389643025, 403576.0, 404896.0, 406275.0, 408932.0, 408983.0, 30631.0, 30801.537976929914, 30898.227544311572, 31034.224144396572, 31274.687253127177, 52723.736381317845, 52790.73604631952, 53320.2001969963, 53466.46533534615, 54393.45606544042, 44696.55303446924, 44943.0, 45637.315440269085, 45886.77056614696, 46804.7659761699, 43506.56493435025, 44382.77808610936, 44554.10891782211, 44904.77547612241, 45584.77207613941, 44196.337054944845, 45480.772596136805, 45493.0, 45957.540424595325, 48422.0, 37910.0, 39262.01844953899, 39420.40869386904, 39615.603843962344, 40311.0, 30147.040442371177, 30150.69849301479, 30246.54630180505, 30536.541951870295, 30930.226744331572], "value": 20671.76248020159, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.76452011053414, 405.98985025374344, 415.85652949732344, 416.3359441690504, 431.70212553338195, 18641.533961650966, 20003.1998720051, 20011.0, 20039.499012524677, 20568.794312056874, 12903.354832258374, 13210.537631182911, 17461.0, 20530.897345513287, 20807.27174548891, 5341.038613049659, 5409.729513524328, 5424.945750542503, 5456.563474921997, 5481.945180548203, 5268.8155914542995, 5389.299391079174, 5414.0, 5419.945800542003, 5420.539254163401, 5372.140457526796, 5400.216968539559, 5682.26130603021, 5908.291005079396, 5912.852178695524, 5956.761729530814, 5989.161517387569, 6015.218021657157, 6021.217241758565, 6041.063635136539, 5962.284525856881, 6046.183765191687, 6068.059450785136, 6073.908891366633, 6088.4520393164385, 17965.910170449064, 24410.511789764107, 24439.755602443925, 25082.24753257387, 25162.370940726447, 2378.5242951409787, 2480.4790993891306, 2549.9490010199693, 2579.87100644967, 3128.1866714654125, 10251.948740256326, 10872.891271087266, 11319.094472442184, 13753.449862005507, 14139.717205655828, 2028.5131568423471, 2095.6018356512213, 2106.147010460766, 2120.5546835164632, 2185.715856938604, 85055.0, 85900.57049714711, 86728.56635716844, 87090.56454717749, 87982.0, 11237.55049797999, 11403.543858245743, 11456.140789440826, 11460.713482162846, 11546.134039947037, 16160.27278772458, 16179.919100404422, 16180.919095404683, 16239.59401014984, 16260.75608865868, 7914.44598878073, 7938.404619653549, 8061.959690201512, 8117.4317797754775, 8120.431569790177, 7358.190599034102, 7399.890016497461, 7423.703051877972, 7474.70101195957, 7490.966158705733, 4870.14772414826, 4923.286123512071, 4947.233178857283, 4961.603071754251, 4997.85006449807, 2008.8493362997833, 2096.989515052415, 2121.854198732667, 2144.624690679125, 2159.751628562704, 949.6296444386695, 996.0885789502524, 1044.2951008069522, 1057.7408534908843, 1071.4803320389606, 20743.0, 20814.37556873296, 21170.894145529175, 21289.254876079263, 21352.039158237916, 1052.4106500359824, 1069.588208539718, 1076.8600081989448, 1088.7985722641338, 1130.2032067392468, 11607.941960290145, 11692.0, 11786.351750653625, 11920.10599205063, 11925.34410607425, 403643.0, 403729.0, 410709.0, 514988.0, 515595.0, 97821.51089244508, 98628.0, 99012.0, 100761.0, 101186.49406752919, 1039.880413752413, 1049.4700176411015, 1083.0360978728938, 1085.4626959654863, 1093.4642025407493, 18637.347692830685, 19007.42977710671, 19049.71425428592, 19313.710294345878, 19328.4201473956, 32919.83540082284, 43659.56340436555, 43884.78057609691, 44307.77846110878, 44889.32666009947, 61977.0, 64052.35947640464, 65039.67480162569, 65467.34532654612, 65998.34001659922, 8902.243309318781, 9151.908480915106, 9240.584173712334, 9289.814203715752, 9296.72109836706, 10929.945350273516, 13325.933370333087, 13853.584392468241, 13855.237961912191, 13944.30278486092, 10960.0, 11151.776964460827, 11227.831582526433, 11293.37886416255, 11671.59149429766, 11859.881401185878, 12052.578159764365, 12389.380530973596, 12443.0, 12702.68243293888, 11112.277701949348, 11405.942970285096, 11575.42122893835, 11644.184907056764, 11963.880361196276, 8608.182222688834, 8791.472511649066, 8802.955985220033, 8805.42764720291, 9213.170814626716, 11136.554537818396, 11256.887431125584, 11305.7738845221, 11373.658790236306, 11436.313821170756], "value": 9521.78451115075, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1533.8389469105741, 1552.9068255904647, 1729.360136749403, 1827.9908600456995, 1867.7105048717444, 8208.261256486914, 8621.879155709757, 8726.563671816415, 9219.446833190004, 9298.25613950884, 8823.382363234576, 9091.18179363857, 9132.452052876832, 9141.085891410856, 9171.128742769442, 2448.5959816630234, 2488.489859578791, 2494.052260141144, 2497.463045445229, 2503.561876671575, 2410.385351735305, 2486.6643003194517, 2489.80081593473, 2495.8128140389454, 2496.588062969608, 2423.4062654649547, 2425.575524283252, 2443.8778061096964, 2446.412860913377, 2453.1659235859806, 2398.6162214045758, 2411.565918134735, 2417.62526808345, 2478.1821998740375, 2482.2056941778637, 2353.0, 2384.332386931662, 2397.1250493569896, 2409.807215422762, 2414.746451622572, 8970.910290897138, 9100.180983711432, 9111.908880911173, 9115.680951166678, 9150.908490915072, 5312.495312945264, 5470.781168753245, 5493.258410114623, 5502.862428439321, 5506.366767821672, 3562.7684200526883, 3607.0, 3688.4651725499652, 3699.815009249554, 3739.158689294914, 1183.7514122034383, 1214.7023979125083, 1251.5744646820124, 1256.1018871506826, 1279.622511359142, 12491.437885295183, 12521.248725076433, 12559.120861539695, 12571.371431428484, 12597.559085432058, 4647.442306923191, 4771.832985845479, 4805.8558243252055, 4842.6368022398465, 4881.316615673809, 10497.265191436527, 10580.89419105799, 10608.946955265328, 10610.575576976835, 10620.628278010232, 5470.370907345627, 5470.398256191816, 5497.422770609029, 5506.476884695948, 5521.5306698931045, 4435.2903535434825, 4918.9508104919205, 5104.03023425548, 5114.181730923035, 5170.6380553360905, 4117.5676553962, 4126.628603425706, 4140.47803611193, 4192.266353388145, 4206.936895946563, 1292.6186774901428, 1307.607717684691, 1309.7707901117458, 1312.9474821007243, 1323.4904561743606, 941.4445477168504, 1000.5447521377756, 1069.6202847988852, 1099.7085772270354, 1101.372217835826, 6021.488173505301, 6256.343083976117, 6389.393007664265, 6394.0, 6477.740890364427, 1019.8572199891872, 1070.6734445994045, 1085.3270971997254, 1099.1316859680921, 1122.7810576937582, 3577.3024260269517, 3720.479132921393, 4045.1707399982934, 4212.53662097169, 4337.8481753138485, 10915.345079295268, 11199.552017919355, 11210.991010809066, 11294.94352528232, 11344.716382090513, 10936.343819370863, 11154.609588664358, 11215.0, 11238.325700458, 11255.437228138724, 8369.0, 8484.19400156984, 8493.915060849436, 8526.190011948855, 8545.48727076365, 6314.810555683337, 6357.586756860789, 6366.2360516736435, 6396.936030639634, 6416.615003099829, 10367.585296588353, 10368.948155259175, 10392.42841643717, 10447.373157610567, 10572.524236409534, 10463.529141188817, 10547.789044219226, 10678.519466623866, 10727.839082413613, 10783.51474183648, 6987.847005244281, 7468.701251949861, 7553.32020118192, 7715.189905059888, 7743.186965368781, 8932.50871202064, 9003.14470125337, 9019.368644194843, 9035.412698174598, 9037.051109633394, 7728.227177282227, 7766.145723970246, 7988.201179881965, 8004.399670024888, 8096.919030809852, 7869.213078692085, 7945.8410831784195, 8008.039035315799, 8106.918930810616, 8202.343812494866, 7037.542559733601, 7208.56748595086, 7303.817404564928, 7325.706971721072, 7340.2292759261645, 5151.253068305, 5200.063988481958, 5215.113430716863, 5263.973680131575, 5310.9734451327495, 5212.713300768494, 5369.838904832861, 5415.458454154553, 5490.890182196254, 5520.171974203901], "value": 4845.077112169478, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.56303242751994, 345.8789423701704, 349.3380044815075, 356.6985896917104, 359.76794967246144, 5751.338596061454, 5764.674124951263, 5877.265341832271, 5892.204552385427, 5906.704664766766, 5726.112452569848, 5747.827565173041, 5767.538596912247, 5803.448672376117, 5809.941900580993, 4519.615832654228, 4526.117407105616, 4529.614982726473, 4531.478879928801, 4537.636989040869, 4467.262901621229, 4504.481984571767, 4514.706544074641, 4525.841595544157, 4533.387992620987, 4445.755483448409, 4447.888802779924, 4455.732656040648, 4464.526706186951, 4481.955180448186, 4449.132419178278, 4476.306172543261, 4476.865694029184, 4528.215147684184, 4529.275315949465, 3890.8832735017995, 3913.6673382762215, 3926.980365098185, 4006.238814625212, 4013.0, 5628.212050312959, 5640.492355687967, 5648.74580643872, 5690.089585666315, 5744.540436765049, 5132.948670513284, 5167.715775632339, 5204.9219261711105, 5213.897730850138, 5223.1642937130255, 5874.706264686749, 6068.180795592627, 6068.453839154453, 6077.149199112084, 6094.725737341831, 4313.805878735465, 4345.1961387143165, 4387.100644367897, 4388.451443569554, 4388.517263101056, 6156.815295541096, 6405.19935008124, 6442.387973142544, 6464.93535064648, 6468.57954232978, 4411.691181617321, 4421.358902959053, 4436.378906953029, 4445.488768791631, 4462.598366147063, 4550.4301016149375, 4555.863324100283, 4560.153137979124, 4566.452025756864, 4573.862784116482, 5187.351581052369, 5191.273221748958, 5208.765605547759, 5243.134882744381, 5255.63210575256, 5895.20414744004, 5931.1992880960515, 6110.358412366726, 6113.510919126459, 6140.478059364915, 1530.143119852886, 1551.1158639575333, 1553.4873491747696, 1554.098622798774, 1555.3312075807512, 946.914777670013, 973.2749101919115, 986.4475893499663, 993.2203220472039, 1005.6580762540772, 5071.54356107952, 5193.714345710947, 5244.396894357198, 5246.396664383568, 5255.239494769218, 5432.70120143388, 5457.154141108134, 5503.642263252876, 5538.473844984801, 5541.695206763586, 5100.69395836251, 5250.369955605275, 5285.920711189336, 5286.017743346245, 5305.522502974751, 2938.765718398278, 2971.465136275448, 2981.38881529286, 3005.5792189093545, 3026.228311780482, 5641.887162256732, 5734.741936612862, 5753.683547404933, 5755.366909639936, 5758.193852860602, 5263.947360526346, 5590.797978434574, 5615.6630602164005, 5622.662640241599, 5663.725661726078, 5575.972120139373, 5673.914891276634, 5707.800226992118, 5734.426557344233, 5739.282589676291, 5148.716820574904, 5484.8354549363585, 5487.368952570346, 5504.504594586507, 5507.394186639546, 5396.83809485716, 5399.406065332889, 5428.131498960305, 5429.647072940246, 5452.318460192476, 5682.272509195526, 5706.429357064427, 5718.085106382959, 5785.541145013269, 5799.753053093606, 3907.9413808792324, 3948.8943095933187, 4006.739561928582, 4064.6748260138525, 4077.4903137107863, 5460.535854452416, 5473.589480788877, 5492.972535137299, 6173.722182501888, 6355.7457701693265, 6168.167297414791, 6213.658248796179, 6236.438720515175, 6249.187605611241, 6252.687365631791, 6051.848703782441, 6204.7828326008375, 6238.625682459067, 6244.875102498016, 6291.182146320949, 6090.23872015998, 6103.84740381494, 6145.0, 6155.876882462415, 6180.165677633462, 6208.286047104641, 6210.937890621036, 6212.720427580679, 6218.378162183745, 6271.3415091414745, 5899.970500147472, 6012.0, 6027.397260273938, 6049.546284028627, 6077.726502307495], "value": 4469.507843576351, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.0646865807311, 830.8379865926144, 861.9612117454714, 915.7390143809014, 940.5767404667902, 15039.548813535597, 17730.11349432528, 17877.195526201318, 18002.729959050626, 18054.638907221848, 15909.44316948907, 15930.362785488567, 16083.276252568634, 16115.516534503955, 16183.514494565152, 837.1126605797843, 881.5944665453899, 882.0826340605762, 884.385352180235, 887.2724366019867, 891.095538028898, 894.2801045158644, 896.2874514760748, 897.3359713811798, 897.3718397122008, 918.5774543709902, 923.9722808315728, 931.3387494878644, 932.9393589416666, 934.0192797562567, 919.3288899103625, 919.5815903763805, 920.2683866326253, 920.9907900920972, 923.3674932671141, 675.8411773233287, 679.178194384795, 682.8839097353413, 684.2541629623734, 684.7295318349225, 14924.62688432787, 14974.775378369333, 15049.322780474795, 15054.698906021928, 15121.395144194219, 11857.94071029648, 13543.255120968342, 14599.416023359054, 14699.559013229513, 14849.628759280997, 14124.50564230247, 14277.0, 14848.0, 15024.699506009927, 15398.769018464733, 4760.238361862085, 4800.135975524404, 4821.059893320804, 4834.564889159992, 4960.801567937278, 65339.3466065338, 70411.64794176047, 73283.0, 73378.26621733821, 92183.53908230484, 12533.185342952678, 12740.681482963, 12778.68053298675, 12896.097273190975, 12962.611121666365, 21711.240106596193, 22567.661485077737, 22701.318960430883, 22708.432289192573, 22967.0, 9348.766280843034, 9467.952660236655, 9599.42403455781, 9901.306908516335, 10054.34646747959, 5179.2749015137915, 5201.271821944931, 5209.583233341324, 5303.496167864047, 5306.416294207634, 3825.7513261637905, 3925.8822235332987, 3935.252302062599, 3946.1515774108702, 3971.5035620547433, 671.1007250284642, 680.1939701453794, 680.7685386968454, 718.3175982816346, 718.5616773767997, 715.427657873699, 763.267263427105, 777.5101685937937, 792.3423558446476, 797.9281864632211, 10494.527746251437, 10969.341839489656, 10974.341539507655, 11114.499847506882, 11231.831522527169, 581.5492992930513, 602.9517638588902, 643.6009674002148, 675.8341860291057, 697.7976386847757, 4892.143874821892, 4922.556969872729, 4997.525235102659, 5008.048470790538, 5025.974870125699, 113822.0, 135461.0, 135653.0, 140149.0, 143273.28363358116, 118127.40936295263, 119191.0, 120420.39789800995, 122593.38703306427, 122665.0, 101029.0, 102335.48832255791, 103541.0, 103976.48011760044, 105418.94581054091, 9118.84684541111, 9464.384814987005, 9536.952315238379, 9581.856272155785, 9633.036696330591, 49534.0, 60273.0, 61036.0, 61147.0, 62414.68792656008, 53644.73177634087, 70985.29014709993, 80849.59575202086, 80900.0, 83410.0, 14023.929880350533, 14197.716045678822, 14393.64015899611, 14422.423103076178, 14576.344064517334, 14522.709545809235, 14770.852291476947, 15240.390384384944, 16174.67650646957, 16464.259108340393, 13421.865781342452, 13999.930000349934, 14130.15219086858, 14145.858541414455, 15092.471763488225, 13756.243406612732, 14261.572152835432, 14495.855041449451, 15199.544013679608, 15420.537383878502, 14962.850371496581, 15006.549803505912, 15025.549233523012, 15101.622459438602, 15340.0, 10652.8934710655, 11087.113030957342, 11141.83287250708, 11242.494087765906, 11345.943270283597, 12289.754204915673, 12530.749385012066, 12699.492020319083, 12839.358032098171, 13160.40778165004], "value": 8227.048951857763, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1501.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 106.0, 110.0, 112.0, 111.0, 111.0, 111.0, 110.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 143.0, 172.0, 116.0, 145.0, 141.0, 126.0, 172.0, 125.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 161.0, 163.0, 165.0, 162.0, 163.0, 165.0, 164.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 176.0, 76.0, 76.0, 75.0, 76.0, 168.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 152.0, 82.0, 84.0, 84.0, 138.0, 83.0, 83.0, 158.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 121.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 55.0, 53.0, 54.0, 55.0, 53.0, 52.0, 53.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 63.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 71.0, 79.0, 75.0, 73.0, 72.0, 72.0, 73.0, 72.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 122.0, 117.0, 118.0, 119.0, 118.0, 118.0, 124.0, 154.0, 123.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 154.0, 159.0, 154.0, 152.0, 159.0, 162.0, 157.0, 153.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 64.0, 62.0, 62.0, 61.0, 61.0, 63.0, 63.0], "value": 62.3, "unit": "score"}]}]} 04:00:42 INFO - Return code: 0 04:00:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:42 ERROR - # TBPL SUCCESS # 04:00:42 INFO - Running post-action listener: _resource_record_post_action 04:00:42 INFO - [mozharness: 2016-08-31 11:00:42.254297Z] Finished run-tests step (success) 04:00:42 INFO - Running post-run listener: _resource_record_post_run 04:00:42 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 328142848; Read time: 0; Write time: 303348 04:00:42 INFO - TinderboxPrint: CPU usage
13.3% 04:00:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:00:42 INFO - TinderboxPrint: I/O write bytes / time
328,142,848 / 303,348 04:00:42 INFO - TinderboxPrint: CPU idle
8,215.7 (86.7%) 04:00:42 INFO - TinderboxPrint: CPU user
1,205.9 (12.7%) 04:00:42 INFO - TinderboxPrint: Swap in / out
0 / 0 04:00:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78458880; Read time: 0; Write time: 118696 04:00:42 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 249270272; Read time: 0; Write time: 184612 04:00:42 INFO - Running post-run listener: _upload_blobber_files 04:00:42 INFO - Blob upload gear active. 04:00:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00: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:00: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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:00: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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:00:43 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:47 INFO - (blobuploader) - INFO - Done attempting. 04:00:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:00:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:00:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:48 INFO - (blobuploader) - INFO - Done attempting. 04:00:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:00:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:00:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:49 INFO - (blobuploader) - INFO - Done attempting. 04:00:49 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:49 INFO - Return code: 0 04:00:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f86017452ebe9d399faf6a99c727222037c50e0cdd525cd247681bcc18f96cecbcfb035faff033bd46f16873fc6ef3389e413c4a73edb109db4bdce21fb5a2b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b3c49134fe11847fdbedc4ab61e6919463b743c7d2c2cb0cb849dabf2bf4c9af1f25a42286d483488e909c58ca97bc29d411b1ecf94d0f0dbc3b63e5db95fb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57266cd75bd4eda905aaf619a9c3d909a0dd842554bbf0cb5257b306293eef5764b89e1e81668c205404c215765fa0b418a41e2ba1bdd4f398d94e97ce89f5a5"} 04:00:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:49 INFO - Contents: 04:00:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f86017452ebe9d399faf6a99c727222037c50e0cdd525cd247681bcc18f96cecbcfb035faff033bd46f16873fc6ef3389e413c4a73edb109db4bdce21fb5a2b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b3c49134fe11847fdbedc4ab61e6919463b743c7d2c2cb0cb849dabf2bf4c9af1f25a42286d483488e909c58ca97bc29d411b1ecf94d0f0dbc3b63e5db95fb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57266cd75bd4eda905aaf619a9c3d909a0dd842554bbf0cb5257b306293eef5764b89e1e81668c205404c215765fa0b418a41e2ba1bdd4f398d94e97ce89f5a5"} 04:00:49 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:49 INFO - Copying logs to upload dir... 04:00:49 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1676.457945 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-08-31 04:00:48.923119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 04:00:48.926518) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f86017452ebe9d399faf6a99c727222037c50e0cdd525cd247681bcc18f96cecbcfb035faff033bd46f16873fc6ef3389e413c4a73edb109db4bdce21fb5a2b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b3c49134fe11847fdbedc4ab61e6919463b743c7d2c2cb0cb849dabf2bf4c9af1f25a42286d483488e909c58ca97bc29d411b1ecf94d0f0dbc3b63e5db95fb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57266cd75bd4eda905aaf619a9c3d909a0dd842554bbf0cb5257b306293eef5764b89e1e81668c205404c215765fa0b418a41e2ba1bdd4f398d94e97ce89f5a5"} build_url:https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/DT2cpJctSvSjmylFOK0X1w/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f86017452ebe9d399faf6a99c727222037c50e0cdd525cd247681bcc18f96cecbcfb035faff033bd46f16873fc6ef3389e413c4a73edb109db4bdce21fb5a2b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0b3c49134fe11847fdbedc4ab61e6919463b743c7d2c2cb0cb849dabf2bf4c9af1f25a42286d483488e909c58ca97bc29d411b1ecf94d0f0dbc3b63e5db95fb5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57266cd75bd4eda905aaf619a9c3d909a0dd842554bbf0cb5257b306293eef5764b89e1e81668c205404c215765fa0b418a41e2ba1bdd4f398d94e97ce89f5a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 04:00:48.952241) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 04:00:48.952579) ========= 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=03627c79f6bb3d1578c4a402000001ba-1472639502.440190-1995695060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 04:00:49.035149) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 04:00:49.035494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 04:00:49.035807) ========= ========= Total master_lag: 0.18 =========