builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-014 starttime: 1462703133.06 results: success (0) buildid: 20160508004021 builduid: dd2b193e54ae45109739835a3bf624ad revision: 544bc272bfe13911e43f21b7fe52eb01f0435de4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.056013) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.056623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.056955) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.077273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.077577) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-08 03:25:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.4M=0s 2016-05-08 03:25:33 (39.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.066174 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.156964) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.157245) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020046 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.209869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.210179) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 544bc272bfe13911e43f21b7fe52eb01f0435de4 --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 544bc272bfe13911e43f21b7fe52eb01f0435de4 --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=31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-08 03:25:33,725 truncating revision to first 12 chars 2016-05-08 03:25:33,725 Setting DEBUG logging. 2016-05-08 03:25:33,725 attempt 1/10 2016-05-08 03:25:33,725 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/544bc272bfe1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-08 03:25:34,021 unpacking tar archive at: mozilla-aurora-544bc272bfe1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.588356 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.818044) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.818341) ========= script_repo_revision: 544bc272bfe13911e43f21b7fe52eb01f0435de4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.818748) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.819052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-08 03:25:33.844086) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-08 03:25:33.844481) ========= /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=31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:25:34 INFO - MultiFileLogger online at 20160508 03:25:34 in /builds/slave/test 03:25:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:25:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:25:34 INFO - {'append_to_log': False, 03:25:34 INFO - 'base_work_dir': '/builds/slave/test', 03:25:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:25:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:25:34 INFO - 'branch': 'Mozilla-Aurora', 03:25:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:25:34 INFO - 'config_files': ('talos/linux_config.py',), 03:25:34 INFO - 'default_actions': ('clobber', 03:25:34 INFO - 'read-buildbot-config', 03:25:34 INFO - 'download-and-extract', 03:25:34 INFO - 'populate-webroot', 03:25:34 INFO - 'create-virtualenv', 03:25:34 INFO - 'install', 03:25:34 INFO - 'run-tests'), 03:25:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:25:34 INFO - 'download_minidump_stackwalk': True, 03:25:34 INFO - 'download_symbols': 'ondemand', 03:25:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:25:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:25:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:25:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:25:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:25:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:25:34 INFO - 'installer_path': 'installer.exe', 03:25:34 INFO - 'log_level': 'info', 03:25:34 INFO - 'log_name': 'talos', 03:25:34 INFO - 'log_to_console': True, 03:25:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:25:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:25:34 INFO - 'opt_config_files': (), 03:25:34 INFO - 'pip_index': False, 03:25:34 INFO - 'sps_profile': False, 03:25:34 INFO - 'sps_profile_interval': 0, 03:25:34 INFO - 'suite': 'dromaeojs-e10s', 03:25:34 INFO - 'system_bits': '32', 03:25:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:25:34 INFO - 'title': 'talos-linux64-ix-014', 03:25:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:25:34 INFO - 'use_talos_json': True, 03:25:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:25:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:25:34 INFO - 'work_dir': 'build'} 03:25:34 INFO - ##### 03:25:34 INFO - ##### Running clobber step. 03:25:34 INFO - ##### 03:25:34 INFO - Running pre-action listener: _resource_record_pre_action 03:25:34 INFO - Running main action method: clobber 03:25:34 INFO - rmtree: /builds/slave/test/build 03:25:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:25:35 INFO - Running post-action listener: _resource_record_post_action 03:25:35 INFO - ##### 03:25:35 INFO - ##### Running read-buildbot-config step. 03:25:35 INFO - ##### 03:25:35 INFO - Running pre-action listener: _resource_record_pre_action 03:25:35 INFO - Running main action method: read_buildbot_config 03:25:35 INFO - Using buildbot properties: 03:25:35 INFO - { 03:25:35 INFO - "project": "", 03:25:35 INFO - "product": "firefox", 03:25:35 INFO - "script_repo_revision": "production", 03:25:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:25:35 INFO - "repository": "", 03:25:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:25:35 INFO - "buildid": "20160508004021", 03:25:35 INFO - "stage_platform": "linux64-pgo", 03:25:35 INFO - "basedir": "/builds/slave/test", 03:25:35 INFO - "nightly_build": "True", 03:25:35 INFO - "buildnumber": 298, 03:25:35 INFO - "slavename": "talos-linux64-ix-014", 03:25:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:25:35 INFO - "platform": "ubuntu64_hw", 03:25:35 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:25:35 INFO - "branch": "mozilla-aurora", 03:25:35 INFO - "repo_path": "releases/mozilla-aurora", 03:25:35 INFO - "revision": "544bc272bfe13911e43f21b7fe52eb01f0435de4", 03:25:35 INFO - "pgo_build": "True", 03:25:35 INFO - "builduid": "dd2b193e54ae45109739835a3bf624ad", 03:25:35 INFO - "slavebuilddir": "test" 03:25:35 INFO - } 03:25:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 03:25:35 INFO - Running post-action listener: _resource_record_post_action 03:25:35 INFO - ##### 03:25:35 INFO - ##### Running download-and-extract step. 03:25:35 INFO - ##### 03:25:35 INFO - Running pre-action listener: _resource_record_pre_action 03:25:35 INFO - Running main action method: download_and_extract 03:25:35 INFO - mkdir: /builds/slave/test/build/tests 03:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:35 INFO - https://queue.taskcluster.net/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:25:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:25:43 INFO - Downloaded 1361 bytes. 03:25:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 03:25:43 INFO - Using the following test package requirements: 03:25:43 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:43 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:25:43 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:25:43 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:43 INFO - u'jsshell-linux-x86_64.zip'], 03:25:43 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:25:43 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 03:25:43 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:25:43 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:25:43 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:25:43 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 03:25:43 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:25:43 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:43 INFO - https://queue.taskcluster.net/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:46 INFO - Downloaded 23799830 bytes. 03:25:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:47 INFO - Return code: 0 03:25:47 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:47 INFO - https://queue.taskcluster.net/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:25:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 03:25:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:25:48 INFO - Downloaded 23799830 bytes. 03:25:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:25:49 INFO - Return code: 0 03:25:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:49 INFO - https://queue.taskcluster.net/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:25:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 03:25:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:25:50 INFO - Downloaded 10840145 bytes. 03:25:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:25:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:25:51 INFO - Return code: 0 03:25: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')]} 03:25:51 INFO - https://queue.taskcluster.net/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:25:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:25:52 INFO - Downloaded 62720108 bytes. 03:25:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:52 INFO - mkdir: /builds/slave/test/properties 03:25:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:52 INFO - Contents: 03:25:52 INFO - build_url:https://queue.taskcluster.net/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 03:25:53 INFO - Running post-action listener: _resource_record_post_action 03:25:53 INFO - Running post-action listener: set_extra_try_arguments 03:25:53 INFO - ##### 03:25:53 INFO - ##### Running populate-webroot step. 03:25:53 INFO - ##### 03:25:53 INFO - Running pre-action listener: _resource_record_pre_action 03:25:53 INFO - Running main action method: populate_webroot 03:25:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:25:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:25:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:25:53 INFO - '--tppagecycles', 03:25:53 INFO - '7'], 03:25:53 INFO - 'tests': ['tsvgm']}}, 03:25:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:25:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:25:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:25:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:25:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'talos_options': ['--disable-e10s'], 03:25:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'talos_options': ['--disable-e10s'], 03:25:53 INFO - 'tests': ['damp', 'tps']}, 03:25:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'tests': ['damp', 'tps']}, 03:25:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:25:53 INFO - 'tests': ['dromaeo_dom']}, 03:25:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:25:53 INFO - 'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore', 03:25:53 INFO - 'tabpaint']}, 03:25:53 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore', 03:25:53 INFO - 'tabpaint']}, 03:25:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore', 03:25:53 INFO - 'tabpaint']}, 03:25:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore', 03:25:53 INFO - 'tabpaint']}, 03:25:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:25:53 INFO - 'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore', 03:25:53 INFO - 'tabpaint']}, 03:25:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:25:53 INFO - 'tests': ['a11yr', 03:25:53 INFO - 'ts_paint', 03:25:53 INFO - 'tpaint', 03:25:53 INFO - 'sessionrestore', 03:25:53 INFO - 'sessionrestore_no_auto_restore', 03:25:53 INFO - 'tabpaint']}, 03:25:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:25:53 INFO - 'tests': ['tsvgx', 03:25:53 INFO - 'tsvgr_opacity', 03:25:53 INFO - 'tart', 03:25:53 INFO - 'tscrollx', 03:25:53 INFO - 'cart']}, 03:25:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:53 INFO - 'tsvgr_opacity', 03:25:53 INFO - 'tart', 03:25:53 INFO - 'tscrollx', 03:25:53 INFO - 'cart']}, 03:25:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'talos_options': ['--disable-e10s'], 03:25:53 INFO - 'tests': ['tp5o']}, 03:25:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'tests': ['tp5o']}, 03:25:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'talos_options': ['--disable-e10s', 03:25:53 INFO - '--xperf_path', 03:25:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:53 INFO - 'tests': ['tp5n']}, 03:25:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:25:53 INFO - 'talos_options': ['--xperf_path', 03:25:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:53 INFO - 'tests': ['tp5n']}}, 03:25:53 INFO - 'talos.zip': {'path': '', 03:25:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:25:53 INFO - Running post-action listener: _resource_record_post_action 03:25:53 INFO - ##### 03:25:53 INFO - ##### Running create-virtualenv step. 03:25:53 INFO - ##### 03:25:53 INFO - Running pre-action listener: _resource_record_pre_action 03:25:53 INFO - Running main action method: create_virtualenv 03:25:53 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:25:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:25:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:53 INFO - Using real prefix '/usr' 03:25:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:56 INFO - Installing pip.................done. 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:56 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 0x7f945eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1adc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b410>, '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 0x1b6c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:25:56 INFO - Using env: {'DISPLAY': ':0', 03:25:56 INFO - 'HOME': '/home/cltbld', 03:25:56 INFO - 'LANG': 'en_US.UTF-8', 03:25:56 INFO - 'LANGUAGE': 'en_US:en', 03:25:56 INFO - 'LOGNAME': 'cltbld', 03:25:56 INFO - 'MAIL': '/var/mail/cltbld', 03:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:56 INFO - 'MOZ_NO_REMOTE': '1', 03:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:56 INFO - 'NO_EM_RESTART': '1', 03:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:56 INFO - 'PWD': '/builds/slave/test', 03:25:56 INFO - 'SHELL': '/bin/bash', 03:25:56 INFO - 'SHLVL': '1', 03:25:56 INFO - 'TERM': 'linux', 03:25:56 INFO - 'TMOUT': '86400', 03:25:56 INFO - 'USER': 'cltbld', 03:25:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 03:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:56 INFO - '_': '/tools/buildbot/bin/python'} 03:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:25:56 INFO - Cleaning up... 03:25:56 INFO - Return code: 0 03:25:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:56 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1adc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b410>, '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 0x1b6c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:56 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>=0.7.1'] in /builds/slave/test/build 03:25:56 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>=0.7.1 03:25:56 INFO - Using env: {'DISPLAY': ':0', 03:25:56 INFO - 'HOME': '/home/cltbld', 03:25:56 INFO - 'LANG': 'en_US.UTF-8', 03:25:56 INFO - 'LANGUAGE': 'en_US:en', 03:25:56 INFO - 'LOGNAME': 'cltbld', 03:25:56 INFO - 'MAIL': '/var/mail/cltbld', 03:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:56 INFO - 'MOZ_NO_REMOTE': '1', 03:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:56 INFO - 'NO_EM_RESTART': '1', 03:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:56 INFO - 'PWD': '/builds/slave/test', 03:25:56 INFO - 'SHELL': '/bin/bash', 03:25:56 INFO - 'SHLVL': '1', 03:25:56 INFO - 'TERM': 'linux', 03:25:56 INFO - 'TMOUT': '86400', 03:25:56 INFO - 'USER': 'cltbld', 03:25:56 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 03:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:56 INFO - '_': '/tools/buildbot/bin/python'} 03:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:56 INFO - Downloading/unpacking psutil>=0.7.1 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:58 INFO - Installing collected packages: psutil 03:25:58 INFO - Running setup.py install for psutil 03:25:58 INFO - building 'psutil._psutil_linux' extension 03:25:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:25:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:25:58 INFO - building 'psutil._psutil_posix' extension 03:25:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:25:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:25:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:59 INFO - Successfully installed psutil 03:25:59 INFO - Cleaning up... 03:25:59 INFO - Return code: 0 03:25:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:25:59 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1adc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b410>, '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 0x1b6c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:25:59 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.0.0'] in /builds/slave/test/build 03:25:59 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.0.0 03:25:59 INFO - Using env: {'DISPLAY': ':0', 03:25:59 INFO - 'HOME': '/home/cltbld', 03:25:59 INFO - 'LANG': 'en_US.UTF-8', 03:25:59 INFO - 'LANGUAGE': 'en_US:en', 03:25:59 INFO - 'LOGNAME': 'cltbld', 03:25:59 INFO - 'MAIL': '/var/mail/cltbld', 03:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:59 INFO - 'MOZ_NO_REMOTE': '1', 03:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:59 INFO - 'NO_EM_RESTART': '1', 03:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:59 INFO - 'PWD': '/builds/slave/test', 03:25:59 INFO - 'SHELL': '/bin/bash', 03:25:59 INFO - 'SHLVL': '1', 03:25:59 INFO - 'TERM': 'linux', 03:25:59 INFO - 'TMOUT': '86400', 03:25:59 INFO - 'USER': 'cltbld', 03:25:59 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 03:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:59 INFO - '_': '/tools/buildbot/bin/python'} 03:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:26:01 INFO - Installing collected packages: mozsystemmonitor 03:26:01 INFO - Running setup.py install for mozsystemmonitor 03:26:01 INFO - Successfully installed mozsystemmonitor 03:26:01 INFO - Cleaning up... 03:26:01 INFO - Return code: 0 03:26:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:01 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 0x7f945eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1adc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b410>, '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 0x1b6c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:26:01 INFO - Using env: {'DISPLAY': ':0', 03:26:01 INFO - 'HOME': '/home/cltbld', 03:26:01 INFO - 'LANG': 'en_US.UTF-8', 03:26:01 INFO - 'LANGUAGE': 'en_US:en', 03:26:01 INFO - 'LOGNAME': 'cltbld', 03:26:01 INFO - 'MAIL': '/var/mail/cltbld', 03:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:01 INFO - 'MOZ_NO_REMOTE': '1', 03:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:01 INFO - 'NO_EM_RESTART': '1', 03:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:01 INFO - 'PWD': '/builds/slave/test', 03:26:01 INFO - 'SHELL': '/bin/bash', 03:26:01 INFO - 'SHLVL': '1', 03:26:01 INFO - 'TERM': 'linux', 03:26:01 INFO - 'TMOUT': '86400', 03:26:01 INFO - 'USER': 'cltbld', 03:26:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 03:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:01 INFO - '_': '/tools/buildbot/bin/python'} 03:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:03 INFO - Downloading blobuploader-1.2.4.tar.gz 03:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:26:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:26:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:04 INFO - Downloading docopt-0.6.1.tar.gz 03:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:26:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:26:04 INFO - Running setup.py install for blobuploader 03:26:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:26:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:26:04 INFO - Running setup.py install for requests 03:26:04 INFO - Running setup.py install for docopt 03:26:05 INFO - Successfully installed blobuploader requests docopt 03:26:05 INFO - Cleaning up... 03:26:05 INFO - Return code: 0 03:26:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:05 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 0x7f945eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1adc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b410>, '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 0x1b6c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:05 INFO - Using env: {'DISPLAY': ':0', 03:26:05 INFO - 'HOME': '/home/cltbld', 03:26:05 INFO - 'LANG': 'en_US.UTF-8', 03:26:05 INFO - 'LANGUAGE': 'en_US:en', 03:26:05 INFO - 'LOGNAME': 'cltbld', 03:26:05 INFO - 'MAIL': '/var/mail/cltbld', 03:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:05 INFO - 'MOZ_NO_REMOTE': '1', 03:26:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:05 INFO - 'NO_EM_RESTART': '1', 03:26:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:05 INFO - 'PWD': '/builds/slave/test', 03:26:05 INFO - 'SHELL': '/bin/bash', 03:26:05 INFO - 'SHLVL': '1', 03:26:05 INFO - 'TERM': 'linux', 03:26:05 INFO - 'TMOUT': '86400', 03:26:05 INFO - 'USER': 'cltbld', 03:26:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 03:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:05 INFO - '_': '/tools/buildbot/bin/python'} 03:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:05 INFO - Running setup.py (path:/tmp/pip-BPkOeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:05 INFO - Running setup.py (path:/tmp/pip-LMKViQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:05 INFO - Running setup.py (path:/tmp/pip-PRz3Q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:05 INFO - Running setup.py (path:/tmp/pip-h6dW7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:05 INFO - Running setup.py (path:/tmp/pip-4FQWpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:05 INFO - Running setup.py (path:/tmp/pip-sk_BjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:05 INFO - Running setup.py (path:/tmp/pip-6yF3bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:05 INFO - Running setup.py (path:/tmp/pip-LeAIZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:05 INFO - Running setup.py (path:/tmp/pip-ViPuZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:06 INFO - Running setup.py (path:/tmp/pip-ogfH8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:06 INFO - Running setup.py (path:/tmp/pip-AHkGjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:06 INFO - Running setup.py (path:/tmp/pip-HqHvoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:06 INFO - Running setup.py (path:/tmp/pip-U4Rfff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:06 INFO - Running setup.py (path:/tmp/pip-nXYsKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:06 INFO - Running setup.py (path:/tmp/pip-AchDB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:06 INFO - Running setup.py (path:/tmp/pip-U5OXof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:06 INFO - Running setup.py (path:/tmp/pip-Ie_xPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:26:06 INFO - Running setup.py install for manifestparser 03:26:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:26:06 INFO - Running setup.py install for mozcrash 03:26:06 INFO - Running setup.py install for mozdebug 03:26:06 INFO - Running setup.py install for mozdevice 03:26:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:26:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:26:06 INFO - Running setup.py install for mozfile 03:26:07 INFO - Running setup.py install for mozhttpd 03:26:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for mozinfo 03:26:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for mozInstall 03:26:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for mozleak 03:26:07 INFO - Running setup.py install for mozlog 03:26:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for moznetwork 03:26:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for mozprocess 03:26:07 INFO - Running setup.py install for mozprofile 03:26:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:26:07 INFO - Running setup.py install for mozrunner 03:26:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:26:08 INFO - Running setup.py install for mozscreenshot 03:26:08 INFO - Running setup.py install for moztest 03:26:08 INFO - Running setup.py install for mozversion 03:26:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:26:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:26:08 INFO - Cleaning up... 03:26:08 INFO - Return code: 0 03:26:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:08 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 0x7f945eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1adc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b410>, '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 0x1b6c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:08 INFO - Using env: {'DISPLAY': ':0', 03:26:08 INFO - 'HOME': '/home/cltbld', 03:26:08 INFO - 'LANG': 'en_US.UTF-8', 03:26:08 INFO - 'LANGUAGE': 'en_US:en', 03:26:08 INFO - 'LOGNAME': 'cltbld', 03:26:08 INFO - 'MAIL': '/var/mail/cltbld', 03:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:08 INFO - 'MOZ_NO_REMOTE': '1', 03:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:08 INFO - 'NO_EM_RESTART': '1', 03:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:08 INFO - 'PWD': '/builds/slave/test', 03:26:08 INFO - 'SHELL': '/bin/bash', 03:26:08 INFO - 'SHLVL': '1', 03:26:08 INFO - 'TERM': 'linux', 03:26:08 INFO - 'TMOUT': '86400', 03:26:08 INFO - 'USER': 'cltbld', 03:26:08 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 03:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:08 INFO - '_': '/tools/buildbot/bin/python'} 03:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:26:08 INFO - Running setup.py (path:/tmp/pip-zyf__R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:26:08 INFO - Running setup.py (path:/tmp/pip-x43pCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:26:08 INFO - Running setup.py (path:/tmp/pip-_Fx67Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:26:08 INFO - Running setup.py (path:/tmp/pip-xZ7kJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:26:08 INFO - Running setup.py (path:/tmp/pip-a4FPIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:26:08 INFO - Running setup.py (path:/tmp/pip-bsIP6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:26:09 INFO - Running setup.py (path:/tmp/pip-LSIAuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:26:09 INFO - Running setup.py (path:/tmp/pip-YkCvu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:26:09 INFO - Running setup.py (path:/tmp/pip-04_mW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:26:09 INFO - Running setup.py (path:/tmp/pip-cXONKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:26:09 INFO - Running setup.py (path:/tmp/pip-NRYoto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:26:09 INFO - Running setup.py (path:/tmp/pip-jF9NjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:26:09 INFO - Running setup.py (path:/tmp/pip-1s5zX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:26:09 INFO - Running setup.py (path:/tmp/pip-ghIujU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:09 INFO - Running setup.py (path:/tmp/pip-sdrMXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:26:09 INFO - Running setup.py (path:/tmp/pip-t54x3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:26:09 INFO - Running setup.py (path:/tmp/pip-B86S8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:26:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:11 INFO - Downloading blessings-1.6.tar.gz 03:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:26:11 INFO - Installing collected packages: blessings 03:26:11 INFO - Running setup.py install for blessings 03:26:11 INFO - Successfully installed blessings 03:26:11 INFO - Cleaning up... 03:26:11 INFO - Return code: 0 03:26:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:26:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:12 INFO - Reading from file tmpfile_stdout 03:26:12 INFO - Current package versions: 03:26:12 INFO - argparse == 1.2.1 03:26:12 INFO - blessings == 1.6 03:26:12 INFO - blobuploader == 1.2.4 03:26:12 INFO - docopt == 0.6.1 03:26:12 INFO - manifestparser == 1.1 03:26:12 INFO - mozInstall == 1.12 03:26:12 INFO - mozcrash == 0.17 03:26:12 INFO - mozdebug == 0.1 03:26:12 INFO - mozdevice == 0.48 03:26:12 INFO - mozfile == 1.2 03:26:12 INFO - mozhttpd == 0.7 03:26:12 INFO - mozinfo == 0.9 03:26:12 INFO - mozleak == 0.1 03:26:12 INFO - mozlog == 3.1 03:26:12 INFO - moznetwork == 0.27 03:26:12 INFO - mozprocess == 0.22 03:26:12 INFO - mozprofile == 0.28 03:26:12 INFO - mozrunner == 6.11 03:26:12 INFO - mozscreenshot == 0.1 03:26:12 INFO - mozsystemmonitor == 0.0 03:26:12 INFO - moztest == 0.7 03:26:12 INFO - mozversion == 1.4 03:26:12 INFO - psutil == 3.1.1 03:26:12 INFO - requests == 1.2.3 03:26:12 INFO - wsgiref == 0.1.2 03:26:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 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 0x7f945eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1adc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b410>, '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 0x1b6c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:26:12 INFO - Using env: {'DISPLAY': ':0', 03:26:12 INFO - 'HOME': '/home/cltbld', 03:26:12 INFO - 'LANG': 'en_US.UTF-8', 03:26:12 INFO - 'LANGUAGE': 'en_US:en', 03:26:12 INFO - 'LOGNAME': 'cltbld', 03:26:12 INFO - 'MAIL': '/var/mail/cltbld', 03:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:12 INFO - 'MOZ_NO_REMOTE': '1', 03:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:12 INFO - 'NO_EM_RESTART': '1', 03:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:12 INFO - 'PWD': '/builds/slave/test', 03:26:12 INFO - 'SHELL': '/bin/bash', 03:26:12 INFO - 'SHLVL': '1', 03:26:12 INFO - 'TERM': 'linux', 03:26:12 INFO - 'TMOUT': '86400', 03:26:12 INFO - 'USER': 'cltbld', 03:26:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 03:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:12 INFO - '_': '/tools/buildbot/bin/python'} 03:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:26:12 INFO - Cleaning up... 03:26:12 INFO - Return code: 0 03:26:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:12 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 0x7f945eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1adc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b410>, '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 0x1b6c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:26:12 INFO - Using env: {'DISPLAY': ':0', 03:26:12 INFO - 'HOME': '/home/cltbld', 03:26:12 INFO - 'LANG': 'en_US.UTF-8', 03:26:12 INFO - 'LANGUAGE': 'en_US:en', 03:26:12 INFO - 'LOGNAME': 'cltbld', 03:26:12 INFO - 'MAIL': '/var/mail/cltbld', 03:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:12 INFO - 'MOZ_NO_REMOTE': '1', 03:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:12 INFO - 'NO_EM_RESTART': '1', 03:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:12 INFO - 'PWD': '/builds/slave/test', 03:26:12 INFO - 'SHELL': '/bin/bash', 03:26:12 INFO - 'SHLVL': '1', 03:26:12 INFO - 'TERM': 'linux', 03:26:12 INFO - 'TMOUT': '86400', 03:26:12 INFO - 'USER': 'cltbld', 03:26:12 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 03:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:12 INFO - '_': '/tools/buildbot/bin/python'} 03:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:12 INFO - Downloading/unpacking jsonschema 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:26:14 INFO - Downloading/unpacking functools32 (from jsonschema) 03:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:14 INFO - Downloading functools32-3.2.3-2.tar.gz 03:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:26:14 INFO - warning: no files found matching '*.txt' 03:26:14 INFO - no previously-included directories found matching 'build' 03:26:14 INFO - no previously-included directories found matching 'dist' 03:26:14 INFO - no previously-included directories found matching '.git*' 03:26:14 INFO - Installing collected packages: jsonschema, functools32 03:26:14 INFO - Running setup.py install for functools32 03:26:14 INFO - warning: no files found matching '*.txt' 03:26:14 INFO - no previously-included directories found matching 'build' 03:26:14 INFO - no previously-included directories found matching 'dist' 03:26:14 INFO - no previously-included directories found matching '.git*' 03:26:14 INFO - Successfully installed jsonschema functools32 03:26:14 INFO - Cleaning up... 03:26:14 INFO - Return code: 0 03:26:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:26:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f945eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1adc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b410>, '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 0x1b6c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c7a0>, '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': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:26:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:26:14 INFO - Using env: {'DISPLAY': ':0', 03:26:14 INFO - 'HOME': '/home/cltbld', 03:26:14 INFO - 'LANG': 'en_US.UTF-8', 03:26:14 INFO - 'LANGUAGE': 'en_US:en', 03:26:14 INFO - 'LOGNAME': 'cltbld', 03:26:14 INFO - 'MAIL': '/var/mail/cltbld', 03:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:14 INFO - 'MOZ_NO_REMOTE': '1', 03:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:14 INFO - 'NO_EM_RESTART': '1', 03:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:14 INFO - 'PWD': '/builds/slave/test', 03:26:14 INFO - 'SHELL': '/bin/bash', 03:26:14 INFO - 'SHLVL': '1', 03:26:14 INFO - 'TERM': 'linux', 03:26:14 INFO - 'TMOUT': '86400', 03:26:14 INFO - 'USER': 'cltbld', 03:26:14 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 03:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:14 INFO - '_': '/tools/buildbot/bin/python'} 03:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:26:15 INFO - Downloading/unpacking flake8 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26: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 03:26:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:26:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:26:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:17 INFO - no previously-included directories found matching 'docs/_build' 03:26:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:26:17 INFO - Running setup.py install for pep8 03:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:26:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:26:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:26:17 INFO - no previously-included directories found matching 'docs/_build' 03:26:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:26:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:26:17 INFO - Cleaning up... 03:26:17 INFO - Return code: 0 03:26:17 INFO - Running post-action listener: _resource_record_post_action 03:26:17 INFO - Running post-action listener: _start_resource_monitoring 03:26:17 INFO - Starting resource monitoring. 03:26:17 INFO - ##### 03:26:17 INFO - ##### Running install step. 03:26:17 INFO - ##### 03:26:17 INFO - Running pre-action listener: _resource_record_pre_action 03:26:17 INFO - Running main action method: install 03:26:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:26:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:26:18 INFO - Reading from file tmpfile_stdout 03:26:18 INFO - Detecting whether we're running mozinstall >=1.0... 03:26:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:26:18 INFO - Reading from file tmpfile_stdout 03:26:18 INFO - Output received: 03:26:18 INFO - Usage: mozinstall [options] installer 03:26:18 INFO - Options: 03:26:18 INFO - -h, --help show this help message and exit 03:26:18 INFO - -d DEST, --destination=DEST 03:26:18 INFO - Directory to install application into. [default: 03:26:18 INFO - "/builds/slave/test"] 03:26:18 INFO - --app=APP Application being installed. [default: firefox] 03:26:18 INFO - mkdir: /builds/slave/test/build/application 03:26:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:26:33 INFO - Reading from file tmpfile_stdout 03:26:33 INFO - Output received: 03:26:33 INFO - /builds/slave/test/build/application/firefox/firefox 03:26:33 INFO - Running post-action listener: _resource_record_post_action 03:26:33 INFO - ##### 03:26:33 INFO - ##### Running run-tests step. 03:26:33 INFO - ##### 03:26:33 INFO - Running pre-action listener: _resource_record_pre_action 03:26:33 INFO - Running main action method: run_tests 03:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:26:33 INFO - Python 2.7.3 03:26:33 INFO - Return code: 0 03:26:33 INFO - grabbing minidump binary from tooltool 03:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:26:33 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b6b410>, '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 0x1b6c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b6c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:26:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:26:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:26:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:26:33 INFO - Return code: 0 03:26:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:26:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:26:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:26:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:26:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:26:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:26:34 INFO - Return code: 0 03:26:34 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/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:26:34 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/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:26:34 INFO - Using env: {'DISPLAY': ':0', 03:26:34 INFO - 'HOME': '/home/cltbld', 03:26:34 INFO - 'LANG': 'en_US.UTF-8', 03:26:34 INFO - 'LANGUAGE': 'en_US:en', 03:26:34 INFO - 'LOGNAME': 'cltbld', 03:26:34 INFO - 'MAIL': '/var/mail/cltbld', 03:26:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:26:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:26:34 INFO - 'MOZ_NO_REMOTE': '1', 03:26:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:26:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:26:34 INFO - 'NO_EM_RESTART': '1', 03:26:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:26:34 INFO - 'PWD': '/builds/slave/test', 03:26:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:26:34 INFO - 'SHELL': '/bin/bash', 03:26:34 INFO - 'SHLVL': '1', 03:26:34 INFO - 'TERM': 'linux', 03:26:34 INFO - 'TMOUT': '86400', 03:26:34 INFO - 'USER': 'cltbld', 03:26:34 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154', 03:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:26:34 INFO - '_': '/tools/buildbot/bin/python'} 03:26:34 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/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:26:35 INFO - mozversion application_buildid: 20160508004021 03:26:35 INFO - mozversion application_changeset: 544bc272bfe13911e43f21b7fe52eb01f0435de4 03:26:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:26:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:26:35 INFO - mozversion application_name: Firefox 03:26:35 INFO - mozversion application_remotingname: firefox-dev 03:26:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:35 INFO - mozversion application_vendor: Mozilla 03:26:35 INFO - mozversion application_version: 48.0a2 03:26:35 INFO - mozversion platform_buildid: 20160508004021 03:26:35 INFO - mozversion platform_changeset: 544bc272bfe13911e43f21b7fe52eb01f0435de4 03:26:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:26:35 INFO - mozversion platform_version: 48.0a2 03:26:35 INFO - using testdate: 1462703195 03:26:35 INFO - actual date: 1462703195 03:26:35 INFO - starting webserver on 'localhost:47340' 03:26:35 INFO - SUITE-START | Running 2 tests 03:26:35 INFO - TEST-START | dromaeo_css 03:26:35 INFO - operating with platform_type : linux_ 03:26:35 INFO - Initialising browser for dromaeo_css test... 03:26:35 INFO - TEST-INFO | started process 8483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptLrjoS/profile http://localhost:47340/getInfo.html) 03:26:38 INFO - PROCESS | 8483 | 03:26:38 INFO - PROCESS | 8483 | (process:8566): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:26:39 INFO - PROCESS | 8483 | __metrics Screen width/height:1600/1200 03:26:39 INFO - PROCESS | 8483 | colorDepth:24 03:26:39 INFO - PROCESS | 8483 | Browser inner width/height: 1024/697 03:26:39 INFO - PROCESS | 8483 | __metrics 03:26:39 ERROR - PROCESS | 8483 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:26:40 INFO - TEST-INFO | 8483: exit 0 03:26:40 INFO - Browser initialized. 03:26:40 INFO - Running cycle 1/1 for dromaeo_css test... 03:26:40 INFO - TEST-INFO | started process 8617 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptLrjoS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:42 INFO - PROCESS | 8617 | 03:26:42 INFO - PROCESS | 8617 | (process:8685): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:26:52 INFO - PROCESS | 8617 | RSS: Main: 152449024 03:26:52 INFO - PROCESS | 8617 | 03:27:42 INFO - PROCESS | 8617 | 1462703262209 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:29:49 INFO - PROCESS | 8617 | Cycle 1(1): loaded http://localhost:47340/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47340/tests/dromaeo/cssquery-ext.html) 03:29:50 INFO - PROCESS | 8617 | RSS: Main: 155021312 03:29:50 INFO - PROCESS | 8617 | 03:32:52 INFO - PROCESS | 8617 | Cycle 1(1): loaded http://localhost:47340/tests/dromaeo/cssquery-ext.html (next: http://localhost:47340/tests/dromaeo/cssquery-jquery.html) 03:32:53 INFO - PROCESS | 8617 | RSS: Main: 153210880 03:32:53 INFO - PROCESS | 8617 | 03:35:55 INFO - PROCESS | 8617 | Cycle 1(1): loaded http://localhost:47340/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47340/tests/dromaeo/cssquery-mootools.html) 03:35:55 INFO - PROCESS | 8617 | RSS: Main: 152969216 03:35:55 INFO - PROCESS | 8617 | 03:38:57 INFO - PROCESS | 8617 | Cycle 1(1): loaded http://localhost:47340/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47340/tests/dromaeo/cssquery-prototype.html) 03:38:58 INFO - PROCESS | 8617 | RSS: Main: 152854528 03:38:58 INFO - PROCESS | 8617 | 03:42:00 INFO - PROCESS | 8617 | Cycle 1(1): loaded http://localhost:47340/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47340/tests/dromaeo/cssquery-yui.html) 03:42:01 INFO - PROCESS | 8617 | RSS: Main: 153976832 03:42:01 INFO - PROCESS | 8617 | 03:45:03 INFO - PROCESS | 8617 | Cycle 1(1): loaded http://localhost:47340/tests/dromaeo/cssquery-yui.html (next: http://localhost:47340/tests/dromaeo/cssquery-dojo.html) 03:45:03 INFO - PROCESS | 8617 | RSS: Main: 155172864 03:45:03 INFO - PROCESS | 8617 | 03:45:03 INFO - PROCESS | 8617 | __start_tp_report 03:45:03 INFO - PROCESS | 8617 | _x_x_mozilla_page_load 03:45:03 INFO - PROCESS | 8617 | _x_x_mozilla_page_load_details 03:45:03 INFO - PROCESS | 8617 | |i|pagename|runs| 03:45:03 INFO - PROCESS | 8617 | |0;dojo.html;3319.834008299585;3329.3674201901636;3385.678360555746;3395.6434574369705;3414.0270023043436;5551.9722401387935;5564.582656300779;5580.051391263485;5624.859378515539;5627.465390787874;5542.75057622407;5603.579731520143;5623.240862483563;5638.323401191863;5691.8292451226425;5025.170846810281;5058.064258112243;5099.133147364957;5132;5162.406323272834;5000.824971126011;5171.224316352558;5237.973810130944;5249.1601343785005;5250.081235783741;5083.745812709368;5129.897402051975;5132.230165475171;5201.375834899817;5233.3981592116825;5110.897782044357;5116.59067274619;5124.692518448905;5127.589792816566;5153.098207813618;4967.50324967504;5054.989002199538;5098.158803797369;5102.183650615883;5113.974430127825;5370.838874833761;5397.4062853086125;5491.972540137273;5501.587380946445;5515.310586176728;5925.792597259118;5963.642181469126;5970.0746384310505;5978.192943952554;5983.730732117022;5892.882142357129;5997.310309314441;6018.608790428652;6021.42796434338;6024.638521688713;5489.011977843987;5489.752961116759;5491.643043202179;5500.779968801243;5508;6055.061465472859;6077.604955677867;6111.404041107485;6122.051082082285;6127.387261273837;5879.882402351929;5911.408859114054;5913.822585322448;5928.673922934194;5930.229070220844;5957.880842383128;5966.791162309299;5976.760929562855;5977.551683623746;6017.638941663514;5887.852803679856;5934.37689042653;5943.167956486095;5948.821535353946;5951.970240148771;5909.468147866713;5920.259967504062;5934.287885453773;5954.940450595525;5957.434043765922;4445.622122119591;4484.865454036384;4519.728816271035;4541.727496350163;4562.315652652129;4052.675785937177;4053;4057.2899742544937;4060.964454064195;4091.202215567995;5682.54539636828;5715.314162300468;5729.140628905614;5730.226419433407;5755.539556835443;5962.85092872673;6047.758089676452;6060.181875446759;6124.869201255686;6126.303932855801;5797.2173756542325;5797.420257974169;5806.30324361071;5807.68057756819;5822.3304320003745;5183.196604526304;5192.61055420845;5221.190715439037;5232.424433312332;5259.921101183485;5976.581639285295;6116.67056464255;6247.937520624736;6251.687415629201;6252.624842509464;5866.823995279978;5916.083007133901;5939.049752039653;5944.078667806497;6000.7899723510345;6011.789587364421;6115.816525504242;6120.7551697931585;6123.632582045091;6134.26388833325;5781.624194427349;5857.50211232033;5884.6469211847425;5924.081767326072;5953.76184952597;5990.041593345044;6004.489618382487;6046.818595442144;6055.273367195965;6071.726772295169;5630.662160270397;5884.08796636522;5893.793717219876;5893.941060589339;5894.410558944242;5865.970670146793;5877.529797616095;5881.794137205177;5881.882442335943;5917.526597872074;5755.482006619424;5757.453041961007;5771.59598828078;5788.53691704671;5791.565632577658;5794.884102318014;5808.94191058084;5877.94122058774;5923.08192230205;5923.970380148072;5689.374168841507;5699.857503562278;5739.253896993531;5756.050251708589;5784.045632470596 03:45:03 INFO - PROCESS | 8617 | |1;ext.html;588.4733163818382;653.3662347522902;657.3492242679746;665.5241502325836;697.543109263432;38512.42231366528;39543.80228098855;39731.801340993254;39961.400578991335;39964.40053399201;40413.59586404135;41096.58903410965;41385.793071034605;41481.58518414815;41571.58428415715;8676.436031657939;8798.252148567379;8816.559172041372;8839.867401988975;8859.20267175954;8706.129387061306;8919.24186444153;8951.731448056536;8959.641614335418;9003.5048072356;8918.197362237397;9028.277737780994;9040.8643870342;9045.819083618324;9054.547272636375;8902.06528314524;8990.685326013623;9036.412633178856;9036.8644470333;9077.727668169966;8754.518501482416;9021.954890225572;9023.187913087853;9031.548422578844;9056.683016094405;36943.630563694554;41374.1725165498;41896.37155442671;41945;42001.36997945033;3585.2650206707563;3643.125649844045;3801.353769859131;4209.179210054041;4466.3523789050405;28181.436371272666;28222.717772822216;28225.85887070572;28860.567091493645;29180.124596262147;4100.7334523255895;4115.58844115589;4121.093359460914;4176.164767046603;4304.139172165579;199077.99999999854;200398;200451;200546;203138;36752.26495470129;37022.8148859254;37261;40097.79951100226;40872.38691419631;38072.23855522874;38303;38465.615343846206;38482.61517384846;38530.22939541194;16698.081605511572;16849.073300968565;16925.7461138083;16944.15279236033;16953.745693814602;14834.925825370805;14884.851151488563;14885.479008234659;14885.702285954438;14896.329665165094;9378.906210937803;9535.2371810255;9560.378575392577;9604.327697061279;9618.230541556659;3612.855485780592;3636.2727454509204;3694.5935947045805;3705.6664900159117;3707.351213537674;1107.8338249262513;1112.265904503024;1188.7919614067503;1204.8674645788956;1208.474313673555;32728.836355818068;33988;35652.7521536745;36727.081822954104;37363.43954840679;1207.9094067944939;1245.2964075297427;1267.3283159925254;1280.3470230182675;1290.5999140266547;15711.98996979977;16077.517674469784;16164.191790410432;16202.75695864563;16359.59101022484;453566;555051;564277;566291;569619;61137.38862611406;62882;62928;62990.68504657447;63421;1561.8281988981203;1568.5216009117328;1570.8586227239603;1573.5436723350329;1670.523900688298;32880.34239315153;33007.83496082504;33467;33947.15132121717;34525.482117768755;52587.73706131598;53203;53574;53923;54019;396858;398346;399271;400143;400269;30347.696523034487;30453.086407407813;31093.378132437676;31123;31240.843795780875;48252.27621585609;48933.2660010093;49148.50851491439;49574;50275.49724502708;41360.1727965445;41555.168896622505;41702.79148604238;42638.78680606577;42671.573284268;40171.598284016785;40236.19527609373;40464.59535404608;41728;41979.37030944477;42156;42566.361504578075;44377.77811110924;44870.3269450952;45142.548574513836;32341.838290808395;33027.00918972435;33312.50031249485;33738.662613373555;33857.49213761845;28871.42257154803;29926.251843703212;30308.393832123675;31222.21944451316;31314 03:45:03 INFO - PROCESS | 8617 | |2;jquery.html;436.5596316590261;447.62089494337596;449.4875841540642;451.1383257977264;452.14770158251685;19913.60172796545;19920.90039549802;20595.176192952284;20811.375658730223;20888.895555522202;19532.90233548834;19837.10733017014;20032.1987120515;20050.69923951138;20348.287809926656;5557.833265002037;5966.552508561854;5993.820185394445;6012.8496787580225;6016.42843929826;5869.090291004901;5934.406559344075;5952.821415357546;5981.1028345748055;6002.309734380558;5715.3141623005085;5937.6140550864275;5951.464368206861;5952;5953.761849526014;5827.038538641119;5861.472467477947;5906.852328691795;5924.911126333109;5925.022371308729;5210.843674689765;5506.256655351516;5519.2824932758485;5522.806701765419;5533.059379905426;13998.650033749136;15807.60480987973;23640.408989775395;24032.279031629078;24162.15432459873;2386.355683965337;2549.859757713325;2611.8171727979047;2850.700676428966;3030.848457577112;10012.59949602015;10450.320729152581;10455.372677639367;10495.895041049567;10717.249792514527;1936.9515762105918;2017.838572914178;2026.6656001759693;2070.823979961705;2117.6929345244853;75791;77170.61414692947;81232.18767812305;82170.58914705388;83133.58433207795;11221.270617409842;11513.366764827848;11621.76756464866;11638.6508404748;11697.941510292394;16188.352465901233;16238.594035148979;16325.755113673304;16329.510114696579;16343.18284085791;8843.0714774949;8942.73171804847;8981.910180898107;8996.280297576179;9063.36556441056;8892;9084.772880678036;9104.13510716481;9112.908870911206;9229.307801914883;5042.268871013683;5044.571211447068;5128.461511541234;5141.691498510101;5260.526552610207;2019.7172395864297;2051.087266166571;2112.176251262009;2197.1760589778833;2203.361025302644;1052.6000119954522;1080.5839751695653;1140.9149183569957;1150.9712257193637;1175.3770501634147;18420.26318947254;19434.12546435414;19822;19871.701924470854;20161.39515814528;1056.0495554001461;1096.2435919215716;1107.4960892793758;1110.123002827757;1131.479519421059;10935.56257749681;11369.886301137049;11434.771304573862;11498.827517587242;11662.591809286803;504866;505396;506604;517996;527014;56491.43508564944;72946;84380.57809711035;86343;95207;980.367662857453;991.2912267728609;993.8956409577034;1002.8245057114975;1041.8541404203418;17588.38440654571;18140.72788908141;18140.72788908194;18210.544736381697;18506.259749609864;37101.814490927376;39237;39622.444774355456;40786.38820417756;41355.586444136374;50384.748076259384;50836.23745643744;51458.22812657888;51578.74210628923;51943;8762.518061506678;8787.91212087871;8906.287497000354;8924.375293729376;8987.19115279628;12779.488820447077;13591.252481113239;13682.384292706653;13788.379522921292;14050.437982480586;12383.876161238271;12585.93707031459;12609.747805043664;12632;12661.620151395473;12240.938795305967;12412.379381031093;12550.623481295575;12683.902157586266;12783.424745886272;11723.472443739882;12588.622341329774;12822.358882055672;13156.210627362389;13213.735725285249;8855.690050848189;8878.089669004978;8923.553822308988;9004.189622933967;9032.774180645536;11439;12200.75598488043;12217.877821221675;12398.318092504638;12573.308468034345 03:45:03 INFO - PROCESS | 8617 | |3;mootools.html;1555.2068445093003;1563.4684207369496;1726.2318268370573;1847.8521718262548;1879.8966056866866;7437.070366204224;8161.143079976606;8173.632186551605;8424.536650484228;8510.531920744364;8268.37987150963;8303.169683031709;8355.080941096474;8463.746087617366;8481.57592120393;2343.9882800586015;2377.7741114594087;2379.524095180962;2389.7849193572574;2392.796612287949;2434.4400787818813;2444.10790061628;2474.084588702183;2485.6271559266165;2485.801135909123;2405.1702162753822;2433.6592876997233;2440.5606990741658;2442.3039433761382;2466.1615050882697;2342.7305859826083;2364.042562762084;2366.290112966103;2376.061455724979;2395.101836811196;2365.8343915925893;2371.65610986406;2385.9045638174625;2389.2712722619594;2419.6128619420983;8613.870791938127;8647.092055334162;8669.523176225304;8702.434341767765;8721.258693011037;5241.187615919539;5322.973385133088;5361.678299302054;5366.543843773284;5386.299781028441;3441.2257242120572;3477.3219222251673;3573.857045718168;3588.4617307403837;3631.782093074424;1062.8193207154802;1107.2802678259116;1112.6495154026536;1114.3648120571277;1122.68003618969;11692;11768.529258829636;11826.645200643994;11837.171398002058;11904.285742855456;4549.909001819945;4553.4991150973365;4589.678722489461;4598.448186217675;4623.329617205486;9373.718788436357;9430.575624096931;9440.433573985583;9484.715458536255;9539.14147726708;5301.3373328333955;5308.92036619451;5319.627626066215;5325.988062268157;5357.249985002103;4404.515503294635;4866.075445665312;4920.483349248278;4941.234108713155;4967.081089998362;3772.7170462214895;3815.1797363566966;3839.577646458943;3881.4954055972544;3918.1967696622123;1139.4075080957855;1141.6289705845634;1145.1010956399186;1156.849609550753;1158.4439469054732;923.35826600512;1008.7478130467383;1018.3431686562126;1019.169376957777;1081.9404932728776;6074.240719910012;6130.295016073209;6165.383461653799;6236.469900058455;6333.018382150774;459.0955817040425;465.69729675711056;467.2337366718584;468.7843591947742;477.40086191829727;4317.956820431756;4329.28566786483;4350.086481838786;4354.303311470213;4366.366876802846;9850.556724947395;9972.501374931224;10157.187425005981;10210.234232432596;10261.538230779484;10114.089731924161;10125.746856328651;10128.797424051625;10140.746481338025;10144.442055687008;7831.921680783119;7873.763787086396;8032.116467188722;8077.151899050633;8156.510609363457;5916.526677865846;6090.969545152246;6151.661658608819;6179.258488981351;6263.780767673292;9079.59141838632;9170.67902623405;9228.723138305862;9346.766330841783;9383.155516003319;9116.453012819253;9452.43285402878;9510.144087031924;9526.142647161789;9759.072888075905;6927.89608155868;7318.085239345082;7521.699132034657;7612;7732.30409263169;8119.959400202961;8121.878171827546;8132.471389359673;8167.591620418836;8186.467879587808;7209.747658831916;7413.851722965618;7420.146683131509;7467.738629147953;7511.399088073051;7103.536310509271;7174.497785155198;7199.71201151948;7266.418686505172;7283.2352602975925;6903.1716194057035;6917.827054323682;7022.719091236498;7068.611226382598;7069.9646501767165;5051.661309752992;5082.567981721595;5138.871528211825;5213.218017297436;5229.320188375486;5163.8192663256605;5240.895182096413;5276.472352764847;5278.1027225372545;5376.7580458878665 03:45:03 INFO - PROCESS | 8617 | |4;prototype.html;368.3222869919348;371.77507607897223;376.42031271841364;376.738166973953;383.8138502826127;6626.701798419071;6633.568818026831;6636.070950066995;6684.264730879606;6772.119624448827;6686.665666716669;6690.43131333836;6693.832654183648;6705.2624211336715;6705.731770729165;5086.440491545936;5098.184290513518;5105.387353517564;5106.591472682177;5113.744312784346;5063.822766203165;5074.847754567369;5079.415867175285;5084.694918304914;5100.974495127519;5023.7236951967625;5039.445660977308;5044.621653375993;5052.393712754475;5060.165072762989;4918.130811317163;4994.400671919357;5036.395632524084;5045.596352291808;5058.4435712071645;4416.646668266531;4438;4446.7554284514335;4451.755153466558;4453.933191002106;6411.455026322721;6423.454006409461;6423.903641445382;6425.518086143558;6428.550001499897;5925.674087925162;5926.970365148147;5951.49412299955;5969.432903874125;5973.313068997078;7080.681369338392;7081.433485321162;7089.92910070903;7095.113110861143;7110.36006759389;4573.49691533931;4772.642051846091;4777.737224452654;4969.552740253358;4971.975140124312;7278.963605181993;7333;7335.926640733578;7378.335949764493;7381.52020118696;4886.780094895738;4893.902121957541;4901.779419926112;4905.141600219948;4905.411350637875;4937.679050861682;4962.900741985212;4963.007398520311;4965.577925876341;4993.80024799004;5776.740046697909;5778.219940308005;5791.507721843606;5791.594588378773;5792.275965504312;6896.586199829023;7089.0784198053925;7090.468214883905;7109.431245500347;7119.6084215368655;1743.7645917801187;1763.2153691607368;1769.672610567049;1772.291083566558;1773.485689150158;1080.9729756756144;1129.9435028248554;1133.920625556203;1136.7555975465314;1157.2362240920952;6707.966460167668;6916.896246556305;6960;6964.990076438888;6968.198657154391;7403.666834992438;7422.109346878301;7423.888641670379;7431.8142046449275;7454.962725186339;6845.349691779273;6860.03959445678;6861.931380686229;6865.210500792373;6875.621840798804;3896.1038961038553;3931.5282166139673;3981.8407263709128;4001.599840015975;4010.3583426651594;7586.317231449196;7627.542347459059;7642.503237289669;7647.617619119133;7657.846843063107;7490;7501.099868015764;7564.054493188351;7568.962155189189;7573.46985710995;7548.358389536841;7568.4323675725645;7592.506487078323;7595.848083038419;7615.5430674159725;7085.114360704912;7373.225811289737;7379.446541509301;7382.040334756447;7437.293457121565;7231.096112985877;7253.963730181315;7262.31008054234;7275.308845659654;7313.707451702086;7531.661075251517;7609.086909570887;7633.503822251536;7639.847203056019;7674.501157424749;4932.1122198004705;4954.925676114934;4976.377952755905;4988.052270068675;4992.8751781205765;7111.182214045451;7297.452691048086;7339.669714862951;7365.2634736525915;7392.96303518479;7030.191527974348;7106.4314854810455;7119.786406407816;7126.679299431435;7130.679119439741;7031.507794454339;7031.613261270679;7108.182559005573;7211.3870321023305;7229.710811567689;6952.130983627047;6979;6979.685914133977;6979.895301570582;6992.965035174791;6976.5814051157095;7112.182099058675;7123.180834204133;7163.176234733072;7180.676869540987;6762.087118238975;6953.756618518328;6959.19969203548;6965.164180298397;6980.7207711693 03:45:03 INFO - PROCESS | 8617 | |5;yui.html;913.684778751331;919.5999740113049;925.893522244942;931.0735817861229;933.5938866593033;12521.248725076503;12530.686732831684;12559.372031398416;12560;12564.497420103196;13188.802167967488;13925.164490130599;14063.085899416556;14139.717205655881;14161.645958851008;906.2749800159879;906.6464079009191;906.8277027364796;907.664164259225;914.8399030169727;907.7685190276503;908.8591268353416;914.7438717159206;914.7575892388489;916.2257892081215;951.1819834941945;953.3707752883098;958.1663952361455;958.611762236292;959.2278216036088;941.5339406993547;944.1219665710886;944.84882418813;949.378157306965;953.4327075390132;694.4930200953282;700.7407259314035;701.137600751079;701.982450438738;703.3072423662688;13507.189568625914;13727.313634318343;13751.931240343834;13794.586162415144;13805.17168969865;12803.231806091664;12881.227126372447;12887.16233444823;13043.152195107383;13090.869091309156;10986;11113.611023614216;11168.329900206014;11266.493007814668;11475.483603237792;3944.7435916665327;4612.561806628365;4703.553162449562;4713.622910167179;4836.782344794493;50403;56091.15863262054;56419.15371269393;56449.435505644826;57334.426655733325;10198.847017294747;10881;10983.670489885317;11464.54141834334;11496.655100347003;17635.206415711324;17638.647227055386;17818.821811781716;17996.10019499046;20545.589088218152;8455.830883382298;8575.742727718178;8645.135486451305;8699.652013919498;8816.823663526822;4729.408823897013;4731.408573928259;4743.976280118577;4828;4936.160852655057;3538.486919396673;3563.8417514307434;3569.39320315547;3589.2821435712963;3590.6947909427467;670.6043434373645;680.1129206518361;680.9489288303397;700.7022015643331;702.4766548920984;680.5270337115757;684.6645143879463;825.3933358981144;831.7587899509195;874.903760586335;9756.804863902682;10033.09702126812;10038.849417258747;10041.598336066476;10123.64567240143;790.7904405332591;791.6081539637917;816.942814003026;834.5451728807815;841.6465084664455;4614.146382919171;4789.664723469394;4814.470408255089;4816.277558366273;4817.229243321051;56101.7194914031;58147;63178.684106579174;63246.36753632497;64284;54859.72570137204;55325.72337138288;55499.72250138724;55559;56036.15945760817;47885.28172077422;48185.75907120442;53132.734336328074;54707;60205;9425.481598511873;9739.220862330854;9763.755906102404;9897.802043958936;10035.648752293635;38846.223075538896;39643.405348920365;39966.600333996284;40099.39850902297;40363.394549082375;49528.257076144604;49707.502924970286;49987.50012499828;50188.247176293116;50475.242871357696;13676.863231367957;13693.863061369259;13885.791713124108;13989.160650361011;14045.789313160107;13704.314784260947;13902.443902243796;14123.576292711236;14140.292985350485;14441.927790360982;12737.149019451079;12903.677408064874;13665.152517749422;13730;13783.379747911167;12530.185537940004;12914.09601327898;13450.663733406744;13518.391672374963;13553.186808791505;13157.407916643966;13207.075504714578;13573.728525429633;13820.447182112603;13852.238126903118;11236.66290011301;11236.775264494501;11477.426128693365;11588.47851846652;11731.472083756422;11609.941950290195;11766.705832354259;11890.940545297564;11981.28112313264;12004.579839705568 03:45:03 INFO - PROCESS | 8617 | __end_tp_report 03:45:03 INFO - PROCESS | 8617 | __start_cc_report 03:45:03 INFO - PROCESS | 8617 | _x_x_mozilla_cycle_collect,324 03:45:03 INFO - PROCESS | 8617 | __end_cc_report 03:45:03 INFO - PROCESS | 8617 | __startTimestamp1462704303635__endTimestamp 03:45:03 INFO - PROCESS | 8617 | 03:45:03 INFO - PROCESS | 8617 | ------- Summary: start ------- 03:45:03 INFO - PROCESS | 8617 | Number of tests: 6 03:45:03 INFO - PROCESS | 8617 | 03:45:03 INFO - PROCESS | 8617 | [#0] dojo.html Cycles:165 Average:5562.76 Median:5794.88 stddev:613.61 (10.6%) stddev-sans-first:589.73 03:45:03 INFO - PROCESS | 8617 | Values: 3319.8 3329.4 3385.7 3395.6 3414.0 5552.0 5564.6 5580.1 5624.9 5627.5 5542.8 5603.6 5623.2 5638.3 5691.8 5025.2 5058.1 5099.1 5132.0 5162.4 5000.8 5171.2 5238.0 5249.2 5250.1 5083.7 5129.9 5132.2 5201.4 5233.4 5110.9 5116.6 5124.7 5127.6 5153.1 4967.5 5055.0 5098.2 5102.2 5114.0 5370.8 5397.4 5492.0 5501.6 5515.3 5925.8 5963.6 5970.1 5978.2 5983.7 5892.9 5997.3 6018.6 6021.4 6024.6 5489.0 5489.8 5491.6 5500.8 5508.0 6055.1 6077.6 6111.4 6122.1 6127.4 5879.9 5911.4 5913.8 5928.7 5930.2 5957.9 5966.8 5976.8 5977.6 6017.6 5887.9 5934.4 5943.2 5948.8 5952.0 5909.5 5920.3 5934.3 5954.9 5957.4 4445.6 4484.9 4519.7 4541.7 4562.3 4052.7 4053.0 4057.3 4061.0 4091.2 5682.5 5715.3 5729.1 5730.2 5755.5 5962.9 6047.8 6060.2 6124.9 6126.3 5797.2 5797.4 5806.3 5807.7 5822.3 5183.2 5192.6 5221.2 5232.4 5259.9 5976.6 6116.7 6247.9 6251.7 6252.6 5866.8 5916.1 5939.0 5944.1 6000.8 6011.8 6115.8 6120.8 6123.6 6134.3 5781.6 5857.5 5884.6 5924.1 5953.8 5990.0 6004.5 6046.8 6055.3 6071.7 5630.7 5884.1 5893.8 5893.9 5894.4 5866.0 5877.5 5881.8 5881.9 5917.5 5755.5 5757.5 5771.6 5788.5 5791.6 5794.9 5808.9 5877.9 5923.1 5924.0 5689.4 5699.9 5739.3 5756.1 5784.0 03:45:03 INFO - PROCESS | 8617 | 03:45:03 INFO - PROCESS | 8617 | [#1] ext.html Cycles:180 Average:53951.75 Median:400206.00 stddev:108325.28 (27.1%) stddev-sans-first:108555.06 03:45:03 INFO - PROCESS | 8617 | Values: 588.5 653.4 657.3 665.5 697.5 38512.4 39543.8 39731.8 39961.4 39964.4 40413.6 41096.6 41385.8 41481.6 41571.6 8676.4 8798.3 8816.6 8839.9 8859.2 8706.1 8919.2 8951.7 8959.6 9003.5 8918.2 9028.3 9040.9 9045.8 9054.5 8902.1 8990.7 9036.4 9036.9 9077.7 8754.5 9022.0 9023.2 9031.5 9056.7 36943.6 41374.2 41896.4 41945.0 42001.4 3585.3 3643.1 3801.4 4209.2 4466.4 28181.4 28222.7 28225.9 28860.6 29180.1 4100.7 4115.6 4121.1 4176.2 4304.1 199078.0 200398.0 200451.0 200546.0 203138.0 36752.3 37022.8 37261.0 40097.8 40872.4 38072.2 38303.0 38465.6 38482.6 38530.2 16698.1 16849.1 16925.7 16944.2 16953.7 14834.9 14884.9 14885.5 14885.7 14896.3 9378.9 9535.2 9560.4 9604.3 9618.2 3612.9 3636.3 3694.6 3705.7 3707.4 1107.8 1112.3 1188.8 1204.9 1208.5 32728.8 33988.0 35652.8 36727.1 37363.4 1207.9 1245.3 1267.3 1280.3 1290.6 15712.0 16077.5 16164.2 16202.8 16359.6 453566.0 555051.0 564277.0 566291.0 569619.0 61137.4 62882.0 62928.0 62990.7 63421.0 1561.8 1568.5 1570.9 1573.5 1670.5 32880.3 33007.8 33467.0 33947.2 34525.5 52587.7 53203.0 53574.0 53923.0 54019.0 396858.0 398346.0 399271.0 400143.0 400269.0 30347.7 30453.1 31093.4 31123.0 31240.8 48252.3 48933.3 49148.5 49574.0 50275.5 41360.2 41555.2 41702.8 42638.8 42671.6 40171.6 40236.2 40464.6 41728.0 41979.4 42156.0 42566.4 44377.8 44870.3 45142.5 32341.8 33027.0 33312.5 33738.7 33857.5 28871.4 29926.3 30308.4 31222.2 31314.0 03:45:03 INFO - PROCESS | 8617 | 03:45:03 INFO - PROCESS | 8617 | [#2] jquery.html Cycles:180 Average:29287.96 Median:13209.32 stddev:84013.92 (636.0%) stddev-sans-first:84221.67 03:45:03 INFO - PROCESS | 8617 | Values: 436.6 447.6 449.5 451.1 452.1 19913.6 19920.9 20595.2 20811.4 20888.9 19532.9 19837.1 20032.2 20050.7 20348.3 5557.8 5966.6 5993.8 6012.8 6016.4 5869.1 5934.4 5952.8 5981.1 6002.3 5715.3 5937.6 5951.5 5952.0 5953.8 5827.0 5861.5 5906.9 5924.9 5925.0 5210.8 5506.3 5519.3 5522.8 5533.1 13998.7 15807.6 23640.4 24032.3 24162.2 2386.4 2549.9 2611.8 2850.7 3030.8 10012.6 10450.3 10455.4 10495.9 10717.2 1937.0 2017.8 2026.7 2070.8 2117.7 75791.0 77170.6 81232.2 82170.6 83133.6 11221.3 11513.4 11621.8 11638.7 11697.9 16188.4 16238.6 16325.8 16329.5 16343.2 8843.1 8942.7 8981.9 8996.3 9063.4 8892.0 9084.8 9104.1 9112.9 9229.3 5042.3 5044.6 5128.5 5141.7 5260.5 2019.7 2051.1 2112.2 2197.2 2203.4 1052.6 1080.6 1140.9 1151.0 1175.4 18420.3 19434.1 19822.0 19871.7 20161.4 1056.0 1096.2 1107.5 1110.1 1131.5 10935.6 11369.9 11434.8 11498.8 11662.6 504866.0 505396.0 506604.0 517996.0 527014.0 56491.4 72946.0 84380.6 86343.0 95207.0 980.4 991.3 993.9 1002.8 1041.9 17588.4 18140.7 18140.7 18210.5 18506.3 37101.8 39237.0 39622.4 40786.4 41355.6 50384.7 50836.2 51458.2 51578.7 51943.0 8762.5 8787.9 8906.3 8924.4 8987.2 12779.5 13591.3 13682.4 13788.4 14050.4 12383.9 12585.9 12609.7 12632.0 12661.6 12240.9 12412.4 12550.6 12683.9 12783.4 11723.5 12588.6 12822.4 13156.2 13213.7 8855.7 8878.1 8923.6 9004.2 9032.8 11439.0 12200.8 12217.9 12398.3 12573.3 03:45:03 INFO - PROCESS | 8617 | 03:45:03 INFO - PROCESS | 8617 | [#3] mootools.html Cycles:180 Average:5626.15 Median:5188.52 stddev:3058.09 (58.9%) stddev-sans-first:3051.36 03:45:03 INFO - PROCESS | 8617 | Values: 1555.2 1563.5 1726.2 1847.9 1879.9 7437.1 8161.1 8173.6 8424.5 8510.5 8268.4 8303.2 8355.1 8463.7 8481.6 2344.0 2377.8 2379.5 2389.8 2392.8 2434.4 2444.1 2474.1 2485.6 2485.8 2405.2 2433.7 2440.6 2442.3 2466.2 2342.7 2364.0 2366.3 2376.1 2395.1 2365.8 2371.7 2385.9 2389.3 2419.6 8613.9 8647.1 8669.5 8702.4 8721.3 5241.2 5323.0 5361.7 5366.5 5386.3 3441.2 3477.3 3573.9 3588.5 3631.8 1062.8 1107.3 1112.6 1114.4 1122.7 11692.0 11768.5 11826.6 11837.2 11904.3 4549.9 4553.5 4589.7 4598.4 4623.3 9373.7 9430.6 9440.4 9484.7 9539.1 5301.3 5308.9 5319.6 5326.0 5357.2 4404.5 4866.1 4920.5 4941.2 4967.1 3772.7 3815.2 3839.6 3881.5 3918.2 1139.4 1141.6 1145.1 1156.8 1158.4 923.4 1008.7 1018.3 1019.2 1081.9 6074.2 6130.3 6165.4 6236.5 6333.0 459.1 465.7 467.2 468.8 477.4 4318.0 4329.3 4350.1 4354.3 4366.4 9850.6 9972.5 10157.2 10210.2 10261.5 10114.1 10125.7 10128.8 10140.7 10144.4 7831.9 7873.8 8032.1 8077.2 8156.5 5916.5 6091.0 6151.7 6179.3 6263.8 9079.6 9170.7 9228.7 9346.8 9383.2 9116.5 9452.4 9510.1 9526.1 9759.1 6927.9 7318.1 7521.7 7612.0 7732.3 8120.0 8121.9 8132.5 8167.6 8186.5 7209.7 7413.9 7420.1 7467.7 7511.4 7103.5 7174.5 7199.7 7266.4 7283.2 6903.2 6917.8 7022.7 7068.6 7070.0 5051.7 5082.6 5138.9 5213.2 5229.3 5163.8 5240.9 5276.5 5278.1 5376.8 03:45:03 INFO - PROCESS | 8617 | 03:45:03 INFO - PROCESS | 8617 | [#4] prototype.html Cycles:180 Average:5924.41 Median:6767.10 stddev:1813.30 (26.8%) stddev-sans-first:1769.78 03:45:03 INFO - PROCESS | 8617 | Values: 368.3 371.8 376.4 376.7 383.8 6626.7 6633.6 6636.1 6684.3 6772.1 6686.7 6690.4 6693.8 6705.3 6705.7 5086.4 5098.2 5105.4 5106.6 5113.7 5063.8 5074.8 5079.4 5084.7 5101.0 5023.7 5039.4 5044.6 5052.4 5060.2 4918.1 4994.4 5036.4 5045.6 5058.4 4416.6 4438.0 4446.8 4451.8 4453.9 6411.5 6423.5 6423.9 6425.5 6428.6 5925.7 5927.0 5951.5 5969.4 5973.3 7080.7 7081.4 7089.9 7095.1 7110.4 4573.5 4772.6 4777.7 4969.6 4972.0 7279.0 7333.0 7335.9 7378.3 7381.5 4886.8 4893.9 4901.8 4905.1 4905.4 4937.7 4962.9 4963.0 4965.6 4993.8 5776.7 5778.2 5791.5 5791.6 5792.3 6896.6 7089.1 7090.5 7109.4 7119.6 1743.8 1763.2 1769.7 1772.3 1773.5 1081.0 1129.9 1133.9 1136.8 1157.2 6708.0 6916.9 6960.0 6965.0 6968.2 7403.7 7422.1 7423.9 7431.8 7455.0 6845.3 6860.0 6861.9 6865.2 6875.6 3896.1 3931.5 3981.8 4001.6 4010.4 7586.3 7627.5 7642.5 7647.6 7657.8 7490.0 7501.1 7564.1 7569.0 7573.5 7548.4 7568.4 7592.5 7595.8 7615.5 7085.1 7373.2 7379.4 7382.0 7437.3 7231.1 7254.0 7262.3 7275.3 7313.7 7531.7 7609.1 7633.5 7639.8 7674.5 4932.1 4954.9 4976.4 4988.1 4992.9 7111.2 7297.5 7339.7 7365.3 7393.0 7030.2 7106.4 7119.8 7126.7 7130.7 7031.5 7031.6 7108.2 7211.4 7229.7 6952.1 6979.0 6979.7 6979.9 6993.0 6976.6 7112.2 7123.2 7163.2 7180.7 6762.1 6953.8 6959.2 6965.2 6980.7 03:45:03 INFO - PROCESS | 8617 | 03:45:03 INFO - PROCESS | 8617 | [#5] yui.html Cycles:180 Average:15362.45 Median:4730.41 stddev:17619.91 (372.5%) stddev-sans-first:17635.92 03:45:03 INFO - PROCESS | 8617 | Values: 913.7 919.6 925.9 931.1 933.6 12521.2 12530.7 12559.4 12560.0 12564.5 13188.8 13925.2 14063.1 14139.7 14161.6 906.3 906.6 906.8 907.7 914.8 907.8 908.9 914.7 914.8 916.2 951.2 953.4 958.2 958.6 959.2 941.5 944.1 944.8 949.4 953.4 694.5 700.7 701.1 702.0 703.3 13507.2 13727.3 13751.9 13794.6 13805.2 12803.2 12881.2 12887.2 13043.2 13090.9 10986.0 11113.6 11168.3 11266.5 11475.5 3944.7 4612.6 4703.6 4713.6 4836.8 50403.0 56091.2 56419.2 56449.4 57334.4 10198.8 10881.0 10983.7 11464.5 11496.7 17635.2 17638.6 17818.8 17996.1 20545.6 8455.8 8575.7 8645.1 8699.7 8816.8 4729.4 4731.4 4744.0 4828.0 4936.2 3538.5 3563.8 3569.4 3589.3 3590.7 670.6 680.1 680.9 700.7 702.5 680.5 684.7 825.4 831.8 874.9 9756.8 10033.1 10038.8 10041.6 10123.6 790.8 791.6 816.9 834.5 841.6 4614.1 4789.7 4814.5 4816.3 4817.2 56101.7 58147.0 63178.7 63246.4 64284.0 54859.7 55325.7 55499.7 55559.0 56036.2 47885.3 48185.8 53132.7 54707.0 60205.0 9425.5 9739.2 9763.8 9897.8 10035.6 38846.2 39643.4 39966.6 40099.4 40363.4 49528.3 49707.5 49987.5 50188.2 50475.2 13676.9 13693.9 13885.8 13989.2 14045.8 13704.3 13902.4 14123.6 14140.3 14441.9 12737.1 12903.7 13665.2 13730.0 13783.4 12530.2 12914.1 13450.7 13518.4 13553.2 13157.4 13207.1 13573.7 13820.4 13852.2 11236.7 11236.8 11477.4 11588.5 11731.5 11609.9 11766.7 11890.9 11981.3 12004.6 03:45:03 INFO - PROCESS | 8617 | -------- Summary: end -------- 03:45:03 INFO - PROCESS | 8617 | 03:45:04 INFO - TEST-INFO | 8617: exit 0 03:45:04 INFO - TEST-OK | dromaeo_css | took 1109262ms 03:45:04 INFO - TEST-START | kraken 03:45:04 INFO - operating with platform_type : linux_ 03:45:04 INFO - Initialising browser for kraken test... 03:45:04 INFO - TEST-INFO | started process 8859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptjWHGT/profile http://localhost:47340/getInfo.html) 03:45:07 INFO - PROCESS | 8859 | 03:45:07 INFO - PROCESS | 8859 | (process:8937): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:45:08 INFO - PROCESS | 8859 | __metrics Screen width/height:1600/1200 03:45:08 INFO - PROCESS | 8859 | colorDepth:24 03:45:08 INFO - PROCESS | 8859 | Browser inner width/height: 1024/697 03:45:08 INFO - PROCESS | 8859 | __metrics 03:45:09 ERROR - PROCESS | 8859 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:45:10 INFO - TEST-INFO | 8859: exit 0 03:45:10 INFO - Browser initialized. 03:45:10 INFO - Running cycle 1/1 for kraken test... 03:45:10 INFO - TEST-INFO | started process 8988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptjWHGT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:11 INFO - PROCESS | 8988 | 03:45:11 INFO - PROCESS | 8988 | (process:9057): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:45:21 INFO - PROCESS | 8988 | RSS: Main: 152424448 03:45:21 INFO - PROCESS | 8988 | 03:45:24 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47340/tests/kraken/driver.html?testName=audio-beat-detection) 03:45:25 INFO - PROCESS | 8988 | RSS: Main: 156864512 03:45:25 INFO - PROCESS | 8988 | 03:45:27 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47340/tests/kraken/driver.html?testName=audio-dft) 03:45:28 INFO - PROCESS | 8988 | RSS: Main: 156991488 03:45:28 INFO - PROCESS | 8988 | 03:45:31 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47340/tests/kraken/driver.html?testName=audio-fft) 03:45:31 INFO - PROCESS | 8988 | RSS: Main: 157351936 03:45:31 INFO - PROCESS | 8988 | 03:45:34 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47340/tests/kraken/driver.html?testName=audio-oscillator) 03:45:34 INFO - PROCESS | 8988 | RSS: Main: 157106176 03:45:34 INFO - PROCESS | 8988 | 03:45:36 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47340/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:45:37 INFO - PROCESS | 8988 | RSS: Main: 157433856 03:45:37 INFO - PROCESS | 8988 | 03:45:40 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47340/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:41 INFO - PROCESS | 8988 | RSS: Main: 157102080 03:45:41 INFO - PROCESS | 8988 | 03:45:44 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47340/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:45 INFO - PROCESS | 8988 | RSS: Main: 157310976 03:45:45 INFO - PROCESS | 8988 | 03:45:47 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47340/tests/kraken/driver.html?testName=json-parse-financial) 03:45:48 INFO - PROCESS | 8988 | RSS: Main: 157589504 03:45:48 INFO - PROCESS | 8988 | 03:45:50 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47340/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:50 INFO - PROCESS | 8988 | RSS: Main: 157261824 03:45:50 INFO - PROCESS | 8988 | 03:45:52 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47340/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:52 INFO - PROCESS | 8988 | RSS: Main: 157159424 03:45:52 INFO - PROCESS | 8988 | 03:45:54 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47340/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:55 INFO - PROCESS | 8988 | RSS: Main: 157786112 03:45:55 INFO - PROCESS | 8988 | 03:45:58 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:58 INFO - PROCESS | 8988 | RSS: Main: 157753344 03:45:58 INFO - PROCESS | 8988 | 03:46:01 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:46:02 INFO - PROCESS | 8988 | RSS: Main: 157720576 03:46:02 INFO - PROCESS | 8988 | 03:46:03 INFO - PROCESS | 8988 | Cycle 1(1): loaded http://localhost:47340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47340/tests/kraken/driver.html?testName=ai-astar) 03:46:04 INFO - PROCESS | 8988 | RSS: Main: 159539200 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | __start_tp_report 03:46:04 INFO - PROCESS | 8988 | _x_x_mozilla_page_load 03:46:04 INFO - PROCESS | 8988 | _x_x_mozilla_page_load_details 03:46:04 INFO - PROCESS | 8988 | |i|pagename|runs| 03:46:04 INFO - PROCESS | 8988 | |0;ai-astar;109;112;104;111;113;113;102;111;111;110 03:46:04 INFO - PROCESS | 8988 | |1;audio-beat-detection;154;127;151;185;127;158;154;126;187;128 03:46:04 INFO - PROCESS | 8988 | |2;audio-dft;167;165;162;175;162;162;160;160;163;161 03:46:04 INFO - PROCESS | 8988 | |3;audio-fft;76;74;77;169;73;76;76;74;165;78 03:46:04 INFO - PROCESS | 8988 | |4;audio-oscillator;91;93;145;92;92;93;142;91;92;139 03:46:04 INFO - PROCESS | 8988 | |5;imaging-gaussian-blur;116;117;117;118;117;117;117;118;117;117 03:46:04 INFO - PROCESS | 8988 | |6;imaging-darkroom;147;147;146;146;146;147;147;148;148;146 03:46:04 INFO - PROCESS | 8988 | |7;imaging-desaturate;95;95;94;95;95;96;96;96;96;95 03:46:04 INFO - PROCESS | 8988 | |8;json-parse-financial;54;55;58;57;55;64;68;72;54;54 03:46:04 INFO - PROCESS | 8988 | |9;json-stringify-tinderbox;56;57;57;58;58;57;58;58;58;57 03:46:04 INFO - PROCESS | 8988 | |10;stanford-crypto-aes;73;74;82;76;74;83;75;74;81;75 03:46:04 INFO - PROCESS | 8988 | |11;stanford-crypto-ccm;114;126;116;121;117;114;129;121;173;140 03:46:04 INFO - PROCESS | 8988 | |12;stanford-crypto-pbkdf2;161;165;160;165;170;162;163;158;163;161 03:46:04 INFO - PROCESS | 8988 | |13;stanford-crypto-sha256-iterative;68;66;68;66;68;66;66;64;66;65 03:46:04 INFO - PROCESS | 8988 | __end_tp_report 03:46:04 INFO - PROCESS | 8988 | __start_cc_report 03:46:04 INFO - PROCESS | 8988 | _x_x_mozilla_cycle_collect,837 03:46:04 INFO - PROCESS | 8988 | __end_cc_report 03:46:04 INFO - PROCESS | 8988 | __startTimestamp1462704364100__endTimestamp 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | ------- Summary: start ------- 03:46:04 INFO - PROCESS | 8988 | Number of tests: 14 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.72 (3.3%) stddev-sans-first:3.94 03:46:04 INFO - PROCESS | 8988 | Values: 109.0 112.0 104.0 111.0 113.0 113.0 102.0 111.0 111.0 110.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:154.00 stddev:23.11 (15.0%) stddev-sans-first:24.46 03:46:04 INFO - PROCESS | 8988 | Values: 154.0 127.0 151.0 185.0 127.0 158.0 154.0 126.0 187.0 128.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#2] audio-dft Cycles:10 Average:163.70 Median:162.50 stddev:4.52 (2.8%) stddev-sans-first:4.64 03:46:04 INFO - PROCESS | 8988 | Values: 167.0 165.0 162.0 175.0 162.0 162.0 160.0 160.0 163.0 161.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:38.62 (50.8%) stddev-sans-first:40.42 03:46:04 INFO - PROCESS | 8988 | Values: 76.0 74.0 77.0 169.0 73.0 76.0 76.0 74.0 165.0 78.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:92.00 stddev:24.20 (26.3%) stddev-sans-first:24.97 03:46:04 INFO - PROCESS | 8988 | Values: 91.0 93.0 145.0 92.0 92.0 93.0 142.0 91.0 92.0 139.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 03:46:04 INFO - PROCESS | 8988 | Values: 116.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 03:46:04 INFO - PROCESS | 8988 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 147.0 148.0 148.0 146.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:46:04 INFO - PROCESS | 8988 | Values: 95.0 95.0 94.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:57.50 stddev:6.56 (11.4%) stddev-sans-first:6.69 03:46:04 INFO - PROCESS | 8988 | Values: 54.0 55.0 58.0 57.0 55.0 64.0 68.0 72.0 54.0 54.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.53 03:46:04 INFO - PROCESS | 8988 | Values: 56.0 57.0 57.0 58.0 58.0 57.0 58.0 58.0 58.0 57.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:75.50 stddev:3.77 (5.0%) stddev-sans-first:3.76 03:46:04 INFO - PROCESS | 8988 | Values: 73.0 74.0 82.0 76.0 74.0 83.0 75.0 74.0 81.0 75.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:123.50 stddev:18.02 (14.6%) stddev-sans-first:18.47 03:46:04 INFO - PROCESS | 8988 | Values: 114.0 126.0 116.0 121.0 117.0 114.0 129.0 121.0 173.0 140.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.00 stddev:3.33 (2.0%) stddev-sans-first:3.46 03:46:04 INFO - PROCESS | 8988 | Values: 161.0 165.0 160.0 165.0 170.0 162.0 163.0 158.0 163.0 161.0 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - PROCESS | 8988 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:1.34 (2.0%) stddev-sans-first:1.27 03:46:04 INFO - PROCESS | 8988 | Values: 68.0 66.0 68.0 66.0 68.0 66.0 66.0 64.0 66.0 65.0 03:46:04 INFO - PROCESS | 8988 | -------- Summary: end -------- 03:46:04 INFO - PROCESS | 8988 | 03:46:04 INFO - TEST-INFO | 8988: exit 0 03:46:04 INFO - TEST-OK | kraken | took 60647ms 03:46:04 INFO - SUITE-END | took 1169s 03:46:05 INFO - Completed test suite (00:19:30) 03:46:05 INFO - javascript benchmark 03:46:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.834008299585, 3329.3674201901636, 3385.678360555746, 3395.6434574369705, 3414.0270023043436, 5551.9722401387935, 5564.582656300779, 5580.051391263485, 5624.859378515539, 5627.465390787874, 5542.75057622407, 5603.579731520143, 5623.240862483563, 5638.323401191863, 5691.8292451226425, 5025.170846810281, 5058.064258112243, 5099.133147364957, 5132.0, 5162.406323272834, 5000.824971126011, 5171.224316352558, 5237.973810130944, 5249.1601343785005, 5250.081235783741, 5083.745812709368, 5129.897402051975, 5132.230165475171, 5201.375834899817, 5233.3981592116825, 5110.897782044357, 5116.59067274619, 5124.692518448905, 5127.589792816566, 5153.098207813618, 4967.50324967504, 5054.989002199538, 5098.158803797369, 5102.183650615883, 5113.974430127825, 5370.838874833761, 5397.4062853086125, 5491.972540137273, 5501.587380946445, 5515.310586176728, 5925.792597259118, 5963.642181469126, 5970.0746384310505, 5978.192943952554, 5983.730732117022, 5892.882142357129, 5997.310309314441, 6018.608790428652, 6021.42796434338, 6024.638521688713, 5489.011977843987, 5489.752961116759, 5491.643043202179, 5500.779968801243, 5508.0, 6055.061465472859, 6077.604955677867, 6111.404041107485, 6122.051082082285, 6127.387261273837, 5879.882402351929, 5911.408859114054, 5913.822585322448, 5928.673922934194, 5930.229070220844, 5957.880842383128, 5966.791162309299, 5976.760929562855, 5977.551683623746, 6017.638941663514, 5887.852803679856, 5934.37689042653, 5943.167956486095, 5948.821535353946, 5951.970240148771, 5909.468147866713, 5920.259967504062, 5934.287885453773, 5954.940450595525, 5957.434043765922, 4445.622122119591, 4484.865454036384, 4519.728816271035, 4541.727496350163, 4562.315652652129, 4052.675785937177, 4053.0, 4057.2899742544937, 4060.964454064195, 4091.202215567995, 5682.54539636828, 5715.314162300468, 5729.140628905614, 5730.226419433407, 5755.539556835443, 5962.85092872673, 6047.758089676452, 6060.181875446759, 6124.869201255686, 6126.303932855801, 5797.2173756542325, 5797.420257974169, 5806.30324361071, 5807.68057756819, 5822.3304320003745, 5183.196604526304, 5192.61055420845, 5221.190715439037, 5232.424433312332, 5259.921101183485, 5976.581639285295, 6116.67056464255, 6247.937520624736, 6251.687415629201, 6252.624842509464, 5866.823995279978, 5916.083007133901, 5939.049752039653, 5944.078667806497, 6000.7899723510345, 6011.789587364421, 6115.816525504242, 6120.7551697931585, 6123.632582045091, 6134.26388833325, 5781.624194427349, 5857.50211232033, 5884.6469211847425, 5924.081767326072, 5953.76184952597, 5990.041593345044, 6004.489618382487, 6046.818595442144, 6055.273367195965, 6071.726772295169, 5630.662160270397, 5884.08796636522, 5893.793717219876, 5893.941060589339, 5894.410558944242, 5865.970670146793, 5877.529797616095, 5881.794137205177, 5881.882442335943, 5917.526597872074, 5755.482006619424, 5757.453041961007, 5771.59598828078, 5788.53691704671, 5791.565632577658, 5794.884102318014, 5808.94191058084, 5877.94122058774, 5923.08192230205, 5923.970380148072, 5689.374168841507, 5699.857503562278, 5739.253896993531, 5756.050251708589, 5784.045632470596], "value": 5522.941984592672, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.4733163818382, 653.3662347522902, 657.3492242679746, 665.5241502325836, 697.543109263432, 38512.42231366528, 39543.80228098855, 39731.801340993254, 39961.400578991335, 39964.40053399201, 40413.59586404135, 41096.58903410965, 41385.793071034605, 41481.58518414815, 41571.58428415715, 8676.436031657939, 8798.252148567379, 8816.559172041372, 8839.867401988975, 8859.20267175954, 8706.129387061306, 8919.24186444153, 8951.731448056536, 8959.641614335418, 9003.5048072356, 8918.197362237397, 9028.277737780994, 9040.8643870342, 9045.819083618324, 9054.547272636375, 8902.06528314524, 8990.685326013623, 9036.412633178856, 9036.8644470333, 9077.727668169966, 8754.518501482416, 9021.954890225572, 9023.187913087853, 9031.548422578844, 9056.683016094405, 36943.630563694554, 41374.1725165498, 41896.37155442671, 41945.0, 42001.36997945033, 3585.2650206707563, 3643.125649844045, 3801.353769859131, 4209.179210054041, 4466.3523789050405, 28181.436371272666, 28222.717772822216, 28225.85887070572, 28860.567091493645, 29180.124596262147, 4100.7334523255895, 4115.58844115589, 4121.093359460914, 4176.164767046603, 4304.139172165579, 199077.99999999854, 200398.0, 200451.0, 200546.0, 203138.0, 36752.26495470129, 37022.8148859254, 37261.0, 40097.79951100226, 40872.38691419631, 38072.23855522874, 38303.0, 38465.615343846206, 38482.61517384846, 38530.22939541194, 16698.081605511572, 16849.073300968565, 16925.7461138083, 16944.15279236033, 16953.745693814602, 14834.925825370805, 14884.851151488563, 14885.479008234659, 14885.702285954438, 14896.329665165094, 9378.906210937803, 9535.2371810255, 9560.378575392577, 9604.327697061279, 9618.230541556659, 3612.855485780592, 3636.2727454509204, 3694.5935947045805, 3705.6664900159117, 3707.351213537674, 1107.8338249262513, 1112.265904503024, 1188.7919614067503, 1204.8674645788956, 1208.474313673555, 32728.836355818068, 33988.0, 35652.7521536745, 36727.081822954104, 37363.43954840679, 1207.9094067944939, 1245.2964075297427, 1267.3283159925254, 1280.3470230182675, 1290.5999140266547, 15711.98996979977, 16077.517674469784, 16164.191790410432, 16202.75695864563, 16359.59101022484, 453566.0, 555051.0, 564277.0, 566291.0, 569619.0, 61137.38862611406, 62882.0, 62928.0, 62990.68504657447, 63421.0, 1561.8281988981203, 1568.5216009117328, 1570.8586227239603, 1573.5436723350329, 1670.523900688298, 32880.34239315153, 33007.83496082504, 33467.0, 33947.15132121717, 34525.482117768755, 52587.73706131598, 53203.0, 53574.0, 53923.0, 54019.0, 396858.0, 398346.0, 399271.0, 400143.0, 400269.0, 30347.696523034487, 30453.086407407813, 31093.378132437676, 31123.0, 31240.843795780875, 48252.27621585609, 48933.2660010093, 49148.50851491439, 49574.0, 50275.49724502708, 41360.1727965445, 41555.168896622505, 41702.79148604238, 42638.78680606577, 42671.573284268, 40171.598284016785, 40236.19527609373, 40464.59535404608, 41728.0, 41979.37030944477, 42156.0, 42566.361504578075, 44377.77811110924, 44870.3269450952, 45142.548574513836, 32341.838290808395, 33027.00918972435, 33312.50031249485, 33738.662613373555, 33857.49213761845, 28871.42257154803, 29926.251843703212, 30308.393832123675, 31222.21944451316, 31314.0], "value": 19019.37666214569, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.5596316590261, 447.62089494337596, 449.4875841540642, 451.1383257977264, 452.14770158251685, 19913.60172796545, 19920.90039549802, 20595.176192952284, 20811.375658730223, 20888.895555522202, 19532.90233548834, 19837.10733017014, 20032.1987120515, 20050.69923951138, 20348.287809926656, 5557.833265002037, 5966.552508561854, 5993.820185394445, 6012.8496787580225, 6016.42843929826, 5869.090291004901, 5934.406559344075, 5952.821415357546, 5981.1028345748055, 6002.309734380558, 5715.3141623005085, 5937.6140550864275, 5951.464368206861, 5952.0, 5953.761849526014, 5827.038538641119, 5861.472467477947, 5906.852328691795, 5924.911126333109, 5925.022371308729, 5210.843674689765, 5506.256655351516, 5519.2824932758485, 5522.806701765419, 5533.059379905426, 13998.650033749136, 15807.60480987973, 23640.408989775395, 24032.279031629078, 24162.15432459873, 2386.355683965337, 2549.859757713325, 2611.8171727979047, 2850.700676428966, 3030.848457577112, 10012.59949602015, 10450.320729152581, 10455.372677639367, 10495.895041049567, 10717.249792514527, 1936.9515762105918, 2017.838572914178, 2026.6656001759693, 2070.823979961705, 2117.6929345244853, 75791.0, 77170.61414692947, 81232.18767812305, 82170.58914705388, 83133.58433207795, 11221.270617409842, 11513.366764827848, 11621.76756464866, 11638.6508404748, 11697.941510292394, 16188.352465901233, 16238.594035148979, 16325.755113673304, 16329.510114696579, 16343.18284085791, 8843.0714774949, 8942.73171804847, 8981.910180898107, 8996.280297576179, 9063.36556441056, 8892.0, 9084.772880678036, 9104.13510716481, 9112.908870911206, 9229.307801914883, 5042.268871013683, 5044.571211447068, 5128.461511541234, 5141.691498510101, 5260.526552610207, 2019.7172395864297, 2051.087266166571, 2112.176251262009, 2197.1760589778833, 2203.361025302644, 1052.6000119954522, 1080.5839751695653, 1140.9149183569957, 1150.9712257193637, 1175.3770501634147, 18420.26318947254, 19434.12546435414, 19822.0, 19871.701924470854, 20161.39515814528, 1056.0495554001461, 1096.2435919215716, 1107.4960892793758, 1110.123002827757, 1131.479519421059, 10935.56257749681, 11369.886301137049, 11434.771304573862, 11498.827517587242, 11662.591809286803, 504866.0, 505396.0, 506604.0, 517996.0, 527014.0, 56491.43508564944, 72946.0, 84380.57809711035, 86343.0, 95207.0, 980.367662857453, 991.2912267728609, 993.8956409577034, 1002.8245057114975, 1041.8541404203418, 17588.38440654571, 18140.72788908141, 18140.72788908194, 18210.544736381697, 18506.259749609864, 37101.814490927376, 39237.0, 39622.444774355456, 40786.38820417756, 41355.586444136374, 50384.748076259384, 50836.23745643744, 51458.22812657888, 51578.74210628923, 51943.0, 8762.518061506678, 8787.91212087871, 8906.287497000354, 8924.375293729376, 8987.19115279628, 12779.488820447077, 13591.252481113239, 13682.384292706653, 13788.379522921292, 14050.437982480586, 12383.876161238271, 12585.93707031459, 12609.747805043664, 12632.0, 12661.620151395473, 12240.938795305967, 12412.379381031093, 12550.623481295575, 12683.902157586266, 12783.424745886272, 11723.472443739882, 12588.622341329774, 12822.358882055672, 13156.210627362389, 13213.735725285249, 8855.690050848189, 8878.089669004978, 8923.553822308988, 9004.189622933967, 9032.774180645536, 11439.0, 12200.75598488043, 12217.877821221675, 12398.318092504638, 12573.308468034345], "value": 9564.835297499083, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.2068445093003, 1563.4684207369496, 1726.2318268370573, 1847.8521718262548, 1879.8966056866866, 7437.070366204224, 8161.143079976606, 8173.632186551605, 8424.536650484228, 8510.531920744364, 8268.37987150963, 8303.169683031709, 8355.080941096474, 8463.746087617366, 8481.57592120393, 2343.9882800586015, 2377.7741114594087, 2379.524095180962, 2389.7849193572574, 2392.796612287949, 2434.4400787818813, 2444.10790061628, 2474.084588702183, 2485.6271559266165, 2485.801135909123, 2405.1702162753822, 2433.6592876997233, 2440.5606990741658, 2442.3039433761382, 2466.1615050882697, 2342.7305859826083, 2364.042562762084, 2366.290112966103, 2376.061455724979, 2395.101836811196, 2365.8343915925893, 2371.65610986406, 2385.9045638174625, 2389.2712722619594, 2419.6128619420983, 8613.870791938127, 8647.092055334162, 8669.523176225304, 8702.434341767765, 8721.258693011037, 5241.187615919539, 5322.973385133088, 5361.678299302054, 5366.543843773284, 5386.299781028441, 3441.2257242120572, 3477.3219222251673, 3573.857045718168, 3588.4617307403837, 3631.782093074424, 1062.8193207154802, 1107.2802678259116, 1112.6495154026536, 1114.3648120571277, 1122.68003618969, 11692.0, 11768.529258829636, 11826.645200643994, 11837.171398002058, 11904.285742855456, 4549.909001819945, 4553.4991150973365, 4589.678722489461, 4598.448186217675, 4623.329617205486, 9373.718788436357, 9430.575624096931, 9440.433573985583, 9484.715458536255, 9539.14147726708, 5301.3373328333955, 5308.92036619451, 5319.627626066215, 5325.988062268157, 5357.249985002103, 4404.515503294635, 4866.075445665312, 4920.483349248278, 4941.234108713155, 4967.081089998362, 3772.7170462214895, 3815.1797363566966, 3839.577646458943, 3881.4954055972544, 3918.1967696622123, 1139.4075080957855, 1141.6289705845634, 1145.1010956399186, 1156.849609550753, 1158.4439469054732, 923.35826600512, 1008.7478130467383, 1018.3431686562126, 1019.169376957777, 1081.9404932728776, 6074.240719910012, 6130.295016073209, 6165.383461653799, 6236.469900058455, 6333.018382150774, 459.0955817040425, 465.69729675711056, 467.2337366718584, 468.7843591947742, 477.40086191829727, 4317.956820431756, 4329.28566786483, 4350.086481838786, 4354.303311470213, 4366.366876802846, 9850.556724947395, 9972.501374931224, 10157.187425005981, 10210.234232432596, 10261.538230779484, 10114.089731924161, 10125.746856328651, 10128.797424051625, 10140.746481338025, 10144.442055687008, 7831.921680783119, 7873.763787086396, 8032.116467188722, 8077.151899050633, 8156.510609363457, 5916.526677865846, 6090.969545152246, 6151.661658608819, 6179.258488981351, 6263.780767673292, 9079.59141838632, 9170.67902623405, 9228.723138305862, 9346.766330841783, 9383.155516003319, 9116.453012819253, 9452.43285402878, 9510.144087031924, 9526.142647161789, 9759.072888075905, 6927.89608155868, 7318.085239345082, 7521.699132034657, 7612.0, 7732.30409263169, 8119.959400202961, 8121.878171827546, 8132.471389359673, 8167.591620418836, 8186.467879587808, 7209.747658831916, 7413.851722965618, 7420.146683131509, 7467.738629147953, 7511.399088073051, 7103.536310509271, 7174.497785155198, 7199.71201151948, 7266.418686505172, 7283.2352602975925, 6903.1716194057035, 6917.827054323682, 7022.719091236498, 7068.611226382598, 7069.9646501767165, 5051.661309752992, 5082.567981721595, 5138.871528211825, 5213.218017297436, 5229.320188375486, 5163.8192663256605, 5240.895182096413, 5276.472352764847, 5278.1027225372545, 5376.7580458878665], "value": 4503.652934930121, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.3222869919348, 371.77507607897223, 376.42031271841364, 376.738166973953, 383.8138502826127, 6626.701798419071, 6633.568818026831, 6636.070950066995, 6684.264730879606, 6772.119624448827, 6686.665666716669, 6690.43131333836, 6693.832654183648, 6705.2624211336715, 6705.731770729165, 5086.440491545936, 5098.184290513518, 5105.387353517564, 5106.591472682177, 5113.744312784346, 5063.822766203165, 5074.847754567369, 5079.415867175285, 5084.694918304914, 5100.974495127519, 5023.7236951967625, 5039.445660977308, 5044.621653375993, 5052.393712754475, 5060.165072762989, 4918.130811317163, 4994.400671919357, 5036.395632524084, 5045.596352291808, 5058.4435712071645, 4416.646668266531, 4438.0, 4446.7554284514335, 4451.755153466558, 4453.933191002106, 6411.455026322721, 6423.454006409461, 6423.903641445382, 6425.518086143558, 6428.550001499897, 5925.674087925162, 5926.970365148147, 5951.49412299955, 5969.432903874125, 5973.313068997078, 7080.681369338392, 7081.433485321162, 7089.92910070903, 7095.113110861143, 7110.36006759389, 4573.49691533931, 4772.642051846091, 4777.737224452654, 4969.552740253358, 4971.975140124312, 7278.963605181993, 7333.0, 7335.926640733578, 7378.335949764493, 7381.52020118696, 4886.780094895738, 4893.902121957541, 4901.779419926112, 4905.141600219948, 4905.411350637875, 4937.679050861682, 4962.900741985212, 4963.007398520311, 4965.577925876341, 4993.80024799004, 5776.740046697909, 5778.219940308005, 5791.507721843606, 5791.594588378773, 5792.275965504312, 6896.586199829023, 7089.0784198053925, 7090.468214883905, 7109.431245500347, 7119.6084215368655, 1743.7645917801187, 1763.2153691607368, 1769.672610567049, 1772.291083566558, 1773.485689150158, 1080.9729756756144, 1129.9435028248554, 1133.920625556203, 1136.7555975465314, 1157.2362240920952, 6707.966460167668, 6916.896246556305, 6960.0, 6964.990076438888, 6968.198657154391, 7403.666834992438, 7422.109346878301, 7423.888641670379, 7431.8142046449275, 7454.962725186339, 6845.349691779273, 6860.03959445678, 6861.931380686229, 6865.210500792373, 6875.621840798804, 3896.1038961038553, 3931.5282166139673, 3981.8407263709128, 4001.599840015975, 4010.3583426651594, 7586.317231449196, 7627.542347459059, 7642.503237289669, 7647.617619119133, 7657.846843063107, 7490.0, 7501.099868015764, 7564.054493188351, 7568.962155189189, 7573.46985710995, 7548.358389536841, 7568.4323675725645, 7592.506487078323, 7595.848083038419, 7615.5430674159725, 7085.114360704912, 7373.225811289737, 7379.446541509301, 7382.040334756447, 7437.293457121565, 7231.096112985877, 7253.963730181315, 7262.31008054234, 7275.308845659654, 7313.707451702086, 7531.661075251517, 7609.086909570887, 7633.503822251536, 7639.847203056019, 7674.501157424749, 4932.1122198004705, 4954.925676114934, 4976.377952755905, 4988.052270068675, 4992.8751781205765, 7111.182214045451, 7297.452691048086, 7339.669714862951, 7365.2634736525915, 7392.96303518479, 7030.191527974348, 7106.4314854810455, 7119.786406407816, 7126.679299431435, 7130.679119439741, 7031.507794454339, 7031.613261270679, 7108.182559005573, 7211.3870321023305, 7229.710811567689, 6952.130983627047, 6979.0, 6979.685914133977, 6979.895301570582, 6992.965035174791, 6976.5814051157095, 7112.182099058675, 7123.180834204133, 7163.176234733072, 7180.676869540987, 6762.087118238975, 6953.756618518328, 6959.19969203548, 6965.164180298397, 6980.7207711693], "value": 5328.987090529313, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.684778751331, 919.5999740113049, 925.893522244942, 931.0735817861229, 933.5938866593033, 12521.248725076503, 12530.686732831684, 12559.372031398416, 12560.0, 12564.497420103196, 13188.802167967488, 13925.164490130599, 14063.085899416556, 14139.717205655881, 14161.645958851008, 906.2749800159879, 906.6464079009191, 906.8277027364796, 907.664164259225, 914.8399030169727, 907.7685190276503, 908.8591268353416, 914.7438717159206, 914.7575892388489, 916.2257892081215, 951.1819834941945, 953.3707752883098, 958.1663952361455, 958.611762236292, 959.2278216036088, 941.5339406993547, 944.1219665710886, 944.84882418813, 949.378157306965, 953.4327075390132, 694.4930200953282, 700.7407259314035, 701.137600751079, 701.982450438738, 703.3072423662688, 13507.189568625914, 13727.313634318343, 13751.931240343834, 13794.586162415144, 13805.17168969865, 12803.231806091664, 12881.227126372447, 12887.16233444823, 13043.152195107383, 13090.869091309156, 10986.0, 11113.611023614216, 11168.329900206014, 11266.493007814668, 11475.483603237792, 3944.7435916665327, 4612.561806628365, 4703.553162449562, 4713.622910167179, 4836.782344794493, 50403.0, 56091.15863262054, 56419.15371269393, 56449.435505644826, 57334.426655733325, 10198.847017294747, 10881.0, 10983.670489885317, 11464.54141834334, 11496.655100347003, 17635.206415711324, 17638.647227055386, 17818.821811781716, 17996.10019499046, 20545.589088218152, 8455.830883382298, 8575.742727718178, 8645.135486451305, 8699.652013919498, 8816.823663526822, 4729.408823897013, 4731.408573928259, 4743.976280118577, 4828.0, 4936.160852655057, 3538.486919396673, 3563.8417514307434, 3569.39320315547, 3589.2821435712963, 3590.6947909427467, 670.6043434373645, 680.1129206518361, 680.9489288303397, 700.7022015643331, 702.4766548920984, 680.5270337115757, 684.6645143879463, 825.3933358981144, 831.7587899509195, 874.903760586335, 9756.804863902682, 10033.09702126812, 10038.849417258747, 10041.598336066476, 10123.64567240143, 790.7904405332591, 791.6081539637917, 816.942814003026, 834.5451728807815, 841.6465084664455, 4614.146382919171, 4789.664723469394, 4814.470408255089, 4816.277558366273, 4817.229243321051, 56101.7194914031, 58147.0, 63178.684106579174, 63246.36753632497, 64284.0, 54859.72570137204, 55325.72337138288, 55499.72250138724, 55559.0, 56036.15945760817, 47885.28172077422, 48185.75907120442, 53132.734336328074, 54707.0, 60205.0, 9425.481598511873, 9739.220862330854, 9763.755906102404, 9897.802043958936, 10035.648752293635, 38846.223075538896, 39643.405348920365, 39966.600333996284, 40099.39850902297, 40363.394549082375, 49528.257076144604, 49707.502924970286, 49987.50012499828, 50188.247176293116, 50475.242871357696, 13676.863231367957, 13693.863061369259, 13885.791713124108, 13989.160650361011, 14045.789313160107, 13704.314784260947, 13902.443902243796, 14123.576292711236, 14140.292985350485, 14441.927790360982, 12737.149019451079, 12903.677408064874, 13665.152517749422, 13730.0, 13783.379747911167, 12530.185537940004, 12914.09601327898, 13450.663733406744, 13518.391672374963, 13553.186808791505, 13157.407916643966, 13207.075504714578, 13573.728525429633, 13820.447182112603, 13852.238126903118, 11236.66290011301, 11236.775264494501, 11477.426128693365, 11588.47851846652, 11731.472083756422, 11609.941950290195, 11766.705832354259, 11890.940545297564, 11981.28112313264, 12004.579839705568], "value": 7154.824888458847, "unit": "score"}], "name": "dromaeo_css", "value": 7461.305987205892, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 104.0, 111.0, 113.0, 113.0, 102.0, 111.0, 111.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 151.0, 185.0, 127.0, 158.0, 154.0, 126.0, 187.0, 128.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 162.0, 175.0, 162.0, 162.0, 160.0, 160.0, 163.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 169.0, 73.0, 76.0, 76.0, 74.0, 165.0, 78.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 145.0, 92.0, 92.0, 93.0, 142.0, 91.0, 92.0, 139.0], "value": 107.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 148.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 58.0, 57.0, 55.0, 64.0, 68.0, 72.0, 54.0, 54.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 57.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 82.0, 76.0, 74.0, 83.0, 75.0, 74.0, 81.0, 75.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 126.0, 116.0, 121.0, 117.0, 114.0, 129.0, 121.0, 173.0, 140.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 160.0, 165.0, 170.0, 162.0, 163.0, 158.0, 163.0, 161.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 66.0, 68.0, 66.0, 66.0, 64.0, 66.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1532.3999999999999, "alertThreshold": 2.0}]} 03:46:05 INFO - Return code: 0 03:46:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:46:05 ERROR - # TBPL SUCCESS # 03:46:05 INFO - Running post-action listener: _resource_record_post_action 03:46:05 INFO - Running post-run listener: _resource_record_post_run 03:46:06 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 270336; Write bytes: 499453952; Read time: 312; Write time: 410520 03:46:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 248442880; Read time: 108; Write time: 242508 03:46:06 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250843136; Read time: 204; Write time: 167988 03:46:06 INFO - Running post-run listener: _upload_blobber_files 03:46:06 INFO - Blob upload gear active. 03:46:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:46:06 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 03:46:06 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'] 03:46:06 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 03:46:06 INFO - (blobuploader) - INFO - Open directory for files ... 03:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:07 INFO - (blobuploader) - INFO - Done attempting. 03:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:46:08 INFO - (blobuploader) - INFO - Done attempting. 03:46:08 INFO - (blobuploader) - INFO - Iteration through files over. 03:46:08 INFO - Return code: 0 03:46:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:46:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:46:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/997f4c930fd2ab9e956f18f65058c1779f4ed3b72ccfe1971ac470426a1e55d832fb7aaf8ba0aab2354e4db33259ab4d849985859f7d2c026c0d83724ac16b5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d2a3ba513889b1c3330ed391b3216d4c9da1b869ad825cc8d518068c33f0e7c0e97b50d8b877616276f3c6eebe372f6c5c46052c1d6c1c295fc9ed2ed7d4631"} 03:46:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:46:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:46:08 INFO - Contents: 03:46:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/997f4c930fd2ab9e956f18f65058c1779f4ed3b72ccfe1971ac470426a1e55d832fb7aaf8ba0aab2354e4db33259ab4d849985859f7d2c026c0d83724ac16b5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d2a3ba513889b1c3330ed391b3216d4c9da1b869ad825cc8d518068c33f0e7c0e97b50d8b877616276f3c6eebe372f6c5c46052c1d6c1c295fc9ed2ed7d4631"} 03:46:08 INFO - Running post-run listener: copy_logs_to_upload_dir 03:46:08 INFO - Copying logs to upload dir... 03:46:08 INFO - mkdir: /builds/slave/test/build/upload/logs 03:46:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.431695 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-05-08 03:46:08.295589) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-08 03:46:08.298933) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154 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/997f4c930fd2ab9e956f18f65058c1779f4ed3b72ccfe1971ac470426a1e55d832fb7aaf8ba0aab2354e4db33259ab4d849985859f7d2c026c0d83724ac16b5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d2a3ba513889b1c3330ed391b3216d4c9da1b869ad825cc8d518068c33f0e7c0e97b50d8b877616276f3c6eebe372f6c5c46052c1d6c1c295fc9ed2ed7d4631"} build_url:https://queue.taskcluster.net/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011144 build_url: 'https://queue.taskcluster.net/v1/task/PVzccX7PQRqJZBtmr3_0QA/artifacts/public/build/firefox-48.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/997f4c930fd2ab9e956f18f65058c1779f4ed3b72ccfe1971ac470426a1e55d832fb7aaf8ba0aab2354e4db33259ab4d849985859f7d2c026c0d83724ac16b5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d2a3ba513889b1c3330ed391b3216d4c9da1b869ad825cc8d518068c33f0e7c0e97b50d8b877616276f3c6eebe372f6c5c46052c1d6c1c295fc9ed2ed7d4631"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-08 03:46:08.323920) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 03:46:08.324267) ========= 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=31acecf42b6a79ec49471d4a000001bb-1462700602.86334-2046122154 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 03:46:08.406467) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-08 03:46:08.406785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-08 03:46:08.407082) ========= ========= Total master_lag: 0.18 =========