builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1463524246.4 results: success (0) buildid: 20160517141644 builduid: 7d8c18ef388e4450bd3406d016684239 revision: e7c3a1d7ce2763284699643fd823c24968e3749a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:46.402090) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:46.402527) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:46.402817) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:46.418933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:46.419286) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 15:30:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-05-17 15:30:46 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131043 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:46.563522) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:46.563875) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020376 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:46.613248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 15:30:46.613613) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e7c3a1d7ce2763284699643fd823c24968e3749a --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 e7c3a1d7ce2763284699643fd823c24968e3749a --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=a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 15:30:46,920 truncating revision to first 12 chars 2016-05-17 15:30:46,920 Setting DEBUG logging. 2016-05-17 15:30:46,920 attempt 1/10 2016-05-17 15:30:46,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e7c3a1d7ce27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 15:30:48,155 unpacking tar archive at: fx-team-e7c3a1d7ce27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.534226 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-17 15:30:48.160121) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:48.160421) ========= script_repo_revision: e7c3a1d7ce2763284699643fd823c24968e3749a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:48.160803) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:48.161219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 15:30:48.169055) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-17 15:30:48.169320) ========= /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=a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:30:48 INFO - MultiFileLogger online at 20160517 15:30:48 in /builds/slave/test 15:30:48 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 15:30:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:48 INFO - {'append_to_log': False, 15:30:48 INFO - 'base_work_dir': '/builds/slave/test', 15:30:48 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:30:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:48 INFO - 'branch': 'Fx-Team-Non-PGO', 15:30:48 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:48 INFO - 'config_files': ('talos/linux_config.py',), 15:30:48 INFO - 'default_actions': ('clobber', 15:30:48 INFO - 'read-buildbot-config', 15:30:48 INFO - 'download-and-extract', 15:30:48 INFO - 'populate-webroot', 15:30:48 INFO - 'create-virtualenv', 15:30:48 INFO - 'install', 15:30:48 INFO - 'run-tests'), 15:30:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:48 INFO - 'download_minidump_stackwalk': True, 15:30:48 INFO - 'download_symbols': 'ondemand', 15:30:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:48 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:48 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:48 INFO - 'installer_path': 'installer.exe', 15:30:48 INFO - 'log_level': 'info', 15:30:48 INFO - 'log_name': 'talos', 15:30:48 INFO - 'log_to_console': True, 15:30:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:30:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:30:48 INFO - 'opt_config_files': (), 15:30:48 INFO - 'pip_index': False, 15:30:48 INFO - 'sps_profile': False, 15:30:48 INFO - 'sps_profile_interval': 0, 15:30:48 INFO - 'suite': 'dromaeojs', 15:30:48 INFO - 'system_bits': '32', 15:30:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:48 INFO - 'title': 'talos-linux64-ix-002', 15:30:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:48 INFO - 'use_talos_json': True, 15:30:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:48 INFO - 'work_dir': 'build'} 15:30:48 INFO - ##### 15:30:48 INFO - ##### Running clobber step. 15:30:48 INFO - ##### 15:30:48 INFO - Running pre-action listener: _resource_record_pre_action 15:30:48 INFO - Running main action method: clobber 15:30:48 INFO - rmtree: /builds/slave/test/build 15:30:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:49 INFO - Running post-action listener: _resource_record_post_action 15:30:49 INFO - ##### 15:30:49 INFO - ##### Finished clobber step (success) 15:30:49 INFO - ##### 15:30:49 INFO - ##### 15:30:49 INFO - ##### Running read-buildbot-config step. 15:30:49 INFO - ##### 15:30:49 INFO - Running pre-action listener: _resource_record_pre_action 15:30:49 INFO - Running main action method: read_buildbot_config 15:30:49 INFO - Using buildbot properties: 15:30:49 INFO - { 15:30:49 INFO - "project": "", 15:30:49 INFO - "product": "firefox", 15:30:49 INFO - "script_repo_revision": "production", 15:30:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:30:49 INFO - "repository": "", 15:30:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 15:30:49 INFO - "buildid": "20160517141644", 15:30:49 INFO - "pgo_build": "False", 15:30:49 INFO - "basedir": "/builds/slave/test", 15:30:49 INFO - "buildnumber": 2978, 15:30:49 INFO - "slavename": "talos-linux64-ix-002", 15:30:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:30:49 INFO - "platform": "ubuntu64_hw", 15:30:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:30:49 INFO - "branch": "fx-team", 15:30:49 INFO - "repo_path": "integration/fx-team", 15:30:49 INFO - "revision": "e7c3a1d7ce2763284699643fd823c24968e3749a", 15:30:49 INFO - "stage_platform": "linux64", 15:30:49 INFO - "builduid": "7d8c18ef388e4450bd3406d016684239", 15:30:49 INFO - "slavebuilddir": "test" 15:30:49 INFO - } 15:30:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:30:49 INFO - Running post-action listener: _resource_record_post_action 15:30:49 INFO - ##### 15:30:49 INFO - ##### Finished read-buildbot-config step (success) 15:30:49 INFO - ##### 15:30:49 INFO - ##### 15:30:49 INFO - ##### Running download-and-extract step. 15:30:49 INFO - ##### 15:30:49 INFO - Running pre-action listener: _resource_record_pre_action 15:30:49 INFO - Running main action method: download_and_extract 15:30:49 INFO - mkdir: /builds/slave/test/build/tests 15:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:49 INFO - https://queue.taskcluster.net/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:30:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:30:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:30:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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 15:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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 15:30:50 INFO - Downloaded 1361 bytes. 15:30:50 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:30:50 INFO - Using the following test package requirements: 15:30:50 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:50 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:30:50 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:30:50 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:50 INFO - u'jsshell-linux-x86_64.zip'], 15:30:50 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:30:50 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:30:50 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:30:50 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:30:50 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:30:50 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:30:50 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:30:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:50 INFO - https://queue.taskcluster.net/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:30:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:30:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:30:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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 15:30:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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 15:30:51 INFO - Downloaded 22448976 bytes. 15:30:51 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'] 15:30:51 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 15:30:52 INFO - Return code: 0 15:30:52 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 15:30:52 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')]} 15:30:52 INFO - https://queue.taskcluster.net/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:30:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:30:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:30:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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 15:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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 15:30:53 INFO - Downloaded 22448976 bytes. 15:30:53 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'] 15:30:53 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 15:30:55 INFO - Return code: 0 15:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:55 INFO - https://queue.taskcluster.net/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:30:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:30:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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 15:30:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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 15:30:55 INFO - Downloaded 10840194 bytes. 15:30:55 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'] 15:30:55 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 15:30:56 INFO - Return code: 0 15:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:56 INFO - https://queue.taskcluster.net/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:30:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:30:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:30:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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 15:30:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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 15:30:57 INFO - Downloaded 54764681 bytes. 15:30:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:30:57 INFO - mkdir: /builds/slave/test/properties 15:30:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:30:57 INFO - Writing to file /builds/slave/test/properties/build_url 15:30:57 INFO - Contents: 15:30:57 INFO - build_url:https://queue.taskcluster.net/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:30:58 INFO - Running post-action listener: _resource_record_post_action 15:30:58 INFO - Running post-action listener: set_extra_try_arguments 15:30:58 INFO - ##### 15:30:58 INFO - ##### Finished download-and-extract step (success) 15:30:58 INFO - ##### 15:30:58 INFO - ##### 15:30:58 INFO - ##### Running populate-webroot step. 15:30:58 INFO - ##### 15:30:58 INFO - Running pre-action listener: _resource_record_pre_action 15:30:58 INFO - Running main action method: populate_webroot 15:30:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:30:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:30:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:30:58 INFO - '--tppagecycles', 15:30:58 INFO - '7'], 15:30:58 INFO - 'tests': ['tsvgm']}}, 15:30:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:30:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:30:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:30:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:30:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:30:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:30:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:58 INFO - 'talos_options': ['--disable-e10s'], 15:30:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:58 INFO - 'talos_options': ['--disable-e10s'], 15:30:58 INFO - 'tests': ['damp', 'tps']}, 15:30:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:58 INFO - 'tests': ['damp', 'tps']}, 15:30:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:30:58 INFO - 'tests': ['dromaeo_dom']}, 15:30:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:30:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:30:58 INFO - 'tests': ['a11yr', 15:30:58 INFO - 'ts_paint', 15:30:58 INFO - 'tpaint', 15:30:58 INFO - 'sessionrestore', 15:30:58 INFO - 'sessionrestore_no_auto_restore', 15:30:58 INFO - 'tabpaint']}, 15:30:58 INFO - 'other-e10s': {'tests': ['a11yr', 15:30:58 INFO - 'ts_paint', 15:30:58 INFO - 'tpaint', 15:30:58 INFO - 'sessionrestore', 15:30:58 INFO - 'sessionrestore_no_auto_restore', 15:30:58 INFO - 'tabpaint']}, 15:30:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:30:58 INFO - 'ts_paint', 15:30:58 INFO - 'tpaint', 15:30:58 INFO - 'sessionrestore', 15:30:58 INFO - 'sessionrestore_no_auto_restore', 15:30:58 INFO - 'tabpaint']}, 15:30:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:30:58 INFO - 'ts_paint', 15:30:58 INFO - 'tpaint', 15:30:58 INFO - 'sessionrestore', 15:30:58 INFO - 'sessionrestore_no_auto_restore', 15:30:58 INFO - 'tabpaint']}, 15:30:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:30:58 INFO - 'tests': ['a11yr', 15:30:58 INFO - 'ts_paint', 15:30:58 INFO - 'tpaint', 15:30:58 INFO - 'sessionrestore', 15:30:58 INFO - 'sessionrestore_no_auto_restore', 15:30:58 INFO - 'tabpaint']}, 15:30:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:30:58 INFO - 'tests': ['a11yr', 15:30:58 INFO - 'ts_paint', 15:30:58 INFO - 'tpaint', 15:30:58 INFO - 'sessionrestore', 15:30:58 INFO - 'sessionrestore_no_auto_restore', 15:30:58 INFO - 'tabpaint']}, 15:30:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:30:58 INFO - 'tests': ['tsvgx', 15:30:58 INFO - 'tsvgr_opacity', 15:30:58 INFO - 'tart', 15:30:58 INFO - 'tscrollx', 15:30:58 INFO - 'cart']}, 15:30:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:30:58 INFO - 'tsvgr_opacity', 15:30:58 INFO - 'tart', 15:30:58 INFO - 'tscrollx', 15:30:58 INFO - 'cart']}, 15:30:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:58 INFO - 'talos_options': ['--disable-e10s'], 15:30:58 INFO - 'tests': ['tp5o']}, 15:30:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:58 INFO - 'tests': ['tp5o']}, 15:30:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:58 INFO - 'talos_options': ['--disable-e10s', 15:30:58 INFO - '--xperf_path', 15:30:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:58 INFO - 'tests': ['tp5n']}, 15:30:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:58 INFO - 'talos_options': ['--xperf_path', 15:30:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:58 INFO - 'tests': ['tp5n']}}, 15:30:58 INFO - 'talos.zip': {'path': '', 15:30:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:30:58 INFO - Running post-action listener: _resource_record_post_action 15:30:58 INFO - ##### 15:30:58 INFO - ##### Finished populate-webroot step (success) 15:30:58 INFO - ##### 15:30:58 INFO - ##### 15:30:58 INFO - ##### Running create-virtualenv step. 15:30:58 INFO - ##### 15:30:58 INFO - Running pre-action listener: _resource_record_pre_action 15:30:58 INFO - Running main action method: create_virtualenv 15:30:58 INFO - Creating virtualenv /builds/slave/test/build/venv 15:30:58 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 15:30:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:30:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:30:58 INFO - Using real prefix '/usr' 15:30:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:30:58 INFO - Installing distribute.............................................................................................................................................................................................done. 15:31:00 INFO - Installing pip.................done. 15:31:00 INFO - Return code: 0 15:31:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1200b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, '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 0xf178c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf17d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', '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 15:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:31:00 INFO - Using env: {'DISPLAY': ':0', 15:31:00 INFO - 'HOME': '/home/cltbld', 15:31:00 INFO - 'LANG': 'en_US.UTF-8', 15:31:00 INFO - 'LANGUAGE': 'en_US:en', 15:31:00 INFO - 'LOGNAME': 'cltbld', 15:31:00 INFO - 'MAIL': '/var/mail/cltbld', 15:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:00 INFO - 'MOZ_NO_REMOTE': '1', 15:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:00 INFO - 'NO_EM_RESTART': '1', 15:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:00 INFO - 'PWD': '/builds/slave/test', 15:31:00 INFO - 'SHELL': '/bin/bash', 15:31:00 INFO - 'SHLVL': '1', 15:31:00 INFO - 'TERM': 'linux', 15:31:00 INFO - 'TMOUT': '86400', 15:31:00 INFO - 'USER': 'cltbld', 15:31:00 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', 15:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:00 INFO - '_': '/tools/buildbot/bin/python'} 15:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:01 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 15:31:01 INFO - Cleaning up... 15:31:01 INFO - Return code: 0 15:31:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1200b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, '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 0xf178c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf17d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', '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 15:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:31:01 INFO - Using env: {'DISPLAY': ':0', 15:31:01 INFO - 'HOME': '/home/cltbld', 15:31:01 INFO - 'LANG': 'en_US.UTF-8', 15:31:01 INFO - 'LANGUAGE': 'en_US:en', 15:31:01 INFO - 'LOGNAME': 'cltbld', 15:31:01 INFO - 'MAIL': '/var/mail/cltbld', 15:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:01 INFO - 'MOZ_NO_REMOTE': '1', 15:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:01 INFO - 'NO_EM_RESTART': '1', 15:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:01 INFO - 'PWD': '/builds/slave/test', 15:31:01 INFO - 'SHELL': '/bin/bash', 15:31:01 INFO - 'SHLVL': '1', 15:31:01 INFO - 'TERM': 'linux', 15:31:01 INFO - 'TMOUT': '86400', 15:31:01 INFO - 'USER': 'cltbld', 15:31:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', 15:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:01 INFO - '_': '/tools/buildbot/bin/python'} 15:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:01 INFO - Downloading/unpacking psutil>=3.1.1 15:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:03 INFO - Installing collected packages: psutil 15:31:03 INFO - Running setup.py install for psutil 15:31:03 INFO - building 'psutil._psutil_linux' extension 15:31:03 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 15:31:03 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 15:31:03 INFO - building 'psutil._psutil_posix' extension 15:31:03 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 15:31:03 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 15:31:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:03 INFO - Successfully installed psutil 15:31:03 INFO - Cleaning up... 15:31:03 INFO - Return code: 0 15:31:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:31:03 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')]} 15:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:03 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')]} 15:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:03 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 0x7f1200b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, '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 0xf178c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf17d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', '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 15:31:03 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 15:31:03 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 15:31:03 INFO - Using env: {'DISPLAY': ':0', 15:31:03 INFO - 'HOME': '/home/cltbld', 15:31:03 INFO - 'LANG': 'en_US.UTF-8', 15:31:03 INFO - 'LANGUAGE': 'en_US:en', 15:31:03 INFO - 'LOGNAME': 'cltbld', 15:31:03 INFO - 'MAIL': '/var/mail/cltbld', 15:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:03 INFO - 'MOZ_NO_REMOTE': '1', 15:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:03 INFO - 'NO_EM_RESTART': '1', 15:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:03 INFO - 'PWD': '/builds/slave/test', 15:31:03 INFO - 'SHELL': '/bin/bash', 15:31:03 INFO - 'SHLVL': '1', 15:31:03 INFO - 'TERM': 'linux', 15:31:03 INFO - 'TMOUT': '86400', 15:31:03 INFO - 'USER': 'cltbld', 15:31:03 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', 15:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:03 INFO - '_': '/tools/buildbot/bin/python'} 15:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:31:06 INFO - Installing collected packages: mozsystemmonitor 15:31:06 INFO - Running setup.py install for mozsystemmonitor 15:31:06 INFO - Successfully installed mozsystemmonitor 15:31:06 INFO - Cleaning up... 15:31:06 INFO - Return code: 0 15:31:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:06 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 0x7f1200b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, '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 0xf178c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf17d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', '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 15:31:06 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 15:31:06 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 15:31:06 INFO - Using env: {'DISPLAY': ':0', 15:31:06 INFO - 'HOME': '/home/cltbld', 15:31:06 INFO - 'LANG': 'en_US.UTF-8', 15:31:06 INFO - 'LANGUAGE': 'en_US:en', 15:31:06 INFO - 'LOGNAME': 'cltbld', 15:31:06 INFO - 'MAIL': '/var/mail/cltbld', 15:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:06 INFO - 'MOZ_NO_REMOTE': '1', 15:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:06 INFO - 'NO_EM_RESTART': '1', 15:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:06 INFO - 'PWD': '/builds/slave/test', 15:31:06 INFO - 'SHELL': '/bin/bash', 15:31:06 INFO - 'SHLVL': '1', 15:31:06 INFO - 'TERM': 'linux', 15:31:06 INFO - 'TMOUT': '86400', 15:31:06 INFO - 'USER': 'cltbld', 15:31:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', 15:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:06 INFO - '_': '/tools/buildbot/bin/python'} 15:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:06 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:06 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 15:31:06 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 15:31:06 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 15:31:06 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 15:31:06 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 15:31:06 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 15:31:08 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:31:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:09 INFO - Downloading docopt-0.6.1.tar.gz 15:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:09 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:09 INFO - Running setup.py install for blobuploader 15:31:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:31:09 INFO - Running setup.py install for requests 15:31:09 INFO - Running setup.py install for docopt 15:31:09 INFO - Successfully installed blobuploader requests docopt 15:31:09 INFO - Cleaning up... 15:31:09 INFO - Return code: 0 15:31:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:09 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')]} 15:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:09 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')]} 15:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:09 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 0x7f1200b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, '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 0xf178c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf17d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', '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 15:31:09 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 15:31:09 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 15:31:09 INFO - Using env: {'DISPLAY': ':0', 15:31:09 INFO - 'HOME': '/home/cltbld', 15:31:09 INFO - 'LANG': 'en_US.UTF-8', 15:31:09 INFO - 'LANGUAGE': 'en_US:en', 15:31:09 INFO - 'LOGNAME': 'cltbld', 15:31:09 INFO - 'MAIL': '/var/mail/cltbld', 15:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:09 INFO - 'MOZ_NO_REMOTE': '1', 15:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:09 INFO - 'NO_EM_RESTART': '1', 15:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:09 INFO - 'PWD': '/builds/slave/test', 15:31:09 INFO - 'SHELL': '/bin/bash', 15:31:09 INFO - 'SHLVL': '1', 15:31:09 INFO - 'TERM': 'linux', 15:31:09 INFO - 'TMOUT': '86400', 15:31:09 INFO - 'USER': 'cltbld', 15:31:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', 15:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:09 INFO - '_': '/tools/buildbot/bin/python'} 15:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:09 INFO - Running setup.py (path:/tmp/pip-vSwAIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:10 INFO - Running setup.py (path:/tmp/pip-yviBuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:10 INFO - Running setup.py (path:/tmp/pip-XLhObL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:10 INFO - Running setup.py (path:/tmp/pip-oamE2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:10 INFO - Running setup.py (path:/tmp/pip-QomSNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:10 INFO - Running setup.py (path:/tmp/pip-EsbzT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:10 INFO - Running setup.py (path:/tmp/pip-ScZ4dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:10 INFO - Running setup.py (path:/tmp/pip-wHYndz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:10 INFO - Running setup.py (path:/tmp/pip-NWKmfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:10 INFO - Running setup.py (path:/tmp/pip-FS0zeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:10 INFO - Running setup.py (path:/tmp/pip-GPdgQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:10 INFO - Running setup.py (path:/tmp/pip-XJfBiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:10 INFO - Running setup.py (path:/tmp/pip-1DD3t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:10 INFO - Running setup.py (path:/tmp/pip-WarEcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:10 INFO - Running setup.py (path:/tmp/pip-prz3S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:11 INFO - Running setup.py (path:/tmp/pip-vnatBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:11 INFO - Running setup.py (path:/tmp/pip-mIXha3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:11 INFO - Running setup.py install for manifestparser 15:31:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:31:11 INFO - Running setup.py install for mozcrash 15:31:11 INFO - Running setup.py install for mozdebug 15:31:11 INFO - Running setup.py install for mozdevice 15:31:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:31:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:31:11 INFO - Running setup.py install for mozfile 15:31:11 INFO - Running setup.py install for mozhttpd 15:31:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:31:11 INFO - Running setup.py install for mozinfo 15:31:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:31:11 INFO - Running setup.py install for mozInstall 15:31:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Running setup.py install for mozleak 15:31:12 INFO - Running setup.py install for mozlog 15:31:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Running setup.py install for moznetwork 15:31:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Running setup.py install for mozprocess 15:31:12 INFO - Running setup.py install for mozprofile 15:31:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Running setup.py install for mozrunner 15:31:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Running setup.py install for mozscreenshot 15:31:12 INFO - Running setup.py install for moztest 15:31:12 INFO - Running setup.py install for mozversion 15:31:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:12 INFO - Cleaning up... 15:31:13 INFO - Return code: 0 15:31:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:13 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 0x7f1200b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, '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 0xf178c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf17d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', '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 15:31:13 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 15:31:13 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 15:31:13 INFO - Using env: {'DISPLAY': ':0', 15:31:13 INFO - 'HOME': '/home/cltbld', 15:31:13 INFO - 'LANG': 'en_US.UTF-8', 15:31:13 INFO - 'LANGUAGE': 'en_US:en', 15:31:13 INFO - 'LOGNAME': 'cltbld', 15:31:13 INFO - 'MAIL': '/var/mail/cltbld', 15:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:13 INFO - 'MOZ_NO_REMOTE': '1', 15:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:13 INFO - 'NO_EM_RESTART': '1', 15:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:13 INFO - 'PWD': '/builds/slave/test', 15:31:13 INFO - 'SHELL': '/bin/bash', 15:31:13 INFO - 'SHLVL': '1', 15:31:13 INFO - 'TERM': 'linux', 15:31:13 INFO - 'TMOUT': '86400', 15:31:13 INFO - 'USER': 'cltbld', 15:31:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', 15:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:13 INFO - '_': '/tools/buildbot/bin/python'} 15:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:13 INFO - Running setup.py (path:/tmp/pip-dKl4Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:13 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)) 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:13 INFO - Running setup.py (path:/tmp/pip-0X44rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:13 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)) 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:13 INFO - Running setup.py (path:/tmp/pip-YhIs1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:13 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)) 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:13 INFO - Running setup.py (path:/tmp/pip-FvWlOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:13 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)) 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:13 INFO - Running setup.py (path:/tmp/pip-3J1cKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:13 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)) 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:13 INFO - Running setup.py (path:/tmp/pip-jkNRKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:13 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)) 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:13 INFO - Running setup.py (path:/tmp/pip-l6dMK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:13 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)) 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:13 INFO - Running setup.py (path:/tmp/pip-ePTbsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:13 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)) 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:13 INFO - Running setup.py (path:/tmp/pip-ObxqgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:13 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)) 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:13 INFO - Running setup.py (path:/tmp/pip-gYxDmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:13 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)) 15:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:13 INFO - Running setup.py (path:/tmp/pip-O2iB4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:14 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)) 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:14 INFO - Running setup.py (path:/tmp/pip-Wm8IBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:14 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)) 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:14 INFO - Running setup.py (path:/tmp/pip-A8Fchc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:14 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)) 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:14 INFO - Running setup.py (path:/tmp/pip-Nbm3jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:14 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)) 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:14 INFO - Running setup.py (path:/tmp/pip-QRg99e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:14 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)) 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:14 INFO - Running setup.py (path:/tmp/pip-iDcYDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:14 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)) 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:14 INFO - Running setup.py (path:/tmp/pip-nbF2Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:14 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)) 15:31:14 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)) 15:31:14 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)) 15:31:14 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)) 15:31:14 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)) 15:31:14 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)) 15:31:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:16 INFO - Downloading blessings-1.6.tar.gz 15:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:16 INFO - Installing collected packages: blessings 15:31:16 INFO - Running setup.py install for blessings 15:31:16 INFO - Successfully installed blessings 15:31:16 INFO - Cleaning up... 15:31:16 INFO - Return code: 0 15:31:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:16 INFO - Reading from file tmpfile_stdout 15:31:16 INFO - Current package versions: 15:31:16 INFO - argparse == 1.2.1 15:31:16 INFO - blessings == 1.6 15:31:16 INFO - blobuploader == 1.2.4 15:31:16 INFO - docopt == 0.6.1 15:31:16 INFO - manifestparser == 1.1 15:31:16 INFO - mozInstall == 1.12 15:31:16 INFO - mozcrash == 0.17 15:31:16 INFO - mozdebug == 0.1 15:31:16 INFO - mozdevice == 0.48 15:31:16 INFO - mozfile == 1.2 15:31:16 INFO - mozhttpd == 0.7 15:31:16 INFO - mozinfo == 0.9 15:31:16 INFO - mozleak == 0.1 15:31:16 INFO - mozlog == 3.2 15:31:16 INFO - moznetwork == 0.27 15:31:16 INFO - mozprocess == 0.22 15:31:16 INFO - mozprofile == 0.28 15:31:16 INFO - mozrunner == 6.11 15:31:16 INFO - mozscreenshot == 0.1 15:31:16 INFO - mozsystemmonitor == 0.3 15:31:16 INFO - moztest == 0.7 15:31:16 INFO - mozversion == 1.4 15:31:16 INFO - psutil == 3.1.1 15:31:16 INFO - requests == 1.2.3 15:31:16 INFO - wsgiref == 0.1.2 15:31:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:16 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 0x7f1200b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, '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 0xf178c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf17d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', '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 15:31:16 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 15:31:16 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 15:31:16 INFO - Using env: {'DISPLAY': ':0', 15:31:16 INFO - 'HOME': '/home/cltbld', 15:31:16 INFO - 'LANG': 'en_US.UTF-8', 15:31:16 INFO - 'LANGUAGE': 'en_US:en', 15:31:16 INFO - 'LOGNAME': 'cltbld', 15:31:16 INFO - 'MAIL': '/var/mail/cltbld', 15:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:16 INFO - 'MOZ_NO_REMOTE': '1', 15:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:16 INFO - 'NO_EM_RESTART': '1', 15:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:16 INFO - 'PWD': '/builds/slave/test', 15:31:16 INFO - 'SHELL': '/bin/bash', 15:31:16 INFO - 'SHLVL': '1', 15:31:16 INFO - 'TERM': 'linux', 15:31:16 INFO - 'TMOUT': '86400', 15:31:16 INFO - 'USER': 'cltbld', 15:31:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', 15:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:16 INFO - '_': '/tools/buildbot/bin/python'} 15:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:16 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)) 15:31:16 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)) 15:31:16 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)) 15:31:16 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)) 15:31:16 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)) 15:31:16 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)) 15:31:16 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)) 15:31:16 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)) 15:31:16 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)) 15:31:16 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)) 15:31:16 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)) 15:31:16 INFO - Cleaning up... 15:31:17 INFO - Return code: 0 15:31:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:17 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 0x7f1200b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, '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 0xf178c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf17d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', '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 15:31:17 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 15:31:17 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 15:31:17 INFO - Using env: {'DISPLAY': ':0', 15:31:17 INFO - 'HOME': '/home/cltbld', 15:31:17 INFO - 'LANG': 'en_US.UTF-8', 15:31:17 INFO - 'LANGUAGE': 'en_US:en', 15:31:17 INFO - 'LOGNAME': 'cltbld', 15:31:17 INFO - 'MAIL': '/var/mail/cltbld', 15:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:17 INFO - 'MOZ_NO_REMOTE': '1', 15:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:17 INFO - 'NO_EM_RESTART': '1', 15:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:17 INFO - 'PWD': '/builds/slave/test', 15:31:17 INFO - 'SHELL': '/bin/bash', 15:31:17 INFO - 'SHLVL': '1', 15:31:17 INFO - 'TERM': 'linux', 15:31:17 INFO - 'TMOUT': '86400', 15:31:17 INFO - 'USER': 'cltbld', 15:31:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', 15:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:17 INFO - '_': '/tools/buildbot/bin/python'} 15:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:17 INFO - Downloading/unpacking jsonschema 15:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:19 INFO - Downloading/unpacking functools32 (from jsonschema) 15:31:19 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 15:31:19 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 15:31:19 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 15:31:19 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 15:31:19 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 15:31:19 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 15:31:19 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:19 INFO - warning: no files found matching '*.txt' 15:31:19 INFO - no previously-included directories found matching 'build' 15:31:19 INFO - no previously-included directories found matching 'dist' 15:31:19 INFO - no previously-included directories found matching '.git*' 15:31:19 INFO - Installing collected packages: jsonschema, functools32 15:31:19 INFO - Running setup.py install for functools32 15:31:19 INFO - warning: no files found matching '*.txt' 15:31:19 INFO - no previously-included directories found matching 'build' 15:31:19 INFO - no previously-included directories found matching 'dist' 15:31:19 INFO - no previously-included directories found matching '.git*' 15:31:19 INFO - Successfully installed jsonschema functools32 15:31:19 INFO - Cleaning up... 15:31:19 INFO - Return code: 0 15:31:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:19 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 0x7f1200b18f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe87770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf169c0>, '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 0xf178c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf17d50>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', '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 15:31:19 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 15:31:19 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 15:31:19 INFO - Using env: {'DISPLAY': ':0', 15:31:19 INFO - 'HOME': '/home/cltbld', 15:31:19 INFO - 'LANG': 'en_US.UTF-8', 15:31:19 INFO - 'LANGUAGE': 'en_US:en', 15:31:19 INFO - 'LOGNAME': 'cltbld', 15:31:19 INFO - 'MAIL': '/var/mail/cltbld', 15:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:19 INFO - 'MOZ_NO_REMOTE': '1', 15:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:19 INFO - 'NO_EM_RESTART': '1', 15:31:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:19 INFO - 'PWD': '/builds/slave/test', 15:31:19 INFO - 'SHELL': '/bin/bash', 15:31:19 INFO - 'SHLVL': '1', 15:31:19 INFO - 'TERM': 'linux', 15:31:19 INFO - 'TMOUT': '86400', 15:31:19 INFO - 'USER': 'cltbld', 15:31:19 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', 15:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:19 INFO - '_': '/tools/buildbot/bin/python'} 15:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:19 INFO - Downloading/unpacking flake8 15:31:19 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 15:31:19 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 15:31:19 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 15:31:19 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 15:31:19 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 15:31:19 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 15:31:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:31:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:31:21 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 15:31:21 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 15:31:21 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 15:31:21 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 15:31:21 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 15:31:21 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 15:31:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:31:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:31:22 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 15:31:22 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 15:31:22 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 15:31:22 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 15:31:22 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 15:31:22 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 15:31:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:31:22 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 15:31:22 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 15:31:22 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 15:31:22 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 15:31:22 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 15:31:22 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 15:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:31:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:31:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:31:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:31:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:31:22 INFO - no previously-included directories found matching 'docs/_build' 15:31:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:31:22 INFO - Running setup.py install for pep8 15:31:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:31:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:31:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:31:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:31:22 INFO - no previously-included directories found matching 'docs/_build' 15:31:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:31:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:31:22 INFO - Cleaning up... 15:31:22 INFO - Return code: 0 15:31:22 INFO - Running post-action listener: _resource_record_post_action 15:31:22 INFO - Running post-action listener: _start_resource_monitoring 15:31:22 INFO - Starting resource monitoring. 15:31:22 INFO - ##### 15:31:22 INFO - ##### Finished create-virtualenv step (success) 15:31:22 INFO - ##### 15:31:22 INFO - ##### 15:31:22 INFO - ##### Running install step. 15:31:22 INFO - ##### 15:31:22 INFO - Running pre-action listener: _resource_record_pre_action 15:31:22 INFO - Running main action method: install 15:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:22 INFO - Reading from file tmpfile_stdout 15:31:22 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:23 INFO - Reading from file tmpfile_stdout 15:31:23 INFO - Output received: 15:31:23 INFO - Usage: mozinstall [options] installer 15:31:23 INFO - Options: 15:31:23 INFO - -h, --help show this help message and exit 15:31:23 INFO - -d DEST, --destination=DEST 15:31:23 INFO - Directory to install application into. [default: 15:31:23 INFO - "/builds/slave/test"] 15:31:23 INFO - --app=APP Application being installed. [default: firefox] 15:31:23 INFO - mkdir: /builds/slave/test/build/application 15:31:23 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'] 15:31:23 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 15:31:38 INFO - Reading from file tmpfile_stdout 15:31:38 INFO - Output received: 15:31:38 INFO - /builds/slave/test/build/application/firefox/firefox 15:31:38 INFO - Running post-action listener: _resource_record_post_action 15:31:38 INFO - ##### 15:31:38 INFO - ##### Finished install step (success) 15:31:38 INFO - ##### 15:31:38 INFO - ##### 15:31:38 INFO - ##### Running run-tests step. 15:31:38 INFO - ##### 15:31:38 INFO - Running pre-action listener: _resource_record_pre_action 15:31:38 INFO - Running main action method: run_tests 15:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:31:38 INFO - Python 2.7.3 15:31:38 INFO - Return code: 0 15:31:38 INFO - grabbing minidump binary from tooltool 15:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:38 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 0xf169c0>, '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 0xf178c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf17d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:31:38 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 15:31:38 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 15:31:38 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 15:31:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:31:38 INFO - Return code: 0 15:31:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:31:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:31:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:31:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:31:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:31:39 INFO - Return code: 0 15:31:39 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/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 15:31:39 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/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 15:31:39 INFO - Using env: {'DISPLAY': ':0', 15:31:39 INFO - 'HOME': '/home/cltbld', 15:31:39 INFO - 'LANG': 'en_US.UTF-8', 15:31:39 INFO - 'LANGUAGE': 'en_US:en', 15:31:39 INFO - 'LOGNAME': 'cltbld', 15:31:39 INFO - 'MAIL': '/var/mail/cltbld', 15:31:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:31:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:39 INFO - 'MOZ_NO_REMOTE': '1', 15:31:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:39 INFO - 'NO_EM_RESTART': '1', 15:31:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:39 INFO - 'PWD': '/builds/slave/test', 15:31:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:31:39 INFO - 'SHELL': '/bin/bash', 15:31:39 INFO - 'SHLVL': '1', 15:31:39 INFO - 'TERM': 'linux', 15:31:39 INFO - 'TMOUT': '86400', 15:31:39 INFO - 'USER': 'cltbld', 15:31:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685', 15:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:39 INFO - '_': '/tools/buildbot/bin/python'} 15:31:39 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/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 15:31:40 INFO - mozversion application_buildid: 20160517141644 15:31:40 INFO - mozversion application_changeset: e7c3a1d7ce2763284699643fd823c24968e3749a 15:31:40 INFO - mozversion application_display_name: Nightly 15:31:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:31:40 INFO - mozversion application_name: Firefox 15:31:40 INFO - mozversion application_remotingname: firefox 15:31:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:31:40 INFO - mozversion application_vendor: Mozilla 15:31:40 INFO - mozversion application_version: 49.0a1 15:31:40 INFO - mozversion platform_buildid: 20160517141644 15:31:40 INFO - mozversion platform_changeset: e7c3a1d7ce2763284699643fd823c24968e3749a 15:31:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:31:40 INFO - mozversion platform_version: 49.0a1 15:31:40 INFO - using testdate: 1463524300 15:31:40 INFO - actual date: 1463524300 15:31:40 INFO - starting webserver on 'localhost:59110' 15:31:40 INFO - SUITE-START | Running 2 tests 15:31:40 INFO - TEST-START | dromaeo_css 15:31:40 INFO - operating with platform_type : linux_ 15:31:40 INFO - Initialising browser for dromaeo_css test... 15:31:40 INFO - TEST-INFO | started process 17958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEM4IYP/profile http://localhost:59110/getInfo.html) 15:31:44 INFO - PROCESS | 17958 | __metrics Screen width/height:1600/1200 15:31:44 INFO - PROCESS | 17958 | colorDepth:24 15:31:44 INFO - PROCESS | 17958 | Browser inner width/height: 1024/697 15:31:44 INFO - PROCESS | 17958 | __metrics 15:31:45 ERROR - PROCESS | 17958 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:31:46 INFO - TEST-INFO | 17958: exit 0 15:31:46 INFO - Browser initialized. 15:31:46 INFO - Running cycle 1/1 for dromaeo_css test... 15:31:46 INFO - TEST-INFO | started process 18039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEM4IYP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:31:58 INFO - PROCESS | 18039 | RSS: Main: 154062848 15:31:58 INFO - PROCESS | 18039 | 15:32:49 INFO - PROCESS | 18039 | 1463524369125 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] 15:35:01 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:59110/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59110/tests/dromaeo/cssquery-ext.html) 15:35:03 INFO - PROCESS | 18039 | RSS: Main: 265109504 15:35:03 INFO - PROCESS | 18039 | 15:38:05 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:59110/tests/dromaeo/cssquery-ext.html (next: http://localhost:59110/tests/dromaeo/cssquery-jquery.html) 15:38:06 INFO - PROCESS | 18039 | RSS: Main: 239190016 15:38:06 INFO - PROCESS | 18039 | 15:41:08 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:59110/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59110/tests/dromaeo/cssquery-mootools.html) 15:41:09 INFO - PROCESS | 18039 | RSS: Main: 233967616 15:41:09 INFO - PROCESS | 18039 | 15:44:11 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:59110/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59110/tests/dromaeo/cssquery-prototype.html) 15:44:12 INFO - PROCESS | 18039 | RSS: Main: 230494208 15:44:12 INFO - PROCESS | 18039 | 15:47:15 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:59110/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59110/tests/dromaeo/cssquery-yui.html) 15:47:15 INFO - PROCESS | 18039 | RSS: Main: 216121344 15:47:15 INFO - PROCESS | 18039 | 15:50:18 INFO - PROCESS | 18039 | Cycle 1(1): loaded http://localhost:59110/tests/dromaeo/cssquery-yui.html (next: http://localhost:59110/tests/dromaeo/cssquery-dojo.html) 15:50:18 INFO - PROCESS | 18039 | RSS: Main: 266399744 15:50:18 INFO - PROCESS | 18039 | 15:50:18 INFO - PROCESS | 18039 | __start_tp_report 15:50:18 INFO - PROCESS | 18039 | _x_x_mozilla_page_load 15:50:18 INFO - PROCESS | 18039 | _x_x_mozilla_page_load_details 15:50:18 INFO - PROCESS | 18039 | |i|pagename|runs| 15:50:18 INFO - PROCESS | 18039 | |0;dojo.html;2629.500394924964;2653.1907768130714;2680.102165774465;2690.838549687018;2698.0826518983554;4621.468531118914;4623.676342656011;4663.114008338422;4727.149113159626;4729.030548737509;4649.139909116807;4656.906861862761;4659.394278743767;4687.0625874825;4725.645576581762;4247.6601871850335;4294.763787991659;4334.263175260214;4358.455193100863;4494.932576011346;4405.140997505488;4426.623736982344;4437.090396468716;4463.33050042493;4473.172463094338;4179.205950869356;4221.514525829538;4227.408162857202;4271.209826182167;4287.849925252617;4306.870793876189;4307.418498502725;4318.5033721121845;4347.760873151976;4350.369196466526;4307.052448461333;4327.632151267146;4334.306510958231;4344.066025804435;4356.215881141393;4455.888602784957;4614.561616646413;4634.536546345372;4679.625629949596;4681.485036645966;5117.923231151536;5158.40678321994;5161.974190129063;5178.818741344035;5186.611004174664;5159.355080614923;5178.171492561172;5182.507661772125;5189.221616757479;5190.169572868323;4634.281686338623;4677.906441871143;4734.692245004064;4736;4816.54242846929;5181.481851814864;5188.948110518922;5220.216967454836;5240.580753539708;5247.370315562081;4975.104481193348;4982.626303027288;5016.347874776328;5023.673461225008;5028.220625803006;4870.099031679079;4960.603151747851;5027.1705168647495;5041.470645582234;5052.141136006888;4974;5000.774965126578;5007.324011258506;5010.423801262828;5055.191169412877;4848.8787780305065;4992.375953005874;4998.925016124761;5007.674501157413;5063.0380227756605;4259.2759230930815;4288.48538175421;4315.28797748368;4316.287812510964;4321.67587430944;3772.2266935278203;3780.8298626561873;3810.6760925321105;3813.103920578662;3861.864834730827;4333.934990975138;4346.47842258931;4347.869563913087;4347.978260108679;4390.8024138913825;4876.122297986397;5024.196128619476;5072.644914855999;5088.898222035538;5123.180291153398;4335.956640433618;4340.327249276367;4341.82632694695;4378.10248898975;4380.16776812411;4593.954060459419;4605.930911036337;4608.032313214196;4616.722996620214;4661.743604101807;4583.289590113538;4745.193317136026;4789.712617242976;4793.18515852306;4798.664093513421;5069.847904562869;5084.186530155157;5084.3644544431945;5091.338126043591;5134.05020071288;4794.376731024944;4805.735684537384;4809.0862736080035;4811.08589368019;4856.344393506832;4786.425628924412;4961.181405068123;4989.950100498949;5021.573166280761;5030.547250747451;5062.924056139234;5090.694558326512;5094.083065048327;5101.438841727481;5148.948510514847;4738.099761045391;4943.950560494349;4955.35580374549;4959.652824302264;4962.057209130254;4888.1690112681645;4922.630802689884;4947.109520286383;4947.678400903929;4968.602511798975;4865.148598995091;4872.585830204331;4921.409430868319;4923.08922849274;4924.433690125681;4789.976050119866;4918.5573298403315;4994.1759609663995;5030.170021946338;5048.469910659474;4862.416510018679;4874.147024270667;4887.731174785421;4901.14230009754;4954.058728841508 15:50:18 INFO - PROCESS | 18039 | |1;ext.html;561.7022977821754;595.2826843653397;602.8342205893382;602.8598475412288;609.2293249039964;28485.43029139416;42260.788696056516;43376.78311608438;43505.564944350546;43541.34687979683;43845.7807710961;44282.892927676825;44405.11189776211;44473.33290000653;44561;7516.173220945719;7673.27103925129;7682.231776822329;7996.800079998017;8141.145179756129;7666;10015.899841001607;10287.382757034564;10290.7427314317;10644.095251903598;10396.948015259952;10424.113950314233;10427.426491542961;10432.269741118125;10440.68677939663;7599.886001709979;7805.804854878616;10218.08037276645;10324.225683073724;10327.638532651321;7648.961755191189;9794.853077203848;10220.693379198636;10227.386356818615;10564.735881602945;40075;40383.59616403857;40421;40492.19015619701;40528.797356013325;3328.766986310959;3410.339393397068;3551.271989242199;3876.733620277378;3901.6293452122004;30357.848210758806;30418.391632167233;30887.691123088705;30894.22764430885;30937;3308.8841890533718;3319.751018673585;3426.4860270959307;3430.9656903430896;3484.442489201741;254766;255664;255771;256042;256395;55834.44165558292;56892.43107568954;57026.42973570294;57041;57041;60511;60668;60730.39269607247;60771;60779.696101520094;14665.48670796517;15049.398024079133;15050.397984080515;15198.544043678707;15201.163935983626;10501.789964200672;11553.884461155281;11669.766604667859;11713.707157320965;12005.87994120065;17639.206235719423;17714;17779;17795.288188472317;17924;6717.227518835396;6787.592744435251;6936.687849046805;7006.964965175243;7033.859322813515;884.9247813935759;969.1955676788249;973.3186769261404;994.9701508954743;1048.5805677728817;29199.854000730284;29816.701832981827;31251.68748312488;31486;31836.204094897814;947.0766003146877;981.0728861226073;1051.4847724614883;1090.2960657569272;1134.4838098665089;15268.389264429521;15697.843021569639;15707.921460392854;15763.842361576237;15877.285522151531;367922;371349;372463;372841;373742;52953.7352313236;53255.73372133115;53321.600527976334;53464.86140554412;53509.73245133827;1169.128998895828;1260.8928241099609;1270.0411189551828;1291.5027714329863;1338.5716570697477;29559.85220073886;31037.68962310348;31124.377512449173;31264.843675781474;31851.36297274088;47035;47514.52485475101;47899.28151077667;47950.760246198544;48034.51965480301;356350;363731;363878;364303;364417;35447;40384;41205.793971029954;41279.58720412877;43859.12281754411;44051.33922991093;44099;44710.3293450605;44858.55141448544;45073.77463112663;37850;38778.80610597042;38844.41733374058;39303.80348098356;39679.2064158721;38079.23841523099;38164.42753358757;38275.26391435771;38950.80524597359;39096.41355379615;37427.2514549702;37490.81254593709;38262.42606360851;38539;38565.80717096396;33370.66629333773;34379;34770.82614586911;34798;34879.651203488655;25981;26188.476230475666;26362.472750545265;26368.340791480365;26696.46607067809 15:50:18 INFO - PROCESS | 18039 | |2;jquery.html;384.2411237805335;387.77509044754044;390.08135840096554;401.22763679916153;410.7268666336886;16366.754498682514;17726.911365443186;18553;18618.627627447444;18629.90685046573;17170.22733976971;17197.914010429962;17809.910950445228;17903.82096179041;17907.462776116703;5019.272205530205;5198.584113270929;5199.194124910626;5207.921881171786;5231.293775340338;3680.5215322008103;3710.8701195458166;5956.136360227764;5965.224520812289;6073.362296958822;5994.46049855513;5999.950008748473;6000.579959402844;6034.155218269446;6037.154798328237;5777.740001699892;5907.852303692399;5928.584999050068;5990.9101363479585;6001.759929602833;5087.389513258396;5219.739013049332;5262.60530460217;5267.657602255841;5270.947290527084;21225.893870530705;21884.12463501458;22165.445863853372;22198;22257;2045.815876571101;2049.631066408046;2089.498520355119;2200.987545728967;2450.6324051392257;13144.60566183016;13208.735825283537;13460.730785384238;13750.793738093937;13978.860211397858;1786.2587026384035;1845.9815401845945;1882.8870267783977;1894.3464504745978;1916.2909723402431;46977;63297.36702632961;64041.67979160074;66791.66604166996;71231;9734.9026509734;9842.311038227255;10375.792484150426;10462.68611941643;10640.733981650366;14423.350949207312;14499.275036248146;14499.565013049625;14518.854811451962;14521;7519.045048287485;7912.446128771046;7939.960300198462;8039.397045221632;8067;7660.846783064308;7704.768856934301;7768.10666773317;7818.804529886798;7837.843243135106;4361.01877077655;4409.739082179743;4465.642748580106;4474.619657329098;4699.365585645894;1885.3872491440336;1914.4926594452481;1929.8166674165932;1944.3000519812856;1952.5021119614407;838.9244967952792;894.6108442827261;924.6717415317465;929.8372784762639;1017.0846238385512;16936.745948810778;17185.39851105205;17411.390601329145;17500.124993750516;17725;883.3419102768479;885.8759773631697;912.8630705394244;914.977125571866;927.4991504587582;9357.672481463116;9773.51132443375;9798.951005245071;10029.26402710777;10038.799224015478;357083;358576;373767;380199;382743;77809.61095194488;78598;78888.60555697184;79473.60263198648;80375.59812201018;929.0894922975386;941.087145468894;958.5973890965672;964.7202311329636;966.8308046092046;15596.376144954074;15690.686186275982;15705.921470392575;15850.286737096627;15978.60053498672;34382;34849.65150348464;36567.08582285464;36612.12281604089;37481.62518374781;49717;51993.480065200376;52056.73971630118;52517;52529.737351313;7567.772966811004;7673.884891726517;7733.883991740241;7886.369090472863;8038.63826127814;11663.659544010774;11815.586454474053;11930.164888457724;12236.327002014974;12255.32595707209;10533.736656583647;10700.411477368509;10808;10816.729581760519;10849.132069434585;10335.431551264752;10596.841047384141;10641.680749577525;10689.679309620724;10798.190135740007;10522.789544209227;10719.839202411815;10828.620998265023;10860.619878304222;10991;7865.4887432319;7880.211978802074;8028.718994835152;8076.353891688768;8111.918880811352;8964.417312874903;10715.303505272132;10718.839217411902;10738.463076846283;10760.569577216824 15:50:18 INFO - PROCESS | 18039 | |3;mootools.html;1298.0913360647548;1463.15868375684;1521.1177517040117;1664;1838.4025191812664;7196.172440169382;7490.213527579607;7519.54882707038;7691.576963267018;7718.614069296541;7532.623368831551;7710.537367757925;7714.768556943287;7725.034370703662;7725.420593455485;1866.9626607467842;1922.4713203868978;1927.5470264487835;2143.431990522513;2172;1959.0890236040239;2129.946751331214;2206.8013878750908;2209.1936443198197;2228.565429741201;2061.1446249806313;2068.979310206901;2083.635363811327;2084.718562993992;2087.5407410369694;1820.1718218210683;2075.833933285341;2078.7921207879244;2079;2083.4583008417767;2096.8322534197227;2163.9891800540895;2167.934961951144;2171.6199665058552;2182.563487302546;7599.582022988733;7653.311201991847;7657.693692252304;7669.38644908406;7678.270564296383;4337.175936572073;4466.59800617946;4469;4471.0610771737975;4471.5081341052455;2849.202223377458;2946.4401763664837;2999.2651800309063;3002.8348440835744;3014.3067094568373;835.3877017356499;867.4144952157269;868.1275318305126;880.1550511508896;880.9911900880974;10323.948380258125;10328.018838210359;10333.379997200193;10374.429406382646;10377.117944974687;3993.2412841560013;4049.2104039712563;4106.609872062149;4114.7942602870335;4155.148194620096;8877.955610222038;8933.19601235892;8933.731988040368;8934.195922366887;8940.776480588038;4519.887002824956;4542.659300552472;4542.841000564964;4555.954440455619;4557.248054071108;3695.501107350527;3791.336516109725;4152.563980782034;4231.978840105779;4233.682473814476;3451.913702157416;3469.670381313771;3540.91147721309;3546.804925729058;3643.7449378543247;1105.9557617695202;1125.752334486428;1151.717829131868;1153.371412580146;1156.8727439981594;707.1372925031453;821.4619424276989;888.7378223423976;910.4400793511943;921.8847644044495;5196.376434827845;5225.895482090337;5303.36359636846;5305.469453054664;5339.225812257201;852.9019162796234;873.7771868173702;878.3631866896449;907.9228265597366;941.242299948548;3696.2237930034457;3748.5689145748042;3788.4885540452237;3821.8280177392085;3829.6744776693736;8879.644814207488;9318.487483188354;9325.626974920928;9380.718578442658;9383.390079644802;9193.632254709737;9275.350725449154;9295.209907157967;9296.953515232515;9304.534773261445;7013.368796808311;7254;7274.563526188445;7297.343239108506;7327.4504412168235;5112.105381558287;5247.947520524746;5304.840854774363;5358.062339090721;5358.758855851418;8499.787505312417;8570.142985701379;8658.39391242607;8665.610047547749;8696.869546956674;8157.632906519102;8489.830203395773;8502.319814414956;8663.566821659018;8682.392232543662;5917.053271476543;6431.646259455775;6499.707513162014;6588.110605068255;6617.239017513048;7468.663910124166;7508.662110205163;7553;7556.24437556262;7580.54516728998;6384.425401713682;6612.338766123349;6623.039659249478;6696.0960270362875;6746.966265168643;6596.472282217315;6648.90026649591;6719;6757.662116894234;6824.385805277549;6167.383261673976;6230.6884655766125;6252.406021427957;6260.68696565179;6261.7182226799;4436.334549817553;4595.954040459553;4621.30680397943;4641.118187544355;4695.741734204652;4599.310103484504;4718.009218064108;4897.632677549127;4957.652964292465;4976.2286845539 15:50:18 INFO - PROCESS | 18039 | |4;prototype.html;292.82430541674995;299.2921740084699;300.1206465057381;314.53605931251394;315.498357611398;4740.431148262205;4830.372051633291;4928.926066109007;4938.2469223425705;4941.283513890488;4637.466691330498;4742.90514189716;4748.477667456577;4760.4525479569775;4768.952310476894;3774.5281839770096;3782.4681004193344;3791.9810400948095;3803.695704343646;3807.809609519527;3624.6737793598572;3650.2881938022097;3782.375907975181;3784.621537846207;3797.6834131179958;3735.9439608405896;3736.1220113273357;3749.2876353492884;3751.1559899022773;3764.171882185915;3731.9067023324496;3743.3262012837677;3749.1189570450924;3761.4357846322996;3780.9810950945343;3318.4192766265805;3330.383878982396;3333.583302087239;3342.6490218526947;3346;4533.705309154927;4563.657725670588;4570.405847239871;4579.793909274091;4581;4275.080857615628;4303.462067241595;4317.7193482423545;4336.544662810423;4341.739495630272;4991.900161996739;4996.875078123039;5025.597952163818;5025.758385841112;5032.521910418541;3400.25194457219;3566.1084728817796;3582.1193873216507;3682.116292089906;3696.0205545530457;5241.266222728783;5255.553277971377;5269.762860671279;5276.182191760283;5277.366715994067;3601.1537288737127;3614.584322802859;3627.183883626216;3665.725070619661;3665.8350374233223;3697.0942119180972;3702.648248416396;3702.7593206441493;3703.7962912039557;3712.9603710960973;3973.7019723520275;4209.494860616745;4210.136921930997;4219.240536703423;4237.703360764717;4998.525140111757;5011.323471331397;5042.294078828967;5052.080209520359;5062.797488100435;1211.7576484703095;1228.9262644241373;1269.2447993443886;1273.8471383434048;1276.9233845969272;814.7189219719187;822.6544851162527;826.4380221449472;829.7718127514981;847.2120927537326;3989.6209860063245;4036.253293140778;4038.757674539537;4046.9797651012145;4049.6962727794944;4583.220852455091;4594;4596.816127354935;4605.700629459075;4636.095961287584;3977.8607748728655;3987.641112299849;4005.35914253718;4010.7593544387432;4024.2494514886116;2366.3847399675865;2448.8530688158767;2457.201409541906;2460.7416221296508;2498.2130628851855;4334.241507736134;4378.16814805186;4392.670549708785;4399.802008909607;4423.159599676052;4704.882377940579;4722.158358240289;4724.811007559659;4730.266808644666;4744.430668319824;4020.533758807645;4339.34909763538;4390;4425.535318791481;4443.933340999887;4533.297338912474;4537.910901383578;4553.954460455486;4563.421666758271;4572.954270457253;4453.265211240109;4504.842330518416;4513.413256276663;4520.231560634635;4547.295169248771;4251.617354438115;4409.889752756207;4440.844570440019;4441.889527618096;4445.333200019893;3375.206826395844;3381.7801842880135;3390.3388839176123;3395.6095049068686;3404.9319013619092;4590.42619672541;4611.515790841913;4641.396618439581;4643.907121857612;4998.525140111684;4848.17581011236;5025.522575355335;5049.520295571915;5051.191809310492;5071.898562028665;5041.369828771403;5053.8736531587;5059.761752478344;5061.772220250024;5082.923756143735;4771.904561908812;4971.254311853251;4984.501549844987;4994.9500504994485;5003.749062734317;5050.72221027847;5068.0234708462995;5075.644704870623;5080.669756465818;5092.872678183075;4915.9922215944935;4950.876228094183;4972.65191436596;4978.701277923336;4988.45127036033 15:50:18 INFO - PROCESS | 18039 | |5;yui.html;698.273795252937;811.3671336357639;818.5988865455927;824.3940703582865;828.1511450762971;13801;14183;14238.003339766221;14239.3592288347;14278.999999999987;14282.642933926658;14423.495177668783;14447.133172009686;14487.565373038798;14518.709625807478;671.8824205763996;871.1854416120916;884.1600479544443;891.5364010714425;892.4333048514208;854.6282367170301;854.811941372897;855.1704846299111;855.1961156512889;855.8844555984924;925.0425809287389;933.3699752666922;933.6685476655791;934.1405906565975;934.2525979216633;702.0592406175698;901.4951627088785;924.154398725169;924.5284904698652;926.7822061815468;687.3950923187613;687.9793606191822;688.3013741052836;688.3770187979886;688.3873352716087;13315.600531983959;13345.332733363293;13361.13152645075;13367.665808354772;13380.598582042554;11870.88129118715;12185.51257949681;12324;12574.559890403792;12689.682757931034;11385.259958102779;11616.186866919319;11692.590759323468;11747.29516229029;12274.509019639203;4131.938020929689;4162.6253637172495;4204.684648651363;4244.978775106105;4308.030693094061;48067.03865922697;48994.755026225;49090.50909490931;49104;49170;9914.55384507699;10011.799764004825;10149.086582207638;10225.437600931871;10263.025012623788;17062.658746824993;17655.293788248327;17705.203265853066;17758.46724598264;17774.733378999324;6589.505787065989;6650.833729156713;6836.794896153124;7041.894371584431;7079.575225486487;3943.901402464904;4000.159966407029;4015.2371049501085;4051.2505186540584;4062.1266427718183;2903.0565066353097;2997.0409468970156;3010.834404107751;3011.653659829104;3013.3973205359016;534.3587694766219;538.2867700297122;543.2638774460628;544.9591280653967;547.1382572448409;464.4821024557594;531.2403263333471;604.5189286248708;634.3878157577959;642.1748053750907;7977.7207797726805;8322.50064996102;8363.330933525303;8382.958085209657;8471.06818249992;573.2891214893585;615.2647586134616;621.6860485454907;625.9123722678829;639.2712307968919;3143.449896268144;3164.4304025275674;3237;3250.967490325114;3362.7982321060813;50876.74561627242;51333.48666513362;51618;55801.720991395596;55819;49116.7544162284;49629;50393;51255.97488050218;51865.74067129716;45911;46474;46778.298325525146;46795;46941.530584694396;7618.352440042659;7702.345300649507;7893.881591776243;7896.131425543071;8052.597370131352;31454.370912581162;31575.21061973469;31800.522992154674;32198.517022245152;33097.50353744648;37328.06679832917;40170.39744403778;40584.79707601443;40990.590094098676;41173.588264116974;9765.85351219718;9816.411015339103;9918.702438926844;9967.40195588267;9971.501424928869;10748.462576871281;10912;10976;11134;11161.888381116085;10379.11777498921;10495.265331426726;10623.787524249317;10856.674299771019;10946.890531094905;11322.830157547478;11436.771264574829;11480.82778758336;11596.47815848272;11895.940520297343;10577.100946419641;11004.614838480615;11032.889671103187;11310.321380717183;12110.878891211327;9565.952170239105;10064.597416103567;10076;10077.244206684674;10290.639827605997;9136.974663934941;9912.405255684682;10033.648822291476;10048.296619236584;10218.1825453965 15:50:18 INFO - PROCESS | 18039 | __end_tp_report 15:50:18 INFO - PROCESS | 18039 | __start_cc_report 15:50:18 INFO - PROCESS | 18039 | _x_x_mozilla_cycle_collect,1096 15:50:18 INFO - PROCESS | 18039 | __end_cc_report 15:50:18 INFO - PROCESS | 18039 | __startTimestamp1463525418794__endTimestamp 15:50:18 INFO - PROCESS | 18039 | 15:50:18 INFO - PROCESS | 18039 | ------- Summary: start ------- 15:50:18 INFO - PROCESS | 18039 | Number of tests: 6 15:50:18 INFO - PROCESS | 18039 | 15:50:18 INFO - PROCESS | 18039 | [#0] dojo.html Cycles:165 Average:4677.54 Median:4798.66 stddev:490.49 (10.2%) stddev-sans-first:464.94 15:50:18 INFO - PROCESS | 18039 | Values: 2629.5 2653.2 2680.1 2690.8 2698.1 4621.5 4623.7 4663.1 4727.1 4729.0 4649.1 4656.9 4659.4 4687.1 4725.6 4247.7 4294.8 4334.3 4358.5 4494.9 4405.1 4426.6 4437.1 4463.3 4473.2 4179.2 4221.5 4227.4 4271.2 4287.8 4306.9 4307.4 4318.5 4347.8 4350.4 4307.1 4327.6 4334.3 4344.1 4356.2 4455.9 4614.6 4634.5 4679.6 4681.5 5117.9 5158.4 5162.0 5178.8 5186.6 5159.4 5178.2 5182.5 5189.2 5190.2 4634.3 4677.9 4734.7 4736.0 4816.5 5181.5 5188.9 5220.2 5240.6 5247.4 4975.1 4982.6 5016.3 5023.7 5028.2 4870.1 4960.6 5027.2 5041.5 5052.1 4974.0 5000.8 5007.3 5010.4 5055.2 4848.9 4992.4 4998.9 5007.7 5063.0 4259.3 4288.5 4315.3 4316.3 4321.7 3772.2 3780.8 3810.7 3813.1 3861.9 4333.9 4346.5 4347.9 4348.0 4390.8 4876.1 5024.2 5072.6 5088.9 5123.2 4336.0 4340.3 4341.8 4378.1 4380.2 4594.0 4605.9 4608.0 4616.7 4661.7 4583.3 4745.2 4789.7 4793.2 4798.7 5069.8 5084.2 5084.4 5091.3 5134.1 4794.4 4805.7 4809.1 4811.1 4856.3 4786.4 4961.2 4990.0 5021.6 5030.5 5062.9 5090.7 5094.1 5101.4 5148.9 4738.1 4944.0 4955.4 4959.7 4962.1 4888.2 4922.6 4947.1 4947.7 4968.6 4865.1 4872.6 4921.4 4923.1 4924.4 4790.0 4918.6 4994.2 5030.2 5048.5 4862.4 4874.1 4887.7 4901.1 4954.1 15:50:18 INFO - PROCESS | 18039 | 15:50:18 INFO - PROCESS | 18039 | [#1] ext.html Cycles:180 Average:50321.92 Median:371906.00 stddev:87696.56 (23.6%) stddev-sans-first:87862.99 15:50:18 INFO - PROCESS | 18039 | Values: 561.7 595.3 602.8 602.9 609.2 28485.4 42260.8 43376.8 43505.6 43541.3 43845.8 44282.9 44405.1 44473.3 44561.0 7516.2 7673.3 7682.2 7996.8 8141.1 7666.0 10015.9 10287.4 10290.7 10644.1 10396.9 10424.1 10427.4 10432.3 10440.7 7599.9 7805.8 10218.1 10324.2 10327.6 7649.0 9794.9 10220.7 10227.4 10564.7 40075.0 40383.6 40421.0 40492.2 40528.8 3328.8 3410.3 3551.3 3876.7 3901.6 30357.8 30418.4 30887.7 30894.2 30937.0 3308.9 3319.8 3426.5 3431.0 3484.4 254766.0 255664.0 255771.0 256042.0 256395.0 55834.4 56892.4 57026.4 57041.0 57041.0 60511.0 60668.0 60730.4 60771.0 60779.7 14665.5 15049.4 15050.4 15198.5 15201.2 10501.8 11553.9 11669.8 11713.7 12005.9 17639.2 17714.0 17779.0 17795.3 17924.0 6717.2 6787.6 6936.7 7007.0 7033.9 884.9 969.2 973.3 995.0 1048.6 29199.9 29816.7 31251.7 31486.0 31836.2 947.1 981.1 1051.5 1090.3 1134.5 15268.4 15697.8 15707.9 15763.8 15877.3 367922.0 371349.0 372463.0 372841.0 373742.0 52953.7 53255.7 53321.6 53464.9 53509.7 1169.1 1260.9 1270.0 1291.5 1338.6 29559.9 31037.7 31124.4 31264.8 31851.4 47035.0 47514.5 47899.3 47950.8 48034.5 356350.0 363731.0 363878.0 364303.0 364417.0 35447.0 40384.0 41205.8 41279.6 43859.1 44051.3 44099.0 44710.3 44858.6 45073.8 37850.0 38778.8 38844.4 39303.8 39679.2 38079.2 38164.4 38275.3 38950.8 39096.4 37427.3 37490.8 38262.4 38539.0 38565.8 33370.7 34379.0 34770.8 34798.0 34879.7 25981.0 26188.5 26362.5 26368.3 26696.5 15:50:18 INFO - PROCESS | 18039 | 15:50:18 INFO - PROCESS | 18039 | [#2] jquery.html Cycles:180 Average:24036.25 Median:381471.00 stddev:61191.29 (16.0%) stddev-sans-first:61337.18 15:50:18 INFO - PROCESS | 18039 | Values: 384.2 387.8 390.1 401.2 410.7 16366.8 17726.9 18553.0 18618.6 18629.9 17170.2 17197.9 17809.9 17903.8 17907.5 5019.3 5198.6 5199.2 5207.9 5231.3 3680.5 3710.9 5956.1 5965.2 6073.4 5994.5 6000.0 6000.6 6034.2 6037.2 5777.7 5907.9 5928.6 5990.9 6001.8 5087.4 5219.7 5262.6 5267.7 5270.9 21225.9 21884.1 22165.4 22198.0 22257.0 2045.8 2049.6 2089.5 2201.0 2450.6 13144.6 13208.7 13460.7 13750.8 13978.9 1786.3 1846.0 1882.9 1894.3 1916.3 46977.0 63297.4 64041.7 66791.7 71231.0 9734.9 9842.3 10375.8 10462.7 10640.7 14423.4 14499.3 14499.6 14518.9 14521.0 7519.0 7912.4 7940.0 8039.4 8067.0 7660.8 7704.8 7768.1 7818.8 7837.8 4361.0 4409.7 4465.6 4474.6 4699.4 1885.4 1914.5 1929.8 1944.3 1952.5 838.9 894.6 924.7 929.8 1017.1 16936.7 17185.4 17411.4 17500.1 17725.0 883.3 885.9 912.9 915.0 927.5 9357.7 9773.5 9799.0 10029.3 10038.8 357083.0 358576.0 373767.0 380199.0 382743.0 77809.6 78598.0 78888.6 79473.6 80375.6 929.1 941.1 958.6 964.7 966.8 15596.4 15690.7 15705.9 15850.3 15978.6 34382.0 34849.7 36567.1 36612.1 37481.6 49717.0 51993.5 52056.7 52517.0 52529.7 7567.8 7673.9 7733.9 7886.4 8038.6 11663.7 11815.6 11930.2 12236.3 12255.3 10533.7 10700.4 10808.0 10816.7 10849.1 10335.4 10596.8 10641.7 10689.7 10798.2 10522.8 10719.8 10828.6 10860.6 10991.0 7865.5 7880.2 8028.7 8076.4 8111.9 8964.4 10715.3 10718.8 10738.5 10760.6 15:50:18 INFO - PROCESS | 18039 | 15:50:18 INFO - PROCESS | 18039 | [#3] mootools.html Cycles:180 Average:5043.53 Median:5305.16 stddev:2787.04 (52.5%) stddev-sans-first:2780.65 15:50:18 INFO - PROCESS | 18039 | Values: 1298.1 1463.2 1521.1 1664.0 1838.4 7196.2 7490.2 7519.5 7691.6 7718.6 7532.6 7710.5 7714.8 7725.0 7725.4 1867.0 1922.5 1927.5 2143.4 2172.0 1959.1 2129.9 2206.8 2209.2 2228.6 2061.1 2069.0 2083.6 2084.7 2087.5 1820.2 2075.8 2078.8 2079.0 2083.5 2096.8 2164.0 2167.9 2171.6 2182.6 7599.6 7653.3 7657.7 7669.4 7678.3 4337.2 4466.6 4469.0 4471.1 4471.5 2849.2 2946.4 2999.3 3002.8 3014.3 835.4 867.4 868.1 880.2 881.0 10323.9 10328.0 10333.4 10374.4 10377.1 3993.2 4049.2 4106.6 4114.8 4155.1 8878.0 8933.2 8933.7 8934.2 8940.8 4519.9 4542.7 4542.8 4556.0 4557.2 3695.5 3791.3 4152.6 4232.0 4233.7 3451.9 3469.7 3540.9 3546.8 3643.7 1106.0 1125.8 1151.7 1153.4 1156.9 707.1 821.5 888.7 910.4 921.9 5196.4 5225.9 5303.4 5305.5 5339.2 852.9 873.8 878.4 907.9 941.2 3696.2 3748.6 3788.5 3821.8 3829.7 8879.6 9318.5 9325.6 9380.7 9383.4 9193.6 9275.4 9295.2 9297.0 9304.5 7013.4 7254.0 7274.6 7297.3 7327.5 5112.1 5247.9 5304.8 5358.1 5358.8 8499.8 8570.1 8658.4 8665.6 8696.9 8157.6 8489.8 8502.3 8663.6 8682.4 5917.1 6431.6 6499.7 6588.1 6617.2 7468.7 7508.7 7553.0 7556.2 7580.5 6384.4 6612.3 6623.0 6696.1 6747.0 6596.5 6648.9 6719.0 6757.7 6824.4 6167.4 6230.7 6252.4 6260.7 6261.7 4436.3 4596.0 4621.3 4641.1 4695.7 4599.3 4718.0 4897.6 4957.7 4976.2 15:50:18 INFO - PROCESS | 18039 | 15:50:18 INFO - PROCESS | 18039 | [#4] prototype.html Cycles:180 Average:4020.71 Median:4433.19 stddev:1159.61 (26.2%) stddev-sans-first:1128.60 15:50:18 INFO - PROCESS | 18039 | Values: 292.8 299.3 300.1 314.5 315.5 4740.4 4830.4 4928.9 4938.2 4941.3 4637.5 4742.9 4748.5 4760.5 4769.0 3774.5 3782.5 3792.0 3803.7 3807.8 3624.7 3650.3 3782.4 3784.6 3797.7 3735.9 3736.1 3749.3 3751.2 3764.2 3731.9 3743.3 3749.1 3761.4 3781.0 3318.4 3330.4 3333.6 3342.6 3346.0 4533.7 4563.7 4570.4 4579.8 4581.0 4275.1 4303.5 4317.7 4336.5 4341.7 4991.9 4996.9 5025.6 5025.8 5032.5 3400.3 3566.1 3582.1 3682.1 3696.0 5241.3 5255.6 5269.8 5276.2 5277.4 3601.2 3614.6 3627.2 3665.7 3665.8 3697.1 3702.6 3702.8 3703.8 3713.0 3973.7 4209.5 4210.1 4219.2 4237.7 4998.5 5011.3 5042.3 5052.1 5062.8 1211.8 1228.9 1269.2 1273.8 1276.9 814.7 822.7 826.4 829.8 847.2 3989.6 4036.3 4038.8 4047.0 4049.7 4583.2 4594.0 4596.8 4605.7 4636.1 3977.9 3987.6 4005.4 4010.8 4024.2 2366.4 2448.9 2457.2 2460.7 2498.2 4334.2 4378.2 4392.7 4399.8 4423.2 4704.9 4722.2 4724.8 4730.3 4744.4 4020.5 4339.3 4390.0 4425.5 4443.9 4533.3 4537.9 4554.0 4563.4 4573.0 4453.3 4504.8 4513.4 4520.2 4547.3 4251.6 4409.9 4440.8 4441.9 4445.3 3375.2 3381.8 3390.3 3395.6 3404.9 4590.4 4611.5 4641.4 4643.9 4998.5 4848.2 5025.5 5049.5 5051.2 5071.9 5041.4 5053.9 5059.8 5061.8 5082.9 4771.9 4971.3 4984.5 4995.0 5003.7 5050.7 5068.0 5075.6 5080.7 5092.9 4916.0 4950.9 4972.7 4978.7 4988.5 15:50:18 INFO - PROCESS | 18039 | 15:50:18 INFO - PROCESS | 18039 | [#5] yui.html Cycles:180 Average:13419.63 Median:25109.52 stddev:15310.69 (61.0%) stddev-sans-first:15323.84 15:50:18 INFO - PROCESS | 18039 | Values: 698.3 811.4 818.6 824.4 828.2 13801.0 14183.0 14238.0 14239.4 14279.0 14282.6 14423.5 14447.1 14487.6 14518.7 671.9 871.2 884.2 891.5 892.4 854.6 854.8 855.2 855.2 855.9 925.0 933.4 933.7 934.1 934.3 702.1 901.5 924.2 924.5 926.8 687.4 688.0 688.3 688.4 688.4 13315.6 13345.3 13361.1 13367.7 13380.6 11870.9 12185.5 12324.0 12574.6 12689.7 11385.3 11616.2 11692.6 11747.3 12274.5 4131.9 4162.6 4204.7 4245.0 4308.0 48067.0 48994.8 49090.5 49104.0 49170.0 9914.6 10011.8 10149.1 10225.4 10263.0 17062.7 17655.3 17705.2 17758.5 17774.7 6589.5 6650.8 6836.8 7041.9 7079.6 3943.9 4000.2 4015.2 4051.3 4062.1 2903.1 2997.0 3010.8 3011.7 3013.4 534.4 538.3 543.3 545.0 547.1 464.5 531.2 604.5 634.4 642.2 7977.7 8322.5 8363.3 8383.0 8471.1 573.3 615.3 621.7 625.9 639.3 3143.4 3164.4 3237.0 3251.0 3362.8 50876.7 51333.5 51618.0 55801.7 55819.0 49116.8 49629.0 50393.0 51256.0 51865.7 45911.0 46474.0 46778.3 46795.0 46941.5 7618.4 7702.3 7893.9 7896.1 8052.6 31454.4 31575.2 31800.5 32198.5 33097.5 37328.1 40170.4 40584.8 40990.6 41173.6 9765.9 9816.4 9918.7 9967.4 9971.5 10748.5 10912.0 10976.0 11134.0 11161.9 10379.1 10495.3 10623.8 10856.7 10946.9 11322.8 11436.8 11480.8 11596.5 11895.9 10577.1 11004.6 11032.9 11310.3 12110.9 9566.0 10064.6 10076.0 10077.2 10290.6 9137.0 9912.4 10033.6 10048.3 10218.2 15:50:18 INFO - PROCESS | 18039 | -------- Summary: end -------- 15:50:18 INFO - PROCESS | 18039 | 15:50:19 INFO - TEST-INFO | 18039: exit 0 15:50:19 INFO - TEST-OK | dromaeo_css | took 1119540ms 15:50:19 INFO - TEST-START | kraken 15:50:19 INFO - operating with platform_type : linux_ 15:50:19 INFO - Initialising browser for kraken test... 15:50:19 INFO - TEST-INFO | started process 18213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJzDMF/profile http://localhost:59110/getInfo.html) 15:50:23 INFO - PROCESS | 18213 | __metrics Screen width/height:1600/1200 15:50:23 INFO - PROCESS | 18213 | colorDepth:24 15:50:23 INFO - PROCESS | 18213 | Browser inner width/height: 1024/697 15:50:23 INFO - PROCESS | 18213 | __metrics 15:50:24 ERROR - PROCESS | 18213 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:50:25 INFO - TEST-INFO | 18213: exit 0 15:50:25 INFO - Browser initialized. 15:50:25 INFO - Running cycle 1/1 for kraken test... 15:50:25 INFO - TEST-INFO | started process 18292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJzDMF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:37 INFO - PROCESS | 18292 | RSS: Main: 154161152 15:50:37 INFO - PROCESS | 18292 | 15:50:40 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59110/tests/kraken/driver.html?testName=audio-beat-detection) 15:50:41 INFO - PROCESS | 18292 | RSS: Main: 210100224 15:50:41 INFO - PROCESS | 18292 | 15:50:44 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59110/tests/kraken/driver.html?testName=audio-dft) 15:50:44 INFO - PROCESS | 18292 | RSS: Main: 197894144 15:50:44 INFO - PROCESS | 18292 | 15:50:48 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59110/tests/kraken/driver.html?testName=audio-fft) 15:50:48 INFO - PROCESS | 18292 | RSS: Main: 266932224 15:50:48 INFO - PROCESS | 18292 | 15:50:50 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59110/tests/kraken/driver.html?testName=audio-oscillator) 15:50:51 INFO - PROCESS | 18292 | RSS: Main: 175652864 15:50:51 INFO - PROCESS | 18292 | 15:50:53 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59110/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:50:54 INFO - PROCESS | 18292 | RSS: Main: 180514816 15:50:54 INFO - PROCESS | 18292 | 15:50:57 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59110/tests/kraken/driver.html?testName=imaging-darkroom) 15:50:58 INFO - PROCESS | 18292 | RSS: Main: 216510464 15:50:58 INFO - PROCESS | 18292 | 15:51:02 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59110/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:02 INFO - PROCESS | 18292 | RSS: Main: 214609920 15:51:02 INFO - PROCESS | 18292 | 15:51:05 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59110/tests/kraken/driver.html?testName=json-parse-financial) 15:51:06 INFO - PROCESS | 18292 | RSS: Main: 214945792 15:51:06 INFO - PROCESS | 18292 | 15:51:08 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59110/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:08 INFO - PROCESS | 18292 | RSS: Main: 209977344 15:51:08 INFO - PROCESS | 18292 | 15:51:10 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59110/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:11 INFO - PROCESS | 18292 | RSS: Main: 211460096 15:51:11 INFO - PROCESS | 18292 | 15:51:13 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59110/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:51:14 INFO - PROCESS | 18292 | RSS: Main: 218157056 15:51:14 INFO - PROCESS | 18292 | 15:51:17 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:51:17 INFO - PROCESS | 18292 | RSS: Main: 219774976 15:51:17 INFO - PROCESS | 18292 | 15:51:20 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:21 INFO - PROCESS | 18292 | RSS: Main: 219557888 15:51:21 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | Cycle 1(1): loaded http://localhost:59110/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59110/tests/kraken/driver.html?testName=ai-astar) 15:51:23 INFO - PROCESS | 18292 | RSS: Main: 265818112 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | __start_tp_report 15:51:23 INFO - PROCESS | 18292 | _x_x_mozilla_page_load 15:51:23 INFO - PROCESS | 18292 | _x_x_mozilla_page_load_details 15:51:23 INFO - PROCESS | 18292 | |i|pagename|runs| 15:51:23 INFO - PROCESS | 18292 | |0;ai-astar;115;109;115;114;115;113;113;115;114;114 15:51:23 INFO - PROCESS | 18292 | |1;audio-beat-detection;161;130;154;222;130;153;155;133;198;134 15:51:23 INFO - PROCESS | 18292 | |2;audio-dft;160;161;160;161;161;163;160;160;161;161 15:51:23 INFO - PROCESS | 18292 | |3;audio-fft;79;74;78;147;77;77;77;78;125;77 15:51:23 INFO - PROCESS | 18292 | |4;audio-oscillator;93;93;150;93;93;93;121;93;92;128 15:51:23 INFO - PROCESS | 18292 | |5;imaging-gaussian-blur;116;117;117;117;117;117;116;116;117;117 15:51:23 INFO - PROCESS | 18292 | |6;imaging-darkroom;146;145;146;146;146;147;146;147;146;147 15:51:23 INFO - PROCESS | 18292 | |7;imaging-desaturate;94;95;95;94;95;94;94;94;94;94 15:51:23 INFO - PROCESS | 18292 | |8;json-parse-financial;63;62;63;64;63;63;64;65;62;62 15:51:23 INFO - PROCESS | 18292 | |9;json-stringify-tinderbox;64;65;64;64;64;64;63;63;64;65 15:51:23 INFO - PROCESS | 18292 | |10;stanford-crypto-aes;83;81;82;81;82;82;89;86;159;82 15:51:23 INFO - PROCESS | 18292 | |11;stanford-crypto-ccm;136;129;135;129;127;136;128;127;152;134 15:51:23 INFO - PROCESS | 18292 | |12;stanford-crypto-pbkdf2;170;170;173;170;168;168;174;173;173;169 15:51:23 INFO - PROCESS | 18292 | |13;stanford-crypto-sha256-iterative;70;69;66;66;66;66;69;66;65;65 15:51:23 INFO - PROCESS | 18292 | __end_tp_report 15:51:23 INFO - PROCESS | 18292 | __start_cc_report 15:51:23 INFO - PROCESS | 18292 | _x_x_mozilla_cycle_collect,2089 15:51:23 INFO - PROCESS | 18292 | __end_cc_report 15:51:23 INFO - PROCESS | 18292 | __startTimestamp1463525483399__endTimestamp 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | ------- Summary: start ------- 15:51:23 INFO - PROCESS | 18292 | Number of tests: 14 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:1.83 (1.6%) stddev-sans-first:1.88 15:51:23 INFO - PROCESS | 18292 | Values: 115.0 109.0 115.0 114.0 115.0 113.0 113.0 115.0 114.0 114.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#1] audio-beat-detection Cycles:10 Average:157.00 Median:154.50 stddev:30.76 (19.9%) stddev-sans-first:32.59 15:51:23 INFO - PROCESS | 18292 | Values: 161.0 130.0 154.0 222.0 130.0 153.0 155.0 133.0 198.0 134.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 15:51:23 INFO - PROCESS | 18292 | Values: 160.0 161.0 160.0 161.0 161.0 163.0 160.0 160.0 161.0 161.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#3] audio-fft Cycles:10 Average:88.90 Median:77.00 stddev:25.39 (33.0%) stddev-sans-first:26.68 15:51:23 INFO - PROCESS | 18292 | Values: 79.0 74.0 78.0 147.0 77.0 77.0 77.0 78.0 125.0 77.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#4] audio-oscillator Cycles:10 Average:104.90 Median:93.00 stddev:20.66 (22.2%) stddev-sans-first:21.46 15:51:23 INFO - PROCESS | 18292 | Values: 93.0 93.0 150.0 93.0 93.0 93.0 121.0 93.0 92.0 128.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:51:23 INFO - PROCESS | 18292 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 15:51:23 INFO - PROCESS | 18292 | Values: 146.0 145.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:51:23 INFO - PROCESS | 18292 | Values: 94.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 15:51:23 INFO - PROCESS | 18292 | Values: 63.0 62.0 63.0 64.0 63.0 63.0 64.0 65.0 62.0 62.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 15:51:23 INFO - PROCESS | 18292 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 63.0 63.0 64.0 65.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:82.00 stddev:24.13 (29.4%) stddev-sans-first:25.43 15:51:23 INFO - PROCESS | 18292 | Values: 83.0 81.0 82.0 81.0 82.0 82.0 89.0 86.0 159.0 82.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:134.50 stddev:7.54 (5.6%) stddev-sans-first:7.94 15:51:23 INFO - PROCESS | 18292 | Values: 136.0 129.0 135.0 129.0 127.0 136.0 128.0 127.0 152.0 134.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.50 stddev:2.25 (1.3%) stddev-sans-first:2.37 15:51:23 INFO - PROCESS | 18292 | Values: 170.0 170.0 173.0 170.0 168.0 168.0 174.0 173.0 173.0 169.0 15:51:23 INFO - PROCESS | 18292 | 15:51:23 INFO - PROCESS | 18292 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.00 stddev:1.81 (2.7%) stddev-sans-first:1.51 15:51:23 INFO - PROCESS | 18292 | Values: 70.0 69.0 66.0 66.0 66.0 66.0 69.0 66.0 65.0 65.0 15:51:23 INFO - PROCESS | 18292 | -------- Summary: end -------- 15:51:23 INFO - PROCESS | 18292 | 15:51:24 INFO - TEST-INFO | 18292: exit 0 15:51:24 INFO - TEST-OK | kraken | took 64882ms 15:51:24 INFO - SUITE-END | took 1184s 15:51:24 INFO - Completed test suite (00:19:44) 15:51:24 INFO - javascript benchmark 15:51:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2629.500394924964, 2653.1907768130714, 2680.102165774465, 2690.838549687018, 2698.0826518983554, 4621.468531118914, 4623.676342656011, 4663.114008338422, 4727.149113159626, 4729.030548737509, 4649.139909116807, 4656.906861862761, 4659.394278743767, 4687.0625874825, 4725.645576581762, 4247.6601871850335, 4294.763787991659, 4334.263175260214, 4358.455193100863, 4494.932576011346, 4405.140997505488, 4426.623736982344, 4437.090396468716, 4463.33050042493, 4473.172463094338, 4179.205950869356, 4221.514525829538, 4227.408162857202, 4271.209826182167, 4287.849925252617, 4306.870793876189, 4307.418498502725, 4318.5033721121845, 4347.760873151976, 4350.369196466526, 4307.052448461333, 4327.632151267146, 4334.306510958231, 4344.066025804435, 4356.215881141393, 4455.888602784957, 4614.561616646413, 4634.536546345372, 4679.625629949596, 4681.485036645966, 5117.923231151536, 5158.40678321994, 5161.974190129063, 5178.818741344035, 5186.611004174664, 5159.355080614923, 5178.171492561172, 5182.507661772125, 5189.221616757479, 5190.169572868323, 4634.281686338623, 4677.906441871143, 4734.692245004064, 4736.0, 4816.54242846929, 5181.481851814864, 5188.948110518922, 5220.216967454836, 5240.580753539708, 5247.370315562081, 4975.104481193348, 4982.626303027288, 5016.347874776328, 5023.673461225008, 5028.220625803006, 4870.099031679079, 4960.603151747851, 5027.1705168647495, 5041.470645582234, 5052.141136006888, 4974.0, 5000.774965126578, 5007.324011258506, 5010.423801262828, 5055.191169412877, 4848.8787780305065, 4992.375953005874, 4998.925016124761, 5007.674501157413, 5063.0380227756605, 4259.2759230930815, 4288.48538175421, 4315.28797748368, 4316.287812510964, 4321.67587430944, 3772.2266935278203, 3780.8298626561873, 3810.6760925321105, 3813.103920578662, 3861.864834730827, 4333.934990975138, 4346.47842258931, 4347.869563913087, 4347.978260108679, 4390.8024138913825, 4876.122297986397, 5024.196128619476, 5072.644914855999, 5088.898222035538, 5123.180291153398, 4335.956640433618, 4340.327249276367, 4341.82632694695, 4378.10248898975, 4380.16776812411, 4593.954060459419, 4605.930911036337, 4608.032313214196, 4616.722996620214, 4661.743604101807, 4583.289590113538, 4745.193317136026, 4789.712617242976, 4793.18515852306, 4798.664093513421, 5069.847904562869, 5084.186530155157, 5084.3644544431945, 5091.338126043591, 5134.05020071288, 4794.376731024944, 4805.735684537384, 4809.0862736080035, 4811.08589368019, 4856.344393506832, 4786.425628924412, 4961.181405068123, 4989.950100498949, 5021.573166280761, 5030.547250747451, 5062.924056139234, 5090.694558326512, 5094.083065048327, 5101.438841727481, 5148.948510514847, 4738.099761045391, 4943.950560494349, 4955.35580374549, 4959.652824302264, 4962.057209130254, 4888.1690112681645, 4922.630802689884, 4947.109520286383, 4947.678400903929, 4968.602511798975, 4865.148598995091, 4872.585830204331, 4921.409430868319, 4923.08922849274, 4924.433690125681, 4789.976050119866, 4918.5573298403315, 4994.1759609663995, 5030.170021946338, 5048.469910659474, 4862.416510018679, 4874.147024270667, 4887.731174785421, 4901.14230009754, 4954.058728841508], "value": 4646.606470508195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.7022977821754, 595.2826843653397, 602.8342205893382, 602.8598475412288, 609.2293249039964, 28485.43029139416, 42260.788696056516, 43376.78311608438, 43505.564944350546, 43541.34687979683, 43845.7807710961, 44282.892927676825, 44405.11189776211, 44473.33290000653, 44561.0, 7516.173220945719, 7673.27103925129, 7682.231776822329, 7996.800079998017, 8141.145179756129, 7666.0, 10015.899841001607, 10287.382757034564, 10290.7427314317, 10644.095251903598, 10396.948015259952, 10424.113950314233, 10427.426491542961, 10432.269741118125, 10440.68677939663, 7599.886001709979, 7805.804854878616, 10218.08037276645, 10324.225683073724, 10327.638532651321, 7648.961755191189, 9794.853077203848, 10220.693379198636, 10227.386356818615, 10564.735881602945, 40075.0, 40383.59616403857, 40421.0, 40492.19015619701, 40528.797356013325, 3328.766986310959, 3410.339393397068, 3551.271989242199, 3876.733620277378, 3901.6293452122004, 30357.848210758806, 30418.391632167233, 30887.691123088705, 30894.22764430885, 30937.0, 3308.8841890533718, 3319.751018673585, 3426.4860270959307, 3430.9656903430896, 3484.442489201741, 254766.0, 255664.0, 255771.0, 256042.0, 256395.0, 55834.44165558292, 56892.43107568954, 57026.42973570294, 57041.0, 57041.0, 60511.0, 60668.0, 60730.39269607247, 60771.0, 60779.696101520094, 14665.48670796517, 15049.398024079133, 15050.397984080515, 15198.544043678707, 15201.163935983626, 10501.789964200672, 11553.884461155281, 11669.766604667859, 11713.707157320965, 12005.87994120065, 17639.206235719423, 17714.0, 17779.0, 17795.288188472317, 17924.0, 6717.227518835396, 6787.592744435251, 6936.687849046805, 7006.964965175243, 7033.859322813515, 884.9247813935759, 969.1955676788249, 973.3186769261404, 994.9701508954743, 1048.5805677728817, 29199.854000730284, 29816.701832981827, 31251.68748312488, 31486.0, 31836.204094897814, 947.0766003146877, 981.0728861226073, 1051.4847724614883, 1090.2960657569272, 1134.4838098665089, 15268.389264429521, 15697.843021569639, 15707.921460392854, 15763.842361576237, 15877.285522151531, 367922.0, 371349.0, 372463.0, 372841.0, 373742.0, 52953.7352313236, 53255.73372133115, 53321.600527976334, 53464.86140554412, 53509.73245133827, 1169.128998895828, 1260.8928241099609, 1270.0411189551828, 1291.5027714329863, 1338.5716570697477, 29559.85220073886, 31037.68962310348, 31124.377512449173, 31264.843675781474, 31851.36297274088, 47035.0, 47514.52485475101, 47899.28151077667, 47950.760246198544, 48034.51965480301, 356350.0, 363731.0, 363878.0, 364303.0, 364417.0, 35447.0, 40384.0, 41205.793971029954, 41279.58720412877, 43859.12281754411, 44051.33922991093, 44099.0, 44710.3293450605, 44858.55141448544, 45073.77463112663, 37850.0, 38778.80610597042, 38844.41733374058, 39303.80348098356, 39679.2064158721, 38079.23841523099, 38164.42753358757, 38275.26391435771, 38950.80524597359, 39096.41355379615, 37427.2514549702, 37490.81254593709, 38262.42606360851, 38539.0, 38565.80717096396, 33370.66629333773, 34379.0, 34770.82614586911, 34798.0, 34879.651203488655, 25981.0, 26188.476230475666, 26362.472750545265, 26368.340791480365, 26696.46607067809], "value": 19101.484248220528, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.2411237805335, 387.77509044754044, 390.08135840096554, 401.22763679916153, 410.7268666336886, 16366.754498682514, 17726.911365443186, 18553.0, 18618.627627447444, 18629.90685046573, 17170.22733976971, 17197.914010429962, 17809.910950445228, 17903.82096179041, 17907.462776116703, 5019.272205530205, 5198.584113270929, 5199.194124910626, 5207.921881171786, 5231.293775340338, 3680.5215322008103, 3710.8701195458166, 5956.136360227764, 5965.224520812289, 6073.362296958822, 5994.46049855513, 5999.950008748473, 6000.579959402844, 6034.155218269446, 6037.154798328237, 5777.740001699892, 5907.852303692399, 5928.584999050068, 5990.9101363479585, 6001.759929602833, 5087.389513258396, 5219.739013049332, 5262.60530460217, 5267.657602255841, 5270.947290527084, 21225.893870530705, 21884.12463501458, 22165.445863853372, 22198.0, 22257.0, 2045.815876571101, 2049.631066408046, 2089.498520355119, 2200.987545728967, 2450.6324051392257, 13144.60566183016, 13208.735825283537, 13460.730785384238, 13750.793738093937, 13978.860211397858, 1786.2587026384035, 1845.9815401845945, 1882.8870267783977, 1894.3464504745978, 1916.2909723402431, 46977.0, 63297.36702632961, 64041.67979160074, 66791.66604166996, 71231.0, 9734.9026509734, 9842.311038227255, 10375.792484150426, 10462.68611941643, 10640.733981650366, 14423.350949207312, 14499.275036248146, 14499.565013049625, 14518.854811451962, 14521.0, 7519.045048287485, 7912.446128771046, 7939.960300198462, 8039.397045221632, 8067.0, 7660.846783064308, 7704.768856934301, 7768.10666773317, 7818.804529886798, 7837.843243135106, 4361.01877077655, 4409.739082179743, 4465.642748580106, 4474.619657329098, 4699.365585645894, 1885.3872491440336, 1914.4926594452481, 1929.8166674165932, 1944.3000519812856, 1952.5021119614407, 838.9244967952792, 894.6108442827261, 924.6717415317465, 929.8372784762639, 1017.0846238385512, 16936.745948810778, 17185.39851105205, 17411.390601329145, 17500.124993750516, 17725.0, 883.3419102768479, 885.8759773631697, 912.8630705394244, 914.977125571866, 927.4991504587582, 9357.672481463116, 9773.51132443375, 9798.951005245071, 10029.26402710777, 10038.799224015478, 357083.0, 358576.0, 373767.0, 380199.0, 382743.0, 77809.61095194488, 78598.0, 78888.60555697184, 79473.60263198648, 80375.59812201018, 929.0894922975386, 941.087145468894, 958.5973890965672, 964.7202311329636, 966.8308046092046, 15596.376144954074, 15690.686186275982, 15705.921470392575, 15850.286737096627, 15978.60053498672, 34382.0, 34849.65150348464, 36567.08582285464, 36612.12281604089, 37481.62518374781, 49717.0, 51993.480065200376, 52056.73971630118, 52517.0, 52529.737351313, 7567.772966811004, 7673.884891726517, 7733.883991740241, 7886.369090472863, 8038.63826127814, 11663.659544010774, 11815.586454474053, 11930.164888457724, 12236.327002014974, 12255.32595707209, 10533.736656583647, 10700.411477368509, 10808.0, 10816.729581760519, 10849.132069434585, 10335.431551264752, 10596.841047384141, 10641.680749577525, 10689.679309620724, 10798.190135740007, 10522.789544209227, 10719.839202411815, 10828.620998265023, 10860.619878304222, 10991.0, 7865.4887432319, 7880.211978802074, 8028.718994835152, 8076.353891688768, 8111.918880811352, 8964.417312874903, 10715.303505272132, 10718.839217411902, 10738.463076846283, 10760.569577216824], "value": 8575.705842896255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.0913360647548, 1463.15868375684, 1521.1177517040117, 1664.0, 1838.4025191812664, 7196.172440169382, 7490.213527579607, 7519.54882707038, 7691.576963267018, 7718.614069296541, 7532.623368831551, 7710.537367757925, 7714.768556943287, 7725.034370703662, 7725.420593455485, 1866.9626607467842, 1922.4713203868978, 1927.5470264487835, 2143.431990522513, 2172.0, 1959.0890236040239, 2129.946751331214, 2206.8013878750908, 2209.1936443198197, 2228.565429741201, 2061.1446249806313, 2068.979310206901, 2083.635363811327, 2084.718562993992, 2087.5407410369694, 1820.1718218210683, 2075.833933285341, 2078.7921207879244, 2079.0, 2083.4583008417767, 2096.8322534197227, 2163.9891800540895, 2167.934961951144, 2171.6199665058552, 2182.563487302546, 7599.582022988733, 7653.311201991847, 7657.693692252304, 7669.38644908406, 7678.270564296383, 4337.175936572073, 4466.59800617946, 4469.0, 4471.0610771737975, 4471.5081341052455, 2849.202223377458, 2946.4401763664837, 2999.2651800309063, 3002.8348440835744, 3014.3067094568373, 835.3877017356499, 867.4144952157269, 868.1275318305126, 880.1550511508896, 880.9911900880974, 10323.948380258125, 10328.018838210359, 10333.379997200193, 10374.429406382646, 10377.117944974687, 3993.2412841560013, 4049.2104039712563, 4106.609872062149, 4114.7942602870335, 4155.148194620096, 8877.955610222038, 8933.19601235892, 8933.731988040368, 8934.195922366887, 8940.776480588038, 4519.887002824956, 4542.659300552472, 4542.841000564964, 4555.954440455619, 4557.248054071108, 3695.501107350527, 3791.336516109725, 4152.563980782034, 4231.978840105779, 4233.682473814476, 3451.913702157416, 3469.670381313771, 3540.91147721309, 3546.804925729058, 3643.7449378543247, 1105.9557617695202, 1125.752334486428, 1151.717829131868, 1153.371412580146, 1156.8727439981594, 707.1372925031453, 821.4619424276989, 888.7378223423976, 910.4400793511943, 921.8847644044495, 5196.376434827845, 5225.895482090337, 5303.36359636846, 5305.469453054664, 5339.225812257201, 852.9019162796234, 873.7771868173702, 878.3631866896449, 907.9228265597366, 941.242299948548, 3696.2237930034457, 3748.5689145748042, 3788.4885540452237, 3821.8280177392085, 3829.6744776693736, 8879.644814207488, 9318.487483188354, 9325.626974920928, 9380.718578442658, 9383.390079644802, 9193.632254709737, 9275.350725449154, 9295.209907157967, 9296.953515232515, 9304.534773261445, 7013.368796808311, 7254.0, 7274.563526188445, 7297.343239108506, 7327.4504412168235, 5112.105381558287, 5247.947520524746, 5304.840854774363, 5358.062339090721, 5358.758855851418, 8499.787505312417, 8570.142985701379, 8658.39391242607, 8665.610047547749, 8696.869546956674, 8157.632906519102, 8489.830203395773, 8502.319814414956, 8663.566821659018, 8682.392232543662, 5917.053271476543, 6431.646259455775, 6499.707513162014, 6588.110605068255, 6617.239017513048, 7468.663910124166, 7508.662110205163, 7553.0, 7556.24437556262, 7580.54516728998, 6384.425401713682, 6612.338766123349, 6623.039659249478, 6696.0960270362875, 6746.966265168643, 6596.472282217315, 6648.90026649591, 6719.0, 6757.662116894234, 6824.385805277549, 6167.383261673976, 6230.6884655766125, 6252.406021427957, 6260.68696565179, 6261.7182226799, 4436.334549817553, 4595.954040459553, 4621.30680397943, 4641.118187544355, 4695.741734204652, 4599.310103484504, 4718.009218064108, 4897.632677549127, 4957.652964292465, 4976.2286845539], "value": 4074.3474169862525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.82430541674995, 299.2921740084699, 300.1206465057381, 314.53605931251394, 315.498357611398, 4740.431148262205, 4830.372051633291, 4928.926066109007, 4938.2469223425705, 4941.283513890488, 4637.466691330498, 4742.90514189716, 4748.477667456577, 4760.4525479569775, 4768.952310476894, 3774.5281839770096, 3782.4681004193344, 3791.9810400948095, 3803.695704343646, 3807.809609519527, 3624.6737793598572, 3650.2881938022097, 3782.375907975181, 3784.621537846207, 3797.6834131179958, 3735.9439608405896, 3736.1220113273357, 3749.2876353492884, 3751.1559899022773, 3764.171882185915, 3731.9067023324496, 3743.3262012837677, 3749.1189570450924, 3761.4357846322996, 3780.9810950945343, 3318.4192766265805, 3330.383878982396, 3333.583302087239, 3342.6490218526947, 3346.0, 4533.705309154927, 4563.657725670588, 4570.405847239871, 4579.793909274091, 4581.0, 4275.080857615628, 4303.462067241595, 4317.7193482423545, 4336.544662810423, 4341.739495630272, 4991.900161996739, 4996.875078123039, 5025.597952163818, 5025.758385841112, 5032.521910418541, 3400.25194457219, 3566.1084728817796, 3582.1193873216507, 3682.116292089906, 3696.0205545530457, 5241.266222728783, 5255.553277971377, 5269.762860671279, 5276.182191760283, 5277.366715994067, 3601.1537288737127, 3614.584322802859, 3627.183883626216, 3665.725070619661, 3665.8350374233223, 3697.0942119180972, 3702.648248416396, 3702.7593206441493, 3703.7962912039557, 3712.9603710960973, 3973.7019723520275, 4209.494860616745, 4210.136921930997, 4219.240536703423, 4237.703360764717, 4998.525140111757, 5011.323471331397, 5042.294078828967, 5052.080209520359, 5062.797488100435, 1211.7576484703095, 1228.9262644241373, 1269.2447993443886, 1273.8471383434048, 1276.9233845969272, 814.7189219719187, 822.6544851162527, 826.4380221449472, 829.7718127514981, 847.2120927537326, 3989.6209860063245, 4036.253293140778, 4038.757674539537, 4046.9797651012145, 4049.6962727794944, 4583.220852455091, 4594.0, 4596.816127354935, 4605.700629459075, 4636.095961287584, 3977.8607748728655, 3987.641112299849, 4005.35914253718, 4010.7593544387432, 4024.2494514886116, 2366.3847399675865, 2448.8530688158767, 2457.201409541906, 2460.7416221296508, 2498.2130628851855, 4334.241507736134, 4378.16814805186, 4392.670549708785, 4399.802008909607, 4423.159599676052, 4704.882377940579, 4722.158358240289, 4724.811007559659, 4730.266808644666, 4744.430668319824, 4020.533758807645, 4339.34909763538, 4390.0, 4425.535318791481, 4443.933340999887, 4533.297338912474, 4537.910901383578, 4553.954460455486, 4563.421666758271, 4572.954270457253, 4453.265211240109, 4504.842330518416, 4513.413256276663, 4520.231560634635, 4547.295169248771, 4251.617354438115, 4409.889752756207, 4440.844570440019, 4441.889527618096, 4445.333200019893, 3375.206826395844, 3381.7801842880135, 3390.3388839176123, 3395.6095049068686, 3404.9319013619092, 4590.42619672541, 4611.515790841913, 4641.396618439581, 4643.907121857612, 4998.525140111684, 4848.17581011236, 5025.522575355335, 5049.520295571915, 5051.191809310492, 5071.898562028665, 5041.369828771403, 5053.8736531587, 5059.761752478344, 5061.772220250024, 5082.923756143735, 4771.904561908812, 4971.254311853251, 4984.501549844987, 4994.9500504994485, 5003.749062734317, 5050.72221027847, 5068.0234708462995, 5075.644704870623, 5080.669756465818, 5092.872678183075, 4915.9922215944935, 4950.876228094183, 4972.65191436596, 4978.701277923336, 4988.45127036033], "value": 3657.5967509521442, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.273795252937, 811.3671336357639, 818.5988865455927, 824.3940703582865, 828.1511450762971, 13801.0, 14183.0, 14238.003339766221, 14239.3592288347, 14278.999999999987, 14282.642933926658, 14423.495177668783, 14447.133172009686, 14487.565373038798, 14518.709625807478, 671.8824205763996, 871.1854416120916, 884.1600479544443, 891.5364010714425, 892.4333048514208, 854.6282367170301, 854.811941372897, 855.1704846299111, 855.1961156512889, 855.8844555984924, 925.0425809287389, 933.3699752666922, 933.6685476655791, 934.1405906565975, 934.2525979216633, 702.0592406175698, 901.4951627088785, 924.154398725169, 924.5284904698652, 926.7822061815468, 687.3950923187613, 687.9793606191822, 688.3013741052836, 688.3770187979886, 688.3873352716087, 13315.600531983959, 13345.332733363293, 13361.13152645075, 13367.665808354772, 13380.598582042554, 11870.88129118715, 12185.51257949681, 12324.0, 12574.559890403792, 12689.682757931034, 11385.259958102779, 11616.186866919319, 11692.590759323468, 11747.29516229029, 12274.509019639203, 4131.938020929689, 4162.6253637172495, 4204.684648651363, 4244.978775106105, 4308.030693094061, 48067.03865922697, 48994.755026225, 49090.50909490931, 49104.0, 49170.0, 9914.55384507699, 10011.799764004825, 10149.086582207638, 10225.437600931871, 10263.025012623788, 17062.658746824993, 17655.293788248327, 17705.203265853066, 17758.46724598264, 17774.733378999324, 6589.505787065989, 6650.833729156713, 6836.794896153124, 7041.894371584431, 7079.575225486487, 3943.901402464904, 4000.159966407029, 4015.2371049501085, 4051.2505186540584, 4062.1266427718183, 2903.0565066353097, 2997.0409468970156, 3010.834404107751, 3011.653659829104, 3013.3973205359016, 534.3587694766219, 538.2867700297122, 543.2638774460628, 544.9591280653967, 547.1382572448409, 464.4821024557594, 531.2403263333471, 604.5189286248708, 634.3878157577959, 642.1748053750907, 7977.7207797726805, 8322.50064996102, 8363.330933525303, 8382.958085209657, 8471.06818249992, 573.2891214893585, 615.2647586134616, 621.6860485454907, 625.9123722678829, 639.2712307968919, 3143.449896268144, 3164.4304025275674, 3237.0, 3250.967490325114, 3362.7982321060813, 50876.74561627242, 51333.48666513362, 51618.0, 55801.720991395596, 55819.0, 49116.7544162284, 49629.0, 50393.0, 51255.97488050218, 51865.74067129716, 45911.0, 46474.0, 46778.298325525146, 46795.0, 46941.530584694396, 7618.352440042659, 7702.345300649507, 7893.881591776243, 7896.131425543071, 8052.597370131352, 31454.370912581162, 31575.21061973469, 31800.522992154674, 32198.517022245152, 33097.50353744648, 37328.06679832917, 40170.39744403778, 40584.79707601443, 40990.590094098676, 41173.588264116974, 9765.85351219718, 9816.411015339103, 9918.702438926844, 9967.40195588267, 9971.501424928869, 10748.462576871281, 10912.0, 10976.0, 11134.0, 11161.888381116085, 10379.11777498921, 10495.265331426726, 10623.787524249317, 10856.674299771019, 10946.890531094905, 11322.830157547478, 11436.771264574829, 11480.82778758336, 11596.47815848272, 11895.940520297343, 10577.100946419641, 11004.614838480615, 11032.889671103187, 11310.321380717183, 12110.878891211327, 9565.952170239105, 10064.597416103567, 10076.0, 10077.244206684674, 10290.639827605997, 9136.974663934941, 9912.405255684682, 10033.648822291476, 10048.296619236584, 10218.1825453965], "value": 6215.870810295687, "unit": "score"}], "name": "dromaeo_css", "value": 6427.581038081629, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 115.0, 114.0, 115.0, 113.0, 113.0, 115.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 130.0, 154.0, 222.0, 130.0, 153.0, 155.0, 133.0, 198.0, 134.0], "value": 157.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 161.0, 161.0, 163.0, 160.0, 160.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 78.0, 147.0, 77.0, 77.0, 77.0, 78.0, 125.0, 77.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 150.0, 93.0, 93.0, 93.0, 121.0, 93.0, 92.0, 128.0], "value": 104.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 64.0, 63.0, 63.0, 64.0, 65.0, 62.0, 62.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0, 65.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 81.0, 82.0, 82.0, 89.0, 86.0, 159.0, 82.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 129.0, 135.0, 129.0, 127.0, 136.0, 128.0, 127.0, 152.0, 134.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 173.0, 170.0, 168.0, 168.0, 174.0, 173.0, 173.0, 169.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 66.0, 66.0, 66.0, 66.0, 69.0, 66.0, 65.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1571.1999999999998, "alertThreshold": 2.0}]} 15:51:24 INFO - Return code: 0 15:51:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:51:24 ERROR - # TBPL SUCCESS # 15:51:24 INFO - Running post-action listener: _resource_record_post_action 15:51:24 INFO - ##### 15:51:24 INFO - ##### Finished run-tests step (success) 15:51:24 INFO - ##### 15:51:24 INFO - Running post-run listener: _resource_record_post_run 15:51:24 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543055872; Read time: 144; Write time: 537856 15:51:24 INFO - TinderboxPrint: CPU usage
13.2% 15:51:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 144 15:51:24 INFO - TinderboxPrint: I/O write bytes / time
543,055,872 / 537,856 15:51:24 INFO - TinderboxPrint: CPU idle
8,316.5 (86.8%) 15:51:24 INFO - TinderboxPrint: CPU user
1,223.2 (12.8%) 15:51:24 INFO - TinderboxPrint: Swap in / out
0 / 0 15:51:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 249139200; Read time: 0; Write time: 319608 15:51:24 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291651584; Read time: 144; Write time: 218144 15:51:25 INFO - Running post-run listener: _upload_blobber_files 15:51:25 INFO - Blob upload gear active. 15:51:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:25 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 15:51:25 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'] 15:51:25 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 15:51:25 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:51:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:26 INFO - (blobuploader) - INFO - Done attempting. 15:51:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:51:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:51:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:31 INFO - (blobuploader) - INFO - Done attempting. 15:51:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:51:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:51:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:32 INFO - (blobuploader) - INFO - Done attempting. 15:51:32 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:32 INFO - Return code: 0 15:51:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a59e17484fe107bb3d355b13cfd34410aff4a7c77707173fe8ebdef978630a96a57edd4c1394c7aff0ff13fa7edd2aaa61450e9d8187a4b76bec05b921a7a6f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e084149a5c9aae99cb812c2b57b792590fd98f588d7549a5885808aa19ce96285decd910df011d330cadeedd5af3d06a2015801151a2c404eb935e943635f18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f142e3b6a7144341196734c4fa46c6228748bc2ff24e5f68206dcec3d004c68fc5b1aa88edfe3f6df77dc560eafba7c593cf52b5e0e9faaf036dcd55ec7de394"} 15:51:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:32 INFO - Contents: 15:51:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a59e17484fe107bb3d355b13cfd34410aff4a7c77707173fe8ebdef978630a96a57edd4c1394c7aff0ff13fa7edd2aaa61450e9d8187a4b76bec05b921a7a6f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e084149a5c9aae99cb812c2b57b792590fd98f588d7549a5885808aa19ce96285decd910df011d330cadeedd5af3d06a2015801151a2c404eb935e943635f18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f142e3b6a7144341196734c4fa46c6228748bc2ff24e5f68206dcec3d004c68fc5b1aa88edfe3f6df77dc560eafba7c593cf52b5e0e9faaf036dcd55ec7de394"} 15:51:32 INFO - Running post-run listener: copy_logs_to_upload_dir 15:51:32 INFO - Copying logs to upload dir... 15:51:32 INFO - mkdir: /builds/slave/test/build/upload/logs 15:51:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.810190 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-05-17 15:51:31.993692) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 15:51:31.997054) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685 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/a59e17484fe107bb3d355b13cfd34410aff4a7c77707173fe8ebdef978630a96a57edd4c1394c7aff0ff13fa7edd2aaa61450e9d8187a4b76bec05b921a7a6f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e084149a5c9aae99cb812c2b57b792590fd98f588d7549a5885808aa19ce96285decd910df011d330cadeedd5af3d06a2015801151a2c404eb935e943635f18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f142e3b6a7144341196734c4fa46c6228748bc2ff24e5f68206dcec3d004c68fc5b1aa88edfe3f6df77dc560eafba7c593cf52b5e0e9faaf036dcd55ec7de394"} build_url:https://queue.taskcluster.net/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011477 build_url: 'https://queue.taskcluster.net/v1/task/ULe1aD_GRoy_lcxYJ6pwFQ/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/a59e17484fe107bb3d355b13cfd34410aff4a7c77707173fe8ebdef978630a96a57edd4c1394c7aff0ff13fa7edd2aaa61450e9d8187a4b76bec05b921a7a6f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5e084149a5c9aae99cb812c2b57b792590fd98f588d7549a5885808aa19ce96285decd910df011d330cadeedd5af3d06a2015801151a2c404eb935e943635f18", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f142e3b6a7144341196734c4fa46c6228748bc2ff24e5f68206dcec3d004c68fc5b1aa88edfe3f6df77dc560eafba7c593cf52b5e0e9faaf036dcd55ec7de394"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 15:51:32.021308) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:51:32.021636) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463524245.577555-1676816685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 15:51:32.106383) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 15:51:32.106710) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 15:51:32.106988) ========= ========= Total master_lag: 0.16 =========