builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1464037934.55 results: success (0) buildid: 20160523133154 builduid: 6807398504784a7580e041da1215d670 revision: a132c5d3fcac17034d38b3191a611440943c5425 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:14.553247) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:14.553652) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:14.553957) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:14.575551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:14.575865) ========= 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=1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-23 14:12:15-- 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-23 14:12:15 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:14.694965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:14.695291) ========= 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=1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015458 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:14.744548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:14.747930) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a132c5d3fcac17034d38b3191a611440943c5425 --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 a132c5d3fcac17034d38b3191a611440943c5425 --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=1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-23 14:12:15,800 truncating revision to first 12 chars 2016-05-23 14:12:15,800 Setting DEBUG logging. 2016-05-23 14:12:15,800 attempt 1/10 2016-05-23 14:12:15,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a132c5d3fcac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-23 14:12:16,070 unpacking tar archive at: fx-team-a132c5d3fcac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:15.313170) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:15.313497) ========= script_repo_revision: a132c5d3fcac17034d38b3191a611440943c5425 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:15.313939) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:15.314207) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-23 14:12:15.323494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-23 14:12:15.323775) ========= /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=1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:12:16 INFO - MultiFileLogger online at 20160523 14:12:16 in /builds/slave/test 14:12:16 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 14:12:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:12:16 INFO - {'append_to_log': False, 14:12:16 INFO - 'base_work_dir': '/builds/slave/test', 14:12:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:12:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:12:16 INFO - 'branch': 'Fx-Team-Non-PGO', 14:12:16 INFO - 'buildbot_json_path': 'buildprops.json', 14:12:16 INFO - 'config_files': ('talos/linux_config.py',), 14:12:16 INFO - 'default_actions': ('clobber', 14:12:16 INFO - 'read-buildbot-config', 14:12:16 INFO - 'download-and-extract', 14:12:16 INFO - 'populate-webroot', 14:12:16 INFO - 'create-virtualenv', 14:12:16 INFO - 'install', 14:12:16 INFO - 'run-tests'), 14:12:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:12:16 INFO - 'download_minidump_stackwalk': True, 14:12:16 INFO - 'download_symbols': 'ondemand', 14:12:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:12:16 INFO - 'tooltool.py': '/tools/tooltool.py', 14:12:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:12:16 INFO - '/tools/misc-python/virtualenv.py')}, 14:12:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:12:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:12:16 INFO - 'installer_path': 'installer.exe', 14:12:16 INFO - 'log_level': 'info', 14:12:16 INFO - 'log_name': 'talos', 14:12:16 INFO - 'log_to_console': True, 14:12:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:12:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:12:16 INFO - 'opt_config_files': (), 14:12:16 INFO - 'pip_index': False, 14:12:16 INFO - 'sps_profile': False, 14:12:16 INFO - 'sps_profile_interval': 0, 14:12:16 INFO - 'suite': 'dromaeojs', 14:12:16 INFO - 'system_bits': '32', 14:12:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:12:16 INFO - 'title': 'talos-linux64-ix-027', 14:12:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:12:16 INFO - 'use_talos_json': True, 14:12:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:12:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:12:16 INFO - 'work_dir': 'build'} 14:12:16 INFO - ##### 14:12:16 INFO - ##### Running clobber step. 14:12:16 INFO - ##### 14:12:16 INFO - Running pre-action listener: _resource_record_pre_action 14:12:16 INFO - Running main action method: clobber 14:12:16 INFO - rmtree: /builds/slave/test/build 14:12:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:12:16 INFO - Running post-action listener: _resource_record_post_action 14:12:16 INFO - ##### 14:12:16 INFO - ##### Finished clobber step (success) 14:12:16 INFO - ##### 14:12:16 INFO - ##### 14:12:16 INFO - ##### Running read-buildbot-config step. 14:12:16 INFO - ##### 14:12:16 INFO - Running pre-action listener: _resource_record_pre_action 14:12:16 INFO - Running main action method: read_buildbot_config 14:12:16 INFO - Using buildbot properties: 14:12:16 INFO - { 14:12:16 INFO - "project": "", 14:12:16 INFO - "product": "firefox", 14:12:16 INFO - "script_repo_revision": "production", 14:12:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:12:16 INFO - "repository": "", 14:12:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:12:16 INFO - "buildid": "20160523133154", 14:12:16 INFO - "pgo_build": "False", 14:12:16 INFO - "basedir": "/builds/slave/test", 14:12:16 INFO - "buildnumber": 2997, 14:12:16 INFO - "slavename": "talos-linux64-ix-027", 14:12:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:12:16 INFO - "platform": "ubuntu64_hw", 14:12:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:12:16 INFO - "branch": "fx-team", 14:12:16 INFO - "repo_path": "integration/fx-team", 14:12:16 INFO - "revision": "a132c5d3fcac17034d38b3191a611440943c5425", 14:12:16 INFO - "stage_platform": "linux64", 14:12:16 INFO - "builduid": "6807398504784a7580e041da1215d670", 14:12:16 INFO - "slavebuilddir": "test" 14:12:16 INFO - } 14:12:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:12:16 INFO - Running post-action listener: _resource_record_post_action 14:12:16 INFO - ##### 14:12:16 INFO - ##### Finished read-buildbot-config step (success) 14:12:16 INFO - ##### 14:12:16 INFO - ##### 14:12:16 INFO - ##### Running download-and-extract step. 14:12:16 INFO - ##### 14:12:16 INFO - Running pre-action listener: _resource_record_pre_action 14:12:16 INFO - Running main action method: download_and_extract 14:12:16 INFO - mkdir: /builds/slave/test/build/tests 14:12:16 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')]} 14:12:16 INFO - https://queue.taskcluster.net/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:12:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:12:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:12:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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 14:12:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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 14:12:17 INFO - Downloaded 1361 bytes. 14:12:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:12:17 INFO - Using the following test package requirements: 14:12:17 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:17 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:12:17 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:12:17 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:17 INFO - u'jsshell-linux-x86_64.zip'], 14:12:17 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:12:17 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:12:17 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:12:17 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:12:17 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:12:17 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:12:17 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:12:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:17 INFO - https://queue.taskcluster.net/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:12:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:12:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:12:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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 14:12:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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 14:12:18 INFO - Downloaded 22814444 bytes. 14:12:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:12:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:12:19 INFO - Return code: 0 14:12:19 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 14:12:19 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')]} 14:12:19 INFO - https://queue.taskcluster.net/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:12:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:12:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:12:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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 14:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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 14:12:21 INFO - Downloaded 22814444 bytes. 14:12:21 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'] 14:12:21 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 14:12:22 INFO - Return code: 0 14:12:22 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')]} 14:12:22 INFO - https://queue.taskcluster.net/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:12:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:12:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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 14:12:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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 14:12:23 INFO - Downloaded 10840359 bytes. 14:12:23 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'] 14:12:23 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 14:12:23 INFO - Return code: 0 14:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:23 INFO - https://queue.taskcluster.net/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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 14:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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 14:12:25 INFO - Downloaded 54811084 bytes. 14:12:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:12:25 INFO - mkdir: /builds/slave/test/properties 14:12:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:12:25 INFO - Writing to file /builds/slave/test/properties/build_url 14:12:25 INFO - Contents: 14:12:25 INFO - build_url:https://queue.taskcluster.net/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:12:25 INFO - Running post-action listener: _resource_record_post_action 14:12:25 INFO - Running post-action listener: set_extra_try_arguments 14:12:25 INFO - ##### 14:12:25 INFO - ##### Finished download-and-extract step (success) 14:12:25 INFO - ##### 14:12:25 INFO - ##### 14:12:25 INFO - ##### Running populate-webroot step. 14:12:25 INFO - ##### 14:12:25 INFO - Running pre-action listener: _resource_record_pre_action 14:12:25 INFO - Running main action method: populate_webroot 14:12:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:12:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:12:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:12:26 INFO - '--tppagecycles', 14:12:26 INFO - '7'], 14:12:26 INFO - 'tests': ['tsvgm']}}, 14:12:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:12:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:12:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:12:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:12:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:12:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:12:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:26 INFO - 'talos_options': ['--disable-e10s'], 14:12:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:12:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:26 INFO - 'talos_options': ['--disable-e10s'], 14:12:26 INFO - 'tests': ['damp', 'tps']}, 14:12:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:26 INFO - 'tests': ['damp', 'tps']}, 14:12:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:12:26 INFO - 'tests': ['dromaeo_dom']}, 14:12:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:12:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:12:26 INFO - 'tests': ['a11yr', 14:12:26 INFO - 'ts_paint', 14:12:26 INFO - 'tpaint', 14:12:26 INFO - 'sessionrestore', 14:12:26 INFO - 'sessionrestore_no_auto_restore', 14:12:26 INFO - 'tabpaint']}, 14:12:26 INFO - 'other-e10s': {'tests': ['a11yr', 14:12:26 INFO - 'ts_paint', 14:12:26 INFO - 'tpaint', 14:12:26 INFO - 'sessionrestore', 14:12:26 INFO - 'sessionrestore_no_auto_restore', 14:12:26 INFO - 'tabpaint']}, 14:12:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:12:26 INFO - 'ts_paint', 14:12:26 INFO - 'tpaint', 14:12:26 INFO - 'sessionrestore', 14:12:26 INFO - 'sessionrestore_no_auto_restore', 14:12:26 INFO - 'tabpaint']}, 14:12:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:12:26 INFO - 'ts_paint', 14:12:26 INFO - 'tpaint', 14:12:26 INFO - 'sessionrestore', 14:12:26 INFO - 'sessionrestore_no_auto_restore', 14:12:26 INFO - 'tabpaint']}, 14:12:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:12:26 INFO - 'tests': ['a11yr', 14:12:26 INFO - 'ts_paint', 14:12:26 INFO - 'tpaint', 14:12:26 INFO - 'sessionrestore', 14:12:26 INFO - 'sessionrestore_no_auto_restore', 14:12:26 INFO - 'tabpaint']}, 14:12:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:12:26 INFO - 'tests': ['a11yr', 14:12:26 INFO - 'ts_paint', 14:12:26 INFO - 'tpaint', 14:12:26 INFO - 'sessionrestore', 14:12:26 INFO - 'sessionrestore_no_auto_restore', 14:12:26 INFO - 'tabpaint']}, 14:12:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:12:26 INFO - 'tests': ['tsvgx', 14:12:26 INFO - 'tsvgr_opacity', 14:12:26 INFO - 'tart', 14:12:26 INFO - 'tscrollx', 14:12:26 INFO - 'cart']}, 14:12:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:12:26 INFO - 'tsvgr_opacity', 14:12:26 INFO - 'tart', 14:12:26 INFO - 'tscrollx', 14:12:26 INFO - 'cart']}, 14:12:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:26 INFO - 'talos_options': ['--disable-e10s'], 14:12:26 INFO - 'tests': ['tp5o']}, 14:12:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:26 INFO - 'tests': ['tp5o']}, 14:12:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:26 INFO - 'talos_options': ['--disable-e10s', 14:12:26 INFO - '--xperf_path', 14:12:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:26 INFO - 'tests': ['tp5n']}, 14:12:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:12:26 INFO - 'talos_options': ['--xperf_path', 14:12:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:12:26 INFO - 'tests': ['tp5n']}}, 14:12:26 INFO - 'talos.zip': {'path': '', 14:12:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:12:26 INFO - Running post-action listener: _resource_record_post_action 14:12:26 INFO - ##### 14:12:26 INFO - ##### Finished populate-webroot step (success) 14:12:26 INFO - ##### 14:12:26 INFO - ##### 14:12:26 INFO - ##### Running create-virtualenv step. 14:12:26 INFO - ##### 14:12:26 INFO - Running pre-action listener: _resource_record_pre_action 14:12:26 INFO - Running main action method: create_virtualenv 14:12:26 INFO - Creating virtualenv /builds/slave/test/build/venv 14:12:26 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 14:12:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:12:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:12:26 INFO - Using real prefix '/usr' 14:12:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:12:26 INFO - Installing distribute.............................................................................................................................................................................................done. 14:12:28 INFO - Installing pip.................done. 14:12:28 INFO - Return code: 0 14:12:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:12:28 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')]} 14:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:28 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')]} 14:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:28 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 0x7f62b815af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a389c0>, '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 0x1a398c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a39d50>, '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': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', '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 14:12:28 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 14:12:28 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 14:12:28 INFO - Using env: {'DISPLAY': ':0', 14:12:28 INFO - 'HOME': '/home/cltbld', 14:12:28 INFO - 'LANG': 'en_US.UTF-8', 14:12:28 INFO - 'LANGUAGE': 'en_US:en', 14:12:28 INFO - 'LOGNAME': 'cltbld', 14:12:28 INFO - 'MAIL': '/var/mail/cltbld', 14:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:28 INFO - 'MOZ_NO_REMOTE': '1', 14:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:28 INFO - 'NO_EM_RESTART': '1', 14:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:28 INFO - 'PWD': '/builds/slave/test', 14:12:28 INFO - 'SHELL': '/bin/bash', 14:12:28 INFO - 'SHLVL': '1', 14:12:28 INFO - 'TERM': 'linux', 14:12:28 INFO - 'TMOUT': '86400', 14:12:28 INFO - 'USER': 'cltbld', 14:12:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', 14:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:28 INFO - '_': '/tools/buildbot/bin/python'} 14:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:28 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 14:12:28 INFO - Cleaning up... 14:12:28 INFO - Return code: 0 14:12:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:12:28 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')]} 14:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:28 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')]} 14:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:28 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 0x7f62b815af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a389c0>, '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 0x1a398c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a39d50>, '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': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', '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 14:12:28 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 14:12:28 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 14:12:28 INFO - Using env: {'DISPLAY': ':0', 14:12:28 INFO - 'HOME': '/home/cltbld', 14:12:28 INFO - 'LANG': 'en_US.UTF-8', 14:12:28 INFO - 'LANGUAGE': 'en_US:en', 14:12:28 INFO - 'LOGNAME': 'cltbld', 14:12:28 INFO - 'MAIL': '/var/mail/cltbld', 14:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:28 INFO - 'MOZ_NO_REMOTE': '1', 14:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:28 INFO - 'NO_EM_RESTART': '1', 14:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:28 INFO - 'PWD': '/builds/slave/test', 14:12:28 INFO - 'SHELL': '/bin/bash', 14:12:28 INFO - 'SHLVL': '1', 14:12:28 INFO - 'TERM': 'linux', 14:12:28 INFO - 'TMOUT': '86400', 14:12:28 INFO - 'USER': 'cltbld', 14:12:28 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', 14:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:28 INFO - '_': '/tools/buildbot/bin/python'} 14:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:29 INFO - Downloading/unpacking psutil>=3.1.1 14:12:29 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 14:12:29 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 14:12:29 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 14:12:29 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 14:12:29 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 14:12:29 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 14:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:31 INFO - Installing collected packages: psutil 14:12:31 INFO - Running setup.py install for psutil 14:12:31 INFO - building 'psutil._psutil_linux' extension 14:12:31 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 14:12:31 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 14:12:31 INFO - building 'psutil._psutil_posix' extension 14:12:31 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 14:12:31 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 14:12:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:12:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:12:31 INFO - Successfully installed psutil 14:12:31 INFO - Cleaning up... 14:12:31 INFO - Return code: 0 14:12:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:12:31 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')]} 14:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:31 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')]} 14:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:31 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 0x7f62b815af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a389c0>, '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 0x1a398c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a39d50>, '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': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', '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 14:12:31 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 14:12:31 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 14:12:31 INFO - Using env: {'DISPLAY': ':0', 14:12:31 INFO - 'HOME': '/home/cltbld', 14:12:31 INFO - 'LANG': 'en_US.UTF-8', 14:12:31 INFO - 'LANGUAGE': 'en_US:en', 14:12:31 INFO - 'LOGNAME': 'cltbld', 14:12:31 INFO - 'MAIL': '/var/mail/cltbld', 14:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:31 INFO - 'MOZ_NO_REMOTE': '1', 14:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:31 INFO - 'NO_EM_RESTART': '1', 14:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:31 INFO - 'PWD': '/builds/slave/test', 14:12:31 INFO - 'SHELL': '/bin/bash', 14:12:31 INFO - 'SHLVL': '1', 14:12:31 INFO - 'TERM': 'linux', 14:12:31 INFO - 'TMOUT': '86400', 14:12:31 INFO - 'USER': 'cltbld', 14:12:31 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', 14:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:31 INFO - '_': '/tools/buildbot/bin/python'} 14:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:12:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:12:33 INFO - Installing collected packages: mozsystemmonitor 14:12:33 INFO - Running setup.py install for mozsystemmonitor 14:12:33 INFO - Successfully installed mozsystemmonitor 14:12:33 INFO - Cleaning up... 14:12:33 INFO - Return code: 0 14:12:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:12: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')]} 14:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12: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')]} 14:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:33 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 0x7f62b815af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a389c0>, '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 0x1a398c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a39d50>, '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': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', '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 14:12:33 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 14:12:33 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 14:12:33 INFO - Using env: {'DISPLAY': ':0', 14:12:33 INFO - 'HOME': '/home/cltbld', 14:12:33 INFO - 'LANG': 'en_US.UTF-8', 14:12:33 INFO - 'LANGUAGE': 'en_US:en', 14:12:33 INFO - 'LOGNAME': 'cltbld', 14:12:33 INFO - 'MAIL': '/var/mail/cltbld', 14:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:33 INFO - 'MOZ_NO_REMOTE': '1', 14:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:33 INFO - 'NO_EM_RESTART': '1', 14:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:33 INFO - 'PWD': '/builds/slave/test', 14:12:33 INFO - 'SHELL': '/bin/bash', 14:12:33 INFO - 'SHLVL': '1', 14:12:33 INFO - 'TERM': 'linux', 14:12:33 INFO - 'TMOUT': '86400', 14:12:33 INFO - 'USER': 'cltbld', 14:12:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', 14:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:33 INFO - '_': '/tools/buildbot/bin/python'} 14:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:34 INFO - Downloading/unpacking blobuploader==1.2.4 14:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:36 INFO - Downloading blobuploader-1.2.4.tar.gz 14:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:12:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:12:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:36 INFO - Downloading docopt-0.6.1.tar.gz 14:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:12:36 INFO - Installing collected packages: blobuploader, requests, docopt 14:12:36 INFO - Running setup.py install for blobuploader 14:12:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:12:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:12:36 INFO - Running setup.py install for requests 14:12:37 INFO - Running setup.py install for docopt 14:12:37 INFO - Successfully installed blobuploader requests docopt 14:12:37 INFO - Cleaning up... 14:12:37 INFO - Return code: 0 14:12:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:37 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 0x7f62b815af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a389c0>, '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 0x1a398c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a39d50>, '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': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', '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 14:12:37 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 14:12:37 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 14:12:37 INFO - Using env: {'DISPLAY': ':0', 14:12:37 INFO - 'HOME': '/home/cltbld', 14:12:37 INFO - 'LANG': 'en_US.UTF-8', 14:12:37 INFO - 'LANGUAGE': 'en_US:en', 14:12:37 INFO - 'LOGNAME': 'cltbld', 14:12:37 INFO - 'MAIL': '/var/mail/cltbld', 14:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:37 INFO - 'MOZ_NO_REMOTE': '1', 14:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:37 INFO - 'NO_EM_RESTART': '1', 14:12:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:37 INFO - 'PWD': '/builds/slave/test', 14:12:37 INFO - 'SHELL': '/bin/bash', 14:12:37 INFO - 'SHLVL': '1', 14:12:37 INFO - 'TERM': 'linux', 14:12:37 INFO - 'TMOUT': '86400', 14:12:37 INFO - 'USER': 'cltbld', 14:12:37 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', 14:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:37 INFO - '_': '/tools/buildbot/bin/python'} 14:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:12:37 INFO - Running setup.py (path:/tmp/pip-Ey3Rs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:12:37 INFO - Running setup.py (path:/tmp/pip-8zuRe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:12:37 INFO - Running setup.py (path:/tmp/pip-bTdGEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:12:37 INFO - Running setup.py (path:/tmp/pip-abIaiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:12:37 INFO - Running setup.py (path:/tmp/pip-Kuq3BF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:12:37 INFO - Running setup.py (path:/tmp/pip-mqcQM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:12:38 INFO - Running setup.py (path:/tmp/pip-8Nj2Xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:12:38 INFO - Running setup.py (path:/tmp/pip-_n4INo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:12:38 INFO - Running setup.py (path:/tmp/pip-GCaIFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:12:38 INFO - Running setup.py (path:/tmp/pip-oOv3HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:12:38 INFO - Running setup.py (path:/tmp/pip-y_jvtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:12:38 INFO - Running setup.py (path:/tmp/pip-Pvt23c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:12:38 INFO - Running setup.py (path:/tmp/pip-fANenw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:12:38 INFO - Running setup.py (path:/tmp/pip-u_GwgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:38 INFO - Running setup.py (path:/tmp/pip-jtxxBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:12:38 INFO - Running setup.py (path:/tmp/pip-EdaZLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:12:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:12:38 INFO - Running setup.py (path:/tmp/pip-Qs1w5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:12:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:12:38 INFO - Running setup.py install for manifestparser 14:12:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:12:38 INFO - Running setup.py install for mozcrash 14:12:39 INFO - Running setup.py install for mozdebug 14:12:39 INFO - Running setup.py install for mozdevice 14:12:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:12:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:12:39 INFO - Running setup.py install for mozfile 14:12:39 INFO - Running setup.py install for mozhttpd 14:12:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:12:39 INFO - Running setup.py install for mozinfo 14:12:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:12:39 INFO - Running setup.py install for mozInstall 14:12:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:12:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:12:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:12:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:12:39 INFO - Running setup.py install for mozleak 14:12:39 INFO - Running setup.py install for mozlog 14:12:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:12:39 INFO - Running setup.py install for moznetwork 14:12:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:12:39 INFO - Running setup.py install for mozprocess 14:12:40 INFO - Running setup.py install for mozprofile 14:12:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:12:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:12:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:12:40 INFO - Running setup.py install for mozrunner 14:12:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:12:40 INFO - Running setup.py install for mozscreenshot 14:12:40 INFO - Running setup.py install for moztest 14:12:40 INFO - Running setup.py install for mozversion 14:12:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:12:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:12:40 INFO - Cleaning up... 14:12:40 INFO - Return code: 0 14:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:40 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 0x7f62b815af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a389c0>, '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 0x1a398c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a39d50>, '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': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', '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 14:12:40 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 14:12:40 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 14:12:40 INFO - Using env: {'DISPLAY': ':0', 14:12:40 INFO - 'HOME': '/home/cltbld', 14:12:40 INFO - 'LANG': 'en_US.UTF-8', 14:12:40 INFO - 'LANGUAGE': 'en_US:en', 14:12:40 INFO - 'LOGNAME': 'cltbld', 14:12:40 INFO - 'MAIL': '/var/mail/cltbld', 14:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:40 INFO - 'MOZ_NO_REMOTE': '1', 14:12:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:40 INFO - 'NO_EM_RESTART': '1', 14:12:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:40 INFO - 'PWD': '/builds/slave/test', 14:12:40 INFO - 'SHELL': '/bin/bash', 14:12:40 INFO - 'SHLVL': '1', 14:12:40 INFO - 'TERM': 'linux', 14:12:40 INFO - 'TMOUT': '86400', 14:12:40 INFO - 'USER': 'cltbld', 14:12:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', 14:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:40 INFO - '_': '/tools/buildbot/bin/python'} 14:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:12:40 INFO - Running setup.py (path:/tmp/pip-ngTPo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:12:40 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)) 14:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:12:40 INFO - Running setup.py (path:/tmp/pip-a6wwyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:12:40 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)) 14:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:12:40 INFO - Running setup.py (path:/tmp/pip-R2j8es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:12:41 INFO - Running setup.py (path:/tmp/pip-nAmnHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:12:41 INFO - Running setup.py (path:/tmp/pip-yXFwBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:12:41 INFO - Running setup.py (path:/tmp/pip-zTRLrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:12:41 INFO - Running setup.py (path:/tmp/pip-wAYFUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:12:41 INFO - Running setup.py (path:/tmp/pip-cBLhHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:12:41 INFO - Running setup.py (path:/tmp/pip-_I_b5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:12:41 INFO - Running setup.py (path:/tmp/pip-s6Pc6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:12:41 INFO - Running setup.py (path:/tmp/pip-eSaB5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:12:41 INFO - Running setup.py (path:/tmp/pip-zeP2mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:12:41 INFO - Running setup.py (path:/tmp/pip-FmdXr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:12:41 INFO - Running setup.py (path:/tmp/pip-nHueOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:41 INFO - Running setup.py (path:/tmp/pip-Sxhrqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:12:41 INFO - Running setup.py (path:/tmp/pip-NuCHHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:12:41 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)) 14:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:12:41 INFO - Running setup.py (path:/tmp/pip-msRtna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:12:42 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)) 14:12:42 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)) 14:12:42 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)) 14:12:42 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)) 14:12:42 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)) 14:12:42 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)) 14:12:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:12:42 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 14:12:42 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 14:12:42 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 14:12:42 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 14:12:42 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 14:12:42 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 14:12:43 INFO - Downloading blessings-1.6.tar.gz 14:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:12:44 INFO - Installing collected packages: blessings 14:12:44 INFO - Running setup.py install for blessings 14:12:44 INFO - Successfully installed blessings 14:12:44 INFO - Cleaning up... 14:12:44 INFO - Return code: 0 14:12:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:12:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:44 INFO - Reading from file tmpfile_stdout 14:12:44 INFO - Current package versions: 14:12:44 INFO - argparse == 1.2.1 14:12:44 INFO - blessings == 1.6 14:12:44 INFO - blobuploader == 1.2.4 14:12:44 INFO - docopt == 0.6.1 14:12:44 INFO - manifestparser == 1.1 14:12:44 INFO - mozInstall == 1.12 14:12:44 INFO - mozcrash == 0.17 14:12:44 INFO - mozdebug == 0.1 14:12:44 INFO - mozdevice == 0.48 14:12:44 INFO - mozfile == 1.2 14:12:44 INFO - mozhttpd == 0.7 14:12:44 INFO - mozinfo == 0.9 14:12:44 INFO - mozleak == 0.1 14:12:44 INFO - mozlog == 3.2 14:12:44 INFO - moznetwork == 0.27 14:12:44 INFO - mozprocess == 0.22 14:12:44 INFO - mozprofile == 0.28 14:12:44 INFO - mozrunner == 6.11 14:12:44 INFO - mozscreenshot == 0.1 14:12:44 INFO - mozsystemmonitor == 0.3 14:12:44 INFO - moztest == 0.7 14:12:44 INFO - mozversion == 1.4 14:12:44 INFO - psutil == 3.1.1 14:12:44 INFO - requests == 1.2.3 14:12:44 INFO - wsgiref == 0.1.2 14:12:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:12:44 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')]} 14:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:44 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')]} 14:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:44 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 0x7f62b815af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a389c0>, '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 0x1a398c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a39d50>, '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': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', '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 14:12:44 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 14:12:44 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 14:12:44 INFO - Using env: {'DISPLAY': ':0', 14:12:44 INFO - 'HOME': '/home/cltbld', 14:12:44 INFO - 'LANG': 'en_US.UTF-8', 14:12:44 INFO - 'LANGUAGE': 'en_US:en', 14:12:44 INFO - 'LOGNAME': 'cltbld', 14:12:44 INFO - 'MAIL': '/var/mail/cltbld', 14:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:44 INFO - 'MOZ_NO_REMOTE': '1', 14:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:44 INFO - 'NO_EM_RESTART': '1', 14:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:44 INFO - 'PWD': '/builds/slave/test', 14:12:44 INFO - 'SHELL': '/bin/bash', 14:12:44 INFO - 'SHLVL': '1', 14:12:44 INFO - 'TERM': 'linux', 14:12:44 INFO - 'TMOUT': '86400', 14:12:44 INFO - 'USER': 'cltbld', 14:12:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', 14:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:44 INFO - '_': '/tools/buildbot/bin/python'} 14:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:44 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)) 14:12:44 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)) 14:12:44 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)) 14:12:44 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)) 14:12:44 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)) 14:12:44 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)) 14:12:44 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)) 14:12:44 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)) 14:12:44 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)) 14:12:44 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)) 14:12:44 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)) 14:12:44 INFO - Cleaning up... 14:12:44 INFO - Return code: 0 14:12:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:12:44 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')]} 14:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:44 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')]} 14:12:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:44 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 0x7f62b815af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a389c0>, '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 0x1a398c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a39d50>, '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': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', '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 14:12:44 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 14:12:44 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 14:12:44 INFO - Using env: {'DISPLAY': ':0', 14:12:44 INFO - 'HOME': '/home/cltbld', 14:12:44 INFO - 'LANG': 'en_US.UTF-8', 14:12:44 INFO - 'LANGUAGE': 'en_US:en', 14:12:44 INFO - 'LOGNAME': 'cltbld', 14:12:44 INFO - 'MAIL': '/var/mail/cltbld', 14:12:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:44 INFO - 'MOZ_NO_REMOTE': '1', 14:12:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:44 INFO - 'NO_EM_RESTART': '1', 14:12:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:44 INFO - 'PWD': '/builds/slave/test', 14:12:44 INFO - 'SHELL': '/bin/bash', 14:12:44 INFO - 'SHLVL': '1', 14:12:44 INFO - 'TERM': 'linux', 14:12:44 INFO - 'TMOUT': '86400', 14:12:44 INFO - 'USER': 'cltbld', 14:12:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', 14:12:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:44 INFO - '_': '/tools/buildbot/bin/python'} 14:12:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:44 INFO - Downloading/unpacking jsonschema 14:12:44 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 14:12:44 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 14:12:44 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 14:12:44 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 14:12:44 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 14:12:44 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 14:12:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:12:46 INFO - Downloading/unpacking functools32 (from jsonschema) 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 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 14:12:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:12:46 INFO - warning: no files found matching '*.txt' 14:12:46 INFO - no previously-included directories found matching 'build' 14:12:46 INFO - no previously-included directories found matching 'dist' 14:12:46 INFO - no previously-included directories found matching '.git*' 14:12:46 INFO - Installing collected packages: jsonschema, functools32 14:12:47 INFO - Running setup.py install for functools32 14:12:47 INFO - warning: no files found matching '*.txt' 14:12:47 INFO - no previously-included directories found matching 'build' 14:12:47 INFO - no previously-included directories found matching 'dist' 14:12:47 INFO - no previously-included directories found matching '.git*' 14:12:47 INFO - Successfully installed jsonschema functools32 14:12:47 INFO - Cleaning up... 14:12:47 INFO - Return code: 0 14:12:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:12:47 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 0x7f62b815af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a9770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a389c0>, '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 0x1a398c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a39d50>, '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': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', '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 14:12:47 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 14:12:47 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 14:12:47 INFO - Using env: {'DISPLAY': ':0', 14:12:47 INFO - 'HOME': '/home/cltbld', 14:12:47 INFO - 'LANG': 'en_US.UTF-8', 14:12:47 INFO - 'LANGUAGE': 'en_US:en', 14:12:47 INFO - 'LOGNAME': 'cltbld', 14:12:47 INFO - 'MAIL': '/var/mail/cltbld', 14:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:47 INFO - 'MOZ_NO_REMOTE': '1', 14:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:12:47 INFO - 'NO_EM_RESTART': '1', 14:12:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:47 INFO - 'PWD': '/builds/slave/test', 14:12:47 INFO - 'SHELL': '/bin/bash', 14:12:47 INFO - 'SHLVL': '1', 14:12:47 INFO - 'TERM': 'linux', 14:12:47 INFO - 'TMOUT': '86400', 14:12:47 INFO - 'USER': 'cltbld', 14:12:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', 14:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:47 INFO - '_': '/tools/buildbot/bin/python'} 14:12:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:12:47 INFO - Downloading/unpacking flake8 14:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:12:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:12:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:12:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:12:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:49 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 14:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:12:50 INFO - no previously-included directories found matching 'docs/_build' 14:12:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:12:50 INFO - Running setup.py install for pep8 14:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:12:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:12:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:12:50 INFO - no previously-included directories found matching 'docs/_build' 14:12:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:12:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:12:50 INFO - Cleaning up... 14:12:50 INFO - Return code: 0 14:12:50 INFO - Running post-action listener: _resource_record_post_action 14:12:50 INFO - Running post-action listener: _start_resource_monitoring 14:12:50 INFO - Starting resource monitoring. 14:12:50 INFO - ##### 14:12:50 INFO - ##### Finished create-virtualenv step (success) 14:12:50 INFO - ##### 14:12:50 INFO - ##### 14:12:50 INFO - ##### Running install step. 14:12:50 INFO - ##### 14:12:50 INFO - Running pre-action listener: _resource_record_pre_action 14:12:50 INFO - Running main action method: install 14:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:12:50 INFO - Reading from file tmpfile_stdout 14:12:50 INFO - Detecting whether we're running mozinstall >=1.0... 14:12:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:12:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:12:50 INFO - Reading from file tmpfile_stdout 14:12:50 INFO - Output received: 14:12:50 INFO - Usage: mozinstall [options] installer 14:12:50 INFO - Options: 14:12:50 INFO - -h, --help show this help message and exit 14:12:50 INFO - -d DEST, --destination=DEST 14:12:50 INFO - Directory to install application into. [default: 14:12:50 INFO - "/builds/slave/test"] 14:12:50 INFO - --app=APP Application being installed. [default: firefox] 14:12:50 INFO - mkdir: /builds/slave/test/build/application 14:12:50 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'] 14:12:50 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 14:13:06 INFO - Reading from file tmpfile_stdout 14:13:06 INFO - Output received: 14:13:06 INFO - /builds/slave/test/build/application/firefox/firefox 14:13:06 INFO - Running post-action listener: _resource_record_post_action 14:13:06 INFO - ##### 14:13:06 INFO - ##### Finished install step (success) 14:13:06 INFO - ##### 14:13:06 INFO - ##### 14:13:06 INFO - ##### Running run-tests step. 14:13:06 INFO - ##### 14:13:06 INFO - Running pre-action listener: _resource_record_pre_action 14:13:06 INFO - Running main action method: run_tests 14:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:13:06 INFO - Python 2.7.3 14:13:06 INFO - Return code: 0 14:13:06 INFO - grabbing minidump binary from tooltool 14:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:13:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a389c0>, '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 0x1a398c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a39d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:13:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:13:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:13:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:13:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:13:06 INFO - Return code: 0 14:13:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:13:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:13:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:13:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:13:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:13:07 INFO - Return code: 0 14:13:07 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/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 14:13:07 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/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 14:13:07 INFO - Using env: {'DISPLAY': ':0', 14:13:07 INFO - 'HOME': '/home/cltbld', 14:13:07 INFO - 'LANG': 'en_US.UTF-8', 14:13:07 INFO - 'LANGUAGE': 'en_US:en', 14:13:07 INFO - 'LOGNAME': 'cltbld', 14:13:07 INFO - 'MAIL': '/var/mail/cltbld', 14:13:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:13:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:13:07 INFO - 'MOZ_NO_REMOTE': '1', 14:13:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:13:07 INFO - 'NO_EM_RESTART': '1', 14:13:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:13:07 INFO - 'PWD': '/builds/slave/test', 14:13:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:13:07 INFO - 'SHELL': '/bin/bash', 14:13:07 INFO - 'SHLVL': '1', 14:13:07 INFO - 'TERM': 'linux', 14:13:07 INFO - 'TMOUT': '86400', 14:13:07 INFO - 'USER': 'cltbld', 14:13:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273', 14:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:13:07 INFO - '_': '/tools/buildbot/bin/python'} 14:13:07 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/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 14:13:07 INFO - mozversion application_buildid: 20160523133154 14:13:07 INFO - mozversion application_changeset: a132c5d3fcac17034d38b3191a611440943c5425 14:13:07 INFO - mozversion application_display_name: Nightly 14:13:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:13:07 INFO - mozversion application_name: Firefox 14:13:07 INFO - mozversion application_remotingname: firefox 14:13:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:13:07 INFO - mozversion application_vendor: Mozilla 14:13:07 INFO - mozversion application_version: 49.0a1 14:13:07 INFO - mozversion platform_buildid: 20160523133154 14:13:07 INFO - mozversion platform_changeset: a132c5d3fcac17034d38b3191a611440943c5425 14:13:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:13:07 INFO - mozversion platform_version: 49.0a1 14:13:07 INFO - using testdate: 1464037987 14:13:07 INFO - actual date: 1464037987 14:13:07 INFO - starting webserver on 'localhost:40105' 14:13:07 INFO - SUITE-START | Running 2 tests 14:13:07 INFO - TEST-START | dromaeo_css 14:13:07 INFO - operating with platform_type : linux_ 14:13:07 INFO - Initialising browser for dromaeo_css test... 14:13:07 INFO - TEST-INFO | started process 24497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXYBelr/profile http://localhost:40105/getInfo.html) 14:13:12 INFO - PROCESS | 24497 | __metrics Screen width/height:1600/1200 14:13:12 INFO - PROCESS | 24497 | colorDepth:24 14:13:12 INFO - PROCESS | 24497 | Browser inner width/height: 1024/697 14:13:12 INFO - PROCESS | 24497 | __metrics 14:13:13 ERROR - PROCESS | 24497 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:13:14 INFO - TEST-INFO | 24497: exit 0 14:13:14 INFO - Browser initialized. 14:13:14 INFO - Running cycle 1/1 for dromaeo_css test... 14:13:14 INFO - TEST-INFO | started process 24576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXYBelr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:13:26 INFO - PROCESS | 24576 | RSS: Main: 154742784 14:13:26 INFO - PROCESS | 24576 | 14:14:18 INFO - PROCESS | 24576 | 1464038058158 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] 14:16:29 INFO - PROCESS | 24576 | Cycle 1(1): loaded http://localhost:40105/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40105/tests/dromaeo/cssquery-ext.html) 14:16:31 INFO - PROCESS | 24576 | RSS: Main: 264425472 14:16:31 INFO - PROCESS | 24576 | 14:19:33 INFO - PROCESS | 24576 | Cycle 1(1): loaded http://localhost:40105/tests/dromaeo/cssquery-ext.html (next: http://localhost:40105/tests/dromaeo/cssquery-jquery.html) 14:19:34 INFO - PROCESS | 24576 | RSS: Main: 243306496 14:19:34 INFO - PROCESS | 24576 | 14:22:36 INFO - PROCESS | 24576 | Cycle 1(1): loaded http://localhost:40105/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40105/tests/dromaeo/cssquery-mootools.html) 14:22:37 INFO - PROCESS | 24576 | RSS: Main: 239435776 14:22:37 INFO - PROCESS | 24576 | 14:25:39 INFO - PROCESS | 24576 | Cycle 1(1): loaded http://localhost:40105/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40105/tests/dromaeo/cssquery-prototype.html) 14:25:39 INFO - PROCESS | 24576 | RSS: Main: 241549312 14:25:39 INFO - PROCESS | 24576 | 14:28:42 INFO - PROCESS | 24576 | Cycle 1(1): loaded http://localhost:40105/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40105/tests/dromaeo/cssquery-yui.html) 14:28:43 INFO - PROCESS | 24576 | RSS: Main: 217436160 14:28:43 INFO - PROCESS | 24576 | 14:31:46 INFO - PROCESS | 24576 | Cycle 1(1): loaded http://localhost:40105/tests/dromaeo/cssquery-yui.html (next: http://localhost:40105/tests/dromaeo/cssquery-dojo.html) 14:31:46 INFO - PROCESS | 24576 | RSS: Main: 284413952 14:31:46 INFO - PROCESS | 24576 | 14:31:46 INFO - PROCESS | 24576 | __start_tp_report 14:31:46 INFO - PROCESS | 24576 | _x_x_mozilla_page_load 14:31:46 INFO - PROCESS | 24576 | _x_x_mozilla_page_load_details 14:31:46 INFO - PROCESS | 24576 | |i|pagename|runs| 14:31:46 INFO - PROCESS | 24576 | |0;dojo.html;2692.1250593557093;2702.5135475614384;2713.3156038100174;2728.6043523689063;2745.588161775733;4640.071985602876;4707.929381059287;4753.310769938357;4815.783289751966;4841.80632774689;4703.929441058387;4728.763561821912;4743.051389722053;4761.357216775734;4763.428388593365;4324.870253892388;4350.108227813306;4410.955890441102;4438.156750217465;4528.980979279652;4444.888877778049;4472.575105364985;4472.776361181928;4507.053518761064;4525.502194758574;4296.806643701041;4343.370211319372;4350.021245219832;4416.779161041935;4455.754933478657;4366.541513141138;4378.868633940955;4391.341298805205;4430.490493593214;4448.666350023761;4376.365427013097;4431.689781715281;4439.689221754478;4441.800118994653;4485.618722408566;4584.518625544337;4762.190427627312;4817.903641927177;4824.059308434857;4833.830815921426;5081.949180508184;5113.514216149497;5114.156164232897;5146.974265128688;5197.714125723083;5152.690838549662;5189.636725429222;5193.091209038404;5193.350831146106;5207.791688332462;4674.2988551716835;4765.523447655207;4812.831550895737;4831.178699621073;4890.021995600894;5256.763445644955;5285.788568457218;5290.709011004432;5344.118220493653;5346.625736198506;5076.111680455905;5088.287639730441;5127.974360128175;5134.897302053938;5141.562967147759;4999.875003124951;5046.142155833444;5051.898962020739;5214.2960700304975;5233.712145832016;4973.50264973507;4987.900241995212;5025.170846810235;5050.419201791768;5051.217061355495;4958.281049247839;5031.195008798574;5034.194528875362;5035.244713292962;5089.821856235014;4210.85262015828;4268.893277668083;4276.465441819772;4280.143971205771;4328.783560821947;3739.476473293741;3746;3761.586225515191;3769.830357633913;3812.5234345706785;4433.844815431445;4434.84478043267;4436.201483732894;4467.039586488921;4480.955190448054;4873.878153046131;5119.513646203604;5133.332666753298;5137.383513978271;5182.948170518246;4361.127774445124;4413.536578659258;4415.050764085737;4415.359772832921;4416.823327066882;4602;4621.792019359137;4625.976870115628;4659.44086709597;4670.089332580183;4747.406574178228;4805.423349198119;4897.902041959141;4900.95099049005;4904.460509343898;5109.744512774272;5132.948670513247;5149.176131818891;5156.9742151289;5197.766100525561;4864.829730959399;4879.243717223836;4888.242322440027;4888.31563581106;4920.901581968412;4921.458639549718;5030.673006254582;5066.36670416198;5076.162433198629;5115.64190506661;5161;5172.379314482287;5184.988927159167;5195.532402083831;5229.346331708536;5036.571891389273;5057.7724002419245;5061.8734531637;5063.443021267732;5109.897802044013;4833.10587541306;4878.341423907727;4928.654994150518;4941.481144479778;5039.26930595069;4869.415670119608;4884.755762211947;4948.307236986752;4949.82675606352;4956.132676781477;4992.051510213193;4993.325901003318;5010.348654674869;5027.296178535081;5061.013102444987;4767.332573439652;4772.021735544275;4798.04039192156;4848.8302909398;4880.194767863263 14:31:46 INFO - PROCESS | 24576 | |1;ext.html;540.1205321608611;561.851109455994;567.347550317135;579.7709904587688;596.2338395162216;42103.578964210385;43355.783221083926;43402.34896476555;43519;46729.29906051404;42872;43603;43611.563884361145;43645;43668.563314366846;7312.744053958112;7824.295813376809;8004.679812807481;9953.850692239623;10223.131033862132;10148.89851101487;10282.331648442865;10302.278840481169;10306.948465257663;10307.742306442324;10253;10326.380417174994;10326.896731032668;10342.482875856178;10343.224258180666;7488.887666685004;9958.701238962843;10321.896781032168;10347.172226221885;10351.896481035245;9861.60553577856;9912.801743965152;9946.502674866228;10284.94857525715;10287.382757034602;39486.80256598727;39865.40201896945;39893.40159897604;39931.8003409984;40030.799846000875;3092.1651154188467;3184.26761844777;3792.336341140317;3828.961710382888;3916.4125381192766;30744.38511229763;30856.845715771276;30866;30995.690043099505;32151.51772723411;3555.6266592007723;3577.302426026926;3585.3904836177653;3704.833282502294;3768.0956570423177;267852;270837;271015;271291;272399;29902.252443688645;59749.70125149346;61195.694021529605;61324.16027519092;61397;34902;35181;35309.29381412409;35312.47031294533;35341;10325.277230593787;11375.658730238107;11509.309441433541;11535.134864885;11544.88455115455;8592.5703714814;8638.697645582375;8682.348823838238;8854.601542930455;8854.778630534289;8156.062052863878;8170.468919520212;8197.50814951093;8218.547979861165;8265.586720663943;3246.788958717676;3265.2000259935994;3266.183454136466;3283.4910588858766;3300.9174770630925;882.6866462405882;890.8084761776249;935.7473482159779;998.9700308990742;1014.9847752283722;26686.599701004114;28620.570691439643;28839.855800720863;29029.56455653167;29207.269818254714;950.5769932380163;997.491279447487;1006.1598565197995;1043.113353649392;1056.5087234436023;14800.925995369955;15184.164870932205;15302.298571024327;15364.231788410534;15445.536633901002;126825;127419;128127;128386.35806820905;129292.3535382317;52559.47440525546;52577.7371113142;52656.73671631694;53129.734351328;53452.465475345525;1071.266182664877;1099.367863478503;1203.0976767424606;1210.4613447016345;1240.503798480597;28840.855795720887;29953.850230748707;30087.849560752933;30326.393472130876;30802.691973079982;44272.335914960655;44339;45114.548854511035;45166.548334517545;45170;297762;299828;300906;301124;302122;23319;25642.48715025652;26203.34491637648;26450.338741531617;27703.861480692467;43234.81182258149;43748;44533.27506927118;45072.77463612661;48821.75589122032;37850.24299513939;38830;39155;39760.80119599384;40082.39876401915;37388.439173411876;38284.42573361346;38713.80643096766;38757.41863871988;38802.223955521295;37542.43686344762;37868.431973519866;37923;38649.42025869671;38730.225395492496;34059;34076.31847363088;34235.82882085673;34589.48115778316;34942.65057349495;26485.867570662023;26490.337741556614;26650.200493985212;26703;27002.189934302 14:31:46 INFO - PROCESS | 24576 | |2;jquery.html;354.9556305461818;363.43485879457444;364.51337464484897;373.36527902565643;375.8628100743228;15596.454124105658;16956.4065257716;17111.144442777873;17502.47492575223;17507.73738393925;15213.695726085472;16062;16372.83627163728;16402.26189821458;16431.096289704063;4919.163742163832;5091.981603679261;5133.717645529495;5142.948570514303;5143.8456846294675;3730.123420996064;3883.0098324927244;5063.03802277568;5572.804951826687;5904.822855314347;5869.589128760988;5890.499307558841;5909.231799866011;5920.585559010871;5929.080992446177;5787.247657804501;5817.923684118452;5870.941290587103;5880.55895807814;6009.128676341949;3409.301093275897;4909.337239472661;5153.845384638467;5153.994970980661;5235.162374020177;19521.80478195214;20203.595928081504;20238.898805506025;20635.17459301626;20653.89673051625;1989.3136867780593;1999.5700924301345;2014.4863059919626;2146.6887301341217;2399.9040038398443;12774.425150868234;13078.215307081511;13095.279759613217;13297.933510332483;13316.400761965735;1774.2459454731688;1834.6055598046485;1842.7051671732459;1868.3927723489785;1880.3982725527837;63123;64308.67845660742;64455.67772161109;64572.67713661402;65519;9620.855687164698;9933.80132397348;10133.341332813343;10596.894031059745;10760.892391076146;13740.793888091686;13825.446982120602;13847.584572462842;13850.376733047036;13855.099418537762;6462.612243265419;6537.509686773511;6538.711450992115;6547.9672601636685;6704.195496540349;5896.262967129109;5912.674802885883;6045.093236014545;6071.544634152457;6075.2405949256345;6216.316205217422;6303.086052522359;6304.211973503312;6334.398232167937;6387.936120638734;1666.841650043244;1703;1766.0918288553817;1771.1055916762211;1795.2818872450862;855.6235256487125;969.5636963366513;978.1148061004802;979.872616559857;986.6842610364614;17404.651906962044;17436.825631743774;17461;17594.82405175932;17801.643967120843;861.6424183963585;894.5303715549388;899.2985471332371;931.417863835103;939.8214339275515;9360.251179905592;9918.065977134534;10252.43611601369;10311.432871192006;10493.632722854663;293569;408981;409189;416621;417488;75416.62291688507;77891;78015.60992195003;78746.60626696945;80046.59976700196;940.9623615055322;955.2644463762864;962.1484985787629;966.3332300712486;967.6758285974137;15527.534173974798;15818.892677512464;15867.206639668202;16216.675666486368;16250;25002;25679.614805778303;31778;32321.35357292888;34758.82620586881;44875.551244487135;46709.06581868412;48713.75643121762;50661.49338506715;51336.229956551426;7415.740449084256;7451.44114191427;7490.101187857492;7542.849143017219;7629.580373079534;8333.208345207195;10739.14086873064;11052.281601695864;11351.602693905674;11420.714482138013;9494.28792840526;9575.425474471554;9717.22262219035;9757.658481953098;10206.897931020892;9686.740723706154;9874.605015799287;9993.750156246151;10010.448380501033;10077.69766906994;9819.459929703935;10098.899011009797;10123;10200.540975656262;10284.228682848667;7173.713051478091;7306.305900939402;7539.396848252236;7558.886616700864;7747;8975.640974361213;9389.248860091313;9723.36798108149;10051.396916185053;10212.336198147097 14:31:46 INFO - PROCESS | 24576 | |3;mootools.html;1293.7606542789579;1417.2701058954638;1452.9564113076608;1588.499622618875;1746.2752957522628;6585.703643336049;7570.129435114964;7769.533827970326;7776.30013298803;8012.359011279098;7706.267904549059;7847.764567062983;7851.725189618351;7852.411069169821;7871.567063811488;2193.309107631091;2219.6781466687403;2220.04538048639;2222.7221597300336;2224.455008522906;2153.3432303147533;2177.6733489976473;2192.9122835086655;2196.4508872781803;2203.0416768705663;2160.945976350588;2183.5087105401235;2187.4859408039097;2190.6385446401323;2197.373748481683;2119.5548934723724;2124.649432843579;2128.904199311027;2130.7549631792385;2133.4133113393787;2090.8536402451837;2133.114757375687;2138.850280480367;2139.5934772393193;2139.8609090409227;7720.459567830254;7776.922230777733;7782.6886924523515;7838.764837054898;8098.554579498125;4297.785110744481;4458.4426946631675;4463.285874260136;4465.933011004838;4469.888252793674;2999.475091858938;3033.2871775132826;3046.6039414875922;3061.265296328865;3084.706952839477;905.6196397513061;907.6732376344577;920.3511524375366;921.654384598487;936.134075979716;10937.56249750017;11023.393713345762;11036.834447483214;11052.281601695864;11066;3921.8431262749173;4093.079057212163;4136.669066474675;4153.501579810442;4160.812763425653;8565.871511927326;8618.138186181332;8644.178803013703;8647.654093836176;8708.825823483496;4278.828846846153;4351.477822661301;4352.542982986804;4358.825646974085;4363.672724545671;3332.600087989457;3744.700423966076;3876.127871228951;3917.216556688674;3984.8007599619905;3383.1711230748133;3386.204242003127;3449.0515108344903;3482.2687235680282;3494.3710132175943;1017.5980487707315;1025.7281820317621;1030.7062487191265;1035.249444152983;1041.0422411381546;842.3850589070013;852.5694524265207;856.3491746272753;876.1720174435097;896.6592694775943;5169.172932330809;5299.788008479694;5424.7016414096815;5426.104692725656;5448;426.4860842684558;427.50623030399936;438.48916012844677;438.8091180336564;439.5780051150867;3710.424884142962;3845.8653947111716;3848.730588858809;3854.7687138771203;3899.122697393064;9683.32216744821;10007.349522281029;10142.087212150942;10157.542910569042;10167.796644067224;9847.704568862946;9971.351862129084;9988.60045598168;10027.899721002843;10048.899511004796;7016.508844380946;7245.203027666952;7534.0582427196605;7647.770566883002;7654.311111999836;5503.679117011969;5520.392756796668;5529.33647962231;5561.6663000220115;5642.181883626933;9060.546972651473;9147.222486088756;9166.266698663958;9237.214836738953;9253.352265341631;9068.909310906807;9300.581473833558;9369.906300936904;9376.437413755197;9405.059494050814;6030.819075427744;6728.899066514105;6879.518433709793;6885;7124.180719217356;7485;7578.014858068415;7771.417143714357;7773.067231932205;7786.454948153575;6656.83357916056;6822;6864.519483636297;7084.079069720903;7161.677724502306;6791.252962174256;6843.657817109025;6872.656367181521;7044.647767611701;7072.292770722886;6186.381361863778;6335;6348.555601107878;6444.645544494911;6457.483401327789;4416.1609294233995;4516.435445569304;4555.157295900269;4691.179043667276;4790.209615413418;4438.245498265238;4470.865874023784;4641.559051890065;4659.068186362809;4676.672632915799 14:31:46 INFO - PROCESS | 24576 | |4;prototype.html;282.7130462580481;283.8566523905428;291.23405443683095;297.44823352680777;302.92426893276684;4587.1972404829185;4754.050839155947;4763.428388593365;4821.686590371623;4829.492903245157;4575.588197062264;4697.201475749122;4743.573078422941;4746.62027037837;4748.810047598101;3771.3400154972906;3772.7547709398937;3792.2225943681547;3793.468914351993;3808.733388662795;3596.8021758803256;3630.909227269326;3757.5115235019407;3794.5256842894637;3804.8478060877533;3718.9628103719024;3754.6808521275725;3756.5725024490794;3765.7175711821587;3768.962310376902;3731.88804335869;3748.3627783276906;3753.7184711146774;3769.736118471708;3772.2078363543687;3348.430766769655;3362.6132994705677;3367.7137443317347;3370.9494357584654;3380.9661903381143;4527.4114365132655;4550.863474095782;4551.544845515455;4578.855286178456;4578.977105114486;4217.74350722362;4236.51280102789;4240.872773816791;4255.212785634668;4259.723117997351;4799.928001079952;4961.982793527318;4981.775820088104;4988.351514303117;5020.573251273646;3649.580298265707;3658.725595580342;3664.4136938089778;3666.2850744104912;3670.2292518570866;5223.276318814782;5233.241180028913;5237.554807841338;5262.552683021948;5275.393329767049;3795.8671446499793;3798.620137986179;3800.4299355096955;3801.82891769871;3807.428885667117;3654.908627284339;3833.4824798651825;3868.516435445569;3872.6514613684903;3878.827856400425;4320.567943205654;4332.1119170569955;4332.9133417332105;4341.283688191413;4341.739495630272;5009.649324547247;5022.397312322545;5029.321041659402;5039.092963266574;5065.467266366816;1242.9689257768628;1297.1244410023385;1313;1313.6847156682327;1318.756030134428;858.8625819868791;867.2108381372921;868.2923417414787;869.7564681889081;878.9252913502424;3938;3967.504061992251;3985.80070996449;4000.9199816003515;4012.4783778109245;4523.479799822997;4528.637708983273;4529.614982726505;4549.363089167519;4572.88567785808;3909.58949310324;3952;3985.3659999400106;3997.7401468904427;4029.569502826513;2289.381866895929;2389.4982053768554;2399.5320912422258;2418.851045753253;2449.155041510676;4252.149570085995;4258.552851950562;4305.105753468464;4361.956380436219;4365.236083685342;4553.317002449659;4559.407277054028;4612.907741845144;4618.861434156981;4685;4150.962259435141;4340.435743353407;4350.151720414552;4357.629601483909;4369.029060239068;4466.665000125068;4495.303227999665;4500.617447516997;4528.373543344918;4559.179347717442;4468.932966005577;4470.485894122217;4487.7980490878645;4495.21333766596;4506.954930450785;4138.57219259355;4302.22559939214;4315.956840431555;4316.424505055695;4387.363832244243;3393.202597389562;3404.7868885224802;3411.6588341166675;3418.4872269159823;3440.2259491614186;4547.727136371828;4558.658100642531;4582.425707947806;4624;4987.526185012418;4842.322074909586;4996.60027197816;4999.825006124768;5003.949960500348;5034.119029169954;4961.851144465528;4970.577500912463;4986.778239331242;4999.15014447552;5008;4802.351682522814;4908.533689299511;4914.729689867092;4957.3059771632725;4968.180250258667;5048.570871475966;5050.141475949024;5064.366954130734;5064.848054558369;5065.29085927963;4961.181405068123;4965.155923492943;4982.427020892499;4992.850214493571;4996.800127994839 14:31:46 INFO - PROCESS | 24576 | |5;yui.html;650.7917466410748;755.5391211361073;771.2441807029111;772.1583474013324;777.9264614831532;12455.937720311396;13052.412641431134;13057.281849498262;13057.869421305784;13084.869151308496;12261.509539618426;12268.079894007962;12271.754564908697;12935.935320323386;13314.267715275655;636.6148480169501;817.1297568089994;818.8444195602816;823.0247157118804;823.2302796884902;788.9644965976545;814.5845618734429;816.873384625384;819.7458787775779;820.1142765812908;840.9285210757093;841.3185319890908;841.7937605286713;847.1697736218479;847.5296210603112;661.7551505942832;818.8853560501534;840.2269911681268;840.8654615261529;841.4068082002174;615.1633778061832;616.303576958039;616.3774587666444;616.4390404731718;620.7765204526366;12390.5663301784;12437.564685236064;12490.562830300896;12491.12562120652;12499.500019999188;11710.590129345517;11799.174057815957;11883.10876684252;12299;12657.810132848015;10136.89863101367;10178.643747468803;10252.282340236112;10393.688189354332;10477.79044419115;3268.950965735516;3299.457189270581;3373.0386839750554;3377.9493307600405;3415.0096472023083;46045;46300.7684961573;46330.30504542434;46962.29556556654;48357.274640880416;9197.356185066981;9203.585838637277;9281.39670921388;9385.343025988252;9535.52322383878;16089.195540223176;16091.195440227943;16119.194040297938;16161.757573636405;16177.19114044293;6623.602583844985;6715.1740176264075;6807.591544507246;6901.171859376806;6937.895931561031;3681.3557627415094;3765.058735316171;3831.7126215533945;3876.5541962674088;3911.92176156481;2788.065997890689;2882.9711702883124;2885.92785180368;2886.5381538953666;2893.7106289371313;489.05368112702035;491.7590380713496;507.73090262161116;509.7043714645497;532.7868852459047;549.8872731090117;572.4447286132445;579.4668904607687;595.3391735173954;603.3815339277276;8439.282660973764;8639.654413823502;8641.438306510057;8674.262687671619;8779.473231606124;605.276694350256;608.9086637004485;615.237105988571;627.7018416252334;633.4868756307405;3864.4589757433982;3891.591382904754;4139.544650088548;4146.688998325138;4225.154969006211;60936.69531652313;61751;63624;63744.36255637477;63833.36166638367;52458;53100.2034969468;53440;55251.44748552463;56182.71908640512;43234.567654323684;44218.557814422085;45995;48713;50982;8343.374246931384;8488;8570.233697437921;8670;8721.258693011165;31747.36505269928;32094.03717888467;32220;32627.83794784179;33566.664333356355;39919;41450.585494144674;41693.62216967175;42290.154196916505;42433.36349954815;10947;10977.725556860823;11034.613788517363;11187.16096292765;11481.311121332747;11482;12178.939105304416;12193.756124877274;12462.813057803958;12533.874661253636;9021.954890225506;11239.325640461599;11244.493997769956;11623.070154387799;11715.1799374043;11161.665150045512;11478.253913495597;11607.187496875475;11870.940645296718;11961.880381196077;10589.364638121737;10816.4050977197;11084.501197446296;11169.776604467703;11509.827352589886;9654.372465789702;9714.125728684452;9721.562529686322;9984.900150998688;10200.183985281308;9348.906510934803;9511.809763804824;9545.140937315675;9866.950665246628;9965.800683986135 14:31:46 INFO - PROCESS | 24576 | __end_tp_report 14:31:46 INFO - PROCESS | 24576 | __start_cc_report 14:31:46 INFO - PROCESS | 24576 | _x_x_mozilla_cycle_collect,1028 14:31:46 INFO - PROCESS | 24576 | __end_cc_report 14:31:46 INFO - PROCESS | 24576 | __startTimestamp1464039106318__endTimestamp 14:31:46 INFO - PROCESS | 24576 | 14:31:46 INFO - PROCESS | 24576 | ------- Summary: start ------- 14:31:46 INFO - PROCESS | 24576 | Number of tests: 6 14:31:46 INFO - PROCESS | 24576 | 14:31:46 INFO - PROCESS | 24576 | [#0] dojo.html Cycles:165 Average:4734.77 Median:4869.42 stddev:495.41 (10.2%) stddev-sans-first:470.30 14:31:46 INFO - PROCESS | 24576 | Values: 2692.1 2702.5 2713.3 2728.6 2745.6 4640.1 4707.9 4753.3 4815.8 4841.8 4703.9 4728.8 4743.1 4761.4 4763.4 4324.9 4350.1 4411.0 4438.2 4529.0 4444.9 4472.6 4472.8 4507.1 4525.5 4296.8 4343.4 4350.0 4416.8 4455.8 4366.5 4378.9 4391.3 4430.5 4448.7 4376.4 4431.7 4439.7 4441.8 4485.6 4584.5 4762.2 4817.9 4824.1 4833.8 5081.9 5113.5 5114.2 5147.0 5197.7 5152.7 5189.6 5193.1 5193.4 5207.8 4674.3 4765.5 4812.8 4831.2 4890.0 5256.8 5285.8 5290.7 5344.1 5346.6 5076.1 5088.3 5128.0 5134.9 5141.6 4999.9 5046.1 5051.9 5214.3 5233.7 4973.5 4987.9 5025.2 5050.4 5051.2 4958.3 5031.2 5034.2 5035.2 5089.8 4210.9 4268.9 4276.5 4280.1 4328.8 3739.5 3746.0 3761.6 3769.8 3812.5 4433.8 4434.8 4436.2 4467.0 4481.0 4873.9 5119.5 5133.3 5137.4 5182.9 4361.1 4413.5 4415.1 4415.4 4416.8 4602.0 4621.8 4626.0 4659.4 4670.1 4747.4 4805.4 4897.9 4901.0 4904.5 5109.7 5132.9 5149.2 5157.0 5197.8 4864.8 4879.2 4888.2 4888.3 4920.9 4921.5 5030.7 5066.4 5076.2 5115.6 5161.0 5172.4 5185.0 5195.5 5229.3 5036.6 5057.8 5061.9 5063.4 5109.9 4833.1 4878.3 4928.7 4941.5 5039.3 4869.4 4884.8 4948.3 4949.8 4956.1 4992.1 4993.3 5010.3 5027.3 5061.0 4767.3 4772.0 4798.0 4848.8 4880.2 14:31:46 INFO - PROCESS | 24576 | 14:31:46 INFO - PROCESS | 24576 | [#1] ext.html Cycles:180 Average:40489.58 Median:35310.88 stddev:64342.89 (182.2%) stddev-sans-first:64453.47 14:31:46 INFO - PROCESS | 24576 | Values: 540.1 561.9 567.3 579.8 596.2 42103.6 43355.8 43402.3 43519.0 46729.3 42872.0 43603.0 43611.6 43645.0 43668.6 7312.7 7824.3 8004.7 9953.9 10223.1 10148.9 10282.3 10302.3 10306.9 10307.7 10253.0 10326.4 10326.9 10342.5 10343.2 7488.9 9958.7 10321.9 10347.2 10351.9 9861.6 9912.8 9946.5 10284.9 10287.4 39486.8 39865.4 39893.4 39931.8 40030.8 3092.2 3184.3 3792.3 3829.0 3916.4 30744.4 30856.8 30866.0 30995.7 32151.5 3555.6 3577.3 3585.4 3704.8 3768.1 267852.0 270837.0 271015.0 271291.0 272399.0 29902.3 59749.7 61195.7 61324.2 61397.0 34902.0 35181.0 35309.3 35312.5 35341.0 10325.3 11375.7 11509.3 11535.1 11544.9 8592.6 8638.7 8682.3 8854.6 8854.8 8156.1 8170.5 8197.5 8218.5 8265.6 3246.8 3265.2 3266.2 3283.5 3300.9 882.7 890.8 935.7 999.0 1015.0 26686.6 28620.6 28839.9 29029.6 29207.3 950.6 997.5 1006.2 1043.1 1056.5 14800.9 15184.2 15302.3 15364.2 15445.5 126825.0 127419.0 128127.0 128386.4 129292.4 52559.5 52577.7 52656.7 53129.7 53452.5 1071.3 1099.4 1203.1 1210.5 1240.5 28840.9 29953.9 30087.8 30326.4 30802.7 44272.3 44339.0 45114.5 45166.5 45170.0 297762.0 299828.0 300906.0 301124.0 302122.0 23319.0 25642.5 26203.3 26450.3 27703.9 43234.8 43748.0 44533.3 45072.8 48821.8 37850.2 38830.0 39155.0 39760.8 40082.4 37388.4 38284.4 38713.8 38757.4 38802.2 37542.4 37868.4 37923.0 38649.4 38730.2 34059.0 34076.3 34235.8 34589.5 34942.7 26485.9 26490.3 26650.2 26703.0 27002.2 14:31:46 INFO - PROCESS | 24576 | 14:31:46 INFO - PROCESS | 24576 | [#2] jquery.html Cycles:180 Average:23976.11 Median:4914.25 stddev:64629.23 (1315.1%) stddev-sans-first:64786.20 14:31:46 INFO - PROCESS | 24576 | Values: 355.0 363.4 364.5 373.4 375.9 15596.5 16956.4 17111.1 17502.5 17507.7 15213.7 16062.0 16372.8 16402.3 16431.1 4919.2 5092.0 5133.7 5142.9 5143.8 3730.1 3883.0 5063.0 5572.8 5904.8 5869.6 5890.5 5909.2 5920.6 5929.1 5787.2 5817.9 5870.9 5880.6 6009.1 3409.3 4909.3 5153.8 5154.0 5235.2 19521.8 20203.6 20238.9 20635.2 20653.9 1989.3 1999.6 2014.5 2146.7 2399.9 12774.4 13078.2 13095.3 13297.9 13316.4 1774.2 1834.6 1842.7 1868.4 1880.4 63123.0 64308.7 64455.7 64572.7 65519.0 9620.9 9933.8 10133.3 10596.9 10760.9 13740.8 13825.4 13847.6 13850.4 13855.1 6462.6 6537.5 6538.7 6548.0 6704.2 5896.3 5912.7 6045.1 6071.5 6075.2 6216.3 6303.1 6304.2 6334.4 6387.9 1666.8 1703.0 1766.1 1771.1 1795.3 855.6 969.6 978.1 979.9 986.7 17404.7 17436.8 17461.0 17594.8 17801.6 861.6 894.5 899.3 931.4 939.8 9360.3 9918.1 10252.4 10311.4 10493.6 293569.0 408981.0 409189.0 416621.0 417488.0 75416.6 77891.0 78015.6 78746.6 80046.6 941.0 955.3 962.1 966.3 967.7 15527.5 15818.9 15867.2 16216.7 16250.0 25002.0 25679.6 31778.0 32321.4 34758.8 44875.6 46709.1 48713.8 50661.5 51336.2 7415.7 7451.4 7490.1 7542.8 7629.6 8333.2 10739.1 11052.3 11351.6 11420.7 9494.3 9575.4 9717.2 9757.7 10206.9 9686.7 9874.6 9993.8 10010.4 10077.7 9819.5 10098.9 10123.0 10200.5 10284.2 7173.7 7306.3 7539.4 7558.9 7747.0 8975.6 9389.2 9723.4 10051.4 10212.3 14:31:46 INFO - PROCESS | 24576 | 14:31:46 INFO - PROCESS | 24576 | [#3] mootools.html Cycles:180 Average:5166.65 Median:4598.36 stddev:2976.93 (64.7%) stddev-sans-first:2971.06 14:31:46 INFO - PROCESS | 24576 | Values: 1293.8 1417.3 1453.0 1588.5 1746.3 6585.7 7570.1 7769.5 7776.3 8012.4 7706.3 7847.8 7851.7 7852.4 7871.6 2193.3 2219.7 2220.0 2222.7 2224.5 2153.3 2177.7 2192.9 2196.5 2203.0 2160.9 2183.5 2187.5 2190.6 2197.4 2119.6 2124.6 2128.9 2130.8 2133.4 2090.9 2133.1 2138.9 2139.6 2139.9 7720.5 7776.9 7782.7 7838.8 8098.6 4297.8 4458.4 4463.3 4465.9 4469.9 2999.5 3033.3 3046.6 3061.3 3084.7 905.6 907.7 920.4 921.7 936.1 10937.6 11023.4 11036.8 11052.3 11066.0 3921.8 4093.1 4136.7 4153.5 4160.8 8565.9 8618.1 8644.2 8647.7 8708.8 4278.8 4351.5 4352.5 4358.8 4363.7 3332.6 3744.7 3876.1 3917.2 3984.8 3383.2 3386.2 3449.1 3482.3 3494.4 1017.6 1025.7 1030.7 1035.2 1041.0 842.4 852.6 856.3 876.2 896.7 5169.2 5299.8 5424.7 5426.1 5448.0 426.5 427.5 438.5 438.8 439.6 3710.4 3845.9 3848.7 3854.8 3899.1 9683.3 10007.3 10142.1 10157.5 10167.8 9847.7 9971.4 9988.6 10027.9 10048.9 7016.5 7245.2 7534.1 7647.8 7654.3 5503.7 5520.4 5529.3 5561.7 5642.2 9060.5 9147.2 9166.3 9237.2 9253.4 9068.9 9300.6 9369.9 9376.4 9405.1 6030.8 6728.9 6879.5 6885.0 7124.2 7485.0 7578.0 7771.4 7773.1 7786.5 6656.8 6822.0 6864.5 7084.1 7161.7 6791.3 6843.7 6872.7 7044.6 7072.3 6186.4 6335.0 6348.6 6444.6 6457.5 4416.2 4516.4 4555.2 4691.2 4790.2 4438.2 4470.9 4641.6 4659.1 4676.7 14:31:46 INFO - PROCESS | 24576 | 14:31:46 INFO - PROCESS | 24576 | [#4] prototype.html Cycles:180 Average:4008.96 Median:4359.79 stddev:1139.62 (26.1%) stddev-sans-first:1107.97 14:31:46 INFO - PROCESS | 24576 | Values: 282.7 283.9 291.2 297.4 302.9 4587.2 4754.1 4763.4 4821.7 4829.5 4575.6 4697.2 4743.6 4746.6 4748.8 3771.3 3772.8 3792.2 3793.5 3808.7 3596.8 3630.9 3757.5 3794.5 3804.8 3719.0 3754.7 3756.6 3765.7 3769.0 3731.9 3748.4 3753.7 3769.7 3772.2 3348.4 3362.6 3367.7 3370.9 3381.0 4527.4 4550.9 4551.5 4578.9 4579.0 4217.7 4236.5 4240.9 4255.2 4259.7 4799.9 4962.0 4981.8 4988.4 5020.6 3649.6 3658.7 3664.4 3666.3 3670.2 5223.3 5233.2 5237.6 5262.6 5275.4 3795.9 3798.6 3800.4 3801.8 3807.4 3654.9 3833.5 3868.5 3872.7 3878.8 4320.6 4332.1 4332.9 4341.3 4341.7 5009.6 5022.4 5029.3 5039.1 5065.5 1243.0 1297.1 1313.0 1313.7 1318.8 858.9 867.2 868.3 869.8 878.9 3938.0 3967.5 3985.8 4000.9 4012.5 4523.5 4528.6 4529.6 4549.4 4572.9 3909.6 3952.0 3985.4 3997.7 4029.6 2289.4 2389.5 2399.5 2418.9 2449.2 4252.1 4258.6 4305.1 4362.0 4365.2 4553.3 4559.4 4612.9 4618.9 4685.0 4151.0 4340.4 4350.2 4357.6 4369.0 4466.7 4495.3 4500.6 4528.4 4559.2 4468.9 4470.5 4487.8 4495.2 4507.0 4138.6 4302.2 4316.0 4316.4 4387.4 3393.2 3404.8 3411.7 3418.5 3440.2 4547.7 4558.7 4582.4 4624.0 4987.5 4842.3 4996.6 4999.8 5003.9 5034.1 4961.9 4970.6 4986.8 4999.2 5008.0 4802.4 4908.5 4914.7 4957.3 4968.2 5048.6 5050.1 5064.4 5064.8 5065.3 4961.2 4965.2 4982.4 4992.9 4996.8 14:31:46 INFO - PROCESS | 24576 | 14:31:46 INFO - PROCESS | 24576 | [#5] yui.html Cycles:180 Average:13636.58 Median:46646.30 stddev:16290.18 (34.9%) stddev-sans-first:16306.69 14:31:46 INFO - PROCESS | 24576 | Values: 650.8 755.5 771.2 772.2 777.9 12455.9 13052.4 13057.3 13057.9 13084.9 12261.5 12268.1 12271.8 12935.9 13314.3 636.6 817.1 818.8 823.0 823.2 789.0 814.6 816.9 819.7 820.1 840.9 841.3 841.8 847.2 847.5 661.8 818.9 840.2 840.9 841.4 615.2 616.3 616.4 616.4 620.8 12390.6 12437.6 12490.6 12491.1 12499.5 11710.6 11799.2 11883.1 12299.0 12657.8 10136.9 10178.6 10252.3 10393.7 10477.8 3269.0 3299.5 3373.0 3377.9 3415.0 46045.0 46300.8 46330.3 46962.3 48357.3 9197.4 9203.6 9281.4 9385.3 9535.5 16089.2 16091.2 16119.2 16161.8 16177.2 6623.6 6715.2 6807.6 6901.2 6937.9 3681.4 3765.1 3831.7 3876.6 3911.9 2788.1 2883.0 2885.9 2886.5 2893.7 489.1 491.8 507.7 509.7 532.8 549.9 572.4 579.5 595.3 603.4 8439.3 8639.7 8641.4 8674.3 8779.5 605.3 608.9 615.2 627.7 633.5 3864.5 3891.6 4139.5 4146.7 4225.2 60936.7 61751.0 63624.0 63744.4 63833.4 52458.0 53100.2 53440.0 55251.4 56182.7 43234.6 44218.6 45995.0 48713.0 50982.0 8343.4 8488.0 8570.2 8670.0 8721.3 31747.4 32094.0 32220.0 32627.8 33566.7 39919.0 41450.6 41693.6 42290.2 42433.4 10947.0 10977.7 11034.6 11187.2 11481.3 11482.0 12178.9 12193.8 12462.8 12533.9 9022.0 11239.3 11244.5 11623.1 11715.2 11161.7 11478.3 11607.2 11870.9 11961.9 10589.4 10816.4 11084.5 11169.8 11509.8 9654.4 9714.1 9721.6 9984.9 10200.2 9348.9 9511.8 9545.1 9867.0 9965.8 14:31:46 INFO - PROCESS | 24576 | -------- Summary: end -------- 14:31:46 INFO - PROCESS | 24576 | 14:31:46 INFO - TEST-INFO | 24576: exit 0 14:31:46 INFO - TEST-OK | dromaeo_css | took 1119195ms 14:31:46 INFO - TEST-START | kraken 14:31:46 INFO - operating with platform_type : linux_ 14:31:46 INFO - Initialising browser for kraken test... 14:31:47 INFO - TEST-INFO | started process 24759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTmoXf_/profile http://localhost:40105/getInfo.html) 14:31:51 INFO - PROCESS | 24759 | __metrics Screen width/height:1600/1200 14:31:51 INFO - PROCESS | 24759 | colorDepth:24 14:31:51 INFO - PROCESS | 24759 | Browser inner width/height: 1024/697 14:31:51 INFO - PROCESS | 24759 | __metrics 14:31:52 ERROR - PROCESS | 24759 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:31:52 INFO - TEST-INFO | 24759: exit 0 14:31:52 INFO - Browser initialized. 14:31:52 INFO - Running cycle 1/1 for kraken test... 14:31:52 INFO - TEST-INFO | started process 24837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTmoXf_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:32:04 INFO - PROCESS | 24837 | RSS: Main: 155070464 14:32:04 INFO - PROCESS | 24837 | 14:32:07 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40105/tests/kraken/driver.html?testName=audio-beat-detection) 14:32:08 INFO - PROCESS | 24837 | RSS: Main: 210608128 14:32:08 INFO - PROCESS | 24837 | 14:32:11 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40105/tests/kraken/driver.html?testName=audio-dft) 14:32:12 INFO - PROCESS | 24837 | RSS: Main: 198688768 14:32:12 INFO - PROCESS | 24837 | 14:32:15 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40105/tests/kraken/driver.html?testName=audio-fft) 14:32:16 INFO - PROCESS | 24837 | RSS: Main: 268165120 14:32:16 INFO - PROCESS | 24837 | 14:32:18 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40105/tests/kraken/driver.html?testName=audio-oscillator) 14:32:19 INFO - PROCESS | 24837 | RSS: Main: 177664000 14:32:19 INFO - PROCESS | 24837 | 14:32:21 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40105/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:32:21 INFO - PROCESS | 24837 | RSS: Main: 180985856 14:32:21 INFO - PROCESS | 24837 | 14:32:25 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40105/tests/kraken/driver.html?testName=imaging-darkroom) 14:32:25 INFO - PROCESS | 24837 | RSS: Main: 216764416 14:32:25 INFO - PROCESS | 24837 | 14:32:29 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40105/tests/kraken/driver.html?testName=imaging-desaturate) 14:32:30 INFO - PROCESS | 24837 | RSS: Main: 214720512 14:32:30 INFO - PROCESS | 24837 | 14:32:33 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40105/tests/kraken/driver.html?testName=json-parse-financial) 14:32:34 INFO - PROCESS | 24837 | RSS: Main: 215728128 14:32:34 INFO - PROCESS | 24837 | 14:32:35 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40105/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:32:36 INFO - PROCESS | 24837 | RSS: Main: 207872000 14:32:36 INFO - PROCESS | 24837 | 14:32:38 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40105/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:32:39 INFO - PROCESS | 24837 | RSS: Main: 213639168 14:32:39 INFO - PROCESS | 24837 | 14:32:41 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40105/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:32:42 INFO - PROCESS | 24837 | RSS: Main: 216920064 14:32:42 INFO - PROCESS | 24837 | 14:32:44 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:32:45 INFO - PROCESS | 24837 | RSS: Main: 220344320 14:32:45 INFO - PROCESS | 24837 | 14:32:48 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:32:49 INFO - PROCESS | 24837 | RSS: Main: 217858048 14:32:49 INFO - PROCESS | 24837 | 14:32:50 INFO - PROCESS | 24837 | Cycle 1(1): loaded http://localhost:40105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40105/tests/kraken/driver.html?testName=ai-astar) 14:32:51 INFO - PROCESS | 24837 | RSS: Main: 264265728 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | __start_tp_report 14:32:51 INFO - PROCESS | 24837 | _x_x_mozilla_page_load 14:32:51 INFO - PROCESS | 24837 | _x_x_mozilla_page_load_details 14:32:51 INFO - PROCESS | 24837 | |i|pagename|runs| 14:32:51 INFO - PROCESS | 24837 | |0;ai-astar;115;109;116;116;114;114;113;114;116;115 14:32:51 INFO - PROCESS | 24837 | |1;audio-beat-detection;155;129;130;218;138;130;160;136;167;136 14:32:51 INFO - PROCESS | 24837 | |2;audio-dft;160;160;162;164;162;162;162;162;163;162 14:32:51 INFO - PROCESS | 24837 | |3;audio-fft;77;76;75;141;75;75;74;75;121;74 14:32:51 INFO - PROCESS | 24837 | |4;audio-oscillator;94;94;158;92;95;94;121;93;103;128 14:32:51 INFO - PROCESS | 24837 | |5;imaging-gaussian-blur;116;117;117;116;117;117;117;117;117;117 14:32:51 INFO - PROCESS | 24837 | |6;imaging-darkroom;146;145;146;146;146;146;145;146;145;146 14:32:51 INFO - PROCESS | 24837 | |7;imaging-desaturate;94;96;97;95;94;95;95;94;95;94 14:32:51 INFO - PROCESS | 24837 | |8;json-parse-financial;66;66;65;66;65;66;65;74;65;65 14:32:51 INFO - PROCESS | 24837 | |9;json-stringify-tinderbox;65;66;66;65;66;65;66;65;66;75 14:32:51 INFO - PROCESS | 24837 | |10;stanford-crypto-aes;83;90;88;85;88;83;90;84;142;84 14:32:51 INFO - PROCESS | 24837 | |11;stanford-crypto-ccm;137;138;130;130;130;129;138;138;159;131 14:32:51 INFO - PROCESS | 24837 | |12;stanford-crypto-pbkdf2;171;170;176;181;179;171;175;174;171;174 14:32:51 INFO - PROCESS | 24837 | |13;stanford-crypto-sha256-iterative;68;67;68;66;66;65;66;65;67;66 14:32:51 INFO - PROCESS | 24837 | __end_tp_report 14:32:51 INFO - PROCESS | 24837 | __start_cc_report 14:32:51 INFO - PROCESS | 24837 | _x_x_mozilla_cycle_collect,2070 14:32:51 INFO - PROCESS | 24837 | __end_cc_report 14:32:51 INFO - PROCESS | 24837 | __startTimestamp1464039171170__endTimestamp 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | ------- Summary: start ------- 14:32:51 INFO - PROCESS | 24837 | Number of tests: 14 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:2.10 (1.8%) stddev-sans-first:2.20 14:32:51 INFO - PROCESS | 24837 | Values: 115.0 109.0 116.0 116.0 114.0 114.0 113.0 114.0 116.0 115.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:146.50 stddev:27.52 (18.8%) stddev-sans-first:29.12 14:32:51 INFO - PROCESS | 24837 | Values: 155.0 129.0 130.0 218.0 138.0 130.0 160.0 136.0 167.0 136.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.05 14:32:51 INFO - PROCESS | 24837 | Values: 160.0 160.0 162.0 164.0 162.0 162.0 162.0 162.0 163.0 162.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#3] audio-fft Cycles:10 Average:86.30 Median:75.00 stddev:24.04 (32.1%) stddev-sans-first:25.26 14:32:51 INFO - PROCESS | 24837 | Values: 77.0 76.0 75.0 141.0 75.0 75.0 74.0 75.0 121.0 74.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:93.50 stddev:21.92 (23.4%) stddev-sans-first:22.73 14:32:51 INFO - PROCESS | 24837 | Values: 94.0 94.0 158.0 92.0 95.0 94.0 121.0 93.0 103.0 128.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:32:51 INFO - PROCESS | 24837 | Values: 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:32:51 INFO - PROCESS | 24837 | Values: 146.0 145.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 14:32:51 INFO - PROCESS | 24837 | Values: 94.0 96.0 97.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:66.00 stddev:2.75 (4.2%) stddev-sans-first:2.92 14:32:51 INFO - PROCESS | 24837 | Values: 66.0 66.0 65.0 66.0 65.0 66.0 65.0 74.0 65.0 65.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:3.03 (4.6%) stddev-sans-first:3.16 14:32:51 INFO - PROCESS | 24837 | Values: 65.0 66.0 66.0 65.0 66.0 65.0 66.0 65.0 66.0 75.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:86.50 stddev:17.88 (20.7%) stddev-sans-first:18.69 14:32:51 INFO - PROCESS | 24837 | Values: 83.0 90.0 88.0 85.0 88.0 83.0 90.0 84.0 142.0 84.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:137.50 stddev:8.97 (6.5%) stddev-sans-first:9.51 14:32:51 INFO - PROCESS | 24837 | Values: 137.0 138.0 130.0 130.0 130.0 129.0 138.0 138.0 159.0 131.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.50 stddev:3.68 (2.1%) stddev-sans-first:3.71 14:32:51 INFO - PROCESS | 24837 | Values: 171.0 170.0 176.0 181.0 179.0 171.0 175.0 174.0 171.0 174.0 14:32:51 INFO - PROCESS | 24837 | 14:32:51 INFO - PROCESS | 24837 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.07 (1.6%) stddev-sans-first:0.97 14:32:51 INFO - PROCESS | 24837 | Values: 68.0 67.0 68.0 66.0 66.0 65.0 66.0 65.0 67.0 66.0 14:32:51 INFO - PROCESS | 24837 | -------- Summary: end -------- 14:32:51 INFO - PROCESS | 24837 | 14:32:52 INFO - TEST-INFO | 24837: exit 0 14:32:52 INFO - TEST-OK | kraken | took 65233ms 14:32:52 INFO - SUITE-END | took 1184s 14:32:52 INFO - Completed test suite (00:19:44) 14:32:52 INFO - javascript benchmark 14:32:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2692.1250593557093, 2702.5135475614384, 2713.3156038100174, 2728.6043523689063, 2745.588161775733, 4640.071985602876, 4707.929381059287, 4753.310769938357, 4815.783289751966, 4841.80632774689, 4703.929441058387, 4728.763561821912, 4743.051389722053, 4761.357216775734, 4763.428388593365, 4324.870253892388, 4350.108227813306, 4410.955890441102, 4438.156750217465, 4528.980979279652, 4444.888877778049, 4472.575105364985, 4472.776361181928, 4507.053518761064, 4525.502194758574, 4296.806643701041, 4343.370211319372, 4350.021245219832, 4416.779161041935, 4455.754933478657, 4366.541513141138, 4378.868633940955, 4391.341298805205, 4430.490493593214, 4448.666350023761, 4376.365427013097, 4431.689781715281, 4439.689221754478, 4441.800118994653, 4485.618722408566, 4584.518625544337, 4762.190427627312, 4817.903641927177, 4824.059308434857, 4833.830815921426, 5081.949180508184, 5113.514216149497, 5114.156164232897, 5146.974265128688, 5197.714125723083, 5152.690838549662, 5189.636725429222, 5193.091209038404, 5193.350831146106, 5207.791688332462, 4674.2988551716835, 4765.523447655207, 4812.831550895737, 4831.178699621073, 4890.021995600894, 5256.763445644955, 5285.788568457218, 5290.709011004432, 5344.118220493653, 5346.625736198506, 5076.111680455905, 5088.287639730441, 5127.974360128175, 5134.897302053938, 5141.562967147759, 4999.875003124951, 5046.142155833444, 5051.898962020739, 5214.2960700304975, 5233.712145832016, 4973.50264973507, 4987.900241995212, 5025.170846810235, 5050.419201791768, 5051.217061355495, 4958.281049247839, 5031.195008798574, 5034.194528875362, 5035.244713292962, 5089.821856235014, 4210.85262015828, 4268.893277668083, 4276.465441819772, 4280.143971205771, 4328.783560821947, 3739.476473293741, 3746.0, 3761.586225515191, 3769.830357633913, 3812.5234345706785, 4433.844815431445, 4434.84478043267, 4436.201483732894, 4467.039586488921, 4480.955190448054, 4873.878153046131, 5119.513646203604, 5133.332666753298, 5137.383513978271, 5182.948170518246, 4361.127774445124, 4413.536578659258, 4415.050764085737, 4415.359772832921, 4416.823327066882, 4602.0, 4621.792019359137, 4625.976870115628, 4659.44086709597, 4670.089332580183, 4747.406574178228, 4805.423349198119, 4897.902041959141, 4900.95099049005, 4904.460509343898, 5109.744512774272, 5132.948670513247, 5149.176131818891, 5156.9742151289, 5197.766100525561, 4864.829730959399, 4879.243717223836, 4888.242322440027, 4888.31563581106, 4920.901581968412, 4921.458639549718, 5030.673006254582, 5066.36670416198, 5076.162433198629, 5115.64190506661, 5161.0, 5172.379314482287, 5184.988927159167, 5195.532402083831, 5229.346331708536, 5036.571891389273, 5057.7724002419245, 5061.8734531637, 5063.443021267732, 5109.897802044013, 4833.10587541306, 4878.341423907727, 4928.654994150518, 4941.481144479778, 5039.26930595069, 4869.415670119608, 4884.755762211947, 4948.307236986752, 4949.82675606352, 4956.132676781477, 4992.051510213193, 4993.325901003318, 5010.348654674869, 5027.296178535081, 5061.013102444987, 4767.332573439652, 4772.021735544275, 4798.04039192156, 4848.8302909398, 4880.194767863263], "value": 4703.569028328122, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.1205321608611, 561.851109455994, 567.347550317135, 579.7709904587688, 596.2338395162216, 42103.578964210385, 43355.783221083926, 43402.34896476555, 43519.0, 46729.29906051404, 42872.0, 43603.0, 43611.563884361145, 43645.0, 43668.563314366846, 7312.744053958112, 7824.295813376809, 8004.679812807481, 9953.850692239623, 10223.131033862132, 10148.89851101487, 10282.331648442865, 10302.278840481169, 10306.948465257663, 10307.742306442324, 10253.0, 10326.380417174994, 10326.896731032668, 10342.482875856178, 10343.224258180666, 7488.887666685004, 9958.701238962843, 10321.896781032168, 10347.172226221885, 10351.896481035245, 9861.60553577856, 9912.801743965152, 9946.502674866228, 10284.94857525715, 10287.382757034602, 39486.80256598727, 39865.40201896945, 39893.40159897604, 39931.8003409984, 40030.799846000875, 3092.1651154188467, 3184.26761844777, 3792.336341140317, 3828.961710382888, 3916.4125381192766, 30744.38511229763, 30856.845715771276, 30866.0, 30995.690043099505, 32151.51772723411, 3555.6266592007723, 3577.302426026926, 3585.3904836177653, 3704.833282502294, 3768.0956570423177, 267852.0, 270837.0, 271015.0, 271291.0, 272399.0, 29902.252443688645, 59749.70125149346, 61195.694021529605, 61324.16027519092, 61397.0, 34902.0, 35181.0, 35309.29381412409, 35312.47031294533, 35341.0, 10325.277230593787, 11375.658730238107, 11509.309441433541, 11535.134864885, 11544.88455115455, 8592.5703714814, 8638.697645582375, 8682.348823838238, 8854.601542930455, 8854.778630534289, 8156.062052863878, 8170.468919520212, 8197.50814951093, 8218.547979861165, 8265.586720663943, 3246.788958717676, 3265.2000259935994, 3266.183454136466, 3283.4910588858766, 3300.9174770630925, 882.6866462405882, 890.8084761776249, 935.7473482159779, 998.9700308990742, 1014.9847752283722, 26686.599701004114, 28620.570691439643, 28839.855800720863, 29029.56455653167, 29207.269818254714, 950.5769932380163, 997.491279447487, 1006.1598565197995, 1043.113353649392, 1056.5087234436023, 14800.925995369955, 15184.164870932205, 15302.298571024327, 15364.231788410534, 15445.536633901002, 126825.0, 127419.0, 128127.0, 128386.35806820905, 129292.3535382317, 52559.47440525546, 52577.7371113142, 52656.73671631694, 53129.734351328, 53452.465475345525, 1071.266182664877, 1099.367863478503, 1203.0976767424606, 1210.4613447016345, 1240.503798480597, 28840.855795720887, 29953.850230748707, 30087.849560752933, 30326.393472130876, 30802.691973079982, 44272.335914960655, 44339.0, 45114.548854511035, 45166.548334517545, 45170.0, 297762.0, 299828.0, 300906.0, 301124.0, 302122.0, 23319.0, 25642.48715025652, 26203.34491637648, 26450.338741531617, 27703.861480692467, 43234.81182258149, 43748.0, 44533.27506927118, 45072.77463612661, 48821.75589122032, 37850.24299513939, 38830.0, 39155.0, 39760.80119599384, 40082.39876401915, 37388.439173411876, 38284.42573361346, 38713.80643096766, 38757.41863871988, 38802.223955521295, 37542.43686344762, 37868.431973519866, 37923.0, 38649.42025869671, 38730.225395492496, 34059.0, 34076.31847363088, 34235.82882085673, 34589.48115778316, 34942.65057349495, 26485.867570662023, 26490.337741556614, 26650.200493985212, 26703.0, 27002.189934302], "value": 16939.45365422427, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.9556305461818, 363.43485879457444, 364.51337464484897, 373.36527902565643, 375.8628100743228, 15596.454124105658, 16956.4065257716, 17111.144442777873, 17502.47492575223, 17507.73738393925, 15213.695726085472, 16062.0, 16372.83627163728, 16402.26189821458, 16431.096289704063, 4919.163742163832, 5091.981603679261, 5133.717645529495, 5142.948570514303, 5143.8456846294675, 3730.123420996064, 3883.0098324927244, 5063.03802277568, 5572.804951826687, 5904.822855314347, 5869.589128760988, 5890.499307558841, 5909.231799866011, 5920.585559010871, 5929.080992446177, 5787.247657804501, 5817.923684118452, 5870.941290587103, 5880.55895807814, 6009.128676341949, 3409.301093275897, 4909.337239472661, 5153.845384638467, 5153.994970980661, 5235.162374020177, 19521.80478195214, 20203.595928081504, 20238.898805506025, 20635.17459301626, 20653.89673051625, 1989.3136867780593, 1999.5700924301345, 2014.4863059919626, 2146.6887301341217, 2399.9040038398443, 12774.425150868234, 13078.215307081511, 13095.279759613217, 13297.933510332483, 13316.400761965735, 1774.2459454731688, 1834.6055598046485, 1842.7051671732459, 1868.3927723489785, 1880.3982725527837, 63123.0, 64308.67845660742, 64455.67772161109, 64572.67713661402, 65519.0, 9620.855687164698, 9933.80132397348, 10133.341332813343, 10596.894031059745, 10760.892391076146, 13740.793888091686, 13825.446982120602, 13847.584572462842, 13850.376733047036, 13855.099418537762, 6462.612243265419, 6537.509686773511, 6538.711450992115, 6547.9672601636685, 6704.195496540349, 5896.262967129109, 5912.674802885883, 6045.093236014545, 6071.544634152457, 6075.2405949256345, 6216.316205217422, 6303.086052522359, 6304.211973503312, 6334.398232167937, 6387.936120638734, 1666.841650043244, 1703.0, 1766.0918288553817, 1771.1055916762211, 1795.2818872450862, 855.6235256487125, 969.5636963366513, 978.1148061004802, 979.872616559857, 986.6842610364614, 17404.651906962044, 17436.825631743774, 17461.0, 17594.82405175932, 17801.643967120843, 861.6424183963585, 894.5303715549388, 899.2985471332371, 931.417863835103, 939.8214339275515, 9360.251179905592, 9918.065977134534, 10252.43611601369, 10311.432871192006, 10493.632722854663, 293569.0, 408981.0, 409189.0, 416621.0, 417488.0, 75416.62291688507, 77891.0, 78015.60992195003, 78746.60626696945, 80046.59976700196, 940.9623615055322, 955.2644463762864, 962.1484985787629, 966.3332300712486, 967.6758285974137, 15527.534173974798, 15818.892677512464, 15867.206639668202, 16216.675666486368, 16250.0, 25002.0, 25679.614805778303, 31778.0, 32321.35357292888, 34758.82620586881, 44875.551244487135, 46709.06581868412, 48713.75643121762, 50661.49338506715, 51336.229956551426, 7415.740449084256, 7451.44114191427, 7490.101187857492, 7542.849143017219, 7629.580373079534, 8333.208345207195, 10739.14086873064, 11052.281601695864, 11351.602693905674, 11420.714482138013, 9494.28792840526, 9575.425474471554, 9717.22262219035, 9757.658481953098, 10206.897931020892, 9686.740723706154, 9874.605015799287, 9993.750156246151, 10010.448380501033, 10077.69766906994, 9819.459929703935, 10098.899011009797, 10123.0, 10200.540975656262, 10284.228682848667, 7173.713051478091, 7306.305900939402, 7539.396848252236, 7558.886616700864, 7747.0, 8975.640974361213, 9389.248860091313, 9723.36798108149, 10051.396916185053, 10212.336198147097], "value": 8242.514977294692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.7606542789579, 1417.2701058954638, 1452.9564113076608, 1588.499622618875, 1746.2752957522628, 6585.703643336049, 7570.129435114964, 7769.533827970326, 7776.30013298803, 8012.359011279098, 7706.267904549059, 7847.764567062983, 7851.725189618351, 7852.411069169821, 7871.567063811488, 2193.309107631091, 2219.6781466687403, 2220.04538048639, 2222.7221597300336, 2224.455008522906, 2153.3432303147533, 2177.6733489976473, 2192.9122835086655, 2196.4508872781803, 2203.0416768705663, 2160.945976350588, 2183.5087105401235, 2187.4859408039097, 2190.6385446401323, 2197.373748481683, 2119.5548934723724, 2124.649432843579, 2128.904199311027, 2130.7549631792385, 2133.4133113393787, 2090.8536402451837, 2133.114757375687, 2138.850280480367, 2139.5934772393193, 2139.8609090409227, 7720.459567830254, 7776.922230777733, 7782.6886924523515, 7838.764837054898, 8098.554579498125, 4297.785110744481, 4458.4426946631675, 4463.285874260136, 4465.933011004838, 4469.888252793674, 2999.475091858938, 3033.2871775132826, 3046.6039414875922, 3061.265296328865, 3084.706952839477, 905.6196397513061, 907.6732376344577, 920.3511524375366, 921.654384598487, 936.134075979716, 10937.56249750017, 11023.393713345762, 11036.834447483214, 11052.281601695864, 11066.0, 3921.8431262749173, 4093.079057212163, 4136.669066474675, 4153.501579810442, 4160.812763425653, 8565.871511927326, 8618.138186181332, 8644.178803013703, 8647.654093836176, 8708.825823483496, 4278.828846846153, 4351.477822661301, 4352.542982986804, 4358.825646974085, 4363.672724545671, 3332.600087989457, 3744.700423966076, 3876.127871228951, 3917.216556688674, 3984.8007599619905, 3383.1711230748133, 3386.204242003127, 3449.0515108344903, 3482.2687235680282, 3494.3710132175943, 1017.5980487707315, 1025.7281820317621, 1030.7062487191265, 1035.249444152983, 1041.0422411381546, 842.3850589070013, 852.5694524265207, 856.3491746272753, 876.1720174435097, 896.6592694775943, 5169.172932330809, 5299.788008479694, 5424.7016414096815, 5426.104692725656, 5448.0, 426.4860842684558, 427.50623030399936, 438.48916012844677, 438.8091180336564, 439.5780051150867, 3710.424884142962, 3845.8653947111716, 3848.730588858809, 3854.7687138771203, 3899.122697393064, 9683.32216744821, 10007.349522281029, 10142.087212150942, 10157.542910569042, 10167.796644067224, 9847.704568862946, 9971.351862129084, 9988.60045598168, 10027.899721002843, 10048.899511004796, 7016.508844380946, 7245.203027666952, 7534.0582427196605, 7647.770566883002, 7654.311111999836, 5503.679117011969, 5520.392756796668, 5529.33647962231, 5561.6663000220115, 5642.181883626933, 9060.546972651473, 9147.222486088756, 9166.266698663958, 9237.214836738953, 9253.352265341631, 9068.909310906807, 9300.581473833558, 9369.906300936904, 9376.437413755197, 9405.059494050814, 6030.819075427744, 6728.899066514105, 6879.518433709793, 6885.0, 7124.180719217356, 7485.0, 7578.014858068415, 7771.417143714357, 7773.067231932205, 7786.454948153575, 6656.83357916056, 6822.0, 6864.519483636297, 7084.079069720903, 7161.677724502306, 6791.252962174256, 6843.657817109025, 6872.656367181521, 7044.647767611701, 7072.292770722886, 6186.381361863778, 6335.0, 6348.555601107878, 6444.645544494911, 6457.483401327789, 4416.1609294233995, 4516.435445569304, 4555.157295900269, 4691.179043667276, 4790.209615413418, 4438.245498265238, 4470.865874023784, 4641.559051890065, 4659.068186362809, 4676.672632915799], "value": 4064.2300854818427, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.7130462580481, 283.8566523905428, 291.23405443683095, 297.44823352680777, 302.92426893276684, 4587.1972404829185, 4754.050839155947, 4763.428388593365, 4821.686590371623, 4829.492903245157, 4575.588197062264, 4697.201475749122, 4743.573078422941, 4746.62027037837, 4748.810047598101, 3771.3400154972906, 3772.7547709398937, 3792.2225943681547, 3793.468914351993, 3808.733388662795, 3596.8021758803256, 3630.909227269326, 3757.5115235019407, 3794.5256842894637, 3804.8478060877533, 3718.9628103719024, 3754.6808521275725, 3756.5725024490794, 3765.7175711821587, 3768.962310376902, 3731.88804335869, 3748.3627783276906, 3753.7184711146774, 3769.736118471708, 3772.2078363543687, 3348.430766769655, 3362.6132994705677, 3367.7137443317347, 3370.9494357584654, 3380.9661903381143, 4527.4114365132655, 4550.863474095782, 4551.544845515455, 4578.855286178456, 4578.977105114486, 4217.74350722362, 4236.51280102789, 4240.872773816791, 4255.212785634668, 4259.723117997351, 4799.928001079952, 4961.982793527318, 4981.775820088104, 4988.351514303117, 5020.573251273646, 3649.580298265707, 3658.725595580342, 3664.4136938089778, 3666.2850744104912, 3670.2292518570866, 5223.276318814782, 5233.241180028913, 5237.554807841338, 5262.552683021948, 5275.393329767049, 3795.8671446499793, 3798.620137986179, 3800.4299355096955, 3801.82891769871, 3807.428885667117, 3654.908627284339, 3833.4824798651825, 3868.516435445569, 3872.6514613684903, 3878.827856400425, 4320.567943205654, 4332.1119170569955, 4332.9133417332105, 4341.283688191413, 4341.739495630272, 5009.649324547247, 5022.397312322545, 5029.321041659402, 5039.092963266574, 5065.467266366816, 1242.9689257768628, 1297.1244410023385, 1313.0, 1313.6847156682327, 1318.756030134428, 858.8625819868791, 867.2108381372921, 868.2923417414787, 869.7564681889081, 878.9252913502424, 3938.0, 3967.504061992251, 3985.80070996449, 4000.9199816003515, 4012.4783778109245, 4523.479799822997, 4528.637708983273, 4529.614982726505, 4549.363089167519, 4572.88567785808, 3909.58949310324, 3952.0, 3985.3659999400106, 3997.7401468904427, 4029.569502826513, 2289.381866895929, 2389.4982053768554, 2399.5320912422258, 2418.851045753253, 2449.155041510676, 4252.149570085995, 4258.552851950562, 4305.105753468464, 4361.956380436219, 4365.236083685342, 4553.317002449659, 4559.407277054028, 4612.907741845144, 4618.861434156981, 4685.0, 4150.962259435141, 4340.435743353407, 4350.151720414552, 4357.629601483909, 4369.029060239068, 4466.665000125068, 4495.303227999665, 4500.617447516997, 4528.373543344918, 4559.179347717442, 4468.932966005577, 4470.485894122217, 4487.7980490878645, 4495.21333766596, 4506.954930450785, 4138.57219259355, 4302.22559939214, 4315.956840431555, 4316.424505055695, 4387.363832244243, 3393.202597389562, 3404.7868885224802, 3411.6588341166675, 3418.4872269159823, 3440.2259491614186, 4547.727136371828, 4558.658100642531, 4582.425707947806, 4624.0, 4987.526185012418, 4842.322074909586, 4996.60027197816, 4999.825006124768, 5003.949960500348, 5034.119029169954, 4961.851144465528, 4970.577500912463, 4986.778239331242, 4999.15014447552, 5008.0, 4802.351682522814, 4908.533689299511, 4914.729689867092, 4957.3059771632725, 4968.180250258667, 5048.570871475966, 5050.141475949024, 5064.366954130734, 5064.848054558369, 5065.29085927963, 4961.181405068123, 4965.155923492943, 4982.427020892499, 4992.850214493571, 4996.800127994839], "value": 3652.121601876019, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.7917466410748, 755.5391211361073, 771.2441807029111, 772.1583474013324, 777.9264614831532, 12455.937720311396, 13052.412641431134, 13057.281849498262, 13057.869421305784, 13084.869151308496, 12261.509539618426, 12268.079894007962, 12271.754564908697, 12935.935320323386, 13314.267715275655, 636.6148480169501, 817.1297568089994, 818.8444195602816, 823.0247157118804, 823.2302796884902, 788.9644965976545, 814.5845618734429, 816.873384625384, 819.7458787775779, 820.1142765812908, 840.9285210757093, 841.3185319890908, 841.7937605286713, 847.1697736218479, 847.5296210603112, 661.7551505942832, 818.8853560501534, 840.2269911681268, 840.8654615261529, 841.4068082002174, 615.1633778061832, 616.303576958039, 616.3774587666444, 616.4390404731718, 620.7765204526366, 12390.5663301784, 12437.564685236064, 12490.562830300896, 12491.12562120652, 12499.500019999188, 11710.590129345517, 11799.174057815957, 11883.10876684252, 12299.0, 12657.810132848015, 10136.89863101367, 10178.643747468803, 10252.282340236112, 10393.688189354332, 10477.79044419115, 3268.950965735516, 3299.457189270581, 3373.0386839750554, 3377.9493307600405, 3415.0096472023083, 46045.0, 46300.7684961573, 46330.30504542434, 46962.29556556654, 48357.274640880416, 9197.356185066981, 9203.585838637277, 9281.39670921388, 9385.343025988252, 9535.52322383878, 16089.195540223176, 16091.195440227943, 16119.194040297938, 16161.757573636405, 16177.19114044293, 6623.602583844985, 6715.1740176264075, 6807.591544507246, 6901.171859376806, 6937.895931561031, 3681.3557627415094, 3765.058735316171, 3831.7126215533945, 3876.5541962674088, 3911.92176156481, 2788.065997890689, 2882.9711702883124, 2885.92785180368, 2886.5381538953666, 2893.7106289371313, 489.05368112702035, 491.7590380713496, 507.73090262161116, 509.7043714645497, 532.7868852459047, 549.8872731090117, 572.4447286132445, 579.4668904607687, 595.3391735173954, 603.3815339277276, 8439.282660973764, 8639.654413823502, 8641.438306510057, 8674.262687671619, 8779.473231606124, 605.276694350256, 608.9086637004485, 615.237105988571, 627.7018416252334, 633.4868756307405, 3864.4589757433982, 3891.591382904754, 4139.544650088548, 4146.688998325138, 4225.154969006211, 60936.69531652313, 61751.0, 63624.0, 63744.36255637477, 63833.36166638367, 52458.0, 53100.2034969468, 53440.0, 55251.44748552463, 56182.71908640512, 43234.567654323684, 44218.557814422085, 45995.0, 48713.0, 50982.0, 8343.374246931384, 8488.0, 8570.233697437921, 8670.0, 8721.258693011165, 31747.36505269928, 32094.03717888467, 32220.0, 32627.83794784179, 33566.664333356355, 39919.0, 41450.585494144674, 41693.62216967175, 42290.154196916505, 42433.36349954815, 10947.0, 10977.725556860823, 11034.613788517363, 11187.16096292765, 11481.311121332747, 11482.0, 12178.939105304416, 12193.756124877274, 12462.813057803958, 12533.874661253636, 9021.954890225506, 11239.325640461599, 11244.493997769956, 11623.070154387799, 11715.1799374043, 11161.665150045512, 11478.253913495597, 11607.187496875475, 11870.940645296718, 11961.880381196077, 10589.364638121737, 10816.4050977197, 11084.501197446296, 11169.776604467703, 11509.827352589886, 9654.372465789702, 9714.125728684452, 9721.562529686322, 9984.900150998688, 10200.183985281308, 9348.906510934803, 9511.809763804824, 9545.140937315675, 9866.950665246628, 9965.800683986135], "value": 6098.655640212774, "unit": "score"}], "name": "dromaeo_css", "value": 6247.3974764576515, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 116.0, 116.0, 114.0, 114.0, 113.0, 114.0, 116.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 130.0, 218.0, 138.0, 130.0, 160.0, 136.0, 167.0, 136.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 164.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 141.0, 75.0, 75.0, 74.0, 75.0, 121.0, 74.0], "value": 86.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 158.0, 92.0, 95.0, 94.0, 121.0, 93.0, 103.0, 128.0], "value": 107.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 97.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 74.0, 65.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 75.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 90.0, 88.0, 85.0, 88.0, 83.0, 90.0, 84.0, 142.0, 84.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 130.0, 130.0, 130.0, 129.0, 138.0, 138.0, 159.0, 131.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 176.0, 181.0, 179.0, 171.0, 175.0, 174.0, 171.0, 174.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 66.0, 65.0, 66.0, 65.0, 67.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1578.0000000000002, "alertThreshold": 2.0}]} 14:32:52 INFO - Return code: 0 14:32:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:32:52 ERROR - # TBPL SUCCESS # 14:32:52 INFO - Running post-action listener: _resource_record_post_action 14:32:52 INFO - ##### 14:32:52 INFO - ##### Finished run-tests step (success) 14:32:52 INFO - ##### 14:32:52 INFO - Running post-run listener: _resource_record_post_run 14:32:52 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 533016576; Read time: 276; Write time: 480352 14:32:52 INFO - TinderboxPrint: CPU usage
13.2% 14:32:52 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 276 14:32:52 INFO - TinderboxPrint: I/O write bytes / time
533,016,576 / 480,352 14:32:52 INFO - TinderboxPrint: CPU idle
8,321.5 (86.8%) 14:32:52 INFO - TinderboxPrint: CPU user
1,222.0 (12.7%) 14:32:52 INFO - TinderboxPrint: Swap in / out
0 / 0 14:32:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 236929024; Read time: 0; Write time: 205428 14:32:52 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 296087552; Read time: 276; Write time: 274924 14:32:53 INFO - Running post-run listener: _upload_blobber_files 14:32:53 INFO - Blob upload gear active. 14:32:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:32:53 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 14:32:53 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'] 14:32:53 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 14:32:53 INFO - (blobuploader) - INFO - Open directory for files ... 14:32:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:32:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:32:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:57 INFO - (blobuploader) - INFO - Done attempting. 14:32:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:32:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:58 INFO - (blobuploader) - INFO - Done attempting. 14:32:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:32:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:32:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:59 INFO - (blobuploader) - INFO - Done attempting. 14:32:59 INFO - (blobuploader) - INFO - Iteration through files over. 14:32:59 INFO - Return code: 0 14:32:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:32:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:32:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a70034273abc33ef0d30a57b1cfba2ccb7bc50582715ea679d4ca08dc248b9836a8a03fad7dbdc603d629d3f6534efc068a4f22500db883a34b2d970ff08ab06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd3914c160354fb7c96c7ff2ffd4fa61549be5c7c5d893807368dd9afd953227a51df668752bc21ee8195cff75e34978fb6d8aeb39223c4b4a989314518b6dac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d4b4aa0d462ede1f5ee45432804aaefe715dac6b8917df2da841f59242d65ef59abaaef594ab57c0758d1a57ebeba74df9c7ff7f77bb39e4a125cc2c258c4bb"} 14:32:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:32:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:32:59 INFO - Contents: 14:32:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a70034273abc33ef0d30a57b1cfba2ccb7bc50582715ea679d4ca08dc248b9836a8a03fad7dbdc603d629d3f6534efc068a4f22500db883a34b2d970ff08ab06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd3914c160354fb7c96c7ff2ffd4fa61549be5c7c5d893807368dd9afd953227a51df668752bc21ee8195cff75e34978fb6d8aeb39223c4b4a989314518b6dac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d4b4aa0d462ede1f5ee45432804aaefe715dac6b8917df2da841f59242d65ef59abaaef594ab57c0758d1a57ebeba74df9c7ff7f77bb39e4a125cc2c258c4bb"} 14:32:59 INFO - Running post-run listener: copy_logs_to_upload_dir 14:32:59 INFO - Copying logs to upload dir... 14:32:59 INFO - mkdir: /builds/slave/test/build/upload/logs 14:32:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.004725 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-23 14:32:58.343099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 14:32:58.346070) ========= 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=1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273 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/a70034273abc33ef0d30a57b1cfba2ccb7bc50582715ea679d4ca08dc248b9836a8a03fad7dbdc603d629d3f6534efc068a4f22500db883a34b2d970ff08ab06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd3914c160354fb7c96c7ff2ffd4fa61549be5c7c5d893807368dd9afd953227a51df668752bc21ee8195cff75e34978fb6d8aeb39223c4b4a989314518b6dac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d4b4aa0d462ede1f5ee45432804aaefe715dac6b8917df2da841f59242d65ef59abaaef594ab57c0758d1a57ebeba74df9c7ff7f77bb39e4a125cc2c258c4bb"} build_url:https://queue.taskcluster.net/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/QSe_21aoSCyJ8QLnfZQ4XA/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/a70034273abc33ef0d30a57b1cfba2ccb7bc50582715ea679d4ca08dc248b9836a8a03fad7dbdc603d629d3f6534efc068a4f22500db883a34b2d970ff08ab06", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd3914c160354fb7c96c7ff2ffd4fa61549be5c7c5d893807368dd9afd953227a51df668752bc21ee8195cff75e34978fb6d8aeb39223c4b4a989314518b6dac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d4b4aa0d462ede1f5ee45432804aaefe715dac6b8917df2da841f59242d65ef59abaaef594ab57c0758d1a57ebeba74df9c7ff7f77bb39e4a125cc2c258c4bb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-23 14:32:58.371462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:32:58.371806) ========= 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=1f5564757af27664ca02d71f000001b0-1464037934.669311-1518659273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-23 14:32:58.457275) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 14:32:58.457548) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-23 14:32:58.457833) ========= ========= Total master_lag: 0.17 =========