builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1464110046.76 results: success (0) buildid: 20160524092604 builduid: 5c6b412eaa7b41fb87abf9250d81b6ca revision: fa6460853ebf5035fe0b05c11213f6eb4bb57ea2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:06.759106) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:06.759588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:06.759878) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:06.776596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:06.776957) ========= 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=7de08804244eb36560b44971000001c3-1464110045.945450-2117122449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 10:14:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-05-24 10:14:06 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:06.937152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:06.937477) ========= 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=7de08804244eb36560b44971000001c3-1464110045.945450-2117122449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017525 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:06.987618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:06.987980) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fa6460853ebf5035fe0b05c11213f6eb4bb57ea2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fa6460853ebf5035fe0b05c11213f6eb4bb57ea2 --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=7de08804244eb36560b44971000001c3-1464110045.945450-2117122449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 10:14:07,048 truncating revision to first 12 chars 2016-05-24 10:14:07,048 Setting DEBUG logging. 2016-05-24 10:14:07,048 attempt 1/10 2016-05-24 10:14:07,048 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fa6460853ebf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 10:14:07,317 unpacking tar archive at: fx-team-fa6460853ebf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.548830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:07.550124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:07.550498) ========= script_repo_revision: fa6460853ebf5035fe0b05c11213f6eb4bb57ea2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:07.550914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:07.551193) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 10:14:07.561179) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-24 10:14:07.561537) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=7de08804244eb36560b44971000001c3-1464110045.945450-2117122449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:14:07 INFO - MultiFileLogger online at 20160524 10:14:07 in /builds/slave/test 10:14:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:14:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:14:07 INFO - {'append_to_log': False, 10:14:07 INFO - 'base_work_dir': '/builds/slave/test', 10:14:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:14:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:14:07 INFO - 'branch': 'Fx-Team-Non-PGO', 10:14:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:07 INFO - 'config_files': ('talos/linux_config.py',), 10:14:07 INFO - 'default_actions': ('clobber', 10:14:07 INFO - 'read-buildbot-config', 10:14:07 INFO - 'download-and-extract', 10:14:07 INFO - 'populate-webroot', 10:14:07 INFO - 'create-virtualenv', 10:14:07 INFO - 'install', 10:14:07 INFO - 'run-tests'), 10:14:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:07 INFO - 'download_minidump_stackwalk': True, 10:14:07 INFO - 'download_symbols': 'ondemand', 10:14:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:07 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:07 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:07 INFO - 'installer_path': 'installer.exe', 10:14:07 INFO - 'log_level': 'info', 10:14:07 INFO - 'log_name': 'talos', 10:14:07 INFO - 'log_to_console': True, 10:14:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:14:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:14:07 INFO - 'opt_config_files': (), 10:14:07 INFO - 'pip_index': False, 10:14:07 INFO - 'sps_profile': False, 10:14:07 INFO - 'sps_profile_interval': 0, 10:14:07 INFO - 'suite': 'dromaeojs', 10:14:07 INFO - 'system_bits': '32', 10:14:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:07 INFO - 'title': 'talos-linux64-ix-003', 10:14:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:07 INFO - 'use_talos_json': True, 10:14:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:14:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:07 INFO - 'work_dir': 'build'} 10:14:07 INFO - ##### 10:14:07 INFO - ##### Running clobber step. 10:14:07 INFO - ##### 10:14:07 INFO - Running pre-action listener: _resource_record_pre_action 10:14:07 INFO - Running main action method: clobber 10:14:07 INFO - rmtree: /builds/slave/test/build 10:14:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:14:08 INFO - Running post-action listener: _resource_record_post_action 10:14:08 INFO - ##### 10:14:08 INFO - ##### Finished clobber step (success) 10:14:08 INFO - ##### 10:14:08 INFO - ##### 10:14:08 INFO - ##### Running read-buildbot-config step. 10:14:08 INFO - ##### 10:14:08 INFO - Running pre-action listener: _resource_record_pre_action 10:14:08 INFO - Running main action method: read_buildbot_config 10:14:08 INFO - Using buildbot properties: 10:14:08 INFO - { 10:14:08 INFO - "project": "", 10:14:08 INFO - "product": "firefox", 10:14:08 INFO - "script_repo_revision": "production", 10:14:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:14:08 INFO - "repository": "", 10:14:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:14:08 INFO - "buildid": "20160524092604", 10:14:08 INFO - "pgo_build": "False", 10:14:08 INFO - "basedir": "/builds/slave/test", 10:14:08 INFO - "buildnumber": 1778, 10:14:08 INFO - "slavename": "talos-linux64-ix-003", 10:14:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:14:08 INFO - "platform": "ubuntu64_hw", 10:14:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:14:08 INFO - "branch": "fx-team", 10:14:08 INFO - "repo_path": "integration/fx-team", 10:14:08 INFO - "revision": "fa6460853ebf5035fe0b05c11213f6eb4bb57ea2", 10:14:08 INFO - "stage_platform": "linux64", 10:14:08 INFO - "builduid": "5c6b412eaa7b41fb87abf9250d81b6ca", 10:14:08 INFO - "slavebuilddir": "test" 10:14:08 INFO - } 10:14:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 10:14:08 INFO - Running post-action listener: _resource_record_post_action 10:14:08 INFO - ##### 10:14:08 INFO - ##### Finished read-buildbot-config step (success) 10:14:08 INFO - ##### 10:14:08 INFO - ##### 10:14:08 INFO - ##### Running download-and-extract step. 10:14:08 INFO - ##### 10:14:08 INFO - Running pre-action listener: _resource_record_pre_action 10:14:08 INFO - Running main action method: download_and_extract 10:14:08 INFO - mkdir: /builds/slave/test/build/tests 10:14: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')]} 10:14:08 INFO - https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:14:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:14:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:14:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:14:08 INFO - Downloaded 1361 bytes. 10:14:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 10:14:08 INFO - Using the following test package requirements: 10:14:08 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:08 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:14:08 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:14:08 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:08 INFO - u'jsshell-linux-x86_64.zip'], 10:14:08 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:14:08 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:08 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:14:08 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:14:08 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:14:08 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:08 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:14:08 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:14: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')]} 10:14:08 INFO - https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:14:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:14:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:14:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:10 INFO - Downloaded 22844322 bytes. 10:14:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:14:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:14:11 INFO - Return code: 0 10:14:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:14:11 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')]} 10:14:11 INFO - https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:14:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:14:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:14:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 10:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:12 INFO - Downloaded 22844322 bytes. 10:14:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:14:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:14:14 INFO - Return code: 0 10:14: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')]} 10:14:14 INFO - https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:14:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:14:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:14:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 10:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:14:15 INFO - Downloaded 10840359 bytes. 10:14:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:14:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:14:15 INFO - Return code: 0 10:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:15 INFO - https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:14:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:14:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:14:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:14:17 INFO - Downloaded 54824893 bytes. 10:14:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:14:17 INFO - mkdir: /builds/slave/test/properties 10:14:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:14:17 INFO - Writing to file /builds/slave/test/properties/build_url 10:14:17 INFO - Contents: 10:14:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 10:14:17 INFO - Running post-action listener: _resource_record_post_action 10:14:17 INFO - Running post-action listener: set_extra_try_arguments 10:14:17 INFO - ##### 10:14:17 INFO - ##### Finished download-and-extract step (success) 10:14:17 INFO - ##### 10:14:17 INFO - ##### 10:14:17 INFO - ##### Running populate-webroot step. 10:14:17 INFO - ##### 10:14:17 INFO - Running pre-action listener: _resource_record_pre_action 10:14:17 INFO - Running main action method: populate_webroot 10:14:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:14:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:14:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:14:17 INFO - '--tppagecycles', 10:14:17 INFO - '7'], 10:14:17 INFO - 'tests': ['tsvgm']}}, 10:14:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:14:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:14:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:14:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:14:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:14:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:14:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:17 INFO - 'talos_options': ['--disable-e10s'], 10:14:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:17 INFO - 'talos_options': ['--disable-e10s'], 10:14:17 INFO - 'tests': ['damp', 'tps']}, 10:14:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:17 INFO - 'tests': ['damp', 'tps']}, 10:14:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:14:17 INFO - 'tests': ['dromaeo_dom']}, 10:14:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:14:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:14:17 INFO - 'tests': ['a11yr', 10:14:17 INFO - 'ts_paint', 10:14:17 INFO - 'tpaint', 10:14:17 INFO - 'sessionrestore', 10:14:17 INFO - 'sessionrestore_no_auto_restore', 10:14:17 INFO - 'tabpaint']}, 10:14:17 INFO - 'other-e10s': {'tests': ['a11yr', 10:14:17 INFO - 'ts_paint', 10:14:17 INFO - 'tpaint', 10:14:17 INFO - 'sessionrestore', 10:14:17 INFO - 'sessionrestore_no_auto_restore', 10:14:17 INFO - 'tabpaint']}, 10:14:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:14:17 INFO - 'ts_paint', 10:14:17 INFO - 'tpaint', 10:14:17 INFO - 'sessionrestore', 10:14:17 INFO - 'sessionrestore_no_auto_restore', 10:14:17 INFO - 'tabpaint']}, 10:14:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:14:17 INFO - 'ts_paint', 10:14:17 INFO - 'tpaint', 10:14:17 INFO - 'sessionrestore', 10:14:17 INFO - 'sessionrestore_no_auto_restore', 10:14:17 INFO - 'tabpaint']}, 10:14:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:14:17 INFO - 'tests': ['a11yr', 10:14:17 INFO - 'ts_paint', 10:14:17 INFO - 'tpaint', 10:14:17 INFO - 'sessionrestore', 10:14:17 INFO - 'sessionrestore_no_auto_restore', 10:14:17 INFO - 'tabpaint']}, 10:14:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:14:17 INFO - 'tests': ['a11yr', 10:14:17 INFO - 'ts_paint', 10:14:17 INFO - 'tpaint', 10:14:17 INFO - 'sessionrestore', 10:14:17 INFO - 'sessionrestore_no_auto_restore', 10:14:17 INFO - 'tabpaint']}, 10:14:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:14:17 INFO - 'tests': ['tsvgx', 10:14:17 INFO - 'tsvgr_opacity', 10:14:17 INFO - 'tart', 10:14:17 INFO - 'tscrollx', 10:14:17 INFO - 'cart']}, 10:14:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:14:17 INFO - 'tsvgr_opacity', 10:14:17 INFO - 'tart', 10:14:17 INFO - 'tscrollx', 10:14:17 INFO - 'cart']}, 10:14:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:17 INFO - 'talos_options': ['--disable-e10s'], 10:14:17 INFO - 'tests': ['tp5o']}, 10:14:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:17 INFO - 'tests': ['tp5o']}, 10:14:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:17 INFO - 'talos_options': ['--disable-e10s', 10:14:17 INFO - '--xperf_path', 10:14:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:17 INFO - 'tests': ['tp5n']}, 10:14:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:17 INFO - 'talos_options': ['--xperf_path', 10:14:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:17 INFO - 'tests': ['tp5n']}}, 10:14:17 INFO - 'talos.zip': {'path': '', 10:14:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:14:17 INFO - Running post-action listener: _resource_record_post_action 10:14:17 INFO - ##### 10:14:17 INFO - ##### Finished populate-webroot step (success) 10:14:17 INFO - ##### 10:14:17 INFO - ##### 10:14:17 INFO - ##### Running create-virtualenv step. 10:14:17 INFO - ##### 10:14:17 INFO - Running pre-action listener: _resource_record_pre_action 10:14:17 INFO - Running main action method: create_virtualenv 10:14:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:14:17 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 10:14:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:14:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:14:17 INFO - Using real prefix '/usr' 10:14:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:14:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:14:20 INFO - Installing pip.................done. 10:14:20 INFO - Return code: 0 10:14:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8066af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c239c0>, '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 0x1c248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24d50>, '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': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', '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 10:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:14:20 INFO - Using env: {'DISPLAY': ':0', 10:14:20 INFO - 'HOME': '/home/cltbld', 10:14:20 INFO - 'LANG': 'en_US.UTF-8', 10:14:20 INFO - 'LANGUAGE': 'en_US:en', 10:14:20 INFO - 'LOGNAME': 'cltbld', 10:14:20 INFO - 'MAIL': '/var/mail/cltbld', 10:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:20 INFO - 'MOZ_NO_REMOTE': '1', 10:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:20 INFO - 'NO_EM_RESTART': '1', 10:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:20 INFO - 'PWD': '/builds/slave/test', 10:14:20 INFO - 'SHELL': '/bin/bash', 10:14:20 INFO - 'SHLVL': '1', 10:14:20 INFO - 'TERM': 'linux', 10:14:20 INFO - 'TMOUT': '86400', 10:14:20 INFO - 'USER': 'cltbld', 10:14:20 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', 10:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:20 INFO - '_': '/tools/buildbot/bin/python'} 10:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:20 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 10:14:20 INFO - Cleaning up... 10:14:20 INFO - Return code: 0 10:14:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8066af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c239c0>, '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 0x1c248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24d50>, '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': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', '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 10:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:14:20 INFO - Using env: {'DISPLAY': ':0', 10:14:20 INFO - 'HOME': '/home/cltbld', 10:14:20 INFO - 'LANG': 'en_US.UTF-8', 10:14:20 INFO - 'LANGUAGE': 'en_US:en', 10:14:20 INFO - 'LOGNAME': 'cltbld', 10:14:20 INFO - 'MAIL': '/var/mail/cltbld', 10:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:20 INFO - 'MOZ_NO_REMOTE': '1', 10:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:20 INFO - 'NO_EM_RESTART': '1', 10:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:20 INFO - 'PWD': '/builds/slave/test', 10:14:20 INFO - 'SHELL': '/bin/bash', 10:14:20 INFO - 'SHLVL': '1', 10:14:20 INFO - 'TERM': 'linux', 10:14:20 INFO - 'TMOUT': '86400', 10:14:20 INFO - 'USER': 'cltbld', 10:14:20 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', 10:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:20 INFO - '_': '/tools/buildbot/bin/python'} 10:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:20 INFO - Downloading/unpacking psutil>=3.1.1 10:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:22 INFO - Installing collected packages: psutil 10:14:22 INFO - Running setup.py install for psutil 10:14:22 INFO - building 'psutil._psutil_linux' extension 10:14:22 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 10:14:23 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 10:14:23 INFO - building 'psutil._psutil_posix' extension 10:14:23 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 10:14:23 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 10:14:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:23 INFO - Successfully installed psutil 10:14:23 INFO - Cleaning up... 10:14:23 INFO - Return code: 0 10:14:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8066af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c239c0>, '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 0x1c248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24d50>, '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': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', '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 10:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:14:23 INFO - Using env: {'DISPLAY': ':0', 10:14:23 INFO - 'HOME': '/home/cltbld', 10:14:23 INFO - 'LANG': 'en_US.UTF-8', 10:14:23 INFO - 'LANGUAGE': 'en_US:en', 10:14:23 INFO - 'LOGNAME': 'cltbld', 10:14:23 INFO - 'MAIL': '/var/mail/cltbld', 10:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:23 INFO - 'MOZ_NO_REMOTE': '1', 10:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:23 INFO - 'NO_EM_RESTART': '1', 10:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:23 INFO - 'PWD': '/builds/slave/test', 10:14:23 INFO - 'SHELL': '/bin/bash', 10:14:23 INFO - 'SHLVL': '1', 10:14:23 INFO - 'TERM': 'linux', 10:14:23 INFO - 'TMOUT': '86400', 10:14:23 INFO - 'USER': 'cltbld', 10:14:23 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', 10:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:23 INFO - '_': '/tools/buildbot/bin/python'} 10:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:14:25 INFO - Installing collected packages: mozsystemmonitor 10:14:25 INFO - Running setup.py install for mozsystemmonitor 10:14:25 INFO - Successfully installed mozsystemmonitor 10:14:25 INFO - Cleaning up... 10:14:25 INFO - Return code: 0 10:14:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:14:25 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')]} 10:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:25 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')]} 10:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:25 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 0x7fae8066af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c239c0>, '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 0x1c248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24d50>, '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': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', '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 10:14:25 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 10:14:25 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 10:14:25 INFO - Using env: {'DISPLAY': ':0', 10:14:25 INFO - 'HOME': '/home/cltbld', 10:14:25 INFO - 'LANG': 'en_US.UTF-8', 10:14:25 INFO - 'LANGUAGE': 'en_US:en', 10:14:25 INFO - 'LOGNAME': 'cltbld', 10:14:25 INFO - 'MAIL': '/var/mail/cltbld', 10:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:25 INFO - 'MOZ_NO_REMOTE': '1', 10:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:25 INFO - 'NO_EM_RESTART': '1', 10:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:25 INFO - 'PWD': '/builds/slave/test', 10:14:25 INFO - 'SHELL': '/bin/bash', 10:14:25 INFO - 'SHLVL': '1', 10:14:25 INFO - 'TERM': 'linux', 10:14:25 INFO - 'TMOUT': '86400', 10:14:25 INFO - 'USER': 'cltbld', 10:14:25 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', 10:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:25 INFO - '_': '/tools/buildbot/bin/python'} 10:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:25 INFO - Downloading/unpacking blobuploader==1.2.4 10:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:27 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14:27 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 10:14:27 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 10:14:27 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 10:14:27 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 10:14:27 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 10:14:27 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 10:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:14:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:28 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 10:14:28 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 10:14:28 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 10:14:28 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 10:14:28 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 10:14:28 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 10:14:28 INFO - Downloading docopt-0.6.1.tar.gz 10:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:28 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:28 INFO - Running setup.py install for blobuploader 10:14:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:14:28 INFO - Running setup.py install for requests 10:14:29 INFO - Running setup.py install for docopt 10:14:29 INFO - Successfully installed blobuploader requests docopt 10:14:29 INFO - Cleaning up... 10:14:29 INFO - Return code: 0 10:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:29 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')]} 10:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:29 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')]} 10:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:29 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 0x7fae8066af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c239c0>, '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 0x1c248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24d50>, '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': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', '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 10:14:29 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 10:14:29 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 10:14:29 INFO - Using env: {'DISPLAY': ':0', 10:14:29 INFO - 'HOME': '/home/cltbld', 10:14:29 INFO - 'LANG': 'en_US.UTF-8', 10:14:29 INFO - 'LANGUAGE': 'en_US:en', 10:14:29 INFO - 'LOGNAME': 'cltbld', 10:14:29 INFO - 'MAIL': '/var/mail/cltbld', 10:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:29 INFO - 'MOZ_NO_REMOTE': '1', 10:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:29 INFO - 'NO_EM_RESTART': '1', 10:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:29 INFO - 'PWD': '/builds/slave/test', 10:14:29 INFO - 'SHELL': '/bin/bash', 10:14:29 INFO - 'SHLVL': '1', 10:14:29 INFO - 'TERM': 'linux', 10:14:29 INFO - 'TMOUT': '86400', 10:14:29 INFO - 'USER': 'cltbld', 10:14:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', 10:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:29 INFO - '_': '/tools/buildbot/bin/python'} 10:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:29 INFO - Running setup.py (path:/tmp/pip-cpOSgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:29 INFO - Running setup.py (path:/tmp/pip-5cekRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:29 INFO - Running setup.py (path:/tmp/pip-F78khQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:29 INFO - Running setup.py (path:/tmp/pip-5oM2a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:29 INFO - Running setup.py (path:/tmp/pip-OyfoBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:29 INFO - Running setup.py (path:/tmp/pip-UXjkjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:29 INFO - Running setup.py (path:/tmp/pip-y13dn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:29 INFO - Running setup.py (path:/tmp/pip-Yg8rGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:29 INFO - Running setup.py (path:/tmp/pip-yqvH9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:30 INFO - Running setup.py (path:/tmp/pip-5SqIBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:30 INFO - Running setup.py (path:/tmp/pip-jM6TUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:30 INFO - Running setup.py (path:/tmp/pip-SzoVbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:30 INFO - Running setup.py (path:/tmp/pip-73BP5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:30 INFO - Running setup.py (path:/tmp/pip-Rp1_wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:30 INFO - Running setup.py (path:/tmp/pip-ALLait-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:30 INFO - Running setup.py (path:/tmp/pip-uctlYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:30 INFO - Running setup.py (path:/tmp/pip-KgxXb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:30 INFO - Running setup.py install for manifestparser 10:14:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:14:30 INFO - Running setup.py install for mozcrash 10:14:30 INFO - Running setup.py install for mozdebug 10:14:30 INFO - Running setup.py install for mozdevice 10:14:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Running setup.py install for mozfile 10:14:31 INFO - Running setup.py install for mozhttpd 10:14:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Running setup.py install for mozinfo 10:14:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Running setup.py install for mozInstall 10:14:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Running setup.py install for mozleak 10:14:31 INFO - Running setup.py install for mozlog 10:14:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Running setup.py install for moznetwork 10:14:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Running setup.py install for mozprocess 10:14:31 INFO - Running setup.py install for mozprofile 10:14:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:14:31 INFO - Running setup.py install for mozrunner 10:14:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:14:32 INFO - Running setup.py install for mozscreenshot 10:14:32 INFO - Running setup.py install for moztest 10:14:32 INFO - Running setup.py install for mozversion 10:14:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:14:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:32 INFO - Cleaning up... 10:14:32 INFO - Return code: 0 10:14:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:32 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')]} 10:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:32 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')]} 10:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:32 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 0x7fae8066af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c239c0>, '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 0x1c248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24d50>, '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': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', '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 10:14:32 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 10:14:32 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 10:14:32 INFO - Using env: {'DISPLAY': ':0', 10:14:32 INFO - 'HOME': '/home/cltbld', 10:14:32 INFO - 'LANG': 'en_US.UTF-8', 10:14:32 INFO - 'LANGUAGE': 'en_US:en', 10:14:32 INFO - 'LOGNAME': 'cltbld', 10:14:32 INFO - 'MAIL': '/var/mail/cltbld', 10:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:32 INFO - 'MOZ_NO_REMOTE': '1', 10:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:32 INFO - 'NO_EM_RESTART': '1', 10:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:32 INFO - 'PWD': '/builds/slave/test', 10:14:32 INFO - 'SHELL': '/bin/bash', 10:14:32 INFO - 'SHLVL': '1', 10:14:32 INFO - 'TERM': 'linux', 10:14:32 INFO - 'TMOUT': '86400', 10:14:32 INFO - 'USER': 'cltbld', 10:14:32 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', 10:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:32 INFO - '_': '/tools/buildbot/bin/python'} 10:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:32 INFO - Running setup.py (path:/tmp/pip-4hCszj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:32 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)) 10:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:32 INFO - Running setup.py (path:/tmp/pip-JBYTnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:32 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)) 10:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:32 INFO - Running setup.py (path:/tmp/pip-ACFNoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:32 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)) 10:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:32 INFO - Running setup.py (path:/tmp/pip-5zMNG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:32 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)) 10:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:32 INFO - Running setup.py (path:/tmp/pip-V5nQ_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:32 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)) 10:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:32 INFO - Running setup.py (path:/tmp/pip-UOyGj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:33 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)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:33 INFO - Running setup.py (path:/tmp/pip-NmNMDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:33 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)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:33 INFO - Running setup.py (path:/tmp/pip-S_gUJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:33 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)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:33 INFO - Running setup.py (path:/tmp/pip-wsV7SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:33 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)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:33 INFO - Running setup.py (path:/tmp/pip-MvwsDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:33 INFO - Running setup.py (path:/tmp/pip-l8ZgOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:33 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)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:33 INFO - Running setup.py (path:/tmp/pip-1bGXMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:33 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)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:33 INFO - Running setup.py (path:/tmp/pip-BUrJpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:33 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)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:33 INFO - Running setup.py (path:/tmp/pip-DDEJcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:33 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)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:33 INFO - Running setup.py (path:/tmp/pip-ucpugD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:33 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)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:33 INFO - Running setup.py (path:/tmp/pip-flWbtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:33 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)) 10:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:33 INFO - Running setup.py (path:/tmp/pip-hBMCMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:33 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)) 10:14:33 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)) 10:14:33 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)) 10:14:33 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)) 10:14:33 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)) 10:14:33 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)) 10:14:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:35 INFO - Downloading blessings-1.6.tar.gz 10:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:35 INFO - Installing collected packages: blessings 10:14:35 INFO - Running setup.py install for blessings 10:14:35 INFO - Successfully installed blessings 10:14:35 INFO - Cleaning up... 10:14:35 INFO - Return code: 0 10:14:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:14:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:36 INFO - Reading from file tmpfile_stdout 10:14:36 INFO - Current package versions: 10:14:36 INFO - argparse == 1.2.1 10:14:36 INFO - blessings == 1.6 10:14:36 INFO - blobuploader == 1.2.4 10:14:36 INFO - docopt == 0.6.1 10:14:36 INFO - manifestparser == 1.1 10:14:36 INFO - mozInstall == 1.12 10:14:36 INFO - mozcrash == 0.17 10:14:36 INFO - mozdebug == 0.1 10:14:36 INFO - mozdevice == 0.48 10:14:36 INFO - mozfile == 1.2 10:14:36 INFO - mozhttpd == 0.7 10:14:36 INFO - mozinfo == 0.9 10:14:36 INFO - mozleak == 0.1 10:14:36 INFO - mozlog == 3.2 10:14:36 INFO - moznetwork == 0.27 10:14:36 INFO - mozprocess == 0.22 10:14:36 INFO - mozprofile == 0.28 10:14:36 INFO - mozrunner == 6.11 10:14:36 INFO - mozscreenshot == 0.1 10:14:36 INFO - mozsystemmonitor == 0.3 10:14:36 INFO - moztest == 0.7 10:14:36 INFO - mozversion == 1.4 10:14:36 INFO - psutil == 3.1.1 10:14:36 INFO - requests == 1.2.3 10:14:36 INFO - wsgiref == 0.1.2 10:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 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 0x7fae8066af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c239c0>, '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 0x1c248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24d50>, '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': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', '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 10:14:36 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 10:14:36 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 10:14:36 INFO - Using env: {'DISPLAY': ':0', 10:14:36 INFO - 'HOME': '/home/cltbld', 10:14:36 INFO - 'LANG': 'en_US.UTF-8', 10:14:36 INFO - 'LANGUAGE': 'en_US:en', 10:14:36 INFO - 'LOGNAME': 'cltbld', 10:14:36 INFO - 'MAIL': '/var/mail/cltbld', 10:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:36 INFO - 'MOZ_NO_REMOTE': '1', 10:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:36 INFO - 'NO_EM_RESTART': '1', 10:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:36 INFO - 'PWD': '/builds/slave/test', 10:14:36 INFO - 'SHELL': '/bin/bash', 10:14:36 INFO - 'SHLVL': '1', 10:14:36 INFO - 'TERM': 'linux', 10:14:36 INFO - 'TMOUT': '86400', 10:14:36 INFO - 'USER': 'cltbld', 10:14:36 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', 10:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:36 INFO - '_': '/tools/buildbot/bin/python'} 10:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:36 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)) 10:14:36 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)) 10:14:36 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)) 10:14:36 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)) 10:14:36 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)) 10:14:36 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)) 10:14:36 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)) 10:14:36 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)) 10:14:36 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)) 10:14:36 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)) 10:14:36 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)) 10:14:36 INFO - Cleaning up... 10:14:36 INFO - Return code: 0 10:14:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8066af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c239c0>, '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 0x1c248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24d50>, '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': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', '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 10:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:14:36 INFO - Using env: {'DISPLAY': ':0', 10:14:36 INFO - 'HOME': '/home/cltbld', 10:14:36 INFO - 'LANG': 'en_US.UTF-8', 10:14:36 INFO - 'LANGUAGE': 'en_US:en', 10:14:36 INFO - 'LOGNAME': 'cltbld', 10:14:36 INFO - 'MAIL': '/var/mail/cltbld', 10:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:36 INFO - 'MOZ_NO_REMOTE': '1', 10:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:36 INFO - 'NO_EM_RESTART': '1', 10:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:36 INFO - 'PWD': '/builds/slave/test', 10:14:36 INFO - 'SHELL': '/bin/bash', 10:14:36 INFO - 'SHLVL': '1', 10:14:36 INFO - 'TERM': 'linux', 10:14:36 INFO - 'TMOUT': '86400', 10:14:36 INFO - 'USER': 'cltbld', 10:14:36 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', 10:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:36 INFO - '_': '/tools/buildbot/bin/python'} 10:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:36 INFO - Downloading/unpacking jsonschema 10:14:36 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 10:14:36 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 10:14:36 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 10:14:36 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 10:14:36 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 10:14:36 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 10:14:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:38 INFO - Downloading/unpacking functools32 (from jsonschema) 10:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:38 INFO - warning: no files found matching '*.txt' 10:14:38 INFO - no previously-included directories found matching 'build' 10:14:38 INFO - no previously-included directories found matching 'dist' 10:14:38 INFO - no previously-included directories found matching '.git*' 10:14:38 INFO - Installing collected packages: jsonschema, functools32 10:14:38 INFO - Running setup.py install for functools32 10:14:38 INFO - warning: no files found matching '*.txt' 10:14:38 INFO - no previously-included directories found matching 'build' 10:14:38 INFO - no previously-included directories found matching 'dist' 10:14:38 INFO - no previously-included directories found matching '.git*' 10:14:38 INFO - Successfully installed jsonschema functools32 10:14:38 INFO - Cleaning up... 10:14:39 INFO - Return code: 0 10:14:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae8066af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b94770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c239c0>, '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 0x1c248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24d50>, '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': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', '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 10:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:14:39 INFO - Using env: {'DISPLAY': ':0', 10:14:39 INFO - 'HOME': '/home/cltbld', 10:14:39 INFO - 'LANG': 'en_US.UTF-8', 10:14:39 INFO - 'LANGUAGE': 'en_US:en', 10:14:39 INFO - 'LOGNAME': 'cltbld', 10:14:39 INFO - 'MAIL': '/var/mail/cltbld', 10:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:39 INFO - 'MOZ_NO_REMOTE': '1', 10:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:39 INFO - 'NO_EM_RESTART': '1', 10:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:39 INFO - 'PWD': '/builds/slave/test', 10:14:39 INFO - 'SHELL': '/bin/bash', 10:14:39 INFO - 'SHLVL': '1', 10:14:39 INFO - 'TERM': 'linux', 10:14:39 INFO - 'TMOUT': '86400', 10:14:39 INFO - 'USER': 'cltbld', 10:14:39 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', 10:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:39 INFO - '_': '/tools/buildbot/bin/python'} 10:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:39 INFO - Downloading/unpacking flake8 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:14:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:14:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:14:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:41 INFO - no previously-included directories found matching 'docs/_build' 10:14:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:14:41 INFO - Running setup.py install for pep8 10:14:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:14:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:14:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:14:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:14:42 INFO - no previously-included directories found matching 'docs/_build' 10:14:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:14:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:14:42 INFO - Cleaning up... 10:14:42 INFO - Return code: 0 10:14:42 INFO - Running post-action listener: _resource_record_post_action 10:14:42 INFO - Running post-action listener: _start_resource_monitoring 10:14:42 INFO - Starting resource monitoring. 10:14:42 INFO - ##### 10:14:42 INFO - ##### Finished create-virtualenv step (success) 10:14:42 INFO - ##### 10:14:42 INFO - ##### 10:14:42 INFO - ##### Running install step. 10:14:42 INFO - ##### 10:14:42 INFO - Running pre-action listener: _resource_record_pre_action 10:14:42 INFO - Running main action method: install 10:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:42 INFO - Reading from file tmpfile_stdout 10:14:42 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:14:42 INFO - Reading from file tmpfile_stdout 10:14:42 INFO - Output received: 10:14:42 INFO - Usage: mozinstall [options] installer 10:14:42 INFO - Options: 10:14:42 INFO - -h, --help show this help message and exit 10:14:42 INFO - -d DEST, --destination=DEST 10:14:42 INFO - Directory to install application into. [default: 10:14:42 INFO - "/builds/slave/test"] 10:14:42 INFO - --app=APP Application being installed. [default: firefox] 10:14:42 INFO - mkdir: /builds/slave/test/build/application 10:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:14:58 INFO - Reading from file tmpfile_stdout 10:14:58 INFO - Output received: 10:14:58 INFO - /builds/slave/test/build/application/firefox/firefox 10:14:58 INFO - Running post-action listener: _resource_record_post_action 10:14:58 INFO - ##### 10:14:58 INFO - ##### Finished install step (success) 10:14:58 INFO - ##### 10:14:58 INFO - ##### 10:14:58 INFO - ##### Running run-tests step. 10:14:58 INFO - ##### 10:14:58 INFO - Running pre-action listener: _resource_record_pre_action 10:14:58 INFO - Running main action method: run_tests 10:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:14:58 INFO - Python 2.7.3 10:14:58 INFO - Return code: 0 10:14:58 INFO - grabbing minidump binary from tooltool 10:14:58 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')]} 10:14:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c239c0>, '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 0x1c248c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c24d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:14:58 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 10:14:58 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 10:14:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:14:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:58 INFO - Return code: 0 10:14:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:14:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:14:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:14:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:14:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:14:59 INFO - Return code: 0 10:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:14:59 INFO - Using env: {'DISPLAY': ':0', 10:14:59 INFO - 'HOME': '/home/cltbld', 10:14:59 INFO - 'LANG': 'en_US.UTF-8', 10:14:59 INFO - 'LANGUAGE': 'en_US:en', 10:14:59 INFO - 'LOGNAME': 'cltbld', 10:14:59 INFO - 'MAIL': '/var/mail/cltbld', 10:14:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:14:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:59 INFO - 'MOZ_NO_REMOTE': '1', 10:14:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:59 INFO - 'NO_EM_RESTART': '1', 10:14:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:59 INFO - 'PWD': '/builds/slave/test', 10:14:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:14:59 INFO - 'SHELL': '/bin/bash', 10:14:59 INFO - 'SHLVL': '1', 10:14:59 INFO - 'TERM': 'linux', 10:14:59 INFO - 'TMOUT': '86400', 10:14:59 INFO - 'USER': 'cltbld', 10:14:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1464110045.945450-2117122449', 10:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:59 INFO - '_': '/tools/buildbot/bin/python'} 10:14:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:14:59 INFO - mozversion application_buildid: 20160524092604 10:14:59 INFO - mozversion application_changeset: fa6460853ebf5035fe0b05c11213f6eb4bb57ea2 10:14:59 INFO - mozversion application_display_name: Nightly 10:14:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:59 INFO - mozversion application_name: Firefox 10:14:59 INFO - mozversion application_remotingname: firefox 10:14:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:14:59 INFO - mozversion application_vendor: Mozilla 10:14:59 INFO - mozversion application_version: 49.0a1 10:14:59 INFO - mozversion platform_buildid: 20160524092604 10:14:59 INFO - mozversion platform_changeset: fa6460853ebf5035fe0b05c11213f6eb4bb57ea2 10:14:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:14:59 INFO - mozversion platform_version: 49.0a1 10:14:59 INFO - using testdate: 1464110099 10:14:59 INFO - actual date: 1464110099 10:14:59 INFO - starting webserver on 'localhost:47796' 10:14:59 INFO - SUITE-START | Running 2 tests 10:14:59 INFO - TEST-START | dromaeo_css 10:14:59 INFO - operating with platform_type : linux_ 10:14:59 INFO - Initialising browser for dromaeo_css test... 10:14:59 INFO - TEST-INFO | started process 14445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpemU4qT/profile http://localhost:47796/getInfo.html) 10:15:04 INFO - PROCESS | 14445 | __metrics Screen width/height:1600/1200 10:15:04 INFO - PROCESS | 14445 | colorDepth:24 10:15:04 INFO - PROCESS | 14445 | Browser inner width/height: 1024/697 10:15:04 INFO - PROCESS | 14445 | __metrics 10:15:05 ERROR - PROCESS | 14445 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:15:06 INFO - TEST-INFO | 14445: exit 0 10:15:06 INFO - Browser initialized. 10:15:06 INFO - Running cycle 1/1 for dromaeo_css test... 10:15:06 INFO - TEST-INFO | started process 14525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpemU4qT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:18 INFO - PROCESS | 14525 | RSS: Main: 154591232 10:15:18 INFO - PROCESS | 14525 | 10:16:10 INFO - PROCESS | 14525 | 1464110170018 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] 10:18:21 INFO - PROCESS | 14525 | Cycle 1(1): loaded http://localhost:47796/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47796/tests/dromaeo/cssquery-ext.html) 10:18:22 INFO - PROCESS | 14525 | RSS: Main: 267485184 10:18:22 INFO - PROCESS | 14525 | 10:21:25 INFO - PROCESS | 14525 | Cycle 1(1): loaded http://localhost:47796/tests/dromaeo/cssquery-ext.html (next: http://localhost:47796/tests/dromaeo/cssquery-jquery.html) 10:21:25 INFO - PROCESS | 14525 | RSS: Main: 235110400 10:21:25 INFO - PROCESS | 14525 | 10:24:27 INFO - PROCESS | 14525 | Cycle 1(1): loaded http://localhost:47796/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47796/tests/dromaeo/cssquery-mootools.html) 10:24:28 INFO - PROCESS | 14525 | RSS: Main: 240594944 10:24:28 INFO - PROCESS | 14525 | 10:27:30 INFO - PROCESS | 14525 | Cycle 1(1): loaded http://localhost:47796/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47796/tests/dromaeo/cssquery-prototype.html) 10:27:31 INFO - PROCESS | 14525 | RSS: Main: 229158912 10:27:31 INFO - PROCESS | 14525 | 10:30:34 INFO - PROCESS | 14525 | Cycle 1(1): loaded http://localhost:47796/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47796/tests/dromaeo/cssquery-yui.html) 10:30:34 INFO - PROCESS | 14525 | RSS: Main: 225792000 10:30:34 INFO - PROCESS | 14525 | 10:33:37 INFO - PROCESS | 14525 | Cycle 1(1): loaded http://localhost:47796/tests/dromaeo/cssquery-yui.html (next: http://localhost:47796/tests/dromaeo/cssquery-dojo.html) 10:33:37 INFO - PROCESS | 14525 | RSS: Main: 288038912 10:33:37 INFO - PROCESS | 14525 | 10:33:37 INFO - PROCESS | 14525 | __start_tp_report 10:33:37 INFO - PROCESS | 14525 | _x_x_mozilla_page_load 10:33:37 INFO - PROCESS | 14525 | _x_x_mozilla_page_load_details 10:33:37 INFO - PROCESS | 14525 | |i|pagename|runs| 10:33:37 INFO - PROCESS | 14525 | |0;dojo.html;2683.329167708073;2693.461307738453;2721.3396136037045;2730.604062410949;2747.574126010468;4661.30080487927;4690.484046754854;4696.248600223965;4762.59517940975;4804.90390192196;4731.361266229058;4745.454272758634;4762.714237145774;4785.880352991177;4833.202521583943;4346.652267818583;4352.238358287287;4368.191884501377;4400.845970391029;4478.955210447886;4391.824327026915;4450.376947227391;4488.438945131858;4521.864344069683;4529.275315949449;4281.978590107061;4447.221736196153;4460.130274596455;4478.484974227973;4489.326601009842;4301.677374196947;4337.826486940518;4361.978190109061;4363.890902727458;4385.802638881258;4341.956580434218;4396.846110386121;4405.074934263776;4422.027154026141;4454.109178164348;4592.609628181609;4740.336352910595;4749.762511874393;4752.382190315271;4772.403449568804;5084.644074914758;5124.461931497213;5139.820106296262;5159.406668233164;5206.843794686166;5186.559142472895;5207.244949482304;5210.400803907562;5230.372355317386;5241.764120614582;4624.398828152386;4745.762711864393;4820.6143508519235;4848.369711937426;4850.6362022848425;5216.061109000417;5234.895302093937;5307.363116425976;5313.946860531345;5315.202719592092;5037.168867136881;5040.294358789773;5078.289039534468;5082.059818933509;5090.261912022736;4943.382077240345;5126.512981266774;5139.408967968657;5165.48345165488;5181.896362072737;5113.795448182105;5132.512411320993;5139.743012849342;5142.1772516397195;5165.819196328111;5114.539691427789;5125.308083408767;5126.743662816844;5130.948155628087;5180;4234.153169366139;4263.296556068214;4296.398504209413;4350.608445239944;4403.8238470461465;3780.4896338993885;3782.243551289753;3790.6967442604528;3826.100866296418;3859.980700096538;4442.355858400579;4445.644348452116;4453.576910193527;4490.034642551802;4496.437945256843;4982.800687972513;5056.418511871108;5111.846644600593;5129.333186685707;5147.3308469898675;4455.6658250631335;4474.709143905636;4504.977475112603;4520.276755719069;4526.117407105583;4661.95338046622;4670.976645116821;4672.74299913508;4674.5325467452985;4716.103940251342;4662.580367766782;4794.328793968777;4830.033993201304;4846.733429661403;4863.173260545645;5130.461301563431;5133.640645154804;5133.666311689728;5142.845714628567;5165.560927321069;4779.211430113992;4825.203841366276;4831.541003604652;4844.685095468783;4864.92702609454;4903.0193961208615;4997.525235102659;5020.824271150492;5025.773840177128;5077.213031980049;5075.644704870623;5095.388553373471;5105.055564720538;5105.463926287686;5150.1502252127975;4953.529414705597;4971.353724015855;4974.17926042199;4974.37820272466;4984.576311013604;4836.12949669063;4884.462709101925;4890.2909078184175;4893.143699852582;4913.950860491493;4815.807367705393;4845.636577256791;4885;4904.485029071896;4919.950800491949;4835.274708793709;4956.82651107224;4966.801327946986;5006.349174607278;5019.02129084825;4853.563179313879;4895.681780684244;4905.190643543775;4919.0407870464915;4923.803047878045 10:33:37 INFO - PROCESS | 14525 | |1;ext.html;545.3673738463383;591.6952769323798;604.85181130623;606.6299557270064;610.8137018209444;40300.39549406761;41589.79205103974;41621;41630.16739665205;45995.54004459955;39051.21897562047;39424;39425.80287098561;39525.60474395255;39740.60259397405;7802.882956755639;7968.362530997506;7975.202479752007;7979.0824055233525;7989.680412783482;7825.413094017943;7921.2474814892785;7925.405594580429;7927.603619819015;7931.24653157952;7841.9215807841765;7951;7968.920310796876;7969.880451793228;7971.521708697497;7888.6844526219165;7939.920600794005;7949.801254968672;7963.3231175350165;7965.641546130438;7824.726134585262;7898.210178982114;7909.683612655487;7915.12933577306;7927.405444591679;39152.21695566101;39525.209495809926;39646.40530392047;39703;39706.80146599277;3063.448579255733;3294.7199488043543;3387.44107222308;3423.8972830815114;3609.205974685565;29490.410191796258;29872.850635746898;30650.23374415635;30827.229319266975;30911.84544077288;3498.6151523332414;3550.3254381667402;3568.7680300780366;3606.441001644749;3661.5972243053243;268629;268663;269751;270508.6474567634;271046;32434.189145271084;55066.17400738992;55754;55801;55829.44170558242;33282.500762488584;35272.11819704528;35308.82345588256;35328.29343413117;35332.116697082776;12598.307093109783;12741.49034038628;12762;12764.936175319064;12768.489260429664;10296.588136474607;10318.793624127475;10345.793084138275;10350.637727679647;10351.689449316533;8046.235607617267;8092.635831387602;8101.756947291591;8188.672453101809;8217.383696222807;3121.3913286908833;3127.56214130022;3153.0698443959086;3164.477861152884;3167.889123880699;895.5119459894242;927.3184209605935;933.7385532051037;934.4813628436283;1019.0879163148941;27945.580816287773;28590.857045714638;28669.139925802257;28996.42007159845;29078.563821542695;808.7937575918103;981.906718861707;995.2833959549113;1008.3798463944621;1099.5162128663362;14789.408423663148;14928;15055.322510487054;15307.693846123015;15335.386584536494;391974;393541;393886;395269;395631;49451.752741236065;49983.75008124936;50029.49970500321;50165.74917125391;50175;1096.2545469081101;1150.1603829204728;1194.6236935365332;1195.910306726999;1214.0954988533776;28804.567931480626;29742.702572973994;29811.70188298089;30052.398952021274;30684.232894177825;43433.3484997719;43511.12977740491;43884.341734873364;43980.78009609931;44001.55998439975;302761;302836;305057;305282;349870;25297.62053569161;25868.741312586633;25918.740812591634;27395.178144655692;27401;42520.5747942529;42833.57166428296;42909.785451072545;43573.782131089145;43613.78193109014;35968.28063438664;36941.26117477689;37380.43929341117;37463;37493.81253093717;35816.283674326885;36277.455838162976;36854.8157259212;36976.81511592425;37001.44497832588;35915.820420897726;35984.28031439409;36136.27727445489;36804.63195368119;36889.44665829961;32619;33136.668633313355;33407.66592334046;33801;33841.32317353688;25431.745682542936;25666.358341041625;25814.483710325312;26047.32167292782;26057.478850423264 10:33:37 INFO - PROCESS | 14525 | |2;jquery.html;360.6970145078134;362.45631552670994;368.9483472313878;372.6385406156028;374.543057469887;15658.138802365866;16899.23953422096;17068;17409.91295043526;17815.643687126267;16240.431584894532;16335.26491307891;17148.399806006793;17158.142092895367;17176.141192940366;4985.326980857583;5161.664491808039;5172.508611681884;5200.635955483118;5220.321358223445;3675.650813172744;3823.3309170895122;5111.7699703513435;5624.803131890385;5926.111083337512;5920.378360272174;5959.284885813709;5989.0417533194695;5991.910121348184;5994.370591087938;5835.183074369592;5861.296644402678;5934.43622855828;5961.165436838846;6002.369751176151;3322.2857085726687;4859.757012149378;5160.277561141444;5164.483551644806;5172.58619310458;19974.300899468595;20599.279025234046;20624.27815026467;20740.792592074038;20753.169873205054;1934.8161924617139;2103.831693464519;2241.60771864923;2453.2640207937725;2503.9749602503925;11575.710607234802;12873.163244389085;13251.138675986127;13728.176309421468;13758.31208439574;1722.2336060453104;1725.4996051145279;1735.9392421265195;1809.3757653609484;1817.6728188925988;64197.67901160511;64802.3519764801;65344.67327663379;66420.6678966602;66580;8833.60248788806;8851;9125.634974601075;9532;9558.474283914313;11956.760864782656;12031.014882544458;12054.879451205376;12061;12061.457234424472;6960.65196740161;7056.1179852518435;7071.222165561784;7160.606166660884;7193.244709305448;6780.694868730919;6806.863862722717;6896.379400814612;6903.102596662502;6961.860762784716;6035.185249991283;6035.336113027563;6105.175801266861;6123.785667501616;6182.227221597301;1561.8360072192256;1634.525987463646;1640.491447651232;1667.9984019177036;1766.629007908328;851.5784686580182;868.0408148995396;875.2385424680568;901.0718959471754;960.279790157382;16212.59468513273;16855.410060648064;17165.82834171667;17302.740458893128;17552;927.4759760735163;930.9255259579218;935.8783358163395;972.8492083727034;995.8605795188535;9853;10055.949720251352;10195.082442580204;10197.898021019842;10213.693589192337;370252;371223;373730;374003;387777;64450.355496444434;66551.33448665548;66669.33330666632;67740.6612966932;67834.32165678378;961.053362437998;970.4129001953858;1002.8094662014194;1013.6705570689555;1020.3469779341227;15360.308786104875;15366.231688415759;15396.84603153999;15488.599267113164;15788.500092491195;32991.50512742263;33098.66901331052;33118.337633247684;33129;33446.49830252597;44570;44570.77714611406;44619;44763.77618111888;44776.77611611921;7448.888266676113;7565.167831538636;7632.732854350071;7675.654595543326;7685.077790664933;7465.141508726566;8837.983631882416;10286.434246116536;11069.169812263952;11112.722181945515;8926.464412135292;9670.274729395464;9795.559199835881;9803.16673082796;9994.550245239127;9677.951610241904;9827.803443930938;9976.750581235527;10008.349457285252;10033.799324013626;9874.802503950024;9910.702678919355;10062.295639305472;10250.743731406774;10432.739181520523;7226.783196504113;7377.151627562685;7398;7456.105267367951;7507.549547027196;10083.092521673085;10102.797944041225;10122.746931326776;10124.746881328027;10370.637027703995 10:33:37 INFO - PROCESS | 14525 | |3;mootools.html;1213.7269114449255;1400.4328247059939;1455.2360010994228;1530.3343045775089;1738.0875040603682;6933.583984960899;7727.072751269849;7957.164497727742;7964.721234756785;8232.217939295757;8010.39922005849;8158.551279679616;8193.754187374388;8197.467164634294;8206.466579672317;1903.8667293289475;2159.6112699714045;2219.5893759654514;2235.3740952533317;2261.9095236190533;2279.6466547685054;2298.8620682759006;2301.723793144825;2307.6884620576175;2309.2725791375747;2173.5435558532727;2194.9341519754435;2203.526241858;2208.056909919269;2208.0726095040122;1851.2317388283914;2123.702681624574;2144.4102871710247;2168.6746987951933;2173.945651358713;2171.4462811982844;2186.7485239197536;2188.2013065231235;2192.495725983033;2194.4733264016522;8062.637181326854;8141.5752243357765;8147.837043259102;8147.877781833277;8149.144339844291;4604.631629469634;4804.327394164819;4805.831795887162;4809.75951202442;4810.6873053251775;2892.4938135826146;2923.6491621005616;2989.491786396296;3036.5445183222473;3048.039867441749;948.0708905272802;950.334765664038;954.7326748510428;967.1875624475474;969.2730452160879;11062.557497700082;11072.169587280905;11086.279391839586;11096;11107.333559986346;4128.91742165155;4250.872473825791;4308.030693094029;4322.589354011364;4325.048489332342;9322.813543729088;9386.953065234768;9390.107939745712;9391.859122113174;9404.482753448488;4804.471508134103;4840;4857.052874689472;4866.975665121652;4870.634702397334;3788.507494025814;4170.666346692257;4271.893202669896;4274.786260686953;4375.168717943644;3645.3620616392027;3708.7033037356946;3778.471014058034;3787.962120378816;3814.4659747635355;1146.3465824480134;1149.0635132367095;1163.6043745126528;1164.1501703756305;1168.9590864319707;709.3438569323355;859.8194379180317;874.2219424712011;890.3144578674385;906.7415786500816;5276.81531146408;5544.306961629796;5558.666480011212;5610.298712660918;5610.523105535994;427.98716038518893;430.4275313832595;431.2840684463838;915.9954200228956;917.8072604753077;3701.5002974598624;3875.922481550353;3917.3536366499206;3935.5670876203594;3953.288408086572;9846.60613575449;9968.053034961667;10060.949695251476;10099.7475063124;10178.694639160836;9284.72145835626;9604.567794449267;9990.40057596532;10007;10011.299209055442;7447.292507211806;7617.085949686073;7625.6568454418575;7637.618119094134;7650.464467487333;5288.524032837063;5363.168708850135;5373.570114390917;5581.079121944996;5630.943690563206;8837.513936733541;9096.044915284065;9120.133587309196;9278.814423711354;9288.767780805534;9225.446473211628;9336.95331523338;9362.625494980124;9416.858747118935;9499.620015199314;6309.33751956038;6711.194656641039;6860.142482189726;6903.758368457281;7042.612656303748;7816.53100813953;7820.374370050268;7852.725154619561;7857.842843143219;7904.170062143622;6814.250432452327;7019.859602808017;7073.469489788184;7188.928110718826;7231.096112985877;6995.8251043722275;7050.964745176241;7070.222275549789;7089.397401220954;7186.748463803742;6121.969390153021;6322.778702745381;6333.936660633335;6393.8721225576155;6395.840103997437;4658.301254811805;4666.020135771526;4684.27393753955;4713.952860471489;4738.407699037621;4877.585405240594;4878.390201224847;4885.291632713165;4924.138275801792;5010.824621138243 10:33:37 INFO - PROCESS | 14525 | |4;prototype.html;289.72186700767264;297.3814465910905;303.4886216724819;310.01415498714096;312.2739630359415;4780.737059461728;4815.879603009922;4819.313225382576;4822.541858523439;4846.442659094197;4716.693414928027;4733.786979585919;4749.810007599701;4766.332713420124;4789.66472346935;3771.2652179997235;3790.867319643813;3804.1630841214887;3808.866689665869;3816.141368192162;3204.5193221016916;3567.215212653225;3817.961820381802;3827.138893748912;3838.692904567642;3593.8742144024964;3606.6032736399106;3614.620464851192;3658.9085272868124;3674.5223120994365;3697.963020369789;3712.628737126293;3719.954025286082;3721.6278372162838;3758.1732018955786;3326.417876871538;3329.7336213102894;3338.8163650999186;3339.933201335984;3347.7154441872226;4421.734695918223;4443.533428989974;4559.977200114012;4575.6568257380495;4610.9077818443775;4262.12626411588;4271.91456170878;4273.380359847804;4296.753941357003;4298.032942587924;5004.84985450437;5015.548600625962;5020.623453240985;5024.371953505812;5031.874203144914;3446.672566106241;3622.728295377857;3624.981875090634;3644.835982380799;3657.2868290683327;5195.636305458619;5209.557187639055;5240;5256.921146182772;5266.683998960075;3733.775973441602;3733.794641294755;3750.799744081922;3784.2053168834304;3793.886183414502;3731.458938453909;3832.5400951885395;3834.750741201813;3836.388716738976;3846.249981253685;4290.313549832012;4301.0537681709975;4302.290122129813;4305.892352691145;4311.633511151587;4993.7503124843615;5000.549840546201;5011.1709226132925;5033.194688849767;5048.848534543969;1317.9934100329438;1318.7494376068516;1328.362386054699;1329.4349901291912;1330.8669133086614;826.5867066466767;863.6372723456163;868.1839071272983;875.2385424680568;901.9233365163903;4431.313146462304;4467.15124126415;4468.240399132155;4498.3252512123445;4514.25514790056;5084.847454576368;5097.923531147036;5110.361204849394;5127.897442051138;5132.204508301219;4311.396404503372;4455.866324010285;4469.463664360298;4474.784981434146;4485.183500682229;2746.5468197747546;2750.2948172133406;2764.4885696146275;2768.9861550692117;2776.3614368694907;4746.4099526658265;4771.260454629538;4913.21388577833;4948.38145231846;4961.3798275215595;5207.5313221809465;5228.072279523479;5294.232336311214;5294.735263236823;5304.443033481429;4887.266909963534;4899.755012249373;4899.975500122548;4917.926231106465;4930.6795058321095;4912.1407741582;5150.304708864405;5161.81933632321;5162.483751624807;5190.6626069306885;4999.750012499288;5009.749512524432;5062.544371006627;5068.440437578999;5104.795808167632;4845.95154048455;4882;4901.828436004723;4904.975475122602;4929.408470983361;3579.302036102935;3614.045698591555;3649.489071529935;3691.1141326082084;3696.242270334521;5092.923606145837;5104.259882317117;5109.284700142058;5122.436531981553;5122.871928201825;4982.800687972441;4999.400071991385;5001.899582091934;5005.249212618136;5008.749562521933;4711.575958163782;4981.953789704058;4989.2786988488915;5001.174806157089;5010.148274793367;4923.08922849274;4925.48282430354;4928.260760885896;4934.629902757236;4963.883126296554;5020.548150666457;5040.949590504195;5045.470225626256;5076.873078173076;5086.771095300646;4808.831690890802;4936;4938.827141050046;4938.950610493849;4966.3859245746 10:33:37 INFO - PROCESS | 14525 | |5;yui.html;738.97783066508;778.4084096086975;779.6491578789546;786.551665550636;795.3041089047084;12018.819717704231;12089.274643521396;12118.45466953987;12136;12338.938305308473;11839.822402663945;11932.761344773122;11942.582009629665;11965.820512692295;11987.999999999978;630.5428564290899;772.2972095393193;773.9264769846884;784.1609477858693;806.9435139540235;803.1286054630704;811.5577010529275;812.6343145584481;812.8171161488648;814.6008455856618;844.5608283692476;850.0861573808181;851.4082712514804;851.7274472168908;852.0627309959058;671.9496037797161;831.9542425166674;850.1753299299669;853.389826274217;853.4324674091722;620.5314987184692;621.6394491195095;622.7540121651967;622.9657368844757;623.2956758862456;12229.3273869938;12298.877011229863;12302.138850280484;12327.938360308231;12416.75166496674;11356.205065645408;12103.697407564794;12572;12749.490020399173;12782.10525263232;11075.11399088071;11360.886391136066;11393.202475826696;11451.94274028633;11474.196806223568;4115.691323150776;4178.456800615901;4197.769122698251;4322.6325762309925;4338.110687309126;47449.28826067612;47627;47741;47894;48216;9793.265505087147;9814.214862810957;9839.311248212556;9906.950465247628;10024.699259022242;16671.6665666686;16868.493945181664;16926.153692315336;17029.63762898965;17073.48779536616;6525.184351956005;6595.472362211011;6620;6682.832929176712;6853.17761868569;3684.907877303035;3723.3298006359114;3806.6193380662266;3814.732968692165;3855.325318069327;2602.2193341997327;2674.7057823639384;2674.893004279846;2679.986600066987;2680.5309070912513;515.8555604430766;522.7543054764254;524.7953298213699;527.5858451115855;538.21689441862;480.83170890188154;495.3857217050831;567.9261695979579;572.8510587247346;578.837925380894;7423.665935032828;7453.142888567776;7528.1719010908755;7553.546787192786;7797.259260370256;492.79795283933413;519.5402069168813;540.3299908113911;541.1422894711926;557.1614719846685;3386.813725245135;3521.4893840393;3548.1484443733316;3693.593704692482;3732.7013838893367;53754.193687094725;53756.731216343665;53931.460685392645;55353.446465535635;55896.44103558994;49343;50063.74968125209;50285.497145028814;50369;50942.49057509452;42351.36472952908;43237.78381108074;43353.78323108427;45558.31662525065;46516.534834651895;7993.360531157609;8091.109977902308;8443.788905277417;8486.83026339482;8781;32079.358412831145;32361.190970225933;32546.83726581352;32776.67223327832;33014.33971320512;40438.1912361757;41555.792221038704;41636.167276653694;41652;42315.57684423116;10564.418956957441;10721.249512534048;10889.945550272198;11133.610323638633;11424.543018279508;12221.75556488883;12233.713338790618;12284.324362160167;12536;12573.836300066696;8048.637811298623;9962.153216976638;10893.782124357627;11195.60815371458;11248.550057997916;10493.033598554686;10501.107405870587;10619.840702389625;10787.244892857425;10935.507902144582;11396.886031139582;11482.425878706199;11541;11599.826002610136;12104.697382565155;9399.248060155307;9621.230301575997;9633;9658.855117173107;9855.408675479493;9491.972597400561;10006.69979900604;10018.599256029676;10038.849417258893;10069.194464442973 10:33:37 INFO - PROCESS | 14525 | __end_tp_report 10:33:37 INFO - PROCESS | 14525 | __start_cc_report 10:33:37 INFO - PROCESS | 14525 | _x_x_mozilla_cycle_collect,1057 10:33:37 INFO - PROCESS | 14525 | __end_cc_report 10:33:37 INFO - PROCESS | 14525 | __startTimestamp1464111217660__endTimestamp 10:33:37 INFO - PROCESS | 14525 | 10:33:37 INFO - PROCESS | 14525 | ------- Summary: start ------- 10:33:37 INFO - PROCESS | 14525 | Number of tests: 6 10:33:37 INFO - PROCESS | 14525 | 10:33:37 INFO - PROCESS | 14525 | [#0] dojo.html Cycles:165 Average:4732.09 Median:4844.69 stddev:488.01 (10.1%) stddev-sans-first:462.29 10:33:37 INFO - PROCESS | 14525 | Values: 2683.3 2693.5 2721.3 2730.6 2747.6 4661.3 4690.5 4696.2 4762.6 4804.9 4731.4 4745.5 4762.7 4785.9 4833.2 4346.7 4352.2 4368.2 4400.8 4479.0 4391.8 4450.4 4488.4 4521.9 4529.3 4282.0 4447.2 4460.1 4478.5 4489.3 4301.7 4337.8 4362.0 4363.9 4385.8 4342.0 4396.8 4405.1 4422.0 4454.1 4592.6 4740.3 4749.8 4752.4 4772.4 5084.6 5124.5 5139.8 5159.4 5206.8 5186.6 5207.2 5210.4 5230.4 5241.8 4624.4 4745.8 4820.6 4848.4 4850.6 5216.1 5234.9 5307.4 5313.9 5315.2 5037.2 5040.3 5078.3 5082.1 5090.3 4943.4 5126.5 5139.4 5165.5 5181.9 5113.8 5132.5 5139.7 5142.2 5165.8 5114.5 5125.3 5126.7 5130.9 5180.0 4234.2 4263.3 4296.4 4350.6 4403.8 3780.5 3782.2 3790.7 3826.1 3860.0 4442.4 4445.6 4453.6 4490.0 4496.4 4982.8 5056.4 5111.8 5129.3 5147.3 4455.7 4474.7 4505.0 4520.3 4526.1 4662.0 4671.0 4672.7 4674.5 4716.1 4662.6 4794.3 4830.0 4846.7 4863.2 5130.5 5133.6 5133.7 5142.8 5165.6 4779.2 4825.2 4831.5 4844.7 4864.9 4903.0 4997.5 5020.8 5025.8 5077.2 5075.6 5095.4 5105.1 5105.5 5150.2 4953.5 4971.4 4974.2 4974.4 4984.6 4836.1 4884.5 4890.3 4893.1 4914.0 4815.8 4845.6 4885.0 4904.5 4920.0 4835.3 4956.8 4966.8 5006.3 5019.0 4853.6 4895.7 4905.2 4919.0 4923.8 10:33:37 INFO - PROCESS | 14525 | 10:33:37 INFO - PROCESS | 14525 | [#1] ext.html Cycles:180 Average:47357.02 Median:36829.72 stddev:86978.89 (236.2%) stddev-sans-first:87151.88 10:33:37 INFO - PROCESS | 14525 | Values: 545.4 591.7 604.9 606.6 610.8 40300.4 41589.8 41621.0 41630.2 45995.5 39051.2 39424.0 39425.8 39525.6 39740.6 7802.9 7968.4 7975.2 7979.1 7989.7 7825.4 7921.2 7925.4 7927.6 7931.2 7841.9 7951.0 7968.9 7969.9 7971.5 7888.7 7939.9 7949.8 7963.3 7965.6 7824.7 7898.2 7909.7 7915.1 7927.4 39152.2 39525.2 39646.4 39703.0 39706.8 3063.4 3294.7 3387.4 3423.9 3609.2 29490.4 29872.9 30650.2 30827.2 30911.8 3498.6 3550.3 3568.8 3606.4 3661.6 268629.0 268663.0 269751.0 270508.6 271046.0 32434.2 55066.2 55754.0 55801.0 55829.4 33282.5 35272.1 35308.8 35328.3 35332.1 12598.3 12741.5 12762.0 12764.9 12768.5 10296.6 10318.8 10345.8 10350.6 10351.7 8046.2 8092.6 8101.8 8188.7 8217.4 3121.4 3127.6 3153.1 3164.5 3167.9 895.5 927.3 933.7 934.5 1019.1 27945.6 28590.9 28669.1 28996.4 29078.6 808.8 981.9 995.3 1008.4 1099.5 14789.4 14928.0 15055.3 15307.7 15335.4 391974.0 393541.0 393886.0 395269.0 395631.0 49451.8 49983.8 50029.5 50165.7 50175.0 1096.3 1150.2 1194.6 1195.9 1214.1 28804.6 29742.7 29811.7 30052.4 30684.2 43433.3 43511.1 43884.3 43980.8 44001.6 302761.0 302836.0 305057.0 305282.0 349870.0 25297.6 25868.7 25918.7 27395.2 27401.0 42520.6 42833.6 42909.8 43573.8 43613.8 35968.3 36941.3 37380.4 37463.0 37493.8 35816.3 36277.5 36854.8 36976.8 37001.4 35915.8 35984.3 36136.3 36804.6 36889.4 32619.0 33136.7 33407.7 33801.0 33841.3 25431.7 25666.4 25814.5 26047.3 26057.5 10:33:37 INFO - PROCESS | 14525 | 10:33:37 INFO - PROCESS | 14525 | [#2] jquery.html Cycles:180 Average:23238.68 Median:44691.39 stddev:61696.24 (138.0%) stddev-sans-first:61845.40 10:33:37 INFO - PROCESS | 14525 | Values: 360.7 362.5 368.9 372.6 374.5 15658.1 16899.2 17068.0 17409.9 17815.6 16240.4 16335.3 17148.4 17158.1 17176.1 4985.3 5161.7 5172.5 5200.6 5220.3 3675.7 3823.3 5111.8 5624.8 5926.1 5920.4 5959.3 5989.0 5991.9 5994.4 5835.2 5861.3 5934.4 5961.2 6002.4 3322.3 4859.8 5160.3 5164.5 5172.6 19974.3 20599.3 20624.3 20740.8 20753.2 1934.8 2103.8 2241.6 2453.3 2504.0 11575.7 12873.2 13251.1 13728.2 13758.3 1722.2 1725.5 1735.9 1809.4 1817.7 64197.7 64802.4 65344.7 66420.7 66580.0 8833.6 8851.0 9125.6 9532.0 9558.5 11956.8 12031.0 12054.9 12061.0 12061.5 6960.7 7056.1 7071.2 7160.6 7193.2 6780.7 6806.9 6896.4 6903.1 6961.9 6035.2 6035.3 6105.2 6123.8 6182.2 1561.8 1634.5 1640.5 1668.0 1766.6 851.6 868.0 875.2 901.1 960.3 16212.6 16855.4 17165.8 17302.7 17552.0 927.5 930.9 935.9 972.8 995.9 9853.0 10055.9 10195.1 10197.9 10213.7 370252.0 371223.0 373730.0 374003.0 387777.0 64450.4 66551.3 66669.3 67740.7 67834.3 961.1 970.4 1002.8 1013.7 1020.3 15360.3 15366.2 15396.8 15488.6 15788.5 32991.5 33098.7 33118.3 33129.0 33446.5 44570.0 44570.8 44619.0 44763.8 44776.8 7448.9 7565.2 7632.7 7675.7 7685.1 7465.1 8838.0 10286.4 11069.2 11112.7 8926.5 9670.3 9795.6 9803.2 9994.6 9678.0 9827.8 9976.8 10008.3 10033.8 9874.8 9910.7 10062.3 10250.7 10432.7 7226.8 7377.2 7398.0 7456.1 7507.5 10083.1 10102.8 10122.7 10124.7 10370.6 10:33:37 INFO - PROCESS | 14525 | 10:33:37 INFO - PROCESS | 14525 | [#3] mootools.html Cycles:180 Average:5297.39 Median:4904.71 stddev:2998.83 (61.1%) stddev-sans-first:2991.54 10:33:37 INFO - PROCESS | 14525 | Values: 1213.7 1400.4 1455.2 1530.3 1738.1 6933.6 7727.1 7957.2 7964.7 8232.2 8010.4 8158.6 8193.8 8197.5 8206.5 1903.9 2159.6 2219.6 2235.4 2261.9 2279.6 2298.9 2301.7 2307.7 2309.3 2173.5 2194.9 2203.5 2208.1 2208.1 1851.2 2123.7 2144.4 2168.7 2173.9 2171.4 2186.7 2188.2 2192.5 2194.5 8062.6 8141.6 8147.8 8147.9 8149.1 4604.6 4804.3 4805.8 4809.8 4810.7 2892.5 2923.6 2989.5 3036.5 3048.0 948.1 950.3 954.7 967.2 969.3 11062.6 11072.2 11086.3 11096.0 11107.3 4128.9 4250.9 4308.0 4322.6 4325.0 9322.8 9387.0 9390.1 9391.9 9404.5 4804.5 4840.0 4857.1 4867.0 4870.6 3788.5 4170.7 4271.9 4274.8 4375.2 3645.4 3708.7 3778.5 3788.0 3814.5 1146.3 1149.1 1163.6 1164.2 1169.0 709.3 859.8 874.2 890.3 906.7 5276.8 5544.3 5558.7 5610.3 5610.5 428.0 430.4 431.3 916.0 917.8 3701.5 3875.9 3917.4 3935.6 3953.3 9846.6 9968.1 10060.9 10099.7 10178.7 9284.7 9604.6 9990.4 10007.0 10011.3 7447.3 7617.1 7625.7 7637.6 7650.5 5288.5 5363.2 5373.6 5581.1 5630.9 8837.5 9096.0 9120.1 9278.8 9288.8 9225.4 9337.0 9362.6 9416.9 9499.6 6309.3 6711.2 6860.1 6903.8 7042.6 7816.5 7820.4 7852.7 7857.8 7904.2 6814.3 7019.9 7073.5 7188.9 7231.1 6995.8 7051.0 7070.2 7089.4 7186.7 6122.0 6322.8 6333.9 6393.9 6395.8 4658.3 4666.0 4684.3 4714.0 4738.4 4877.6 4878.4 4885.3 4924.1 5010.8 10:33:37 INFO - PROCESS | 14525 | 10:33:37 INFO - PROCESS | 14525 | [#4] prototype.html Cycles:180 Average:4173.30 Median:4768.80 stddev:1200.58 (25.2%) stddev-sans-first:1168.03 10:33:37 INFO - PROCESS | 14525 | Values: 289.7 297.4 303.5 310.0 312.3 4780.7 4815.9 4819.3 4822.5 4846.4 4716.7 4733.8 4749.8 4766.3 4789.7 3771.3 3790.9 3804.2 3808.9 3816.1 3204.5 3567.2 3818.0 3827.1 3838.7 3593.9 3606.6 3614.6 3658.9 3674.5 3698.0 3712.6 3720.0 3721.6 3758.2 3326.4 3329.7 3338.8 3339.9 3347.7 4421.7 4443.5 4560.0 4575.7 4610.9 4262.1 4271.9 4273.4 4296.8 4298.0 5004.8 5015.5 5020.6 5024.4 5031.9 3446.7 3622.7 3625.0 3644.8 3657.3 5195.6 5209.6 5240.0 5256.9 5266.7 3733.8 3733.8 3750.8 3784.2 3793.9 3731.5 3832.5 3834.8 3836.4 3846.2 4290.3 4301.1 4302.3 4305.9 4311.6 4993.8 5000.5 5011.2 5033.2 5048.8 1318.0 1318.7 1328.4 1329.4 1330.9 826.6 863.6 868.2 875.2 901.9 4431.3 4467.2 4468.2 4498.3 4514.3 5084.8 5097.9 5110.4 5127.9 5132.2 4311.4 4455.9 4469.5 4474.8 4485.2 2746.5 2750.3 2764.5 2769.0 2776.4 4746.4 4771.3 4913.2 4948.4 4961.4 5207.5 5228.1 5294.2 5294.7 5304.4 4887.3 4899.8 4900.0 4917.9 4930.7 4912.1 5150.3 5161.8 5162.5 5190.7 4999.8 5009.7 5062.5 5068.4 5104.8 4846.0 4882.0 4901.8 4905.0 4929.4 3579.3 3614.0 3649.5 3691.1 3696.2 5092.9 5104.3 5109.3 5122.4 5122.9 4982.8 4999.4 5001.9 5005.2 5008.7 4711.6 4982.0 4989.3 5001.2 5010.1 4923.1 4925.5 4928.3 4934.6 4963.9 5020.5 5040.9 5045.5 5076.9 5086.8 4808.8 4936.0 4938.8 4939.0 4966.4 10:33:37 INFO - PROCESS | 14525 | 10:33:37 INFO - PROCESS | 14525 | [#5] yui.html Cycles:180 Average:13225.43 Median:24948.21 stddev:15296.82 (61.3%) stddev-sans-first:15311.00 10:33:37 INFO - PROCESS | 14525 | Values: 739.0 778.4 779.6 786.6 795.3 12018.8 12089.3 12118.5 12136.0 12338.9 11839.8 11932.8 11942.6 11965.8 11988.0 630.5 772.3 773.9 784.2 806.9 803.1 811.6 812.6 812.8 814.6 844.6 850.1 851.4 851.7 852.1 671.9 832.0 850.2 853.4 853.4 620.5 621.6 622.8 623.0 623.3 12229.3 12298.9 12302.1 12327.9 12416.8 11356.2 12103.7 12572.0 12749.5 12782.1 11075.1 11360.9 11393.2 11451.9 11474.2 4115.7 4178.5 4197.8 4322.6 4338.1 47449.3 47627.0 47741.0 47894.0 48216.0 9793.3 9814.2 9839.3 9907.0 10024.7 16671.7 16868.5 16926.2 17029.6 17073.5 6525.2 6595.5 6620.0 6682.8 6853.2 3684.9 3723.3 3806.6 3814.7 3855.3 2602.2 2674.7 2674.9 2680.0 2680.5 515.9 522.8 524.8 527.6 538.2 480.8 495.4 567.9 572.9 578.8 7423.7 7453.1 7528.2 7553.5 7797.3 492.8 519.5 540.3 541.1 557.2 3386.8 3521.5 3548.1 3693.6 3732.7 53754.2 53756.7 53931.5 55353.4 55896.4 49343.0 50063.7 50285.5 50369.0 50942.5 42351.4 43237.8 43353.8 45558.3 46516.5 7993.4 8091.1 8443.8 8486.8 8781.0 32079.4 32361.2 32546.8 32776.7 33014.3 40438.2 41555.8 41636.2 41652.0 42315.6 10564.4 10721.2 10889.9 11133.6 11424.5 12221.8 12233.7 12284.3 12536.0 12573.8 8048.6 9962.2 10893.8 11195.6 11248.6 10493.0 10501.1 10619.8 10787.2 10935.5 11396.9 11482.4 11541.0 11599.8 12104.7 9399.2 9621.2 9633.0 9658.9 9855.4 9492.0 10006.7 10018.6 10038.8 10069.2 10:33:37 INFO - PROCESS | 14525 | -------- Summary: end -------- 10:33:37 INFO - PROCESS | 14525 | 10:33:38 INFO - TEST-INFO | 14525: exit 0 10:33:38 INFO - TEST-OK | dromaeo_css | took 1119026ms 10:33:38 INFO - TEST-START | kraken 10:33:38 INFO - operating with platform_type : linux_ 10:33:38 INFO - Initialising browser for kraken test... 10:33:38 INFO - TEST-INFO | started process 14705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxVwGzX/profile http://localhost:47796/getInfo.html) 10:33:43 INFO - PROCESS | 14705 | __metrics Screen width/height:1600/1200 10:33:43 INFO - PROCESS | 14705 | colorDepth:24 10:33:43 INFO - PROCESS | 14705 | Browser inner width/height: 1024/697 10:33:43 INFO - PROCESS | 14705 | __metrics 10:33:44 ERROR - PROCESS | 14705 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:33:45 INFO - TEST-INFO | 14705: exit 0 10:33:45 INFO - Browser initialized. 10:33:45 INFO - Running cycle 1/1 for kraken test... 10:33:45 INFO - TEST-INFO | started process 14787 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxVwGzX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:57 INFO - PROCESS | 14787 | RSS: Main: 155291648 10:33:57 INFO - PROCESS | 14787 | 10:33:59 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47796/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:00 INFO - PROCESS | 14787 | RSS: Main: 210722816 10:34:00 INFO - PROCESS | 14787 | 10:34:03 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47796/tests/kraken/driver.html?testName=audio-dft) 10:34:04 INFO - PROCESS | 14787 | RSS: Main: 197242880 10:34:04 INFO - PROCESS | 14787 | 10:34:07 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47796/tests/kraken/driver.html?testName=audio-fft) 10:34:07 INFO - PROCESS | 14787 | RSS: Main: 267190272 10:34:07 INFO - PROCESS | 14787 | 10:34:10 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47796/tests/kraken/driver.html?testName=audio-oscillator) 10:34:10 INFO - PROCESS | 14787 | RSS: Main: 176676864 10:34:10 INFO - PROCESS | 14787 | 10:34:13 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47796/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:34:13 INFO - PROCESS | 14787 | RSS: Main: 180424704 10:34:13 INFO - PROCESS | 14787 | 10:34:16 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47796/tests/kraken/driver.html?testName=imaging-darkroom) 10:34:17 INFO - PROCESS | 14787 | RSS: Main: 216739840 10:34:17 INFO - PROCESS | 14787 | 10:34:20 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47796/tests/kraken/driver.html?testName=imaging-desaturate) 10:34:21 INFO - PROCESS | 14787 | RSS: Main: 214790144 10:34:21 INFO - PROCESS | 14787 | 10:34:24 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47796/tests/kraken/driver.html?testName=json-parse-financial) 10:34:24 INFO - PROCESS | 14787 | RSS: Main: 215855104 10:34:24 INFO - PROCESS | 14787 | 10:34:26 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47796/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:34:27 INFO - PROCESS | 14787 | RSS: Main: 202219520 10:34:27 INFO - PROCESS | 14787 | 10:34:29 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47796/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:29 INFO - PROCESS | 14787 | RSS: Main: 208629760 10:34:29 INFO - PROCESS | 14787 | 10:34:31 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47796/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:32 INFO - PROCESS | 14787 | RSS: Main: 217432064 10:34:32 INFO - PROCESS | 14787 | 10:34:35 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47796/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:36 INFO - PROCESS | 14787 | RSS: Main: 225259520 10:34:36 INFO - PROCESS | 14787 | 10:34:38 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47796/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:39 INFO - PROCESS | 14787 | RSS: Main: 223105024 10:34:39 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | Cycle 1(1): loaded http://localhost:47796/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47796/tests/kraken/driver.html?testName=ai-astar) 10:34:41 INFO - PROCESS | 14787 | RSS: Main: 268935168 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | __start_tp_report 10:34:41 INFO - PROCESS | 14787 | _x_x_mozilla_page_load 10:34:41 INFO - PROCESS | 14787 | _x_x_mozilla_page_load_details 10:34:41 INFO - PROCESS | 14787 | |i|pagename|runs| 10:34:41 INFO - PROCESS | 14787 | |0;ai-astar;112;110;115;112;112;113;112;111;112;111 10:34:41 INFO - PROCESS | 14787 | |1;audio-beat-detection;151;133;134;185;131;133;165;148;168;131 10:34:41 INFO - PROCESS | 14787 | |2;audio-dft;161;161;161;160;161;162;162;161;162;162 10:34:41 INFO - PROCESS | 14787 | |3;audio-fft;74;75;76;106;75;75;75;75;100;76 10:34:41 INFO - PROCESS | 14787 | |4;audio-oscillator;84;84;126;83;84;84;124;83;85;121 10:34:41 INFO - PROCESS | 14787 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;116;116 10:34:41 INFO - PROCESS | 14787 | |6;imaging-darkroom;146;146;145;146;146;145;146;146;146;145 10:34:41 INFO - PROCESS | 14787 | |7;imaging-desaturate;94;95;95;95;95;95;94;96;95;95 10:34:41 INFO - PROCESS | 14787 | |8;json-parse-financial;64;65;64;64;64;65;65;82;62;62 10:34:41 INFO - PROCESS | 14787 | |9;json-stringify-tinderbox;64;64;65;66;65;65;65;64;65;65 10:34:41 INFO - PROCESS | 14787 | |10;stanford-crypto-aes;82;82;83;82;81;83;84;83;83;89 10:34:41 INFO - PROCESS | 14787 | |11;stanford-crypto-ccm;133;132;133;143;132;128;128;141;174;141 10:34:41 INFO - PROCESS | 14787 | |12;stanford-crypto-pbkdf2;173;168;169;167;171;173;166;167;174;168 10:34:41 INFO - PROCESS | 14787 | |13;stanford-crypto-sha256-iterative;66;67;67;66;66;70;66;66;66;66 10:34:41 INFO - PROCESS | 14787 | __end_tp_report 10:34:41 INFO - PROCESS | 14787 | __start_cc_report 10:34:41 INFO - PROCESS | 14787 | _x_x_mozilla_cycle_collect,1909 10:34:41 INFO - PROCESS | 14787 | __end_cc_report 10:34:41 INFO - PROCESS | 14787 | __startTimestamp1464111281573__endTimestamp 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | ------- Summary: start ------- 10:34:41 INFO - PROCESS | 14787 | Number of tests: 14 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:1.33 (1.2%) stddev-sans-first:1.41 10:34:41 INFO - PROCESS | 14787 | Values: 112.0 110.0 115.0 112.0 112.0 113.0 112.0 111.0 112.0 111.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:149.50 stddev:19.12 (12.8%) stddev-sans-first:20.25 10:34:41 INFO - PROCESS | 14787 | Values: 151.0 133.0 134.0 185.0 131.0 133.0 165.0 148.0 168.0 131.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.71 10:34:41 INFO - PROCESS | 14787 | Values: 161.0 161.0 161.0 160.0 161.0 162.0 162.0 161.0 162.0 162.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:11.85 (15.8%) stddev-sans-first:12.32 10:34:41 INFO - PROCESS | 14787 | Values: 74.0 75.0 76.0 106.0 75.0 75.0 75.0 75.0 100.0 76.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:84.00 stddev:19.27 (22.9%) stddev-sans-first:19.97 10:34:41 INFO - PROCESS | 14787 | Values: 84.0 84.0 126.0 83.0 84.0 84.0 124.0 83.0 85.0 121.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 10:34:41 INFO - PROCESS | 14787 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 116.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:34:41 INFO - PROCESS | 14787 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 10:34:41 INFO - PROCESS | 14787 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 95.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:64.50 stddev:5.83 (9.0%) stddev-sans-first:6.15 10:34:41 INFO - PROCESS | 14787 | Values: 64.0 65.0 64.0 64.0 64.0 65.0 65.0 82.0 62.0 62.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 10:34:41 INFO - PROCESS | 14787 | Values: 64.0 64.0 65.0 66.0 65.0 65.0 65.0 64.0 65.0 65.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:2.20 (2.7%) stddev-sans-first:2.29 10:34:41 INFO - PROCESS | 14787 | Values: 82.0 82.0 83.0 82.0 81.0 83.0 84.0 83.0 83.0 89.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:137.00 stddev:13.57 (9.9%) stddev-sans-first:14.25 10:34:41 INFO - PROCESS | 14787 | Values: 133.0 132.0 133.0 143.0 132.0 128.0 128.0 141.0 174.0 141.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.00 stddev:2.91 (1.7%) stddev-sans-first:2.82 10:34:41 INFO - PROCESS | 14787 | Values: 173.0 168.0 169.0 167.0 171.0 173.0 166.0 167.0 174.0 168.0 10:34:41 INFO - PROCESS | 14787 | 10:34:41 INFO - PROCESS | 14787 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.32 10:34:41 INFO - PROCESS | 14787 | Values: 66.0 67.0 67.0 66.0 66.0 70.0 66.0 66.0 66.0 66.0 10:34:41 INFO - PROCESS | 14787 | -------- Summary: end -------- 10:34:41 INFO - PROCESS | 14787 | 10:34:42 INFO - TEST-INFO | 14787: exit 0 10:34:42 INFO - TEST-OK | kraken | took 64185ms 10:34:42 INFO - SUITE-END | took 1183s 10:34:42 INFO - Completed test suite (00:19:43) 10:34:42 INFO - javascript benchmark 10:34:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2683.329167708073, 2693.461307738453, 2721.3396136037045, 2730.604062410949, 2747.574126010468, 4661.30080487927, 4690.484046754854, 4696.248600223965, 4762.59517940975, 4804.90390192196, 4731.361266229058, 4745.454272758634, 4762.714237145774, 4785.880352991177, 4833.202521583943, 4346.652267818583, 4352.238358287287, 4368.191884501377, 4400.845970391029, 4478.955210447886, 4391.824327026915, 4450.376947227391, 4488.438945131858, 4521.864344069683, 4529.275315949449, 4281.978590107061, 4447.221736196153, 4460.130274596455, 4478.484974227973, 4489.326601009842, 4301.677374196947, 4337.826486940518, 4361.978190109061, 4363.890902727458, 4385.802638881258, 4341.956580434218, 4396.846110386121, 4405.074934263776, 4422.027154026141, 4454.109178164348, 4592.609628181609, 4740.336352910595, 4749.762511874393, 4752.382190315271, 4772.403449568804, 5084.644074914758, 5124.461931497213, 5139.820106296262, 5159.406668233164, 5206.843794686166, 5186.559142472895, 5207.244949482304, 5210.400803907562, 5230.372355317386, 5241.764120614582, 4624.398828152386, 4745.762711864393, 4820.6143508519235, 4848.369711937426, 4850.6362022848425, 5216.061109000417, 5234.895302093937, 5307.363116425976, 5313.946860531345, 5315.202719592092, 5037.168867136881, 5040.294358789773, 5078.289039534468, 5082.059818933509, 5090.261912022736, 4943.382077240345, 5126.512981266774, 5139.408967968657, 5165.48345165488, 5181.896362072737, 5113.795448182105, 5132.512411320993, 5139.743012849342, 5142.1772516397195, 5165.819196328111, 5114.539691427789, 5125.308083408767, 5126.743662816844, 5130.948155628087, 5180.0, 4234.153169366139, 4263.296556068214, 4296.398504209413, 4350.608445239944, 4403.8238470461465, 3780.4896338993885, 3782.243551289753, 3790.6967442604528, 3826.100866296418, 3859.980700096538, 4442.355858400579, 4445.644348452116, 4453.576910193527, 4490.034642551802, 4496.437945256843, 4982.800687972513, 5056.418511871108, 5111.846644600593, 5129.333186685707, 5147.3308469898675, 4455.6658250631335, 4474.709143905636, 4504.977475112603, 4520.276755719069, 4526.117407105583, 4661.95338046622, 4670.976645116821, 4672.74299913508, 4674.5325467452985, 4716.103940251342, 4662.580367766782, 4794.328793968777, 4830.033993201304, 4846.733429661403, 4863.173260545645, 5130.461301563431, 5133.640645154804, 5133.666311689728, 5142.845714628567, 5165.560927321069, 4779.211430113992, 4825.203841366276, 4831.541003604652, 4844.685095468783, 4864.92702609454, 4903.0193961208615, 4997.525235102659, 5020.824271150492, 5025.773840177128, 5077.213031980049, 5075.644704870623, 5095.388553373471, 5105.055564720538, 5105.463926287686, 5150.1502252127975, 4953.529414705597, 4971.353724015855, 4974.17926042199, 4974.37820272466, 4984.576311013604, 4836.12949669063, 4884.462709101925, 4890.2909078184175, 4893.143699852582, 4913.950860491493, 4815.807367705393, 4845.636577256791, 4885.0, 4904.485029071896, 4919.950800491949, 4835.274708793709, 4956.82651107224, 4966.801327946986, 5006.349174607278, 5019.02129084825, 4853.563179313879, 4895.681780684244, 4905.190643543775, 4919.0407870464915, 4923.803047878045], "value": 4701.672066534549, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.3673738463383, 591.6952769323798, 604.85181130623, 606.6299557270064, 610.8137018209444, 40300.39549406761, 41589.79205103974, 41621.0, 41630.16739665205, 45995.54004459955, 39051.21897562047, 39424.0, 39425.80287098561, 39525.60474395255, 39740.60259397405, 7802.882956755639, 7968.362530997506, 7975.202479752007, 7979.0824055233525, 7989.680412783482, 7825.413094017943, 7921.2474814892785, 7925.405594580429, 7927.603619819015, 7931.24653157952, 7841.9215807841765, 7951.0, 7968.920310796876, 7969.880451793228, 7971.521708697497, 7888.6844526219165, 7939.920600794005, 7949.801254968672, 7963.3231175350165, 7965.641546130438, 7824.726134585262, 7898.210178982114, 7909.683612655487, 7915.12933577306, 7927.405444591679, 39152.21695566101, 39525.209495809926, 39646.40530392047, 39703.0, 39706.80146599277, 3063.448579255733, 3294.7199488043543, 3387.44107222308, 3423.8972830815114, 3609.205974685565, 29490.410191796258, 29872.850635746898, 30650.23374415635, 30827.229319266975, 30911.84544077288, 3498.6151523332414, 3550.3254381667402, 3568.7680300780366, 3606.441001644749, 3661.5972243053243, 268629.0, 268663.0, 269751.0, 270508.6474567634, 271046.0, 32434.189145271084, 55066.17400738992, 55754.0, 55801.0, 55829.44170558242, 33282.500762488584, 35272.11819704528, 35308.82345588256, 35328.29343413117, 35332.116697082776, 12598.307093109783, 12741.49034038628, 12762.0, 12764.936175319064, 12768.489260429664, 10296.588136474607, 10318.793624127475, 10345.793084138275, 10350.637727679647, 10351.689449316533, 8046.235607617267, 8092.635831387602, 8101.756947291591, 8188.672453101809, 8217.383696222807, 3121.3913286908833, 3127.56214130022, 3153.0698443959086, 3164.477861152884, 3167.889123880699, 895.5119459894242, 927.3184209605935, 933.7385532051037, 934.4813628436283, 1019.0879163148941, 27945.580816287773, 28590.857045714638, 28669.139925802257, 28996.42007159845, 29078.563821542695, 808.7937575918103, 981.906718861707, 995.2833959549113, 1008.3798463944621, 1099.5162128663362, 14789.408423663148, 14928.0, 15055.322510487054, 15307.693846123015, 15335.386584536494, 391974.0, 393541.0, 393886.0, 395269.0, 395631.0, 49451.752741236065, 49983.75008124936, 50029.49970500321, 50165.74917125391, 50175.0, 1096.2545469081101, 1150.1603829204728, 1194.6236935365332, 1195.910306726999, 1214.0954988533776, 28804.567931480626, 29742.702572973994, 29811.70188298089, 30052.398952021274, 30684.232894177825, 43433.3484997719, 43511.12977740491, 43884.341734873364, 43980.78009609931, 44001.55998439975, 302761.0, 302836.0, 305057.0, 305282.0, 349870.0, 25297.62053569161, 25868.741312586633, 25918.740812591634, 27395.178144655692, 27401.0, 42520.5747942529, 42833.57166428296, 42909.785451072545, 43573.782131089145, 43613.78193109014, 35968.28063438664, 36941.26117477689, 37380.43929341117, 37463.0, 37493.81253093717, 35816.283674326885, 36277.455838162976, 36854.8157259212, 36976.81511592425, 37001.44497832588, 35915.820420897726, 35984.28031439409, 36136.27727445489, 36804.63195368119, 36889.44665829961, 32619.0, 33136.668633313355, 33407.66592334046, 33801.0, 33841.32317353688, 25431.745682542936, 25666.358341041625, 25814.483710325312, 26047.32167292782, 26057.478850423264], "value": 16803.989749900258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.6970145078134, 362.45631552670994, 368.9483472313878, 372.6385406156028, 374.543057469887, 15658.138802365866, 16899.23953422096, 17068.0, 17409.91295043526, 17815.643687126267, 16240.431584894532, 16335.26491307891, 17148.399806006793, 17158.142092895367, 17176.141192940366, 4985.326980857583, 5161.664491808039, 5172.508611681884, 5200.635955483118, 5220.321358223445, 3675.650813172744, 3823.3309170895122, 5111.7699703513435, 5624.803131890385, 5926.111083337512, 5920.378360272174, 5959.284885813709, 5989.0417533194695, 5991.910121348184, 5994.370591087938, 5835.183074369592, 5861.296644402678, 5934.43622855828, 5961.165436838846, 6002.369751176151, 3322.2857085726687, 4859.757012149378, 5160.277561141444, 5164.483551644806, 5172.58619310458, 19974.300899468595, 20599.279025234046, 20624.27815026467, 20740.792592074038, 20753.169873205054, 1934.8161924617139, 2103.831693464519, 2241.60771864923, 2453.2640207937725, 2503.9749602503925, 11575.710607234802, 12873.163244389085, 13251.138675986127, 13728.176309421468, 13758.31208439574, 1722.2336060453104, 1725.4996051145279, 1735.9392421265195, 1809.3757653609484, 1817.6728188925988, 64197.67901160511, 64802.3519764801, 65344.67327663379, 66420.6678966602, 66580.0, 8833.60248788806, 8851.0, 9125.634974601075, 9532.0, 9558.474283914313, 11956.760864782656, 12031.014882544458, 12054.879451205376, 12061.0, 12061.457234424472, 6960.65196740161, 7056.1179852518435, 7071.222165561784, 7160.606166660884, 7193.244709305448, 6780.694868730919, 6806.863862722717, 6896.379400814612, 6903.102596662502, 6961.860762784716, 6035.185249991283, 6035.336113027563, 6105.175801266861, 6123.785667501616, 6182.227221597301, 1561.8360072192256, 1634.525987463646, 1640.491447651232, 1667.9984019177036, 1766.629007908328, 851.5784686580182, 868.0408148995396, 875.2385424680568, 901.0718959471754, 960.279790157382, 16212.59468513273, 16855.410060648064, 17165.82834171667, 17302.740458893128, 17552.0, 927.4759760735163, 930.9255259579218, 935.8783358163395, 972.8492083727034, 995.8605795188535, 9853.0, 10055.949720251352, 10195.082442580204, 10197.898021019842, 10213.693589192337, 370252.0, 371223.0, 373730.0, 374003.0, 387777.0, 64450.355496444434, 66551.33448665548, 66669.33330666632, 67740.6612966932, 67834.32165678378, 961.053362437998, 970.4129001953858, 1002.8094662014194, 1013.6705570689555, 1020.3469779341227, 15360.308786104875, 15366.231688415759, 15396.84603153999, 15488.599267113164, 15788.500092491195, 32991.50512742263, 33098.66901331052, 33118.337633247684, 33129.0, 33446.49830252597, 44570.0, 44570.77714611406, 44619.0, 44763.77618111888, 44776.77611611921, 7448.888266676113, 7565.167831538636, 7632.732854350071, 7675.654595543326, 7685.077790664933, 7465.141508726566, 8837.983631882416, 10286.434246116536, 11069.169812263952, 11112.722181945515, 8926.464412135292, 9670.274729395464, 9795.559199835881, 9803.16673082796, 9994.550245239127, 9677.951610241904, 9827.803443930938, 9976.750581235527, 10008.349457285252, 10033.799324013626, 9874.802503950024, 9910.702678919355, 10062.295639305472, 10250.743731406774, 10432.739181520523, 7226.783196504113, 7377.151627562685, 7398.0, 7456.105267367951, 7507.549547027196, 10083.092521673085, 10102.797944041225, 10122.746931326776, 10124.746881328027, 10370.637027703995], "value": 8185.349630801801, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.7269114449255, 1400.4328247059939, 1455.2360010994228, 1530.3343045775089, 1738.0875040603682, 6933.583984960899, 7727.072751269849, 7957.164497727742, 7964.721234756785, 8232.217939295757, 8010.39922005849, 8158.551279679616, 8193.754187374388, 8197.467164634294, 8206.466579672317, 1903.8667293289475, 2159.6112699714045, 2219.5893759654514, 2235.3740952533317, 2261.9095236190533, 2279.6466547685054, 2298.8620682759006, 2301.723793144825, 2307.6884620576175, 2309.2725791375747, 2173.5435558532727, 2194.9341519754435, 2203.526241858, 2208.056909919269, 2208.0726095040122, 1851.2317388283914, 2123.702681624574, 2144.4102871710247, 2168.6746987951933, 2173.945651358713, 2171.4462811982844, 2186.7485239197536, 2188.2013065231235, 2192.495725983033, 2194.4733264016522, 8062.637181326854, 8141.5752243357765, 8147.837043259102, 8147.877781833277, 8149.144339844291, 4604.631629469634, 4804.327394164819, 4805.831795887162, 4809.75951202442, 4810.6873053251775, 2892.4938135826146, 2923.6491621005616, 2989.491786396296, 3036.5445183222473, 3048.039867441749, 948.0708905272802, 950.334765664038, 954.7326748510428, 967.1875624475474, 969.2730452160879, 11062.557497700082, 11072.169587280905, 11086.279391839586, 11096.0, 11107.333559986346, 4128.91742165155, 4250.872473825791, 4308.030693094029, 4322.589354011364, 4325.048489332342, 9322.813543729088, 9386.953065234768, 9390.107939745712, 9391.859122113174, 9404.482753448488, 4804.471508134103, 4840.0, 4857.052874689472, 4866.975665121652, 4870.634702397334, 3788.507494025814, 4170.666346692257, 4271.893202669896, 4274.786260686953, 4375.168717943644, 3645.3620616392027, 3708.7033037356946, 3778.471014058034, 3787.962120378816, 3814.4659747635355, 1146.3465824480134, 1149.0635132367095, 1163.6043745126528, 1164.1501703756305, 1168.9590864319707, 709.3438569323355, 859.8194379180317, 874.2219424712011, 890.3144578674385, 906.7415786500816, 5276.81531146408, 5544.306961629796, 5558.666480011212, 5610.298712660918, 5610.523105535994, 427.98716038518893, 430.4275313832595, 431.2840684463838, 915.9954200228956, 917.8072604753077, 3701.5002974598624, 3875.922481550353, 3917.3536366499206, 3935.5670876203594, 3953.288408086572, 9846.60613575449, 9968.053034961667, 10060.949695251476, 10099.7475063124, 10178.694639160836, 9284.72145835626, 9604.567794449267, 9990.40057596532, 10007.0, 10011.299209055442, 7447.292507211806, 7617.085949686073, 7625.6568454418575, 7637.618119094134, 7650.464467487333, 5288.524032837063, 5363.168708850135, 5373.570114390917, 5581.079121944996, 5630.943690563206, 8837.513936733541, 9096.044915284065, 9120.133587309196, 9278.814423711354, 9288.767780805534, 9225.446473211628, 9336.95331523338, 9362.625494980124, 9416.858747118935, 9499.620015199314, 6309.33751956038, 6711.194656641039, 6860.142482189726, 6903.758368457281, 7042.612656303748, 7816.53100813953, 7820.374370050268, 7852.725154619561, 7857.842843143219, 7904.170062143622, 6814.250432452327, 7019.859602808017, 7073.469489788184, 7188.928110718826, 7231.096112985877, 6995.8251043722275, 7050.964745176241, 7070.222275549789, 7089.397401220954, 7186.748463803742, 6121.969390153021, 6322.778702745381, 6333.936660633335, 6393.8721225576155, 6395.840103997437, 4658.301254811805, 4666.020135771526, 4684.27393753955, 4713.952860471489, 4738.407699037621, 4877.585405240594, 4878.390201224847, 4885.291632713165, 4924.138275801792, 5010.824621138243], "value": 4212.628314618893, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.72186700767264, 297.3814465910905, 303.4886216724819, 310.01415498714096, 312.2739630359415, 4780.737059461728, 4815.879603009922, 4819.313225382576, 4822.541858523439, 4846.442659094197, 4716.693414928027, 4733.786979585919, 4749.810007599701, 4766.332713420124, 4789.66472346935, 3771.2652179997235, 3790.867319643813, 3804.1630841214887, 3808.866689665869, 3816.141368192162, 3204.5193221016916, 3567.215212653225, 3817.961820381802, 3827.138893748912, 3838.692904567642, 3593.8742144024964, 3606.6032736399106, 3614.620464851192, 3658.9085272868124, 3674.5223120994365, 3697.963020369789, 3712.628737126293, 3719.954025286082, 3721.6278372162838, 3758.1732018955786, 3326.417876871538, 3329.7336213102894, 3338.8163650999186, 3339.933201335984, 3347.7154441872226, 4421.734695918223, 4443.533428989974, 4559.977200114012, 4575.6568257380495, 4610.9077818443775, 4262.12626411588, 4271.91456170878, 4273.380359847804, 4296.753941357003, 4298.032942587924, 5004.84985450437, 5015.548600625962, 5020.623453240985, 5024.371953505812, 5031.874203144914, 3446.672566106241, 3622.728295377857, 3624.981875090634, 3644.835982380799, 3657.2868290683327, 5195.636305458619, 5209.557187639055, 5240.0, 5256.921146182772, 5266.683998960075, 3733.775973441602, 3733.794641294755, 3750.799744081922, 3784.2053168834304, 3793.886183414502, 3731.458938453909, 3832.5400951885395, 3834.750741201813, 3836.388716738976, 3846.249981253685, 4290.313549832012, 4301.0537681709975, 4302.290122129813, 4305.892352691145, 4311.633511151587, 4993.7503124843615, 5000.549840546201, 5011.1709226132925, 5033.194688849767, 5048.848534543969, 1317.9934100329438, 1318.7494376068516, 1328.362386054699, 1329.4349901291912, 1330.8669133086614, 826.5867066466767, 863.6372723456163, 868.1839071272983, 875.2385424680568, 901.9233365163903, 4431.313146462304, 4467.15124126415, 4468.240399132155, 4498.3252512123445, 4514.25514790056, 5084.847454576368, 5097.923531147036, 5110.361204849394, 5127.897442051138, 5132.204508301219, 4311.396404503372, 4455.866324010285, 4469.463664360298, 4474.784981434146, 4485.183500682229, 2746.5468197747546, 2750.2948172133406, 2764.4885696146275, 2768.9861550692117, 2776.3614368694907, 4746.4099526658265, 4771.260454629538, 4913.21388577833, 4948.38145231846, 4961.3798275215595, 5207.5313221809465, 5228.072279523479, 5294.232336311214, 5294.735263236823, 5304.443033481429, 4887.266909963534, 4899.755012249373, 4899.975500122548, 4917.926231106465, 4930.6795058321095, 4912.1407741582, 5150.304708864405, 5161.81933632321, 5162.483751624807, 5190.6626069306885, 4999.750012499288, 5009.749512524432, 5062.544371006627, 5068.440437578999, 5104.795808167632, 4845.95154048455, 4882.0, 4901.828436004723, 4904.975475122602, 4929.408470983361, 3579.302036102935, 3614.045698591555, 3649.489071529935, 3691.1141326082084, 3696.242270334521, 5092.923606145837, 5104.259882317117, 5109.284700142058, 5122.436531981553, 5122.871928201825, 4982.800687972441, 4999.400071991385, 5001.899582091934, 5005.249212618136, 5008.749562521933, 4711.575958163782, 4981.953789704058, 4989.2786988488915, 5001.174806157089, 5010.148274793367, 4923.08922849274, 4925.48282430354, 4928.260760885896, 4934.629902757236, 4963.883126296554, 5020.548150666457, 5040.949590504195, 5045.470225626256, 5076.873078173076, 5086.771095300646, 4808.831690890802, 4936.0, 4938.827141050046, 4938.950610493849, 4966.3859245746], "value": 3795.1483061863355, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.97783066508, 778.4084096086975, 779.6491578789546, 786.551665550636, 795.3041089047084, 12018.819717704231, 12089.274643521396, 12118.45466953987, 12136.0, 12338.938305308473, 11839.822402663945, 11932.761344773122, 11942.582009629665, 11965.820512692295, 11987.999999999978, 630.5428564290899, 772.2972095393193, 773.9264769846884, 784.1609477858693, 806.9435139540235, 803.1286054630704, 811.5577010529275, 812.6343145584481, 812.8171161488648, 814.6008455856618, 844.5608283692476, 850.0861573808181, 851.4082712514804, 851.7274472168908, 852.0627309959058, 671.9496037797161, 831.9542425166674, 850.1753299299669, 853.389826274217, 853.4324674091722, 620.5314987184692, 621.6394491195095, 622.7540121651967, 622.9657368844757, 623.2956758862456, 12229.3273869938, 12298.877011229863, 12302.138850280484, 12327.938360308231, 12416.75166496674, 11356.205065645408, 12103.697407564794, 12572.0, 12749.490020399173, 12782.10525263232, 11075.11399088071, 11360.886391136066, 11393.202475826696, 11451.94274028633, 11474.196806223568, 4115.691323150776, 4178.456800615901, 4197.769122698251, 4322.6325762309925, 4338.110687309126, 47449.28826067612, 47627.0, 47741.0, 47894.0, 48216.0, 9793.265505087147, 9814.214862810957, 9839.311248212556, 9906.950465247628, 10024.699259022242, 16671.6665666686, 16868.493945181664, 16926.153692315336, 17029.63762898965, 17073.48779536616, 6525.184351956005, 6595.472362211011, 6620.0, 6682.832929176712, 6853.17761868569, 3684.907877303035, 3723.3298006359114, 3806.6193380662266, 3814.732968692165, 3855.325318069327, 2602.2193341997327, 2674.7057823639384, 2674.893004279846, 2679.986600066987, 2680.5309070912513, 515.8555604430766, 522.7543054764254, 524.7953298213699, 527.5858451115855, 538.21689441862, 480.83170890188154, 495.3857217050831, 567.9261695979579, 572.8510587247346, 578.837925380894, 7423.665935032828, 7453.142888567776, 7528.1719010908755, 7553.546787192786, 7797.259260370256, 492.79795283933413, 519.5402069168813, 540.3299908113911, 541.1422894711926, 557.1614719846685, 3386.813725245135, 3521.4893840393, 3548.1484443733316, 3693.593704692482, 3732.7013838893367, 53754.193687094725, 53756.731216343665, 53931.460685392645, 55353.446465535635, 55896.44103558994, 49343.0, 50063.74968125209, 50285.497145028814, 50369.0, 50942.49057509452, 42351.36472952908, 43237.78381108074, 43353.78323108427, 45558.31662525065, 46516.534834651895, 7993.360531157609, 8091.109977902308, 8443.788905277417, 8486.83026339482, 8781.0, 32079.358412831145, 32361.190970225933, 32546.83726581352, 32776.67223327832, 33014.33971320512, 40438.1912361757, 41555.792221038704, 41636.167276653694, 41652.0, 42315.57684423116, 10564.418956957441, 10721.249512534048, 10889.945550272198, 11133.610323638633, 11424.543018279508, 12221.75556488883, 12233.713338790618, 12284.324362160167, 12536.0, 12573.836300066696, 8048.637811298623, 9962.153216976638, 10893.782124357627, 11195.60815371458, 11248.550057997916, 10493.033598554686, 10501.107405870587, 10619.840702389625, 10787.244892857425, 10935.507902144582, 11396.886031139582, 11482.425878706199, 11541.0, 11599.826002610136, 12104.697382565155, 9399.248060155307, 9621.230301575997, 9633.0, 9658.855117173107, 9855.408675479493, 9491.972597400561, 10006.69979900604, 10018.599256029676, 10038.849417258893, 10069.194464442973], "value": 6004.787718915885, "unit": "score"}], "name": "dromaeo_css", "value": 6292.715414264183, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 115.0, 112.0, 112.0, 113.0, 112.0, 111.0, 112.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 133.0, 134.0, 185.0, 131.0, 133.0, 165.0, 148.0, 168.0, 131.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 162.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 106.0, 75.0, 75.0, 75.0, 75.0, 100.0, 76.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 126.0, 83.0, 84.0, 84.0, 124.0, 83.0, 85.0, 121.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 82.0, 62.0, 62.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 82.0, 81.0, 83.0, 84.0, 83.0, 83.0, 89.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 133.0, 143.0, 132.0, 128.0, 128.0, 141.0, 174.0, 141.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 168.0, 169.0, 167.0, 171.0, 173.0, 166.0, 167.0, 174.0, 168.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 70.0, 66.0, 66.0, 66.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1543.6, "alertThreshold": 2.0}]} 10:34:42 INFO - Return code: 0 10:34:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:34:42 ERROR - # TBPL SUCCESS # 10:34:42 INFO - Running post-action listener: _resource_record_post_action 10:34:42 INFO - ##### 10:34:42 INFO - ##### Finished run-tests step (success) 10:34:42 INFO - ##### 10:34:42 INFO - Running post-run listener: _resource_record_post_run 10:34:42 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 151552; Write bytes: 531906560; Read time: 48; Write time: 605264 10:34:42 INFO - TinderboxPrint: CPU usage
13.1% 10:34:42 INFO - TinderboxPrint: I/O read bytes / time
151,552 / 48 10:34:42 INFO - TinderboxPrint: I/O write bytes / time
531,906,560 / 605,264 10:34:42 INFO - TinderboxPrint: CPU idle
8,323.2 (86.9%) 10:34:42 INFO - TinderboxPrint: CPU user
1,209.8 (12.6%) 10:34:42 INFO - TinderboxPrint: Swap in / out
0 / 0 10:34:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 247771136; Read time: 0; Write time: 335632 10:34:42 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 151552; Write bytes: 283992064; Read time: 48; Write time: 269612 10:34:43 INFO - Running post-run listener: _upload_blobber_files 10:34:43 INFO - Blob upload gear active. 10:34:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:34:43 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 10:34:43 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:34:43 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:34:43 INFO - (blobuploader) - INFO - Open directory for files ... 10:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:44 INFO - (blobuploader) - INFO - Done attempting. 10:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:45 INFO - (blobuploader) - INFO - Done attempting. 10:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:34:49 INFO - (blobuploader) - INFO - Done attempting. 10:34:49 INFO - (blobuploader) - INFO - Iteration through files over. 10:34:49 INFO - Return code: 0 10:34:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:34:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:34:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c080524810f8059cd1c1a94786ed9a4e3d1c80d5be74ad6fc3b6a15723b4799333d286fd767c9c8e4ae02ac47d74a500ab1e7dc33c04682d67fc43d7f6a37c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb456bd3aa72e3027682a3fdc3de729f64384f5880a2ef0c32438663355523a2bfa82b248f8e95451cf2e10f3163656a4b207beb3adbc6c7222d76f9ebacfdd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d8ae9a5166244cb8bf5c3594959d09dd79f3bf90e06f12a2fd3d5dbfa030b33787f2a860bd3db8fa09b40dbfc412d30c168cc4b0fc46a81bf557dcdde8850a7"} 10:34:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:34:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:34:49 INFO - Contents: 10:34:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c080524810f8059cd1c1a94786ed9a4e3d1c80d5be74ad6fc3b6a15723b4799333d286fd767c9c8e4ae02ac47d74a500ab1e7dc33c04682d67fc43d7f6a37c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb456bd3aa72e3027682a3fdc3de729f64384f5880a2ef0c32438663355523a2bfa82b248f8e95451cf2e10f3163656a4b207beb3adbc6c7222d76f9ebacfdd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d8ae9a5166244cb8bf5c3594959d09dd79f3bf90e06f12a2fd3d5dbfa030b33787f2a860bd3db8fa09b40dbfc412d30c168cc4b0fc46a81bf557dcdde8850a7"} 10:34:49 INFO - Running post-run listener: copy_logs_to_upload_dir 10:34:49 INFO - Copying logs to upload dir... 10:34:49 INFO - mkdir: /builds/slave/test/build/upload/logs 10:34:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.208652 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-24 10:34:49.795528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 10:34:49.799013) ========= 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=7de08804244eb36560b44971000001c3-1464110045.945450-2117122449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c080524810f8059cd1c1a94786ed9a4e3d1c80d5be74ad6fc3b6a15723b4799333d286fd767c9c8e4ae02ac47d74a500ab1e7dc33c04682d67fc43d7f6a37c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb456bd3aa72e3027682a3fdc3de729f64384f5880a2ef0c32438663355523a2bfa82b248f8e95451cf2e10f3163656a4b207beb3adbc6c7222d76f9ebacfdd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d8ae9a5166244cb8bf5c3594959d09dd79f3bf90e06f12a2fd3d5dbfa030b33787f2a860bd3db8fa09b40dbfc412d30c168cc4b0fc46a81bf557dcdde8850a7"} build_url:https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011404 build_url: 'https://queue.taskcluster.net/v1/task/Noy-a_ofT0CmDU3iSRu2vg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c080524810f8059cd1c1a94786ed9a4e3d1c80d5be74ad6fc3b6a15723b4799333d286fd767c9c8e4ae02ac47d74a500ab1e7dc33c04682d67fc43d7f6a37c0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb456bd3aa72e3027682a3fdc3de729f64384f5880a2ef0c32438663355523a2bfa82b248f8e95451cf2e10f3163656a4b207beb3adbc6c7222d76f9ebacfdd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d8ae9a5166244cb8bf5c3594959d09dd79f3bf90e06f12a2fd3d5dbfa030b33787f2a860bd3db8fa09b40dbfc412d30c168cc4b0fc46a81bf557dcdde8850a7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 10:34:49.827604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:34:49.828342) ========= 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=7de08804244eb36560b44971000001c3-1464110045.945450-2117122449 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 10:34:49.909752) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 10:34:49.910414) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 10:34:49.911065) ========= ========= Total master_lag: 0.18 =========