builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1472767531.88 results: success (0) buildid: 20160901115421 builduid: 185aafea41d244318a4ca969a32ec1be revision: a46345ccdae2f09ab412abe89ae28281419d0565 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:31.883461) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:31.884109) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:31.884714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:31.901961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:31.902524) ========= 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=d2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 15:05:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.4M=0s 2016-09-01 15:05:32 (88.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147043 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:32.065691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:32.066102) ========= 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=d2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023637 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:32.116776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:32.117179) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a46345ccdae2f09ab412abe89ae28281419d0565 --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 a46345ccdae2f09ab412abe89ae28281419d0565 --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=d2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 15:05:32,449 truncating revision to first 12 chars 2016-09-01 15:05:32,449 Setting DEBUG logging. 2016-09-01 15:05:32,449 attempt 1/10 2016-09-01 15:05:32,449 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a46345ccdae2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 15:05:32,772 unpacking tar archive at: mozilla-aurora-a46345ccdae2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.735072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:32.869520) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:32.870366) ========= script_repo_revision: a46345ccdae2f09ab412abe89ae28281419d0565 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:32.871432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:32.872142) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 15:05:32.883894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-01 15:05:32.884202) ========= /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=d2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:05:33 INFO - MultiFileLogger online at 20160901 15:05:33 in /builds/slave/test 15:05:33 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 15:05:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:05:33 INFO - {'append_to_log': False, 15:05:33 INFO - 'base_work_dir': '/builds/slave/test', 15:05:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:05:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:05:33 INFO - 'branch': 'Mozilla-Aurora', 15:05:33 INFO - 'buildbot_json_path': 'buildprops.json', 15:05:33 INFO - 'config_files': ('talos/linux_config.py',), 15:05:33 INFO - 'default_actions': ('clobber', 15:05:33 INFO - 'read-buildbot-config', 15:05:33 INFO - 'download-and-extract', 15:05:33 INFO - 'populate-webroot', 15:05:33 INFO - 'create-virtualenv', 15:05:33 INFO - 'install', 15:05:33 INFO - 'run-tests'), 15:05:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:05:33 INFO - 'download_minidump_stackwalk': True, 15:05:33 INFO - 'download_symbols': 'ondemand', 15:05:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:05:33 INFO - 'tooltool.py': '/tools/tooltool.py', 15:05:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:05:33 INFO - '/tools/misc-python/virtualenv.py')}, 15:05:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:05:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:05:33 INFO - 'installer_path': 'installer.exe', 15:05:33 INFO - 'log_level': 'info', 15:05:33 INFO - 'log_name': 'talos', 15:05:33 INFO - 'log_to_console': True, 15:05:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:05:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:05:33 INFO - 'opt_config_files': (), 15:05:33 INFO - 'pip_index': False, 15:05:33 INFO - 'sps_profile': False, 15:05:33 INFO - 'sps_profile_interval': 0, 15:05:33 INFO - 'suite': 'dromaeojs-e10s', 15:05:33 INFO - 'system_bits': '32', 15:05:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:05:33 INFO - 'title': 'talos-linux64-ix-043', 15:05:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:05:33 INFO - 'use_talos_json': True, 15:05:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:05:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:05:33 INFO - 'work_dir': 'build'} 15:05:33 INFO - [mozharness: 2016-09-01 22:05:33.306004Z] Running clobber step. 15:05:33 INFO - Running pre-action listener: _resource_record_pre_action 15:05:33 INFO - Running main action method: clobber 15:05:33 INFO - rmtree: /builds/slave/test/build 15:05:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:05:34 INFO - Running post-action listener: _resource_record_post_action 15:05:34 INFO - [mozharness: 2016-09-01 22:05:34.255758Z] Finished clobber step (success) 15:05:34 INFO - [mozharness: 2016-09-01 22:05:34.255858Z] Running read-buildbot-config step. 15:05:34 INFO - Running pre-action listener: _resource_record_pre_action 15:05:34 INFO - Running main action method: read_buildbot_config 15:05:34 INFO - Using buildbot properties: 15:05:34 INFO - { 15:05:34 INFO - "project": "", 15:05:34 INFO - "product": "firefox", 15:05:34 INFO - "script_repo_revision": "production", 15:05:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:05:34 INFO - "repository": "", 15:05:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:05:34 INFO - "buildid": "20160901115421", 15:05:34 INFO - "pgo_build": "True", 15:05:34 INFO - "basedir": "/builds/slave/test", 15:05:34 INFO - "buildnumber": 527, 15:05:34 INFO - "slavename": "talos-linux64-ix-043", 15:05:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:05:34 INFO - "platform": "ubuntu64_hw", 15:05:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:05:34 INFO - "branch": "mozilla-aurora", 15:05:34 INFO - "repo_path": "releases/mozilla-aurora", 15:05:34 INFO - "revision": "a46345ccdae2f09ab412abe89ae28281419d0565", 15:05:34 INFO - "stage_platform": "linux64-pgo", 15:05:34 INFO - "builduid": "185aafea41d244318a4ca969a32ec1be", 15:05:34 INFO - "slavebuilddir": "test" 15:05:34 INFO - } 15:05:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 15:05:34 INFO - Running post-action listener: _resource_record_post_action 15:05:34 INFO - [mozharness: 2016-09-01 22:05:34.258317Z] Finished read-buildbot-config step (success) 15:05:34 INFO - [mozharness: 2016-09-01 22:05:34.258407Z] Running download-and-extract step. 15:05:34 INFO - Running pre-action listener: _resource_record_pre_action 15:05:34 INFO - Running main action method: download_and_extract 15:05:34 INFO - mkdir: /builds/slave/test/build/tests 15:05: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')]} 15:05:34 INFO - https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:05:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:05:34 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:05:34 INFO - retry: Failed, sleeping 30 seconds before retrying 15:06:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:06:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:06:04 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:06:04 INFO - retry: Failed, sleeping 60 seconds before retrying 15:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:07:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:07:04 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:07:04 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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! 15:07:04 INFO - Caught exception: HTTP Error 404: Not Found 15:07:04 INFO - Caught exception: HTTP Error 404: Not Found 15:07:04 INFO - Caught exception: HTTP Error 404: Not Found 15:07:04 INFO - trying https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:07:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:07:04 INFO - Downloaded 1361 bytes. 15:07:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 15:07:04 INFO - Using the following test package requirements: 15:07:04 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 15:07:04 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:07:04 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:07:04 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:07:04 INFO - u'jsshell-linux-x86_64.zip'], 15:07:04 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:07:04 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 15:07:04 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:07:04 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:07:04 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:07:04 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 15:07:04 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:07:04 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:07:04 INFO - https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:07:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:07:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:07:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:07:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:07:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:07:04 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:07:04 INFO - retry: Failed, sleeping 30 seconds before retrying 15:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:07:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:07:35 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:07:35 INFO - retry: Failed, sleeping 60 seconds before retrying 15:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:08:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:08:35 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:08:35 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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! 15:08:35 INFO - Caught exception: HTTP Error 404: Not Found 15:08:35 INFO - Caught exception: HTTP Error 404: Not Found 15:08:35 INFO - Caught exception: HTTP Error 404: Not Found 15:08:35 INFO - trying https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:08:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:08:35 INFO - Downloaded 21769825 bytes. 15:08:35 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'] 15:08:35 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 15:08:37 INFO - Return code: 0 15:08:37 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 15:08: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')]} 15:08:37 INFO - https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:08:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:08:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:08:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:08:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:08:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:08:37 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:08:37 INFO - retry: Failed, sleeping 30 seconds before retrying 15:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:09:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:09:07 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:09:07 INFO - retry: Failed, sleeping 60 seconds before retrying 15:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:10:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:10:07 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:10:07 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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! 15:10:07 INFO - Caught exception: HTTP Error 404: Not Found 15:10:07 INFO - Caught exception: HTTP Error 404: Not Found 15:10:07 INFO - Caught exception: HTTP Error 404: Not Found 15:10:07 INFO - trying https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 15:10:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:10:08 INFO - Downloaded 21769825 bytes. 15:10:08 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'] 15:10:08 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 15:10:09 INFO - Return code: 0 15:10: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')]} 15:10:09 INFO - https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:10:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:10:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:10:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:10:09 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:10:09 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:10:09 INFO - retry: Failed, sleeping 30 seconds before retrying 15:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:10:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:10:39 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:10:39 INFO - retry: Failed, sleeping 60 seconds before retrying 15:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:11:39 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:11:39 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:11:39 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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! 15:11:39 INFO - Caught exception: HTTP Error 404: Not Found 15:11:39 INFO - Caught exception: HTTP Error 404: Not Found 15:11:39 INFO - Caught exception: HTTP Error 404: Not Found 15:11:39 INFO - trying https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 15:11:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:11:40 INFO - Downloaded 14413740 bytes. 15:11:40 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'] 15:11:40 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 15:11:40 INFO - Return code: 0 15:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:11:40 INFO - https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:11:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:11:40 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 15:11:40 INFO - retry: Failed, sleeping 30 seconds before retrying 15:12:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:12:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:12:10 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 15:12:10 INFO - retry: Failed, sleeping 60 seconds before retrying 15:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:13:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:13:10 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 15:13:10 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qb5tLwGpScarhrbysaQpSg/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! 15:13:10 INFO - Caught exception: HTTP Error 404: Not Found 15:13:10 INFO - Caught exception: HTTP Error 404: Not Found 15:13:10 INFO - Caught exception: HTTP Error 404: Not Found 15:13:10 INFO - trying https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:13:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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 15:13:11 INFO - Downloaded 63895804 bytes. 15:13:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:13:11 INFO - mkdir: /builds/slave/test/properties 15:13:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:13:11 INFO - Writing to file /builds/slave/test/properties/build_url 15:13:11 INFO - Contents: 15:13:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 15:13:12 INFO - Running post-action listener: _resource_record_post_action 15:13:12 INFO - Running post-action listener: set_extra_try_arguments 15:13:12 INFO - [mozharness: 2016-09-01 22:13:12.535897Z] Finished download-and-extract step (success) 15:13:12 INFO - [mozharness: 2016-09-01 22:13:12.536128Z] Running populate-webroot step. 15:13:12 INFO - Running pre-action listener: _resource_record_pre_action 15:13:12 INFO - Running main action method: populate_webroot 15:13:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:13:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:13:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:13:12 INFO - '--tppagecycles', 15:13:12 INFO - '7'], 15:13:12 INFO - 'tests': ['tsvgm']}}, 15:13:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:13:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:13:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:13:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:13:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:12 INFO - 'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:12 INFO - 'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['damp', 'tps']}, 15:13:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:12 INFO - 'tests': ['damp', 'tps']}, 15:13:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['dromaeo_dom']}, 15:13:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:13:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['basic_compositor_video']}, 15:13:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:13:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['a11yr', 15:13:12 INFO - 'ts_paint', 15:13:12 INFO - 'tpaint', 15:13:12 INFO - 'sessionrestore', 15:13:12 INFO - 'sessionrestore_no_auto_restore', 15:13:12 INFO - 'tabpaint']}, 15:13:12 INFO - 'other-e10s': {'tests': ['a11yr', 15:13:12 INFO - 'ts_paint', 15:13:12 INFO - 'tpaint', 15:13:12 INFO - 'sessionrestore', 15:13:12 INFO - 'sessionrestore_no_auto_restore', 15:13:12 INFO - 'tabpaint']}, 15:13:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:13:12 INFO - 'ts_paint', 15:13:12 INFO - 'tpaint', 15:13:12 INFO - 'sessionrestore', 15:13:12 INFO - 'sessionrestore_no_auto_restore', 15:13:12 INFO - 'tabpaint']}, 15:13:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:13:12 INFO - 'ts_paint', 15:13:12 INFO - 'tpaint', 15:13:12 INFO - 'sessionrestore', 15:13:12 INFO - 'sessionrestore_no_auto_restore', 15:13:12 INFO - 'tabpaint']}, 15:13:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['a11yr', 15:13:12 INFO - 'ts_paint', 15:13:12 INFO - 'tpaint', 15:13:12 INFO - 'sessionrestore', 15:13:12 INFO - 'sessionrestore_no_auto_restore', 15:13:12 INFO - 'tabpaint']}, 15:13:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['a11yr', 15:13:12 INFO - 'ts_paint', 15:13:12 INFO - 'tpaint', 15:13:12 INFO - 'sessionrestore', 15:13:12 INFO - 'sessionrestore_no_auto_restore', 15:13:12 INFO - 'tabpaint']}, 15:13:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['tsvgx', 15:13:12 INFO - 'tsvgr_opacity', 15:13:12 INFO - 'tart', 15:13:12 INFO - 'tscrollx', 15:13:12 INFO - 'cart']}, 15:13:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:13:12 INFO - 'tsvgr_opacity', 15:13:12 INFO - 'tart', 15:13:12 INFO - 'tscrollx', 15:13:12 INFO - 'cart']}, 15:13:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:12 INFO - 'talos_options': ['--disable-e10s'], 15:13:12 INFO - 'tests': ['tp5o']}, 15:13:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:12 INFO - 'tests': ['tp5o']}, 15:13:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:12 INFO - 'talos_options': ['--disable-e10s', 15:13:12 INFO - '--xperf_path', 15:13:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:12 INFO - 'tests': ['tp5n']}, 15:13:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:12 INFO - 'talos_options': ['--xperf_path', 15:13:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:12 INFO - 'tests': ['tp5n']}}, 15:13:12 INFO - 'talos.zip': {'path': '', 15:13:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:13:12 INFO - Running post-action listener: _resource_record_post_action 15:13:12 INFO - [mozharness: 2016-09-01 22:13:12.555181Z] Finished populate-webroot step (success) 15:13:12 INFO - [mozharness: 2016-09-01 22:13:12.555270Z] Running create-virtualenv step. 15:13:12 INFO - Running pre-action listener: _resource_record_pre_action 15:13:12 INFO - Running main action method: create_virtualenv 15:13:12 INFO - Creating virtualenv /builds/slave/test/build/venv 15:13:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:13:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:13:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:13:12 INFO - Using real prefix '/usr' 15:13:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:13:13 INFO - Installing distribute.............................................................................................................................................................................................done. 15:13:15 INFO - Installing pip.................done. 15:13:15 INFO - Return code: 0 15:13:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:15 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 0x21d3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, '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': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:13:15 INFO - Using env: {'DISPLAY': ':0', 15:13:15 INFO - 'HOME': '/home/cltbld', 15:13:15 INFO - 'LANG': 'en_US.UTF-8', 15:13:15 INFO - 'LANGUAGE': 'en_US:en', 15:13:15 INFO - 'LOGNAME': 'cltbld', 15:13:15 INFO - 'MAIL': '/var/mail/cltbld', 15:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:15 INFO - 'MOZ_NO_REMOTE': '1', 15:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:15 INFO - 'NO_EM_RESTART': '1', 15:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:15 INFO - 'PWD': '/builds/slave/test', 15:13:15 INFO - 'SHELL': '/bin/bash', 15:13:15 INFO - 'SHLVL': '1', 15:13:15 INFO - 'TERM': 'linux', 15:13:15 INFO - 'TMOUT': '86400', 15:13:15 INFO - 'USER': 'cltbld', 15:13:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:15 INFO - '_': '/tools/buildbot/bin/python'} 15:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:13:15 INFO - Cleaning up... 15:13:15 INFO - Return code: 0 15:13:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:15 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 0x21d3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, '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': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:13:15 INFO - Using env: {'DISPLAY': ':0', 15:13:15 INFO - 'HOME': '/home/cltbld', 15:13:15 INFO - 'LANG': 'en_US.UTF-8', 15:13:15 INFO - 'LANGUAGE': 'en_US:en', 15:13:15 INFO - 'LOGNAME': 'cltbld', 15:13:15 INFO - 'MAIL': '/var/mail/cltbld', 15:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:15 INFO - 'MOZ_NO_REMOTE': '1', 15:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:15 INFO - 'NO_EM_RESTART': '1', 15:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:15 INFO - 'PWD': '/builds/slave/test', 15:13:15 INFO - 'SHELL': '/bin/bash', 15:13:15 INFO - 'SHLVL': '1', 15:13:15 INFO - 'TERM': 'linux', 15:13:15 INFO - 'TMOUT': '86400', 15:13:15 INFO - 'USER': 'cltbld', 15:13:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:15 INFO - '_': '/tools/buildbot/bin/python'} 15:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:15 INFO - Downloading/unpacking psutil>=3.1.1 15:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:13:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:17 INFO - Installing collected packages: psutil 15:13:17 INFO - Running setup.py install for psutil 15:13:17 INFO - building 'psutil._psutil_linux' extension 15:13:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:13:17 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:13:17 INFO - building 'psutil._psutil_posix' extension 15:13:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:13:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:13:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:18 INFO - Successfully installed psutil 15:13:18 INFO - Cleaning up... 15:13:18 INFO - Return code: 0 15:13:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:18 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 0x21d3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, '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': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:13:18 INFO - Using env: {'DISPLAY': ':0', 15:13:18 INFO - 'HOME': '/home/cltbld', 15:13:18 INFO - 'LANG': 'en_US.UTF-8', 15:13:18 INFO - 'LANGUAGE': 'en_US:en', 15:13:18 INFO - 'LOGNAME': 'cltbld', 15:13:18 INFO - 'MAIL': '/var/mail/cltbld', 15:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:18 INFO - 'MOZ_NO_REMOTE': '1', 15:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:18 INFO - 'NO_EM_RESTART': '1', 15:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:18 INFO - 'PWD': '/builds/slave/test', 15:13:18 INFO - 'SHELL': '/bin/bash', 15:13:18 INFO - 'SHLVL': '1', 15:13:18 INFO - 'TERM': 'linux', 15:13:18 INFO - 'TMOUT': '86400', 15:13:18 INFO - 'USER': 'cltbld', 15:13:18 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:18 INFO - '_': '/tools/buildbot/bin/python'} 15:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:13:20 INFO - Installing collected packages: mozsystemmonitor 15:13:20 INFO - Running setup.py install for mozsystemmonitor 15:13:20 INFO - Successfully installed mozsystemmonitor 15:13:20 INFO - Cleaning up... 15:13:20 INFO - Return code: 0 15:13:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:20 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 0x21d3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, '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': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:13:20 INFO - Using env: {'DISPLAY': ':0', 15:13:20 INFO - 'HOME': '/home/cltbld', 15:13:20 INFO - 'LANG': 'en_US.UTF-8', 15:13:20 INFO - 'LANGUAGE': 'en_US:en', 15:13:20 INFO - 'LOGNAME': 'cltbld', 15:13:20 INFO - 'MAIL': '/var/mail/cltbld', 15:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:20 INFO - 'MOZ_NO_REMOTE': '1', 15:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:20 INFO - 'NO_EM_RESTART': '1', 15:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:20 INFO - 'PWD': '/builds/slave/test', 15:13:20 INFO - 'SHELL': '/bin/bash', 15:13:20 INFO - 'SHLVL': '1', 15:13:20 INFO - 'TERM': 'linux', 15:13:20 INFO - 'TMOUT': '86400', 15:13:20 INFO - 'USER': 'cltbld', 15:13:20 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:20 INFO - '_': '/tools/buildbot/bin/python'} 15:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:20 INFO - Downloading/unpacking jsonschema==2.5.1 15:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:13:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:22 INFO - Downloading functools32-3.2.3-2.tar.gz 15:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:13:23 INFO - warning: no files found matching '*.txt' 15:13:23 INFO - no previously-included directories found matching 'build' 15:13:23 INFO - no previously-included directories found matching 'dist' 15:13:23 INFO - no previously-included directories found matching '.git*' 15:13:23 INFO - Installing collected packages: jsonschema, functools32 15:13:23 INFO - Running setup.py install for functools32 15:13:23 INFO - warning: no files found matching '*.txt' 15:13:23 INFO - no previously-included directories found matching 'build' 15:13:23 INFO - no previously-included directories found matching 'dist' 15:13:23 INFO - no previously-included directories found matching '.git*' 15:13:23 INFO - Successfully installed jsonschema functools32 15:13:23 INFO - Cleaning up... 15:13:23 INFO - Return code: 0 15:13:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:23 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 0x21d3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, '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': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:13:23 INFO - Using env: {'DISPLAY': ':0', 15:13:23 INFO - 'HOME': '/home/cltbld', 15:13:23 INFO - 'LANG': 'en_US.UTF-8', 15:13:23 INFO - 'LANGUAGE': 'en_US:en', 15:13:23 INFO - 'LOGNAME': 'cltbld', 15:13:23 INFO - 'MAIL': '/var/mail/cltbld', 15:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:23 INFO - 'MOZ_NO_REMOTE': '1', 15:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:23 INFO - 'NO_EM_RESTART': '1', 15:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:23 INFO - 'PWD': '/builds/slave/test', 15:13:23 INFO - 'SHELL': '/bin/bash', 15:13:23 INFO - 'SHLVL': '1', 15:13:23 INFO - 'TERM': 'linux', 15:13:23 INFO - 'TMOUT': '86400', 15:13:23 INFO - 'USER': 'cltbld', 15:13:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:23 INFO - '_': '/tools/buildbot/bin/python'} 15:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:13:23 INFO - Cleaning up... 15:13:23 INFO - Return code: 0 15:13:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:23 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 0x21d3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, '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': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:13:23 INFO - Using env: {'DISPLAY': ':0', 15:13:23 INFO - 'HOME': '/home/cltbld', 15:13:23 INFO - 'LANG': 'en_US.UTF-8', 15:13:23 INFO - 'LANGUAGE': 'en_US:en', 15:13:23 INFO - 'LOGNAME': 'cltbld', 15:13:23 INFO - 'MAIL': '/var/mail/cltbld', 15:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:23 INFO - 'MOZ_NO_REMOTE': '1', 15:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:23 INFO - 'NO_EM_RESTART': '1', 15:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:23 INFO - 'PWD': '/builds/slave/test', 15:13:23 INFO - 'SHELL': '/bin/bash', 15:13:23 INFO - 'SHLVL': '1', 15:13:23 INFO - 'TERM': 'linux', 15:13:23 INFO - 'TMOUT': '86400', 15:13:23 INFO - 'USER': 'cltbld', 15:13:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:23 INFO - '_': '/tools/buildbot/bin/python'} 15:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:23 INFO - Downloading/unpacking blobuploader==1.2.4 15:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:13:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:13:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:26 INFO - Downloading docopt-0.6.1.tar.gz 15:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:13:26 INFO - Installing collected packages: blobuploader, requests, docopt 15:13:26 INFO - Running setup.py install for blobuploader 15:13:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:13:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:13:26 INFO - Running setup.py install for requests 15:13:26 INFO - Running setup.py install for docopt 15:13:26 INFO - Successfully installed blobuploader requests docopt 15:13:26 INFO - Cleaning up... 15:13:26 INFO - Return code: 0 15:13:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:26 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 0x21d3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, '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': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:13:26 INFO - Using env: {'DISPLAY': ':0', 15:13:26 INFO - 'HOME': '/home/cltbld', 15:13:26 INFO - 'LANG': 'en_US.UTF-8', 15:13:26 INFO - 'LANGUAGE': 'en_US:en', 15:13:26 INFO - 'LOGNAME': 'cltbld', 15:13:26 INFO - 'MAIL': '/var/mail/cltbld', 15:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:26 INFO - 'MOZ_NO_REMOTE': '1', 15:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:26 INFO - 'NO_EM_RESTART': '1', 15:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:26 INFO - 'PWD': '/builds/slave/test', 15:13:26 INFO - 'SHELL': '/bin/bash', 15:13:26 INFO - 'SHLVL': '1', 15:13:26 INFO - 'TERM': 'linux', 15:13:26 INFO - 'TMOUT': '86400', 15:13:26 INFO - 'USER': 'cltbld', 15:13:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:26 INFO - '_': '/tools/buildbot/bin/python'} 15:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:27 INFO - Running setup.py (path:/tmp/pip-KXp6wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:27 INFO - Running setup.py (path:/tmp/pip-sggIKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:27 INFO - Running setup.py (path:/tmp/pip-kWnBxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:27 INFO - Running setup.py (path:/tmp/pip-zJH1aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:27 INFO - Running setup.py (path:/tmp/pip-QS__Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:27 INFO - Running setup.py (path:/tmp/pip-0CZS4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:27 INFO - Running setup.py (path:/tmp/pip-ejPezn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:27 INFO - Running setup.py (path:/tmp/pip-Rb9RCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:27 INFO - Running setup.py (path:/tmp/pip-i3sH8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:27 INFO - Running setup.py (path:/tmp/pip-NTHJWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:27 INFO - Running setup.py (path:/tmp/pip-psB_y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:27 INFO - Running setup.py (path:/tmp/pip-EuJwgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:28 INFO - Running setup.py (path:/tmp/pip-BHmi8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:28 INFO - Running setup.py (path:/tmp/pip-SrE5ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:28 INFO - Running setup.py (path:/tmp/pip-i8VHnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:13:28 INFO - Running setup.py (path:/tmp/pip-QP4j3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:13:28 INFO - Running setup.py (path:/tmp/pip-VFvz28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:13:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:13:28 INFO - Running setup.py install for manifestparser 15:13:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:13:28 INFO - Running setup.py install for mozcrash 15:13:28 INFO - Running setup.py install for mozdebug 15:13:28 INFO - Running setup.py install for mozdevice 15:13:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:13:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:13:28 INFO - Running setup.py install for mozfile 15:13:28 INFO - Running setup.py install for mozhttpd 15:13:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Running setup.py install for mozinfo 15:13:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Running setup.py install for mozInstall 15:13:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Running setup.py install for mozleak 15:13:29 INFO - Running setup.py install for mozlog 15:13:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Running setup.py install for moznetwork 15:13:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Running setup.py install for mozprocess 15:13:29 INFO - Running setup.py install for mozprofile 15:13:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Running setup.py install for mozrunner 15:13:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:13:29 INFO - Running setup.py install for mozscreenshot 15:13:29 INFO - Running setup.py install for moztest 15:13:30 INFO - Running setup.py install for mozversion 15:13:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:13:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:13:30 INFO - Cleaning up... 15:13:30 INFO - Return code: 0 15:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:30 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 0x21d3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, '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': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:13:30 INFO - Using env: {'DISPLAY': ':0', 15:13:30 INFO - 'HOME': '/home/cltbld', 15:13:30 INFO - 'LANG': 'en_US.UTF-8', 15:13:30 INFO - 'LANGUAGE': 'en_US:en', 15:13:30 INFO - 'LOGNAME': 'cltbld', 15:13:30 INFO - 'MAIL': '/var/mail/cltbld', 15:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:30 INFO - 'MOZ_NO_REMOTE': '1', 15:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:30 INFO - 'NO_EM_RESTART': '1', 15:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:30 INFO - 'PWD': '/builds/slave/test', 15:13:30 INFO - 'SHELL': '/bin/bash', 15:13:30 INFO - 'SHLVL': '1', 15:13:30 INFO - 'TERM': 'linux', 15:13:30 INFO - 'TMOUT': '86400', 15:13:30 INFO - 'USER': 'cltbld', 15:13:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:30 INFO - '_': '/tools/buildbot/bin/python'} 15:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:30 INFO - Running setup.py (path:/tmp/pip-_GtQzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:30 INFO - Running setup.py (path:/tmp/pip-RPNBOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:30 INFO - Running setup.py (path:/tmp/pip-0PjaLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:30 INFO - Running setup.py (path:/tmp/pip-E593rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:30 INFO - Running setup.py (path:/tmp/pip-5Quvnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:30 INFO - Running setup.py (path:/tmp/pip-Crpd2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:30 INFO - Running setup.py (path:/tmp/pip-N5kgAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:30 INFO - Running setup.py (path:/tmp/pip-nS5NP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:31 INFO - Running setup.py (path:/tmp/pip-5v6t8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:31 INFO - Running setup.py (path:/tmp/pip-KRgSaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:31 INFO - Running setup.py (path:/tmp/pip-uZJ58_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:31 INFO - Running setup.py (path:/tmp/pip-GkBCfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:31 INFO - Running setup.py (path:/tmp/pip-RRuZui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:31 INFO - Running setup.py (path:/tmp/pip-V4cxns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:31 INFO - Running setup.py (path:/tmp/pip-ulx9s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:13:31 INFO - Running setup.py (path:/tmp/pip-17boej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:13:31 INFO - Running setup.py (path:/tmp/pip-sjDeGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:13:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:33 INFO - Downloading blessings-1.6.tar.gz 15:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:13:33 INFO - Installing collected packages: blessings 15:13:33 INFO - Running setup.py install for blessings 15:13:33 INFO - Successfully installed blessings 15:13:33 INFO - Cleaning up... 15:13:33 INFO - Return code: 0 15:13:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:34 INFO - Reading from file tmpfile_stdout 15:13:34 INFO - Current package versions: 15:13:34 INFO - argparse == 1.2.1 15:13:34 INFO - blessings == 1.6 15:13:34 INFO - blobuploader == 1.2.4 15:13:34 INFO - docopt == 0.6.1 15:13:34 INFO - functools32 == 3.2.3-2 15:13:34 INFO - jsonschema == 2.5.1 15:13:34 INFO - manifestparser == 1.1 15:13:34 INFO - mozInstall == 1.12 15:13:34 INFO - mozcrash == 0.17 15:13:34 INFO - mozdebug == 0.1 15:13:34 INFO - mozdevice == 0.48 15:13:34 INFO - mozfile == 1.2 15:13:34 INFO - mozhttpd == 0.7 15:13:34 INFO - mozinfo == 0.9 15:13:34 INFO - mozleak == 0.1 15:13:34 INFO - mozlog == 3.3 15:13:34 INFO - moznetwork == 0.27 15:13:34 INFO - mozprocess == 0.23 15:13:34 INFO - mozprofile == 0.28 15:13:34 INFO - mozrunner == 6.12 15:13:34 INFO - mozscreenshot == 0.1 15:13:34 INFO - mozsystemmonitor == 0.3 15:13:34 INFO - moztest == 0.7 15:13:34 INFO - mozversion == 1.4 15:13:34 INFO - psutil == 3.1.1 15:13:34 INFO - requests == 1.2.3 15:13:34 INFO - wsgiref == 0.1.2 15:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:34 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 0x21d3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, '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': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:13:34 INFO - Using env: {'DISPLAY': ':0', 15:13:34 INFO - 'HOME': '/home/cltbld', 15:13:34 INFO - 'LANG': 'en_US.UTF-8', 15:13:34 INFO - 'LANGUAGE': 'en_US:en', 15:13:34 INFO - 'LOGNAME': 'cltbld', 15:13:34 INFO - 'MAIL': '/var/mail/cltbld', 15:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:34 INFO - 'MOZ_NO_REMOTE': '1', 15:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:34 INFO - 'NO_EM_RESTART': '1', 15:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:34 INFO - 'PWD': '/builds/slave/test', 15:13:34 INFO - 'SHELL': '/bin/bash', 15:13:34 INFO - 'SHLVL': '1', 15:13:34 INFO - 'TERM': 'linux', 15:13:34 INFO - 'TMOUT': '86400', 15:13:34 INFO - 'USER': 'cltbld', 15:13:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:34 INFO - '_': '/tools/buildbot/bin/python'} 15:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:13:34 INFO - Cleaning up... 15:13:34 INFO - Return code: 0 15:13:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21d3030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23368a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2402400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, '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': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:13:34 INFO - Using env: {'DISPLAY': ':0', 15:13:34 INFO - 'HOME': '/home/cltbld', 15:13:34 INFO - 'LANG': 'en_US.UTF-8', 15:13:34 INFO - 'LANGUAGE': 'en_US:en', 15:13:34 INFO - 'LOGNAME': 'cltbld', 15:13:34 INFO - 'MAIL': '/var/mail/cltbld', 15:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:34 INFO - 'MOZ_NO_REMOTE': '1', 15:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:34 INFO - 'NO_EM_RESTART': '1', 15:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:34 INFO - 'PWD': '/builds/slave/test', 15:13:34 INFO - 'SHELL': '/bin/bash', 15:13:34 INFO - 'SHLVL': '1', 15:13:34 INFO - 'TERM': 'linux', 15:13:34 INFO - 'TMOUT': '86400', 15:13:34 INFO - 'USER': 'cltbld', 15:13:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:34 INFO - '_': '/tools/buildbot/bin/python'} 15:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:13:34 INFO - Cleaning up... 15:13:34 INFO - Return code: 0 15:13:34 INFO - Running post-action listener: _resource_record_post_action 15:13:34 INFO - Running post-action listener: _start_resource_monitoring 15:13:34 INFO - Starting resource monitoring. 15:13:34 INFO - [mozharness: 2016-09-01 22:13:34.479076Z] Finished create-virtualenv step (success) 15:13:34 INFO - [mozharness: 2016-09-01 22:13:34.479549Z] Running install step. 15:13:34 INFO - Running pre-action listener: _resource_record_pre_action 15:13:34 INFO - Running main action method: install 15:13:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:34 INFO - Reading from file tmpfile_stdout 15:13:34 INFO - Detecting whether we're running mozinstall >=1.0... 15:13:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:13:34 INFO - Reading from file tmpfile_stdout 15:13:34 INFO - Output received: 15:13:34 INFO - Usage: mozinstall [options] installer 15:13:34 INFO - Options: 15:13:34 INFO - -h, --help show this help message and exit 15:13:34 INFO - -d DEST, --destination=DEST 15:13:34 INFO - Directory to install application into. [default: 15:13:34 INFO - "/builds/slave/test"] 15:13:34 INFO - --app=APP Application being installed. [default: firefox] 15:13:34 INFO - mkdir: /builds/slave/test/build/application 15:13:34 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'] 15:13:34 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 15:13:51 INFO - Reading from file tmpfile_stdout 15:13:51 INFO - Output received: 15:13:51 INFO - /builds/slave/test/build/application/firefox/firefox 15:13:51 INFO - Running post-action listener: _resource_record_post_action 15:13:51 INFO - [mozharness: 2016-09-01 22:13:51.398436Z] Finished install step (success) 15:13:51 INFO - [mozharness: 2016-09-01 22:13:51.398710Z] Running run-tests step. 15:13:51 INFO - Running pre-action listener: _resource_record_pre_action 15:13:51 INFO - Running main action method: run_tests 15:13:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:13:51 INFO - Python 2.7.3 15:13:51 INFO - Return code: 0 15:13:51 INFO - grabbing minidump binary from tooltool 15:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:51 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 0x2491570>, '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 0x2492470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2492900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:13:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:13:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:13:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:13:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:13:51 INFO - Return code: 0 15:13:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:13:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:13:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:13:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:13:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:13:51 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/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:13:51 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/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:13:51 INFO - Using env: {'DISPLAY': ':0', 15:13:51 INFO - 'HOME': '/home/cltbld', 15:13:51 INFO - 'LANG': 'en_US.UTF-8', 15:13:51 INFO - 'LANGUAGE': 'en_US:en', 15:13:51 INFO - 'LOGNAME': 'cltbld', 15:13:51 INFO - 'MAIL': '/var/mail/cltbld', 15:13:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:13:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:51 INFO - 'MOZ_NO_REMOTE': '1', 15:13:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:51 INFO - 'NO_EM_RESTART': '1', 15:13:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:51 INFO - 'PWD': '/builds/slave/test', 15:13:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:13:51 INFO - 'SHELL': '/bin/bash', 15:13:51 INFO - 'SHLVL': '1', 15:13:51 INFO - 'TERM': 'linux', 15:13:51 INFO - 'TMOUT': '86400', 15:13:51 INFO - 'USER': 'cltbld', 15:13:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307', 15:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:51 INFO - '_': '/tools/buildbot/bin/python'} 15:13:51 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/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:13:51 INFO - mozversion application_buildid: 20160901115421 15:13:51 INFO - mozversion application_changeset: a46345ccdae2f09ab412abe89ae28281419d0565 15:13:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:13:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:13:51 INFO - mozversion application_name: Firefox 15:13:51 INFO - mozversion application_remotingname: firefox-dev 15:13:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:13:51 INFO - mozversion application_vendor: Mozilla 15:13:51 INFO - mozversion application_version: 50.0a2 15:13:51 INFO - mozversion platform_buildid: 20160901115421 15:13:51 INFO - mozversion platform_changeset: a46345ccdae2f09ab412abe89ae28281419d0565 15:13:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:13:51 INFO - mozversion platform_version: 50.0a2 15:13:51 INFO - using testdate: 1472768031 15:13:51 INFO - actual date: 1472768031 15:13:51 INFO - starting webserver on 'localhost:41410' 15:13:51 INFO - SUITE-START | Running 2 tests 15:13:51 INFO - TEST-START | dromaeo_css 15:13:51 INFO - operating with platform_type : linux_ 15:13:51 INFO - Initialising browser for dromaeo_css test... 15:13:51 INFO - TEST-INFO | started process 4490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIvcv4/profile http://localhost:41410/getInfo.html) 15:13:56 INFO - PROCESS | 4490 | __metrics Screen width/height:1600/1200 15:13:56 INFO - PROCESS | 4490 | colorDepth:24 15:13:56 INFO - PROCESS | 4490 | Browser inner width/height: 1024/697 15:13:56 INFO - PROCESS | 4490 | __metrics 15:13:57 ERROR - PROCESS | 4490 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:13:58 INFO - TEST-INFO | 4490: exit 0 15:13:58 INFO - Browser initialized. 15:13:58 INFO - Running cycle 1/1 for dromaeo_css test... 15:13:58 INFO - TEST-INFO | started process 4614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIvcv4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:14:09 INFO - PROCESS | 4614 | RSS: Main: 152809472 15:14:09 INFO - PROCESS | 4614 | 15:14:59 INFO - PROCESS | 4614 | 1472768099551 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:17:08 INFO - PROCESS | 4614 | Cycle 1(1): loaded http://localhost:41410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41410/tests/dromaeo/cssquery-ext.html) 15:17:09 INFO - PROCESS | 4614 | RSS: Main: 158183424 15:17:09 INFO - PROCESS | 4614 | 15:20:11 INFO - PROCESS | 4614 | Cycle 1(1): loaded http://localhost:41410/tests/dromaeo/cssquery-ext.html (next: http://localhost:41410/tests/dromaeo/cssquery-jquery.html) 15:20:12 INFO - PROCESS | 4614 | RSS: Main: 153899008 15:20:12 INFO - PROCESS | 4614 | 15:23:13 INFO - PROCESS | 4614 | Cycle 1(1): loaded http://localhost:41410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41410/tests/dromaeo/cssquery-mootools.html) 15:23:14 INFO - PROCESS | 4614 | RSS: Main: 154726400 15:23:14 INFO - PROCESS | 4614 | 15:26:16 INFO - PROCESS | 4614 | Cycle 1(1): loaded http://localhost:41410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41410/tests/dromaeo/cssquery-prototype.html) 15:26:16 INFO - PROCESS | 4614 | RSS: Main: 153509888 15:26:16 INFO - PROCESS | 4614 | 15:29:19 INFO - PROCESS | 4614 | Cycle 1(1): loaded http://localhost:41410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41410/tests/dromaeo/cssquery-yui.html) 15:29:19 INFO - PROCESS | 4614 | RSS: Main: 155787264 15:29:19 INFO - PROCESS | 4614 | 15:32:22 INFO - PROCESS | 4614 | Cycle 1(1): loaded http://localhost:41410/tests/dromaeo/cssquery-yui.html (next: http://localhost:41410/tests/dromaeo/cssquery-dojo.html) 15:32:22 INFO - PROCESS | 4614 | RSS: Main: 155996160 15:32:22 INFO - PROCESS | 4614 | 15:32:22 INFO - PROCESS | 4614 | __start_tp_report 15:32:22 INFO - PROCESS | 4614 | _x_x_mozilla_page_load 15:32:22 INFO - PROCESS | 4614 | _x_x_mozilla_page_load_details 15:32:22 INFO - PROCESS | 4614 | |i|pagename|runs| 15:32:22 INFO - PROCESS | 4614 | |0;dojo.html;3281.540584318195;3327.5175099610556;3336.5829271341067;3352.363051020306;3357.6810203030705;5939.4060593940585;5954.851128721784;5957.195778569891;5976.432238937305;5981.222441082658;5887.175795388649;5916.88166236675;5952.017917043682;5956.493698035672;5959.70201489926;5317.229001794747;5343;5407.270018547505;5447.536959358459;5483.561315094783;5169.767360468788;5190.688558686472;5253.238280449333;5337.066013447631;5383.4616538346045;5361.892762144755;5389.299391079154;5392.40683524812;5396.406395296514;5407.648502847303;5401.70290634015;5427.782888684467;5460.153676180198;5460.453954604547;5482.314710661168;5123.692578445305;5209.479052094798;5234.110201265794;5347.732613369355;5363.892722145535;5756.827295181151;5799.5650326225705;5809.099589563624;5850.736716847709;5859;6247.062940558907;6296.496280297565;6303.842403939938;6304.211973503312;6309.716062777186;6067.908981365283;6224.159738435344;6280.654563999024;6357.618542887441;6361.713722882481;5915.526757859361;5915.792947246826;5947.226860508106;5953.434423729739;5962.642241465526;6455.128557644752;6463.418292353711;6487.902681459782;6507.772227971998;6515.218173819172;5932.673702946379;6080.452759251689;6106.45041946227;6223.906641400383;6231.688415579203;6237.09562113491;6247.875042499125;6271;6287.151234583364;6318.778842740482;6257.937420625826;6260.7495700171485;6264.906026409608;6278.937210627927;6279.246490421087;5997.280326360865;6202.41077097675;6221;6237.688115594202;6269.498440124779;4823.662343635982;4823.758812059383;4827.324174615556;4845.370101886802;4857.562819346276;4277.422547955986;4278.935815962763;4285.3786201000685;4286.249906266391;4306.138772245564;5927.9703601481715;6008.3390827009;6053.818385448443;6072.969635151884;6137.7851775187655;6350.872982540416;6390.488760899117;6401.55189136756;6403.775867844696;6406.167198264196;6075.1798507200965;6134.631922084689;6137.171481849893;6137.693115344215;6146.139540464339;5295.602829787705;5388.67667939917;5411.053065713484;5480.369757477862;5527.55779537636;6607.504437167232;6632.1709786276715;6635.568688035262;6642;6661.16735408074;6319.24169099711;6355.809325720235;6380.712867921047;6385.521085918667;6393.2328120625825;6347.904781428375;6506.837329066811;6511.283758786435;6562.34376562359;6643.70103345341;6278.058291256348;6280.5289603279025;6282.842928926813;6283;6285.057241413641;6327.430531252209;6376.075469057054;6389.169407976933;6403.7118329676205;6418.229812422539;5926.051831706906;6120.599512025131;6147.784827531015;6209.751609935552;6225.906611400742;6198.783042593487;6217.751289948352;6218.440340369208;6241.937580624136;6248.875022499434;6168.9691551541955;6235.594686345373;6240.00159974402;6240.594361366497;6242.812715618538;5961.701914904324;6113.9932453606225;6150.231221097363;6226.875462490815;6250.843728906631;6089.238845144357;6098.207233059674;6100.908486372619;6116.3272040076445;6124.816255512342 15:32:22 INFO - PROCESS | 4614 | |1;ext.html;583.4194975998881;631.3402494393358;670.6143967218849;678.0642713055979;688.9483288753345;42827;47870.04259914804;47945.52054479454;47952.28071578929;47997.760011199985;47622;48306.758466207706;48357.274640880416;48372.27441588379;48471.75764121174;9116.589753461094;9189.127032931894;9253.120953509406;9258.490783006931;9261.259099272076;9244;9268.02685718;9294;9330.253579713606;9350.485723285217;9312.906870931272;9364.25085993119;9370.437773733564;9399.154076133147;9411.388259763093;9294.907050929505;9305.767355816091;9305.906940930572;9357.39176953496;9394.06059394062;9235.261179105722;9274.07259274074;9278;9330.766730831716;9342.205912497446;45623.77188114071;46061.53938460606;46094.07811843778;46099.07801843978;46155.76922115368;3636.090977255686;3809.942850857212;3867.149227170018;3907;4225.331143082585;35885.64114358849;36415.63584364149;36489;36759.26481470383;36856.26287474235;4659.464161621423;4706.199946009152;4711.952880471185;4728.078024785168;4745.857624271277;381467;381511.9999999972;382647;384279;387712;66042.66978665076;66740;66857;67009.66495167493;67212;42120.157596848505;42949.14101717948;43087;43185.78407107944;43258.78370608127;17454.389096381565;17512.562185945455;17556.736648950275;17615.38346157904;17646.91176544109;14069.648258793612;14110.22393768332;14161.85838141626;14187.432502699776;14248.287585620677;21738;21740.56518869614;21810.781892180876;21974.560508789735;21985.120595176333;7566.810829729301;7708.614569271514;7759.689612415553;7816.335611472975;8037.598120093972;1042.6924057403085;1135.6536256441864;1169.1523645357217;1175.5239128153112;1215.598852378713;34933.65066349304;35452.29095418129;35595.28809423797;35723;35859.282814344086;1175.2948231061296;1180.1856718863955;1180.6635108993896;1204.0668481926577;1235.7950997777095;17820.91089544544;18331.900085994883;18472.445826625222;18476.168572414274;18510.722339164924;478958;695453;702842;703363;707370;66974;67602.32397676058;67751.32248677549;68032.6598367005;68185.31814681888;1439.100562148657;1459.5913144319607;1475.5278310940396;1483.6735918098002;1499.3402902722767;35531;35985;36113.27773444569;36770;36836.81581592075;58025.70987145037;59519.40480595139;59536.404635954816;59585.40414595972;59616;516508;519617;520579;522030;524499;32680.50979235361;32860.83569582137;32874;32970.5054424179;33188.50217246792;54088.729556351966;54281;54825.725871370385;54865.72567137139;55641.165382518484;45195.32207016832;47620;48281.5171848277;48524;48922;46545.301820473396;46577;47193.29210061783;47329.76335118302;47522.52477475181;39508.40737388884;45534.31698524591;45784.313235302165;46532.7673361631;46821.29768053414;38795;41010;41301.79349103235;41322.38016429816;42354.78822605867;30794.846025769726;31066;31481.527777082905;31580.210494737814;31634.525482117326 15:32:22 INFO - PROCESS | 4614 | |2;jquery.html;407.27911596474223;412.6100834711197;420.80222295521105;429.7786639880461;439.7383556783715;19700.11349489273;20480.180792768308;20935.37193884182;21214.257500987467;21417.357479275626;18036.188371523313;19589.804101959013;20394;20923.16307347708;21185.57628847422;5936.139259807325;6175.845603859917;6175.907361389583;6178.165947597085;6179.19670442844;5972.402759724015;6006.3393026767235;6026.939730602704;6069.969650151766;6097.359777223394;5833.416658334175;5951.2858456985;5990.73041713124;5997.610155339889;6018.8194354169445;5942.405759424067;5948.196993405878;5973.462388385023;5993.520518358521;6017.969910150443;5303.124984377573;5427.185922111676;5430.782768689287;5435.266239057716;5436;25436;25583.872080639663;25603.359916002064;25712.614310785353;25855.74144258552;2540.5808041673104;2661.441097369555;3012.9246768830953;3257.478803391446;3315.8342082896;15376.000559963566;15789.605259868595;15977.840221597751;15989.680206395808;16091.114988675617;2087.937361879146;2160.654295312758;2176.8911554422375;2181.182056728727;2204.812590929773;84864.57567712122;85140.14859851384;86964.5651771737;87122.56438717766;88229;10603.734906627396;10677.09244714208;11134;11495.298604827858;11556.248843825124;16236.18819059066;16291.266892989845;16338.591535211715;16350.591235219215;16359.100249486155;8459.385141328288;8515.957420212859;8567.957160214284;8774.341924355698;8809.251213646912;8418.957905210435;8514.74455766328;8703.825923481494;8743.519106449206;8744.737657870273;6948.513604047769;7035.613041282779;7041.4718896082995;7103.680334384965;7141.107361579802;1978.4064780565773;1981.1778112083323;1988.6420444319872;2062.752469703615;2115.206797450956;1016.4460369098858;1097.1332647208776;1150.6202953025481;1152.3604399558326;1173.0732721150366;21021.633593816354;21022.894885525475;21529.928081153583;21585;21721.782782171977;1040.2718097331897;1078.2883297023927;1101.1906248907046;1164.493445351258;1176.864660564029;11308.547658093748;11778.175527712978;11809.40952952349;11964.461599228056;11997.220180688228;446942;448753;463436;527070;528951;83028.16971830325;83243.58378208191;84942.5752871244;85880.57059714786;101989;1088.7441451258949;1090.6946055104584;1113.9387333696725;1121.966341009771;1123.797716411054;15540.766888496455;18001.369952051617;18536.536586585444;19174.71237931404;19480.318188863323;41884.37173442462;44843.55156448394;45319.546804531536;45668;48460.273095902885;55535;58516.414835851094;61691.69154154201;64298.67850660717;66964;9109.954450227706;9486.620535178792;9523.666671666459;9586.137247647745;9600.90399096028;10736.463176841284;14488.420463181355;14518.782218266946;14550.4907328243;14960.17719025464;12853.293068881301;12869.742605147658;12927;12993.285369304778;13299.933500332436;12420.751584968431;12598.748025039631;12692.619221423372;12896.29070401137;13133.868661313265;12001.699957501132;12312.569060082855;12312.75374492523;12919.289439080942;13031;9144.679936202201;9182.862257066015;9264.675736349196;9298.814023719622;9313.44119352841;11571.6528504145;12467.376631168225;12553.93723031379;12618.242905425705;12812.039097067944 15:32:22 INFO - PROCESS | 4614 | |3;mootools.html;1556.7742677311794;1579.6129948162697;1727.19685346314;1834.3763120539031;1847.8891266524001;8679.349048821348;9146.31402644801;9402.341836071479;10005.549750261238;10086.14267787238;9500.80998380032;9823.607055717763;9854.260930430228;9896.851547226797;9906.851397229048;2502.524520341134;2545.681789776278;2555.5400027995047;2555.782758465533;2556.75710807473;2436.658867758515;2553.834000789943;2562.6412302277695;2565.679290088739;2565.987170064147;2516.169664010881;2549.7067837198683;2567.5378431882255;2570.807189460789;2575.381908341994;2491.5266099441137;2491.862947537885;2494.5135698538793;2496.8377055491337;2511.1462102885016;2484.291976786607;2485.0556788420286;2487.117073438921;2487.291122030231;2499.262717498342;9923.255755818342;9984.700458986243;9998.300118991674;10031.949840250825;10038.046385593358;5604.747786349624;5859.44335288147;5868.9413105868825;5874.471297583238;5911.024680927641;3530.894073177809;3615.3311637347174;3638.308721342936;3686.1337585667347;3706.5366829146355;1120.355795417638;1169.502961241469;1174.0979613026866;1186.7685801268756;1206.90344772418;13724.93137534306;13742.587722368346;13755.38100785457;13798.93100534501;13802.447902083904;5053.36832895888;5096.592272618182;5262.947370526323;5272.894542109213;5281.524662780368;10182.643607473703;10192.949035254776;10246.129079028366;10249;10254.743631409125;5707.942920570824;5751.396103409165;5773.855653608609;5774.68239246837;5785.334686511105;4774.116788394158;5274.393444753826;5376.327959005124;5409.459054094559;5410.540104091117;4179;4258.723182993095;4287.8499252526635;4287.871363859089;4316.848910288125;1279.2004996876951;1304.6868751499762;1310.9119430872354;1324.4304948871884;1325.1982550556775;1014.2545229256491;1065.9093977011885;1081.9513121909533;1084.2356138922041;1101.5758932810766;6543.9345606544275;6620;6676.031975363545;6701.195856497154;6836.726530938707;503.16725818769993;508.506748453999;518.5765420959224;519.9246109314129;525.8422473258007;4590.081983603292;4591.79336929839;4658.254679251304;4706.670533062653;4771.117343291502;11900.166988310908;12185;12264.509419623293;12328.691782705504;12342.81485777714;11481.770364592661;11932.522699092113;11953.16327857059;12373.876261237452;12427.502899883903;8992.505412202261;9115.36192466521;9137.81724365509;9142.542872856198;9166;6739.224989126314;6927.411170050602;6948.200956890022;7000.544964577286;7031.648417579203;11171.72070698239;11372.20394572372;11429.314241145557;11453.713657158638;11556.306621602731;11532.481038353126;11560;11633.76732465329;11692.649220523397;11695.12286578493;8445.746627601182;8612.095729948265;8668;8687.305015598864;8863.64545418176;9597;9612.951935240279;9699.030096990244;9705.563249653642;9722.805543889224;8620.568971551524;8638.481691098554;8691.304695624462;8775;8856.468611883307;8360.707375241838;8430.494170349799;8482.57587120629;8532.829343413221;8800.119988001148;7890.210978902064;8011.599420028859;8040.075391330072;8067.636956336862;8068.636911338886;5763.94236057634;5808;5930.436608522184;5955.464008239279;6047.213862197887;5355.491228333302;5948.970255148696;5972.790952316648;5993.880122397615;6127.571070025056 15:32:22 INFO - PROCESS | 4614 | |4;prototype.html;319.0921827401043;325.04923099932694;330.86930662388374;338.1579866133328;339.66373290442453;5754.539636829054;5763.82708518744;5874.970625146873;5971.552133589982;5992.520598352132;5827.650340979533;5841.2114364560775;5848.070136854838;5872.827053990019;5939.495142912858;4531.637469002472;4548.135854187711;4551.589007407698;4558.475775285843;4570.725756454607;4421.602055814976;4492.39352687388;4519.774011299438;4549.408576885;4552.385427967231;4470.128324976631;4490.393796837434;4492.326151077332;4513.323001549761;4555.612772914306;4244.681648876316;4514.367988481616;4525.977370113162;4533.138703646297;4550.249208880531;3854.69162467002;3873.9612603873884;3886.164474637938;3886.7862267575274;3887.9805600972095;5681.147827825818;5688.11834165705;5693.943060569382;5699.629524080921;5728.42715728428;4841.2496063110275;5081.79672813087;5121.359830021247;5155.71643559604;5181.792728290864;6057.30341010785;6058.727357268934;6075.605085669417;6078.240219972504;6091.573589848713;4246.426732391118;4259.829606815754;4267;4269.167512335096;4287.399764033038;6255.781047663356;6306.180196574462;6390.584612000252;6408.647524386157;6409.391107844747;4358.8038538265855;4375.912481750347;4381.123775244963;4385.736855788663;4408.360787685768;4394.890127746832;4412.691111622155;4414.933775993362;4435.290353543418;4462.9776851116185;5021.774020169101;5089.338386009795;5139.640225184201;5140.665856719376;5155.38135423744;5909.438603332676;6046.546509011754;6127.96936015326;6132.63204207749;6173.857836300299;1468.12646475347;1482.3181336585076;1482.5404124721372;1484.547213100015;1486.568895020432;903.8927314040379;928.8513837785922;932.5989824375583;953.2278854128178;967.666155176463;5209.843704688866;5247.10799164143;5304.522592966651;5405.7567409466665;5416.83749487516;5481.835544933659;5540.559454541848;5557.527610153102;5572.86067848307;5609.887802243932;4961.479044700327;5288.8413347599635;5298.97350513245;5329.920051199235;5356.7321633918145;2957.68383069532;2965.9174401343353;2966.4363770883465;2977.2556860784803;2998.775091868075;5695.92420093145;5710.428957104339;5711.828645140652;5727.828165155052;5734.197212390269;5952.315483719428;6318.2624778185445;6468.935310646927;6469.935300647027;6472.967635161794;6570.226038969547;6646.734130634721;6657.3009833966735;6663.300353462913;6672.499562532927;6156.722947467285;6286.559940804283;6311.747530098744;6363.490920726424;6444.387783160592;6239.656818875005;6263.96868015657;6272.8431789203805;6304.5586808922935;6326.8804950342155;6348.873022539431;6587.814193445226;6604.306547812411;6651.434628056476;6668.766593169215;4375.124975004948;4391.297392417198;4420.7126536775;4452.465704115527;4462.910741785081;6153.72308246139;6200.410960958701;6386;6398.5521013528605;6418.6469744164515;6119.938800611937;6173.56785025044;6200.906986395298;6210.627362358273;6223.941929872023;6064.4541991221;6124.938750612437;6169.074638804215;6194.721237544411;6234.781782637586;6102.481289090477;6170.660613666112;6203.348648391854;6227.439530442282;6228.252609686867;6250.34354902369;6264.31092579825;6278.529110316653;6283.994560870239;6286.779962701284;5784.537237020944;5973.790917317873;6012.488938440281;6034.517238620988;6051.576389652682 15:32:22 INFO - PROCESS | 4614 | |5;yui.html;793.6309616028549;807.382352500337;815.502543448496;904.9004609492955;923.5105394141106;16295.755563666555;16995.830041699595;17483.825161748395;18033.549161270974;18341.082945852686;15542.922285388557;15647.530574082795;15664.138472384042;15701.528954131365;15725.056496610212;866.9133086691312;885.1723638398103;899.0200681257428;901.5807649443008;905.316486053029;900.7207765592688;903.6927444668811;904.8235594059161;905.2576886952702;907.7503686486203;945.8959514453439;950.4772375193651;955.6273053509137;957.9712608621718;958.6980101268078;955.8327292723745;955.9283053770995;956.268454632207;956.7751578379075;957.0094951724931;705.2559549675091;705.3017512662478;705.4638474759169;706.0961968680098;708.4934271995548;16674.83325166745;16741.6651666966;16763.245653945603;16801.663966720596;16818.411355602497;14397.64005899861;14598;14774;15178.620534486616;15196.544103676908;14913.105213687213;14998;15049.699006019819;15057;15472.5358239253;4840.080384726891;4879.829205977774;4883.536064073907;4936;5045.243213517965;90513;90721;91321;91350.08649913482;91774.54112729394;12473.189242699196;12486.75026499465;12568.87431125677;12611.936940315423;12613;22369.44076398103;22617;22640;22663.546729065325;23480;8593.957030214933;8663.176998185163;8826;9166.541672916328;9283.535823208813;4933.975330123327;5032.622553308516;5086.262491938722;5117.360329958755;5134.178531434953;3646;3764.0589852536864;3782.4893639358334;3783.39465685489;3795.69634429245;641.2081079866362;653.8659574787157;654.6693919570681;669.2337273821545;676.6549059979446;541.3611937913222;564.4214679952998;589.7346194212621;637.3944752485065;705.7882635209417;10157.644482443078;10290.794184116276;10443.530041148166;10448.68653940383;10519.737006574744;678.2674711311771;707.1125737199782;726.5822152262471;732.7105793211651;749.134749364485;4491.528389519053;4933;5002.099622068063;5021.548060674484;5043.84868453947;76175.61912190514;94164;101614.49192754137;121002;143508;118989.40505297591;120389;121759;123310.38344808399;127631.36184319019;78953.60523197462;79017;90232.5488372567;90808.54595727111;103550;10006.349587276804;10331.32846365014;10687.412192329497;10867.402292873969;10869.347839129678;56294.71852640711;56311.71844140753;57233.42766572448;57344.1398379033;58095.709521452125;71859.64070179616;77922.66232013049;79636.60181699286;79823;79939.20060799317;12839.29383883858;13528.323583820573;13585.660358491117;13862.168269903837;13868.583942481742;15202.543923681866;15226.314815833535;15422.228888555303;15699.529014129594;16498.34006639769;14216.502422415166;14304.57086287413;14417.7837332438;14799.704005920037;15289.770653439984;13582.524611638546;13662.863371366158;14187.361568729226;14425.134491930517;14668.77996830027;13333.866661333263;13547.25490098054;13646.454141834216;14009;14350.425982960565;10679.679609611723;10682.09202217789;10702.357858528514;10869.836952445561;11180.608678696206;11248.212625116163;11673.708157296136;11735.823962640738;11773.941130294294;11892.108091893315 15:32:22 INFO - PROCESS | 4614 | __end_tp_report 15:32:22 INFO - PROCESS | 4614 | __start_cc_report 15:32:22 INFO - PROCESS | 4614 | _x_x_mozilla_cycle_collect,312 15:32:22 INFO - PROCESS | 4614 | __end_cc_report 15:32:22 INFO - PROCESS | 4614 | __startTimestamp1472769142497__endTimestamp 15:32:22 INFO - PROCESS | 4614 | 15:32:22 INFO - PROCESS | 4614 | ------- Summary: start ------- 15:32:22 INFO - PROCESS | 4614 | Number of tests: 6 15:32:22 INFO - PROCESS | 4614 | 15:32:22 INFO - PROCESS | 4614 | [#0] dojo.html Cycles:165 Average:5870.39 Median:6120.60 stddev:685.33 (11.2%) stddev-sans-first:656.65 15:32:22 INFO - PROCESS | 4614 | Values: 3281.5 3327.5 3336.6 3352.4 3357.7 5939.4 5954.9 5957.2 5976.4 5981.2 5887.2 5916.9 5952.0 5956.5 5959.7 5317.2 5343.0 5407.3 5447.5 5483.6 5169.8 5190.7 5253.2 5337.1 5383.5 5361.9 5389.3 5392.4 5396.4 5407.6 5401.7 5427.8 5460.2 5460.5 5482.3 5123.7 5209.5 5234.1 5347.7 5363.9 5756.8 5799.6 5809.1 5850.7 5859.0 6247.1 6296.5 6303.8 6304.2 6309.7 6067.9 6224.2 6280.7 6357.6 6361.7 5915.5 5915.8 5947.2 5953.4 5962.6 6455.1 6463.4 6487.9 6507.8 6515.2 5932.7 6080.5 6106.5 6223.9 6231.7 6237.1 6247.9 6271.0 6287.2 6318.8 6257.9 6260.7 6264.9 6278.9 6279.2 5997.3 6202.4 6221.0 6237.7 6269.5 4823.7 4823.8 4827.3 4845.4 4857.6 4277.4 4278.9 4285.4 4286.2 4306.1 5928.0 6008.3 6053.8 6073.0 6137.8 6350.9 6390.5 6401.6 6403.8 6406.2 6075.2 6134.6 6137.2 6137.7 6146.1 5295.6 5388.7 5411.1 5480.4 5527.6 6607.5 6632.2 6635.6 6642.0 6661.2 6319.2 6355.8 6380.7 6385.5 6393.2 6347.9 6506.8 6511.3 6562.3 6643.7 6278.1 6280.5 6282.8 6283.0 6285.1 6327.4 6376.1 6389.2 6403.7 6418.2 5926.1 6120.6 6147.8 6209.8 6225.9 6198.8 6217.8 6218.4 6241.9 6248.9 6169.0 6235.6 6240.0 6240.6 6242.8 5961.7 6114.0 6150.2 6226.9 6250.8 6089.2 6098.2 6100.9 6116.3 6124.8 15:32:22 INFO - PROCESS | 4614 | 15:32:22 INFO - PROCESS | 4614 | [#1] ext.html Cycles:180 Average:69070.97 Median:46539.03 stddev:142494.78 (306.2%) stddev-sans-first:142801.73 15:32:22 INFO - PROCESS | 4614 | Values: 583.4 631.3 670.6 678.1 688.9 42827.0 47870.0 47945.5 47952.3 47997.8 47622.0 48306.8 48357.3 48372.3 48471.8 9116.6 9189.1 9253.1 9258.5 9261.3 9244.0 9268.0 9294.0 9330.3 9350.5 9312.9 9364.3 9370.4 9399.2 9411.4 9294.9 9305.8 9305.9 9357.4 9394.1 9235.3 9274.1 9278.0 9330.8 9342.2 45623.8 46061.5 46094.1 46099.1 46155.8 3636.1 3809.9 3867.1 3907.0 4225.3 35885.6 36415.6 36489.0 36759.3 36856.3 4659.5 4706.2 4712.0 4728.1 4745.9 381467.0 381512.0 382647.0 384279.0 387712.0 66042.7 66740.0 66857.0 67009.7 67212.0 42120.2 42949.1 43087.0 43185.8 43258.8 17454.4 17512.6 17556.7 17615.4 17646.9 14069.6 14110.2 14161.9 14187.4 14248.3 21738.0 21740.6 21810.8 21974.6 21985.1 7566.8 7708.6 7759.7 7816.3 8037.6 1042.7 1135.7 1169.2 1175.5 1215.6 34933.7 35452.3 35595.3 35723.0 35859.3 1175.3 1180.2 1180.7 1204.1 1235.8 17820.9 18331.9 18472.4 18476.2 18510.7 478958.0 695453.0 702842.0 703363.0 707370.0 66974.0 67602.3 67751.3 68032.7 68185.3 1439.1 1459.6 1475.5 1483.7 1499.3 35531.0 35985.0 36113.3 36770.0 36836.8 58025.7 59519.4 59536.4 59585.4 59616.0 516508.0 519617.0 520579.0 522030.0 524499.0 32680.5 32860.8 32874.0 32970.5 33188.5 54088.7 54281.0 54825.7 54865.7 55641.2 45195.3 47620.0 48281.5 48524.0 48922.0 46545.3 46577.0 47193.3 47329.8 47522.5 39508.4 45534.3 45784.3 46532.8 46821.3 38795.0 41010.0 41301.8 41322.4 42354.8 30794.8 31066.0 31481.5 31580.2 31634.5 15:32:22 INFO - PROCESS | 4614 | 15:32:22 INFO - PROCESS | 4614 | [#2] jquery.html Cycles:180 Average:29800.91 Median:2372.70 stddev:79851.61 (3365.4%) stddev-sans-first:80045.11 15:32:22 INFO - PROCESS | 4614 | Values: 407.3 412.6 420.8 429.8 439.7 19700.1 20480.2 20935.4 21214.3 21417.4 18036.2 19589.8 20394.0 20923.2 21185.6 5936.1 6175.8 6175.9 6178.2 6179.2 5972.4 6006.3 6026.9 6070.0 6097.4 5833.4 5951.3 5990.7 5997.6 6018.8 5942.4 5948.2 5973.5 5993.5 6018.0 5303.1 5427.2 5430.8 5435.3 5436.0 25436.0 25583.9 25603.4 25712.6 25855.7 2540.6 2661.4 3012.9 3257.5 3315.8 15376.0 15789.6 15977.8 15989.7 16091.1 2087.9 2160.7 2176.9 2181.2 2204.8 84864.6 85140.1 86964.6 87122.6 88229.0 10603.7 10677.1 11134.0 11495.3 11556.2 16236.2 16291.3 16338.6 16350.6 16359.1 8459.4 8516.0 8568.0 8774.3 8809.3 8419.0 8514.7 8703.8 8743.5 8744.7 6948.5 7035.6 7041.5 7103.7 7141.1 1978.4 1981.2 1988.6 2062.8 2115.2 1016.4 1097.1 1150.6 1152.4 1173.1 21021.6 21022.9 21529.9 21585.0 21721.8 1040.3 1078.3 1101.2 1164.5 1176.9 11308.5 11778.2 11809.4 11964.5 11997.2 446942.0 448753.0 463436.0 527070.0 528951.0 83028.2 83243.6 84942.6 85880.6 101989.0 1088.7 1090.7 1113.9 1122.0 1123.8 15540.8 18001.4 18536.5 19174.7 19480.3 41884.4 44843.6 45319.5 45668.0 48460.3 55535.0 58516.4 61691.7 64298.7 66964.0 9110.0 9486.6 9523.7 9586.1 9600.9 10736.5 14488.4 14518.8 14550.5 14960.2 12853.3 12869.7 12927.0 12993.3 13299.9 12420.8 12598.7 12692.6 12896.3 13133.9 12001.7 12312.6 12312.8 12919.3 13031.0 9144.7 9182.9 9264.7 9298.8 9313.4 11571.7 12467.4 12553.9 12618.2 12812.0 15:32:22 INFO - PROCESS | 4614 | 15:32:22 INFO - PROCESS | 4614 | [#3] mootools.html Cycles:180 Average:6432.28 Median:4625.02 stddev:3698.53 (80.0%) stddev-sans-first:3690.76 15:32:22 INFO - PROCESS | 4614 | Values: 1556.8 1579.6 1727.2 1834.4 1847.9 8679.3 9146.3 9402.3 10005.5 10086.1 9500.8 9823.6 9854.3 9896.9 9906.9 2502.5 2545.7 2555.5 2555.8 2556.8 2436.7 2553.8 2562.6 2565.7 2566.0 2516.2 2549.7 2567.5 2570.8 2575.4 2491.5 2491.9 2494.5 2496.8 2511.1 2484.3 2485.1 2487.1 2487.3 2499.3 9923.3 9984.7 9998.3 10031.9 10038.0 5604.7 5859.4 5868.9 5874.5 5911.0 3530.9 3615.3 3638.3 3686.1 3706.5 1120.4 1169.5 1174.1 1186.8 1206.9 13724.9 13742.6 13755.4 13798.9 13802.4 5053.4 5096.6 5262.9 5272.9 5281.5 10182.6 10192.9 10246.1 10249.0 10254.7 5707.9 5751.4 5773.9 5774.7 5785.3 4774.1 5274.4 5376.3 5409.5 5410.5 4179.0 4258.7 4287.8 4287.9 4316.8 1279.2 1304.7 1310.9 1324.4 1325.2 1014.3 1065.9 1082.0 1084.2 1101.6 6543.9 6620.0 6676.0 6701.2 6836.7 503.2 508.5 518.6 519.9 525.8 4590.1 4591.8 4658.3 4706.7 4771.1 11900.2 12185.0 12264.5 12328.7 12342.8 11481.8 11932.5 11953.2 12373.9 12427.5 8992.5 9115.4 9137.8 9142.5 9166.0 6739.2 6927.4 6948.2 7000.5 7031.6 11171.7 11372.2 11429.3 11453.7 11556.3 11532.5 11560.0 11633.8 11692.6 11695.1 8445.7 8612.1 8668.0 8687.3 8863.6 9597.0 9613.0 9699.0 9705.6 9722.8 8620.6 8638.5 8691.3 8775.0 8856.5 8360.7 8430.5 8482.6 8532.8 8800.1 7890.2 8011.6 8040.1 8067.6 8068.6 5763.9 5808.0 5930.4 5955.5 6047.2 5355.5 5949.0 5972.8 5993.9 6127.6 15:32:22 INFO - PROCESS | 4614 | 15:32:22 INFO - PROCESS | 4614 | [#4] prototype.html Cycles:180 Average:5064.40 Median:5711.13 stddev:1536.78 (26.9%) stddev-sans-first:1499.25 15:32:22 INFO - PROCESS | 4614 | Values: 319.1 325.0 330.9 338.2 339.7 5754.5 5763.8 5875.0 5971.6 5992.5 5827.7 5841.2 5848.1 5872.8 5939.5 4531.6 4548.1 4551.6 4558.5 4570.7 4421.6 4492.4 4519.8 4549.4 4552.4 4470.1 4490.4 4492.3 4513.3 4555.6 4244.7 4514.4 4526.0 4533.1 4550.2 3854.7 3874.0 3886.2 3886.8 3888.0 5681.1 5688.1 5693.9 5699.6 5728.4 4841.2 5081.8 5121.4 5155.7 5181.8 6057.3 6058.7 6075.6 6078.2 6091.6 4246.4 4259.8 4267.0 4269.2 4287.4 6255.8 6306.2 6390.6 6408.6 6409.4 4358.8 4375.9 4381.1 4385.7 4408.4 4394.9 4412.7 4414.9 4435.3 4463.0 5021.8 5089.3 5139.6 5140.7 5155.4 5909.4 6046.5 6128.0 6132.6 6173.9 1468.1 1482.3 1482.5 1484.5 1486.6 903.9 928.9 932.6 953.2 967.7 5209.8 5247.1 5304.5 5405.8 5416.8 5481.8 5540.6 5557.5 5572.9 5609.9 4961.5 5288.8 5299.0 5329.9 5356.7 2957.7 2965.9 2966.4 2977.3 2998.8 5695.9 5710.4 5711.8 5727.8 5734.2 5952.3 6318.3 6468.9 6469.9 6473.0 6570.2 6646.7 6657.3 6663.3 6672.5 6156.7 6286.6 6311.7 6363.5 6444.4 6239.7 6264.0 6272.8 6304.6 6326.9 6348.9 6587.8 6604.3 6651.4 6668.8 4375.1 4391.3 4420.7 4452.5 4462.9 6153.7 6200.4 6386.0 6398.6 6418.6 6119.9 6173.6 6200.9 6210.6 6223.9 6064.5 6124.9 6169.1 6194.7 6234.8 6102.5 6170.7 6203.3 6227.4 6228.3 6250.3 6264.3 6278.5 6284.0 6286.8 5784.5 5973.8 6012.5 6034.5 6051.6 15:32:22 INFO - PROCESS | 4614 | 15:32:22 INFO - PROCESS | 4614 | [#5] yui.html Cycles:180 Average:22476.62 Median:3773.27 stddev:32592.90 (863.8%) stddev-sans-first:32643.66 15:32:22 INFO - PROCESS | 4614 | Values: 793.6 807.4 815.5 904.9 923.5 16295.8 16995.8 17483.8 18033.5 18341.1 15542.9 15647.5 15664.1 15701.5 15725.1 866.9 885.2 899.0 901.6 905.3 900.7 903.7 904.8 905.3 907.8 945.9 950.5 955.6 958.0 958.7 955.8 955.9 956.3 956.8 957.0 705.3 705.3 705.5 706.1 708.5 16674.8 16741.7 16763.2 16801.7 16818.4 14397.6 14598.0 14774.0 15178.6 15196.5 14913.1 14998.0 15049.7 15057.0 15472.5 4840.1 4879.8 4883.5 4936.0 5045.2 90513.0 90721.0 91321.0 91350.1 91774.5 12473.2 12486.8 12568.9 12611.9 12613.0 22369.4 22617.0 22640.0 22663.5 23480.0 8594.0 8663.2 8826.0 9166.5 9283.5 4934.0 5032.6 5086.3 5117.4 5134.2 3646.0 3764.1 3782.5 3783.4 3795.7 641.2 653.9 654.7 669.2 676.7 541.4 564.4 589.7 637.4 705.8 10157.6 10290.8 10443.5 10448.7 10519.7 678.3 707.1 726.6 732.7 749.1 4491.5 4933.0 5002.1 5021.5 5043.8 76175.6 94164.0 101614.5 121002.0 143508.0 118989.4 120389.0 121759.0 123310.4 127631.4 78953.6 79017.0 90232.5 90808.5 103550.0 10006.3 10331.3 10687.4 10867.4 10869.3 56294.7 56311.7 57233.4 57344.1 58095.7 71859.6 77922.7 79636.6 79823.0 79939.2 12839.3 13528.3 13585.7 13862.2 13868.6 15202.5 15226.3 15422.2 15699.5 16498.3 14216.5 14304.6 14417.8 14799.7 15289.8 13582.5 13662.9 14187.4 14425.1 14668.8 13333.9 13547.3 13646.5 14009.0 14350.4 10679.7 10682.1 10702.4 10869.8 11180.6 11248.2 11673.7 11735.8 11773.9 11892.1 15:32:22 INFO - PROCESS | 4614 | -------- Summary: end -------- 15:32:22 INFO - PROCESS | 4614 | 15:32:23 INFO - TEST-INFO | 4614: exit 0 15:32:23 INFO - TEST-OK | dromaeo_css | took 1111506ms 15:32:23 INFO - TEST-START | kraken 15:32:23 INFO - operating with platform_type : linux_ 15:32:23 INFO - Initialising browser for kraken test... 15:32:23 INFO - TEST-INFO | started process 4877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppoTp90/profile http://localhost:41410/getInfo.html) 15:32:27 INFO - PROCESS | 4877 | __metrics Screen width/height:1600/1200 15:32:27 INFO - PROCESS | 4877 | colorDepth:24 15:32:27 INFO - PROCESS | 4877 | Browser inner width/height: 1024/697 15:32:27 INFO - PROCESS | 4877 | __metrics 15:32:28 ERROR - PROCESS | 4877 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:32:29 INFO - TEST-INFO | 4877: exit 0 15:32:29 INFO - Browser initialized. 15:32:29 INFO - Running cycle 1/1 for kraken test... 15:32:29 INFO - TEST-INFO | started process 5003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppoTp90/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:41 INFO - PROCESS | 5003 | RSS: Main: 152850432 15:32:41 INFO - PROCESS | 5003 | 15:32:43 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41410/tests/kraken/driver.html?testName=audio-beat-detection) 15:32:44 INFO - PROCESS | 5003 | RSS: Main: 157618176 15:32:44 INFO - PROCESS | 5003 | 15:32:47 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41410/tests/kraken/driver.html?testName=audio-dft) 15:32:47 INFO - PROCESS | 5003 | RSS: Main: 157077504 15:32:47 INFO - PROCESS | 5003 | 15:32:50 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41410/tests/kraken/driver.html?testName=audio-fft) 15:32:51 INFO - PROCESS | 5003 | RSS: Main: 157589504 15:32:51 INFO - PROCESS | 5003 | 15:32:53 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41410/tests/kraken/driver.html?testName=audio-oscillator) 15:32:54 INFO - PROCESS | 5003 | RSS: Main: 157093888 15:32:54 INFO - PROCESS | 5003 | 15:32:56 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41410/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:32:56 INFO - PROCESS | 5003 | RSS: Main: 156950528 15:32:56 INFO - PROCESS | 5003 | 15:32:59 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41410/tests/kraken/driver.html?testName=imaging-darkroom) 15:33:00 INFO - PROCESS | 5003 | RSS: Main: 156368896 15:33:00 INFO - PROCESS | 5003 | 15:33:04 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41410/tests/kraken/driver.html?testName=imaging-desaturate) 15:33:04 INFO - PROCESS | 5003 | RSS: Main: 155148288 15:33:04 INFO - PROCESS | 5003 | 15:33:07 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41410/tests/kraken/driver.html?testName=json-parse-financial) 15:33:08 INFO - PROCESS | 5003 | RSS: Main: 156815360 15:33:08 INFO - PROCESS | 5003 | 15:33:09 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41410/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:33:10 INFO - PROCESS | 5003 | RSS: Main: 156426240 15:33:10 INFO - PROCESS | 5003 | 15:33:11 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41410/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:33:12 INFO - PROCESS | 5003 | RSS: Main: 156794880 15:33:12 INFO - PROCESS | 5003 | 15:33:14 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41410/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:33:15 INFO - PROCESS | 5003 | RSS: Main: 157655040 15:33:15 INFO - PROCESS | 5003 | 15:33:17 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:33:18 INFO - PROCESS | 5003 | RSS: Main: 157581312 15:33:18 INFO - PROCESS | 5003 | 15:33:21 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:33:21 INFO - PROCESS | 5003 | RSS: Main: 158060544 15:33:21 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | Cycle 1(1): loaded http://localhost:41410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41410/tests/kraken/driver.html?testName=ai-astar) 15:33:23 INFO - PROCESS | 5003 | RSS: Main: 159117312 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | __start_tp_report 15:33:23 INFO - PROCESS | 5003 | _x_x_mozilla_page_load 15:33:23 INFO - PROCESS | 5003 | _x_x_mozilla_page_load_details 15:33:23 INFO - PROCESS | 5003 | |i|pagename|runs| 15:33:23 INFO - PROCESS | 5003 | |0;ai-astar;100;110;104;110;110;111;110;117;112;110 15:33:23 INFO - PROCESS | 5003 | |1;audio-beat-detection;155;118;141;177;118;141;145;118;173;116 15:33:23 INFO - PROCESS | 5003 | |2;audio-dft;162;163;166;164;163;162;164;162;162;162 15:33:23 INFO - PROCESS | 5003 | |3;audio-fft;75;75;76;181;76;76;76;74;163;77 15:33:23 INFO - PROCESS | 5003 | |4;audio-oscillator;83;83;149;85;83;83;140;83;83;140 15:33:23 INFO - PROCESS | 5003 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;118;118;118 15:33:23 INFO - PROCESS | 5003 | |6;imaging-darkroom;148;148;148;147;148;147;148;147;147;146 15:33:23 INFO - PROCESS | 5003 | |7;imaging-desaturate;95;96;96;100;96;96;95;95;95;95 15:33:23 INFO - PROCESS | 5003 | |8;json-parse-financial;57;52;54;52;56;53;52;55;51;52 15:33:23 INFO - PROCESS | 5003 | |9;json-stringify-tinderbox;60;61;60;62;61;60;60;61;61;62 15:33:23 INFO - PROCESS | 5003 | |10;stanford-crypto-aes;73;72;83;76;72;74;72;73;79;74 15:33:23 INFO - PROCESS | 5003 | |11;stanford-crypto-ccm;118;126;121;120;117;127;128;128;158;127 15:33:23 INFO - PROCESS | 5003 | |12;stanford-crypto-pbkdf2;155;154;150;155;155;163;156;150;150;156 15:33:23 INFO - PROCESS | 5003 | |13;stanford-crypto-sha256-iterative;62;67;64;62;64;63;64;62;60;63 15:33:23 INFO - PROCESS | 5003 | __end_tp_report 15:33:23 INFO - PROCESS | 5003 | __start_cc_report 15:33:23 INFO - PROCESS | 5003 | _x_x_mozilla_cycle_collect,843 15:33:23 INFO - PROCESS | 5003 | __end_cc_report 15:33:23 INFO - PROCESS | 5003 | __startTimestamp1472769203655__endTimestamp 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | ------- Summary: start ------- 15:33:23 INFO - PROCESS | 5003 | Number of tests: 14 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:4.55 (4.1%) stddev-sans-first:3.32 15:33:23 INFO - PROCESS | 5003 | Values: 100.0 110.0 104.0 110.0 110.0 111.0 110.0 117.0 112.0 110.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:143.00 stddev:22.94 (16.0%) stddev-sans-first:23.70 15:33:23 INFO - PROCESS | 5003 | Values: 155.0 118.0 141.0 177.0 118.0 141.0 145.0 118.0 173.0 116.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.33 (0.8%) stddev-sans-first:1.36 15:33:23 INFO - PROCESS | 5003 | Values: 162.0 163.0 166.0 164.0 163.0 162.0 164.0 162.0 162.0 162.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:40.86 (53.8%) stddev-sans-first:42.70 15:33:23 INFO - PROCESS | 5003 | Values: 75.0 75.0 76.0 181.0 76.0 76.0 76.0 74.0 163.0 77.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:83.00 stddev:28.96 (34.9%) stddev-sans-first:29.95 15:33:23 INFO - PROCESS | 5003 | Values: 83.0 83.0 149.0 85.0 83.0 83.0 140.0 83.0 83.0 140.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 15:33:23 INFO - PROCESS | 5003 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 15:33:23 INFO - PROCESS | 5003 | Values: 148.0 148.0 148.0 147.0 148.0 147.0 148.0 147.0 147.0 146.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:95.50 stddev:1.52 (1.6%) stddev-sans-first:1.58 15:33:23 INFO - PROCESS | 5003 | Values: 95.0 96.0 96.0 100.0 96.0 96.0 95.0 95.0 95.0 95.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:2.01 (3.8%) stddev-sans-first:1.66 15:33:23 INFO - PROCESS | 5003 | Values: 57.0 52.0 54.0 52.0 56.0 53.0 52.0 55.0 51.0 52.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.78 15:33:23 INFO - PROCESS | 5003 | Values: 60.0 61.0 60.0 62.0 61.0 60.0 60.0 61.0 61.0 62.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:74.00 stddev:3.61 (4.9%) stddev-sans-first:3.77 15:33:23 INFO - PROCESS | 5003 | Values: 73.0 72.0 83.0 76.0 72.0 74.0 72.0 73.0 79.0 74.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:127.00 stddev:11.69 (9.2%) stddev-sans-first:11.94 15:33:23 INFO - PROCESS | 5003 | Values: 118.0 126.0 121.0 120.0 117.0 127.0 128.0 128.0 158.0 127.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.40 Median:155.00 stddev:3.92 (2.5%) stddev-sans-first:4.15 15:33:23 INFO - PROCESS | 5003 | Values: 155.0 154.0 150.0 155.0 155.0 163.0 156.0 150.0 150.0 156.0 15:33:23 INFO - PROCESS | 5003 | 15:33:23 INFO - PROCESS | 5003 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.50 stddev:1.85 (2.9%) stddev-sans-first:1.92 15:33:23 INFO - PROCESS | 5003 | Values: 62.0 67.0 64.0 62.0 64.0 63.0 64.0 62.0 60.0 63.0 15:33:23 INFO - PROCESS | 5003 | -------- Summary: end -------- 15:33:23 INFO - PROCESS | 5003 | 15:33:24 INFO - TEST-INFO | 5003: exit 0 15:33:24 INFO - TEST-OK | kraken | took 61437ms 15:33:24 INFO - SUITE-END | took 1172s 15:33:24 INFO - Completed test suite (00:19:33) 15:33:24 INFO - javascript benchmark 15:33:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7887.529614596183, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3281.540584318195, 3327.5175099610556, 3336.5829271341067, 3352.363051020306, 3357.6810203030705, 5939.4060593940585, 5954.851128721784, 5957.195778569891, 5976.432238937305, 5981.222441082658, 5887.175795388649, 5916.88166236675, 5952.017917043682, 5956.493698035672, 5959.70201489926, 5317.229001794747, 5343.0, 5407.270018547505, 5447.536959358459, 5483.561315094783, 5169.767360468788, 5190.688558686472, 5253.238280449333, 5337.066013447631, 5383.4616538346045, 5361.892762144755, 5389.299391079154, 5392.40683524812, 5396.406395296514, 5407.648502847303, 5401.70290634015, 5427.782888684467, 5460.153676180198, 5460.453954604547, 5482.314710661168, 5123.692578445305, 5209.479052094798, 5234.110201265794, 5347.732613369355, 5363.892722145535, 5756.827295181151, 5799.5650326225705, 5809.099589563624, 5850.736716847709, 5859.0, 6247.062940558907, 6296.496280297565, 6303.842403939938, 6304.211973503312, 6309.716062777186, 6067.908981365283, 6224.159738435344, 6280.654563999024, 6357.618542887441, 6361.713722882481, 5915.526757859361, 5915.792947246826, 5947.226860508106, 5953.434423729739, 5962.642241465526, 6455.128557644752, 6463.418292353711, 6487.902681459782, 6507.772227971998, 6515.218173819172, 5932.673702946379, 6080.452759251689, 6106.45041946227, 6223.906641400383, 6231.688415579203, 6237.09562113491, 6247.875042499125, 6271.0, 6287.151234583364, 6318.778842740482, 6257.937420625826, 6260.7495700171485, 6264.906026409608, 6278.937210627927, 6279.246490421087, 5997.280326360865, 6202.41077097675, 6221.0, 6237.688115594202, 6269.498440124779, 4823.662343635982, 4823.758812059383, 4827.324174615556, 4845.370101886802, 4857.562819346276, 4277.422547955986, 4278.935815962763, 4285.3786201000685, 4286.249906266391, 4306.138772245564, 5927.9703601481715, 6008.3390827009, 6053.818385448443, 6072.969635151884, 6137.7851775187655, 6350.872982540416, 6390.488760899117, 6401.55189136756, 6403.775867844696, 6406.167198264196, 6075.1798507200965, 6134.631922084689, 6137.171481849893, 6137.693115344215, 6146.139540464339, 5295.602829787705, 5388.67667939917, 5411.053065713484, 5480.369757477862, 5527.55779537636, 6607.504437167232, 6632.1709786276715, 6635.568688035262, 6642.0, 6661.16735408074, 6319.24169099711, 6355.809325720235, 6380.712867921047, 6385.521085918667, 6393.2328120625825, 6347.904781428375, 6506.837329066811, 6511.283758786435, 6562.34376562359, 6643.70103345341, 6278.058291256348, 6280.5289603279025, 6282.842928926813, 6283.0, 6285.057241413641, 6327.430531252209, 6376.075469057054, 6389.169407976933, 6403.7118329676205, 6418.229812422539, 5926.051831706906, 6120.599512025131, 6147.784827531015, 6209.751609935552, 6225.906611400742, 6198.783042593487, 6217.751289948352, 6218.440340369208, 6241.937580624136, 6248.875022499434, 6168.9691551541955, 6235.594686345373, 6240.00159974402, 6240.594361366497, 6242.812715618538, 5961.701914904324, 6113.9932453606225, 6150.231221097363, 6226.875462490815, 6250.843728906631, 6089.238845144357, 6098.207233059674, 6100.908486372619, 6116.3272040076445, 6124.816255512342], "value": 5822.31529406811, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4194975998881, 631.3402494393358, 670.6143967218849, 678.0642713055979, 688.9483288753345, 42827.0, 47870.04259914804, 47945.52054479454, 47952.28071578929, 47997.760011199985, 47622.0, 48306.758466207706, 48357.274640880416, 48372.27441588379, 48471.75764121174, 9116.589753461094, 9189.127032931894, 9253.120953509406, 9258.490783006931, 9261.259099272076, 9244.0, 9268.02685718, 9294.0, 9330.253579713606, 9350.485723285217, 9312.906870931272, 9364.25085993119, 9370.437773733564, 9399.154076133147, 9411.388259763093, 9294.907050929505, 9305.767355816091, 9305.906940930572, 9357.39176953496, 9394.06059394062, 9235.261179105722, 9274.07259274074, 9278.0, 9330.766730831716, 9342.205912497446, 45623.77188114071, 46061.53938460606, 46094.07811843778, 46099.07801843978, 46155.76922115368, 3636.090977255686, 3809.942850857212, 3867.149227170018, 3907.0, 4225.331143082585, 35885.64114358849, 36415.63584364149, 36489.0, 36759.26481470383, 36856.26287474235, 4659.464161621423, 4706.199946009152, 4711.952880471185, 4728.078024785168, 4745.857624271277, 381467.0, 381511.9999999972, 382647.0, 384279.0, 387712.0, 66042.66978665076, 66740.0, 66857.0, 67009.66495167493, 67212.0, 42120.157596848505, 42949.14101717948, 43087.0, 43185.78407107944, 43258.78370608127, 17454.389096381565, 17512.562185945455, 17556.736648950275, 17615.38346157904, 17646.91176544109, 14069.648258793612, 14110.22393768332, 14161.85838141626, 14187.432502699776, 14248.287585620677, 21738.0, 21740.56518869614, 21810.781892180876, 21974.560508789735, 21985.120595176333, 7566.810829729301, 7708.614569271514, 7759.689612415553, 7816.335611472975, 8037.598120093972, 1042.6924057403085, 1135.6536256441864, 1169.1523645357217, 1175.5239128153112, 1215.598852378713, 34933.65066349304, 35452.29095418129, 35595.28809423797, 35723.0, 35859.282814344086, 1175.2948231061296, 1180.1856718863955, 1180.6635108993896, 1204.0668481926577, 1235.7950997777095, 17820.91089544544, 18331.900085994883, 18472.445826625222, 18476.168572414274, 18510.722339164924, 478958.0, 695453.0, 702842.0, 703363.0, 707370.0, 66974.0, 67602.32397676058, 67751.32248677549, 68032.6598367005, 68185.31814681888, 1439.100562148657, 1459.5913144319607, 1475.5278310940396, 1483.6735918098002, 1499.3402902722767, 35531.0, 35985.0, 36113.27773444569, 36770.0, 36836.81581592075, 58025.70987145037, 59519.40480595139, 59536.404635954816, 59585.40414595972, 59616.0, 516508.0, 519617.0, 520579.0, 522030.0, 524499.0, 32680.50979235361, 32860.83569582137, 32874.0, 32970.5054424179, 33188.50217246792, 54088.729556351966, 54281.0, 54825.725871370385, 54865.72567137139, 55641.165382518484, 45195.32207016832, 47620.0, 48281.5171848277, 48524.0, 48922.0, 46545.301820473396, 46577.0, 47193.29210061783, 47329.76335118302, 47522.52477475181, 39508.40737388884, 45534.31698524591, 45784.313235302165, 46532.7673361631, 46821.29768053414, 38795.0, 41010.0, 41301.79349103235, 41322.38016429816, 42354.78822605867, 30794.846025769726, 31066.0, 31481.527777082905, 31580.210494737814, 31634.525482117326], "value": 22030.427173077063, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.27911596474223, 412.6100834711197, 420.80222295521105, 429.7786639880461, 439.7383556783715, 19700.11349489273, 20480.180792768308, 20935.37193884182, 21214.257500987467, 21417.357479275626, 18036.188371523313, 19589.804101959013, 20394.0, 20923.16307347708, 21185.57628847422, 5936.139259807325, 6175.845603859917, 6175.907361389583, 6178.165947597085, 6179.19670442844, 5972.402759724015, 6006.3393026767235, 6026.939730602704, 6069.969650151766, 6097.359777223394, 5833.416658334175, 5951.2858456985, 5990.73041713124, 5997.610155339889, 6018.8194354169445, 5942.405759424067, 5948.196993405878, 5973.462388385023, 5993.520518358521, 6017.969910150443, 5303.124984377573, 5427.185922111676, 5430.782768689287, 5435.266239057716, 5436.0, 25436.0, 25583.872080639663, 25603.359916002064, 25712.614310785353, 25855.74144258552, 2540.5808041673104, 2661.441097369555, 3012.9246768830953, 3257.478803391446, 3315.8342082896, 15376.000559963566, 15789.605259868595, 15977.840221597751, 15989.680206395808, 16091.114988675617, 2087.937361879146, 2160.654295312758, 2176.8911554422375, 2181.182056728727, 2204.812590929773, 84864.57567712122, 85140.14859851384, 86964.5651771737, 87122.56438717766, 88229.0, 10603.734906627396, 10677.09244714208, 11134.0, 11495.298604827858, 11556.248843825124, 16236.18819059066, 16291.266892989845, 16338.591535211715, 16350.591235219215, 16359.100249486155, 8459.385141328288, 8515.957420212859, 8567.957160214284, 8774.341924355698, 8809.251213646912, 8418.957905210435, 8514.74455766328, 8703.825923481494, 8743.519106449206, 8744.737657870273, 6948.513604047769, 7035.613041282779, 7041.4718896082995, 7103.680334384965, 7141.107361579802, 1978.4064780565773, 1981.1778112083323, 1988.6420444319872, 2062.752469703615, 2115.206797450956, 1016.4460369098858, 1097.1332647208776, 1150.6202953025481, 1152.3604399558326, 1173.0732721150366, 21021.633593816354, 21022.894885525475, 21529.928081153583, 21585.0, 21721.782782171977, 1040.2718097331897, 1078.2883297023927, 1101.1906248907046, 1164.493445351258, 1176.864660564029, 11308.547658093748, 11778.175527712978, 11809.40952952349, 11964.461599228056, 11997.220180688228, 446942.0, 448753.0, 463436.0, 527070.0, 528951.0, 83028.16971830325, 83243.58378208191, 84942.5752871244, 85880.57059714786, 101989.0, 1088.7441451258949, 1090.6946055104584, 1113.9387333696725, 1121.966341009771, 1123.797716411054, 15540.766888496455, 18001.369952051617, 18536.536586585444, 19174.71237931404, 19480.318188863323, 41884.37173442462, 44843.55156448394, 45319.546804531536, 45668.0, 48460.273095902885, 55535.0, 58516.414835851094, 61691.69154154201, 64298.67850660717, 66964.0, 9109.954450227706, 9486.620535178792, 9523.666671666459, 9586.137247647745, 9600.90399096028, 10736.463176841284, 14488.420463181355, 14518.782218266946, 14550.4907328243, 14960.17719025464, 12853.293068881301, 12869.742605147658, 12927.0, 12993.285369304778, 13299.933500332436, 12420.751584968431, 12598.748025039631, 12692.619221423372, 12896.29070401137, 13133.868661313265, 12001.699957501132, 12312.569060082855, 12312.75374492523, 12919.289439080942, 13031.0, 9144.679936202201, 9182.862257066015, 9264.675736349196, 9298.814023719622, 9313.44119352841, 11571.6528504145, 12467.376631168225, 12553.93723031379, 12618.242905425705, 12812.039097067944], "value": 10062.412729135853, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1556.7742677311794, 1579.6129948162697, 1727.19685346314, 1834.3763120539031, 1847.8891266524001, 8679.349048821348, 9146.31402644801, 9402.341836071479, 10005.549750261238, 10086.14267787238, 9500.80998380032, 9823.607055717763, 9854.260930430228, 9896.851547226797, 9906.851397229048, 2502.524520341134, 2545.681789776278, 2555.5400027995047, 2555.782758465533, 2556.75710807473, 2436.658867758515, 2553.834000789943, 2562.6412302277695, 2565.679290088739, 2565.987170064147, 2516.169664010881, 2549.7067837198683, 2567.5378431882255, 2570.807189460789, 2575.381908341994, 2491.5266099441137, 2491.862947537885, 2494.5135698538793, 2496.8377055491337, 2511.1462102885016, 2484.291976786607, 2485.0556788420286, 2487.117073438921, 2487.291122030231, 2499.262717498342, 9923.255755818342, 9984.700458986243, 9998.300118991674, 10031.949840250825, 10038.046385593358, 5604.747786349624, 5859.44335288147, 5868.9413105868825, 5874.471297583238, 5911.024680927641, 3530.894073177809, 3615.3311637347174, 3638.308721342936, 3686.1337585667347, 3706.5366829146355, 1120.355795417638, 1169.502961241469, 1174.0979613026866, 1186.7685801268756, 1206.90344772418, 13724.93137534306, 13742.587722368346, 13755.38100785457, 13798.93100534501, 13802.447902083904, 5053.36832895888, 5096.592272618182, 5262.947370526323, 5272.894542109213, 5281.524662780368, 10182.643607473703, 10192.949035254776, 10246.129079028366, 10249.0, 10254.743631409125, 5707.942920570824, 5751.396103409165, 5773.855653608609, 5774.68239246837, 5785.334686511105, 4774.116788394158, 5274.393444753826, 5376.327959005124, 5409.459054094559, 5410.540104091117, 4179.0, 4258.723182993095, 4287.8499252526635, 4287.871363859089, 4316.848910288125, 1279.2004996876951, 1304.6868751499762, 1310.9119430872354, 1324.4304948871884, 1325.1982550556775, 1014.2545229256491, 1065.9093977011885, 1081.9513121909533, 1084.2356138922041, 1101.5758932810766, 6543.9345606544275, 6620.0, 6676.031975363545, 6701.195856497154, 6836.726530938707, 503.16725818769993, 508.506748453999, 518.5765420959224, 519.9246109314129, 525.8422473258007, 4590.081983603292, 4591.79336929839, 4658.254679251304, 4706.670533062653, 4771.117343291502, 11900.166988310908, 12185.0, 12264.509419623293, 12328.691782705504, 12342.81485777714, 11481.770364592661, 11932.522699092113, 11953.16327857059, 12373.876261237452, 12427.502899883903, 8992.505412202261, 9115.36192466521, 9137.81724365509, 9142.542872856198, 9166.0, 6739.224989126314, 6927.411170050602, 6948.200956890022, 7000.544964577286, 7031.648417579203, 11171.72070698239, 11372.20394572372, 11429.314241145557, 11453.713657158638, 11556.306621602731, 11532.481038353126, 11560.0, 11633.76732465329, 11692.649220523397, 11695.12286578493, 8445.746627601182, 8612.095729948265, 8668.0, 8687.305015598864, 8863.64545418176, 9597.0, 9612.951935240279, 9699.030096990244, 9705.563249653642, 9722.805543889224, 8620.568971551524, 8638.481691098554, 8691.304695624462, 8775.0, 8856.468611883307, 8360.707375241838, 8430.494170349799, 8482.57587120629, 8532.829343413221, 8800.119988001148, 7890.210978902064, 8011.599420028859, 8040.075391330072, 8067.636956336862, 8068.636911338886, 5763.94236057634, 5808.0, 5930.436608522184, 5955.464008239279, 6047.213862197887, 5355.491228333302, 5948.970255148696, 5972.790952316648, 5993.880122397615, 6127.571070025056], "value": 5030.802887913826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.0921827401043, 325.04923099932694, 330.86930662388374, 338.1579866133328, 339.66373290442453, 5754.539636829054, 5763.82708518744, 5874.970625146873, 5971.552133589982, 5992.520598352132, 5827.650340979533, 5841.2114364560775, 5848.070136854838, 5872.827053990019, 5939.495142912858, 4531.637469002472, 4548.135854187711, 4551.589007407698, 4558.475775285843, 4570.725756454607, 4421.602055814976, 4492.39352687388, 4519.774011299438, 4549.408576885, 4552.385427967231, 4470.128324976631, 4490.393796837434, 4492.326151077332, 4513.323001549761, 4555.612772914306, 4244.681648876316, 4514.367988481616, 4525.977370113162, 4533.138703646297, 4550.249208880531, 3854.69162467002, 3873.9612603873884, 3886.164474637938, 3886.7862267575274, 3887.9805600972095, 5681.147827825818, 5688.11834165705, 5693.943060569382, 5699.629524080921, 5728.42715728428, 4841.2496063110275, 5081.79672813087, 5121.359830021247, 5155.71643559604, 5181.792728290864, 6057.30341010785, 6058.727357268934, 6075.605085669417, 6078.240219972504, 6091.573589848713, 4246.426732391118, 4259.829606815754, 4267.0, 4269.167512335096, 4287.399764033038, 6255.781047663356, 6306.180196574462, 6390.584612000252, 6408.647524386157, 6409.391107844747, 4358.8038538265855, 4375.912481750347, 4381.123775244963, 4385.736855788663, 4408.360787685768, 4394.890127746832, 4412.691111622155, 4414.933775993362, 4435.290353543418, 4462.9776851116185, 5021.774020169101, 5089.338386009795, 5139.640225184201, 5140.665856719376, 5155.38135423744, 5909.438603332676, 6046.546509011754, 6127.96936015326, 6132.63204207749, 6173.857836300299, 1468.12646475347, 1482.3181336585076, 1482.5404124721372, 1484.547213100015, 1486.568895020432, 903.8927314040379, 928.8513837785922, 932.5989824375583, 953.2278854128178, 967.666155176463, 5209.843704688866, 5247.10799164143, 5304.522592966651, 5405.7567409466665, 5416.83749487516, 5481.835544933659, 5540.559454541848, 5557.527610153102, 5572.86067848307, 5609.887802243932, 4961.479044700327, 5288.8413347599635, 5298.97350513245, 5329.920051199235, 5356.7321633918145, 2957.68383069532, 2965.9174401343353, 2966.4363770883465, 2977.2556860784803, 2998.775091868075, 5695.92420093145, 5710.428957104339, 5711.828645140652, 5727.828165155052, 5734.197212390269, 5952.315483719428, 6318.2624778185445, 6468.935310646927, 6469.935300647027, 6472.967635161794, 6570.226038969547, 6646.734130634721, 6657.3009833966735, 6663.300353462913, 6672.499562532927, 6156.722947467285, 6286.559940804283, 6311.747530098744, 6363.490920726424, 6444.387783160592, 6239.656818875005, 6263.96868015657, 6272.8431789203805, 6304.5586808922935, 6326.8804950342155, 6348.873022539431, 6587.814193445226, 6604.306547812411, 6651.434628056476, 6668.766593169215, 4375.124975004948, 4391.297392417198, 4420.7126536775, 4452.465704115527, 4462.910741785081, 6153.72308246139, 6200.410960958701, 6386.0, 6398.5521013528605, 6418.6469744164515, 6119.938800611937, 6173.56785025044, 6200.906986395298, 6210.627362358273, 6223.941929872023, 6064.4541991221, 6124.938750612437, 6169.074638804215, 6194.721237544411, 6234.781782637586, 6102.481289090477, 6170.660613666112, 6203.348648391854, 6227.439530442282, 6228.252609686867, 6250.34354902369, 6264.31092579825, 6278.529110316653, 6283.994560870239, 6286.779962701284, 5784.537237020944, 5973.790917317873, 6012.488938440281, 6034.517238620988, 6051.576389652682], "value": 4557.550680412561, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.6309616028549, 807.382352500337, 815.502543448496, 904.9004609492955, 923.5105394141106, 16295.755563666555, 16995.830041699595, 17483.825161748395, 18033.549161270974, 18341.082945852686, 15542.922285388557, 15647.530574082795, 15664.138472384042, 15701.528954131365, 15725.056496610212, 866.9133086691312, 885.1723638398103, 899.0200681257428, 901.5807649443008, 905.316486053029, 900.7207765592688, 903.6927444668811, 904.8235594059161, 905.2576886952702, 907.7503686486203, 945.8959514453439, 950.4772375193651, 955.6273053509137, 957.9712608621718, 958.6980101268078, 955.8327292723745, 955.9283053770995, 956.268454632207, 956.7751578379075, 957.0094951724931, 705.2559549675091, 705.3017512662478, 705.4638474759169, 706.0961968680098, 708.4934271995548, 16674.83325166745, 16741.6651666966, 16763.245653945603, 16801.663966720596, 16818.411355602497, 14397.64005899861, 14598.0, 14774.0, 15178.620534486616, 15196.544103676908, 14913.105213687213, 14998.0, 15049.699006019819, 15057.0, 15472.5358239253, 4840.080384726891, 4879.829205977774, 4883.536064073907, 4936.0, 5045.243213517965, 90513.0, 90721.0, 91321.0, 91350.08649913482, 91774.54112729394, 12473.189242699196, 12486.75026499465, 12568.87431125677, 12611.936940315423, 12613.0, 22369.44076398103, 22617.0, 22640.0, 22663.546729065325, 23480.0, 8593.957030214933, 8663.176998185163, 8826.0, 9166.541672916328, 9283.535823208813, 4933.975330123327, 5032.622553308516, 5086.262491938722, 5117.360329958755, 5134.178531434953, 3646.0, 3764.0589852536864, 3782.4893639358334, 3783.39465685489, 3795.69634429245, 641.2081079866362, 653.8659574787157, 654.6693919570681, 669.2337273821545, 676.6549059979446, 541.3611937913222, 564.4214679952998, 589.7346194212621, 637.3944752485065, 705.7882635209417, 10157.644482443078, 10290.794184116276, 10443.530041148166, 10448.68653940383, 10519.737006574744, 678.2674711311771, 707.1125737199782, 726.5822152262471, 732.7105793211651, 749.134749364485, 4491.528389519053, 4933.0, 5002.099622068063, 5021.548060674484, 5043.84868453947, 76175.61912190514, 94164.0, 101614.49192754137, 121002.0, 143508.0, 118989.40505297591, 120389.0, 121759.0, 123310.38344808399, 127631.36184319019, 78953.60523197462, 79017.0, 90232.5488372567, 90808.54595727111, 103550.0, 10006.349587276804, 10331.32846365014, 10687.412192329497, 10867.402292873969, 10869.347839129678, 56294.71852640711, 56311.71844140753, 57233.42766572448, 57344.1398379033, 58095.709521452125, 71859.64070179616, 77922.66232013049, 79636.60181699286, 79823.0, 79939.20060799317, 12839.29383883858, 13528.323583820573, 13585.660358491117, 13862.168269903837, 13868.583942481742, 15202.543923681866, 15226.314815833535, 15422.228888555303, 15699.529014129594, 16498.34006639769, 14216.502422415166, 14304.57086287413, 14417.7837332438, 14799.704005920037, 15289.770653439984, 13582.524611638546, 13662.863371366158, 14187.361568729226, 14425.134491930517, 14668.77996830027, 13333.866661333263, 13547.25490098054, 13646.454141834216, 14009.0, 14350.425982960565, 10679.679609611723, 10682.09202217789, 10702.357858528514, 10869.836952445561, 11180.608678696206, 11248.212625116163, 11673.708157296136, 11735.823962640738, 11773.941130294294, 11892.108091893315], "value": 8136.064026388267, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 104.0, 110.0, 110.0, 111.0, 110.0, 117.0, 112.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 141.0, 177.0, 118.0, 141.0, 145.0, 118.0, 173.0, 116.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 166.0, 164.0, 163.0, 162.0, 164.0, 162.0, 162.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 181.0, 76.0, 76.0, 76.0, 74.0, 163.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 149.0, 85.0, 83.0, 83.0, 140.0, 83.0, 83.0, 140.0], "value": 101.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 100.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 54.0, 52.0, 56.0, 53.0, 52.0, 55.0, 51.0, 52.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 62.0, 61.0, 60.0, 60.0, 61.0, 61.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 83.0, 76.0, 72.0, 74.0, 72.0, 73.0, 79.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 126.0, 121.0, 120.0, 117.0, 127.0, 128.0, 128.0, 158.0, 127.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 150.0, 155.0, 155.0, 163.0, 156.0, 150.0, 150.0, 156.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 67.0, 64.0, 62.0, 64.0, 63.0, 64.0, 62.0, 60.0, 63.0], "value": 63.1, "unit": "score"}]}]} 15:33:24 INFO - Return code: 0 15:33:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:33:24 ERROR - # TBPL SUCCESS # 15:33:24 INFO - Running post-action listener: _resource_record_post_action 15:33:24 INFO - [mozharness: 2016-09-01 22:33:24.987383Z] Finished run-tests step (success) 15:33:24 INFO - Running post-run listener: _resource_record_post_run 15:33:25 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 262144; Write bytes: 326279168; Read time: 16; Write time: 339540 15:33:25 INFO - TinderboxPrint: CPU usage
13.3% 15:33:25 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 16 15:33:25 INFO - TinderboxPrint: I/O write bytes / time
326,279,168 / 339,540 15:33:25 INFO - TinderboxPrint: CPU idle
8,234.8 (86.7%) 15:33:25 INFO - TinderboxPrint: CPU user
1,201.5 (12.7%) 15:33:25 INFO - TinderboxPrint: Swap in / out
0 / 0 15:33:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78368768; Read time: 0; Write time: 120044 15:33:25 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247009280; Read time: 16; Write time: 219472 15:33:25 INFO - Running post-run listener: _upload_blobber_files 15:33:25 INFO - Blob upload gear active. 15:33:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:33:25 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 15:33:25 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'] 15:33:25 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 15:33:26 INFO - (blobuploader) - INFO - Open directory for files ... 15:33:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:33:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:33:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:26 INFO - (blobuploader) - INFO - Done attempting. 15:33:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:33:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:30 INFO - (blobuploader) - INFO - Done attempting. 15:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:33:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:31 INFO - (blobuploader) - INFO - Done attempting. 15:33:31 INFO - (blobuploader) - INFO - Iteration through files over. 15:33:31 INFO - Return code: 0 15:33:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:33:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:33:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b36b8b774d4ac75a87bb7d9fbd6c629c5063c13234b7492c73a12c9afee4463e236a5a2cfaea363e5cab69e02019ef4882b7d5fcf443aca600868e46db734ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4aa14c67930507dcdd440c0a1c4cb73c49315480ee2538e003f2001bc65a8de0e961472d6a1b12b0830c5ae5cf74693b48387ceb6bb5605ef4575d3758620cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b2ab19085dcbfa13b68ded64abf0620259cf762da45681b009c6d3a875e5d7137bb426c74622389f4b87ef56160372de20cc3c191612c298f4d0e44812fc36e"} 15:33:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:33:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:33:31 INFO - Contents: 15:33:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7b36b8b774d4ac75a87bb7d9fbd6c629c5063c13234b7492c73a12c9afee4463e236a5a2cfaea363e5cab69e02019ef4882b7d5fcf443aca600868e46db734ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4aa14c67930507dcdd440c0a1c4cb73c49315480ee2538e003f2001bc65a8de0e961472d6a1b12b0830c5ae5cf74693b48387ceb6bb5605ef4575d3758620cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b2ab19085dcbfa13b68ded64abf0620259cf762da45681b009c6d3a875e5d7137bb426c74622389f4b87ef56160372de20cc3c191612c298f4d0e44812fc36e"} 15:33:31 INFO - Running post-run listener: copy_logs_to_upload_dir 15:33:31 INFO - Copying logs to upload dir... 15:33:31 INFO - mkdir: /builds/slave/test/build/upload/logs 15:33:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1678.608290 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-01 15:33:31.506278) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 15:33:31.510049) ========= 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=d2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307 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/7b36b8b774d4ac75a87bb7d9fbd6c629c5063c13234b7492c73a12c9afee4463e236a5a2cfaea363e5cab69e02019ef4882b7d5fcf443aca600868e46db734ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4aa14c67930507dcdd440c0a1c4cb73c49315480ee2538e003f2001bc65a8de0e961472d6a1b12b0830c5ae5cf74693b48387ceb6bb5605ef4575d3758620cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b2ab19085dcbfa13b68ded64abf0620259cf762da45681b009c6d3a875e5d7137bb426c74622389f4b87ef56160372de20cc3c191612c298f4d0e44812fc36e"} build_url:https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/Qb5tLwGpScarhrbysaQpSg/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/7b36b8b774d4ac75a87bb7d9fbd6c629c5063c13234b7492c73a12c9afee4463e236a5a2cfaea363e5cab69e02019ef4882b7d5fcf443aca600868e46db734ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4aa14c67930507dcdd440c0a1c4cb73c49315480ee2538e003f2001bc65a8de0e961472d6a1b12b0830c5ae5cf74693b48387ceb6bb5605ef4575d3758620cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6b2ab19085dcbfa13b68ded64abf0620259cf762da45681b009c6d3a875e5d7137bb426c74622389f4b87ef56160372de20cc3c191612c298f4d0e44812fc36e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 15:33:31.537561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 15:33:31.538256) ========= 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=d2a8c569965ab8367867b893000001a1-1472767531.291911-1202246307 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 15:33:31.621705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 15:33:31.622094) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 15:33:31.622488) ========= ========= Total master_lag: 0.17 =========