builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1464882252.15 results: success (0) buildid: 20160602053015 builduid: dbb3070b718e4003a0ee9ef1d47f5207 revision: a92a2888973b566c4d4630df3a22869f80ff5587 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:12.145578) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:12.146070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:12.146490) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:12.173429) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:12.173830) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-02 08:44:12-- 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% 224M=0s 2016-06-02 08:44:12 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072126 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:12.260240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:12.260575) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019267 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:12.310713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 08:44:12.311095) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a92a2888973b566c4d4630df3a22869f80ff5587 --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 a92a2888973b566c4d4630df3a22869f80ff5587 --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=5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-02 08:44:12,596 truncating revision to first 12 chars 2016-06-02 08:44:12,596 Setting DEBUG logging. 2016-06-02 08:44:12,596 attempt 1/10 2016-06-02 08:44:12,596 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a92a2888973b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-02 08:44:13,238 unpacking tar archive at: fx-team-a92a2888973b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986343 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-02 08:44:13.311103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:13.311454) ========= script_repo_revision: a92a2888973b566c4d4630df3a22869f80ff5587 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:13.311896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:13.312172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-02 08:44:13.322405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-02 08:44:13.322855) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:13 INFO - MultiFileLogger online at 20160602 08:44:13 in /builds/slave/test 08:44:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:44:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:13 INFO - {'append_to_log': False, 08:44:13 INFO - 'base_work_dir': '/builds/slave/test', 08:44:13 INFO - 'blob_upload_branch': 'Fx-Team', 08:44:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:13 INFO - 'branch': 'Fx-Team', 08:44:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:13 INFO - 'config_files': ('talos/linux_config.py',), 08:44:13 INFO - 'default_actions': ('clobber', 08:44:13 INFO - 'read-buildbot-config', 08:44:13 INFO - 'download-and-extract', 08:44:13 INFO - 'populate-webroot', 08:44:13 INFO - 'create-virtualenv', 08:44:13 INFO - 'install', 08:44:13 INFO - 'run-tests'), 08:44:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:13 INFO - 'download_minidump_stackwalk': True, 08:44:13 INFO - 'download_symbols': 'ondemand', 08:44:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:13 INFO - 'installer_path': 'installer.exe', 08:44:13 INFO - 'log_level': 'info', 08:44:13 INFO - 'log_name': 'talos', 08:44:13 INFO - 'log_to_console': True, 08:44:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:13 INFO - 'opt_config_files': (), 08:44:13 INFO - 'pip_index': False, 08:44:13 INFO - 'sps_profile': False, 08:44:13 INFO - 'sps_profile_interval': 0, 08:44:13 INFO - 'suite': 'dromaeojs', 08:44:13 INFO - 'system_bits': '32', 08:44:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:13 INFO - 'title': 'talos-linux64-ix-011', 08:44:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:13 INFO - 'use_talos_json': True, 08:44:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:13 INFO - 'work_dir': 'build'} 08:44:13 INFO - ##### 08:44:13 INFO - ##### Running clobber step. 08:44:13 INFO - ##### 08:44:13 INFO - Running pre-action listener: _resource_record_pre_action 08:44:13 INFO - Running main action method: clobber 08:44:13 INFO - rmtree: /builds/slave/test/build 08:44:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:14 INFO - Running post-action listener: _resource_record_post_action 08:44:14 INFO - ##### 08:44:14 INFO - ##### Finished clobber step (success) 08:44:14 INFO - ##### 08:44:14 INFO - ##### 08:44:14 INFO - ##### Running read-buildbot-config step. 08:44:14 INFO - ##### 08:44:14 INFO - Running pre-action listener: _resource_record_pre_action 08:44:14 INFO - Running main action method: read_buildbot_config 08:44:14 INFO - Using buildbot properties: 08:44:14 INFO - { 08:44:14 INFO - "project": "", 08:44:14 INFO - "product": "firefox", 08:44:14 INFO - "script_repo_revision": "production", 08:44:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:44:14 INFO - "repository": "", 08:44:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:44:14 INFO - "buildid": "20160602053015", 08:44:14 INFO - "pgo_build": "True", 08:44:14 INFO - "basedir": "/builds/slave/test", 08:44:14 INFO - "buildnumber": 1216, 08:44:14 INFO - "slavename": "talos-linux64-ix-011", 08:44:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:44:14 INFO - "platform": "ubuntu64_hw", 08:44:14 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:44:14 INFO - "branch": "fx-team", 08:44:14 INFO - "repo_path": "integration/fx-team", 08:44:14 INFO - "revision": "a92a2888973b566c4d4630df3a22869f80ff5587", 08:44:14 INFO - "stage_platform": "linux64-pgo", 08:44:14 INFO - "builduid": "dbb3070b718e4003a0ee9ef1d47f5207", 08:44:14 INFO - "slavebuilddir": "test" 08:44:14 INFO - } 08:44:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:44:14 INFO - Running post-action listener: _resource_record_post_action 08:44:14 INFO - ##### 08:44:14 INFO - ##### Finished read-buildbot-config step (success) 08:44:14 INFO - ##### 08:44:14 INFO - ##### 08:44:14 INFO - ##### Running download-and-extract step. 08:44:14 INFO - ##### 08:44:14 INFO - Running pre-action listener: _resource_record_pre_action 08:44:14 INFO - Running main action method: download_and_extract 08:44:14 INFO - mkdir: /builds/slave/test/build/tests 08:44: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')]} 08:44:14 INFO - https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:44:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:44:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:44:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/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 08:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/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 08:44:14 INFO - Downloaded 1361 bytes. 08:44:14 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:44:14 INFO - Using the following test package requirements: 08:44:14 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:14 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:44:14 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:44:14 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:14 INFO - u'jsshell-linux-x86_64.zip'], 08:44:14 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:44:14 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:14 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:44:14 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:44:14 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:44:14 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:14 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:44:14 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:44: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')]} 08:44:14 INFO - https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:44:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:44:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:44:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/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 08:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/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 08:44:16 INFO - Downloaded 24439699 bytes. 08:44:16 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'] 08:44:16 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 08:44:17 INFO - Return code: 0 08:44:17 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 08:44:17 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')]} 08:44:17 INFO - https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:44:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:44:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:44:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/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 08:44:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/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 08:44:18 INFO - Downloaded 24439699 bytes. 08:44:18 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'] 08:44:18 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 08:44:20 INFO - Return code: 0 08:44: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')]} 08:44:20 INFO - https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:44:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:44:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:44:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/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 08:44:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/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 08:44:21 INFO - Downloaded 10834055 bytes. 08:44:21 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'] 08:44:21 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 08:44:21 INFO - Return code: 0 08:44:21 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')]} 08:44:21 INFO - https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:44:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:44:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:44:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/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 08:44:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WwKabylfTaeW4W3PyOB64Q/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 08:44:23 INFO - Downloaded 59057139 bytes. 08:44:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:44:23 INFO - mkdir: /builds/slave/test/properties 08:44:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:44:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:44:23 INFO - Contents: 08:44:23 INFO - build_url:https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:44:24 INFO - Running post-action listener: _resource_record_post_action 08:44:24 INFO - Running post-action listener: set_extra_try_arguments 08:44:24 INFO - ##### 08:44:24 INFO - ##### Finished download-and-extract step (success) 08:44:24 INFO - ##### 08:44:24 INFO - ##### 08:44:24 INFO - ##### Running populate-webroot step. 08:44:24 INFO - ##### 08:44:24 INFO - Running pre-action listener: _resource_record_pre_action 08:44:24 INFO - Running main action method: populate_webroot 08:44:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:44:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:44:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:44:24 INFO - '--tppagecycles', 08:44:24 INFO - '7'], 08:44:24 INFO - 'tests': ['tsvgm']}}, 08:44:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:44:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:44:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:44:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:44:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:44:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:44:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:24 INFO - 'talos_options': ['--disable-e10s'], 08:44:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:24 INFO - 'talos_options': ['--disable-e10s'], 08:44:24 INFO - 'tests': ['damp', 'tps']}, 08:44:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:24 INFO - 'tests': ['damp', 'tps']}, 08:44:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:44:24 INFO - 'tests': ['dromaeo_dom']}, 08:44:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:44:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:44:24 INFO - 'tests': ['a11yr', 08:44:24 INFO - 'ts_paint', 08:44:24 INFO - 'tpaint', 08:44:24 INFO - 'sessionrestore', 08:44:24 INFO - 'sessionrestore_no_auto_restore', 08:44:24 INFO - 'tabpaint']}, 08:44:24 INFO - 'other-e10s': {'tests': ['a11yr', 08:44:24 INFO - 'ts_paint', 08:44:24 INFO - 'tpaint', 08:44:24 INFO - 'sessionrestore', 08:44:24 INFO - 'sessionrestore_no_auto_restore', 08:44:24 INFO - 'tabpaint']}, 08:44:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:44:24 INFO - 'ts_paint', 08:44:24 INFO - 'tpaint', 08:44:24 INFO - 'sessionrestore', 08:44:24 INFO - 'sessionrestore_no_auto_restore', 08:44:24 INFO - 'tabpaint']}, 08:44:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:44:24 INFO - 'ts_paint', 08:44:24 INFO - 'tpaint', 08:44:24 INFO - 'sessionrestore', 08:44:24 INFO - 'sessionrestore_no_auto_restore', 08:44:24 INFO - 'tabpaint']}, 08:44:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:44:24 INFO - 'tests': ['a11yr', 08:44:24 INFO - 'ts_paint', 08:44:24 INFO - 'tpaint', 08:44:24 INFO - 'sessionrestore', 08:44:24 INFO - 'sessionrestore_no_auto_restore', 08:44:24 INFO - 'tabpaint']}, 08:44:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:44:24 INFO - 'tests': ['a11yr', 08:44:24 INFO - 'ts_paint', 08:44:24 INFO - 'tpaint', 08:44:24 INFO - 'sessionrestore', 08:44:24 INFO - 'sessionrestore_no_auto_restore', 08:44:24 INFO - 'tabpaint']}, 08:44:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:44:24 INFO - 'tests': ['tsvgx', 08:44:24 INFO - 'tsvgr_opacity', 08:44:24 INFO - 'tart', 08:44:24 INFO - 'tscrollx', 08:44:24 INFO - 'cart']}, 08:44:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:44:24 INFO - 'tsvgr_opacity', 08:44:24 INFO - 'tart', 08:44:24 INFO - 'tscrollx', 08:44:24 INFO - 'cart']}, 08:44:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:24 INFO - 'talos_options': ['--disable-e10s'], 08:44:24 INFO - 'tests': ['tp5o']}, 08:44:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:24 INFO - 'tests': ['tp5o']}, 08:44:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:24 INFO - 'talos_options': ['--disable-e10s', 08:44:24 INFO - '--xperf_path', 08:44:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:24 INFO - 'tests': ['tp5n']}, 08:44:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:44:24 INFO - 'talos_options': ['--xperf_path', 08:44:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:24 INFO - 'tests': ['tp5n']}}, 08:44:24 INFO - 'talos.zip': {'path': '', 08:44:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:44:24 INFO - Running post-action listener: _resource_record_post_action 08:44:24 INFO - ##### 08:44:24 INFO - ##### Finished populate-webroot step (success) 08:44:24 INFO - ##### 08:44:24 INFO - ##### 08:44:24 INFO - ##### Running create-virtualenv step. 08:44:24 INFO - ##### 08:44:24 INFO - Running pre-action listener: _resource_record_pre_action 08:44:24 INFO - Running main action method: create_virtualenv 08:44:24 INFO - Creating virtualenv /builds/slave/test/build/venv 08:44:24 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 08:44:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:44:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:44:24 INFO - Using real prefix '/usr' 08:44:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:44:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:44:26 INFO - Installing pip.................done. 08:44:26 INFO - Return code: 0 08:44:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:26 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 0x7f69f3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, '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 0x26078c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2607d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', '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 08:44:26 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 08:44:26 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 08:44:26 INFO - Using env: {'DISPLAY': ':0', 08:44:26 INFO - 'HOME': '/home/cltbld', 08:44:26 INFO - 'LANG': 'en_US.UTF-8', 08:44:26 INFO - 'LANGUAGE': 'en_US:en', 08:44:26 INFO - 'LOGNAME': 'cltbld', 08:44:26 INFO - 'MAIL': '/var/mail/cltbld', 08:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:26 INFO - 'MOZ_NO_REMOTE': '1', 08:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:26 INFO - 'NO_EM_RESTART': '1', 08:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:26 INFO - 'PWD': '/builds/slave/test', 08:44:26 INFO - 'SHELL': '/bin/bash', 08:44:26 INFO - 'SHLVL': '1', 08:44:26 INFO - 'TERM': 'linux', 08:44:26 INFO - 'TMOUT': '86400', 08:44:26 INFO - 'USER': 'cltbld', 08:44:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', 08:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:26 INFO - '_': '/tools/buildbot/bin/python'} 08:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:27 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 08:44:27 INFO - Cleaning up... 08:44:27 INFO - Return code: 0 08:44:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:44:27 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')]} 08:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:27 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')]} 08:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:27 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 0x7f69f3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, '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 0x26078c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2607d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', '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 08:44:27 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 08:44:27 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 08:44:27 INFO - Using env: {'DISPLAY': ':0', 08:44:27 INFO - 'HOME': '/home/cltbld', 08:44:27 INFO - 'LANG': 'en_US.UTF-8', 08:44:27 INFO - 'LANGUAGE': 'en_US:en', 08:44:27 INFO - 'LOGNAME': 'cltbld', 08:44:27 INFO - 'MAIL': '/var/mail/cltbld', 08:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:27 INFO - 'MOZ_NO_REMOTE': '1', 08:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:27 INFO - 'NO_EM_RESTART': '1', 08:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:27 INFO - 'PWD': '/builds/slave/test', 08:44:27 INFO - 'SHELL': '/bin/bash', 08:44:27 INFO - 'SHLVL': '1', 08:44:27 INFO - 'TERM': 'linux', 08:44:27 INFO - 'TMOUT': '86400', 08:44:27 INFO - 'USER': 'cltbld', 08:44:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', 08:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:27 INFO - '_': '/tools/buildbot/bin/python'} 08:44:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:27 INFO - Downloading/unpacking psutil>=3.1.1 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:44:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:29 INFO - Installing collected packages: psutil 08:44:29 INFO - Running setup.py install for psutil 08:44:29 INFO - building 'psutil._psutil_linux' extension 08:44:29 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 08:44:29 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 08:44:29 INFO - building 'psutil._psutil_posix' extension 08:44:29 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 08:44:29 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 08:44:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:29 INFO - Successfully installed psutil 08:44:29 INFO - Cleaning up... 08:44:29 INFO - Return code: 0 08:44:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:29 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 0x7f69f3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, '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 0x26078c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2607d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', '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 08:44:29 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 08:44:29 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 08:44:29 INFO - Using env: {'DISPLAY': ':0', 08:44:29 INFO - 'HOME': '/home/cltbld', 08:44:29 INFO - 'LANG': 'en_US.UTF-8', 08:44:29 INFO - 'LANGUAGE': 'en_US:en', 08:44:29 INFO - 'LOGNAME': 'cltbld', 08:44:29 INFO - 'MAIL': '/var/mail/cltbld', 08:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:29 INFO - 'MOZ_NO_REMOTE': '1', 08:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:29 INFO - 'NO_EM_RESTART': '1', 08:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:29 INFO - 'PWD': '/builds/slave/test', 08:44:29 INFO - 'SHELL': '/bin/bash', 08:44:29 INFO - 'SHLVL': '1', 08:44:29 INFO - 'TERM': 'linux', 08:44:29 INFO - 'TMOUT': '86400', 08:44:29 INFO - 'USER': 'cltbld', 08:44:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', 08:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:29 INFO - '_': '/tools/buildbot/bin/python'} 08:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:44:30 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 08:44:30 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 08:44:30 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 08:44:30 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 08:44:30 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 08:44:30 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 08:44:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:44:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:44:32 INFO - Installing collected packages: mozsystemmonitor 08:44:32 INFO - Running setup.py install for mozsystemmonitor 08:44:32 INFO - Successfully installed mozsystemmonitor 08:44:32 INFO - Cleaning up... 08:44:32 INFO - Return code: 0 08:44:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:32 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 0x7f69f3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, '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 0x26078c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2607d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', '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 08:44:32 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 08:44:32 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 08:44:32 INFO - Using env: {'DISPLAY': ':0', 08:44:32 INFO - 'HOME': '/home/cltbld', 08:44:32 INFO - 'LANG': 'en_US.UTF-8', 08:44:32 INFO - 'LANGUAGE': 'en_US:en', 08:44:32 INFO - 'LOGNAME': 'cltbld', 08:44:32 INFO - 'MAIL': '/var/mail/cltbld', 08:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:32 INFO - 'MOZ_NO_REMOTE': '1', 08:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:32 INFO - 'NO_EM_RESTART': '1', 08:44:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:32 INFO - 'PWD': '/builds/slave/test', 08:44:32 INFO - 'SHELL': '/bin/bash', 08:44:32 INFO - 'SHLVL': '1', 08:44:32 INFO - 'TERM': 'linux', 08:44:32 INFO - 'TMOUT': '86400', 08:44:32 INFO - 'USER': 'cltbld', 08:44:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', 08:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:32 INFO - '_': '/tools/buildbot/bin/python'} 08:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:32 INFO - Downloading/unpacking blobuploader==1.2.4 08:44:32 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 08:44:32 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 08:44:32 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 08:44:32 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 08:44:32 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 08:44:32 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 08:44:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:35 INFO - Downloading docopt-0.6.1.tar.gz 08:44:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:35 INFO - Running setup.py install for blobuploader 08:44:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:35 INFO - Running setup.py install for requests 08:44:35 INFO - Running setup.py install for docopt 08:44:35 INFO - Successfully installed blobuploader requests docopt 08:44:35 INFO - Cleaning up... 08:44:35 INFO - Return code: 0 08:44:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:35 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 0x7f69f3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, '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 0x26078c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2607d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', '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 08:44:35 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 08:44:35 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 08:44:35 INFO - Using env: {'DISPLAY': ':0', 08:44:35 INFO - 'HOME': '/home/cltbld', 08:44:35 INFO - 'LANG': 'en_US.UTF-8', 08:44:35 INFO - 'LANGUAGE': 'en_US:en', 08:44:35 INFO - 'LOGNAME': 'cltbld', 08:44:35 INFO - 'MAIL': '/var/mail/cltbld', 08:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:35 INFO - 'MOZ_NO_REMOTE': '1', 08:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:35 INFO - 'NO_EM_RESTART': '1', 08:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:35 INFO - 'PWD': '/builds/slave/test', 08:44:35 INFO - 'SHELL': '/bin/bash', 08:44:35 INFO - 'SHLVL': '1', 08:44:35 INFO - 'TERM': 'linux', 08:44:35 INFO - 'TMOUT': '86400', 08:44:35 INFO - 'USER': 'cltbld', 08:44:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', 08:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:35 INFO - '_': '/tools/buildbot/bin/python'} 08:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:35 INFO - Running setup.py (path:/tmp/pip-UKMhNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:35 INFO - Running setup.py (path:/tmp/pip-I4W7sF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:36 INFO - Running setup.py (path:/tmp/pip-kxh_VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:36 INFO - Running setup.py (path:/tmp/pip-3b6p9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:36 INFO - Running setup.py (path:/tmp/pip-nch3AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:36 INFO - Running setup.py (path:/tmp/pip-IJRkkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:36 INFO - Running setup.py (path:/tmp/pip-MykRj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:36 INFO - Running setup.py (path:/tmp/pip-FYyLjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:36 INFO - Running setup.py (path:/tmp/pip-WBZH2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:36 INFO - Running setup.py (path:/tmp/pip-RGgdK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:36 INFO - Running setup.py (path:/tmp/pip-7jP9up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:36 INFO - Running setup.py (path:/tmp/pip-FPYI3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:36 INFO - Running setup.py (path:/tmp/pip-rIRHiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:36 INFO - Running setup.py (path:/tmp/pip-bOHxLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:36 INFO - Running setup.py (path:/tmp/pip-V4Geb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:36 INFO - Running setup.py (path:/tmp/pip-ScVIiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:37 INFO - Running setup.py (path:/tmp/pip-1kU0NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:44:37 INFO - Running setup.py install for manifestparser 08:44:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:44:37 INFO - Running setup.py install for mozcrash 08:44:37 INFO - Running setup.py install for mozdebug 08:44:37 INFO - Running setup.py install for mozdevice 08:44:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:44:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:44:37 INFO - Running setup.py install for mozfile 08:44:37 INFO - Running setup.py install for mozhttpd 08:44:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:44:37 INFO - Running setup.py install for mozinfo 08:44:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:44:37 INFO - Running setup.py install for mozInstall 08:44:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:44:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:44:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:44:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:44:37 INFO - Running setup.py install for mozleak 08:44:38 INFO - Running setup.py install for mozlog 08:44:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:44:38 INFO - Running setup.py install for moznetwork 08:44:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:44:38 INFO - Running setup.py install for mozprocess 08:44:38 INFO - Running setup.py install for mozprofile 08:44:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:44:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:44:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:44:38 INFO - Running setup.py install for mozrunner 08:44:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:44:38 INFO - Running setup.py install for mozscreenshot 08:44:38 INFO - Running setup.py install for moztest 08:44:38 INFO - Running setup.py install for mozversion 08:44:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:44:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:44:38 INFO - Cleaning up... 08:44:38 INFO - Return code: 0 08:44:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:38 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')]} 08:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:38 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')]} 08:44:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:38 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 0x7f69f3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, '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 0x26078c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2607d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', '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 08:44:38 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 08:44:38 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 08:44:38 INFO - Using env: {'DISPLAY': ':0', 08:44:38 INFO - 'HOME': '/home/cltbld', 08:44:38 INFO - 'LANG': 'en_US.UTF-8', 08:44:38 INFO - 'LANGUAGE': 'en_US:en', 08:44:38 INFO - 'LOGNAME': 'cltbld', 08:44:38 INFO - 'MAIL': '/var/mail/cltbld', 08:44:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:38 INFO - 'MOZ_NO_REMOTE': '1', 08:44:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:38 INFO - 'NO_EM_RESTART': '1', 08:44:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:38 INFO - 'PWD': '/builds/slave/test', 08:44:38 INFO - 'SHELL': '/bin/bash', 08:44:38 INFO - 'SHLVL': '1', 08:44:38 INFO - 'TERM': 'linux', 08:44:38 INFO - 'TMOUT': '86400', 08:44:38 INFO - 'USER': 'cltbld', 08:44:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', 08:44:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:38 INFO - '_': '/tools/buildbot/bin/python'} 08:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:44:39 INFO - Running setup.py (path:/tmp/pip-d2Lynr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:44:39 INFO - Running setup.py (path:/tmp/pip-MZeClE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:44:39 INFO - Running setup.py (path:/tmp/pip-wTM5zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:44:39 INFO - Running setup.py (path:/tmp/pip-R719Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:44:39 INFO - Running setup.py (path:/tmp/pip-_TOVsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:44:39 INFO - Running setup.py (path:/tmp/pip-uFEl3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:44:39 INFO - Running setup.py (path:/tmp/pip-yjMtyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:44:39 INFO - Running setup.py (path:/tmp/pip-Rhfm0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:44:39 INFO - Running setup.py (path:/tmp/pip-3z1Rza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:44:39 INFO - Running setup.py (path:/tmp/pip-yoTPB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:44:39 INFO - Running setup.py (path:/tmp/pip-qBUedJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:44:39 INFO - Running setup.py (path:/tmp/pip-AeED4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:44:39 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)) 08:44:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:44:40 INFO - Running setup.py (path:/tmp/pip-2AOJCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:44:40 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)) 08:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:44:40 INFO - Running setup.py (path:/tmp/pip-wCzbbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:44:40 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)) 08:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:40 INFO - Running setup.py (path:/tmp/pip-bvklsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:44:40 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)) 08:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:44:40 INFO - Running setup.py (path:/tmp/pip-c6HCBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:44:40 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)) 08:44:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:44:40 INFO - Running setup.py (path:/tmp/pip-jTxa48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:44:40 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)) 08:44:40 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)) 08:44:40 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)) 08:44:40 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)) 08:44:40 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)) 08:44:40 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)) 08:44:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:44:40 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 08:44:40 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 08:44:40 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 08:44:40 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 08:44:40 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 08:44:40 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 08:44:42 INFO - Downloading blessings-1.6.tar.gz 08:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:44:42 INFO - Installing collected packages: blessings 08:44:42 INFO - Running setup.py install for blessings 08:44:42 INFO - Successfully installed blessings 08:44:42 INFO - Cleaning up... 08:44:42 INFO - Return code: 0 08:44:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:44:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:42 INFO - Reading from file tmpfile_stdout 08:44:42 INFO - Current package versions: 08:44:42 INFO - argparse == 1.2.1 08:44:42 INFO - blessings == 1.6 08:44:42 INFO - blobuploader == 1.2.4 08:44:42 INFO - docopt == 0.6.1 08:44:42 INFO - manifestparser == 1.1 08:44:42 INFO - mozInstall == 1.12 08:44:42 INFO - mozcrash == 0.17 08:44:42 INFO - mozdebug == 0.1 08:44:42 INFO - mozdevice == 0.48 08:44:42 INFO - mozfile == 1.2 08:44:42 INFO - mozhttpd == 0.7 08:44:42 INFO - mozinfo == 0.9 08:44:42 INFO - mozleak == 0.1 08:44:42 INFO - mozlog == 3.2 08:44:42 INFO - moznetwork == 0.27 08:44:42 INFO - mozprocess == 0.22 08:44:42 INFO - mozprofile == 0.28 08:44:42 INFO - mozrunner == 6.11 08:44:42 INFO - mozscreenshot == 0.1 08:44:42 INFO - mozsystemmonitor == 0.3 08:44:42 INFO - moztest == 0.7 08:44:42 INFO - mozversion == 1.4 08:44:42 INFO - psutil == 3.1.1 08:44:42 INFO - requests == 1.2.3 08:44:42 INFO - wsgiref == 0.1.2 08:44:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:42 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 0x7f69f3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, '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 0x26078c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2607d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', '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 08:44:42 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 08:44:42 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 08:44:42 INFO - Using env: {'DISPLAY': ':0', 08:44:42 INFO - 'HOME': '/home/cltbld', 08:44:42 INFO - 'LANG': 'en_US.UTF-8', 08:44:42 INFO - 'LANGUAGE': 'en_US:en', 08:44:42 INFO - 'LOGNAME': 'cltbld', 08:44:42 INFO - 'MAIL': '/var/mail/cltbld', 08:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:42 INFO - 'MOZ_NO_REMOTE': '1', 08:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:42 INFO - 'NO_EM_RESTART': '1', 08:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:42 INFO - 'PWD': '/builds/slave/test', 08:44:42 INFO - 'SHELL': '/bin/bash', 08:44:42 INFO - 'SHLVL': '1', 08:44:42 INFO - 'TERM': 'linux', 08:44:42 INFO - 'TMOUT': '86400', 08:44:42 INFO - 'USER': 'cltbld', 08:44:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', 08:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:42 INFO - '_': '/tools/buildbot/bin/python'} 08:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:42 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)) 08:44:42 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)) 08:44:42 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)) 08:44:42 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)) 08:44:42 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)) 08:44:42 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)) 08:44:42 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)) 08:44:42 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)) 08:44:42 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)) 08:44:42 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)) 08:44:42 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)) 08:44:42 INFO - Cleaning up... 08:44:42 INFO - Return code: 0 08:44:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f69f3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, '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 0x26078c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2607d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', '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 08:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:44:42 INFO - Using env: {'DISPLAY': ':0', 08:44:42 INFO - 'HOME': '/home/cltbld', 08:44:42 INFO - 'LANG': 'en_US.UTF-8', 08:44:42 INFO - 'LANGUAGE': 'en_US:en', 08:44:42 INFO - 'LOGNAME': 'cltbld', 08:44:42 INFO - 'MAIL': '/var/mail/cltbld', 08:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:42 INFO - 'MOZ_NO_REMOTE': '1', 08:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:42 INFO - 'NO_EM_RESTART': '1', 08:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:42 INFO - 'PWD': '/builds/slave/test', 08:44:42 INFO - 'SHELL': '/bin/bash', 08:44:42 INFO - 'SHLVL': '1', 08:44:42 INFO - 'TERM': 'linux', 08:44:42 INFO - 'TMOUT': '86400', 08:44:42 INFO - 'USER': 'cltbld', 08:44:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', 08:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:42 INFO - '_': '/tools/buildbot/bin/python'} 08:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:43 INFO - Downloading/unpacking jsonschema 08:44:43 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 08:44:43 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 08:44:43 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 08:44:43 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 08:44:43 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 08:44:43 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 08:44:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:44:45 INFO - Downloading/unpacking functools32 (from jsonschema) 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 INFO - Downloading functools32-3.2.3-2.tar.gz 08:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:44:45 INFO - warning: no files found matching '*.txt' 08:44:45 INFO - no previously-included directories found matching 'build' 08:44:45 INFO - no previously-included directories found matching 'dist' 08:44:45 INFO - no previously-included directories found matching '.git*' 08:44:45 INFO - Installing collected packages: jsonschema, functools32 08:44:45 INFO - Running setup.py install for functools32 08:44:45 INFO - warning: no files found matching '*.txt' 08:44:45 INFO - no previously-included directories found matching 'build' 08:44:45 INFO - no previously-included directories found matching 'dist' 08:44:45 INFO - no previously-included directories found matching '.git*' 08:44:45 INFO - Successfully installed jsonschema functools32 08:44:45 INFO - Cleaning up... 08:44:45 INFO - Return code: 0 08:44:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:45 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 0x7f69f3aa5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ac8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2577770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26069c0>, '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 0x26078c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2607d50>, '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': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', '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 08:44:45 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 08:44:45 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 08:44:45 INFO - Using env: {'DISPLAY': ':0', 08:44:45 INFO - 'HOME': '/home/cltbld', 08:44:45 INFO - 'LANG': 'en_US.UTF-8', 08:44:45 INFO - 'LANGUAGE': 'en_US:en', 08:44:45 INFO - 'LOGNAME': 'cltbld', 08:44:45 INFO - 'MAIL': '/var/mail/cltbld', 08:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:45 INFO - 'MOZ_NO_REMOTE': '1', 08:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:44:45 INFO - 'NO_EM_RESTART': '1', 08:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:45 INFO - 'PWD': '/builds/slave/test', 08:44:45 INFO - 'SHELL': '/bin/bash', 08:44:45 INFO - 'SHLVL': '1', 08:44:45 INFO - 'TERM': 'linux', 08:44:45 INFO - 'TMOUT': '86400', 08:44:45 INFO - 'USER': 'cltbld', 08:44:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', 08:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:45 INFO - '_': '/tools/buildbot/bin/python'} 08:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:45 INFO - Downloading/unpacking flake8 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 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 08:44:45 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 08:44:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:44:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:44:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 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 08:44:47 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 08:44:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:44:48 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 08:44:48 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 08:44:48 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 08:44:48 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 08:44:48 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 08:44:48 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 08:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:44:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:44:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:44:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:44:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:44:48 INFO - no previously-included directories found matching 'docs/_build' 08:44:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:44:48 INFO - Running setup.py install for pep8 08:44:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:44:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:44:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:44:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:44:48 INFO - no previously-included directories found matching 'docs/_build' 08:44:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:44:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:44:48 INFO - Cleaning up... 08:44:48 INFO - Return code: 0 08:44:48 INFO - Running post-action listener: _resource_record_post_action 08:44:48 INFO - Running post-action listener: _start_resource_monitoring 08:44:48 INFO - Starting resource monitoring. 08:44:48 INFO - ##### 08:44:48 INFO - ##### Finished create-virtualenv step (success) 08:44:48 INFO - ##### 08:44:48 INFO - ##### 08:44:48 INFO - ##### Running install step. 08:44:48 INFO - ##### 08:44:48 INFO - Running pre-action listener: _resource_record_pre_action 08:44:48 INFO - Running main action method: install 08:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:44:48 INFO - Reading from file tmpfile_stdout 08:44:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:44:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:44:48 INFO - Reading from file tmpfile_stdout 08:44:48 INFO - Output received: 08:44:48 INFO - Usage: mozinstall [options] installer 08:44:48 INFO - Options: 08:44:48 INFO - -h, --help show this help message and exit 08:44:48 INFO - -d DEST, --destination=DEST 08:44:48 INFO - Directory to install application into. [default: 08:44:48 INFO - "/builds/slave/test"] 08:44:48 INFO - --app=APP Application being installed. [default: firefox] 08:44:48 INFO - mkdir: /builds/slave/test/build/application 08:44:48 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'] 08:44:48 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 08:45:06 INFO - Reading from file tmpfile_stdout 08:45:06 INFO - Output received: 08:45:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:06 INFO - Running post-action listener: _resource_record_post_action 08:45:06 INFO - ##### 08:45:06 INFO - ##### Finished install step (success) 08:45:06 INFO - ##### 08:45:06 INFO - ##### 08:45:06 INFO - ##### Running run-tests step. 08:45:06 INFO - ##### 08:45:06 INFO - Running pre-action listener: _resource_record_pre_action 08:45:06 INFO - Running main action method: run_tests 08:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:06 INFO - Python 2.7.3 08:45:06 INFO - Return code: 0 08:45:06 INFO - grabbing minidump binary from tooltool 08:45:06 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')]} 08:45:06 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 0x26069c0>, '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 0x26078c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2607d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:06 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 08:45:06 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 08:45:06 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 08:45:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:06 INFO - Return code: 0 08:45:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:45:07 INFO - Return code: 0 08:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 08:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 08:45:07 INFO - Using env: {'DISPLAY': ':0', 08:45:07 INFO - 'HOME': '/home/cltbld', 08:45:07 INFO - 'LANG': 'en_US.UTF-8', 08:45:07 INFO - 'LANGUAGE': 'en_US:en', 08:45:07 INFO - 'LOGNAME': 'cltbld', 08:45:07 INFO - 'MAIL': '/var/mail/cltbld', 08:45:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:07 INFO - 'MOZ_NO_REMOTE': '1', 08:45:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:07 INFO - 'NO_EM_RESTART': '1', 08:45:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:07 INFO - 'PWD': '/builds/slave/test', 08:45:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:07 INFO - 'SHELL': '/bin/bash', 08:45:07 INFO - 'SHLVL': '1', 08:45:07 INFO - 'TERM': 'linux', 08:45:07 INFO - 'TMOUT': '86400', 08:45:07 INFO - 'USER': 'cltbld', 08:45:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617', 08:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:07 INFO - '_': '/tools/buildbot/bin/python'} 08:45:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 08:45:07 INFO - mozversion application_buildid: 20160602053015 08:45:07 INFO - mozversion application_changeset: a92a2888973b566c4d4630df3a22869f80ff5587 08:45:07 INFO - mozversion application_display_name: Nightly 08:45:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:07 INFO - mozversion application_name: Firefox 08:45:07 INFO - mozversion application_remotingname: firefox 08:45:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:45:07 INFO - mozversion application_vendor: Mozilla 08:45:07 INFO - mozversion application_version: 49.0a1 08:45:07 INFO - mozversion platform_buildid: 20160602053015 08:45:07 INFO - mozversion platform_changeset: a92a2888973b566c4d4630df3a22869f80ff5587 08:45:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:45:07 INFO - mozversion platform_version: 49.0a1 08:45:07 INFO - using testdate: 1464882307 08:45:07 INFO - actual date: 1464882307 08:45:07 INFO - starting webserver on 'localhost:52392' 08:45:07 INFO - SUITE-START | Running 2 tests 08:45:07 INFO - TEST-START | dromaeo_css 08:45:07 INFO - operating with platform_type : linux_ 08:45:07 INFO - Initialising browser for dromaeo_css test... 08:45:07 INFO - TEST-INFO | started process 26756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbKlurr/profile http://localhost:52392/getInfo.html) 08:45:12 INFO - PROCESS | 26756 | __metrics Screen width/height:1600/1200 08:45:12 INFO - PROCESS | 26756 | colorDepth:24 08:45:12 INFO - PROCESS | 26756 | Browser inner width/height: 1024/697 08:45:12 INFO - PROCESS | 26756 | __metrics 08:45:13 ERROR - PROCESS | 26756 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:45:14 INFO - TEST-INFO | 26756: exit 0 08:45:14 INFO - Browser initialized. 08:45:14 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:14 INFO - TEST-INFO | started process 26837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbKlurr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:26 INFO - PROCESS | 26837 | RSS: Main: 155893760 08:45:26 INFO - PROCESS | 26837 | 08:46:17 INFO - PROCESS | 26837 | 1464882377010 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] 08:48:25 INFO - PROCESS | 26837 | Cycle 1(1): loaded http://localhost:52392/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52392/tests/dromaeo/cssquery-ext.html) 08:48:26 INFO - PROCESS | 26837 | RSS: Main: 258125824 08:48:26 INFO - PROCESS | 26837 | 08:51:29 INFO - PROCESS | 26837 | Cycle 1(1): loaded http://localhost:52392/tests/dromaeo/cssquery-ext.html (next: http://localhost:52392/tests/dromaeo/cssquery-jquery.html) 08:51:29 INFO - PROCESS | 26837 | RSS: Main: 241713152 08:51:29 INFO - PROCESS | 26837 | 08:54:31 INFO - PROCESS | 26837 | Cycle 1(1): loaded http://localhost:52392/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52392/tests/dromaeo/cssquery-mootools.html) 08:54:32 INFO - PROCESS | 26837 | RSS: Main: 243720192 08:54:32 INFO - PROCESS | 26837 | 08:57:34 INFO - PROCESS | 26837 | Cycle 1(1): loaded http://localhost:52392/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52392/tests/dromaeo/cssquery-prototype.html) 08:57:35 INFO - PROCESS | 26837 | RSS: Main: 234676224 08:57:35 INFO - PROCESS | 26837 | 09:00:37 INFO - PROCESS | 26837 | Cycle 1(1): loaded http://localhost:52392/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52392/tests/dromaeo/cssquery-yui.html) 09:00:38 INFO - PROCESS | 26837 | RSS: Main: 224309248 09:00:38 INFO - PROCESS | 26837 | 09:03:40 INFO - PROCESS | 26837 | Cycle 1(1): loaded http://localhost:52392/tests/dromaeo/cssquery-yui.html (next: http://localhost:52392/tests/dromaeo/cssquery-dojo.html) 09:03:41 INFO - PROCESS | 26837 | RSS: Main: 260190208 09:03:41 INFO - PROCESS | 26837 | 09:03:41 INFO - PROCESS | 26837 | __start_tp_report 09:03:41 INFO - PROCESS | 26837 | _x_x_mozilla_page_load 09:03:41 INFO - PROCESS | 26837 | _x_x_mozilla_page_load_details 09:03:41 INFO - PROCESS | 26837 | |i|pagename|runs| 09:03:41 INFO - PROCESS | 26837 | |0;dojo.html;3137.0588823352996;3143.764217683673;3159.7946133501323;3182.490801471765;3205.6794320567947;5230.947690523094;5283.973580132104;5373.946260537394;5478.945210547893;5483.040467918113;5354.839354819352;5367.543758780498;5407.297051383324;5497.285352904117;5508.228847961279;4811.783469743861;4816.494268101851;4891.290762839386;4893.510648935096;5095;5008.524190201943;5014.648974571782;5024.296598476216;5034.798608055692;5055.9241611375855;4756.072565849643;4810.39870016248;4811.855644330641;4826.3001864729595;4891.608671306305;4858.344123543312;4873.342098816685;4874.780634871439;4878.02439512099;4882.975585122087;4841.370621819176;4863;4907.631927605444;4956.231784073474;5025.0954828130925;5314.282571852789;5353.304070470853;5376.462353764592;5458.399576046631;5458.4814442627885;5923.526117910556;5929.110633404981;5932.288125424977;5934.1692163097205;5934.436228558323;5580.91628625571;5759.971200143972;5787.33445653751;5788.565857560699;5946.524278057745;5470.398256191816;5483.232347471358;5485.067538518421;5491.093969494988;5492.505674489315;5951.256092988377;5953.553483488756;5956.880862382728;5961.821145365646;5967.940320596826;5542.140968149944;5677.545796336283;5735.426457354231;5749.080147176515;5750.1949727038245;5894.322152952465;5923.881522369615;5938.2280303560265;5946.286445626466;5957.404259574095;5844.444777746107;5852.297724273115;5858.091995740667;5859.619124756877;5870.530357571384;5487.039768040577;5666.4050274721385;5716.314042314949;5723.713814309268;5830.38780928005;4390.275604525217;4392.099619578043;4396.868093957187;4399.406080179135;4437.201303765353;3921.8039098044983;3937.074787424953;3941.192055628589;3948.1314110895555;3998.140399814054;5319.6808191508635;5320.893582128336;5362.624616276901;5377.946220537823;5409.648372855751;5786.363500014995;5789.363170051291;5791.420857914175;5798.043322851682;5812.88374232513;5422.674639521641;5439.102548079522;5440.591955603267;5447.836564903059;5454.12733962572;4820.783064762094;4976.552110310089;4997.775100120503;5010.64925455222;5066.265391518209;6090;6099.146119543356;6099.817005489843;6103.877922441527;6112.480439162632;5682.715864206691;5887.676177810262;5898.882022359443;5901.439363260483;5903.586748927534;5990.850228744316;6016.969915150396;6029.909551356821;6119.388061193845;6119.755209791559;5733.140028995517;5756.481916627524;5798.420157984167;5806.332271788799;5806.738696758572;5554.555635549065;5800.477956983892;5918.7928422505;5924.081767326072;5928.051511758271;5686.687232202268;5735.11105778605;5744.396838331915;5744.712764361849;5791.0734282514595;5727.369989301257;5734;5738.885222295614;5739.282589676291;5742.799002034909;5367.946320536901;5478.698671572943;5498.80754173602;5630.324361076533;5635.549156067423;5715.457031582159;5716.199732037601;5748.5688573358;5750.9424905752085;5753.424657534213;5542.445755424586;5543.805966791143;5553.9725150847225;5560.193771903132;5563.193336966036 09:03:41 INFO - PROCESS | 26837 | |1;ext.html;586.331581996524;620.1658768955758;620.2990620598724;636.9681515924206;644.3653001793233;34647.30705385894;35203.4719479208;35473.82263088684;35513.11217219571;35544.82227588865;45260.77369613147;46204.306935395995;46251.768741156244;50573.49426505743;50642;8733.214010739048;8916.331275154389;8926.062763409846;8927;8927.241184499326;8698.217160455557;8815.294776417872;8817.382783205177;8820.294376449869;8824.426412283214;8829.293656507496;8891.244244239215;8896.466212027266;8900.8664870027;8902.130552583965;8778.517181555011;8818.603162857687;8827.602757875879;8834.11658834118;8844.955775221148;8665.783355416102;8753.562321883945;8755.868661970075;8756.4308319959;8763.474191548528;42019.57980420187;42349.57650423487;42435;42446;42520;3660.7437479376454;3687.2441149564274;3802.1825307559006;3860.9034774130873;4107.835686572564;31411.528827067614;32198.678013219804;32464;32479.72641915067;33176.17059573506;3978.1645854370618;4030.2141082488924;4104.343305071175;4122.134351786129;4232.682548808821;345610;346095;346692;346938;347188;59939;60035.399646003854;60166.69916650476;60301.39698602958;60350.69824650849;63997.680011599645;64026.6798666013;64087.679561602825;64188.35811641917;64238.357616424175;17188.742168867477;17434.738478922827;17439.564010899576;17447.040412777165;17450.65098698019;12387.442565084593;12453.25280483174;12474.563390281297;12488.687782805502;12499.250044997329;17073.829261707226;17660.646787064186;17744.822551774316;17761.644767104845;17853.642927141645;5273.630845840754;6270.968645156745;6321.620702757849;6389.233292004989;6434.195725534309;1037.8852962939095;1112.1325366214367;1143.2511704833348;1162.2503485252134;1171.6777886081395;32526.186845328582;33015.339693206;33228.4085183654;33317.50023749645;33398.499022514196;1127.0926903842321;1144.5822274869613;1194.778965891313;1197.9700507487207;1203.807390817465;17383.56541086483;17441.825581744273;17497.650046998988;17549.473515794547;17774.91112544429;525619;529749;529753;530571;531068;60157;60280.39719602748;60294;60463;60480.69759651174;1256.0830593666492;1372.3069849726023;1376.6558360409897;1415.688548519324;1427.7715565509468;33342;34072.82963585166;34256;34589.82705086459;34669.13327166841;50858.49141508537;50936.74531627318;51507.22739158841;51529.48470515247;51529.742351289504;410174;411321;413113;413437;414179;36329;41285.58714412817;42466;42467;46086.46524441188;49487;49630.751846240535;50366.49633503618;50661.74669126631;50716;39394.40908386319;40470;42158.78920605377;43413.13173736444;45164.77417612891;41204;41470.1705965873;41647;41700.79149604232;42310.57689423066;41639;43010.56989430066;43139;43345.34981975336;43593.346099807895;35518.822405887804;37682.8115859419;38350.42474362831;38482.80758596189;38534.80732596319;28262.016383488746;28470.85764571164;28646;28976.85511572513;30084 09:03:41 INFO - PROCESS | 26837 | |2;jquery.html;393.29796313580255;400.34943217271933;406.22208470778463;407.98776036718897;420.43871431638763;17871.82128178718;18253.36113236037;19169.424917252487;19173.616527669437;19358.90320548395;17827.73258401125;18337.90831045846;18369.265229390807;19271.807281927177;19305.517362065955;5488.643238189525;5630.634008789426;5759.539236861041;5816.272965879265;5817.360090390053;5668.603197776158;5728.3126024876865;5729.6562206267545;5769.5672824538115;5821.214136091616;5485.232067510532;5737.483626473617;5792.71036448178;5802.5938184327115;5877.588568800185;5691.544676425897;5704.34400043994;5717.914231286534;5732.369439361667;5915.852103697399;5577.581681373873;5686.943130568683;5714.200011998323;5718.7426565804635;5718.914216286759;13330.666733331647;13541.59375218745;13726.862731372657;13772.724545509134;13802.102863313852;2331.114176612893;2447.7552244775557;2499.662545556345;2585.3795089178648;2628.7502687244873;9681;10266.589336426534;10271.229657775622;10273.691789246335;10426.218033647507;1932.130541256426;1954.4429837496245;1970.4581240158927;2037.3174986379433;2044.8977551122532;77771.6111419445;78058.14563907673;78226.60886695587;78551;82105;10953.123750099972;11020.669379918616;11132.220744547965;11149.944250278859;11215.214934954638;15081.924590377197;15119.848801511844;15287.694246115016;15311.310991005432;15424.768628470581;7481.364084052808;7890.329322007578;8023.598820058974;8101.797455063671;8105.2705256526015;7670.27132422419;7722.53664780115;7781.844363112819;7907.644156012993;7967.8406431871035;4632.2819962905805;4658.697184682985;4710.539732682879;4760.619150467955;4769.785359658824;1926.6146770645928;1976.5552750630993;1990.3431867483985;1998.2406685459432;1998.4104689116746;449.18921346969034;1019.2457581389718;1040.5317607076845;1044.237706474278;1054.3410368519676;11350.602728904449;11848.289102653696;11859.644210673694;11919.165658404001;12033.338166400757;456.8652247586903;464.1089108910899;467.36905178009414;470.8846332648523;474.0873817900597;6370.554061215763;6394.968025159845;6432.6462044588;6457.4511166551365;6505.381988711065;452538;455545;466298;485329;489834;87779;93052.53473732588;93708;94040.52979735195;94559.52720236355;471.9693219940693;474.409360346371;476.27368263398597;478.6386278359886;479.4007490636704;10637.9468102659;11086.833697494383;11216.383098929637;11242.325460472397;11313.434328283389;30787.9224227151;35833;39800.80099599483;40703;41233.58766412298;55875.16187257276;56170;58306.12540811976;58877;59464.70267648634;7085.220625731268;7611.200823913409;7686.616409046425;8010.559419231765;8668.653253869774;10546.472676366304;12233.571824986082;13338.666533336744;13408.128471649312;13642;11579.8263026053;11601;12063.155579109378;12222.694432639255;12307.87692123103;11397.601083962021;11455.198136130724;11583.362915039754;11768.588099416822;11889.643310700692;11522.711932201426;11749.941250294036;11754;12082.818757718465;12212.816807747713;7345.77962661121;7600.315971562365;7956.443048986515;8060.879086813819;8079.192080791874;11075;11263.549458021915;11454.94272528632;11682.47428865686;11917.582884598998 09:03:41 INFO - PROCESS | 26837 | |3;mootools.html;1316.6115995781245;1489.5233525271915;1519.490970524874;1640.8441198086177;1781.8307260810218;7886.566238856861;8253.793655158617;8269.173082691728;8491;8515.872261916076;8171.509709417439;8396.328293736502;8396.412251142423;8397.244248017678;8404.41169118162;2325.9185928492507;2353.8234632402555;2357.457784709518;2357.728861180969;2362.232274510782;2342.145117032288;2388.0209114263157;2401.0995876546294;2407.6508906208587;2408.2534414331526;2326.1742081561056;2334.5447637710654;2350.048230466664;2353.6587194856734;2361.740208577055;2283.1666441748644;2290.7480177180496;2304.7810458006547;2324.1633012115626;2325.837191396603;2252.031626400647;2265.6714776357335;2265.7734226577377;2266.88665566721;2269.6482045283005;7985.281324680748;8203.794905127419;8291.08798032216;8325.209105135002;8329.12544182858;5213.2701421800975;5352.4915133062295;5363.758630861621;5365.195220716923;5368;3378.2230087079865;3389.813560254185;3411;3472.149323415754;3475.4265546184847;1142.2289954280827;1186.792311345511;1193.3555879824885;1198.101423932051;1198.988010119905;11317.264377815498;11343.886561134366;11360.091192704564;11391.088712902947;11426.37154956477;4461.687681862303;4495.190865644216;4617.399738034102;4638.698484598491;4639.675222734444;9109.316801239933;9133.90866091344;9135;9143.817123657489;9152.725418237464;5166.819161329336;5175.585953123741;5176.456472070454;5177.430482646906;5179.637425380262;4115.32097203958;4208.36874468826;4685.344051832746;4789.688670236424;4834.903301933941;3770.1517158639085;3788.3938569829247;3865.420186971977;3879.86420475282;4015.196960607832;1143.3940011793763;1167.3287859480834;1168.2464810197375;1172.2556176827604;1174.8590169179754;761.9276168763959;969.7187815533416;986.3145114145743;1018.6689325969089;1022.7647641042453;5845.649261044266;5865.912011319833;5882.176495290662;5977.103434484775;6013.939860601426;499.47804544251346;500.2546206152879;504.80564982481275;509.1395541534794;664.0338307762195;4075.714699971033;4248.320268756984;4253.170631726845;4324.048709283952;4349.478062632441;10065.345752526062;10346.5344059516;10393.324433911772;10430.895691042992;10438.37369757817;9985.950070249603;10320.48397580118;10324.07083362501;10359.378437293786;10374.22193335503;7761.223877612194;7807.492512986638;7906.327962123169;7940.563269020259;7946.443748937519;5862.618929769551;5891.440313170242;5957.16599676037;5970.253718285215;6160.907586386118;8877.334199934901;9590.184834289164;9605.279604029585;9607.51962401891;9696.0788725071;9160.404573702688;9487.762805929908;9559.474228917197;9588.56851441673;9595.376300540442;6667.233268174222;7210.9278907210255;7290.125184977836;7351.522151060378;7503.13713922884;8261.876071858807;8272.255497005299;8339.24946754795;8341.124181960808;8350.290225330915;7237.3486386225495;7323.8535229296185;7455.0681164854395;7572.318491335806;7607.315341619281;7120.1099862517185;7383.8154046149275;7421.591812450151;7464.664090116066;7578.431617628589;6967.79096627102;6989.580625162506;7011;7023.508354415142;7030.156381234285;5129.307543481731;5201.115810312181;5241.423443421297;5286.81496147633;5338.558589180977;5022.27177059317;5073.315102461121;5137.537621614073;5187.32564766593;5205.141151709925 09:03:41 INFO - PROCESS | 26837 | |4;prototype.html;331.42166918726826;333.50141538400095;338.9322135572886;343.1592598134571;343.98796042138514;5289.682619042856;5377.435369286227;5391.353037635479;5394.892102157959;5529.529989950859;5283.524482796547;5329.600279979008;5360.65155764876;5403.864903377417;5456.236126942231;3976.562578116405;4012;4128.814203360856;4160.56314087021;4162.854300099497;4153.8961525961795;4154.605312495308;4167.562405947378;4172.5604666390045;4178.811953462102;3946.9210615787665;4141.544430112685;4146.564610715876;4151.837485504064;4167.562405947362;4029.6373326400617;4039.656629186508;4045.6965727570255;4146.035584557026;4158.854440094612;3658.5243918290453;3672.3022625701033;3674.7978861162624;3676.6874815640704;3678.337899178147;5163.432022477525;5166.225066240057;5190;5215.191645294985;5228.137357336035;4480.350349199348;4718.834840780591;4734.621230301567;4734.715917044989;4734.928976065362;5524.944750552483;5544.972275138639;5549.694766787825;5551.639848237167;5576.072561904992;3964.2467931093;3967.920641587181;3974.3839704845795;3996.980015099935;4006.979965100185;5575.721213939287;5784.913226301609;5785.768569257225;5794.855128621776;5803.477687008147;4046.7167298288837;4048.69634777387;4052.2705912935953;4052.513698356216;4054.391841223781;4086.40747091676;4130.153318569686;4131.731437456556;4173.08192197716;4174.91650166995;4592.724436533818;4628.745419001987;4642.141203877226;4651.395318608559;4742.312364707098;5462.317210348707;5534.363548192009;5557.277553917965;5559.471850174227;5599.524040456526;1408.3451195194284;1421.1473116130446;1426.493594773861;1430.9570712878422;1431.5061303850155;875.605977310213;900.9189172974463;913.8126684029758;927.8772685051028;938.5260443476137;5296.523312901857;5355.598330125256;5363.597730170253;5365.275687782178;5420.186971954238;5631.662100273997;5657.680351056048;5751.1085781703905;5754.223179870748;5782.88434231313;5103.948960510347;5364.034473794754;5365.436629153961;5398.082326004589;5404.783808647689;2991.8055326403714;3013;3014.7588192944513;3021.214484234115;3041.5133578627315;5595.496405323459;5771.220885180531;5854.765809367577;5859.296884373903;5860.208871802252;5744.655320680772;5783.2192653992015;5812.447817457335;5832.562557808182;5842.912356314659;5819.970900145472;5820.447057529528;5828.970855145697;5830.9416905832095;5876.206712093813;5417.458254174551;5631.380548139619;5669.291338582677;5719.656820590778;5732.111522713986;5549.611527193219;5569.8581790733615;5592.133219351007;5595.272614560081;5606.971965140148;5768.855778605568;5771.653700777967;5792.623479473821;5804.519847438876;5838.153467747238;3785.337565925897;4039.636432721069;4050.3316952702476;4051.817668204879;4068.877933661995;5698.230738850202;5708.885822283448;5712.65724056558;5728.283964504437;5730.5129064030025;5388.326459192601;5586.301712285965;5594.944050559442;5601.551875850004;5608.775648973995;5527.060399732136;5543.778248870161;5558;5595.580331475075;5595.748191331319;5295;5353.330833645794;5437.592180586393;5466.480684334982;5503.3395992481155;5627.424321190073;5633.971830140987;5657;5664.348599911063;5673.432656734293;5429.918551221655;5450.582848459349;5461.323951263931;5475.986942415666;5520.123158126256 09:03:41 INFO - PROCESS | 26837 | |5;yui.html;740.6333864736956;755.9962200188999;789.964451599678;825.9050209225938;841.9368547358949;14551.636209094764;14908.627284317898;15158.84841151588;15352.46266380677;15378.307976141086;15050.623734406645;15260.923695381507;15269.465568705098;15289.694206115872;15307.693846123098;687.0655907965163;813.1299509524811;816.9305609023226;826.396730386818;839.5004972041656;818.3085292927467;821.7945513621595;829.531314807132;829.7054545636303;830.3979614779267;860.995695021524;870.5908223135116;870.7605408512646;871.7689812199773;871.7820544863785;721.9783406497813;819.9918000819976;838.5262326785347;839.6935118681698;847.2120927537388;619.8884200843846;620.8882401167788;621.0808004153832;621.3072424246977;621.4127649371346;14771;14811.925940370336;14859.331330090065;14872;14878.479253226085;13210.735785284336;13900.51348202808;14430.71138577233;14641;14655.853441465662;12248.877511224951;12644.747105057939;12686.619401417973;12847.678808029781;13018.218906865619;4393.275109606911;4442.267025940748;4450.399196108517;4472.619827314682;4666.65000124992;72958.63520682363;73457;73564.2643573568;74874;74884.62557687177;11453.942730286462;11686.532538698528;11712.765744685228;11837.348945807891;12220.877791222152;21446.678299825515;21479;21483.67774483384;21519.246826361003;21578.784212157676;7902.3678105751405;8003.759887203277;8043.477173983672;8220.260176584135;8226.670933162606;4540.750258735801;4632.930506042412;4662.790174442158;4738.0523895221095;4789.281607758794;3349.69852713257;3425.1950791563963;3447.8620855165514;3455.4298540740997;3456.948145777815;590.3122861865963;598.4195330529379;610.5451438678214;616.0605077257129;616.3066550131102;595.3926994465621;605.772835186805;676.8409423785406;691.2914262880487;701.2321507948787;9160.526223889601;9316.534173291308;9350.15848573618;9355.158035776813;9658.130768230752;615.2002396884033;650.4664332425177;666.1735724674762;678.6878036103349;700.1598082301259;4043.9191216175514;4388.605025547716;4405.669574781904;4406.471223453206;4436.622887054572;67562;69242;69315.3068469319;84858.18138183796;106349.46825265825;77577.61211193907;77763.61118194372;83387;92140.53929730442;93592.53203733938;83980;84037;84043;84710;86903.56548217092;9513.191378732608;9632.75918102053;9656.662016829378;9670.613175473183;9714.222862171151;46923.53076469192;49503.50496495133;50259.497405026945;50950.745246275015;51979.2203116946;68912.3108768906;75255;75976.62011689907;75998.62000689961;76539.23460765321;12342.629721108382;12453.501859925502;12467.93766031164;12951.805722913976;13079.738405232032;13354.799678004643;13565;14072.929635351758;14222.502212422516;14223.288835558387;11757.647270581896;11835.11236657237;11904.940475297568;11912.344821034927;12006.279623222634;12817.423215955117;12842.614721558368;12847.743045139232;12886;12887.80668289995;11004.339739615649;11054.659258599093;11288.661340159808;11700.35648039366;12430.875691242973;9087.409318394282;9156.359054866096;9295.163435290857;9555.235581153353;9585.233181345337;10275.691729248134;10615.681529554126;10645.520951557353;11607.76784464289;11663.24188927751 09:03:41 INFO - PROCESS | 26837 | __end_tp_report 09:03:41 INFO - PROCESS | 26837 | __start_cc_report 09:03:41 INFO - PROCESS | 26837 | _x_x_mozilla_cycle_collect,932 09:03:41 INFO - PROCESS | 26837 | __end_cc_report 09:03:41 INFO - PROCESS | 26837 | __startTimestamp1464883421090__endTimestamp 09:03:41 INFO - PROCESS | 26837 | 09:03:41 INFO - PROCESS | 26837 | ------- Summary: start ------- 09:03:41 INFO - PROCESS | 26837 | Number of tests: 6 09:03:41 INFO - PROCESS | 26837 | 09:03:41 INFO - PROCESS | 26837 | [#0] dojo.html Cycles:165 Average:5394.96 Median:5553.97 stddev:629.98 (11.3%) stddev-sans-first:606.50 09:03:41 INFO - PROCESS | 26837 | Values: 3137.1 3143.8 3159.8 3182.5 3205.7 5230.9 5284.0 5373.9 5478.9 5483.0 5354.8 5367.5 5407.3 5497.3 5508.2 4811.8 4816.5 4891.3 4893.5 5095.0 5008.5 5014.6 5024.3 5034.8 5055.9 4756.1 4810.4 4811.9 4826.3 4891.6 4858.3 4873.3 4874.8 4878.0 4883.0 4841.4 4863.0 4907.6 4956.2 5025.1 5314.3 5353.3 5376.5 5458.4 5458.5 5923.5 5929.1 5932.3 5934.2 5934.4 5580.9 5760.0 5787.3 5788.6 5946.5 5470.4 5483.2 5485.1 5491.1 5492.5 5951.3 5953.6 5956.9 5961.8 5967.9 5542.1 5677.5 5735.4 5749.1 5750.2 5894.3 5923.9 5938.2 5946.3 5957.4 5844.4 5852.3 5858.1 5859.6 5870.5 5487.0 5666.4 5716.3 5723.7 5830.4 4390.3 4392.1 4396.9 4399.4 4437.2 3921.8 3937.1 3941.2 3948.1 3998.1 5319.7 5320.9 5362.6 5377.9 5409.6 5786.4 5789.4 5791.4 5798.0 5812.9 5422.7 5439.1 5440.6 5447.8 5454.1 4820.8 4976.6 4997.8 5010.6 5066.3 6090.0 6099.1 6099.8 6103.9 6112.5 5682.7 5887.7 5898.9 5901.4 5903.6 5990.9 6017.0 6029.9 6119.4 6119.8 5733.1 5756.5 5798.4 5806.3 5806.7 5554.6 5800.5 5918.8 5924.1 5928.1 5686.7 5735.1 5744.4 5744.7 5791.1 5727.4 5734.0 5738.9 5739.3 5742.8 5367.9 5478.7 5498.8 5630.3 5635.5 5715.5 5716.2 5748.6 5750.9 5753.4 5542.4 5543.8 5554.0 5560.2 5563.2 09:03:41 INFO - PROCESS | 26837 | 09:03:41 INFO - PROCESS | 26837 | [#1] ext.html Cycles:180 Average:60053.51 Median:41643.00 stddev:115384.58 (277.1%) stddev-sans-first:115621.88 09:03:41 INFO - PROCESS | 26837 | Values: 586.3 620.2 620.3 637.0 644.4 34647.3 35203.5 35473.8 35513.1 35544.8 45260.8 46204.3 46251.8 50573.5 50642.0 8733.2 8916.3 8926.1 8927.0 8927.2 8698.2 8815.3 8817.4 8820.3 8824.4 8829.3 8891.2 8896.5 8900.9 8902.1 8778.5 8818.6 8827.6 8834.1 8845.0 8665.8 8753.6 8755.9 8756.4 8763.5 42019.6 42349.6 42435.0 42446.0 42520.0 3660.7 3687.2 3802.2 3860.9 4107.8 31411.5 32198.7 32464.0 32479.7 33176.2 3978.2 4030.2 4104.3 4122.1 4232.7 345610.0 346095.0 346692.0 346938.0 347188.0 59939.0 60035.4 60166.7 60301.4 60350.7 63997.7 64026.7 64087.7 64188.4 64238.4 17188.7 17434.7 17439.6 17447.0 17450.7 12387.4 12453.3 12474.6 12488.7 12499.3 17073.8 17660.6 17744.8 17761.6 17853.6 5273.6 6271.0 6321.6 6389.2 6434.2 1037.9 1112.1 1143.3 1162.3 1171.7 32526.2 33015.3 33228.4 33317.5 33398.5 1127.1 1144.6 1194.8 1198.0 1203.8 17383.6 17441.8 17497.7 17549.5 17774.9 525619.0 529749.0 529753.0 530571.0 531068.0 60157.0 60280.4 60294.0 60463.0 60480.7 1256.1 1372.3 1376.7 1415.7 1427.8 33342.0 34072.8 34256.0 34589.8 34669.1 50858.5 50936.7 51507.2 51529.5 51529.7 410174.0 411321.0 413113.0 413437.0 414179.0 36329.0 41285.6 42466.0 42467.0 46086.5 49487.0 49630.8 50366.5 50661.7 50716.0 39394.4 40470.0 42158.8 43413.1 45164.8 41204.0 41470.2 41647.0 41700.8 42310.6 41639.0 43010.6 43139.0 43345.3 43593.3 35518.8 37682.8 38350.4 38482.8 38534.8 28262.0 28470.9 28646.0 28976.9 30084.0 09:03:41 INFO - PROCESS | 26837 | 09:03:41 INFO - PROCESS | 26837 | [#2] jquery.html Cycles:180 Average:27409.24 Median:40968.29 stddev:77747.47 (189.8%) stddev-sans-first:77939.11 09:03:41 INFO - PROCESS | 26837 | Values: 393.3 400.3 406.2 408.0 420.4 17871.8 18253.4 19169.4 19173.6 19358.9 17827.7 18337.9 18369.3 19271.8 19305.5 5488.6 5630.6 5759.5 5816.3 5817.4 5668.6 5728.3 5729.7 5769.6 5821.2 5485.2 5737.5 5792.7 5802.6 5877.6 5691.5 5704.3 5717.9 5732.4 5915.9 5577.6 5686.9 5714.2 5718.7 5718.9 13330.7 13541.6 13726.9 13772.7 13802.1 2331.1 2447.8 2499.7 2585.4 2628.8 9681.0 10266.6 10271.2 10273.7 10426.2 1932.1 1954.4 1970.5 2037.3 2044.9 77771.6 78058.1 78226.6 78551.0 82105.0 10953.1 11020.7 11132.2 11149.9 11215.2 15081.9 15119.8 15287.7 15311.3 15424.8 7481.4 7890.3 8023.6 8101.8 8105.3 7670.3 7722.5 7781.8 7907.6 7967.8 4632.3 4658.7 4710.5 4760.6 4769.8 1926.6 1976.6 1990.3 1998.2 1998.4 449.2 1019.2 1040.5 1044.2 1054.3 11350.6 11848.3 11859.6 11919.2 12033.3 456.9 464.1 467.4 470.9 474.1 6370.6 6395.0 6432.6 6457.5 6505.4 452538.0 455545.0 466298.0 485329.0 489834.0 87779.0 93052.5 93708.0 94040.5 94559.5 472.0 474.4 476.3 478.6 479.4 10637.9 11086.8 11216.4 11242.3 11313.4 30787.9 35833.0 39800.8 40703.0 41233.6 55875.2 56170.0 58306.1 58877.0 59464.7 7085.2 7611.2 7686.6 8010.6 8668.7 10546.5 12233.6 13338.7 13408.1 13642.0 11579.8 11601.0 12063.2 12222.7 12307.9 11397.6 11455.2 11583.4 11768.6 11889.6 11522.7 11749.9 11754.0 12082.8 12212.8 7345.8 7600.3 7956.4 8060.9 8079.2 11075.0 11263.5 11454.9 11682.5 11917.6 09:03:41 INFO - PROCESS | 26837 | 09:03:41 INFO - PROCESS | 26837 | [#3] mootools.html Cycles:180 Average:5571.97 Median:5176.02 stddev:3058.26 (59.1%) stddev-sans-first:3050.12 09:03:41 INFO - PROCESS | 26837 | Values: 1316.6 1489.5 1519.5 1640.8 1781.8 7886.6 8253.8 8269.2 8491.0 8515.9 8171.5 8396.3 8396.4 8397.2 8404.4 2325.9 2353.8 2357.5 2357.7 2362.2 2342.1 2388.0 2401.1 2407.7 2408.3 2326.2 2334.5 2350.0 2353.7 2361.7 2283.2 2290.7 2304.8 2324.2 2325.8 2252.0 2265.7 2265.8 2266.9 2269.6 7985.3 8203.8 8291.1 8325.2 8329.1 5213.3 5352.5 5363.8 5365.2 5368.0 3378.2 3389.8 3411.0 3472.1 3475.4 1142.2 1186.8 1193.4 1198.1 1199.0 11317.3 11343.9 11360.1 11391.1 11426.4 4461.7 4495.2 4617.4 4638.7 4639.7 9109.3 9133.9 9135.0 9143.8 9152.7 5166.8 5175.6 5176.5 5177.4 5179.6 4115.3 4208.4 4685.3 4789.7 4834.9 3770.2 3788.4 3865.4 3879.9 4015.2 1143.4 1167.3 1168.2 1172.3 1174.9 761.9 969.7 986.3 1018.7 1022.8 5845.6 5865.9 5882.2 5977.1 6013.9 499.5 500.3 504.8 509.1 664.0 4075.7 4248.3 4253.2 4324.0 4349.5 10065.3 10346.5 10393.3 10430.9 10438.4 9986.0 10320.5 10324.1 10359.4 10374.2 7761.2 7807.5 7906.3 7940.6 7946.4 5862.6 5891.4 5957.2 5970.3 6160.9 8877.3 9590.2 9605.3 9607.5 9696.1 9160.4 9487.8 9559.5 9588.6 9595.4 6667.2 7210.9 7290.1 7351.5 7503.1 8261.9 8272.3 8339.2 8341.1 8350.3 7237.3 7323.9 7455.1 7572.3 7607.3 7120.1 7383.8 7421.6 7464.7 7578.4 6967.8 6989.6 7011.0 7023.5 7030.2 5129.3 5201.1 5241.4 5286.8 5338.6 5022.3 5073.3 5137.5 5187.3 5205.1 09:03:41 INFO - PROCESS | 26837 | 09:03:41 INFO - PROCESS | 26837 | [#4] prototype.html Cycles:180 Average:4675.51 Median:5393.12 stddev:1376.71 (25.5%) stddev-sans-first:1341.40 09:03:41 INFO - PROCESS | 26837 | Values: 331.4 333.5 338.9 343.2 344.0 5289.7 5377.4 5391.4 5394.9 5529.5 5283.5 5329.6 5360.7 5403.9 5456.2 3976.6 4012.0 4128.8 4160.6 4162.9 4153.9 4154.6 4167.6 4172.6 4178.8 3946.9 4141.5 4146.6 4151.8 4167.6 4029.6 4039.7 4045.7 4146.0 4158.9 3658.5 3672.3 3674.8 3676.7 3678.3 5163.4 5166.2 5190.0 5215.2 5228.1 4480.4 4718.8 4734.6 4734.7 4734.9 5524.9 5545.0 5549.7 5551.6 5576.1 3964.2 3967.9 3974.4 3997.0 4007.0 5575.7 5784.9 5785.8 5794.9 5803.5 4046.7 4048.7 4052.3 4052.5 4054.4 4086.4 4130.2 4131.7 4173.1 4174.9 4592.7 4628.7 4642.1 4651.4 4742.3 5462.3 5534.4 5557.3 5559.5 5599.5 1408.3 1421.1 1426.5 1431.0 1431.5 875.6 900.9 913.8 927.9 938.5 5296.5 5355.6 5363.6 5365.3 5420.2 5631.7 5657.7 5751.1 5754.2 5782.9 5103.9 5364.0 5365.4 5398.1 5404.8 2991.8 3013.0 3014.8 3021.2 3041.5 5595.5 5771.2 5854.8 5859.3 5860.2 5744.7 5783.2 5812.4 5832.6 5842.9 5820.0 5820.4 5829.0 5830.9 5876.2 5417.5 5631.4 5669.3 5719.7 5732.1 5549.6 5569.9 5592.1 5595.3 5607.0 5768.9 5771.7 5792.6 5804.5 5838.2 3785.3 4039.6 4050.3 4051.8 4068.9 5698.2 5708.9 5712.7 5728.3 5730.5 5388.3 5586.3 5594.9 5601.6 5608.8 5527.1 5543.8 5558.0 5595.6 5595.7 5295.0 5353.3 5437.6 5466.5 5503.3 5627.4 5634.0 5657.0 5664.3 5673.4 5429.9 5450.6 5461.3 5476.0 5520.1 09:03:41 INFO - PROCESS | 26837 | 09:03:41 INFO - PROCESS | 26837 | [#5] yui.html Cycles:180 Average:19069.72 Median:26284.77 stddev:26092.04 (99.3%) stddev-sans-first:26128.93 09:03:41 INFO - PROCESS | 26837 | Values: 740.6 756.0 790.0 825.9 841.9 14551.6 14908.6 15158.8 15352.5 15378.3 15050.6 15260.9 15269.5 15289.7 15307.7 687.1 813.1 816.9 826.4 839.5 818.3 821.8 829.5 829.7 830.4 861.0 870.6 870.8 871.8 871.8 722.0 820.0 838.5 839.7 847.2 619.9 620.9 621.1 621.3 621.4 14771.0 14811.9 14859.3 14872.0 14878.5 13210.7 13900.5 14430.7 14641.0 14655.9 12248.9 12644.7 12686.6 12847.7 13018.2 4393.3 4442.3 4450.4 4472.6 4666.7 72958.6 73457.0 73564.3 74874.0 74884.6 11453.9 11686.5 11712.8 11837.3 12220.9 21446.7 21479.0 21483.7 21519.2 21578.8 7902.4 8003.8 8043.5 8220.3 8226.7 4540.8 4632.9 4662.8 4738.1 4789.3 3349.7 3425.2 3447.9 3455.4 3456.9 590.3 598.4 610.5 616.1 616.3 595.4 605.8 676.8 691.3 701.2 9160.5 9316.5 9350.2 9355.2 9658.1 615.2 650.5 666.2 678.7 700.2 4043.9 4388.6 4405.7 4406.5 4436.6 67562.0 69242.0 69315.3 84858.2 106349.5 77577.6 77763.6 83387.0 92140.5 93592.5 83980.0 84037.0 84043.0 84710.0 86903.6 9513.2 9632.8 9656.7 9670.6 9714.2 46923.5 49503.5 50259.5 50950.7 51979.2 68912.3 75255.0 75976.6 75998.6 76539.2 12342.6 12453.5 12467.9 12951.8 13079.7 13354.8 13565.0 14072.9 14222.5 14223.3 11757.6 11835.1 11904.9 11912.3 12006.3 12817.4 12842.6 12847.7 12886.0 12887.8 11004.3 11054.7 11288.7 11700.4 12430.9 9087.4 9156.4 9295.2 9555.2 9585.2 10275.7 10615.7 10645.5 11607.8 11663.2 09:03:41 INFO - PROCESS | 26837 | -------- Summary: end -------- 09:03:41 INFO - PROCESS | 26837 | 09:03:41 INFO - TEST-INFO | 26837: exit 0 09:03:41 INFO - TEST-OK | dromaeo_css | took 1114505ms 09:03:41 INFO - TEST-START | kraken 09:03:41 INFO - operating with platform_type : linux_ 09:03:41 INFO - Initialising browser for kraken test... 09:03:41 INFO - TEST-INFO | started process 27017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHmzhx_/profile http://localhost:52392/getInfo.html) 09:03:46 INFO - PROCESS | 27017 | __metrics Screen width/height:1600/1200 09:03:46 INFO - PROCESS | 27017 | colorDepth:24 09:03:46 INFO - PROCESS | 27017 | Browser inner width/height: 1024/697 09:03:46 INFO - PROCESS | 27017 | __metrics 09:03:48 ERROR - PROCESS | 27017 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:03:48 INFO - TEST-INFO | 27017: exit 0 09:03:48 INFO - Browser initialized. 09:03:48 INFO - Running cycle 1/1 for kraken test... 09:03:48 INFO - TEST-INFO | started process 27098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHmzhx_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:00 INFO - PROCESS | 27098 | RSS: Main: 156565504 09:04:00 INFO - PROCESS | 27098 | 09:04:03 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52392/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:04 INFO - PROCESS | 27098 | RSS: Main: 214257664 09:04:04 INFO - PROCESS | 27098 | 09:04:06 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52392/tests/kraken/driver.html?testName=audio-dft) 09:04:07 INFO - PROCESS | 27098 | RSS: Main: 196739072 09:04:07 INFO - PROCESS | 27098 | 09:04:10 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52392/tests/kraken/driver.html?testName=audio-fft) 09:04:10 INFO - PROCESS | 27098 | RSS: Main: 268165120 09:04:10 INFO - PROCESS | 27098 | 09:04:12 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52392/tests/kraken/driver.html?testName=audio-oscillator) 09:04:13 INFO - PROCESS | 27098 | RSS: Main: 178847744 09:04:13 INFO - PROCESS | 27098 | 09:04:15 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52392/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:04:16 INFO - PROCESS | 27098 | RSS: Main: 183660544 09:04:16 INFO - PROCESS | 27098 | 09:04:19 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52392/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:19 INFO - PROCESS | 27098 | RSS: Main: 218230784 09:04:19 INFO - PROCESS | 27098 | 09:04:23 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52392/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:23 INFO - PROCESS | 27098 | RSS: Main: 220250112 09:04:23 INFO - PROCESS | 27098 | 09:04:26 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52392/tests/kraken/driver.html?testName=json-parse-financial) 09:04:27 INFO - PROCESS | 27098 | RSS: Main: 219815936 09:04:27 INFO - PROCESS | 27098 | 09:04:28 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52392/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:29 INFO - PROCESS | 27098 | RSS: Main: 205537280 09:04:29 INFO - PROCESS | 27098 | 09:04:31 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52392/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:31 INFO - PROCESS | 27098 | RSS: Main: 210776064 09:04:31 INFO - PROCESS | 27098 | 09:04:33 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52392/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:04:34 INFO - PROCESS | 27098 | RSS: Main: 217534464 09:04:34 INFO - PROCESS | 27098 | 09:04:36 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:04:37 INFO - PROCESS | 27098 | RSS: Main: 222294016 09:04:37 INFO - PROCESS | 27098 | 09:04:40 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:04:40 INFO - PROCESS | 27098 | RSS: Main: 223682560 09:04:40 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | Cycle 1(1): loaded http://localhost:52392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52392/tests/kraken/driver.html?testName=ai-astar) 09:04:42 INFO - PROCESS | 27098 | RSS: Main: 266166272 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | __start_tp_report 09:04:42 INFO - PROCESS | 27098 | _x_x_mozilla_page_load 09:04:42 INFO - PROCESS | 27098 | _x_x_mozilla_page_load_details 09:04:42 INFO - PROCESS | 27098 | |i|pagename|runs| 09:04:42 INFO - PROCESS | 27098 | |0;ai-astar;111;105;110;110;113;111;111;110;110;110 09:04:42 INFO - PROCESS | 27098 | |1;audio-beat-detection;148;127;129;170;128;127;153;131;166;132 09:04:42 INFO - PROCESS | 27098 | |2;audio-dft;160;160;161;161;161;161;160;161;161;161 09:04:42 INFO - PROCESS | 27098 | |3;audio-fft;74;82;74;110;75;75;73;75;98;75 09:04:42 INFO - PROCESS | 27098 | |4;audio-oscillator;83;83;113;84;83;83;112;84;83;125 09:04:42 INFO - PROCESS | 27098 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;117;117 09:04:42 INFO - PROCESS | 27098 | |6;imaging-darkroom;146;145;145;146;145;145;145;145;146;145 09:04:42 INFO - PROCESS | 27098 | |7;imaging-desaturate;95;95;94;94;95;95;94;95;95;94 09:04:42 INFO - PROCESS | 27098 | |8;json-parse-financial;55;56;52;53;53;53;55;54;52;54 09:04:42 INFO - PROCESS | 27098 | |9;json-stringify-tinderbox;62;62;61;62;62;61;65;62;62;62 09:04:42 INFO - PROCESS | 27098 | |10;stanford-crypto-aes;79;80;79;78;80;81;80;80;109;81 09:04:42 INFO - PROCESS | 27098 | |11;stanford-crypto-ccm;132;122;124;118;120;131;127;121;128;123 09:04:42 INFO - PROCESS | 27098 | |12;stanford-crypto-pbkdf2;160;161;161;162;162;158;159;160;160;159 09:04:42 INFO - PROCESS | 27098 | |13;stanford-crypto-sha256-iterative;64;65;66;62;62;62;63;62;62;60 09:04:42 INFO - PROCESS | 27098 | __end_tp_report 09:04:42 INFO - PROCESS | 27098 | __start_cc_report 09:04:42 INFO - PROCESS | 27098 | _x_x_mozilla_cycle_collect,1592 09:04:42 INFO - PROCESS | 27098 | __end_cc_report 09:04:42 INFO - PROCESS | 27098 | __startTimestamp1464883482702__endTimestamp 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | ------- Summary: start ------- 09:04:42 INFO - PROCESS | 27098 | Number of tests: 14 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:2.02 (1.8%) stddev-sans-first:2.12 09:04:42 INFO - PROCESS | 27098 | Values: 111.0 105.0 110.0 110.0 113.0 111.0 111.0 110.0 110.0 110.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:140.00 stddev:16.82 (12.0%) stddev-sans-first:17.65 09:04:42 INFO - PROCESS | 27098 | Values: 148.0 127.0 129.0 170.0 128.0 127.0 153.0 131.0 166.0 132.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 09:04:42 INFO - PROCESS | 27098 | Values: 160.0 160.0 161.0 161.0 161.0 161.0 160.0 161.0 161.0 161.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:12.64 (16.8%) stddev-sans-first:13.14 09:04:42 INFO - PROCESS | 27098 | Values: 74.0 82.0 74.0 110.0 75.0 75.0 73.0 75.0 98.0 75.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.00 stddev:16.49 (19.9%) stddev-sans-first:17.06 09:04:42 INFO - PROCESS | 27098 | Values: 83.0 83.0 113.0 84.0 83.0 83.0 112.0 84.0 83.0 125.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 09:04:42 INFO - PROCESS | 27098 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 09:04:42 INFO - PROCESS | 27098 | Values: 146.0 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 145.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:04:42 INFO - PROCESS | 27098 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.34 (2.5%) stddev-sans-first:1.33 09:04:42 INFO - PROCESS | 27098 | Values: 55.0 56.0 52.0 53.0 53.0 53.0 55.0 54.0 52.0 54.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 09:04:42 INFO - PROCESS | 27098 | Values: 62.0 62.0 61.0 62.0 62.0 61.0 65.0 62.0 62.0 62.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:80.00 stddev:9.29 (11.6%) stddev-sans-first:9.75 09:04:42 INFO - PROCESS | 27098 | Values: 79.0 80.0 79.0 78.0 80.0 81.0 80.0 80.0 109.0 81.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:125.50 stddev:4.72 (3.8%) stddev-sans-first:4.18 09:04:42 INFO - PROCESS | 27098 | Values: 132.0 122.0 124.0 118.0 120.0 131.0 127.0 121.0 128.0 123.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:1.32 (0.8%) stddev-sans-first:1.39 09:04:42 INFO - PROCESS | 27098 | Values: 160.0 161.0 161.0 162.0 162.0 158.0 159.0 160.0 160.0 159.0 09:04:42 INFO - PROCESS | 27098 | 09:04:42 INFO - PROCESS | 27098 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:1.75 (2.8%) stddev-sans-first:1.80 09:04:42 INFO - PROCESS | 27098 | Values: 64.0 65.0 66.0 62.0 62.0 62.0 63.0 62.0 62.0 60.0 09:04:42 INFO - PROCESS | 27098 | -------- Summary: end -------- 09:04:42 INFO - PROCESS | 27098 | 09:04:43 INFO - TEST-INFO | 27098: exit 0 09:04:43 INFO - TEST-OK | kraken | took 61798ms 09:04:43 INFO - SUITE-END | took 1176s 09:04:43 INFO - Completed test suite (00:19:36) 09:04:43 INFO - javascript benchmark 09:04:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.0588823352996, 3143.764217683673, 3159.7946133501323, 3182.490801471765, 3205.6794320567947, 5230.947690523094, 5283.973580132104, 5373.946260537394, 5478.945210547893, 5483.040467918113, 5354.839354819352, 5367.543758780498, 5407.297051383324, 5497.285352904117, 5508.228847961279, 4811.783469743861, 4816.494268101851, 4891.290762839386, 4893.510648935096, 5095.0, 5008.524190201943, 5014.648974571782, 5024.296598476216, 5034.798608055692, 5055.9241611375855, 4756.072565849643, 4810.39870016248, 4811.855644330641, 4826.3001864729595, 4891.608671306305, 4858.344123543312, 4873.342098816685, 4874.780634871439, 4878.02439512099, 4882.975585122087, 4841.370621819176, 4863.0, 4907.631927605444, 4956.231784073474, 5025.0954828130925, 5314.282571852789, 5353.304070470853, 5376.462353764592, 5458.399576046631, 5458.4814442627885, 5923.526117910556, 5929.110633404981, 5932.288125424977, 5934.1692163097205, 5934.436228558323, 5580.91628625571, 5759.971200143972, 5787.33445653751, 5788.565857560699, 5946.524278057745, 5470.398256191816, 5483.232347471358, 5485.067538518421, 5491.093969494988, 5492.505674489315, 5951.256092988377, 5953.553483488756, 5956.880862382728, 5961.821145365646, 5967.940320596826, 5542.140968149944, 5677.545796336283, 5735.426457354231, 5749.080147176515, 5750.1949727038245, 5894.322152952465, 5923.881522369615, 5938.2280303560265, 5946.286445626466, 5957.404259574095, 5844.444777746107, 5852.297724273115, 5858.091995740667, 5859.619124756877, 5870.530357571384, 5487.039768040577, 5666.4050274721385, 5716.314042314949, 5723.713814309268, 5830.38780928005, 4390.275604525217, 4392.099619578043, 4396.868093957187, 4399.406080179135, 4437.201303765353, 3921.8039098044983, 3937.074787424953, 3941.192055628589, 3948.1314110895555, 3998.140399814054, 5319.6808191508635, 5320.893582128336, 5362.624616276901, 5377.946220537823, 5409.648372855751, 5786.363500014995, 5789.363170051291, 5791.420857914175, 5798.043322851682, 5812.88374232513, 5422.674639521641, 5439.102548079522, 5440.591955603267, 5447.836564903059, 5454.12733962572, 4820.783064762094, 4976.552110310089, 4997.775100120503, 5010.64925455222, 5066.265391518209, 6090.0, 6099.146119543356, 6099.817005489843, 6103.877922441527, 6112.480439162632, 5682.715864206691, 5887.676177810262, 5898.882022359443, 5901.439363260483, 5903.586748927534, 5990.850228744316, 6016.969915150396, 6029.909551356821, 6119.388061193845, 6119.755209791559, 5733.140028995517, 5756.481916627524, 5798.420157984167, 5806.332271788799, 5806.738696758572, 5554.555635549065, 5800.477956983892, 5918.7928422505, 5924.081767326072, 5928.051511758271, 5686.687232202268, 5735.11105778605, 5744.396838331915, 5744.712764361849, 5791.0734282514595, 5727.369989301257, 5734.0, 5738.885222295614, 5739.282589676291, 5742.799002034909, 5367.946320536901, 5478.698671572943, 5498.80754173602, 5630.324361076533, 5635.549156067423, 5715.457031582159, 5716.199732037601, 5748.5688573358, 5750.9424905752085, 5753.424657534213, 5542.445755424586, 5543.805966791143, 5553.9725150847225, 5560.193771903132, 5563.193336966036], "value": 5351.880325595735, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.331581996524, 620.1658768955758, 620.2990620598724, 636.9681515924206, 644.3653001793233, 34647.30705385894, 35203.4719479208, 35473.82263088684, 35513.11217219571, 35544.82227588865, 45260.77369613147, 46204.306935395995, 46251.768741156244, 50573.49426505743, 50642.0, 8733.214010739048, 8916.331275154389, 8926.062763409846, 8927.0, 8927.241184499326, 8698.217160455557, 8815.294776417872, 8817.382783205177, 8820.294376449869, 8824.426412283214, 8829.293656507496, 8891.244244239215, 8896.466212027266, 8900.8664870027, 8902.130552583965, 8778.517181555011, 8818.603162857687, 8827.602757875879, 8834.11658834118, 8844.955775221148, 8665.783355416102, 8753.562321883945, 8755.868661970075, 8756.4308319959, 8763.474191548528, 42019.57980420187, 42349.57650423487, 42435.0, 42446.0, 42520.0, 3660.7437479376454, 3687.2441149564274, 3802.1825307559006, 3860.9034774130873, 4107.835686572564, 31411.528827067614, 32198.678013219804, 32464.0, 32479.72641915067, 33176.17059573506, 3978.1645854370618, 4030.2141082488924, 4104.343305071175, 4122.134351786129, 4232.682548808821, 345610.0, 346095.0, 346692.0, 346938.0, 347188.0, 59939.0, 60035.399646003854, 60166.69916650476, 60301.39698602958, 60350.69824650849, 63997.680011599645, 64026.6798666013, 64087.679561602825, 64188.35811641917, 64238.357616424175, 17188.742168867477, 17434.738478922827, 17439.564010899576, 17447.040412777165, 17450.65098698019, 12387.442565084593, 12453.25280483174, 12474.563390281297, 12488.687782805502, 12499.250044997329, 17073.829261707226, 17660.646787064186, 17744.822551774316, 17761.644767104845, 17853.642927141645, 5273.630845840754, 6270.968645156745, 6321.620702757849, 6389.233292004989, 6434.195725534309, 1037.8852962939095, 1112.1325366214367, 1143.2511704833348, 1162.2503485252134, 1171.6777886081395, 32526.186845328582, 33015.339693206, 33228.4085183654, 33317.50023749645, 33398.499022514196, 1127.0926903842321, 1144.5822274869613, 1194.778965891313, 1197.9700507487207, 1203.807390817465, 17383.56541086483, 17441.825581744273, 17497.650046998988, 17549.473515794547, 17774.91112544429, 525619.0, 529749.0, 529753.0, 530571.0, 531068.0, 60157.0, 60280.39719602748, 60294.0, 60463.0, 60480.69759651174, 1256.0830593666492, 1372.3069849726023, 1376.6558360409897, 1415.688548519324, 1427.7715565509468, 33342.0, 34072.82963585166, 34256.0, 34589.82705086459, 34669.13327166841, 50858.49141508537, 50936.74531627318, 51507.22739158841, 51529.48470515247, 51529.742351289504, 410174.0, 411321.0, 413113.0, 413437.0, 414179.0, 36329.0, 41285.58714412817, 42466.0, 42467.0, 46086.46524441188, 49487.0, 49630.751846240535, 50366.49633503618, 50661.74669126631, 50716.0, 39394.40908386319, 40470.0, 42158.78920605377, 43413.13173736444, 45164.77417612891, 41204.0, 41470.1705965873, 41647.0, 41700.79149604232, 42310.57689423066, 41639.0, 43010.56989430066, 43139.0, 43345.34981975336, 43593.346099807895, 35518.822405887804, 37682.8115859419, 38350.42474362831, 38482.80758596189, 38534.80732596319, 28262.016383488746, 28470.85764571164, 28646.0, 28976.85511572513, 30084.0], "value": 20466.46571054745, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.29796313580255, 400.34943217271933, 406.22208470778463, 407.98776036718897, 420.43871431638763, 17871.82128178718, 18253.36113236037, 19169.424917252487, 19173.616527669437, 19358.90320548395, 17827.73258401125, 18337.90831045846, 18369.265229390807, 19271.807281927177, 19305.517362065955, 5488.643238189525, 5630.634008789426, 5759.539236861041, 5816.272965879265, 5817.360090390053, 5668.603197776158, 5728.3126024876865, 5729.6562206267545, 5769.5672824538115, 5821.214136091616, 5485.232067510532, 5737.483626473617, 5792.71036448178, 5802.5938184327115, 5877.588568800185, 5691.544676425897, 5704.34400043994, 5717.914231286534, 5732.369439361667, 5915.852103697399, 5577.581681373873, 5686.943130568683, 5714.200011998323, 5718.7426565804635, 5718.914216286759, 13330.666733331647, 13541.59375218745, 13726.862731372657, 13772.724545509134, 13802.102863313852, 2331.114176612893, 2447.7552244775557, 2499.662545556345, 2585.3795089178648, 2628.7502687244873, 9681.0, 10266.589336426534, 10271.229657775622, 10273.691789246335, 10426.218033647507, 1932.130541256426, 1954.4429837496245, 1970.4581240158927, 2037.3174986379433, 2044.8977551122532, 77771.6111419445, 78058.14563907673, 78226.60886695587, 78551.0, 82105.0, 10953.123750099972, 11020.669379918616, 11132.220744547965, 11149.944250278859, 11215.214934954638, 15081.924590377197, 15119.848801511844, 15287.694246115016, 15311.310991005432, 15424.768628470581, 7481.364084052808, 7890.329322007578, 8023.598820058974, 8101.797455063671, 8105.2705256526015, 7670.27132422419, 7722.53664780115, 7781.844363112819, 7907.644156012993, 7967.8406431871035, 4632.2819962905805, 4658.697184682985, 4710.539732682879, 4760.619150467955, 4769.785359658824, 1926.6146770645928, 1976.5552750630993, 1990.3431867483985, 1998.2406685459432, 1998.4104689116746, 449.18921346969034, 1019.2457581389718, 1040.5317607076845, 1044.237706474278, 1054.3410368519676, 11350.602728904449, 11848.289102653696, 11859.644210673694, 11919.165658404001, 12033.338166400757, 456.8652247586903, 464.1089108910899, 467.36905178009414, 470.8846332648523, 474.0873817900597, 6370.554061215763, 6394.968025159845, 6432.6462044588, 6457.4511166551365, 6505.381988711065, 452538.0, 455545.0, 466298.0, 485329.0, 489834.0, 87779.0, 93052.53473732588, 93708.0, 94040.52979735195, 94559.52720236355, 471.9693219940693, 474.409360346371, 476.27368263398597, 478.6386278359886, 479.4007490636704, 10637.9468102659, 11086.833697494383, 11216.383098929637, 11242.325460472397, 11313.434328283389, 30787.9224227151, 35833.0, 39800.80099599483, 40703.0, 41233.58766412298, 55875.16187257276, 56170.0, 58306.12540811976, 58877.0, 59464.70267648634, 7085.220625731268, 7611.200823913409, 7686.616409046425, 8010.559419231765, 8668.653253869774, 10546.472676366304, 12233.571824986082, 13338.666533336744, 13408.128471649312, 13642.0, 11579.8263026053, 11601.0, 12063.155579109378, 12222.694432639255, 12307.87692123103, 11397.601083962021, 11455.198136130724, 11583.362915039754, 11768.588099416822, 11889.643310700692, 11522.711932201426, 11749.941250294036, 11754.0, 12082.818757718465, 12212.816807747713, 7345.77962661121, 7600.315971562365, 7956.443048986515, 8060.879086813819, 8079.192080791874, 11075.0, 11263.549458021915, 11454.94272528632, 11682.47428865686, 11917.582884598998], "value": 8277.702714962728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1316.6115995781245, 1489.5233525271915, 1519.490970524874, 1640.8441198086177, 1781.8307260810218, 7886.566238856861, 8253.793655158617, 8269.173082691728, 8491.0, 8515.872261916076, 8171.509709417439, 8396.328293736502, 8396.412251142423, 8397.244248017678, 8404.41169118162, 2325.9185928492507, 2353.8234632402555, 2357.457784709518, 2357.728861180969, 2362.232274510782, 2342.145117032288, 2388.0209114263157, 2401.0995876546294, 2407.6508906208587, 2408.2534414331526, 2326.1742081561056, 2334.5447637710654, 2350.048230466664, 2353.6587194856734, 2361.740208577055, 2283.1666441748644, 2290.7480177180496, 2304.7810458006547, 2324.1633012115626, 2325.837191396603, 2252.031626400647, 2265.6714776357335, 2265.7734226577377, 2266.88665566721, 2269.6482045283005, 7985.281324680748, 8203.794905127419, 8291.08798032216, 8325.209105135002, 8329.12544182858, 5213.2701421800975, 5352.4915133062295, 5363.758630861621, 5365.195220716923, 5368.0, 3378.2230087079865, 3389.813560254185, 3411.0, 3472.149323415754, 3475.4265546184847, 1142.2289954280827, 1186.792311345511, 1193.3555879824885, 1198.101423932051, 1198.988010119905, 11317.264377815498, 11343.886561134366, 11360.091192704564, 11391.088712902947, 11426.37154956477, 4461.687681862303, 4495.190865644216, 4617.399738034102, 4638.698484598491, 4639.675222734444, 9109.316801239933, 9133.90866091344, 9135.0, 9143.817123657489, 9152.725418237464, 5166.819161329336, 5175.585953123741, 5176.456472070454, 5177.430482646906, 5179.637425380262, 4115.32097203958, 4208.36874468826, 4685.344051832746, 4789.688670236424, 4834.903301933941, 3770.1517158639085, 3788.3938569829247, 3865.420186971977, 3879.86420475282, 4015.196960607832, 1143.3940011793763, 1167.3287859480834, 1168.2464810197375, 1172.2556176827604, 1174.8590169179754, 761.9276168763959, 969.7187815533416, 986.3145114145743, 1018.6689325969089, 1022.7647641042453, 5845.649261044266, 5865.912011319833, 5882.176495290662, 5977.103434484775, 6013.939860601426, 499.47804544251346, 500.2546206152879, 504.80564982481275, 509.1395541534794, 664.0338307762195, 4075.714699971033, 4248.320268756984, 4253.170631726845, 4324.048709283952, 4349.478062632441, 10065.345752526062, 10346.5344059516, 10393.324433911772, 10430.895691042992, 10438.37369757817, 9985.950070249603, 10320.48397580118, 10324.07083362501, 10359.378437293786, 10374.22193335503, 7761.223877612194, 7807.492512986638, 7906.327962123169, 7940.563269020259, 7946.443748937519, 5862.618929769551, 5891.440313170242, 5957.16599676037, 5970.253718285215, 6160.907586386118, 8877.334199934901, 9590.184834289164, 9605.279604029585, 9607.51962401891, 9696.0788725071, 9160.404573702688, 9487.762805929908, 9559.474228917197, 9588.56851441673, 9595.376300540442, 6667.233268174222, 7210.9278907210255, 7290.125184977836, 7351.522151060378, 7503.13713922884, 8261.876071858807, 8272.255497005299, 8339.24946754795, 8341.124181960808, 8350.290225330915, 7237.3486386225495, 7323.8535229296185, 7455.0681164854395, 7572.318491335806, 7607.315341619281, 7120.1099862517185, 7383.8154046149275, 7421.591812450151, 7464.664090116066, 7578.431617628589, 6967.79096627102, 6989.580625162506, 7011.0, 7023.508354415142, 7030.156381234285, 5129.307543481731, 5201.115810312181, 5241.423443421297, 5286.81496147633, 5338.558589180977, 5022.27177059317, 5073.315102461121, 5137.537621614073, 5187.32564766593, 5205.141151709925], "value": 4458.337138441647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.42166918726826, 333.50141538400095, 338.9322135572886, 343.1592598134571, 343.98796042138514, 5289.682619042856, 5377.435369286227, 5391.353037635479, 5394.892102157959, 5529.529989950859, 5283.524482796547, 5329.600279979008, 5360.65155764876, 5403.864903377417, 5456.236126942231, 3976.562578116405, 4012.0, 4128.814203360856, 4160.56314087021, 4162.854300099497, 4153.8961525961795, 4154.605312495308, 4167.562405947378, 4172.5604666390045, 4178.811953462102, 3946.9210615787665, 4141.544430112685, 4146.564610715876, 4151.837485504064, 4167.562405947362, 4029.6373326400617, 4039.656629186508, 4045.6965727570255, 4146.035584557026, 4158.854440094612, 3658.5243918290453, 3672.3022625701033, 3674.7978861162624, 3676.6874815640704, 3678.337899178147, 5163.432022477525, 5166.225066240057, 5190.0, 5215.191645294985, 5228.137357336035, 4480.350349199348, 4718.834840780591, 4734.621230301567, 4734.715917044989, 4734.928976065362, 5524.944750552483, 5544.972275138639, 5549.694766787825, 5551.639848237167, 5576.072561904992, 3964.2467931093, 3967.920641587181, 3974.3839704845795, 3996.980015099935, 4006.979965100185, 5575.721213939287, 5784.913226301609, 5785.768569257225, 5794.855128621776, 5803.477687008147, 4046.7167298288837, 4048.69634777387, 4052.2705912935953, 4052.513698356216, 4054.391841223781, 4086.40747091676, 4130.153318569686, 4131.731437456556, 4173.08192197716, 4174.91650166995, 4592.724436533818, 4628.745419001987, 4642.141203877226, 4651.395318608559, 4742.312364707098, 5462.317210348707, 5534.363548192009, 5557.277553917965, 5559.471850174227, 5599.524040456526, 1408.3451195194284, 1421.1473116130446, 1426.493594773861, 1430.9570712878422, 1431.5061303850155, 875.605977310213, 900.9189172974463, 913.8126684029758, 927.8772685051028, 938.5260443476137, 5296.523312901857, 5355.598330125256, 5363.597730170253, 5365.275687782178, 5420.186971954238, 5631.662100273997, 5657.680351056048, 5751.1085781703905, 5754.223179870748, 5782.88434231313, 5103.948960510347, 5364.034473794754, 5365.436629153961, 5398.082326004589, 5404.783808647689, 2991.8055326403714, 3013.0, 3014.7588192944513, 3021.214484234115, 3041.5133578627315, 5595.496405323459, 5771.220885180531, 5854.765809367577, 5859.296884373903, 5860.208871802252, 5744.655320680772, 5783.2192653992015, 5812.447817457335, 5832.562557808182, 5842.912356314659, 5819.970900145472, 5820.447057529528, 5828.970855145697, 5830.9416905832095, 5876.206712093813, 5417.458254174551, 5631.380548139619, 5669.291338582677, 5719.656820590778, 5732.111522713986, 5549.611527193219, 5569.8581790733615, 5592.133219351007, 5595.272614560081, 5606.971965140148, 5768.855778605568, 5771.653700777967, 5792.623479473821, 5804.519847438876, 5838.153467747238, 3785.337565925897, 4039.636432721069, 4050.3316952702476, 4051.817668204879, 4068.877933661995, 5698.230738850202, 5708.885822283448, 5712.65724056558, 5728.283964504437, 5730.5129064030025, 5388.326459192601, 5586.301712285965, 5594.944050559442, 5601.551875850004, 5608.775648973995, 5527.060399732136, 5543.778248870161, 5558.0, 5595.580331475075, 5595.748191331319, 5295.0, 5353.330833645794, 5437.592180586393, 5466.480684334982, 5503.3395992481155, 5627.424321190073, 5633.971830140987, 5657.0, 5664.348599911063, 5673.432656734293, 5429.918551221655, 5450.582848459349, 5461.323951263931, 5475.986942415666, 5520.123158126256], "value": 4235.789551258365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.6333864736956, 755.9962200188999, 789.964451599678, 825.9050209225938, 841.9368547358949, 14551.636209094764, 14908.627284317898, 15158.84841151588, 15352.46266380677, 15378.307976141086, 15050.623734406645, 15260.923695381507, 15269.465568705098, 15289.694206115872, 15307.693846123098, 687.0655907965163, 813.1299509524811, 816.9305609023226, 826.396730386818, 839.5004972041656, 818.3085292927467, 821.7945513621595, 829.531314807132, 829.7054545636303, 830.3979614779267, 860.995695021524, 870.5908223135116, 870.7605408512646, 871.7689812199773, 871.7820544863785, 721.9783406497813, 819.9918000819976, 838.5262326785347, 839.6935118681698, 847.2120927537388, 619.8884200843846, 620.8882401167788, 621.0808004153832, 621.3072424246977, 621.4127649371346, 14771.0, 14811.925940370336, 14859.331330090065, 14872.0, 14878.479253226085, 13210.735785284336, 13900.51348202808, 14430.71138577233, 14641.0, 14655.853441465662, 12248.877511224951, 12644.747105057939, 12686.619401417973, 12847.678808029781, 13018.218906865619, 4393.275109606911, 4442.267025940748, 4450.399196108517, 4472.619827314682, 4666.65000124992, 72958.63520682363, 73457.0, 73564.2643573568, 74874.0, 74884.62557687177, 11453.942730286462, 11686.532538698528, 11712.765744685228, 11837.348945807891, 12220.877791222152, 21446.678299825515, 21479.0, 21483.67774483384, 21519.246826361003, 21578.784212157676, 7902.3678105751405, 8003.759887203277, 8043.477173983672, 8220.260176584135, 8226.670933162606, 4540.750258735801, 4632.930506042412, 4662.790174442158, 4738.0523895221095, 4789.281607758794, 3349.69852713257, 3425.1950791563963, 3447.8620855165514, 3455.4298540740997, 3456.948145777815, 590.3122861865963, 598.4195330529379, 610.5451438678214, 616.0605077257129, 616.3066550131102, 595.3926994465621, 605.772835186805, 676.8409423785406, 691.2914262880487, 701.2321507948787, 9160.526223889601, 9316.534173291308, 9350.15848573618, 9355.158035776813, 9658.130768230752, 615.2002396884033, 650.4664332425177, 666.1735724674762, 678.6878036103349, 700.1598082301259, 4043.9191216175514, 4388.605025547716, 4405.669574781904, 4406.471223453206, 4436.622887054572, 67562.0, 69242.0, 69315.3068469319, 84858.18138183796, 106349.46825265825, 77577.61211193907, 77763.61118194372, 83387.0, 92140.53929730442, 93592.53203733938, 83980.0, 84037.0, 84043.0, 84710.0, 86903.56548217092, 9513.191378732608, 9632.75918102053, 9656.662016829378, 9670.613175473183, 9714.222862171151, 46923.53076469192, 49503.50496495133, 50259.497405026945, 50950.745246275015, 51979.2203116946, 68912.3108768906, 75255.0, 75976.62011689907, 75998.62000689961, 76539.23460765321, 12342.629721108382, 12453.501859925502, 12467.93766031164, 12951.805722913976, 13079.738405232032, 13354.799678004643, 13565.0, 14072.929635351758, 14222.502212422516, 14223.288835558387, 11757.647270581896, 11835.11236657237, 11904.940475297568, 11912.344821034927, 12006.279623222634, 12817.423215955117, 12842.614721558368, 12847.743045139232, 12886.0, 12887.80668289995, 11004.339739615649, 11054.659258599093, 11288.661340159808, 11700.35648039366, 12430.875691242973, 9087.409318394282, 9156.359054866096, 9295.163435290857, 9555.235581153353, 9585.233181345337, 10275.691729248134, 10615.681529554126, 10645.520951557353, 11607.76784464289, 11663.24188927751], "value": 7274.971150042914, "unit": "score"}], "name": "dromaeo_css", "value": 7067.0890126643935, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 110.0, 113.0, 111.0, 111.0, 110.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 127.0, 129.0, 170.0, 128.0, 127.0, 153.0, 131.0, 166.0, 132.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 74.0, 110.0, 75.0, 75.0, 73.0, 75.0, 98.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 113.0, 84.0, 83.0, 83.0, 112.0, 84.0, 83.0, 125.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 52.0, 53.0, 53.0, 53.0, 55.0, 54.0, 52.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 65.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 78.0, 80.0, 81.0, 80.0, 80.0, 109.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 122.0, 124.0, 118.0, 120.0, 131.0, 127.0, 121.0, 128.0, 123.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 162.0, 162.0, 158.0, 159.0, 160.0, 160.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 60.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1489.0, "alertThreshold": 2.0}]} 09:04:43 INFO - Return code: 0 09:04:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:04:44 ERROR - # TBPL SUCCESS # 09:04:44 INFO - Running post-action listener: _resource_record_post_action 09:04:44 INFO - ##### 09:04:44 INFO - ##### Finished run-tests step (success) 09:04:44 INFO - ##### 09:04:44 INFO - Running post-run listener: _resource_record_post_run 09:04:44 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 539238400; Read time: 0; Write time: 1195716 09:04:44 INFO - TinderboxPrint: CPU usage
13.2% 09:04:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:04:44 INFO - TinderboxPrint: I/O write bytes / time
539,238,400 / 1,195,716 09:04:44 INFO - TinderboxPrint: CPU idle
8,276.3 (86.8%) 09:04:44 INFO - TinderboxPrint: CPU user
1,206.3 (12.6%) 09:04:44 INFO - TinderboxPrint: Swap in / out
0 / 0 09:04:44 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 247808000; Read time: 0; Write time: 678460 09:04:44 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289095680; Read time: 0; Write time: 517148 09:04:44 INFO - Running post-run listener: _upload_blobber_files 09:04:44 INFO - Blob upload gear active. 09:04:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:04:44 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 09:04:44 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:04:44 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:04:45 INFO - (blobuploader) - INFO - Open directory for files ... 09:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:04:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:45 INFO - (blobuploader) - INFO - Done attempting. 09:04:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:04:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:04:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:46 INFO - (blobuploader) - INFO - Done attempting. 09:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:50 INFO - (blobuploader) - INFO - Done attempting. 09:04:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:50 INFO - Return code: 0 09:04:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3dfd2fdcc906db5c5c4aa30cdbc665837984108f9b846c31e54c0b38b39348a9866064a7f13c515289080e27d33c04fe661977fa010272b4eabdadbce6b81aac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50646c7dfa82ee4a5d33163ac191e7c01215a4b4e9bff81e3fc09d80cfc0a7314804780680d71ae0c6344faa2b7ba0d31416012e844fa4f5a22e730cef1ec470", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9379ba444693fe026aeede7d528b37193cfb119ac70218a6cc19c9a7a96067ea06b54439b3a7dc908592650a97a0b9a0805d9c2b75cb0a7f655748e312164e2c"} 09:04:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:50 INFO - Contents: 09:04:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3dfd2fdcc906db5c5c4aa30cdbc665837984108f9b846c31e54c0b38b39348a9866064a7f13c515289080e27d33c04fe661977fa010272b4eabdadbce6b81aac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50646c7dfa82ee4a5d33163ac191e7c01215a4b4e9bff81e3fc09d80cfc0a7314804780680d71ae0c6344faa2b7ba0d31416012e844fa4f5a22e730cef1ec470", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9379ba444693fe026aeede7d528b37193cfb119ac70218a6cc19c9a7a96067ea06b54439b3a7dc908592650a97a0b9a0805d9c2b75cb0a7f655748e312164e2c"} 09:04:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:50 INFO - Copying logs to upload dir... 09:04:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.924540 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-02 09:04:50.264758) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 09:04:50.268130) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617 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/sha512/3dfd2fdcc906db5c5c4aa30cdbc665837984108f9b846c31e54c0b38b39348a9866064a7f13c515289080e27d33c04fe661977fa010272b4eabdadbce6b81aac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50646c7dfa82ee4a5d33163ac191e7c01215a4b4e9bff81e3fc09d80cfc0a7314804780680d71ae0c6344faa2b7ba0d31416012e844fa4f5a22e730cef1ec470", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9379ba444693fe026aeede7d528b37193cfb119ac70218a6cc19c9a7a96067ea06b54439b3a7dc908592650a97a0b9a0805d9c2b75cb0a7f655748e312164e2c"} build_url:https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/WwKabylfTaeW4W3PyOB64Q/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/sha512/3dfd2fdcc906db5c5c4aa30cdbc665837984108f9b846c31e54c0b38b39348a9866064a7f13c515289080e27d33c04fe661977fa010272b4eabdadbce6b81aac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50646c7dfa82ee4a5d33163ac191e7c01215a4b4e9bff81e3fc09d80cfc0a7314804780680d71ae0c6344faa2b7ba0d31416012e844fa4f5a22e730cef1ec470", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9379ba444693fe026aeede7d528b37193cfb119ac70218a6cc19c9a7a96067ea06b54439b3a7dc908592650a97a0b9a0805d9c2b75cb0a7f655748e312164e2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-02 09:04:50.294005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 09:04:50.294353) ========= 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=5cf47e208febbcd81da23b2e0000026f-1464882251.329595-1851980617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-02 09:04:50.378536) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 09:04:50.378886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-02 09:04:50.379191) ========= ========= Total master_lag: 0.17 =========