builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1463818112.82 results: success (0) buildid: 20160521003735 builduid: c2181ba5fda8461ea3c84343455ce2ef revision: b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:32.815655) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:32.816497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:32.816822) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:32.846360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:32.846720) ========= 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=aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-21 01:08:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 225M=0s 2016-05-21 01:08:33 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106920 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:32.971928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:32.972302) ========= 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=aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018361 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.032408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.032778) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 --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 b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 --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=aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-21 01:08:33,228 truncating revision to first 12 chars 2016-05-21 01:08:33,228 Setting DEBUG logging. 2016-05-21 01:08:33,228 attempt 1/10 2016-05-21 01:08:33,228 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b7756d054ba8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-21 01:08:33,499 unpacking tar archive at: fx-team-b7756d054ba8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579119 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.625542) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.625888) ========= script_repo_revision: b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.626312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.626685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 01:08:33.635310) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-21 01:08:33.635603) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:08:33 INFO - MultiFileLogger online at 20160521 01:08:33 in /builds/slave/test 01:08:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:08:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:08:33 INFO - {'append_to_log': False, 01:08:33 INFO - 'base_work_dir': '/builds/slave/test', 01:08:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:08:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:08:33 INFO - 'branch': 'Fx-Team-Non-PGO', 01:08:33 INFO - 'buildbot_json_path': 'buildprops.json', 01:08:33 INFO - 'config_files': ('talos/linux_config.py',), 01:08:33 INFO - 'default_actions': ('clobber', 01:08:33 INFO - 'read-buildbot-config', 01:08:33 INFO - 'download-and-extract', 01:08:33 INFO - 'populate-webroot', 01:08:33 INFO - 'create-virtualenv', 01:08:33 INFO - 'install', 01:08:33 INFO - 'run-tests'), 01:08:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:08:33 INFO - 'download_minidump_stackwalk': True, 01:08:33 INFO - 'download_symbols': 'ondemand', 01:08:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:08:33 INFO - 'tooltool.py': '/tools/tooltool.py', 01:08:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:08:33 INFO - '/tools/misc-python/virtualenv.py')}, 01:08:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:08:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:08:33 INFO - 'installer_path': 'installer.exe', 01:08:33 INFO - 'log_level': 'info', 01:08:33 INFO - 'log_name': 'talos', 01:08:33 INFO - 'log_to_console': True, 01:08:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:08:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:08:33 INFO - 'opt_config_files': (), 01:08:33 INFO - 'pip_index': False, 01:08:33 INFO - 'sps_profile': False, 01:08:33 INFO - 'sps_profile_interval': 0, 01:08:33 INFO - 'suite': 'dromaeojs', 01:08:33 INFO - 'system_bits': '32', 01:08:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:08:33 INFO - 'title': 'talos-linux64-ix-037', 01:08:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:08:33 INFO - 'use_talos_json': True, 01:08:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:08:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:08:33 INFO - 'work_dir': 'build'} 01:08:33 INFO - ##### 01:08:33 INFO - ##### Running clobber step. 01:08:33 INFO - ##### 01:08:33 INFO - Running pre-action listener: _resource_record_pre_action 01:08:33 INFO - Running main action method: clobber 01:08:33 INFO - rmtree: /builds/slave/test/build 01:08:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:08:34 INFO - Running post-action listener: _resource_record_post_action 01:08:34 INFO - ##### 01:08:34 INFO - ##### Finished clobber step (success) 01:08:34 INFO - ##### 01:08:34 INFO - ##### 01:08:34 INFO - ##### Running read-buildbot-config step. 01:08:34 INFO - ##### 01:08:34 INFO - Running pre-action listener: _resource_record_pre_action 01:08:34 INFO - Running main action method: read_buildbot_config 01:08:34 INFO - Using buildbot properties: 01:08:34 INFO - { 01:08:34 INFO - "project": "", 01:08:34 INFO - "product": "firefox", 01:08:34 INFO - "script_repo_revision": "production", 01:08:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:08:34 INFO - "repository": "", 01:08:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:08:34 INFO - "buildid": "20160521003735", 01:08:34 INFO - "pgo_build": "False", 01:08:34 INFO - "basedir": "/builds/slave/test", 01:08:34 INFO - "buildnumber": 1703, 01:08:34 INFO - "slavename": "talos-linux64-ix-037", 01:08:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:08:34 INFO - "platform": "ubuntu64_hw", 01:08:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:08:34 INFO - "branch": "fx-team", 01:08:34 INFO - "repo_path": "integration/fx-team", 01:08:34 INFO - "revision": "b7756d054ba86fd2a6a9bd851dbd58b0b4542b42", 01:08:34 INFO - "stage_platform": "linux64", 01:08:34 INFO - "builduid": "c2181ba5fda8461ea3c84343455ce2ef", 01:08:34 INFO - "slavebuilddir": "test" 01:08:34 INFO - } 01:08:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:08:34 INFO - Running post-action listener: _resource_record_post_action 01:08:34 INFO - ##### 01:08:34 INFO - ##### Finished read-buildbot-config step (success) 01:08:34 INFO - ##### 01:08:34 INFO - ##### 01:08:34 INFO - ##### Running download-and-extract step. 01:08:34 INFO - ##### 01:08:34 INFO - Running pre-action listener: _resource_record_pre_action 01:08:34 INFO - Running main action method: download_and_extract 01:08:34 INFO - mkdir: /builds/slave/test/build/tests 01:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:34 INFO - https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:36 INFO - Downloaded 1361 bytes. 01:08:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:08:36 INFO - Using the following test package requirements: 01:08:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:08:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:08:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:36 INFO - u'jsshell-linux-x86_64.zip'], 01:08:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:08:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:08:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:08:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:08:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:08:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:36 INFO - https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:37 INFO - Downloaded 22814444 bytes. 01:08:37 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'] 01:08:37 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 01:08:38 INFO - Return code: 0 01:08:38 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 01:08: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')]} 01:08:38 INFO - https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:08:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:08:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:48 INFO - Downloaded 22814444 bytes. 01:08:48 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'] 01:08:48 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 01:08:49 INFO - Return code: 0 01:08:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:49 INFO - https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:50 INFO - Downloaded 10840359 bytes. 01:08:50 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'] 01:08:50 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 01:08:50 INFO - Return code: 0 01:08:50 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')]} 01:08:50 INFO - https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RuvXAPfARoWBOv8HAJB2Cw/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 01:08:51 INFO - Downloaded 54815024 bytes. 01:08:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:08:51 INFO - mkdir: /builds/slave/test/properties 01:08:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:08:51 INFO - Writing to file /builds/slave/test/properties/build_url 01:08:51 INFO - Contents: 01:08:51 INFO - build_url:https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:08:52 INFO - Running post-action listener: _resource_record_post_action 01:08:52 INFO - Running post-action listener: set_extra_try_arguments 01:08:52 INFO - ##### 01:08:52 INFO - ##### Finished download-and-extract step (success) 01:08:52 INFO - ##### 01:08:52 INFO - ##### 01:08:52 INFO - ##### Running populate-webroot step. 01:08:52 INFO - ##### 01:08:52 INFO - Running pre-action listener: _resource_record_pre_action 01:08:52 INFO - Running main action method: populate_webroot 01:08:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:08:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:08:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:08:52 INFO - '--tppagecycles', 01:08:52 INFO - '7'], 01:08:52 INFO - 'tests': ['tsvgm']}}, 01:08:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:08:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:08:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:08:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:08:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:08:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:08:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:52 INFO - 'talos_options': ['--disable-e10s'], 01:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:52 INFO - 'talos_options': ['--disable-e10s'], 01:08:52 INFO - 'tests': ['damp', 'tps']}, 01:08:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:52 INFO - 'tests': ['damp', 'tps']}, 01:08:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:08:52 INFO - 'tests': ['dromaeo_dom']}, 01:08:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:08:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:08:52 INFO - 'tests': ['a11yr', 01:08:52 INFO - 'ts_paint', 01:08:52 INFO - 'tpaint', 01:08:52 INFO - 'sessionrestore', 01:08:52 INFO - 'sessionrestore_no_auto_restore', 01:08:52 INFO - 'tabpaint']}, 01:08:52 INFO - 'other-e10s': {'tests': ['a11yr', 01:08:52 INFO - 'ts_paint', 01:08:52 INFO - 'tpaint', 01:08:52 INFO - 'sessionrestore', 01:08:52 INFO - 'sessionrestore_no_auto_restore', 01:08:52 INFO - 'tabpaint']}, 01:08:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:08:52 INFO - 'ts_paint', 01:08:52 INFO - 'tpaint', 01:08:52 INFO - 'sessionrestore', 01:08:52 INFO - 'sessionrestore_no_auto_restore', 01:08:52 INFO - 'tabpaint']}, 01:08:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:08:52 INFO - 'ts_paint', 01:08:52 INFO - 'tpaint', 01:08:52 INFO - 'sessionrestore', 01:08:52 INFO - 'sessionrestore_no_auto_restore', 01:08:52 INFO - 'tabpaint']}, 01:08:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:08:52 INFO - 'tests': ['a11yr', 01:08:52 INFO - 'ts_paint', 01:08:52 INFO - 'tpaint', 01:08:52 INFO - 'sessionrestore', 01:08:52 INFO - 'sessionrestore_no_auto_restore', 01:08:52 INFO - 'tabpaint']}, 01:08:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:08:52 INFO - 'tests': ['a11yr', 01:08:52 INFO - 'ts_paint', 01:08:52 INFO - 'tpaint', 01:08:52 INFO - 'sessionrestore', 01:08:52 INFO - 'sessionrestore_no_auto_restore', 01:08:52 INFO - 'tabpaint']}, 01:08:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:08:52 INFO - 'tests': ['tsvgx', 01:08:52 INFO - 'tsvgr_opacity', 01:08:52 INFO - 'tart', 01:08:52 INFO - 'tscrollx', 01:08:52 INFO - 'cart']}, 01:08:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:08:52 INFO - 'tsvgr_opacity', 01:08:52 INFO - 'tart', 01:08:52 INFO - 'tscrollx', 01:08:52 INFO - 'cart']}, 01:08:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:52 INFO - 'talos_options': ['--disable-e10s'], 01:08:52 INFO - 'tests': ['tp5o']}, 01:08:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:52 INFO - 'tests': ['tp5o']}, 01:08:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:52 INFO - 'talos_options': ['--disable-e10s', 01:08:52 INFO - '--xperf_path', 01:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:52 INFO - 'tests': ['tp5n']}, 01:08:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:52 INFO - 'talos_options': ['--xperf_path', 01:08:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:52 INFO - 'tests': ['tp5n']}}, 01:08:52 INFO - 'talos.zip': {'path': '', 01:08:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:08:52 INFO - Running post-action listener: _resource_record_post_action 01:08:52 INFO - ##### 01:08:52 INFO - ##### Finished populate-webroot step (success) 01:08:52 INFO - ##### 01:08:52 INFO - ##### 01:08:52 INFO - ##### Running create-virtualenv step. 01:08:52 INFO - ##### 01:08:52 INFO - Running pre-action listener: _resource_record_pre_action 01:08:52 INFO - Running main action method: create_virtualenv 01:08:52 INFO - Creating virtualenv /builds/slave/test/build/venv 01:08:52 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 01:08:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:08:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:08:52 INFO - Using real prefix '/usr' 01:08:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:08:53 INFO - Installing distribute.............................................................................................................................................................................................done. 01:08:55 INFO - Installing pip.................done. 01:08:55 INFO - Return code: 0 01:08:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:08:55 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')]} 01:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:55 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')]} 01:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:55 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 0x7fb5b244ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1688770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17179c0>, '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 0x17188c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1718d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', '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 01:08:55 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 01:08:55 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 01:08:55 INFO - Using env: {'DISPLAY': ':0', 01:08:55 INFO - 'HOME': '/home/cltbld', 01:08:55 INFO - 'LANG': 'en_US.UTF-8', 01:08:55 INFO - 'LANGUAGE': 'en_US:en', 01:08:55 INFO - 'LOGNAME': 'cltbld', 01:08:55 INFO - 'MAIL': '/var/mail/cltbld', 01:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:55 INFO - 'MOZ_NO_REMOTE': '1', 01:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:55 INFO - 'NO_EM_RESTART': '1', 01:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:55 INFO - 'PWD': '/builds/slave/test', 01:08:55 INFO - 'SHELL': '/bin/bash', 01:08:55 INFO - 'SHLVL': '1', 01:08:55 INFO - 'TERM': 'linux', 01:08:55 INFO - 'TMOUT': '86400', 01:08:55 INFO - 'USER': 'cltbld', 01:08:55 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', 01:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:55 INFO - '_': '/tools/buildbot/bin/python'} 01:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:55 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 01:08:55 INFO - Cleaning up... 01:08:55 INFO - Return code: 0 01:08:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:08:55 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')]} 01:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:55 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')]} 01:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:55 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 0x7fb5b244ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1688770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17179c0>, '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 0x17188c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1718d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', '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 01:08:55 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 01:08:55 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 01:08:55 INFO - Using env: {'DISPLAY': ':0', 01:08:55 INFO - 'HOME': '/home/cltbld', 01:08:55 INFO - 'LANG': 'en_US.UTF-8', 01:08:55 INFO - 'LANGUAGE': 'en_US:en', 01:08:55 INFO - 'LOGNAME': 'cltbld', 01:08:55 INFO - 'MAIL': '/var/mail/cltbld', 01:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:55 INFO - 'MOZ_NO_REMOTE': '1', 01:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:55 INFO - 'NO_EM_RESTART': '1', 01:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:55 INFO - 'PWD': '/builds/slave/test', 01:08:55 INFO - 'SHELL': '/bin/bash', 01:08:55 INFO - 'SHLVL': '1', 01:08:55 INFO - 'TERM': 'linux', 01:08:55 INFO - 'TMOUT': '86400', 01:08:55 INFO - 'USER': 'cltbld', 01:08:55 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', 01:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:55 INFO - '_': '/tools/buildbot/bin/python'} 01:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:55 INFO - Downloading/unpacking psutil>=3.1.1 01:08:55 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 01:08:55 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 01:08:55 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 01:08:55 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 01:08:55 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 01:08:55 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 01:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:08:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:57 INFO - Installing collected packages: psutil 01:08:57 INFO - Running setup.py install for psutil 01:08:57 INFO - building 'psutil._psutil_linux' extension 01:08:57 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 01:08:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:08:58 INFO - building 'psutil._psutil_posix' extension 01:08:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:08:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:08:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:58 INFO - Successfully installed psutil 01:08:58 INFO - Cleaning up... 01:08:58 INFO - Return code: 0 01:08:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:58 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 0x7fb5b244ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1688770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17179c0>, '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 0x17188c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1718d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', '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 01:08:58 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 01:08:58 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 01:08:58 INFO - Using env: {'DISPLAY': ':0', 01:08:58 INFO - 'HOME': '/home/cltbld', 01:08:58 INFO - 'LANG': 'en_US.UTF-8', 01:08:58 INFO - 'LANGUAGE': 'en_US:en', 01:08:58 INFO - 'LOGNAME': 'cltbld', 01:08:58 INFO - 'MAIL': '/var/mail/cltbld', 01:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:58 INFO - 'MOZ_NO_REMOTE': '1', 01:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:58 INFO - 'NO_EM_RESTART': '1', 01:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:08:58 INFO - 'PWD': '/builds/slave/test', 01:08:58 INFO - 'SHELL': '/bin/bash', 01:08:58 INFO - 'SHLVL': '1', 01:08:58 INFO - 'TERM': 'linux', 01:08:58 INFO - 'TMOUT': '86400', 01:08:58 INFO - 'USER': 'cltbld', 01:08:58 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', 01:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:58 INFO - '_': '/tools/buildbot/bin/python'} 01:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:08:58 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 01:08:58 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 01:08:58 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 01:08:58 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 01:08:58 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 01:08:58 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 01:09:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:09:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:09:00 INFO - Installing collected packages: mozsystemmonitor 01:09:00 INFO - Running setup.py install for mozsystemmonitor 01:09:00 INFO - Successfully installed mozsystemmonitor 01:09:00 INFO - Cleaning up... 01:09:00 INFO - Return code: 0 01:09:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:09:00 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')]} 01:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:00 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')]} 01:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:00 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 0x7fb5b244ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1688770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17179c0>, '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 0x17188c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1718d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', '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 01:09:00 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 01:09:00 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 01:09:00 INFO - Using env: {'DISPLAY': ':0', 01:09:00 INFO - 'HOME': '/home/cltbld', 01:09:00 INFO - 'LANG': 'en_US.UTF-8', 01:09:00 INFO - 'LANGUAGE': 'en_US:en', 01:09:00 INFO - 'LOGNAME': 'cltbld', 01:09:00 INFO - 'MAIL': '/var/mail/cltbld', 01:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:00 INFO - 'MOZ_NO_REMOTE': '1', 01:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:00 INFO - 'NO_EM_RESTART': '1', 01:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:00 INFO - 'PWD': '/builds/slave/test', 01:09:00 INFO - 'SHELL': '/bin/bash', 01:09:00 INFO - 'SHLVL': '1', 01:09:00 INFO - 'TERM': 'linux', 01:09:00 INFO - 'TMOUT': '86400', 01:09:00 INFO - 'USER': 'cltbld', 01:09:00 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', 01:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:00 INFO - '_': '/tools/buildbot/bin/python'} 01:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:00 INFO - Downloading/unpacking blobuploader==1.2.4 01:09:00 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 01:09:00 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 01:09:00 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 01:09:00 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 01:09:00 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 01:09:00 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 01:09:02 INFO - Downloading blobuploader-1.2.4.tar.gz 01:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:09:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:09:02 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 01:09:02 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 01:09:02 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 01:09:02 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 01:09:02 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 01:09:02 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 01:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:09:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:03 INFO - Downloading docopt-0.6.1.tar.gz 01:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:09:03 INFO - Installing collected packages: blobuploader, requests, docopt 01:09:03 INFO - Running setup.py install for blobuploader 01:09:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:09:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:09:03 INFO - Running setup.py install for requests 01:09:03 INFO - Running setup.py install for docopt 01:09:04 INFO - Successfully installed blobuploader requests docopt 01:09:04 INFO - Cleaning up... 01:09:04 INFO - Return code: 0 01:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:04 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 0x7fb5b244ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1688770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17179c0>, '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 0x17188c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1718d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', '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 01:09:04 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 01:09:04 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 01:09:04 INFO - Using env: {'DISPLAY': ':0', 01:09:04 INFO - 'HOME': '/home/cltbld', 01:09:04 INFO - 'LANG': 'en_US.UTF-8', 01:09:04 INFO - 'LANGUAGE': 'en_US:en', 01:09:04 INFO - 'LOGNAME': 'cltbld', 01:09:04 INFO - 'MAIL': '/var/mail/cltbld', 01:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:04 INFO - 'MOZ_NO_REMOTE': '1', 01:09:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:04 INFO - 'NO_EM_RESTART': '1', 01:09:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:04 INFO - 'PWD': '/builds/slave/test', 01:09:04 INFO - 'SHELL': '/bin/bash', 01:09:04 INFO - 'SHLVL': '1', 01:09:04 INFO - 'TERM': 'linux', 01:09:04 INFO - 'TMOUT': '86400', 01:09:04 INFO - 'USER': 'cltbld', 01:09:04 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', 01:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:04 INFO - '_': '/tools/buildbot/bin/python'} 01:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:04 INFO - Running setup.py (path:/tmp/pip-FliXHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:04 INFO - Running setup.py (path:/tmp/pip-mmjddS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:04 INFO - Running setup.py (path:/tmp/pip-4G4YBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:04 INFO - Running setup.py (path:/tmp/pip-o46ySm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:04 INFO - Running setup.py (path:/tmp/pip-NebyQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:04 INFO - Running setup.py (path:/tmp/pip-ZTPVH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:04 INFO - Running setup.py (path:/tmp/pip-63_gk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:04 INFO - Running setup.py (path:/tmp/pip-39kgsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:04 INFO - Running setup.py (path:/tmp/pip-ld2UJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:04 INFO - Running setup.py (path:/tmp/pip-UDYekQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:05 INFO - Running setup.py (path:/tmp/pip-JmQLR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:05 INFO - Running setup.py (path:/tmp/pip-vCehtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:05 INFO - Running setup.py (path:/tmp/pip-W7_0iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:05 INFO - Running setup.py (path:/tmp/pip-ncPjgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:05 INFO - Running setup.py (path:/tmp/pip-pfenMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:05 INFO - Running setup.py (path:/tmp/pip-P0Mz5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:05 INFO - Running setup.py (path:/tmp/pip-61TdWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:09:05 INFO - Running setup.py install for manifestparser 01:09:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:09:05 INFO - Running setup.py install for mozcrash 01:09:05 INFO - Running setup.py install for mozdebug 01:09:05 INFO - Running setup.py install for mozdevice 01:09:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:09:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:09:05 INFO - Running setup.py install for mozfile 01:09:06 INFO - Running setup.py install for mozhttpd 01:09:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Running setup.py install for mozinfo 01:09:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Running setup.py install for mozInstall 01:09:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Running setup.py install for mozleak 01:09:06 INFO - Running setup.py install for mozlog 01:09:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Running setup.py install for moznetwork 01:09:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Running setup.py install for mozprocess 01:09:06 INFO - Running setup.py install for mozprofile 01:09:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:09:06 INFO - Running setup.py install for mozrunner 01:09:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:09:07 INFO - Running setup.py install for mozscreenshot 01:09:07 INFO - Running setup.py install for moztest 01:09:07 INFO - Running setup.py install for mozversion 01:09:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:09:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:09:07 INFO - Cleaning up... 01:09:07 INFO - Return code: 0 01:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:07 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')]} 01:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:07 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')]} 01:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:07 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 0x7fb5b244ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1688770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17179c0>, '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 0x17188c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1718d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', '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 01:09:07 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 01:09:07 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 01:09:07 INFO - Using env: {'DISPLAY': ':0', 01:09:07 INFO - 'HOME': '/home/cltbld', 01:09:07 INFO - 'LANG': 'en_US.UTF-8', 01:09:07 INFO - 'LANGUAGE': 'en_US:en', 01:09:07 INFO - 'LOGNAME': 'cltbld', 01:09:07 INFO - 'MAIL': '/var/mail/cltbld', 01:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:07 INFO - 'MOZ_NO_REMOTE': '1', 01:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:07 INFO - 'NO_EM_RESTART': '1', 01:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:07 INFO - 'PWD': '/builds/slave/test', 01:09:07 INFO - 'SHELL': '/bin/bash', 01:09:07 INFO - 'SHLVL': '1', 01:09:07 INFO - 'TERM': 'linux', 01:09:07 INFO - 'TMOUT': '86400', 01:09:07 INFO - 'USER': 'cltbld', 01:09:07 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', 01:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:07 INFO - '_': '/tools/buildbot/bin/python'} 01:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:07 INFO - Running setup.py (path:/tmp/pip-T8P2v_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:07 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)) 01:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:07 INFO - Running setup.py (path:/tmp/pip-4S376k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:07 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)) 01:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:07 INFO - Running setup.py (path:/tmp/pip-p0ssdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:07 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)) 01:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:07 INFO - Running setup.py (path:/tmp/pip-VfE0vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:07 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)) 01:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:07 INFO - Running setup.py (path:/tmp/pip-_JFE1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:07 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)) 01:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:07 INFO - Running setup.py (path:/tmp/pip-YhUp3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:07 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)) 01:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:07 INFO - Running setup.py (path:/tmp/pip-EmdqnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:08 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)) 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:08 INFO - Running setup.py (path:/tmp/pip-1wL87q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:08 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)) 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:08 INFO - Running setup.py (path:/tmp/pip-YgBbSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:08 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)) 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:08 INFO - Running setup.py (path:/tmp/pip-42bCJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:08 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)) 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:08 INFO - Running setup.py (path:/tmp/pip-Paelmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:08 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)) 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:08 INFO - Running setup.py (path:/tmp/pip-DLPyvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:08 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)) 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:08 INFO - Running setup.py (path:/tmp/pip-rsfQhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:08 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)) 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:08 INFO - Running setup.py (path:/tmp/pip-8T9Ucf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:08 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)) 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:08 INFO - Running setup.py (path:/tmp/pip-Gz3Gmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:08 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)) 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:08 INFO - Running setup.py (path:/tmp/pip-DI7PB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:08 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)) 01:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:08 INFO - Running setup.py (path:/tmp/pip-5xR8gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:08 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)) 01:09:08 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)) 01:09:08 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)) 01:09:08 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)) 01:09:08 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)) 01:09:08 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)) 01:09:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:09:08 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 01:09:08 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 01:09:08 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 01:09:08 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 01:09:08 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 01:09:08 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 01:09:10 INFO - Downloading blessings-1.6.tar.gz 01:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:09:10 INFO - Installing collected packages: blessings 01:09:10 INFO - Running setup.py install for blessings 01:09:10 INFO - Successfully installed blessings 01:09:10 INFO - Cleaning up... 01:09:10 INFO - Return code: 0 01:09:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:11 INFO - Reading from file tmpfile_stdout 01:09:11 INFO - Current package versions: 01:09:11 INFO - argparse == 1.2.1 01:09:11 INFO - blessings == 1.6 01:09:11 INFO - blobuploader == 1.2.4 01:09:11 INFO - docopt == 0.6.1 01:09:11 INFO - manifestparser == 1.1 01:09:11 INFO - mozInstall == 1.12 01:09:11 INFO - mozcrash == 0.17 01:09:11 INFO - mozdebug == 0.1 01:09:11 INFO - mozdevice == 0.48 01:09:11 INFO - mozfile == 1.2 01:09:11 INFO - mozhttpd == 0.7 01:09:11 INFO - mozinfo == 0.9 01:09:11 INFO - mozleak == 0.1 01:09:11 INFO - mozlog == 3.2 01:09:11 INFO - moznetwork == 0.27 01:09:11 INFO - mozprocess == 0.22 01:09:11 INFO - mozprofile == 0.28 01:09:11 INFO - mozrunner == 6.11 01:09:11 INFO - mozscreenshot == 0.1 01:09:11 INFO - mozsystemmonitor == 0.3 01:09:11 INFO - moztest == 0.7 01:09:11 INFO - mozversion == 1.4 01:09:11 INFO - psutil == 3.1.1 01:09:11 INFO - requests == 1.2.3 01:09:11 INFO - wsgiref == 0.1.2 01:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:11 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 0x7fb5b244ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1688770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17179c0>, '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 0x17188c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1718d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', '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 01:09:11 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 01:09:11 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 01:09:11 INFO - Using env: {'DISPLAY': ':0', 01:09:11 INFO - 'HOME': '/home/cltbld', 01:09:11 INFO - 'LANG': 'en_US.UTF-8', 01:09:11 INFO - 'LANGUAGE': 'en_US:en', 01:09:11 INFO - 'LOGNAME': 'cltbld', 01:09:11 INFO - 'MAIL': '/var/mail/cltbld', 01:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:11 INFO - 'MOZ_NO_REMOTE': '1', 01:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:11 INFO - 'NO_EM_RESTART': '1', 01:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:11 INFO - 'PWD': '/builds/slave/test', 01:09:11 INFO - 'SHELL': '/bin/bash', 01:09:11 INFO - 'SHLVL': '1', 01:09:11 INFO - 'TERM': 'linux', 01:09:11 INFO - 'TMOUT': '86400', 01:09:11 INFO - 'USER': 'cltbld', 01:09:11 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', 01:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:11 INFO - '_': '/tools/buildbot/bin/python'} 01:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:11 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)) 01:09:11 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)) 01:09:11 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)) 01:09:11 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)) 01:09:11 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)) 01:09:11 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)) 01:09:11 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)) 01:09:11 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)) 01:09:11 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)) 01:09:11 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)) 01:09:11 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)) 01:09:11 INFO - Cleaning up... 01:09:11 INFO - Return code: 0 01:09:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:11 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 0x7fb5b244ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1688770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17179c0>, '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 0x17188c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1718d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', '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 01:09:11 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 01:09:11 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 01:09:11 INFO - Using env: {'DISPLAY': ':0', 01:09:11 INFO - 'HOME': '/home/cltbld', 01:09:11 INFO - 'LANG': 'en_US.UTF-8', 01:09:11 INFO - 'LANGUAGE': 'en_US:en', 01:09:11 INFO - 'LOGNAME': 'cltbld', 01:09:11 INFO - 'MAIL': '/var/mail/cltbld', 01:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:11 INFO - 'MOZ_NO_REMOTE': '1', 01:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:11 INFO - 'NO_EM_RESTART': '1', 01:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:11 INFO - 'PWD': '/builds/slave/test', 01:09:11 INFO - 'SHELL': '/bin/bash', 01:09:11 INFO - 'SHLVL': '1', 01:09:11 INFO - 'TERM': 'linux', 01:09:11 INFO - 'TMOUT': '86400', 01:09:11 INFO - 'USER': 'cltbld', 01:09:11 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', 01:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:11 INFO - '_': '/tools/buildbot/bin/python'} 01:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:11 INFO - Downloading/unpacking jsonschema 01:09:11 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 01:09:11 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 01:09:11 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 01:09:11 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 01:09:11 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 01:09:11 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 01:09:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:09:13 INFO - Downloading/unpacking functools32 (from jsonschema) 01:09:13 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 01:09:13 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 01:09:13 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 01:09:13 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 01:09:13 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 01:09:13 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 01:09:13 INFO - Downloading functools32-3.2.3-2.tar.gz 01:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:09:13 INFO - warning: no files found matching '*.txt' 01:09:13 INFO - no previously-included directories found matching 'build' 01:09:13 INFO - no previously-included directories found matching 'dist' 01:09:13 INFO - no previously-included directories found matching '.git*' 01:09:13 INFO - Installing collected packages: jsonschema, functools32 01:09:13 INFO - Running setup.py install for functools32 01:09:13 INFO - warning: no files found matching '*.txt' 01:09:13 INFO - no previously-included directories found matching 'build' 01:09:13 INFO - no previously-included directories found matching 'dist' 01:09:13 INFO - no previously-included directories found matching '.git*' 01:09:13 INFO - Successfully installed jsonschema functools32 01:09:13 INFO - Cleaning up... 01:09:13 INFO - Return code: 0 01:09:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:09:13 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')]} 01:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:13 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')]} 01:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:13 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 0x7fb5b244ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1688770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17179c0>, '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 0x17188c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1718d50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', '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 01:09:13 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 01:09:13 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 01:09:13 INFO - Using env: {'DISPLAY': ':0', 01:09:13 INFO - 'HOME': '/home/cltbld', 01:09:13 INFO - 'LANG': 'en_US.UTF-8', 01:09:13 INFO - 'LANGUAGE': 'en_US:en', 01:09:13 INFO - 'LOGNAME': 'cltbld', 01:09:13 INFO - 'MAIL': '/var/mail/cltbld', 01:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:13 INFO - 'MOZ_NO_REMOTE': '1', 01:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:13 INFO - 'NO_EM_RESTART': '1', 01:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:13 INFO - 'PWD': '/builds/slave/test', 01:09:13 INFO - 'SHELL': '/bin/bash', 01:09:13 INFO - 'SHLVL': '1', 01:09:13 INFO - 'TERM': 'linux', 01:09:13 INFO - 'TMOUT': '86400', 01:09:13 INFO - 'USER': 'cltbld', 01:09:13 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', 01:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:13 INFO - '_': '/tools/buildbot/bin/python'} 01:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:14 INFO - Downloading/unpacking flake8 01:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:09:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:09:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 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 01:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:09:16 INFO - no previously-included directories found matching 'docs/_build' 01:09:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:09:16 INFO - Running setup.py install for pep8 01:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:09:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:09:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:09:16 INFO - no previously-included directories found matching 'docs/_build' 01:09:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:09:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:09:16 INFO - Cleaning up... 01:09:16 INFO - Return code: 0 01:09:16 INFO - Running post-action listener: _resource_record_post_action 01:09:16 INFO - Running post-action listener: _start_resource_monitoring 01:09:16 INFO - Starting resource monitoring. 01:09:16 INFO - ##### 01:09:16 INFO - ##### Finished create-virtualenv step (success) 01:09:16 INFO - ##### 01:09:16 INFO - ##### 01:09:16 INFO - ##### Running install step. 01:09:16 INFO - ##### 01:09:16 INFO - Running pre-action listener: _resource_record_pre_action 01:09:16 INFO - Running main action method: install 01:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:17 INFO - Reading from file tmpfile_stdout 01:09:17 INFO - Detecting whether we're running mozinstall >=1.0... 01:09:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:09:17 INFO - Reading from file tmpfile_stdout 01:09:17 INFO - Output received: 01:09:17 INFO - Usage: mozinstall [options] installer 01:09:17 INFO - Options: 01:09:17 INFO - -h, --help show this help message and exit 01:09:17 INFO - -d DEST, --destination=DEST 01:09:17 INFO - Directory to install application into. [default: 01:09:17 INFO - "/builds/slave/test"] 01:09:17 INFO - --app=APP Application being installed. [default: firefox] 01:09:17 INFO - mkdir: /builds/slave/test/build/application 01:09:17 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'] 01:09:17 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 01:09:33 INFO - Reading from file tmpfile_stdout 01:09:33 INFO - Output received: 01:09:33 INFO - /builds/slave/test/build/application/firefox/firefox 01:09:33 INFO - Running post-action listener: _resource_record_post_action 01:09:33 INFO - ##### 01:09:33 INFO - ##### Finished install step (success) 01:09:33 INFO - ##### 01:09:33 INFO - ##### 01:09:33 INFO - ##### Running run-tests step. 01:09:33 INFO - ##### 01:09:33 INFO - Running pre-action listener: _resource_record_pre_action 01:09:33 INFO - Running main action method: run_tests 01:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:09:33 INFO - Python 2.7.3 01:09:33 INFO - Return code: 0 01:09:33 INFO - grabbing minidump binary from tooltool 01:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17179c0>, '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 0x17188c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1718d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:09:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:09:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:09:33 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 01:09:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:09:33 INFO - Return code: 0 01:09:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:09:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:09:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:09:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:09:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:09:34 INFO - Return code: 0 01:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 01:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 01:09:34 INFO - Using env: {'DISPLAY': ':0', 01:09:34 INFO - 'HOME': '/home/cltbld', 01:09:34 INFO - 'LANG': 'en_US.UTF-8', 01:09:34 INFO - 'LANGUAGE': 'en_US:en', 01:09:34 INFO - 'LOGNAME': 'cltbld', 01:09:34 INFO - 'MAIL': '/var/mail/cltbld', 01:09:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:09:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:34 INFO - 'MOZ_NO_REMOTE': '1', 01:09:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:34 INFO - 'NO_EM_RESTART': '1', 01:09:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:34 INFO - 'PWD': '/builds/slave/test', 01:09:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:09:34 INFO - 'SHELL': '/bin/bash', 01:09:34 INFO - 'SHLVL': '1', 01:09:34 INFO - 'TERM': 'linux', 01:09:34 INFO - 'TMOUT': '86400', 01:09:34 INFO - 'USER': 'cltbld', 01:09:34 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507', 01:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:34 INFO - '_': '/tools/buildbot/bin/python'} 01:09:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 01:09:34 INFO - mozversion application_buildid: 20160521003735 01:09:34 INFO - mozversion application_changeset: b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 01:09:34 INFO - mozversion application_display_name: Nightly 01:09:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:09:34 INFO - mozversion application_name: Firefox 01:09:34 INFO - mozversion application_remotingname: firefox 01:09:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:09:34 INFO - mozversion application_vendor: Mozilla 01:09:34 INFO - mozversion application_version: 49.0a1 01:09:34 INFO - mozversion platform_buildid: 20160521003735 01:09:34 INFO - mozversion platform_changeset: b7756d054ba86fd2a6a9bd851dbd58b0b4542b42 01:09:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:09:34 INFO - mozversion platform_version: 49.0a1 01:09:34 INFO - using testdate: 1463818174 01:09:34 INFO - actual date: 1463818174 01:09:34 INFO - starting webserver on 'localhost:34660' 01:09:34 INFO - SUITE-START | Running 2 tests 01:09:34 INFO - TEST-START | dromaeo_css 01:09:34 INFO - operating with platform_type : linux_ 01:09:34 INFO - Initialising browser for dromaeo_css test... 01:09:34 INFO - TEST-INFO | started process 12518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd80xsl/profile http://localhost:34660/getInfo.html) 01:09:38 INFO - PROCESS | 12518 | __metrics Screen width/height:1600/1200 01:09:38 INFO - PROCESS | 12518 | colorDepth:24 01:09:38 INFO - PROCESS | 12518 | Browser inner width/height: 1024/697 01:09:38 INFO - PROCESS | 12518 | __metrics 01:09:39 ERROR - PROCESS | 12518 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:09:40 INFO - TEST-INFO | 12518: exit 0 01:09:40 INFO - Browser initialized. 01:09:40 INFO - Running cycle 1/1 for dromaeo_css test... 01:09:40 INFO - TEST-INFO | started process 12596 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd80xsl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:52 INFO - PROCESS | 12596 | RSS: Main: 154603520 01:09:52 INFO - PROCESS | 12596 | 01:10:44 INFO - PROCESS | 12596 | 1463818244431 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] 01:12:56 INFO - PROCESS | 12596 | Cycle 1(1): loaded http://localhost:34660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34660/tests/dromaeo/cssquery-ext.html) 01:12:57 INFO - PROCESS | 12596 | RSS: Main: 263155712 01:12:57 INFO - PROCESS | 12596 | 01:15:59 INFO - PROCESS | 12596 | Cycle 1(1): loaded http://localhost:34660/tests/dromaeo/cssquery-ext.html (next: http://localhost:34660/tests/dromaeo/cssquery-jquery.html) 01:16:00 INFO - PROCESS | 12596 | RSS: Main: 235479040 01:16:00 INFO - PROCESS | 12596 | 01:19:02 INFO - PROCESS | 12596 | Cycle 1(1): loaded http://localhost:34660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34660/tests/dromaeo/cssquery-mootools.html) 01:19:03 INFO - PROCESS | 12596 | RSS: Main: 230731776 01:19:03 INFO - PROCESS | 12596 | 01:22:05 INFO - PROCESS | 12596 | Cycle 1(1): loaded http://localhost:34660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34660/tests/dromaeo/cssquery-prototype.html) 01:22:05 INFO - PROCESS | 12596 | RSS: Main: 231084032 01:22:05 INFO - PROCESS | 12596 | 01:25:08 INFO - PROCESS | 12596 | Cycle 1(1): loaded http://localhost:34660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34660/tests/dromaeo/cssquery-yui.html) 01:25:09 INFO - PROCESS | 12596 | RSS: Main: 213872640 01:25:09 INFO - PROCESS | 12596 | 01:28:12 INFO - PROCESS | 12596 | Cycle 1(1): loaded http://localhost:34660/tests/dromaeo/cssquery-yui.html (next: http://localhost:34660/tests/dromaeo/cssquery-dojo.html) 01:28:12 INFO - PROCESS | 12596 | RSS: Main: 275406848 01:28:12 INFO - PROCESS | 12596 | 01:28:12 INFO - PROCESS | 12596 | __start_tp_report 01:28:12 INFO - PROCESS | 12596 | _x_x_mozilla_page_load 01:28:12 INFO - PROCESS | 12596 | _x_x_mozilla_page_load_details 01:28:12 INFO - PROCESS | 12596 | |i|pagename|runs| 01:28:12 INFO - PROCESS | 12596 | |0;dojo.html;2666.7199944005883;2690.0988168963395;2715.334742987968;2723.1285988483683;2732.016474069335;4646.581807637312;4723.929141062887;4743.5967942724865;4820.252860806572;4856.077345304389;4728.243481043034;4731.361266229058;4737.289406589005;4814.927776083362;4818.783154758035;4296.527381987987;4331.242032644291;4370.803313850868;4410.889727756799;4546.113507865967;4465.441819772528;4488.955110448886;4492.079123779634;4521.886952826173;4537.727736335831;4248.915021699549;4293.055527783914;4360.389545463638;4389.846355377546;4414.448193975753;4349.717268377545;4352.564743525622;4356.89107772305;4461.9107617847785;4476.350929115292;4372.584604462571;4379.671524635665;4397.2964325707735;4405.603495685372;4427.380166776654;4542.636589072867;4617.653675974316;4693.7653117344;4746.857594272177;4753.691010084368;5072.315237442935;5156.92264616031;5159.458256883048;5160.48395160481;5164.715940623264;5120.385553733576;5176.50823171798;5190.532852043334;5194.0391027659625;5197.948020519784;4662.417197850269;4728.739919304402;4770.356001939763;4821.734804585782;4824.228123500258;5251.894962100737;5260.552853007461;5297.17893726473;5300.44345343741;5313.362396512443;5032.169692000779;5033.672811267256;5077.543021128116;5087.109755792721;5092.643514953992;4958.603311735053;4981.850544483671;4982.551570358685;5036.84889453317;5174.353205849269;4999.250112483157;5002.699838009658;5056.772445239973;5092.9745351273;5097.108006098918;5055.87360315995;5062.367204099488;5067.315912351785;5080.796768129233;5109.489051094861;4167.604077612622;4279.636230920407;4286.357046443059;4293.2701440755145;4335.6965012449455;3724.0875985383755;3728.12389088564;3772.867949621805;3781.8865434037025;3825.024618722208;4480.507144214133;4481.305397663367;4488.259437192892;4522.208613492626;4533.161365147393;4962.230854217602;5164.767585458663;5175.585953123741;5178.572315702134;5184.8963020739375;4396.230659634552;4456.977715111469;4472.284434490466;4472.508024117345;4476.35092911526;4625.259958406638;4633.513481084437;4637.420322459692;4653.464851542049;4677.602403795648;4739.028499157595;4822;4904.901901961941;4920.6801557898625;4921.975390123026;5134.691918484903;5138.229265610188;5171.120909445328;5176.197689358156;5228.529432351107;4882.95117048825;4884.340614017062;4885.1206782779445;4892.192788190051;4939.728314942569;4870;5016.874578135576;5057.974710126426;5068.442471328225;5071.442141364373;5121.795128194831;5148.073346797612;5148.4851514848215;5162.922556161586;5207.895842083061;5008.048470790538;5023.824166154167;5024.949750502595;5027.069992051483;5073.6955782651685;4858.805647774191;4881.780319885543;4903.41159060915;4939.036887806843;4983.925241121314;4845.2732090186755;4870.634702397405;4871.756412179306;4911.386076740408;4925.261210818406;4983.9003219934675;4987.451380348231;5037.0429618373855;5038.546530812245;5048.469910659328;4771.5228477152;4833.371661683958;4855.441624213119;4881.9023619528125;4901.044296362175 01:28:12 INFO - PROCESS | 12596 | |1;ext.html;533.8069513308172;599.7391134856338;601.5518438763122;602.3945934335991;603.815836169968;40389.79805100974;41650.37524437136;41661.79169104154;45091.77454112725;45243.77378113113;41300.58699413005;41726.7913660432;41765.37351939723;41797.7910110449;41818.163636727244;7741.651625676844;7921.04947406312;7922.48503847251;7923.326517246041;7923.484973476706;7710.190430004853;7803.921960780404;7809.492382995116;7818.296353328199;7821.608919554028;7828.843423131534;7867.921320786776;7874.094479134887;7874.960625196894;7878.487898286622;7780.2608752168735;7835;7840.2159784021715;7840.803979900491;7843.8431231375625;7719.073711154641;7780.610969451504;7862.977812884345;7869.370450363957;7871.134175240719;38701.61298387008;38988;39085.804570976965;39141.804290978645;39151.804240978614;3152.6059242594674;3272.345530893831;3274.8035117892764;3455.1189446691183;3799.35410980134;28530.144095676955;29002.27494312638;29681.851590742124;29895.850520747474;30789.692103078905;3421.127612458807;3423.640517745651;3464.168599536093;3475.200703838106;3541.610422853484;265840;305843;309466;309675;406675;55851;56194.43805561892;56414.71792641011;56427.153592696144;56430.43569564252;33201.3359732804;33705.83147084298;33774.49338259928;35379;59037.70481147567;12320.75358492825;12452.626421207378;12470.501179952882;12473.251604903735;12482.937585312015;9511.809763804824;9516.619335226653;9519.904800951901;9613.615455381707;9637.759056023515;18626.627467450846;18681.15934782938;18681.906590466962;18867.245310187438;18888.622227555374;6739.393454589012;6763.661816909135;6896.344847239504;6971.82570435733;6999.8600027999155;793.3573805217792;897.7037577599376;969.9127078562822;978.5107446276861;1050.1231471721046;27417.45165096687;28091.71908280932;28536.286592835346;28698.569521457193;28960.27599309992;950.3727539823683;950.6245033211843;951.414879848888;953.947532885684;1000.5447521377756;14683.339249733788;15002.324895379734;15040;15214.695706085817;15263.389464421522;390863;394224;397735;398371;398680;49438.50561494411;49674.254886176735;49936;49938;49961.75019124881;1073.5652060915343;1154.4054811771944;1161.6573110932295;1190.1966172833477;1191.862935762381;28066.85966570154;28522.42955140927;29099.869314950865;29185.70814291915;29545.55681664734;41694.58305416907;41822.58177418187;42169.578304216564;42278.788606056776;42281.365779513944;289481;290758;292677;293003;293236;22357.552848943255;24667;24988.500229994934;25202.36994075163;25366.492670146126;41493.1701365965;41683.37474937939;42435;42593.78703106465;42838;35009.37429692732;35582;36254.27491450103;36285;36316.81841590775;35586.46620300646;35984.28031439409;36097.81951090228;36227.27545449129;36350;34986.300273994886;35435.468467973515;35660.46509302415;36650;36745.265094698494;30810.537841932837;32200.516992245604;32658.510122347707;32695;32860.67139328672;24924.50150997006;25325.493490130462;25673;25728;25882.35294117662 01:28:12 INFO - PROCESS | 12596 | |2;jquery.html;358.7524608020466;367.65440485943196;370.3149174028048;377.2495620321708;378.53818341623247;15671.29479173437;16784.664306713858;16840.32638694452;17234.569135771613;17254.39609613664;15260;16292.348306067774;17012.574685632866;17059.48821535353;17066.14669266535;5035.496450354963;5202.3497062867145;5212.582993360522;5235.55497782689;5238.607104467161;3725.9068523287;3898.785566793825;5156.097682905495;5773.134029895528;6075.696215189245;6121.632702037869;6137.5089992800695;6140.3859614038465;6154.846128846792;6170.876582468348;6054.666993315366;6122.326544080148;6130.540209484307;6131.9386806131815;6145.631262124264;3392.643772403887;4990.802207470218;5240.947590524084;5316;5362.115250983583;19744.901275493674;20403.38789836307;20439.182432702823;20524.486887827774;20573.382798516068;1979.0401655197218;1990.9402717918485;2051.5999380120884;2251.5159240763314;2276.408133885185;12788.808167877489;13014.414351354117;13046.804297935538;13085;13557.864421355758;1649.736042233237;1674.6566953774568;1709.4700642800772;1781.2073627235886;1841.6961201401753;58230;60016.69991650058;61309.693451532905;62483.37516624821;70520.29479705138;9923.65267215644;9945.45300008492;10010.199184065257;10063.39619622825;10270.33242839213;13949.372278247503;14037.298135093204;14067.43730250799;14082;14159.646008849655;6109.8472538186015;6166.5991710539565;6247.219097612799;6392.424681778569;6430.260520040161;5540.2243685884005;5588.692621905753;5698.629589076697;5712.714364281769;5714.314282286152;4310.396544483775;4377.759223242752;4383.232934236496;4471.262241730143;4486.304622783474;1643.7534369844618;1722.2852516205635;1781.768370111903;1832.395309547846;1834.5230240137394;818.6234332207251;834.8038211020405;847.2586486824028;849.995750021246;891.3270480786964;16064.919675401548;16916.06961617123;16916.830831691525;16991.91504042472;17091.914540427217;868.6308318964415;873.8328944218247;885.2210055151554;886.866969954499;929.9860502092474;9203.723888283363;9442.339036267533;9609.759756006155;9636.614535418645;9643.517824108767;399021;399828;408195;423555;430699;78848.60575697085;79668.6016569925;80678.19321806825;82159.58920205361;83472;917.2799352508249;944.1219665710818;956.531299663174;961.3895176562793;971.6599190283345;15209.543713688607;15294.847051529343;15437.305321260346;15597.220138993232;15899.682006360039;33815.83092084524;35609.46585801267;35629.82185089058;36669.63330366662;36865;44648.776756116014;46345.536544634124;49161.754191228814;51113.74443127909;51699;7308.853822923618;7328.523645962995;7336.7065317386705;7417.295356941082;7550.509216900884;10300.793984120426;10377.792444150924;10590.311629744043;10995.175361847734;11214.88785112171;8535.445196062235;8995.685151019683;9798.118169364792;10101.444420556645;10121.69634910954;9903.405795652285;9948.552315145691;10044.648437304659;10116.443595602019;10160.237982151517;9604.27967902396;9902.900970990486;10144.898551014396;10215.080642741892;10308.278420510793;7399.519031262951;7466.104067511933;7490.176080631018;7500.399968002437;7575.0909890813455;9482.95258523703;9557.139857412867;9623.230141588516;9739.269554783277;9823.459709716035 01:28:12 INFO - PROCESS | 12596 | |3;mootools.html;1015.553156611091;1027.5581499955022;1161.947712352944;1246.308298894114;1451.4411951398715;6684.766033188839;7418;7596.96201518993;7602.049743782028;7617.04786901638;7553.093628764542;7695.384369250461;7699.230076992298;7703.46075774696;7706.190849960757;1811.8278763517444;2053.1068984991502;2117.5553133841913;2142.368001439579;2172.663237198237;2123.3205374280237;2162.9891850540803;2163.967540486894;2164.437246315961;2164.6969424280614;2120.0777661717125;2128.1806504495726;2168.035224325168;2169.305822136917;2171.478845077178;1780.6438712257536;2038.9388318350473;2055.9074841632087;2108.135664377598;2114.238874005357;2136.145541783299;2141.8072373486307;2162.37291185556;2162.545865368259;2166.794154555315;7607.201243869369;7640.541567505968;7664.425168112358;7673.040869891263;7677.961610191969;4238.427812245369;4363.38912552243;4367.650587952988;4369.1480161368545;4371.934420983688;2877.6402949631297;2877.812942158753;2930.2088436122126;2935.735783779449;2953.350262942171;924.2513564013103;939.0562484702898;944.9527523623791;945.0974319524906;947.3179310896144;10318.380897146195;10522.421266830397;10556.788864222672;10567.894321056769;10578.735531611694;4048.4534587830854;4151.771652559139;4198.538160802309;4251.192273468031;4252.255855225323;8916.777080572907;8961.775955601162;8962.507062111516;8977.596008179647;8982.910170898338;4391.297392417198;4430.645548356124;4444.733316000986;4446.644268458515;4454.57681520255;3494.336076145524;3917.118648304109;3973.9602603974167;3997.200559888034;4053.0272734543496;3654.3239500692457;3661.707063434919;3732.869349572752;3775.716821238418;3806.42903564462;1162.1980833225048;1183.3255044624655;1193.659806955031;1196.090970862151;1206.1376116077047;703.4794252253296;781.5037451218403;803.714681288146;849.7408290471342;850.1498501498502;4995.700257984533;5120.385553733501;5149.382074151126;5255.316808814906;5285.2600635911;380.7487058541349;878.5299864572551;951.9666811661558;957.3250858144991;983.341161421849;3570.910727231788;3607.8196090195383;3651.689606383487;3691.483192353019;3731.5149030625844;9338.393004454689;9516.19112375442;9603.135717785433;9621.807563848824;9630.229581633592;9425.811483770423;9479.478628675352;9483.14651681352;9511.619535218513;9527.09492598202;6789.864202716017;6958.130233720785;7067.328603782633;7083.893741593777;7106.2183159852375;5062.316587260672;5139.486051394831;5175.249588809676;5185.09260879337;5223.895522089461;7939.920600793918;8298.792530186794;8563.058063612873;8583.18459746323;8585.055643879043;8203.0566484855;8350.331973442231;8453.408261421642;8488.83022339562;8524.531150786766;6034.969825150846;6312.652804095819;6560.114384558215;6595.8021259362295;6743.9325606743305;7477.850442991218;7481.17707052213;7513.511621744569;7526.5860377679755;7535.321821035914;6636.27001029896;6688.197416310074;6746.257911629618;6792.93207067923;6891.793246202622;6516.57642253252;6554.115194448688;6561.212654481493;6647.567908085959;6715.127033485811;6243.188385509855;6271.529635277281;6323.810285691437;6340.619562826245;6343.080253363144;4530.614897733598;4544.863654090383;4557.065801510616;4617.746023968714;4622.907541849211;4553.066621342683;4568.0863827234025;4575.6339492839825;4601.217792975269;4610 01:28:12 INFO - PROCESS | 12596 | |4;prototype.html;275.5838683587783;283.7132710354542;286.36998603073243;286.6803514081799;288.24479862759574;4600.332951722006;4650.976745116278;4789.425268967724;4808.302796094568;4810.807567697292;4626.676132670715;4677.579017888389;4691.812327506896;4752.572268495835;4753.310769938365;3724.9813750931276;3736.6637002669754;3751.0247335692643;3770.1705624762644;3775.320442320381;3555.9466608000903;3564.803935783531;3707.3326801175776;3767.943480847776;3774.924501509968;3677.356462619044;3693.1874987502842;3705.814709264526;3710.4063349864027;3715.516982792233;3688.4282936144805;3706.9629303707156;3709.443583462475;3714.4428335749585;3743.8315275812383;3292.0453068610313;3296.8351582420783;3308.123347312964;3315.088350703552;3317.270200555874;4307.590778876001;4523.751193684346;4526.6831321807485;4563.977180114111;4587.587117159438;4109.3425051991535;4109.815058322352;4115.506139263278;4124.360724087771;4132.442120313749;4899.191633380488;4900.485449027837;4901.460839307673;4910.607151427877;4914.213725803854;3278.6885245901603;3468.3063387322636;3469.8785542505893;3485.512028316012;3494.6330635283184;5095.363079615048;5117.667351622133;5138.460461651547;5154.999999999963;5167.819126330561;3553.36039512885;3556.715462762973;3557.5730912290173;3558.5373901392654;3563.94654080189;3602.6217247189193;3622.5109610202812;3630.945535816965;3631.891043268706;3633.854645814191;3960.6435420812263;4147.585241475828;4165.562615925345;4172.395002724588;4183.330667093251;4647.488776234612;4874.488178741252;4881.682690625169;4887.682300650446;4906.165951788204;1217.2696382170805;1234.1731040203085;1245.8068999305121;1253.7993920972601;1255.9434825432877;781.7185813107277;787.9724209652635;797.9840403191904;804.951702897828;817.791463176886;3997.5802540733384;4001.7598944063448;4022.456968309299;4026.3960405939342;4030.2946984277633;4416.78538401942;4540.841070562515;4575.428071491064;4584.61030812378;4611.400517932647;3931.4299426582984;3932.4297976793205;3949.466821978996;3964.484616999772;4007.458993035903;2312.2947501012018;2399.2682231919434;2408.867512286806;2409.9879500602383;2422.454947636803;4297.140571885573;4307.461567304087;4320.395144679747;4332.1985432695055;4339.566043395698;4543.5002149763495;4570.405847239837;4585;4607.631389488833;4634.814607415733;4156.459660244149;4215.199112168678;4358.455193100863;4372;4372.803223854934;4402.207602631429;4482.8655140345845;4541.866112382578;4545.954540454553;4555.362249285036;4366.890827729332;4377.796106070856;4381.138016342978;4407.6914615976575;4477.432898485504;4248.8300467980935;4265.253580623441;4288.62763915544;4348.913021739484;4442.533533978885;3601.423772196436;3618.203995121069;3628.8911332660064;3632.9818350908076;3636.618155093677;4841.975790121027;5047.520485553867;5055.696658200372;5061.7469126544265;5073.604758691389;4779.856604301876;4939.185034469272;4939.6542242042715;4950.4059512858685;4952.504749525018;4893.825481884393;4928.186849169847;4934.555889969776;4939.777710002986;4976.178930476575;4631.355868666575;4858.416989961227;4884.609231261562;4890.559849613552;4897.240927656219;4965.627577931597;4983.327250821093;4993.1012417763695;5002.349694539686;5006.549410553068;4878.853634390832;4895.583875370633;4910.477751896923;4911.312416261798;4931.7040977541465 01:28:12 INFO - PROCESS | 12596 | |5;yui.html;664.8105289992353;681.8261343357443;728.4391018915438;773.8607050730868;776.9261920117594;12772.68068298293;13258.535951241709;13275.137116087471;13290.534831280907;13296.401661925212;12403.44184511697;12458.688532786686;12468.314242716648;12473.31396773177;12484.875151248485;626.962382257066;782.7729958312083;791.2048391366683;806.2260230179036;808.5957021489255;803.5339503088195;804.6218277409608;806.9233422824823;806.9314108300772;808.6118663041743;850.0946491986045;852.7825404521839;853.2363534636528;853.3429259470204;853.7225401744427;661.9669016549177;822.9794255143639;840.3949156607233;844.995775021121;846.2426128614917;613.947814435769;614.3886832601545;614.529884638252;614.5544480251826;616.2789536242607;12673.809892851614;12714;12768.170068945488;12777.23336599807;12818.038647101504;12573.308468034254;13037.348132593332;13125;13289.667758306023;13493.055486115976;9175;10952.178586606036;10969.396683182422;11100.056495197918;11169.329840209532;4247.8088486018205;4284.2074216269775;4295.183915056129;4336.3712261722185;4363.127374525107;41553.1689366214;41600.167996639895;41682.37476437856;41905.58094419078;41984.160316793495;9341.859872101924;9804.166645835041;9955.900440995498;9957.601695932082;10527.631532896465;17770;18452.723209151874;18472;18511.53721156982;18539.258429662932;6908.758193463305;6927.064846245692;6958.025876377311;7079.539829911039;7248.710051597877;3696.094456858087;3815.523059617548;3818.8090595470117;3830.942535861964;3861.4014827701753;2926.3415731460677;3005.834679092627;3005.9549106763416;3011.4729922263955;3019.89430369936;461.6768262216395;490.1838438999098;508.659198337115;512.4081685653076;519.2833889232835;475.89054517461176;552.933647962247;611.6727550760322;614.3487902823022;637.8309747916805;8089.352851771844;8246.175382461826;8267.503949763033;8372.41393102477;8528.957355213184;551.9917201241905;566.1578874052317;567.4637467593085;570.1419363857368;574.8562859285179;3808.6762625176616;3865.845366185321;3879.573246942834;4002.599740026032;4035.3139966205817;56056.15915761267;56492;57206.427935720945;57210.71394643;57302;49560.256596151085;50539.49460505421;52125.7393713029;52793;53678.7316063425;47159.5284047162;47922.5207747925;48291.275630865566;48293.275600866014;49506;7729.536227826348;7811.4922530035365;7985.361171106181;8036.959815200887;8100.716474923585;33095.50356744699;33180.66819331776;33334.499982499794;33903.32193356168;33925.83037084799;40085.599144008185;42795.57204427916;42967.14065718731;43668;44586.55413445824;10165.644202453175;10477.161827053666;10483;10582.682519524427;10817.51321190564;10797.26855702719;11127.109831213322;11229.38238396896;11301.321920684457;11837.585684501;10021.799564008825;10025.448600327052;10026.69919902404;10728.463576821285;10788.298760580537;10457.738556535844;10506.054455099078;10622.89377106219;10666.520006599567;10724.302920310467;10199;10203.94898025505;10319.981250903833;10462.267641265344;10723.981221783917;8641.913580864111;9107.681231156877;9196.03441638645;9397.389169703947;9536.570854311434;9478.38390504615;9750.80498390014;9822.557984890555;9890.554925028247;9907.157891579296 01:28:12 INFO - PROCESS | 12596 | __end_tp_report 01:28:12 INFO - PROCESS | 12596 | __start_cc_report 01:28:12 INFO - PROCESS | 12596 | _x_x_mozilla_cycle_collect,1003 01:28:12 INFO - PROCESS | 12596 | __end_cc_report 01:28:12 INFO - PROCESS | 12596 | __startTimestamp1463819292496__endTimestamp 01:28:12 INFO - PROCESS | 12596 | 01:28:12 INFO - PROCESS | 12596 | ------- Summary: start ------- 01:28:12 INFO - PROCESS | 12596 | Number of tests: 6 01:28:12 INFO - PROCESS | 12596 | 01:28:12 INFO - PROCESS | 12596 | [#0] dojo.html Cycles:165 Average:4729.87 Median:4870.00 stddev:494.06 (10.1%) stddev-sans-first:468.31 01:28:12 INFO - PROCESS | 12596 | Values: 2666.7 2690.1 2715.3 2723.1 2732.0 4646.6 4723.9 4743.6 4820.3 4856.1 4728.2 4731.4 4737.3 4814.9 4818.8 4296.5 4331.2 4370.8 4410.9 4546.1 4465.4 4489.0 4492.1 4521.9 4537.7 4248.9 4293.1 4360.4 4389.8 4414.4 4349.7 4352.6 4356.9 4461.9 4476.4 4372.6 4379.7 4397.3 4405.6 4427.4 4542.6 4617.7 4693.8 4746.9 4753.7 5072.3 5156.9 5159.5 5160.5 5164.7 5120.4 5176.5 5190.5 5194.0 5197.9 4662.4 4728.7 4770.4 4821.7 4824.2 5251.9 5260.6 5297.2 5300.4 5313.4 5032.2 5033.7 5077.5 5087.1 5092.6 4958.6 4981.9 4982.6 5036.8 5174.4 4999.3 5002.7 5056.8 5093.0 5097.1 5055.9 5062.4 5067.3 5080.8 5109.5 4167.6 4279.6 4286.4 4293.3 4335.7 3724.1 3728.1 3772.9 3781.9 3825.0 4480.5 4481.3 4488.3 4522.2 4533.2 4962.2 5164.8 5175.6 5178.6 5184.9 4396.2 4457.0 4472.3 4472.5 4476.4 4625.3 4633.5 4637.4 4653.5 4677.6 4739.0 4822.0 4904.9 4920.7 4922.0 5134.7 5138.2 5171.1 5176.2 5228.5 4883.0 4884.3 4885.1 4892.2 4939.7 4870.0 5016.9 5058.0 5068.4 5071.4 5121.8 5148.1 5148.5 5162.9 5207.9 5008.0 5023.8 5024.9 5027.1 5073.7 4858.8 4881.8 4903.4 4939.0 4983.9 4845.3 4870.6 4871.8 4911.4 4925.3 4983.9 4987.5 5037.0 5038.5 5048.5 4771.5 4833.4 4855.4 4881.9 4901.0 01:28:12 INFO - PROCESS | 12596 | 01:28:12 INFO - PROCESS | 12596 | [#1] ext.html Cycles:180 Average:48594.48 Median:38844.81 stddev:89539.03 (230.5%) stddev-sans-first:89717.50 01:28:12 INFO - PROCESS | 12596 | Values: 533.8 599.7 601.6 602.4 603.8 40389.8 41650.4 41661.8 45091.8 45243.8 41300.6 41726.8 41765.4 41797.8 41818.2 7741.7 7921.0 7922.5 7923.3 7923.5 7710.2 7803.9 7809.5 7818.3 7821.6 7828.8 7867.9 7874.1 7875.0 7878.5 7780.3 7835.0 7840.2 7840.8 7843.8 7719.1 7780.6 7863.0 7869.4 7871.1 38701.6 38988.0 39085.8 39141.8 39151.8 3152.6 3272.3 3274.8 3455.1 3799.4 28530.1 29002.3 29681.9 29895.9 30789.7 3421.1 3423.6 3464.2 3475.2 3541.6 265840.0 305843.0 309466.0 309675.0 406675.0 55851.0 56194.4 56414.7 56427.2 56430.4 33201.3 33705.8 33774.5 35379.0 59037.7 12320.8 12452.6 12470.5 12473.3 12482.9 9511.8 9516.6 9519.9 9613.6 9637.8 18626.6 18681.2 18681.9 18867.2 18888.6 6739.4 6763.7 6896.3 6971.8 6999.9 793.4 897.7 969.9 978.5 1050.1 27417.5 28091.7 28536.3 28698.6 28960.3 950.4 950.6 951.4 953.9 1000.5 14683.3 15002.3 15040.0 15214.7 15263.4 390863.0 394224.0 397735.0 398371.0 398680.0 49438.5 49674.3 49936.0 49938.0 49961.8 1073.6 1154.4 1161.7 1190.2 1191.9 28066.9 28522.4 29099.9 29185.7 29545.6 41694.6 41822.6 42169.6 42278.8 42281.4 289481.0 290758.0 292677.0 293003.0 293236.0 22357.6 24667.0 24988.5 25202.4 25366.5 41493.2 41683.4 42435.0 42593.8 42838.0 35009.4 35582.0 36254.3 36285.0 36316.8 35586.5 35984.3 36097.8 36227.3 36350.0 34986.3 35435.5 35660.5 36650.0 36745.3 30810.5 32200.5 32658.5 32695.0 32860.7 24924.5 25325.5 25673.0 25728.0 25882.4 01:28:12 INFO - PROCESS | 12596 | 01:28:12 INFO - PROCESS | 12596 | [#2] jquery.html Cycles:180 Average:24713.61 Median:47753.65 stddev:67926.25 (142.2%) stddev-sans-first:68092.19 01:28:12 INFO - PROCESS | 12596 | Values: 358.8 367.7 370.3 377.2 378.5 15671.3 16784.7 16840.3 17234.6 17254.4 15260.0 16292.3 17012.6 17059.5 17066.1 5035.5 5202.3 5212.6 5235.6 5238.6 3725.9 3898.8 5156.1 5773.1 6075.7 6121.6 6137.5 6140.4 6154.8 6170.9 6054.7 6122.3 6130.5 6131.9 6145.6 3392.6 4990.8 5240.9 5316.0 5362.1 19744.9 20403.4 20439.2 20524.5 20573.4 1979.0 1990.9 2051.6 2251.5 2276.4 12788.8 13014.4 13046.8 13085.0 13557.9 1649.7 1674.7 1709.5 1781.2 1841.7 58230.0 60016.7 61309.7 62483.4 70520.3 9923.7 9945.5 10010.2 10063.4 10270.3 13949.4 14037.3 14067.4 14082.0 14159.6 6109.8 6166.6 6247.2 6392.4 6430.3 5540.2 5588.7 5698.6 5712.7 5714.3 4310.4 4377.8 4383.2 4471.3 4486.3 1643.8 1722.3 1781.8 1832.4 1834.5 818.6 834.8 847.3 850.0 891.3 16064.9 16916.1 16916.8 16991.9 17091.9 868.6 873.8 885.2 886.9 930.0 9203.7 9442.3 9609.8 9636.6 9643.5 399021.0 399828.0 408195.0 423555.0 430699.0 78848.6 79668.6 80678.2 82159.6 83472.0 917.3 944.1 956.5 961.4 971.7 15209.5 15294.8 15437.3 15597.2 15899.7 33815.8 35609.5 35629.8 36669.6 36865.0 44648.8 46345.5 49161.8 51113.7 51699.0 7308.9 7328.5 7336.7 7417.3 7550.5 10300.8 10377.8 10590.3 10995.2 11214.9 8535.4 8995.7 9798.1 10101.4 10121.7 9903.4 9948.6 10044.6 10116.4 10160.2 9604.3 9902.9 10144.9 10215.1 10308.3 7399.5 7466.1 7490.2 7500.4 7575.1 9483.0 9557.1 9623.2 9739.3 9823.5 01:28:12 INFO - PROCESS | 12596 | 01:28:12 INFO - PROCESS | 12596 | [#3] mootools.html Cycles:180 Average:5019.49 Median:5162.32 stddev:2813.03 (54.5%) stddev-sans-first:2804.82 01:28:12 INFO - PROCESS | 12596 | Values: 1015.6 1027.6 1161.9 1246.3 1451.4 6684.8 7418.0 7597.0 7602.0 7617.0 7553.1 7695.4 7699.2 7703.5 7706.2 1811.8 2053.1 2117.6 2142.4 2172.7 2123.3 2163.0 2164.0 2164.4 2164.7 2120.1 2128.2 2168.0 2169.3 2171.5 1780.6 2038.9 2055.9 2108.1 2114.2 2136.1 2141.8 2162.4 2162.5 2166.8 7607.2 7640.5 7664.4 7673.0 7678.0 4238.4 4363.4 4367.7 4369.1 4371.9 2877.6 2877.8 2930.2 2935.7 2953.4 924.3 939.1 945.0 945.1 947.3 10318.4 10522.4 10556.8 10567.9 10578.7 4048.5 4151.8 4198.5 4251.2 4252.3 8916.8 8961.8 8962.5 8977.6 8982.9 4391.3 4430.6 4444.7 4446.6 4454.6 3494.3 3917.1 3974.0 3997.2 4053.0 3654.3 3661.7 3732.9 3775.7 3806.4 1162.2 1183.3 1193.7 1196.1 1206.1 703.5 781.5 803.7 849.7 850.1 4995.7 5120.4 5149.4 5255.3 5285.3 380.7 878.5 952.0 957.3 983.3 3570.9 3607.8 3651.7 3691.5 3731.5 9338.4 9516.2 9603.1 9621.8 9630.2 9425.8 9479.5 9483.1 9511.6 9527.1 6789.9 6958.1 7067.3 7083.9 7106.2 5062.3 5139.5 5175.2 5185.1 5223.9 7939.9 8298.8 8563.1 8583.2 8585.1 8203.1 8350.3 8453.4 8488.8 8524.5 6035.0 6312.7 6560.1 6595.8 6743.9 7477.9 7481.2 7513.5 7526.6 7535.3 6636.3 6688.2 6746.3 6792.9 6891.8 6516.6 6554.1 6561.2 6647.6 6715.1 6243.2 6271.5 6323.8 6340.6 6343.1 4530.6 4544.9 4557.1 4617.7 4622.9 4553.1 4568.1 4575.6 4601.2 4610.0 01:28:12 INFO - PROCESS | 12596 | 01:28:12 INFO - PROCESS | 12596 | [#4] prototype.html Cycles:180 Average:3963.93 Median:4344.24 stddev:1141.38 (26.3%) stddev-sans-first:1110.50 01:28:12 INFO - PROCESS | 12596 | Values: 275.6 283.7 286.4 286.7 288.2 4600.3 4651.0 4789.4 4808.3 4810.8 4626.7 4677.6 4691.8 4752.6 4753.3 3725.0 3736.7 3751.0 3770.2 3775.3 3555.9 3564.8 3707.3 3767.9 3774.9 3677.4 3693.2 3705.8 3710.4 3715.5 3688.4 3707.0 3709.4 3714.4 3743.8 3292.0 3296.8 3308.1 3315.1 3317.3 4307.6 4523.8 4526.7 4564.0 4587.6 4109.3 4109.8 4115.5 4124.4 4132.4 4899.2 4900.5 4901.5 4910.6 4914.2 3278.7 3468.3 3469.9 3485.5 3494.6 5095.4 5117.7 5138.5 5155.0 5167.8 3553.4 3556.7 3557.6 3558.5 3563.9 3602.6 3622.5 3630.9 3631.9 3633.9 3960.6 4147.6 4165.6 4172.4 4183.3 4647.5 4874.5 4881.7 4887.7 4906.2 1217.3 1234.2 1245.8 1253.8 1255.9 781.7 788.0 798.0 805.0 817.8 3997.6 4001.8 4022.5 4026.4 4030.3 4416.8 4540.8 4575.4 4584.6 4611.4 3931.4 3932.4 3949.5 3964.5 4007.5 2312.3 2399.3 2408.9 2410.0 2422.5 4297.1 4307.5 4320.4 4332.2 4339.6 4543.5 4570.4 4585.0 4607.6 4634.8 4156.5 4215.2 4358.5 4372.0 4372.8 4402.2 4482.9 4541.9 4546.0 4555.4 4366.9 4377.8 4381.1 4407.7 4477.4 4248.8 4265.3 4288.6 4348.9 4442.5 3601.4 3618.2 3628.9 3633.0 3636.6 4842.0 5047.5 5055.7 5061.7 5073.6 4779.9 4939.2 4939.7 4950.4 4952.5 4893.8 4928.2 4934.6 4939.8 4976.2 4631.4 4858.4 4884.6 4890.6 4897.2 4965.6 4983.3 4993.1 5002.3 5006.5 4878.9 4895.6 4910.5 4911.3 4931.7 01:28:12 INFO - PROCESS | 12596 | 01:28:12 INFO - PROCESS | 12596 | [#5] yui.html Cycles:180 Average:13383.46 Median:23810.60 stddev:15580.57 (65.4%) stddev-sans-first:15595.00 01:28:12 INFO - PROCESS | 12596 | Values: 664.8 681.8 728.4 773.9 776.9 12772.7 13258.5 13275.1 13290.5 13296.4 12403.4 12458.7 12468.3 12473.3 12484.9 627.0 782.8 791.2 806.2 808.6 803.5 804.6 806.9 806.9 808.6 850.1 852.8 853.2 853.3 853.7 662.0 823.0 840.4 845.0 846.2 613.9 614.4 614.5 614.6 616.3 12673.8 12714.0 12768.2 12777.2 12818.0 12573.3 13037.3 13125.0 13289.7 13493.1 9175.0 10952.2 10969.4 11100.1 11169.3 4247.8 4284.2 4295.2 4336.4 4363.1 41553.2 41600.2 41682.4 41905.6 41984.2 9341.9 9804.2 9955.9 9957.6 10527.6 17770.0 18452.7 18472.0 18511.5 18539.3 6908.8 6927.1 6958.0 7079.5 7248.7 3696.1 3815.5 3818.8 3830.9 3861.4 2926.3 3005.8 3006.0 3011.5 3019.9 461.7 490.2 508.7 512.4 519.3 475.9 552.9 611.7 614.3 637.8 8089.4 8246.2 8267.5 8372.4 8529.0 552.0 566.2 567.5 570.1 574.9 3808.7 3865.8 3879.6 4002.6 4035.3 56056.2 56492.0 57206.4 57210.7 57302.0 49560.3 50539.5 52125.7 52793.0 53678.7 47159.5 47922.5 48291.3 48293.3 49506.0 7729.5 7811.5 7985.4 8037.0 8100.7 33095.5 33180.7 33334.5 33903.3 33925.8 40085.6 42795.6 42967.1 43668.0 44586.6 10165.6 10477.2 10483.0 10582.7 10817.5 10797.3 11127.1 11229.4 11301.3 11837.6 10021.8 10025.4 10026.7 10728.5 10788.3 10457.7 10506.1 10622.9 10666.5 10724.3 10199.0 10203.9 10320.0 10462.3 10724.0 8641.9 9107.7 9196.0 9397.4 9536.6 9478.4 9750.8 9822.6 9890.6 9907.2 01:28:12 INFO - PROCESS | 12596 | -------- Summary: end -------- 01:28:12 INFO - PROCESS | 12596 | 01:28:13 INFO - TEST-INFO | 12596: exit 0 01:28:13 INFO - TEST-OK | dromaeo_css | took 1118968ms 01:28:13 INFO - TEST-START | kraken 01:28:13 INFO - operating with platform_type : linux_ 01:28:13 INFO - Initialising browser for kraken test... 01:28:13 INFO - TEST-INFO | started process 12776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJrxaZ6/profile http://localhost:34660/getInfo.html) 01:28:17 INFO - PROCESS | 12776 | __metrics Screen width/height:1600/1200 01:28:17 INFO - PROCESS | 12776 | colorDepth:24 01:28:17 INFO - PROCESS | 12776 | Browser inner width/height: 1024/697 01:28:17 INFO - PROCESS | 12776 | __metrics 01:28:18 ERROR - PROCESS | 12776 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:28:19 INFO - TEST-INFO | 12776: exit 0 01:28:19 INFO - Browser initialized. 01:28:19 INFO - Running cycle 1/1 for kraken test... 01:28:19 INFO - TEST-INFO | started process 12854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJrxaZ6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:31 INFO - PROCESS | 12854 | RSS: Main: 155004928 01:28:31 INFO - PROCESS | 12854 | 01:28:34 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34660/tests/kraken/driver.html?testName=audio-beat-detection) 01:28:35 INFO - PROCESS | 12854 | RSS: Main: 211271680 01:28:35 INFO - PROCESS | 12854 | 01:28:38 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34660/tests/kraken/driver.html?testName=audio-dft) 01:28:38 INFO - PROCESS | 12854 | RSS: Main: 197898240 01:28:38 INFO - PROCESS | 12854 | 01:28:42 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34660/tests/kraken/driver.html?testName=audio-fft) 01:28:42 INFO - PROCESS | 12854 | RSS: Main: 267382784 01:28:42 INFO - PROCESS | 12854 | 01:28:44 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34660/tests/kraken/driver.html?testName=audio-oscillator) 01:28:45 INFO - PROCESS | 12854 | RSS: Main: 177627136 01:28:45 INFO - PROCESS | 12854 | 01:28:47 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:28:48 INFO - PROCESS | 12854 | RSS: Main: 180867072 01:28:48 INFO - PROCESS | 12854 | 01:28:51 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34660/tests/kraken/driver.html?testName=imaging-darkroom) 01:28:52 INFO - PROCESS | 12854 | RSS: Main: 217255936 01:28:52 INFO - PROCESS | 12854 | 01:28:56 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34660/tests/kraken/driver.html?testName=imaging-desaturate) 01:28:56 INFO - PROCESS | 12854 | RSS: Main: 215498752 01:28:56 INFO - PROCESS | 12854 | 01:28:59 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34660/tests/kraken/driver.html?testName=json-parse-financial) 01:29:00 INFO - PROCESS | 12854 | RSS: Main: 215707648 01:29:00 INFO - PROCESS | 12854 | 01:29:02 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:29:02 INFO - PROCESS | 12854 | RSS: Main: 205385728 01:29:02 INFO - PROCESS | 12854 | 01:29:04 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34660/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:29:05 INFO - PROCESS | 12854 | RSS: Main: 209178624 01:29:05 INFO - PROCESS | 12854 | 01:29:07 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:29:08 INFO - PROCESS | 12854 | RSS: Main: 221069312 01:29:08 INFO - PROCESS | 12854 | 01:29:11 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:29:11 INFO - PROCESS | 12854 | RSS: Main: 224874496 01:29:11 INFO - PROCESS | 12854 | 01:29:14 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:29:15 INFO - PROCESS | 12854 | RSS: Main: 222605312 01:29:15 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | Cycle 1(1): loaded http://localhost:34660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34660/tests/kraken/driver.html?testName=ai-astar) 01:29:17 INFO - PROCESS | 12854 | RSS: Main: 268988416 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | __start_tp_report 01:29:17 INFO - PROCESS | 12854 | _x_x_mozilla_page_load 01:29:17 INFO - PROCESS | 12854 | _x_x_mozilla_page_load_details 01:29:17 INFO - PROCESS | 12854 | |i|pagename|runs| 01:29:17 INFO - PROCESS | 12854 | |0;ai-astar;115;109;114;116;114;115;113;112;113;114 01:29:17 INFO - PROCESS | 12854 | |1;audio-beat-detection;174;136;129;216;130;131;155;128;161;129 01:29:17 INFO - PROCESS | 12854 | |2;audio-dft;160;161;161;161;162;161;162;161;161;160 01:29:17 INFO - PROCESS | 12854 | |3;audio-fft;76;77;75;133;77;77;76;76;133;75 01:29:17 INFO - PROCESS | 12854 | |4;audio-oscillator;93;93;172;94;94;94;122;94;94;130 01:29:17 INFO - PROCESS | 12854 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;116;117 01:29:17 INFO - PROCESS | 12854 | |6;imaging-darkroom;146;146;146;145;146;146;145;145;145;145 01:29:17 INFO - PROCESS | 12854 | |7;imaging-desaturate;94;94;94;95;94;94;94;95;94;95 01:29:17 INFO - PROCESS | 12854 | |8;json-parse-financial;65;64;64;64;67;64;65;123;63;63 01:29:17 INFO - PROCESS | 12854 | |9;json-stringify-tinderbox;64;66;65;65;65;65;65;64;65;64 01:29:17 INFO - PROCESS | 12854 | |10;stanford-crypto-aes;82;82;82;82;86;83;80;85;83;88 01:29:17 INFO - PROCESS | 12854 | |11;stanford-crypto-ccm;130;130;129;128;131;133;143;129;194;131 01:29:17 INFO - PROCESS | 12854 | |12;stanford-crypto-pbkdf2;171;174;173;173;172;175;171;170;176;171 01:29:17 INFO - PROCESS | 12854 | |13;stanford-crypto-sha256-iterative;71;71;67;68;66;66;67;65;70;66 01:29:17 INFO - PROCESS | 12854 | __end_tp_report 01:29:17 INFO - PROCESS | 12854 | __start_cc_report 01:29:17 INFO - PROCESS | 12854 | _x_x_mozilla_cycle_collect,2160 01:29:17 INFO - PROCESS | 12854 | __end_cc_report 01:29:17 INFO - PROCESS | 12854 | __startTimestamp1463819357589__endTimestamp 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | ------- Summary: start ------- 01:29:17 INFO - PROCESS | 12854 | Number of tests: 14 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.96 (1.7%) stddev-sans-first:2.00 01:29:17 INFO - PROCESS | 12854 | Values: 115.0 109.0 114.0 116.0 114.0 115.0 113.0 112.0 113.0 114.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:145.50 stddev:28.65 (19.7%) stddev-sans-first:28.92 01:29:17 INFO - PROCESS | 12854 | Values: 174.0 136.0 129.0 216.0 130.0 131.0 155.0 128.0 161.0 129.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 01:29:17 INFO - PROCESS | 12854 | Values: 160.0 161.0 161.0 161.0 162.0 161.0 162.0 161.0 161.0 160.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#3] audio-fft Cycles:10 Average:87.50 Median:76.00 stddev:23.99 (31.6%) stddev-sans-first:25.08 01:29:17 INFO - PROCESS | 12854 | Values: 76.0 77.0 75.0 133.0 77.0 77.0 76.0 76.0 133.0 75.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:94.00 stddev:26.26 (27.9%) stddev-sans-first:27.29 01:29:17 INFO - PROCESS | 12854 | Values: 93.0 93.0 172.0 94.0 94.0 94.0 122.0 94.0 94.0 130.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 01:29:17 INFO - PROCESS | 12854 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 01:29:17 INFO - PROCESS | 12854 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:29:17 INFO - PROCESS | 12854 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 95.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#8] json-parse-financial Cycles:10 Average:70.20 Median:64.00 stddev:18.59 (29.0%) stddev-sans-first:19.62 01:29:17 INFO - PROCESS | 12854 | Values: 65.0 64.0 64.0 64.0 67.0 64.0 65.0 123.0 63.0 63.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 01:29:17 INFO - PROCESS | 12854 | Values: 64.0 66.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 64.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:2.36 (2.8%) stddev-sans-first:2.46 01:29:17 INFO - PROCESS | 12854 | Values: 82.0 82.0 82.0 82.0 86.0 83.0 80.0 85.0 83.0 88.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:131.00 stddev:20.20 (15.4%) stddev-sans-first:21.23 01:29:17 INFO - PROCESS | 12854 | Values: 130.0 130.0 129.0 128.0 131.0 133.0 143.0 129.0 194.0 131.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.60 Median:173.00 stddev:1.96 (1.1%) stddev-sans-first:1.99 01:29:17 INFO - PROCESS | 12854 | Values: 171.0 174.0 173.0 173.0 172.0 175.0 171.0 170.0 176.0 171.0 01:29:17 INFO - PROCESS | 12854 | 01:29:17 INFO - PROCESS | 12854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:2.21 (3.3%) stddev-sans-first:2.00 01:29:17 INFO - PROCESS | 12854 | Values: 71.0 71.0 67.0 68.0 66.0 66.0 67.0 65.0 70.0 66.0 01:29:17 INFO - PROCESS | 12854 | -------- Summary: end -------- 01:29:17 INFO - PROCESS | 12854 | 01:29:18 INFO - TEST-INFO | 12854: exit 0 01:29:18 INFO - TEST-OK | kraken | took 65449ms 01:29:18 INFO - SUITE-END | took 1184s 01:29:18 INFO - Completed test suite (00:19:44) 01:29:18 INFO - javascript benchmark 01:29:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2666.7199944005883, 2690.0988168963395, 2715.334742987968, 2723.1285988483683, 2732.016474069335, 4646.581807637312, 4723.929141062887, 4743.5967942724865, 4820.252860806572, 4856.077345304389, 4728.243481043034, 4731.361266229058, 4737.289406589005, 4814.927776083362, 4818.783154758035, 4296.527381987987, 4331.242032644291, 4370.803313850868, 4410.889727756799, 4546.113507865967, 4465.441819772528, 4488.955110448886, 4492.079123779634, 4521.886952826173, 4537.727736335831, 4248.915021699549, 4293.055527783914, 4360.389545463638, 4389.846355377546, 4414.448193975753, 4349.717268377545, 4352.564743525622, 4356.89107772305, 4461.9107617847785, 4476.350929115292, 4372.584604462571, 4379.671524635665, 4397.2964325707735, 4405.603495685372, 4427.380166776654, 4542.636589072867, 4617.653675974316, 4693.7653117344, 4746.857594272177, 4753.691010084368, 5072.315237442935, 5156.92264616031, 5159.458256883048, 5160.48395160481, 5164.715940623264, 5120.385553733576, 5176.50823171798, 5190.532852043334, 5194.0391027659625, 5197.948020519784, 4662.417197850269, 4728.739919304402, 4770.356001939763, 4821.734804585782, 4824.228123500258, 5251.894962100737, 5260.552853007461, 5297.17893726473, 5300.44345343741, 5313.362396512443, 5032.169692000779, 5033.672811267256, 5077.543021128116, 5087.109755792721, 5092.643514953992, 4958.603311735053, 4981.850544483671, 4982.551570358685, 5036.84889453317, 5174.353205849269, 4999.250112483157, 5002.699838009658, 5056.772445239973, 5092.9745351273, 5097.108006098918, 5055.87360315995, 5062.367204099488, 5067.315912351785, 5080.796768129233, 5109.489051094861, 4167.604077612622, 4279.636230920407, 4286.357046443059, 4293.2701440755145, 4335.6965012449455, 3724.0875985383755, 3728.12389088564, 3772.867949621805, 3781.8865434037025, 3825.024618722208, 4480.507144214133, 4481.305397663367, 4488.259437192892, 4522.208613492626, 4533.161365147393, 4962.230854217602, 5164.767585458663, 5175.585953123741, 5178.572315702134, 5184.8963020739375, 4396.230659634552, 4456.977715111469, 4472.284434490466, 4472.508024117345, 4476.35092911526, 4625.259958406638, 4633.513481084437, 4637.420322459692, 4653.464851542049, 4677.602403795648, 4739.028499157595, 4822.0, 4904.901901961941, 4920.6801557898625, 4921.975390123026, 5134.691918484903, 5138.229265610188, 5171.120909445328, 5176.197689358156, 5228.529432351107, 4882.95117048825, 4884.340614017062, 4885.1206782779445, 4892.192788190051, 4939.728314942569, 4870.0, 5016.874578135576, 5057.974710126426, 5068.442471328225, 5071.442141364373, 5121.795128194831, 5148.073346797612, 5148.4851514848215, 5162.922556161586, 5207.895842083061, 5008.048470790538, 5023.824166154167, 5024.949750502595, 5027.069992051483, 5073.6955782651685, 4858.805647774191, 4881.780319885543, 4903.41159060915, 4939.036887806843, 4983.925241121314, 4845.2732090186755, 4870.634702397405, 4871.756412179306, 4911.386076740408, 4925.261210818406, 4983.9003219934675, 4987.451380348231, 5037.0429618373855, 5038.546530812245, 5048.469910659328, 4771.5228477152, 4833.371661683958, 4855.441624213119, 4881.9023619528125, 4901.044296362175], "value": 4698.697066396723, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.8069513308172, 599.7391134856338, 601.5518438763122, 602.3945934335991, 603.815836169968, 40389.79805100974, 41650.37524437136, 41661.79169104154, 45091.77454112725, 45243.77378113113, 41300.58699413005, 41726.7913660432, 41765.37351939723, 41797.7910110449, 41818.163636727244, 7741.651625676844, 7921.04947406312, 7922.48503847251, 7923.326517246041, 7923.484973476706, 7710.190430004853, 7803.921960780404, 7809.492382995116, 7818.296353328199, 7821.608919554028, 7828.843423131534, 7867.921320786776, 7874.094479134887, 7874.960625196894, 7878.487898286622, 7780.2608752168735, 7835.0, 7840.2159784021715, 7840.803979900491, 7843.8431231375625, 7719.073711154641, 7780.610969451504, 7862.977812884345, 7869.370450363957, 7871.134175240719, 38701.61298387008, 38988.0, 39085.804570976965, 39141.804290978645, 39151.804240978614, 3152.6059242594674, 3272.345530893831, 3274.8035117892764, 3455.1189446691183, 3799.35410980134, 28530.144095676955, 29002.27494312638, 29681.851590742124, 29895.850520747474, 30789.692103078905, 3421.127612458807, 3423.640517745651, 3464.168599536093, 3475.200703838106, 3541.610422853484, 265840.0, 305843.0, 309466.0, 309675.0, 406675.0, 55851.0, 56194.43805561892, 56414.71792641011, 56427.153592696144, 56430.43569564252, 33201.3359732804, 33705.83147084298, 33774.49338259928, 35379.0, 59037.70481147567, 12320.75358492825, 12452.626421207378, 12470.501179952882, 12473.251604903735, 12482.937585312015, 9511.809763804824, 9516.619335226653, 9519.904800951901, 9613.615455381707, 9637.759056023515, 18626.627467450846, 18681.15934782938, 18681.906590466962, 18867.245310187438, 18888.622227555374, 6739.393454589012, 6763.661816909135, 6896.344847239504, 6971.82570435733, 6999.8600027999155, 793.3573805217792, 897.7037577599376, 969.9127078562822, 978.5107446276861, 1050.1231471721046, 27417.45165096687, 28091.71908280932, 28536.286592835346, 28698.569521457193, 28960.27599309992, 950.3727539823683, 950.6245033211843, 951.414879848888, 953.947532885684, 1000.5447521377756, 14683.339249733788, 15002.324895379734, 15040.0, 15214.695706085817, 15263.389464421522, 390863.0, 394224.0, 397735.0, 398371.0, 398680.0, 49438.50561494411, 49674.254886176735, 49936.0, 49938.0, 49961.75019124881, 1073.5652060915343, 1154.4054811771944, 1161.6573110932295, 1190.1966172833477, 1191.862935762381, 28066.85966570154, 28522.42955140927, 29099.869314950865, 29185.70814291915, 29545.55681664734, 41694.58305416907, 41822.58177418187, 42169.578304216564, 42278.788606056776, 42281.365779513944, 289481.0, 290758.0, 292677.0, 293003.0, 293236.0, 22357.552848943255, 24667.0, 24988.500229994934, 25202.36994075163, 25366.492670146126, 41493.1701365965, 41683.37474937939, 42435.0, 42593.78703106465, 42838.0, 35009.37429692732, 35582.0, 36254.27491450103, 36285.0, 36316.81841590775, 35586.46620300646, 35984.28031439409, 36097.81951090228, 36227.27545449129, 36350.0, 34986.300273994886, 35435.468467973515, 35660.46509302415, 36650.0, 36745.265094698494, 30810.537841932837, 32200.516992245604, 32658.510122347707, 32695.0, 32860.67139328672, 24924.50150997006, 25325.493490130462, 25673.0, 25728.0, 25882.35294117662], "value": 17496.5426035394, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.7524608020466, 367.65440485943196, 370.3149174028048, 377.2495620321708, 378.53818341623247, 15671.29479173437, 16784.664306713858, 16840.32638694452, 17234.569135771613, 17254.39609613664, 15260.0, 16292.348306067774, 17012.574685632866, 17059.48821535353, 17066.14669266535, 5035.496450354963, 5202.3497062867145, 5212.582993360522, 5235.55497782689, 5238.607104467161, 3725.9068523287, 3898.785566793825, 5156.097682905495, 5773.134029895528, 6075.696215189245, 6121.632702037869, 6137.5089992800695, 6140.3859614038465, 6154.846128846792, 6170.876582468348, 6054.666993315366, 6122.326544080148, 6130.540209484307, 6131.9386806131815, 6145.631262124264, 3392.643772403887, 4990.802207470218, 5240.947590524084, 5316.0, 5362.115250983583, 19744.901275493674, 20403.38789836307, 20439.182432702823, 20524.486887827774, 20573.382798516068, 1979.0401655197218, 1990.9402717918485, 2051.5999380120884, 2251.5159240763314, 2276.408133885185, 12788.808167877489, 13014.414351354117, 13046.804297935538, 13085.0, 13557.864421355758, 1649.736042233237, 1674.6566953774568, 1709.4700642800772, 1781.2073627235886, 1841.6961201401753, 58230.0, 60016.69991650058, 61309.693451532905, 62483.37516624821, 70520.29479705138, 9923.65267215644, 9945.45300008492, 10010.199184065257, 10063.39619622825, 10270.33242839213, 13949.372278247503, 14037.298135093204, 14067.43730250799, 14082.0, 14159.646008849655, 6109.8472538186015, 6166.5991710539565, 6247.219097612799, 6392.424681778569, 6430.260520040161, 5540.2243685884005, 5588.692621905753, 5698.629589076697, 5712.714364281769, 5714.314282286152, 4310.396544483775, 4377.759223242752, 4383.232934236496, 4471.262241730143, 4486.304622783474, 1643.7534369844618, 1722.2852516205635, 1781.768370111903, 1832.395309547846, 1834.5230240137394, 818.6234332207251, 834.8038211020405, 847.2586486824028, 849.995750021246, 891.3270480786964, 16064.919675401548, 16916.06961617123, 16916.830831691525, 16991.91504042472, 17091.914540427217, 868.6308318964415, 873.8328944218247, 885.2210055151554, 886.866969954499, 929.9860502092474, 9203.723888283363, 9442.339036267533, 9609.759756006155, 9636.614535418645, 9643.517824108767, 399021.0, 399828.0, 408195.0, 423555.0, 430699.0, 78848.60575697085, 79668.6016569925, 80678.19321806825, 82159.58920205361, 83472.0, 917.2799352508249, 944.1219665710818, 956.531299663174, 961.3895176562793, 971.6599190283345, 15209.543713688607, 15294.847051529343, 15437.305321260346, 15597.220138993232, 15899.682006360039, 33815.83092084524, 35609.46585801267, 35629.82185089058, 36669.63330366662, 36865.0, 44648.776756116014, 46345.536544634124, 49161.754191228814, 51113.74443127909, 51699.0, 7308.853822923618, 7328.523645962995, 7336.7065317386705, 7417.295356941082, 7550.509216900884, 10300.793984120426, 10377.792444150924, 10590.311629744043, 10995.175361847734, 11214.88785112171, 8535.445196062235, 8995.685151019683, 9798.118169364792, 10101.444420556645, 10121.69634910954, 9903.405795652285, 9948.552315145691, 10044.648437304659, 10116.443595602019, 10160.237982151517, 9604.27967902396, 9902.900970990486, 10144.898551014396, 10215.080642741892, 10308.278420510793, 7399.519031262951, 7466.104067511933, 7490.176080631018, 7500.399968002437, 7575.0909890813455, 9482.95258523703, 9557.139857412867, 9623.230141588516, 9739.269554783277, 9823.459709716035], "value": 8152.106709707252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1015.553156611091, 1027.5581499955022, 1161.947712352944, 1246.308298894114, 1451.4411951398715, 6684.766033188839, 7418.0, 7596.96201518993, 7602.049743782028, 7617.04786901638, 7553.093628764542, 7695.384369250461, 7699.230076992298, 7703.46075774696, 7706.190849960757, 1811.8278763517444, 2053.1068984991502, 2117.5553133841913, 2142.368001439579, 2172.663237198237, 2123.3205374280237, 2162.9891850540803, 2163.967540486894, 2164.437246315961, 2164.6969424280614, 2120.0777661717125, 2128.1806504495726, 2168.035224325168, 2169.305822136917, 2171.478845077178, 1780.6438712257536, 2038.9388318350473, 2055.9074841632087, 2108.135664377598, 2114.238874005357, 2136.145541783299, 2141.8072373486307, 2162.37291185556, 2162.545865368259, 2166.794154555315, 7607.201243869369, 7640.541567505968, 7664.425168112358, 7673.040869891263, 7677.961610191969, 4238.427812245369, 4363.38912552243, 4367.650587952988, 4369.1480161368545, 4371.934420983688, 2877.6402949631297, 2877.812942158753, 2930.2088436122126, 2935.735783779449, 2953.350262942171, 924.2513564013103, 939.0562484702898, 944.9527523623791, 945.0974319524906, 947.3179310896144, 10318.380897146195, 10522.421266830397, 10556.788864222672, 10567.894321056769, 10578.735531611694, 4048.4534587830854, 4151.771652559139, 4198.538160802309, 4251.192273468031, 4252.255855225323, 8916.777080572907, 8961.775955601162, 8962.507062111516, 8977.596008179647, 8982.910170898338, 4391.297392417198, 4430.645548356124, 4444.733316000986, 4446.644268458515, 4454.57681520255, 3494.336076145524, 3917.118648304109, 3973.9602603974167, 3997.200559888034, 4053.0272734543496, 3654.3239500692457, 3661.707063434919, 3732.869349572752, 3775.716821238418, 3806.42903564462, 1162.1980833225048, 1183.3255044624655, 1193.659806955031, 1196.090970862151, 1206.1376116077047, 703.4794252253296, 781.5037451218403, 803.714681288146, 849.7408290471342, 850.1498501498502, 4995.700257984533, 5120.385553733501, 5149.382074151126, 5255.316808814906, 5285.2600635911, 380.7487058541349, 878.5299864572551, 951.9666811661558, 957.3250858144991, 983.341161421849, 3570.910727231788, 3607.8196090195383, 3651.689606383487, 3691.483192353019, 3731.5149030625844, 9338.393004454689, 9516.19112375442, 9603.135717785433, 9621.807563848824, 9630.229581633592, 9425.811483770423, 9479.478628675352, 9483.14651681352, 9511.619535218513, 9527.09492598202, 6789.864202716017, 6958.130233720785, 7067.328603782633, 7083.893741593777, 7106.2183159852375, 5062.316587260672, 5139.486051394831, 5175.249588809676, 5185.09260879337, 5223.895522089461, 7939.920600793918, 8298.792530186794, 8563.058063612873, 8583.18459746323, 8585.055643879043, 8203.0566484855, 8350.331973442231, 8453.408261421642, 8488.83022339562, 8524.531150786766, 6034.969825150846, 6312.652804095819, 6560.114384558215, 6595.8021259362295, 6743.9325606743305, 7477.850442991218, 7481.17707052213, 7513.511621744569, 7526.5860377679755, 7535.321821035914, 6636.27001029896, 6688.197416310074, 6746.257911629618, 6792.93207067923, 6891.793246202622, 6516.57642253252, 6554.115194448688, 6561.212654481493, 6647.567908085959, 6715.127033485811, 6243.188385509855, 6271.529635277281, 6323.810285691437, 6340.619562826245, 6343.080253363144, 4530.614897733598, 4544.863654090383, 4557.065801510616, 4617.746023968714, 4622.907541849211, 4553.066621342683, 4568.0863827234025, 4575.6339492839825, 4601.217792975269, 4610.0], "value": 4031.3204837828243, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.5838683587783, 283.7132710354542, 286.36998603073243, 286.6803514081799, 288.24479862759574, 4600.332951722006, 4650.976745116278, 4789.425268967724, 4808.302796094568, 4810.807567697292, 4626.676132670715, 4677.579017888389, 4691.812327506896, 4752.572268495835, 4753.310769938365, 3724.9813750931276, 3736.6637002669754, 3751.0247335692643, 3770.1705624762644, 3775.320442320381, 3555.9466608000903, 3564.803935783531, 3707.3326801175776, 3767.943480847776, 3774.924501509968, 3677.356462619044, 3693.1874987502842, 3705.814709264526, 3710.4063349864027, 3715.516982792233, 3688.4282936144805, 3706.9629303707156, 3709.443583462475, 3714.4428335749585, 3743.8315275812383, 3292.0453068610313, 3296.8351582420783, 3308.123347312964, 3315.088350703552, 3317.270200555874, 4307.590778876001, 4523.751193684346, 4526.6831321807485, 4563.977180114111, 4587.587117159438, 4109.3425051991535, 4109.815058322352, 4115.506139263278, 4124.360724087771, 4132.442120313749, 4899.191633380488, 4900.485449027837, 4901.460839307673, 4910.607151427877, 4914.213725803854, 3278.6885245901603, 3468.3063387322636, 3469.8785542505893, 3485.512028316012, 3494.6330635283184, 5095.363079615048, 5117.667351622133, 5138.460461651547, 5154.999999999963, 5167.819126330561, 3553.36039512885, 3556.715462762973, 3557.5730912290173, 3558.5373901392654, 3563.94654080189, 3602.6217247189193, 3622.5109610202812, 3630.945535816965, 3631.891043268706, 3633.854645814191, 3960.6435420812263, 4147.585241475828, 4165.562615925345, 4172.395002724588, 4183.330667093251, 4647.488776234612, 4874.488178741252, 4881.682690625169, 4887.682300650446, 4906.165951788204, 1217.2696382170805, 1234.1731040203085, 1245.8068999305121, 1253.7993920972601, 1255.9434825432877, 781.7185813107277, 787.9724209652635, 797.9840403191904, 804.951702897828, 817.791463176886, 3997.5802540733384, 4001.7598944063448, 4022.456968309299, 4026.3960405939342, 4030.2946984277633, 4416.78538401942, 4540.841070562515, 4575.428071491064, 4584.61030812378, 4611.400517932647, 3931.4299426582984, 3932.4297976793205, 3949.466821978996, 3964.484616999772, 4007.458993035903, 2312.2947501012018, 2399.2682231919434, 2408.867512286806, 2409.9879500602383, 2422.454947636803, 4297.140571885573, 4307.461567304087, 4320.395144679747, 4332.1985432695055, 4339.566043395698, 4543.5002149763495, 4570.405847239837, 4585.0, 4607.631389488833, 4634.814607415733, 4156.459660244149, 4215.199112168678, 4358.455193100863, 4372.0, 4372.803223854934, 4402.207602631429, 4482.8655140345845, 4541.866112382578, 4545.954540454553, 4555.362249285036, 4366.890827729332, 4377.796106070856, 4381.138016342978, 4407.6914615976575, 4477.432898485504, 4248.8300467980935, 4265.253580623441, 4288.62763915544, 4348.913021739484, 4442.533533978885, 3601.423772196436, 3618.203995121069, 3628.8911332660064, 3632.9818350908076, 3636.618155093677, 4841.975790121027, 5047.520485553867, 5055.696658200372, 5061.7469126544265, 5073.604758691389, 4779.856604301876, 4939.185034469272, 4939.6542242042715, 4950.4059512858685, 4952.504749525018, 4893.825481884393, 4928.186849169847, 4934.555889969776, 4939.777710002986, 4976.178930476575, 4631.355868666575, 4858.416989961227, 4884.609231261562, 4890.559849613552, 4897.240927656219, 4965.627577931597, 4983.327250821093, 4993.1012417763695, 5002.349694539686, 5006.549410553068, 4878.853634390832, 4895.583875370633, 4910.477751896923, 4911.312416261798, 4931.7040977541465], "value": 3600.347725767411, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.8105289992353, 681.8261343357443, 728.4391018915438, 773.8607050730868, 776.9261920117594, 12772.68068298293, 13258.535951241709, 13275.137116087471, 13290.534831280907, 13296.401661925212, 12403.44184511697, 12458.688532786686, 12468.314242716648, 12473.31396773177, 12484.875151248485, 626.962382257066, 782.7729958312083, 791.2048391366683, 806.2260230179036, 808.5957021489255, 803.5339503088195, 804.6218277409608, 806.9233422824823, 806.9314108300772, 808.6118663041743, 850.0946491986045, 852.7825404521839, 853.2363534636528, 853.3429259470204, 853.7225401744427, 661.9669016549177, 822.9794255143639, 840.3949156607233, 844.995775021121, 846.2426128614917, 613.947814435769, 614.3886832601545, 614.529884638252, 614.5544480251826, 616.2789536242607, 12673.809892851614, 12714.0, 12768.170068945488, 12777.23336599807, 12818.038647101504, 12573.308468034254, 13037.348132593332, 13125.0, 13289.667758306023, 13493.055486115976, 9175.0, 10952.178586606036, 10969.396683182422, 11100.056495197918, 11169.329840209532, 4247.8088486018205, 4284.2074216269775, 4295.183915056129, 4336.3712261722185, 4363.127374525107, 41553.1689366214, 41600.167996639895, 41682.37476437856, 41905.58094419078, 41984.160316793495, 9341.859872101924, 9804.166645835041, 9955.900440995498, 9957.601695932082, 10527.631532896465, 17770.0, 18452.723209151874, 18472.0, 18511.53721156982, 18539.258429662932, 6908.758193463305, 6927.064846245692, 6958.025876377311, 7079.539829911039, 7248.710051597877, 3696.094456858087, 3815.523059617548, 3818.8090595470117, 3830.942535861964, 3861.4014827701753, 2926.3415731460677, 3005.834679092627, 3005.9549106763416, 3011.4729922263955, 3019.89430369936, 461.6768262216395, 490.1838438999098, 508.659198337115, 512.4081685653076, 519.2833889232835, 475.89054517461176, 552.933647962247, 611.6727550760322, 614.3487902823022, 637.8309747916805, 8089.352851771844, 8246.175382461826, 8267.503949763033, 8372.41393102477, 8528.957355213184, 551.9917201241905, 566.1578874052317, 567.4637467593085, 570.1419363857368, 574.8562859285179, 3808.6762625176616, 3865.845366185321, 3879.573246942834, 4002.599740026032, 4035.3139966205817, 56056.15915761267, 56492.0, 57206.427935720945, 57210.71394643, 57302.0, 49560.256596151085, 50539.49460505421, 52125.7393713029, 52793.0, 53678.7316063425, 47159.5284047162, 47922.5207747925, 48291.275630865566, 48293.275600866014, 49506.0, 7729.536227826348, 7811.4922530035365, 7985.361171106181, 8036.959815200887, 8100.716474923585, 33095.50356744699, 33180.66819331776, 33334.499982499794, 33903.32193356168, 33925.83037084799, 40085.599144008185, 42795.57204427916, 42967.14065718731, 43668.0, 44586.55413445824, 10165.644202453175, 10477.161827053666, 10483.0, 10582.682519524427, 10817.51321190564, 10797.26855702719, 11127.109831213322, 11229.38238396896, 11301.321920684457, 11837.585684501, 10021.799564008825, 10025.448600327052, 10026.69919902404, 10728.463576821285, 10788.298760580537, 10457.738556535844, 10506.054455099078, 10622.89377106219, 10666.520006599567, 10724.302920310467, 10199.0, 10203.94898025505, 10319.981250903833, 10462.267641265344, 10723.981221783917, 8641.913580864111, 9107.681231156877, 9196.03441638645, 9397.389169703947, 9536.570854311434, 9478.38390504615, 9750.80498390014, 9822.557984890555, 9890.554925028247, 9907.157891579296], "value": 6062.713552604221, "unit": "score"}], "name": "dromaeo_css", "value": 6239.05097997329, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 114.0, 116.0, 114.0, 115.0, 113.0, 112.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 136.0, 129.0, 216.0, 130.0, 131.0, 155.0, 128.0, 161.0, 129.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 133.0, 77.0, 77.0, 76.0, 76.0, 133.0, 75.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 172.0, 94.0, 94.0, 94.0, 122.0, 94.0, 94.0, 130.0], "value": 108.0, "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, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 67.0, 64.0, 65.0, 123.0, 63.0, 63.0], "value": 70.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 82.0, 86.0, 83.0, 80.0, 85.0, 83.0, 88.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 129.0, 128.0, 131.0, 133.0, 143.0, 129.0, 194.0, 131.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 173.0, 173.0, 172.0, 175.0, 171.0, 170.0, 176.0, 171.0], "value": 172.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 67.0, 68.0, 66.0, 66.0, 67.0, 65.0, 70.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1571.6999999999998, "alertThreshold": 2.0}]} 01:29:18 INFO - Return code: 0 01:29:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:29:18 ERROR - # TBPL SUCCESS # 01:29:18 INFO - Running post-action listener: _resource_record_post_action 01:29:18 INFO - ##### 01:29:18 INFO - ##### Finished run-tests step (success) 01:29:18 INFO - ##### 01:29:18 INFO - Running post-run listener: _resource_record_post_run 01:29:18 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530731008; Read time: 8; Write time: 372952 01:29:18 INFO - TinderboxPrint: CPU usage
13.1% 01:29:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 01:29:18 INFO - TinderboxPrint: I/O write bytes / time
530,731,008 / 372,952 01:29:18 INFO - TinderboxPrint: CPU idle
8,325.6 (86.8%) 01:29:18 INFO - TinderboxPrint: CPU user
1,217.5 (12.7%) 01:29:18 INFO - TinderboxPrint: Swap in / out
0 / 0 01:29:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236769280; Read time: 0; Write time: 196844 01:29:18 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293961728; Read time: 8; Write time: 176108 01:29:19 INFO - Running post-run listener: _upload_blobber_files 01:29:19 INFO - Blob upload gear active. 01:29:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:29:19 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 01:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:29:19 INFO - (blobuploader) - INFO - Open directory for files ... 01:29:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:29:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:29:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:23 INFO - (blobuploader) - INFO - Done attempting. 01:29:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:29:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:29:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:24 INFO - (blobuploader) - INFO - Done attempting. 01:29:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:29:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:29:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:25 INFO - (blobuploader) - INFO - Done attempting. 01:29:25 INFO - (blobuploader) - INFO - Iteration through files over. 01:29:25 INFO - Return code: 0 01:29:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:29:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:29:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/027cfd84d9212aae571d250b5af0b9c60e42d88e24f0d0b852d848809ef82784e67e86a087cf4cd25e28ffd0ac985be74294b057e70446aef8be0ad27af983b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ad4f3cb0cda73341495778c6760e7356d770e2506a84b4f5e5d4fbb8ffb26dee627b85dd07db94ce0e8466c918d111116ef8ada88776381d68f9769f4597f80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bcc777728892bcb1fd175c269d82e4942a20b3d3fab4481c74c7bc94e7e9d91f95713f778b0a227a7fef6591ded0d25a2c994c3c9b3f3ea4ac1fb9ce3f9189b"} 01:29:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:29:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:29:25 INFO - Contents: 01:29:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/027cfd84d9212aae571d250b5af0b9c60e42d88e24f0d0b852d848809ef82784e67e86a087cf4cd25e28ffd0ac985be74294b057e70446aef8be0ad27af983b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ad4f3cb0cda73341495778c6760e7356d770e2506a84b4f5e5d4fbb8ffb26dee627b85dd07db94ce0e8466c918d111116ef8ada88776381d68f9769f4597f80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bcc777728892bcb1fd175c269d82e4942a20b3d3fab4481c74c7bc94e7e9d91f95713f778b0a227a7fef6591ded0d25a2c994c3c9b3f3ea4ac1fb9ce3f9189b"} 01:29:25 INFO - Running post-run listener: copy_logs_to_upload_dir 01:29:25 INFO - Copying logs to upload dir... 01:29:25 INFO - mkdir: /builds/slave/test/build/upload/logs 01:29:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.816860 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-21 01:29:25.473412) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 01:29:25.476917) ========= 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=aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/027cfd84d9212aae571d250b5af0b9c60e42d88e24f0d0b852d848809ef82784e67e86a087cf4cd25e28ffd0ac985be74294b057e70446aef8be0ad27af983b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ad4f3cb0cda73341495778c6760e7356d770e2506a84b4f5e5d4fbb8ffb26dee627b85dd07db94ce0e8466c918d111116ef8ada88776381d68f9769f4597f80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bcc777728892bcb1fd175c269d82e4942a20b3d3fab4481c74c7bc94e7e9d91f95713f778b0a227a7fef6591ded0d25a2c994c3c9b3f3ea4ac1fb9ce3f9189b"} build_url:https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/RuvXAPfARoWBOv8HAJB2Cw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/027cfd84d9212aae571d250b5af0b9c60e42d88e24f0d0b852d848809ef82784e67e86a087cf4cd25e28ffd0ac985be74294b057e70446aef8be0ad27af983b5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ad4f3cb0cda73341495778c6760e7356d770e2506a84b4f5e5d4fbb8ffb26dee627b85dd07db94ce0e8466c918d111116ef8ada88776381d68f9769f4597f80", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3bcc777728892bcb1fd175c269d82e4942a20b3d3fab4481c74c7bc94e7e9d91f95713f778b0a227a7fef6591ded0d25a2c994c3c9b3f3ea4ac1fb9ce3f9189b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 01:29:25.504660) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:29:25.505013) ========= 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=aa08bb06ff6271ef470a76a4000001be-1463813436.116598-1336588507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004680 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:29:25.555824) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 01:29:25.556137) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 01:29:25.556473) ========= ========= Total master_lag: 0.16 =========