builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1458277924.54 results: success (0) buildid: 20160317214015 builduid: 03cb30dbf36843baa7b56b3a7aa7b083 revision: 02cf3a4bf42ae31d09d2088cb25334d13e2523ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.541740) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.542190) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.542504) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006433 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.612385) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.612671) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.668355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.668610) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004701 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.720591) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.720853) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.721171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.721456) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-17 22:12:04-- 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% 95.6M=0s 2016-03-17 22:12:04 (95.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091572 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.829637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.829912) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.118650 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.957973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:04.958338) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 02cf3a4bf42ae31d09d2088cb25334d13e2523ec --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 02cf3a4bf42ae31d09d2088cb25334d13e2523ec --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=516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-17 22:12:05,111 truncating revision to first 12 chars 2016-03-17 22:12:05,111 Setting DEBUG logging. 2016-03-17 22:12:05,111 attempt 1/10 2016-03-17 22:12:05,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/02cf3a4bf42a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-17 22:12:05,387 unpacking tar archive at: fx-team-02cf3a4bf42a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.576112 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:05.555775) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:05.556260) ========= echo 02cf3a4bf42ae31d09d2088cb25334d13e2523ec in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'02cf3a4bf42ae31d09d2088cb25334d13e2523ec'] 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=516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02cf3a4bf42ae31d09d2088cb25334d13e2523ec program finished with exit code 0 elapsedTime=0.004715 script_repo_revision: '02cf3a4bf42ae31d09d2088cb25334d13e2523ec' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:05.611441) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:05.611716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-17 22:12:05.621703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-17 22:12:05.621979) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:12:05 INFO - MultiFileLogger online at 20160317 22:12:05 in /builds/slave/test 22:12:05 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 22:12:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:12:05 INFO - {'append_to_log': False, 22:12:05 INFO - 'base_work_dir': '/builds/slave/test', 22:12:05 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:12:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:12:05 INFO - 'branch': 'Fx-Team-Non-PGO', 22:12:05 INFO - 'buildbot_json_path': 'buildprops.json', 22:12:05 INFO - 'config_files': ('talos/linux_config.py',), 22:12:05 INFO - 'default_actions': ('clobber', 22:12:05 INFO - 'read-buildbot-config', 22:12:05 INFO - 'download-and-extract', 22:12:05 INFO - 'populate-webroot', 22:12:05 INFO - 'create-virtualenv', 22:12:05 INFO - 'install', 22:12:05 INFO - 'run-tests'), 22:12:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:12:05 INFO - 'download_minidump_stackwalk': True, 22:12:05 INFO - 'download_symbols': 'ondemand', 22:12:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:12:05 INFO - 'tooltool.py': '/tools/tooltool.py', 22:12:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:12:05 INFO - '/tools/misc-python/virtualenv.py')}, 22:12:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:12:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:12:05 INFO - 'installer_path': 'installer.exe', 22:12:05 INFO - 'log_level': 'info', 22:12:05 INFO - 'log_name': 'talos', 22:12:05 INFO - 'log_to_console': True, 22:12:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:12:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:12:05 INFO - 'opt_config_files': (), 22:12:05 INFO - 'pip_index': False, 22:12:05 INFO - 'sps_profile': False, 22:12:05 INFO - 'sps_profile_interval': 0, 22:12:05 INFO - 'suite': 'dromaeojs', 22:12:05 INFO - 'system_bits': '32', 22:12:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:12:05 INFO - 'title': 'talos-linux64-ix-061', 22:12:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:12:05 INFO - 'use_talos_json': True, 22:12:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:12:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:12:05 INFO - 'work_dir': 'build'} 22:12:05 INFO - ##### 22:12:05 INFO - ##### Running clobber step. 22:12:05 INFO - ##### 22:12:05 INFO - Running pre-action listener: _resource_record_pre_action 22:12:05 INFO - Running main action method: clobber 22:12:05 INFO - rmtree: /builds/slave/test/build 22:12:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:12:06 INFO - Running post-action listener: _resource_record_post_action 22:12:06 INFO - ##### 22:12:06 INFO - ##### Running read-buildbot-config step. 22:12:06 INFO - ##### 22:12:06 INFO - Running pre-action listener: _resource_record_pre_action 22:12:06 INFO - Running main action method: read_buildbot_config 22:12:06 INFO - Using buildbot properties: 22:12:06 INFO - { 22:12:06 INFO - "project": "", 22:12:06 INFO - "product": "firefox", 22:12:06 INFO - "script_repo_revision": "production", 22:12:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:12:06 INFO - "repository": "", 22:12:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:12:06 INFO - "buildid": "20160317214015", 22:12:06 INFO - "pgo_build": "False", 22:12:06 INFO - "basedir": "/builds/slave/test", 22:12:06 INFO - "buildnumber": 1555, 22:12:06 INFO - "slavename": "talos-linux64-ix-061", 22:12:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:12:06 INFO - "platform": "ubuntu64_hw", 22:12:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:12:06 INFO - "branch": "fx-team", 22:12:06 INFO - "repo_path": "integration/fx-team", 22:12:06 INFO - "revision": "02cf3a4bf42ae31d09d2088cb25334d13e2523ec", 22:12:06 INFO - "stage_platform": "linux64", 22:12:06 INFO - "builduid": "03cb30dbf36843baa7b56b3a7aa7b083", 22:12:06 INFO - "slavebuilddir": "test" 22:12:06 INFO - } 22:12:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:12:06 INFO - Running post-action listener: _resource_record_post_action 22:12:06 INFO - ##### 22:12:06 INFO - ##### Running download-and-extract step. 22:12:06 INFO - ##### 22:12:06 INFO - Running pre-action listener: _resource_record_pre_action 22:12:06 INFO - Running main action method: download_and_extract 22:12:06 INFO - mkdir: /builds/slave/test/build/tests 22:12: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')]} 22:12:06 INFO - https://queue.taskcluster.net/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:12:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:12:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:12:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:12:08 INFO - Downloaded 1361 bytes. 22:12:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:12:08 INFO - Using the following test package requirements: 22:12:08 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:12:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:12:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:08 INFO - u'jsshell-linux-x86_64.zip'], 22:12:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:12:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:12:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:12:08 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:12:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:12:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:12:08 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:12:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:08 INFO - https://queue.taskcluster.net/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:12:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:12:10 INFO - Downloaded 22008976 bytes. 22:12:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:12:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:12:11 INFO - Return code: 0 22:12:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:11 INFO - https://queue.taskcluster.net/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:12:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:12:12 INFO - Downloaded 22008976 bytes. 22:12:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:12:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:12:14 INFO - Return code: 0 22:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:14 INFO - https://queue.taskcluster.net/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:12:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:12:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:12:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:12:15 INFO - Downloaded 10846565 bytes. 22:12:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:12:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:12:15 INFO - Return code: 0 22:12:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:15 INFO - https://queue.taskcluster.net/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:12:19 INFO - Downloaded 54144748 bytes. 22:12:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:12:19 INFO - mkdir: /builds/slave/test/properties 22:12:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:12:19 INFO - Writing to file /builds/slave/test/properties/build_url 22:12:19 INFO - Contents: 22:12:19 INFO - build_url:https://queue.taskcluster.net/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:12:20 INFO - Running post-action listener: _resource_record_post_action 22:12:20 INFO - Running post-action listener: set_extra_try_arguments 22:12:20 INFO - ##### 22:12:20 INFO - ##### Running populate-webroot step. 22:12:20 INFO - ##### 22:12:20 INFO - Running pre-action listener: _resource_record_pre_action 22:12:20 INFO - Running main action method: populate_webroot 22:12:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:12:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:12:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:12:20 INFO - '--tppagecycles', 22:12:20 INFO - '7'], 22:12:20 INFO - 'tests': ['tsvgm']}}, 22:12:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:12:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:12:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:12:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:12:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:12:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:12:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:20 INFO - 'talos_options': ['--e10s'], 22:12:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:12:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:20 INFO - 'tests': ['damp', 'tps']}, 22:12:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:20 INFO - 'talos_options': ['--e10s'], 22:12:20 INFO - 'tests': ['damp', 'tps']}, 22:12:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:12:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:12:20 INFO - 'other': {'tests': ['a11yr', 22:12:20 INFO - 'ts_paint', 22:12:20 INFO - 'tpaint', 22:12:20 INFO - 'sessionrestore', 22:12:20 INFO - 'sessionrestore_no_auto_restore', 22:12:20 INFO - 'tabpaint']}, 22:12:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:12:20 INFO - 'tests': ['a11yr', 22:12:20 INFO - 'ts_paint', 22:12:20 INFO - 'tpaint', 22:12:20 INFO - 'sessionrestore', 22:12:20 INFO - 'sessionrestore_no_auto_restore', 22:12:20 INFO - 'tabpaint']}, 22:12:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:12:20 INFO - 'tests': ['a11yr', 22:12:20 INFO - 'ts_paint', 22:12:20 INFO - 'tpaint', 22:12:20 INFO - 'sessionrestore', 22:12:20 INFO - 'sessionrestore_no_auto_restore', 22:12:20 INFO - 'tabpaint']}, 22:12:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:12:20 INFO - 'tests': ['a11yr', 22:12:20 INFO - 'ts_paint', 22:12:20 INFO - 'tpaint', 22:12:20 INFO - 'sessionrestore', 22:12:20 INFO - 'sessionrestore_no_auto_restore', 22:12:20 INFO - 'tabpaint']}, 22:12:20 INFO - 'other_l64': {'tests': ['a11yr', 22:12:20 INFO - 'ts_paint', 22:12:20 INFO - 'tpaint', 22:12:20 INFO - 'sessionrestore', 22:12:20 INFO - 'sessionrestore_no_auto_restore', 22:12:20 INFO - 'tabpaint']}, 22:12:20 INFO - 'other_nol64': {'tests': ['a11yr', 22:12:20 INFO - 'ts_paint', 22:12:20 INFO - 'tpaint', 22:12:20 INFO - 'sessionrestore', 22:12:20 INFO - 'sessionrestore_no_auto_restore', 22:12:20 INFO - 'tabpaint']}, 22:12:20 INFO - 'svgr': {'tests': ['tsvgx', 22:12:20 INFO - 'tsvgr_opacity', 22:12:20 INFO - 'tart', 22:12:20 INFO - 'tscrollx', 22:12:20 INFO - 'cart']}, 22:12:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:12:20 INFO - 'tests': ['tsvgx', 22:12:20 INFO - 'tsvgr_opacity', 22:12:20 INFO - 'tart', 22:12:20 INFO - 'tscrollx', 22:12:20 INFO - 'cart']}, 22:12:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:20 INFO - 'tests': ['tp5o']}, 22:12:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:20 INFO - 'talos_options': ['--e10s'], 22:12:20 INFO - 'tests': ['tp5o']}, 22:12:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:20 INFO - 'talos_options': ['--xperf_path', 22:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:20 INFO - 'tests': ['tp5n']}, 22:12:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:12:20 INFO - 'talos_options': ['--e10s', 22:12:20 INFO - '--xperf_path', 22:12:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:12:20 INFO - 'tests': ['tp5n']}}, 22:12:20 INFO - 'talos.zip': {'path': '', 22:12:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:12:20 INFO - Running post-action listener: _resource_record_post_action 22:12:20 INFO - ##### 22:12:20 INFO - ##### Running create-virtualenv step. 22:12:20 INFO - ##### 22:12:20 INFO - Running pre-action listener: _resource_record_pre_action 22:12:20 INFO - Running main action method: create_virtualenv 22:12:20 INFO - Creating virtualenv /builds/slave/test/build/venv 22:12:20 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 22:12:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:12:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:12:20 INFO - Using real prefix '/usr' 22:12:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:12:21 INFO - Installing distribute.............................................................................................................................................................................................done. 22:12:23 INFO - Installing pip.................done. 22:12:23 INFO - Return code: 0 22:12:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c1d27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5410>, '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 0x18d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', '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 22:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:12:23 INFO - Using env: {'DISPLAY': ':0', 22:12:23 INFO - 'HOME': '/home/cltbld', 22:12:23 INFO - 'LANG': 'en_US.UTF-8', 22:12:23 INFO - 'LANGUAGE': 'en_US:en', 22:12:23 INFO - 'LOGNAME': 'cltbld', 22:12:23 INFO - 'MAIL': '/var/mail/cltbld', 22:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:23 INFO - 'MOZ_NO_REMOTE': '1', 22:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:23 INFO - 'NO_EM_RESTART': '1', 22:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:23 INFO - 'PWD': '/builds/slave/test', 22:12:23 INFO - 'SHELL': '/bin/bash', 22:12:23 INFO - 'SHLVL': '1', 22:12:23 INFO - 'TERM': 'linux', 22:12:23 INFO - 'TMOUT': '86400', 22:12:23 INFO - 'USER': 'cltbld', 22:12:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', 22:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:23 INFO - '_': '/tools/buildbot/bin/python'} 22:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:23 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 22:12:23 INFO - Cleaning up... 22:12:23 INFO - Return code: 0 22:12:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c1d27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5410>, '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 0x18d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', '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 22:12:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:12:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:12:23 INFO - Using env: {'DISPLAY': ':0', 22:12:23 INFO - 'HOME': '/home/cltbld', 22:12:23 INFO - 'LANG': 'en_US.UTF-8', 22:12:23 INFO - 'LANGUAGE': 'en_US:en', 22:12:23 INFO - 'LOGNAME': 'cltbld', 22:12:23 INFO - 'MAIL': '/var/mail/cltbld', 22:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:23 INFO - 'MOZ_NO_REMOTE': '1', 22:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:23 INFO - 'NO_EM_RESTART': '1', 22:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:23 INFO - 'PWD': '/builds/slave/test', 22:12:23 INFO - 'SHELL': '/bin/bash', 22:12:23 INFO - 'SHLVL': '1', 22:12:23 INFO - 'TERM': 'linux', 22:12:23 INFO - 'TMOUT': '86400', 22:12:23 INFO - 'USER': 'cltbld', 22:12:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', 22:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:23 INFO - '_': '/tools/buildbot/bin/python'} 22:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:23 INFO - Downloading/unpacking psutil>=0.7.1 22:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:12:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:12:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:12:25 INFO - Installing collected packages: psutil 22:12:25 INFO - Running setup.py install for psutil 22:12:25 INFO - building 'psutil._psutil_linux' extension 22:12:25 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 22:12:25 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 22:12:25 INFO - building 'psutil._psutil_posix' extension 22:12:25 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 22:12:26 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 22:12:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:12:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:12:26 INFO - Successfully installed psutil 22:12:26 INFO - Cleaning up... 22:12:26 INFO - Return code: 0 22:12:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c1d27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5410>, '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 0x18d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', '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 22:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:12:26 INFO - Using env: {'DISPLAY': ':0', 22:12:26 INFO - 'HOME': '/home/cltbld', 22:12:26 INFO - 'LANG': 'en_US.UTF-8', 22:12:26 INFO - 'LANGUAGE': 'en_US:en', 22:12:26 INFO - 'LOGNAME': 'cltbld', 22:12:26 INFO - 'MAIL': '/var/mail/cltbld', 22:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:26 INFO - 'MOZ_NO_REMOTE': '1', 22:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:26 INFO - 'NO_EM_RESTART': '1', 22:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:26 INFO - 'PWD': '/builds/slave/test', 22:12:26 INFO - 'SHELL': '/bin/bash', 22:12:26 INFO - 'SHLVL': '1', 22:12:26 INFO - 'TERM': 'linux', 22:12:26 INFO - 'TMOUT': '86400', 22:12:26 INFO - 'USER': 'cltbld', 22:12:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', 22:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:26 INFO - '_': '/tools/buildbot/bin/python'} 22:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:12:26 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 22:12:26 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 22:12:26 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 22:12:26 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 22:12:26 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 22:12:26 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 22:12:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:12:27 INFO - Installing collected packages: mozsystemmonitor 22:12:27 INFO - Running setup.py install for mozsystemmonitor 22:12:28 INFO - Successfully installed mozsystemmonitor 22:12:28 INFO - Cleaning up... 22:12:28 INFO - Return code: 0 22:12:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2c1d27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5410>, '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 0x18d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', '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 22:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:12:28 INFO - Using env: {'DISPLAY': ':0', 22:12:28 INFO - 'HOME': '/home/cltbld', 22:12:28 INFO - 'LANG': 'en_US.UTF-8', 22:12:28 INFO - 'LANGUAGE': 'en_US:en', 22:12:28 INFO - 'LOGNAME': 'cltbld', 22:12:28 INFO - 'MAIL': '/var/mail/cltbld', 22:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:28 INFO - 'MOZ_NO_REMOTE': '1', 22:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:28 INFO - 'NO_EM_RESTART': '1', 22:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:28 INFO - 'PWD': '/builds/slave/test', 22:12:28 INFO - 'SHELL': '/bin/bash', 22:12:28 INFO - 'SHLVL': '1', 22:12:28 INFO - 'TERM': 'linux', 22:12:28 INFO - 'TMOUT': '86400', 22:12:28 INFO - 'USER': 'cltbld', 22:12:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', 22:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:28 INFO - '_': '/tools/buildbot/bin/python'} 22:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:28 INFO - Downloading/unpacking blobuploader==1.2.4 22:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:30 INFO - Downloading blobuploader-1.2.4.tar.gz 22:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:12:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:12:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:31 INFO - Downloading docopt-0.6.1.tar.gz 22:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:12:31 INFO - Installing collected packages: blobuploader, requests, docopt 22:12:31 INFO - Running setup.py install for blobuploader 22:12:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:12:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:12:31 INFO - Running setup.py install for requests 22:12:32 INFO - Running setup.py install for docopt 22:12:32 INFO - Successfully installed blobuploader requests docopt 22:12:32 INFO - Cleaning up... 22:12:32 INFO - Return code: 0 22:12:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:32 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 0x7f2c1d27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5410>, '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 0x18d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', '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 22:12:32 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 22:12:32 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 22:12:32 INFO - Using env: {'DISPLAY': ':0', 22:12:32 INFO - 'HOME': '/home/cltbld', 22:12:32 INFO - 'LANG': 'en_US.UTF-8', 22:12:32 INFO - 'LANGUAGE': 'en_US:en', 22:12:32 INFO - 'LOGNAME': 'cltbld', 22:12:32 INFO - 'MAIL': '/var/mail/cltbld', 22:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:32 INFO - 'MOZ_NO_REMOTE': '1', 22:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:32 INFO - 'NO_EM_RESTART': '1', 22:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:32 INFO - 'PWD': '/builds/slave/test', 22:12:32 INFO - 'SHELL': '/bin/bash', 22:12:32 INFO - 'SHLVL': '1', 22:12:32 INFO - 'TERM': 'linux', 22:12:32 INFO - 'TMOUT': '86400', 22:12:32 INFO - 'USER': 'cltbld', 22:12:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', 22:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:32 INFO - '_': '/tools/buildbot/bin/python'} 22:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:12:32 INFO - Running setup.py (path:/tmp/pip-4gTIb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:12:32 INFO - Running setup.py (path:/tmp/pip-SmfJ4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:12:32 INFO - Running setup.py (path:/tmp/pip-er3P0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:12:32 INFO - Running setup.py (path:/tmp/pip-Nxi9Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:12:32 INFO - Running setup.py (path:/tmp/pip-GIRdby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:12:33 INFO - Running setup.py (path:/tmp/pip-NNC5ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:12:33 INFO - Running setup.py (path:/tmp/pip-IC73_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:12:33 INFO - Running setup.py (path:/tmp/pip-Ljc4fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:12:33 INFO - Running setup.py (path:/tmp/pip-2pqmr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:12:33 INFO - Running setup.py (path:/tmp/pip-4aGzbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:12:33 INFO - Running setup.py (path:/tmp/pip-zx2nBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:12:33 INFO - Running setup.py (path:/tmp/pip-LAbKw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:12:33 INFO - Running setup.py (path:/tmp/pip-eyWO7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:12:33 INFO - Running setup.py (path:/tmp/pip-DgWFa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:33 INFO - Running setup.py (path:/tmp/pip-yZAbzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:12:33 INFO - Running setup.py (path:/tmp/pip-4vp8kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:12:33 INFO - Running setup.py (path:/tmp/pip-Lh9blo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:12:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:12:33 INFO - Running setup.py install for manifestparser 22:12:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:12:34 INFO - Running setup.py install for mozcrash 22:12:34 INFO - Running setup.py install for mozdebug 22:12:34 INFO - Running setup.py install for mozdevice 22:12:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:12:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:12:34 INFO - Running setup.py install for mozfile 22:12:34 INFO - Running setup.py install for mozhttpd 22:12:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:12:34 INFO - Running setup.py install for mozinfo 22:12:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:12:34 INFO - Running setup.py install for mozInstall 22:12:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:12:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:12:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:12:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:12:34 INFO - Running setup.py install for mozleak 22:12:34 INFO - Running setup.py install for mozlog 22:12:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:12:34 INFO - Running setup.py install for moznetwork 22:12:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:12:35 INFO - Running setup.py install for mozprocess 22:12:35 INFO - Running setup.py install for mozprofile 22:12:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:12:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:12:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:12:35 INFO - Running setup.py install for mozrunner 22:12:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:12:35 INFO - Running setup.py install for mozscreenshot 22:12:35 INFO - Running setup.py install for moztest 22:12:35 INFO - Running setup.py install for mozversion 22:12:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:12:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:12:35 INFO - Cleaning up... 22:12:35 INFO - Return code: 0 22:12:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:35 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 0x7f2c1d27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5410>, '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 0x18d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', '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 22:12:35 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 22:12:35 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 22:12:35 INFO - Using env: {'DISPLAY': ':0', 22:12:35 INFO - 'HOME': '/home/cltbld', 22:12:35 INFO - 'LANG': 'en_US.UTF-8', 22:12:35 INFO - 'LANGUAGE': 'en_US:en', 22:12:35 INFO - 'LOGNAME': 'cltbld', 22:12:35 INFO - 'MAIL': '/var/mail/cltbld', 22:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:35 INFO - 'MOZ_NO_REMOTE': '1', 22:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:35 INFO - 'NO_EM_RESTART': '1', 22:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:35 INFO - 'PWD': '/builds/slave/test', 22:12:35 INFO - 'SHELL': '/bin/bash', 22:12:35 INFO - 'SHLVL': '1', 22:12:35 INFO - 'TERM': 'linux', 22:12:35 INFO - 'TMOUT': '86400', 22:12:35 INFO - 'USER': 'cltbld', 22:12:35 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', 22:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:35 INFO - '_': '/tools/buildbot/bin/python'} 22:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:12:35 INFO - Running setup.py (path:/tmp/pip-dda8SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:12:35 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)) 22:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:12:35 INFO - Running setup.py (path:/tmp/pip-m2cdMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:12:36 INFO - Running setup.py (path:/tmp/pip-KA9iPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:12:36 INFO - Running setup.py (path:/tmp/pip-WF5Yi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:12:36 INFO - Running setup.py (path:/tmp/pip-Ni3b52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:12:36 INFO - Running setup.py (path:/tmp/pip-Qspzpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:12:36 INFO - Running setup.py (path:/tmp/pip-U1qqdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:12:36 INFO - Running setup.py (path:/tmp/pip-RqyxQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:12:36 INFO - Running setup.py (path:/tmp/pip-UYexXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:12:36 INFO - Running setup.py (path:/tmp/pip-yTHTRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:12:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:12:36 INFO - Running setup.py (path:/tmp/pip-Lbl5qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:12:36 INFO - Running setup.py (path:/tmp/pip-3NGEBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:12:36 INFO - Running setup.py (path:/tmp/pip-zE1_NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:12:36 INFO - Running setup.py (path:/tmp/pip-LUEJQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:12:36 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)) 22:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:36 INFO - Running setup.py (path:/tmp/pip-TOPcTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:12:37 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)) 22:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:12:37 INFO - Running setup.py (path:/tmp/pip-pqL0uZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:12:37 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)) 22:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:12:37 INFO - Running setup.py (path:/tmp/pip-JdmZnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:12:37 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)) 22:12:37 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)) 22:12:37 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)) 22:12:37 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)) 22:12:37 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)) 22:12:37 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)) 22:12:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:12:37 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 22:12:37 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 22:12:37 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 22:12:37 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 22:12:37 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 22:12:37 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 22:12:38 INFO - Downloading blessings-1.6.tar.gz 22:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:12:39 INFO - Installing collected packages: blessings 22:12:39 INFO - Running setup.py install for blessings 22:12:39 INFO - Successfully installed blessings 22:12:39 INFO - Cleaning up... 22:12:39 INFO - Return code: 0 22:12:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:12:39 INFO - Reading from file tmpfile_stdout 22:12:39 INFO - Current package versions: 22:12:39 INFO - argparse == 1.2.1 22:12:39 INFO - blessings == 1.6 22:12:39 INFO - blobuploader == 1.2.4 22:12:39 INFO - docopt == 0.6.1 22:12:39 INFO - manifestparser == 1.1 22:12:39 INFO - mozInstall == 1.12 22:12:39 INFO - mozcrash == 0.17 22:12:39 INFO - mozdebug == 0.1 22:12:39 INFO - mozdevice == 0.48 22:12:39 INFO - mozfile == 1.2 22:12:39 INFO - mozhttpd == 0.7 22:12:39 INFO - mozinfo == 0.9 22:12:39 INFO - mozleak == 0.1 22:12:39 INFO - mozlog == 3.1 22:12:39 INFO - moznetwork == 0.27 22:12:39 INFO - mozprocess == 0.22 22:12:39 INFO - mozprofile == 0.28 22:12:39 INFO - mozrunner == 6.11 22:12:39 INFO - mozscreenshot == 0.1 22:12:39 INFO - mozsystemmonitor == 0.0 22:12:39 INFO - moztest == 0.7 22:12:39 INFO - mozversion == 1.4 22:12:39 INFO - psutil == 3.1.1 22:12:39 INFO - requests == 1.2.3 22:12:39 INFO - wsgiref == 0.1.2 22:12:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:39 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 0x7f2c1d27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5410>, '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 0x18d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', '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 22:12:39 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 22:12:39 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 22:12:39 INFO - Using env: {'DISPLAY': ':0', 22:12:39 INFO - 'HOME': '/home/cltbld', 22:12:39 INFO - 'LANG': 'en_US.UTF-8', 22:12:39 INFO - 'LANGUAGE': 'en_US:en', 22:12:39 INFO - 'LOGNAME': 'cltbld', 22:12:39 INFO - 'MAIL': '/var/mail/cltbld', 22:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:39 INFO - 'MOZ_NO_REMOTE': '1', 22:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:39 INFO - 'NO_EM_RESTART': '1', 22:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:39 INFO - 'PWD': '/builds/slave/test', 22:12:39 INFO - 'SHELL': '/bin/bash', 22:12:39 INFO - 'SHLVL': '1', 22:12:39 INFO - 'TERM': 'linux', 22:12:39 INFO - 'TMOUT': '86400', 22:12:39 INFO - 'USER': 'cltbld', 22:12:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', 22:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:39 INFO - '_': '/tools/buildbot/bin/python'} 22:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:39 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)) 22:12:39 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)) 22:12:39 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)) 22:12:39 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)) 22:12:39 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)) 22:12:39 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)) 22:12:39 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)) 22:12:39 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)) 22:12:39 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)) 22:12:39 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)) 22:12:39 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)) 22:12:39 INFO - Cleaning up... 22:12:39 INFO - Return code: 0 22:12:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c1d27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5410>, '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 0x18d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', '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 22:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:12:39 INFO - Using env: {'DISPLAY': ':0', 22:12:39 INFO - 'HOME': '/home/cltbld', 22:12:39 INFO - 'LANG': 'en_US.UTF-8', 22:12:39 INFO - 'LANGUAGE': 'en_US:en', 22:12:39 INFO - 'LOGNAME': 'cltbld', 22:12:39 INFO - 'MAIL': '/var/mail/cltbld', 22:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:39 INFO - 'MOZ_NO_REMOTE': '1', 22:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:39 INFO - 'NO_EM_RESTART': '1', 22:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:39 INFO - 'PWD': '/builds/slave/test', 22:12:39 INFO - 'SHELL': '/bin/bash', 22:12:39 INFO - 'SHLVL': '1', 22:12:39 INFO - 'TERM': 'linux', 22:12:39 INFO - 'TMOUT': '86400', 22:12:39 INFO - 'USER': 'cltbld', 22:12:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', 22:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:39 INFO - '_': '/tools/buildbot/bin/python'} 22:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:39 INFO - Downloading/unpacking jsonschema 22:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:12:41 INFO - Downloading/unpacking functools32 (from jsonschema) 22:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:41 INFO - Downloading functools32-3.2.3-2.tar.gz 22:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:12:41 INFO - warning: no files found matching '*.txt' 22:12:41 INFO - no previously-included directories found matching 'build' 22:12:41 INFO - no previously-included directories found matching 'dist' 22:12:41 INFO - no previously-included directories found matching '.git*' 22:12:41 INFO - Installing collected packages: jsonschema, functools32 22:12:42 INFO - Running setup.py install for functools32 22:12:42 INFO - warning: no files found matching '*.txt' 22:12:42 INFO - no previously-included directories found matching 'build' 22:12:42 INFO - no previously-included directories found matching 'dist' 22:12:42 INFO - no previously-included directories found matching '.git*' 22:12:42 INFO - Successfully installed jsonschema functools32 22:12:42 INFO - Cleaning up... 22:12:42 INFO - Return code: 0 22:12:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:12:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2c1d27cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18465a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5410>, '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 0x18d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d67a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', '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 22:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:12:42 INFO - Using env: {'DISPLAY': ':0', 22:12:42 INFO - 'HOME': '/home/cltbld', 22:12:42 INFO - 'LANG': 'en_US.UTF-8', 22:12:42 INFO - 'LANGUAGE': 'en_US:en', 22:12:42 INFO - 'LOGNAME': 'cltbld', 22:12:42 INFO - 'MAIL': '/var/mail/cltbld', 22:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:42 INFO - 'MOZ_NO_REMOTE': '1', 22:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:42 INFO - 'NO_EM_RESTART': '1', 22:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:12:42 INFO - 'PWD': '/builds/slave/test', 22:12:42 INFO - 'SHELL': '/bin/bash', 22:12:42 INFO - 'SHLVL': '1', 22:12:42 INFO - 'TERM': 'linux', 22:12:42 INFO - 'TMOUT': '86400', 22:12:42 INFO - 'USER': 'cltbld', 22:12:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', 22:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:42 INFO - '_': '/tools/buildbot/bin/python'} 22:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:12:42 INFO - Downloading/unpacking flake8 22:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:12:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:12:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:12:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:12:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:12:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:12:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:12:44 INFO - no previously-included directories found matching 'docs/_build' 22:12:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:12:45 INFO - Running setup.py install for pep8 22:12:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:12:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:12:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:12:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:12:45 INFO - no previously-included directories found matching 'docs/_build' 22:12:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:12:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:12:45 INFO - Cleaning up... 22:12:45 INFO - Return code: 0 22:12:45 INFO - Running post-action listener: _resource_record_post_action 22:12:45 INFO - Running post-action listener: _start_resource_monitoring 22:12:45 INFO - Starting resource monitoring. 22:12:45 INFO - ##### 22:12:45 INFO - ##### Running install step. 22:12:45 INFO - ##### 22:12:45 INFO - Running pre-action listener: _resource_record_pre_action 22:12:45 INFO - Running main action method: install 22:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:12:45 INFO - Reading from file tmpfile_stdout 22:12:45 INFO - Detecting whether we're running mozinstall >=1.0... 22:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:12:45 INFO - Reading from file tmpfile_stdout 22:12:45 INFO - Output received: 22:12:45 INFO - Usage: mozinstall [options] installer 22:12:45 INFO - Options: 22:12:45 INFO - -h, --help show this help message and exit 22:12:45 INFO - -d DEST, --destination=DEST 22:12:45 INFO - Directory to install application into. [default: 22:12:45 INFO - "/builds/slave/test"] 22:12:45 INFO - --app=APP Application being installed. [default: firefox] 22:12:45 INFO - mkdir: /builds/slave/test/build/application 22:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:13:01 INFO - Reading from file tmpfile_stdout 22:13:01 INFO - Output received: 22:13:01 INFO - /builds/slave/test/build/application/firefox/firefox 22:13:01 INFO - Running post-action listener: _resource_record_post_action 22:13:01 INFO - ##### 22:13:01 INFO - ##### Running run-tests step. 22:13:01 INFO - ##### 22:13:01 INFO - Running pre-action listener: _resource_record_pre_action 22:13:01 INFO - Running main action method: run_tests 22:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:13:01 INFO - Python 2.7.3 22:13:01 INFO - Return code: 0 22:13:01 INFO - grabbing minidump binary from tooltool 22:13: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')]} 22:13:01 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d5410>, '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 0x18d6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18d67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:13:01 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 22:13:01 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 22:13:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:13:01 INFO - Return code: 0 22:13:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:13:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:13:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:13:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:13:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:13:02 INFO - Return code: 0 22:13:02 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/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 22:13:02 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/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 22:13:02 INFO - Using env: {'DISPLAY': ':0', 22:13:02 INFO - 'HOME': '/home/cltbld', 22:13:02 INFO - 'LANG': 'en_US.UTF-8', 22:13:02 INFO - 'LANGUAGE': 'en_US:en', 22:13:02 INFO - 'LOGNAME': 'cltbld', 22:13:02 INFO - 'MAIL': '/var/mail/cltbld', 22:13:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:13:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:13:02 INFO - 'MOZ_NO_REMOTE': '1', 22:13:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:13:02 INFO - 'NO_EM_RESTART': '1', 22:13:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:13:02 INFO - 'PWD': '/builds/slave/test', 22:13:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:13:02 INFO - 'SHELL': '/bin/bash', 22:13:02 INFO - 'SHLVL': '1', 22:13:02 INFO - 'TERM': 'linux', 22:13:02 INFO - 'TMOUT': '86400', 22:13:02 INFO - 'USER': 'cltbld', 22:13:02 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530', 22:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:13:02 INFO - '_': '/tools/buildbot/bin/python'} 22:13:02 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/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 22:13:02 INFO - mozversion application_buildid: 20160317214015 22:13:02 INFO - mozversion application_changeset: 02cf3a4bf42ae31d09d2088cb25334d13e2523ec 22:13:02 INFO - mozversion application_display_name: Nightly 22:13:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:13:02 INFO - mozversion application_name: Firefox 22:13:02 INFO - mozversion application_remotingname: firefox 22:13:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:13:02 INFO - mozversion application_vendor: Mozilla 22:13:02 INFO - mozversion application_version: 48.0a1 22:13:02 INFO - mozversion platform_buildid: 20160317214015 22:13:02 INFO - mozversion platform_changeset: 02cf3a4bf42ae31d09d2088cb25334d13e2523ec 22:13:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:13:02 INFO - mozversion platform_version: 48.0a1 22:13:02 INFO - using testdate: 1458277982 22:13:02 INFO - actual date: 1458277982 22:13:02 INFO - starting webserver on 'localhost:54349' 22:13:02 INFO - SUITE-START | Running 2 tests 22:13:02 INFO - TEST-START | dromaeo_css 22:13:02 INFO - operating with platform_type : linux_ 22:13:02 INFO - Initialising browser for dromaeo_css test... 22:13:02 INFO - TEST-INFO | started process 4890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPAMgpj/profile http://localhost:54349/getInfo.html) 22:13:07 INFO - PROCESS | 4890 | __metrics Screen width/height:1600/1200 22:13:07 INFO - PROCESS | 4890 | colorDepth:24 22:13:07 INFO - PROCESS | 4890 | Browser inner width/height: 1024/697 22:13:07 INFO - PROCESS | 4890 | __metrics 22:13:08 ERROR - PROCESS | 4890 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:13:08 INFO - PROCESS | 4890 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 22:13:09 INFO - TEST-INFO | 4890: exit 0 22:13:09 INFO - Browser initialized. 22:13:09 INFO - Running cycle 1/1 for dromaeo_css test... 22:13:09 INFO - TEST-INFO | started process 4981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPAMgpj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:13:21 INFO - PROCESS | 4981 | RSS: Main: 154292224 22:13:21 INFO - PROCESS | 4981 | 22:14:12 INFO - PROCESS | 4981 | 1458278052278 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] 22:16:23 INFO - PROCESS | 4981 | Cycle 1(1): loaded http://localhost:54349/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54349/tests/dromaeo/cssquery-ext.html) 22:16:24 INFO - PROCESS | 4981 | RSS: Main: 234045440 22:16:24 INFO - PROCESS | 4981 | 22:19:26 INFO - PROCESS | 4981 | Cycle 1(1): loaded http://localhost:54349/tests/dromaeo/cssquery-ext.html (next: http://localhost:54349/tests/dromaeo/cssquery-jquery.html) 22:19:27 INFO - PROCESS | 4981 | RSS: Main: 237309952 22:19:27 INFO - PROCESS | 4981 | 22:22:29 INFO - PROCESS | 4981 | Cycle 1(1): loaded http://localhost:54349/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54349/tests/dromaeo/cssquery-mootools.html) 22:22:29 INFO - PROCESS | 4981 | RSS: Main: 237146112 22:22:29 INFO - PROCESS | 4981 | 22:25:31 INFO - PROCESS | 4981 | Cycle 1(1): loaded http://localhost:54349/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54349/tests/dromaeo/cssquery-prototype.html) 22:25:32 INFO - PROCESS | 4981 | RSS: Main: 206721024 22:25:32 INFO - PROCESS | 4981 | 22:28:35 INFO - PROCESS | 4981 | Cycle 1(1): loaded http://localhost:54349/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54349/tests/dromaeo/cssquery-yui.html) 22:28:35 INFO - PROCESS | 4981 | RSS: Main: 207069184 22:28:35 INFO - PROCESS | 4981 | 22:31:38 INFO - PROCESS | 4981 | Cycle 1(1): loaded http://localhost:54349/tests/dromaeo/cssquery-yui.html (next: http://localhost:54349/tests/dromaeo/cssquery-dojo.html) 22:31:38 INFO - PROCESS | 4981 | RSS: Main: 271843328 22:31:38 INFO - PROCESS | 4981 | 22:31:38 INFO - PROCESS | 4981 | __start_tp_report 22:31:38 INFO - PROCESS | 4981 | _x_x_mozilla_page_load 22:31:38 INFO - PROCESS | 4981 | _x_x_mozilla_page_load_details 22:31:38 INFO - PROCESS | 4981 | |i|pagename|runs| 22:31:38 INFO - PROCESS | 4981 | |0;dojo.html;2616.0974463809985;2669.0258055809636;2675.5050315691587;2701.149138021523;2722.8638568071606;4650.0467404182145;4677.134730074934;4678.508756580557;4692.741899195543;4735.928961065578;4658.976705116478;4719.551642593948;4794.041191761653;4807.831725889595;4830.106430310395;4308.956910430903;4332.65338772899;4353.608175264226;4399.164158809832;4410.206162890679;4411.316245981878;4466.62033727132;4473.776311184428;4493;4509.25597276449;4245.5542168072525;4275.828966841323;4367.104743527601;4399.78001099947;4430.202563538578;4290.656747460227;4317.028668549551;4319.02821865081;4344.500382456026;4356.281213599752;4261.041265715189;4282.807273672693;4289.785510724482;4301;4328.177646247203;4491.25894227452;4552.704074235164;4572.839950601746;4608.976955115203;4618.145643056012;5014.548690617826;5041.243813427978;5041.697498150123;5057.2666963290485;5078.466760990117;5051.974740126276;5062.164742817431;5075.390953085616;5081.74591270435;5115.155999260155;4661.207594708908;4723.598494128003;4725.9291110632685;4804.783784729696;4809.519048095162;5212.8957420851375;5229.4770522948165;5230.503102205284;5241.292425522582;5248.606354523426;4995.475475075137;5007.549320561167;5021.573166280907;5069.188929771219;5070.9858028394465;4927.187014142626;4976.925346119811;5040.042391945519;5082.33929589151;5100.260462232955;4943.752812359367;4960.8759781005765;4969.602431805447;4991.151504244287;5008.424031236382;4862.562369386772;4968.527989840959;4970.602351811919;4980.551750342486;5019.924701129486;4194.979025104855;4208.85269015583;4229.6827737919775;4259.467566554181;4276;3719.962800372016;3723.069232691827;3731.5149030625844;3743.6256374362347;3758.699304055669;4266.786660666954;4342.457192850894;4375.47494300686;4386.254336762758;4422.513523512411;4966.453690094087;5055.368078990126;5071.239314102914;5104.489551044866;5107.157319042316;4325.3728209409455;4341.218580655449;4344.717593356421;4350.260455722535;4379.430674012358;4447.355133505624;4502.279635258343;4507.18870603288;4519.593236608721;4539.02410981634;4790.5448982346625;4801.1117943180625;4819.180739274332;4823.131836269506;4877.317175595419;5059.620528460454;5062.114130027304;5065.417476990193;5071.061853557104;5074.264231686311;4621.3299071633755;4758.690685105457;4785.760711964457;4803.18345881208;4811;4978.253262010728;4997.950020499894;5000.774965126505;5001.599872010303;5030.220315851049;5080.7205603692155;5097.923531146962;5098.872528186825;5102.642815002914;5122.74386280677;4779.856604301876;4859.222524396079;4921.966387058757;4941.530554597308;4945.703257804544;4851.58761505276;4875.975620121877;4891.388576427947;4892.168331383745;4940.456549779593;4801.279808028824;4818.759062046814;4825.252085926687;4831.879203019812;4849.248366503198;4766.928496072493;4912.091263116335;4977.129002424634;5016;5029.27075574047;4840.177169881199;4846.442659094249;4853.830115945925;4860.07884702373;4909.0672772173175 22:31:38 INFO - PROCESS | 4981 | |1;ext.html;530.9362876454826;543.7498750574736;552.8092807981245;559.1752165555806;570.5407147246467;28482.715172848264;29118.563221551667;29131;29190.124296271148;29194.562081568794;33944.15139621511;34374;34470.13824654385;34473;34475.82762086192;7880.172581878906;8110.229528194842;8112.797180070516;8116.1478044805335;8122.228388303101;7712.845743085135;7782.105057918327;7803.141654418009;7804.219578042207;7805.219478052206;7981.960090199541;8053.1946805319585;8071.717489887855;8075.596220188967;8082.676692932276;7944.682212711485;8035.316998055172;8052.959735201345;8053.4765240259785;8055.275025247726;7729;7796.61016949156;7843.764687059397;7844.960775196145;7853.489523181032;36327.63672363269;36702.449463258075;36839;36908.81545592282;36910.44634330487;2992.925176870574;3128.2179455136215;3219.050380137865;3552.0231936217488;3811.2377524495214;28486.572701409495;28712.712872871212;28852.567211491845;29262.414751704848;29548.852255738584;3484.372812893678;3501.1422201560526;3510.3154884797473;3520.7887526748477;3530.5939816921127;178513;178665.1066744671;178721;179364;179902;46972.363316402254;47406.5259347409;47457.525424746;47556.04887902222;47575.762121189866;41251;57440.42559574351;57742;57814.421855781744;57845;14423.350949207312;14521.636959076108;14540.41838326455;14627.341769620392;14729;11205.831912521318;11329.94335028336;11330.263532870336;11334.093272538343;11338.092952563775;15774.842251577567;18408.447746567625;18449.907750461163;18634.720479192823;18823.623527529373;7102.112235970504;7365.1530074042175;7400.592967386845;7407.444441666897;7435.367993720594;882.6381183714647;974.7563109222694;994.0655783563427;1004.5931397783909;1008.9293749437469;26552.8672356637;27728.861355693494;27878.72121278802;28158;28208.576871346948;890.3811850763657;932.5337331334333;935.5789894547481;997.6408492942535;1055.37205362809;13001.089923705438;13201.47194112244;13482.25847578373;13700.314984250748;14059.156450612996;307579;310870;312061;313088;313305;45375.31937020947;45480.54519454763;45663.54336456659;45765.77117114393;45785.542144578125;1077.3159044007111;1204.3315959642307;1270.1997741423029;1274.3691872522975;1284.1588759362633;23782.16762413307;24024;26340.20979370622;26663.33341666474;26830.463390732468;37230.44154337633;37319.6268037327;37773.43339849849;37786.811065944494;37912.62087379091;208973;211237;211530;211638;211989;25781;30006.24984375321;30062.54906176453;30113;30189.245268868453;33295;33659.66340336565;34264.828675856465;34360.65639343575;34414.65585344215;29420;29523.26191845135;29585.704142959155;29614.407711846074;29785.10644680663;31483;32059;32096;32309.51535727013;32374.514382283814;32123.518147227343;32188;32529.512057318687;32735;32847.34305313928;27913.2317137192;28765;29140.417191656474;29146.854265728536;29216.561751573317;23255.534889302457;23303.908201550596;23394.883025584764;23496.530069398174;23533.76466235316 22:31:38 INFO - PROCESS | 4981 | |2;jquery.html;356.65226404255856;357.8049962770291;363.15385152594456;371.1074864949795;371.29454037329054;15600.843991560096;15933.283002264898;16622.25199866006;17249.568760780985;17601.471955841345;15913.204339783022;16136.596585085379;16174.19129043549;16194.514164575081;16693.83306166941;4937.111319962405;5038.067957427869;5139.408967968694;5146.408163061258;5175.068487672217;5047.343845300106;5103.515166059218;5107.336046313974;5109.3357863477695;5131.358580177478;5017.347744793172;5040.218766091261;5048.763053052007;5074.873128171788;5104.948950510485;4935.703857768545;5022.17134172861;5059.924101138467;5061.822836200715;5079.974600126994;4534.342520334566;4537.841175558872;4538.8865278367975;4540.72755634663;4542.977285113587;11524.711882202928;19346.806531934642;20293.391198264075;20366.389008329774;20387.89806050975;1832.3586744639404;1928.3829174664113;1949.6783030799902;1952.9316473923345;2174.3803016140323;8742.169493898133;8759.430637008574;8860.405127077123;9050.683226087056;9066;1784.6966015777218;1789.9910500447415;1850.1489314915154;1866.0669665167416;1871;59184.40815591832;61373.69313153451;62521.37478625246;62685.686571567305;63102.36897631011;10395.116415104801;10453.895461045293;10503.789924201626;10517.84223236652;10555.10281626055;13456.596302110953;13545.59363219105;13551.728965420636;13598.524051658145;13609.659758505919;7195.928040719526;7394.2975417335265;7401.925980740231;7511.136219334847;7544.735934242385;7151.856962860714;7153;7290.307420795016;7290.744823931243;7300.233475485104;4466.642668586505;4488.4165058542185;4491.76807444519;4566.634669226454;4615.353850460938;1668.8247733987998;1703.872209584286;1718.484454663596;1732.8093909669926;1756.8682348823888;893.620211410148;902.3007169443733;909.2998391238841;960.7550074731039;979.8236317462926;15865.365385384686;15928.283227254802;16519.83480165207;16792.496225113267;16799.916000420166;837.8324335132997;843.1863251961886;858.7552547524051;865.8441480533564;953.0564740906591;9131.812864327727;9217.815643687089;9477.573509192103;9578.329516933747;9664.37181583209;364683;392439;424280;426705;428092;67357;68363;68504.3149568508;68745.31254687489;69647;918.169057003413;927.5733162745078;928.1229238369676;943.9292053096045;944.9291303152291;14202.857971420153;14509.492167774077;14592.708145836812;14627.268636567916;14784.704305913607;31601.683983159874;32276.515852262706;33084.834575826964;33392.49911251382;33445.33109337848;41819;44227.778861105486;44874;45369;46338.7683061596;7430.919342584085;7514.699412023458;7661.846763064596;7729.884051739341;7740.187280335709;9119.863202051842;11284.3325919075;11326.433678316216;11339.319640821577;11558.340325599613;9848.60605575769;9903.306768526421;10039.196864250696;10263.640772572924;10557.577696892346;9988.60045598168;10071.69784906454;10074;10111.3427627204;10123.291369604058;9922.305438619227;10238.385696858213;10243.846342304721;10522.894771052192;10555.788884222426;7356.742514011984;7431.29402706742;7448.776536703907;7502.924970750222;7701.229877012254;7847.686092556234;9918.603255869684;9969.40183588987;10125.392476451436;10463.372197667859 22:31:38 INFO - PROCESS | 4981 | |3;mootools.html;1154.4285578638576;1413.8798202152816;1424.933845923411;1549.9612509687256;1743.1807050686182;7182.209956904736;7340.5595664260045;7348.63256837158;7368.189499155089;7374.74188403406;7107.253738357475;7295.781126566211;7300.0509933708545;7307.89038164428;7317.487775855692;1893.640208360414;2246.4608493961496;2249.089118906837;2279.179495381661;2321.210788331967;2248.4716091718433;2256.8533045352;2257.3679369776487;2261.231181398324;2261.2989973108306;2204.515006698524;2269.251147121446;2270.6366981283;2272.0230300970575;2272.2842304673973;2252.560750653623;2254.3687767425067;2261.4911644879853;2296.4832912594698;2298.184144628666;2253.549290141978;2264.501809601885;2277.146070223666;2277.271273192579;2303.5392921415782;7526.9247307526775;7550.320471157622;7590.127135379446;7594.544327340322;7599.202083781179;4550.863474095782;4649.325847752091;4653.232216684243;4664.090502352043;4682.204025315705;2993.4611769881412;3011.2170835582906;3058.740007099399;3066.9079927602206;3162.968370316313;1002.4987506246877;1013;1025.8974102589757;1042.2443728297;1042.9217808664305;9564.282678799049;9647.083527064917;9680.177184939288;9716.75708107296;9720.270979676552;4197.055662475918;4281.2293787118;4364.039911219526;4387.890302742393;4389.561043895649;8334.749957501284;8380.57530219864;8389.622466989;8407.11725268838;8430;4108.630223279919;4569.383133277031;4628.213203755369;4633.166030114612;4634.142683603544;4171.728837625545;4215.936760948527;4223.113146239324;4246.193223287565;4264.786760661955;3521.7534772566187;3613.8735144269826;3630.3828349180703;3645.7786641474872;3660.8718694846084;1214.4595654933469;1238.294172321786;1245.894099001577;1248.7814632439288;1257.0823298991788;977.8728765260471;1009.7223263602568;1154.4343271796927;1183.627157445402;1184.2598376014992;6971.268016858156;6997.930020699728;7033.577985320897;7054.012438258545;7061.89407158893;1044.3420644993605;1058.158763782779;1060.6234786650782;1068.9694715481542;1096.983545246822;5526.364468086141;5530.557555395559;5579.38626751057;5583.106702927512;5635.605507614428;8578.270846978077;9072.364934454657;9094.226990705733;9104;9109.81780364389;8965.731028069169;8969.910300896907;8976.326775491734;8992.100789920956;9026.413283136575;6963.895541566881;7273.781786546412;7292.234315396807;7319.853602927911;7348.559086454937;6852.246252912275;6921.965390173017;6932.792016239521;6938.895916561357;6954.235034146139;7788.532688038736;7819.84360312802;7953.960230198812;7955.045394552691;8074.717384891501;8042.075161356285;8064.798380040546;8114.188581141839;8162.551059691774;8197.46716463428;5616.522595579258;5705.172749951317;5713.657180569179;6429.7749578764515;6654.667266636746;6363.5227357947415;6927.965360173167;7132.857342853217;7135.464840137114;7140.107486564179;6068.059450785136;6233.470155036691;6278.937210627835;6296.401841825203;6400.679966001774;6235.906461403173;6408.102865598913;6462.127612772216;6492.740290388331;6624.536282460182;6759.628220447923;6804.251532331341;6807.863842723217;6809.012693159563;6919.37725604698;6236.968815155895;6271.153394291712;6319.9052014218905;6325.841853953688;6339.429451349401;6214.5028397727165;6226.844328891814;6268.874622507433;6271.529635277281;6276.246850377984 22:31:38 INFO - PROCESS | 4981 | |4;prototype.html;323.7490944517998;324.1135494422753;324.55211807705365;330.30635665103284;332.48132912656274;5373.462653734625;5387.4073851876265;5397.109476936305;5398.001369746599;5406.08096623574;5344.652597581155;5352.116900711388;5355.544778693806;5356.678599284046;5364.70494122824;3990.7006974476885;4078.9190864420952;4147.502299724038;4182.6235638792505;4212.799352184628;4162.562930892258;4169.353750168729;4187.1625674865;4189;4199.6430303424095;4138.234426631067;4178.874633760992;4186.079062606222;4186.602272784081;4194.748315101088;3951.3480275754464;4063.1061166543163;4180.581941805825;4182.811773470201;4186.455760751113;3704.8888533344043;3715.238376132886;3718.2749363874054;3720.9813950930343;3725.3853114236117;5175.7670904809;5199.48005199477;5202.245674377232;5203.895922081575;5207.6615020023955;4832.299316599074;4863.465018847924;4878.170710979142;4883.731394773286;4885.7312847793355;5658.91511627326;5671.06427439472;5680.358633235524;5681.517071048966;5688.175214593861;3985.9835741885922;4106.630403263721;4109.0959988802715;4112.115895082572;4112.773797441139;5917.171595976567;5963.582549221556;5969.5821292509545;5970.104484327342;5970.31341395745;4210.45264115663;4220.662347012231;4221.6200541951375;4222.894427639334;4227.239096962515;4276.08064266178;4289.335153051282;4290.970167159921;4292.527821939584;4296.033392486665;4838.637102217348;4843.806247750121;4849.80600775965;4850.805967761321;4855.271709243571;5688.089905615082;5695.943040569624;5697.715114244271;5700.116481945305;5701.71491425427;1387.438087574534;1487.605784467117;1514.6970605878869;1514.9166795826116;1515.454436402894;924.7965447601517;961.6682244625733;973.1533565797802;983.3116818227127;994.0705440413237;4850.563449289511;4896.436909755424;4898.485659005753;4938.530839570235;4968.1554135797005;5841.211436456024;5899.941000589939;5901.380355062656;5902.911456328158;5905.586608937419;4975.228839529878;4978.128827455181;4979.551840334388;4983.725895075733;4988.775505102279;3094;3133.263683034485;3137.0588823352905;3138.6704396038085;3138.9686103138674;5484.095124304525;5517.393086760453;5531.170324451284;5539.362973258127;5546.223528705985;5918.556108291896;6103.816885493442;6115.205023347025;6115.724792384353;6122.326544080237;5579.19101730255;5585.385607583163;5613.915791263134;5623.522000629992;5624.578156638268;5929.080992446177;5936.406359364029;5937.554683398676;5994.760209591567;6000.21997140369;5769.365369809401;5833.620814647034;5834.445727655866;5836.037053886062;5837.503812176013;5374.408815030265;5626.099824028136;5627.7467513961155;5636.4927156556105;5638.689872057076;3991.3613821788376;4032.153247817991;4065.735727177724;4072.6334629883454;4100.2414553307735;5893;5900;5910.822675319747;5911.349751527243;5912.674802885883;5613.663180209201;5623.2127502148915;5687.971560142173;5693.715314234355;5694.4590263924865;5651.039323314964;5651.858703532444;5652.802151924663;5654.321481422256;5668.943310566841;5359.571234301168;5537.418571050143;5559.138333558305;5574.219609254626;5582.385937546947;5670.376258611467;5697.886042279214;5699.401562835843;5708.571857110816;5717.456841600041;5561.749721262472;5564.221009058654;5573.693446860461;5576.470235327637;5578.246936663499 22:31:38 INFO - PROCESS | 4981 | |5;yui.html;689.6103701408704;767.6392095715012;781.9296263336298;794.1581923161449;804.3846457460044;11911.523539058438;12058.758824823499;12102.092343074282;12107.394630268473;12141.150119491627;12005.339706316148;12030.69923251917;12077.335746533938;12094.576689815858;12101.576444824412;777.3237283563308;797.6011994002998;820.1716266570747;832.134580036761;835.106436113359;821.4126899267023;822.005373498068;823.1110400767157;823.2508417340222;826.8759686047111;862.2067697718114;865.3985480091308;865.5931712095337;865.8268346330759;866.0170706248422;847.7414388611471;848.2662496940164;851.7615067780969;852.2798235491;853.9743807685779;620.4199073865905;623.7068577768487;625.1029772276797;626.3141859663707;626.7117126121989;13021.86978130216;13123.278219697913;13186.538471153464;13187.406566704522;13222.272774997371;12290.815637765441;12420.130590858644;12558.372081395984;12601.117921745481;12613.369331533386;9984.800303993952;10020.248481363855;10152.137068349199;10157.085862272357;10193.847092293621;3240.951385729216;3274.476083826576;3302.1579497228054;3407.0289967359186;3414.4195486767308;39226.21547569061;43186.35220471695;44454;44942.32586511172;44991.32513012308;9914.40513569188;9929.900700992897;9946.403215807075;9989.400635961865;10021.448820314952;15869.603259918595;15881.920590396974;16009.199540022952;16031.278592463366;16057.839421605635;7017.157941047005;7115.501914866013;7184.604846733375;7217.458690598226;7338.376238019828;3774.584795672474;3863.208042351311;3883.805809709503;3928.253631809947;4002.9799851000557;2854.2293580733085;2884.769218462518;2896.8551572421716;2900.6664233612983;2902.3179552805072;504.2134270537899;504.5811976059862;517.1544524702064;519.8804275016768;523.8454655876526;459.92411252143023;466.96030837379203;496.71438922618916;542.9511343979061;579.1573260905373;7641.197674244125;7947.602619868983;7994.960025199837;8021.719239826578;8533.189347012023;559.8208573256519;577.2639884147745;585.359031860121;590.9852253693692;611.400827189357;3581.158427769472;3624.5348530210395;3653.725970552219;3672.192117734094;3700.5189325388064;48077;48134.518654813706;48152.5184748155;48239.51760482421;50277.49722502801;45250.54749452529;45574.54425455703;45708.08583828305;45908.54091459043;46049.76975115103;36051.819740901126;38594.80702596469;40588.39117413241;40786.59213407887;40922.59077409188;8096.109427963037;8125.692275453247;8279.710210142857;8299.204233497516;8448.915510844812;32351.838240808644;32476.188095297806;33540.66459335375;33934.151646209044;34205.315893682484;37688.43467348047;37758.244835103695;39354.2129157421;39917.40123898202;40277.79861100676;9786.75533111678;9796.16732577739;9862.753431163992;10044.949775251076;10099.596016159272;10922.617708380169;11039.227254092137;11255.774884502427;11381.203315767816;11457.828132578185;10336.586536538454;10341.327813692085;10343.172546196136;10446.440994653116;10650.946745266225;10188.847167292644;10616;10782.137429005817;10906.34561926287;10912.94543527309;9524.14282714559;10591.258611897401;10637.308574942605;10893.801681815152;10896.836547451636;8651.91348086511;8661.696840610548;8794.42836215644;8960;9067.05320770739;8929.687460938836;9050.841020618185;9344;9509.429434233969;9544.284178686765 22:31:38 INFO - PROCESS | 4981 | __end_tp_report 22:31:38 INFO - PROCESS | 4981 | __start_cc_report 22:31:38 INFO - PROCESS | 4981 | _x_x_mozilla_cycle_collect,1033 22:31:38 INFO - PROCESS | 4981 | __end_cc_report 22:31:38 INFO - PROCESS | 4981 | __startTimestamp1458279098665__endTimestamp 22:31:38 INFO - PROCESS | 4981 | 22:31:38 INFO - PROCESS | 4981 | ------- Summary: start ------- 22:31:38 INFO - PROCESS | 4981 | Number of tests: 6 22:31:38 INFO - PROCESS | 4981 | 22:31:38 INFO - PROCESS | 4981 | [#0] dojo.html Cycles:165 Average:4665.99 Median:4809.52 stddev:486.90 (10.1%) stddev-sans-first:461.08 22:31:38 INFO - PROCESS | 4981 | Values: 2616.1 2669.0 2675.5 2701.1 2722.9 4650.0 4677.1 4678.5 4692.7 4735.9 4659.0 4719.6 4794.0 4807.8 4830.1 4309.0 4332.7 4353.6 4399.2 4410.2 4411.3 4466.6 4473.8 4493.0 4509.3 4245.6 4275.8 4367.1 4399.8 4430.2 4290.7 4317.0 4319.0 4344.5 4356.3 4261.0 4282.8 4289.8 4301.0 4328.2 4491.3 4552.7 4572.8 4609.0 4618.1 5014.5 5041.2 5041.7 5057.3 5078.5 5052.0 5062.2 5075.4 5081.7 5115.2 4661.2 4723.6 4725.9 4804.8 4809.5 5212.9 5229.5 5230.5 5241.3 5248.6 4995.5 5007.5 5021.6 5069.2 5071.0 4927.2 4976.9 5040.0 5082.3 5100.3 4943.8 4960.9 4969.6 4991.2 5008.4 4862.6 4968.5 4970.6 4980.6 5019.9 4195.0 4208.9 4229.7 4259.5 4276.0 3720.0 3723.1 3731.5 3743.6 3758.7 4266.8 4342.5 4375.5 4386.3 4422.5 4966.5 5055.4 5071.2 5104.5 5107.2 4325.4 4341.2 4344.7 4350.3 4379.4 4447.4 4502.3 4507.2 4519.6 4539.0 4790.5 4801.1 4819.2 4823.1 4877.3 5059.6 5062.1 5065.4 5071.1 5074.3 4621.3 4758.7 4785.8 4803.2 4811.0 4978.3 4998.0 5000.8 5001.6 5030.2 5080.7 5097.9 5098.9 5102.6 5122.7 4779.9 4859.2 4922.0 4941.5 4945.7 4851.6 4876.0 4891.4 4892.2 4940.5 4801.3 4818.8 4825.3 4831.9 4849.2 4766.9 4912.1 4977.1 5016.0 5029.3 4840.2 4846.4 4853.8 4860.1 4909.1 22:31:38 INFO - PROCESS | 4981 | 22:31:38 INFO - PROCESS | 4981 | [#1] ext.html Cycles:180 Average:38707.19 Median:17764.28 stddev:62892.84 (354.0%) stddev-sans-first:63003.95 22:31:38 INFO - PROCESS | 4981 | Values: 530.9 543.7 552.8 559.2 570.5 28482.7 29118.6 29131.0 29190.1 29194.6 33944.2 34374.0 34470.1 34473.0 34475.8 7880.2 8110.2 8112.8 8116.1 8122.2 7712.8 7782.1 7803.1 7804.2 7805.2 7982.0 8053.2 8071.7 8075.6 8082.7 7944.7 8035.3 8053.0 8053.5 8055.3 7729.0 7796.6 7843.8 7845.0 7853.5 36327.6 36702.4 36839.0 36908.8 36910.4 2992.9 3128.2 3219.1 3552.0 3811.2 28486.6 28712.7 28852.6 29262.4 29548.9 3484.4 3501.1 3510.3 3520.8 3530.6 178513.0 178665.1 178721.0 179364.0 179902.0 46972.4 47406.5 47457.5 47556.0 47575.8 41251.0 57440.4 57742.0 57814.4 57845.0 14423.4 14521.6 14540.4 14627.3 14729.0 11205.8 11329.9 11330.3 11334.1 11338.1 15774.8 18408.4 18449.9 18634.7 18823.6 7102.1 7365.2 7400.6 7407.4 7435.4 882.6 974.8 994.1 1004.6 1008.9 26552.9 27728.9 27878.7 28158.0 28208.6 890.4 932.5 935.6 997.6 1055.4 13001.1 13201.5 13482.3 13700.3 14059.2 307579.0 310870.0 312061.0 313088.0 313305.0 45375.3 45480.5 45663.5 45765.8 45785.5 1077.3 1204.3 1270.2 1274.4 1284.2 23782.2 24024.0 26340.2 26663.3 26830.5 37230.4 37319.6 37773.4 37786.8 37912.6 208973.0 211237.0 211530.0 211638.0 211989.0 25781.0 30006.2 30062.5 30113.0 30189.2 33295.0 33659.7 34264.8 34360.7 34414.7 29420.0 29523.3 29585.7 29614.4 29785.1 31483.0 32059.0 32096.0 32309.5 32374.5 32123.5 32188.0 32529.5 32735.0 32847.3 27913.2 28765.0 29140.4 29146.9 29216.6 23255.5 23303.9 23394.9 23496.5 23533.8 22:31:38 INFO - PROCESS | 4981 | 22:31:38 INFO - PROCESS | 4981 | [#2] jquery.html Cycles:180 Average:23835.85 Median:4538.36 stddev:66920.23 (1474.5%) stddev-sans-first:67084.74 22:31:38 INFO - PROCESS | 4981 | Values: 356.7 357.8 363.2 371.1 371.3 15600.8 15933.3 16622.3 17249.6 17601.5 15913.2 16136.6 16174.2 16194.5 16693.8 4937.1 5038.1 5139.4 5146.4 5175.1 5047.3 5103.5 5107.3 5109.3 5131.4 5017.3 5040.2 5048.8 5074.9 5104.9 4935.7 5022.2 5059.9 5061.8 5080.0 4534.3 4537.8 4538.9 4540.7 4543.0 11524.7 19346.8 20293.4 20366.4 20387.9 1832.4 1928.4 1949.7 1952.9 2174.4 8742.2 8759.4 8860.4 9050.7 9066.0 1784.7 1790.0 1850.1 1866.1 1871.0 59184.4 61373.7 62521.4 62685.7 63102.4 10395.1 10453.9 10503.8 10517.8 10555.1 13456.6 13545.6 13551.7 13598.5 13609.7 7195.9 7394.3 7401.9 7511.1 7544.7 7151.9 7153.0 7290.3 7290.7 7300.2 4466.6 4488.4 4491.8 4566.6 4615.4 1668.8 1703.9 1718.5 1732.8 1756.9 893.6 902.3 909.3 960.8 979.8 15865.4 15928.3 16519.8 16792.5 16799.9 837.8 843.2 858.8 865.8 953.1 9131.8 9217.8 9477.6 9578.3 9664.4 364683.0 392439.0 424280.0 426705.0 428092.0 67357.0 68363.0 68504.3 68745.3 69647.0 918.2 927.6 928.1 943.9 944.9 14202.9 14509.5 14592.7 14627.3 14784.7 31601.7 32276.5 33084.8 33392.5 33445.3 41819.0 44227.8 44874.0 45369.0 46338.8 7430.9 7514.7 7661.8 7729.9 7740.2 9119.9 11284.3 11326.4 11339.3 11558.3 9848.6 9903.3 10039.2 10263.6 10557.6 9988.6 10071.7 10074.0 10111.3 10123.3 9922.3 10238.4 10243.8 10522.9 10555.8 7356.7 7431.3 7448.8 7502.9 7701.2 7847.7 9918.6 9969.4 10125.4 10463.4 22:31:38 INFO - PROCESS | 4981 | 22:31:38 INFO - PROCESS | 4981 | [#3] mootools.html Cycles:180 Average:5209.56 Median:6234.69 stddev:2619.15 (42.0%) stddev-sans-first:2608.75 22:31:38 INFO - PROCESS | 4981 | Values: 1154.4 1413.9 1424.9 1550.0 1743.2 7182.2 7340.6 7348.6 7368.2 7374.7 7107.3 7295.8 7300.1 7307.9 7317.5 1893.6 2246.5 2249.1 2279.2 2321.2 2248.5 2256.9 2257.4 2261.2 2261.3 2204.5 2269.3 2270.6 2272.0 2272.3 2252.6 2254.4 2261.5 2296.5 2298.2 2253.5 2264.5 2277.1 2277.3 2303.5 7526.9 7550.3 7590.1 7594.5 7599.2 4550.9 4649.3 4653.2 4664.1 4682.2 2993.5 3011.2 3058.7 3066.9 3163.0 1002.5 1013.0 1025.9 1042.2 1042.9 9564.3 9647.1 9680.2 9716.8 9720.3 4197.1 4281.2 4364.0 4387.9 4389.6 8334.7 8380.6 8389.6 8407.1 8430.0 4108.6 4569.4 4628.2 4633.2 4634.1 4171.7 4215.9 4223.1 4246.2 4264.8 3521.8 3613.9 3630.4 3645.8 3660.9 1214.5 1238.3 1245.9 1248.8 1257.1 977.9 1009.7 1154.4 1183.6 1184.3 6971.3 6997.9 7033.6 7054.0 7061.9 1044.3 1058.2 1060.6 1069.0 1097.0 5526.4 5530.6 5579.4 5583.1 5635.6 8578.3 9072.4 9094.2 9104.0 9109.8 8965.7 8969.9 8976.3 8992.1 9026.4 6963.9 7273.8 7292.2 7319.9 7348.6 6852.2 6922.0 6932.8 6938.9 6954.2 7788.5 7819.8 7954.0 7955.0 8074.7 8042.1 8064.8 8114.2 8162.6 8197.5 5616.5 5705.2 5713.7 6429.8 6654.7 6363.5 6928.0 7132.9 7135.5 7140.1 6068.1 6233.5 6278.9 6296.4 6400.7 6235.9 6408.1 6462.1 6492.7 6624.5 6759.6 6804.3 6807.9 6809.0 6919.4 6237.0 6271.2 6319.9 6325.8 6339.4 6214.5 6226.8 6268.9 6271.5 6276.2 22:31:38 INFO - PROCESS | 4981 | 22:31:38 INFO - PROCESS | 4981 | [#4] prototype.html Cycles:180 Average:4728.38 Median:5369.08 stddev:1381.11 (25.7%) stddev-sans-first:1344.84 22:31:38 INFO - PROCESS | 4981 | Values: 323.7 324.1 324.6 330.3 332.5 5373.5 5387.4 5397.1 5398.0 5406.1 5344.7 5352.1 5355.5 5356.7 5364.7 3990.7 4078.9 4147.5 4182.6 4212.8 4162.6 4169.4 4187.2 4189.0 4199.6 4138.2 4178.9 4186.1 4186.6 4194.7 3951.3 4063.1 4180.6 4182.8 4186.5 3704.9 3715.2 3718.3 3721.0 3725.4 5175.8 5199.5 5202.2 5203.9 5207.7 4832.3 4863.5 4878.2 4883.7 4885.7 5658.9 5671.1 5680.4 5681.5 5688.2 3986.0 4106.6 4109.1 4112.1 4112.8 5917.2 5963.6 5969.6 5970.1 5970.3 4210.5 4220.7 4221.6 4222.9 4227.2 4276.1 4289.3 4291.0 4292.5 4296.0 4838.6 4843.8 4849.8 4850.8 4855.3 5688.1 5695.9 5697.7 5700.1 5701.7 1387.4 1487.6 1514.7 1514.9 1515.5 924.8 961.7 973.2 983.3 994.1 4850.6 4896.4 4898.5 4938.5 4968.2 5841.2 5899.9 5901.4 5902.9 5905.6 4975.2 4978.1 4979.6 4983.7 4988.8 3094.0 3133.3 3137.1 3138.7 3139.0 5484.1 5517.4 5531.2 5539.4 5546.2 5918.6 6103.8 6115.2 6115.7 6122.3 5579.2 5585.4 5613.9 5623.5 5624.6 5929.1 5936.4 5937.6 5994.8 6000.2 5769.4 5833.6 5834.4 5836.0 5837.5 5374.4 5626.1 5627.7 5636.5 5638.7 3991.4 4032.2 4065.7 4072.6 4100.2 5893.0 5900.0 5910.8 5911.3 5912.7 5613.7 5623.2 5688.0 5693.7 5694.5 5651.0 5651.9 5652.8 5654.3 5668.9 5359.6 5537.4 5559.1 5574.2 5582.4 5670.4 5697.9 5699.4 5708.6 5717.5 5561.7 5564.2 5573.7 5576.5 5578.2 22:31:38 INFO - PROCESS | 4981 | 22:31:38 INFO - PROCESS | 4981 | [#5] yui.html Cycles:180 Average:12486.93 Median:45120.94 stddev:13924.88 (30.9%) stddev-sans-first:13935.76 22:31:38 INFO - PROCESS | 4981 | Values: 689.6 767.6 781.9 794.2 804.4 11911.5 12058.8 12102.1 12107.4 12141.2 12005.3 12030.7 12077.3 12094.6 12101.6 777.3 797.6 820.2 832.1 835.1 821.4 822.0 823.1 823.3 826.9 862.2 865.4 865.6 865.8 866.0 847.7 848.3 851.8 852.3 854.0 620.4 623.7 625.1 626.3 626.7 13021.9 13123.3 13186.5 13187.4 13222.3 12290.8 12420.1 12558.4 12601.1 12613.4 9984.8 10020.2 10152.1 10157.1 10193.8 3241.0 3274.5 3302.2 3407.0 3414.4 39226.2 43186.4 44454.0 44942.3 44991.3 9914.4 9929.9 9946.4 9989.4 10021.4 15869.6 15881.9 16009.2 16031.3 16057.8 7017.2 7115.5 7184.6 7217.5 7338.4 3774.6 3863.2 3883.8 3928.3 4003.0 2854.2 2884.8 2896.9 2900.7 2902.3 504.2 504.6 517.2 519.9 523.8 459.9 467.0 496.7 543.0 579.2 7641.2 7947.6 7995.0 8021.7 8533.2 559.8 577.3 585.4 591.0 611.4 3581.2 3624.5 3653.7 3672.2 3700.5 48077.0 48134.5 48152.5 48239.5 50277.5 45250.5 45574.5 45708.1 45908.5 46049.8 36051.8 38594.8 40588.4 40786.6 40922.6 8096.1 8125.7 8279.7 8299.2 8448.9 32351.8 32476.2 33540.7 33934.2 34205.3 37688.4 37758.2 39354.2 39917.4 40277.8 9786.8 9796.2 9862.8 10044.9 10099.6 10922.6 11039.2 11255.8 11381.2 11457.8 10336.6 10341.3 10343.2 10446.4 10650.9 10188.8 10616.0 10782.1 10906.3 10912.9 9524.1 10591.3 10637.3 10893.8 10896.8 8651.9 8661.7 8794.4 8960.0 9067.1 8929.7 9050.8 9344.0 9509.4 9544.3 22:31:38 INFO - PROCESS | 4981 | -------- Summary: end -------- 22:31:38 INFO - PROCESS | 4981 | 22:31:39 INFO - TEST-INFO | 4981: exit 0 22:31:39 INFO - TEST-OK | dromaeo_css | took 1117075ms 22:31:39 INFO - TEST-START | kraken 22:31:39 INFO - operating with platform_type : linux_ 22:31:39 INFO - Initialising browser for kraken test... 22:31:39 INFO - TEST-INFO | started process 5162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM6Qz55/profile http://localhost:54349/getInfo.html) 22:31:44 INFO - PROCESS | 5162 | __metrics Screen width/height:1600/1200 22:31:44 INFO - PROCESS | 5162 | colorDepth:24 22:31:44 INFO - PROCESS | 5162 | Browser inner width/height: 1024/697 22:31:44 INFO - PROCESS | 5162 | __metrics 22:31:44 ERROR - PROCESS | 5162 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:31:45 INFO - TEST-INFO | 5162: exit 0 22:31:45 INFO - Browser initialized. 22:31:45 INFO - Running cycle 1/1 for kraken test... 22:31:45 INFO - TEST-INFO | started process 5247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM6Qz55/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:31:57 INFO - PROCESS | 5247 | RSS: Main: 154427392 22:31:57 INFO - PROCESS | 5247 | 22:32:00 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54349/tests/kraken/driver.html?testName=audio-beat-detection) 22:32:00 INFO - PROCESS | 5247 | RSS: Main: 197652480 22:32:00 INFO - PROCESS | 5247 | 22:32:03 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54349/tests/kraken/driver.html?testName=audio-dft) 22:32:04 INFO - PROCESS | 5247 | RSS: Main: 186294272 22:32:04 INFO - PROCESS | 5247 | 22:32:07 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54349/tests/kraken/driver.html?testName=audio-fft) 22:32:07 INFO - PROCESS | 5247 | RSS: Main: 172249088 22:32:07 INFO - PROCESS | 5247 | 22:32:09 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54349/tests/kraken/driver.html?testName=audio-oscillator) 22:32:10 INFO - PROCESS | 5247 | RSS: Main: 173916160 22:32:10 INFO - PROCESS | 5247 | 22:32:12 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54349/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:32:13 INFO - PROCESS | 5247 | RSS: Main: 176300032 22:32:13 INFO - PROCESS | 5247 | 22:32:16 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54349/tests/kraken/driver.html?testName=imaging-darkroom) 22:32:16 INFO - PROCESS | 5247 | RSS: Main: 174710784 22:32:16 INFO - PROCESS | 5247 | 22:32:20 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54349/tests/kraken/driver.html?testName=imaging-desaturate) 22:32:20 INFO - PROCESS | 5247 | RSS: Main: 177401856 22:32:20 INFO - PROCESS | 5247 | 22:32:23 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54349/tests/kraken/driver.html?testName=json-parse-financial) 22:32:24 INFO - PROCESS | 5247 | RSS: Main: 175693824 22:32:24 INFO - PROCESS | 5247 | 22:32:26 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54349/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:32:26 INFO - PROCESS | 5247 | RSS: Main: 185696256 22:32:26 INFO - PROCESS | 5247 | 22:32:28 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54349/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:32:29 INFO - PROCESS | 5247 | RSS: Main: 182181888 22:32:29 INFO - PROCESS | 5247 | 22:32:31 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54349/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:32:31 INFO - PROCESS | 5247 | RSS: Main: 194629632 22:32:31 INFO - PROCESS | 5247 | 22:32:34 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:32:34 INFO - PROCESS | 5247 | RSS: Main: 198602752 22:32:34 INFO - PROCESS | 5247 | 22:32:37 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:32:38 INFO - PROCESS | 5247 | RSS: Main: 197398528 22:32:38 INFO - PROCESS | 5247 | 22:32:39 INFO - PROCESS | 5247 | Cycle 1(1): loaded http://localhost:54349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54349/tests/kraken/driver.html?testName=ai-astar) 22:32:40 INFO - PROCESS | 5247 | RSS: Main: 258748416 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | __start_tp_report 22:32:40 INFO - PROCESS | 5247 | _x_x_mozilla_page_load 22:32:40 INFO - PROCESS | 5247 | _x_x_mozilla_page_load_details 22:32:40 INFO - PROCESS | 5247 | |i|pagename|runs| 22:32:40 INFO - PROCESS | 5247 | |0;ai-astar;113;113;107;112;112;112;102;113;113;112 22:32:40 INFO - PROCESS | 5247 | |1;audio-beat-detection;157;132;156;170;130;153;151;131;169;130 22:32:40 INFO - PROCESS | 5247 | |2;audio-dft;160;161;161;162;162;160;164;161;162;162 22:32:40 INFO - PROCESS | 5247 | |3;audio-fft;73;73;104;97;76;74;73;114;92;73 22:32:40 INFO - PROCESS | 5247 | |4;audio-oscillator;94;92;138;93;94;93;140;93;92;141 22:32:40 INFO - PROCESS | 5247 | |5;imaging-gaussian-blur;118;117;117;117;118;117;117;117;117;117 22:32:40 INFO - PROCESS | 5247 | |6;imaging-darkroom;146;146;145;145;145;146;146;145;146;146 22:32:40 INFO - PROCESS | 5247 | |7;imaging-desaturate;96;95;95;95;96;96;95;95;96;95 22:32:40 INFO - PROCESS | 5247 | |8;json-parse-financial;63;64;64;63;62;64;64;74;61;61 22:32:40 INFO - PROCESS | 5247 | |9;json-stringify-tinderbox;63;64;64;63;63;63;65;64;64;65 22:32:40 INFO - PROCESS | 5247 | |10;stanford-crypto-aes;89;83;91;82;82;81;83;82;83;82 22:32:40 INFO - PROCESS | 5247 | |11;stanford-crypto-ccm;130;115;117;112;124;118;125;119;115;132 22:32:40 INFO - PROCESS | 5247 | |12;stanford-crypto-pbkdf2;140;128;141;140;139;130;139;140;147;131 22:32:40 INFO - PROCESS | 5247 | |13;stanford-crypto-sha256-iterative;67;66;65;64;66;64;66;68;65;67 22:32:40 INFO - PROCESS | 5247 | __end_tp_report 22:32:40 INFO - PROCESS | 5247 | __start_cc_report 22:32:40 INFO - PROCESS | 5247 | _x_x_mozilla_cycle_collect,1109 22:32:40 INFO - PROCESS | 5247 | __end_cc_report 22:32:40 INFO - PROCESS | 5247 | __startTimestamp1458279160079__endTimestamp 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | ------- Summary: start ------- 22:32:40 INFO - PROCESS | 5247 | Number of tests: 14 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.50 stddev:3.60 (3.2%) stddev-sans-first:3.74 22:32:40 INFO - PROCESS | 5247 | Values: 113.0 113.0 107.0 112.0 112.0 112.0 102.0 113.0 113.0 112.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:154.50 stddev:15.98 (10.3%) stddev-sans-first:16.60 22:32:40 INFO - PROCESS | 5247 | Values: 157.0 132.0 156.0 170.0 130.0 153.0 151.0 131.0 169.0 130.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.18 (0.7%) stddev-sans-first:1.12 22:32:40 INFO - PROCESS | 5247 | Values: 160.0 161.0 161.0 162.0 162.0 160.0 164.0 161.0 162.0 162.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#3] audio-fft Cycles:10 Average:84.90 Median:73.50 stddev:15.54 (21.1%) stddev-sans-first:15.87 22:32:40 INFO - PROCESS | 5247 | Values: 73.0 73.0 104.0 97.0 76.0 74.0 73.0 114.0 92.0 73.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:93.00 stddev:22.56 (24.3%) stddev-sans-first:23.44 22:32:40 INFO - PROCESS | 5247 | Values: 94.0 92.0 138.0 93.0 94.0 93.0 140.0 93.0 92.0 141.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 22:32:40 INFO - PROCESS | 5247 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 22:32:40 INFO - PROCESS | 5247 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:32:40 INFO - PROCESS | 5247 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:3.71 (5.8%) stddev-sans-first:3.92 22:32:40 INFO - PROCESS | 5247 | Values: 63.0 64.0 64.0 63.0 62.0 64.0 64.0 74.0 61.0 61.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 22:32:40 INFO - PROCESS | 5247 | Values: 63.0 64.0 64.0 63.0 63.0 63.0 65.0 64.0 64.0 65.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:3.36 (4.0%) stddev-sans-first:2.99 22:32:40 INFO - PROCESS | 5247 | Values: 89.0 83.0 91.0 82.0 82.0 81.0 83.0 82.0 83.0 82.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:121.50 stddev:6.73 (5.5%) stddev-sans-first:6.24 22:32:40 INFO - PROCESS | 5247 | Values: 130.0 115.0 117.0 112.0 124.0 118.0 125.0 119.0 115.0 132.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.50 Median:140.00 stddev:5.91 (4.2%) stddev-sans-first:6.20 22:32:40 INFO - PROCESS | 5247 | Values: 140.0 128.0 141.0 140.0 139.0 130.0 139.0 140.0 147.0 131.0 22:32:40 INFO - PROCESS | 5247 | 22:32:40 INFO - PROCESS | 5247 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:1.32 22:32:40 INFO - PROCESS | 5247 | Values: 67.0 66.0 65.0 64.0 66.0 64.0 66.0 68.0 65.0 67.0 22:32:40 INFO - PROCESS | 5247 | -------- Summary: end -------- 22:32:40 INFO - PROCESS | 5247 | 22:32:41 INFO - TEST-INFO | 5247: exit 0 22:32:41 INFO - TEST-OK | kraken | took 61643ms 22:32:41 INFO - SUITE-END | took 1178s 22:32:41 INFO - Completed test suite (00:19:38) 22:32:41 INFO - javascript benchmark 22:32:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2616.0974463809985, 2669.0258055809636, 2675.5050315691587, 2701.149138021523, 2722.8638568071606, 4650.0467404182145, 4677.134730074934, 4678.508756580557, 4692.741899195543, 4735.928961065578, 4658.976705116478, 4719.551642593948, 4794.041191761653, 4807.831725889595, 4830.106430310395, 4308.956910430903, 4332.65338772899, 4353.608175264226, 4399.164158809832, 4410.206162890679, 4411.316245981878, 4466.62033727132, 4473.776311184428, 4493.0, 4509.25597276449, 4245.5542168072525, 4275.828966841323, 4367.104743527601, 4399.78001099947, 4430.202563538578, 4290.656747460227, 4317.028668549551, 4319.02821865081, 4344.500382456026, 4356.281213599752, 4261.041265715189, 4282.807273672693, 4289.785510724482, 4301.0, 4328.177646247203, 4491.25894227452, 4552.704074235164, 4572.839950601746, 4608.976955115203, 4618.145643056012, 5014.548690617826, 5041.243813427978, 5041.697498150123, 5057.2666963290485, 5078.466760990117, 5051.974740126276, 5062.164742817431, 5075.390953085616, 5081.74591270435, 5115.155999260155, 4661.207594708908, 4723.598494128003, 4725.9291110632685, 4804.783784729696, 4809.519048095162, 5212.8957420851375, 5229.4770522948165, 5230.503102205284, 5241.292425522582, 5248.606354523426, 4995.475475075137, 5007.549320561167, 5021.573166280907, 5069.188929771219, 5070.9858028394465, 4927.187014142626, 4976.925346119811, 5040.042391945519, 5082.33929589151, 5100.260462232955, 4943.752812359367, 4960.8759781005765, 4969.602431805447, 4991.151504244287, 5008.424031236382, 4862.562369386772, 4968.527989840959, 4970.602351811919, 4980.551750342486, 5019.924701129486, 4194.979025104855, 4208.85269015583, 4229.6827737919775, 4259.467566554181, 4276.0, 3719.962800372016, 3723.069232691827, 3731.5149030625844, 3743.6256374362347, 3758.699304055669, 4266.786660666954, 4342.457192850894, 4375.47494300686, 4386.254336762758, 4422.513523512411, 4966.453690094087, 5055.368078990126, 5071.239314102914, 5104.489551044866, 5107.157319042316, 4325.3728209409455, 4341.218580655449, 4344.717593356421, 4350.260455722535, 4379.430674012358, 4447.355133505624, 4502.279635258343, 4507.18870603288, 4519.593236608721, 4539.02410981634, 4790.5448982346625, 4801.1117943180625, 4819.180739274332, 4823.131836269506, 4877.317175595419, 5059.620528460454, 5062.114130027304, 5065.417476990193, 5071.061853557104, 5074.264231686311, 4621.3299071633755, 4758.690685105457, 4785.760711964457, 4803.18345881208, 4811.0, 4978.253262010728, 4997.950020499894, 5000.774965126505, 5001.599872010303, 5030.220315851049, 5080.7205603692155, 5097.923531146962, 5098.872528186825, 5102.642815002914, 5122.74386280677, 4779.856604301876, 4859.222524396079, 4921.966387058757, 4941.530554597308, 4945.703257804544, 4851.58761505276, 4875.975620121877, 4891.388576427947, 4892.168331383745, 4940.456549779593, 4801.279808028824, 4818.759062046814, 4825.252085926687, 4831.879203019812, 4849.248366503198, 4766.928496072493, 4912.091263116335, 4977.129002424634, 5016.0, 5029.27075574047, 4840.177169881199, 4846.442659094249, 4853.830115945925, 4860.07884702373, 4909.0672772173175], "unit": "score", "name": "dojo.html", "value": 4635.341583758824}, {"lowerIsBetter": false, "replicates": [530.9362876454826, 543.7498750574736, 552.8092807981245, 559.1752165555806, 570.5407147246467, 28482.715172848264, 29118.563221551667, 29131.0, 29190.124296271148, 29194.562081568794, 33944.15139621511, 34374.0, 34470.13824654385, 34473.0, 34475.82762086192, 7880.172581878906, 8110.229528194842, 8112.797180070516, 8116.1478044805335, 8122.228388303101, 7712.845743085135, 7782.105057918327, 7803.141654418009, 7804.219578042207, 7805.219478052206, 7981.960090199541, 8053.1946805319585, 8071.717489887855, 8075.596220188967, 8082.676692932276, 7944.682212711485, 8035.316998055172, 8052.959735201345, 8053.4765240259785, 8055.275025247726, 7729.0, 7796.61016949156, 7843.764687059397, 7844.960775196145, 7853.489523181032, 36327.63672363269, 36702.449463258075, 36839.0, 36908.81545592282, 36910.44634330487, 2992.925176870574, 3128.2179455136215, 3219.050380137865, 3552.0231936217488, 3811.2377524495214, 28486.572701409495, 28712.712872871212, 28852.567211491845, 29262.414751704848, 29548.852255738584, 3484.372812893678, 3501.1422201560526, 3510.3154884797473, 3520.7887526748477, 3530.5939816921127, 178513.0, 178665.1066744671, 178721.0, 179364.0, 179902.0, 46972.363316402254, 47406.5259347409, 47457.525424746, 47556.04887902222, 47575.762121189866, 41251.0, 57440.42559574351, 57742.0, 57814.421855781744, 57845.0, 14423.350949207312, 14521.636959076108, 14540.41838326455, 14627.341769620392, 14729.0, 11205.831912521318, 11329.94335028336, 11330.263532870336, 11334.093272538343, 11338.092952563775, 15774.842251577567, 18408.447746567625, 18449.907750461163, 18634.720479192823, 18823.623527529373, 7102.112235970504, 7365.1530074042175, 7400.592967386845, 7407.444441666897, 7435.367993720594, 882.6381183714647, 974.7563109222694, 994.0655783563427, 1004.5931397783909, 1008.9293749437469, 26552.8672356637, 27728.861355693494, 27878.72121278802, 28158.0, 28208.576871346948, 890.3811850763657, 932.5337331334333, 935.5789894547481, 997.6408492942535, 1055.37205362809, 13001.089923705438, 13201.47194112244, 13482.25847578373, 13700.314984250748, 14059.156450612996, 307579.0, 310870.0, 312061.0, 313088.0, 313305.0, 45375.31937020947, 45480.54519454763, 45663.54336456659, 45765.77117114393, 45785.542144578125, 1077.3159044007111, 1204.3315959642307, 1270.1997741423029, 1274.3691872522975, 1284.1588759362633, 23782.16762413307, 24024.0, 26340.20979370622, 26663.33341666474, 26830.463390732468, 37230.44154337633, 37319.6268037327, 37773.43339849849, 37786.811065944494, 37912.62087379091, 208973.0, 211237.0, 211530.0, 211638.0, 211989.0, 25781.0, 30006.24984375321, 30062.54906176453, 30113.0, 30189.245268868453, 33295.0, 33659.66340336565, 34264.828675856465, 34360.65639343575, 34414.65585344215, 29420.0, 29523.26191845135, 29585.704142959155, 29614.407711846074, 29785.10644680663, 31483.0, 32059.0, 32096.0, 32309.51535727013, 32374.514382283814, 32123.518147227343, 32188.0, 32529.512057318687, 32735.0, 32847.34305313928, 27913.2317137192, 28765.0, 29140.417191656474, 29146.854265728536, 29216.561751573317, 23255.534889302457, 23303.908201550596, 23394.883025584764, 23496.530069398174, 23533.76466235316], "unit": "score", "name": "ext.html", "value": 16413.952944693658}, {"lowerIsBetter": false, "replicates": [356.65226404255856, 357.8049962770291, 363.15385152594456, 371.1074864949795, 371.29454037329054, 15600.843991560096, 15933.283002264898, 16622.25199866006, 17249.568760780985, 17601.471955841345, 15913.204339783022, 16136.596585085379, 16174.19129043549, 16194.514164575081, 16693.83306166941, 4937.111319962405, 5038.067957427869, 5139.408967968694, 5146.408163061258, 5175.068487672217, 5047.343845300106, 5103.515166059218, 5107.336046313974, 5109.3357863477695, 5131.358580177478, 5017.347744793172, 5040.218766091261, 5048.763053052007, 5074.873128171788, 5104.948950510485, 4935.703857768545, 5022.17134172861, 5059.924101138467, 5061.822836200715, 5079.974600126994, 4534.342520334566, 4537.841175558872, 4538.8865278367975, 4540.72755634663, 4542.977285113587, 11524.711882202928, 19346.806531934642, 20293.391198264075, 20366.389008329774, 20387.89806050975, 1832.3586744639404, 1928.3829174664113, 1949.6783030799902, 1952.9316473923345, 2174.3803016140323, 8742.169493898133, 8759.430637008574, 8860.405127077123, 9050.683226087056, 9066.0, 1784.6966015777218, 1789.9910500447415, 1850.1489314915154, 1866.0669665167416, 1871.0, 59184.40815591832, 61373.69313153451, 62521.37478625246, 62685.686571567305, 63102.36897631011, 10395.116415104801, 10453.895461045293, 10503.789924201626, 10517.84223236652, 10555.10281626055, 13456.596302110953, 13545.59363219105, 13551.728965420636, 13598.524051658145, 13609.659758505919, 7195.928040719526, 7394.2975417335265, 7401.925980740231, 7511.136219334847, 7544.735934242385, 7151.856962860714, 7153.0, 7290.307420795016, 7290.744823931243, 7300.233475485104, 4466.642668586505, 4488.4165058542185, 4491.76807444519, 4566.634669226454, 4615.353850460938, 1668.8247733987998, 1703.872209584286, 1718.484454663596, 1732.8093909669926, 1756.8682348823888, 893.620211410148, 902.3007169443733, 909.2998391238841, 960.7550074731039, 979.8236317462926, 15865.365385384686, 15928.283227254802, 16519.83480165207, 16792.496225113267, 16799.916000420166, 837.8324335132997, 843.1863251961886, 858.7552547524051, 865.8441480533564, 953.0564740906591, 9131.812864327727, 9217.815643687089, 9477.573509192103, 9578.329516933747, 9664.37181583209, 364683.0, 392439.0, 424280.0, 426705.0, 428092.0, 67357.0, 68363.0, 68504.3149568508, 68745.31254687489, 69647.0, 918.169057003413, 927.5733162745078, 928.1229238369676, 943.9292053096045, 944.9291303152291, 14202.857971420153, 14509.492167774077, 14592.708145836812, 14627.268636567916, 14784.704305913607, 31601.683983159874, 32276.515852262706, 33084.834575826964, 33392.49911251382, 33445.33109337848, 41819.0, 44227.778861105486, 44874.0, 45369.0, 46338.7683061596, 7430.919342584085, 7514.699412023458, 7661.846763064596, 7729.884051739341, 7740.187280335709, 9119.863202051842, 11284.3325919075, 11326.433678316216, 11339.319640821577, 11558.340325599613, 9848.60605575769, 9903.306768526421, 10039.196864250696, 10263.640772572924, 10557.577696892346, 9988.60045598168, 10071.69784906454, 10074.0, 10111.3427627204, 10123.291369604058, 9922.305438619227, 10238.385696858213, 10243.846342304721, 10522.894771052192, 10555.788884222426, 7356.742514011984, 7431.29402706742, 7448.776536703907, 7502.924970750222, 7701.229877012254, 7847.686092556234, 9918.603255869684, 9969.40183588987, 10125.392476451436, 10463.372197667859], "unit": "score", "name": "jquery.html", "value": 7965.532828800779}, {"lowerIsBetter": false, "replicates": [1154.4285578638576, 1413.8798202152816, 1424.933845923411, 1549.9612509687256, 1743.1807050686182, 7182.209956904736, 7340.5595664260045, 7348.63256837158, 7368.189499155089, 7374.74188403406, 7107.253738357475, 7295.781126566211, 7300.0509933708545, 7307.89038164428, 7317.487775855692, 1893.640208360414, 2246.4608493961496, 2249.089118906837, 2279.179495381661, 2321.210788331967, 2248.4716091718433, 2256.8533045352, 2257.3679369776487, 2261.231181398324, 2261.2989973108306, 2204.515006698524, 2269.251147121446, 2270.6366981283, 2272.0230300970575, 2272.2842304673973, 2252.560750653623, 2254.3687767425067, 2261.4911644879853, 2296.4832912594698, 2298.184144628666, 2253.549290141978, 2264.501809601885, 2277.146070223666, 2277.271273192579, 2303.5392921415782, 7526.9247307526775, 7550.320471157622, 7590.127135379446, 7594.544327340322, 7599.202083781179, 4550.863474095782, 4649.325847752091, 4653.232216684243, 4664.090502352043, 4682.204025315705, 2993.4611769881412, 3011.2170835582906, 3058.740007099399, 3066.9079927602206, 3162.968370316313, 1002.4987506246877, 1013.0, 1025.8974102589757, 1042.2443728297, 1042.9217808664305, 9564.282678799049, 9647.083527064917, 9680.177184939288, 9716.75708107296, 9720.270979676552, 4197.055662475918, 4281.2293787118, 4364.039911219526, 4387.890302742393, 4389.561043895649, 8334.749957501284, 8380.57530219864, 8389.622466989, 8407.11725268838, 8430.0, 4108.630223279919, 4569.383133277031, 4628.213203755369, 4633.166030114612, 4634.142683603544, 4171.728837625545, 4215.936760948527, 4223.113146239324, 4246.193223287565, 4264.786760661955, 3521.7534772566187, 3613.8735144269826, 3630.3828349180703, 3645.7786641474872, 3660.8718694846084, 1214.4595654933469, 1238.294172321786, 1245.894099001577, 1248.7814632439288, 1257.0823298991788, 977.8728765260471, 1009.7223263602568, 1154.4343271796927, 1183.627157445402, 1184.2598376014992, 6971.268016858156, 6997.930020699728, 7033.577985320897, 7054.012438258545, 7061.89407158893, 1044.3420644993605, 1058.158763782779, 1060.6234786650782, 1068.9694715481542, 1096.983545246822, 5526.364468086141, 5530.557555395559, 5579.38626751057, 5583.106702927512, 5635.605507614428, 8578.270846978077, 9072.364934454657, 9094.226990705733, 9104.0, 9109.81780364389, 8965.731028069169, 8969.910300896907, 8976.326775491734, 8992.100789920956, 9026.413283136575, 6963.895541566881, 7273.781786546412, 7292.234315396807, 7319.853602927911, 7348.559086454937, 6852.246252912275, 6921.965390173017, 6932.792016239521, 6938.895916561357, 6954.235034146139, 7788.532688038736, 7819.84360312802, 7953.960230198812, 7955.045394552691, 8074.717384891501, 8042.075161356285, 8064.798380040546, 8114.188581141839, 8162.551059691774, 8197.46716463428, 5616.522595579258, 5705.172749951317, 5713.657180569179, 6429.7749578764515, 6654.667266636746, 6363.5227357947415, 6927.965360173167, 7132.857342853217, 7135.464840137114, 7140.107486564179, 6068.059450785136, 6233.470155036691, 6278.937210627835, 6296.401841825203, 6400.679966001774, 6235.906461403173, 6408.102865598913, 6462.127612772216, 6492.740290388331, 6624.536282460182, 6759.628220447923, 6804.251532331341, 6807.863842723217, 6809.012693159563, 6919.37725604698, 6236.968815155895, 6271.153394291712, 6319.9052014218905, 6325.841853953688, 6339.429451349401, 6214.5028397727165, 6226.844328891814, 6268.874622507433, 6271.529635277281, 6276.246850377984], "unit": "score", "name": "mootools.html", "value": 4327.846090853921}, {"lowerIsBetter": false, "replicates": [323.7490944517998, 324.1135494422753, 324.55211807705365, 330.30635665103284, 332.48132912656274, 5373.462653734625, 5387.4073851876265, 5397.109476936305, 5398.001369746599, 5406.08096623574, 5344.652597581155, 5352.116900711388, 5355.544778693806, 5356.678599284046, 5364.70494122824, 3990.7006974476885, 4078.9190864420952, 4147.502299724038, 4182.6235638792505, 4212.799352184628, 4162.562930892258, 4169.353750168729, 4187.1625674865, 4189.0, 4199.6430303424095, 4138.234426631067, 4178.874633760992, 4186.079062606222, 4186.602272784081, 4194.748315101088, 3951.3480275754464, 4063.1061166543163, 4180.581941805825, 4182.811773470201, 4186.455760751113, 3704.8888533344043, 3715.238376132886, 3718.2749363874054, 3720.9813950930343, 3725.3853114236117, 5175.7670904809, 5199.48005199477, 5202.245674377232, 5203.895922081575, 5207.6615020023955, 4832.299316599074, 4863.465018847924, 4878.170710979142, 4883.731394773286, 4885.7312847793355, 5658.91511627326, 5671.06427439472, 5680.358633235524, 5681.517071048966, 5688.175214593861, 3985.9835741885922, 4106.630403263721, 4109.0959988802715, 4112.115895082572, 4112.773797441139, 5917.171595976567, 5963.582549221556, 5969.5821292509545, 5970.104484327342, 5970.31341395745, 4210.45264115663, 4220.662347012231, 4221.6200541951375, 4222.894427639334, 4227.239096962515, 4276.08064266178, 4289.335153051282, 4290.970167159921, 4292.527821939584, 4296.033392486665, 4838.637102217348, 4843.806247750121, 4849.80600775965, 4850.805967761321, 4855.271709243571, 5688.089905615082, 5695.943040569624, 5697.715114244271, 5700.116481945305, 5701.71491425427, 1387.438087574534, 1487.605784467117, 1514.6970605878869, 1514.9166795826116, 1515.454436402894, 924.7965447601517, 961.6682244625733, 973.1533565797802, 983.3116818227127, 994.0705440413237, 4850.563449289511, 4896.436909755424, 4898.485659005753, 4938.530839570235, 4968.1554135797005, 5841.211436456024, 5899.941000589939, 5901.380355062656, 5902.911456328158, 5905.586608937419, 4975.228839529878, 4978.128827455181, 4979.551840334388, 4983.725895075733, 4988.775505102279, 3094.0, 3133.263683034485, 3137.0588823352905, 3138.6704396038085, 3138.9686103138674, 5484.095124304525, 5517.393086760453, 5531.170324451284, 5539.362973258127, 5546.223528705985, 5918.556108291896, 6103.816885493442, 6115.205023347025, 6115.724792384353, 6122.326544080237, 5579.19101730255, 5585.385607583163, 5613.915791263134, 5623.522000629992, 5624.578156638268, 5929.080992446177, 5936.406359364029, 5937.554683398676, 5994.760209591567, 6000.21997140369, 5769.365369809401, 5833.620814647034, 5834.445727655866, 5836.037053886062, 5837.503812176013, 5374.408815030265, 5626.099824028136, 5627.7467513961155, 5636.4927156556105, 5638.689872057076, 3991.3613821788376, 4032.153247817991, 4065.735727177724, 4072.6334629883454, 4100.2414553307735, 5893.0, 5900.0, 5910.822675319747, 5911.349751527243, 5912.674802885883, 5613.663180209201, 5623.2127502148915, 5687.971560142173, 5693.715314234355, 5694.4590263924865, 5651.039323314964, 5651.858703532444, 5652.802151924663, 5654.321481422256, 5668.943310566841, 5359.571234301168, 5537.418571050143, 5559.138333558305, 5574.219609254626, 5582.385937546947, 5670.376258611467, 5697.886042279214, 5699.401562835843, 5708.571857110816, 5717.456841600041, 5561.749721262472, 5564.221009058654, 5573.693446860461, 5576.470235327637, 5578.246936663499], "unit": "score", "name": "prototype.html", "value": 4288.027312474248}, {"lowerIsBetter": false, "replicates": [689.6103701408704, 767.6392095715012, 781.9296263336298, 794.1581923161449, 804.3846457460044, 11911.523539058438, 12058.758824823499, 12102.092343074282, 12107.394630268473, 12141.150119491627, 12005.339706316148, 12030.69923251917, 12077.335746533938, 12094.576689815858, 12101.576444824412, 777.3237283563308, 797.6011994002998, 820.1716266570747, 832.134580036761, 835.106436113359, 821.4126899267023, 822.005373498068, 823.1110400767157, 823.2508417340222, 826.8759686047111, 862.2067697718114, 865.3985480091308, 865.5931712095337, 865.8268346330759, 866.0170706248422, 847.7414388611471, 848.2662496940164, 851.7615067780969, 852.2798235491, 853.9743807685779, 620.4199073865905, 623.7068577768487, 625.1029772276797, 626.3141859663707, 626.7117126121989, 13021.86978130216, 13123.278219697913, 13186.538471153464, 13187.406566704522, 13222.272774997371, 12290.815637765441, 12420.130590858644, 12558.372081395984, 12601.117921745481, 12613.369331533386, 9984.800303993952, 10020.248481363855, 10152.137068349199, 10157.085862272357, 10193.847092293621, 3240.951385729216, 3274.476083826576, 3302.1579497228054, 3407.0289967359186, 3414.4195486767308, 39226.21547569061, 43186.35220471695, 44454.0, 44942.32586511172, 44991.32513012308, 9914.40513569188, 9929.900700992897, 9946.403215807075, 9989.400635961865, 10021.448820314952, 15869.603259918595, 15881.920590396974, 16009.199540022952, 16031.278592463366, 16057.839421605635, 7017.157941047005, 7115.501914866013, 7184.604846733375, 7217.458690598226, 7338.376238019828, 3774.584795672474, 3863.208042351311, 3883.805809709503, 3928.253631809947, 4002.9799851000557, 2854.2293580733085, 2884.769218462518, 2896.8551572421716, 2900.6664233612983, 2902.3179552805072, 504.2134270537899, 504.5811976059862, 517.1544524702064, 519.8804275016768, 523.8454655876526, 459.92411252143023, 466.96030837379203, 496.71438922618916, 542.9511343979061, 579.1573260905373, 7641.197674244125, 7947.602619868983, 7994.960025199837, 8021.719239826578, 8533.189347012023, 559.8208573256519, 577.2639884147745, 585.359031860121, 590.9852253693692, 611.400827189357, 3581.158427769472, 3624.5348530210395, 3653.725970552219, 3672.192117734094, 3700.5189325388064, 48077.0, 48134.518654813706, 48152.5184748155, 48239.51760482421, 50277.49722502801, 45250.54749452529, 45574.54425455703, 45708.08583828305, 45908.54091459043, 46049.76975115103, 36051.819740901126, 38594.80702596469, 40588.39117413241, 40786.59213407887, 40922.59077409188, 8096.109427963037, 8125.692275453247, 8279.710210142857, 8299.204233497516, 8448.915510844812, 32351.838240808644, 32476.188095297806, 33540.66459335375, 33934.151646209044, 34205.315893682484, 37688.43467348047, 37758.244835103695, 39354.2129157421, 39917.40123898202, 40277.79861100676, 9786.75533111678, 9796.16732577739, 9862.753431163992, 10044.949775251076, 10099.596016159272, 10922.617708380169, 11039.227254092137, 11255.774884502427, 11381.203315767816, 11457.828132578185, 10336.586536538454, 10341.327813692085, 10343.172546196136, 10446.440994653116, 10650.946745266225, 10188.847167292644, 10616.0, 10782.137429005817, 10906.34561926287, 10912.94543527309, 9524.14282714559, 10591.258611897401, 10637.308574942605, 10893.801681815152, 10896.836547451636, 8651.91348086511, 8661.696840610548, 8794.42836215644, 8960.0, 9067.05320770739, 8929.687460938836, 9050.841020618185, 9344.0, 9509.429434233969, 9544.284178686765], "unit": "score", "name": "yui.html", "value": 5872.5830368499655}], "name": "dromaeo_css", "value": 6357.964706107117}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 107.0, 112.0, 112.0, 112.0, 102.0, 113.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [157.0, 132.0, 156.0, 170.0, 130.0, 153.0, 151.0, 131.0, 169.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 162.0, 162.0, 160.0, 164.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 104.0, 97.0, 76.0, 74.0, 73.0, 114.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 84.9}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 138.0, 93.0, 94.0, 93.0, 140.0, 93.0, 92.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 63.0, 62.0, 64.0, 64.0, 74.0, 61.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 64.0}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 65.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.8}, {"lowerIsBetter": true, "replicates": [89.0, 83.0, 91.0, 82.0, 82.0, 81.0, 83.0, 82.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [130.0, 115.0, 117.0, 112.0, 124.0, 118.0, 125.0, 119.0, 115.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [140.0, 128.0, 141.0, 140.0, 139.0, 130.0, 139.0, 140.0, 147.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.5}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 65.0, 64.0, 66.0, 64.0, 66.0, 68.0, 65.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1506.0}]} 22:32:41 INFO - Return code: 0 22:32:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:32:41 ERROR - # TBPL SUCCESS # 22:32:41 INFO - Running post-action listener: _resource_record_post_action 22:32:41 INFO - Running post-run listener: _resource_record_post_run 22:32:42 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 57344; Write bytes: 284332032; Read time: 72; Write time: 134996 22:32:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 618496; Read time: 0; Write time: 44 22:32:42 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 57344; Write bytes: 283115520; Read time: 72; Write time: 134952 22:32:42 INFO - Running post-run listener: _upload_blobber_files 22:32:42 INFO - Blob upload gear active. 22:32:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:32:42 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 22:32:42 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'] 22:32:42 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 22:32:42 INFO - (blobuploader) - INFO - Open directory for files ... 22:32:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:32:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:32:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:43 INFO - (blobuploader) - INFO - Done attempting. 22:32:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:32:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:32:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:32:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:32:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:32:44 INFO - (blobuploader) - INFO - Done attempting. 22:32:44 INFO - (blobuploader) - INFO - Iteration through files over. 22:32:44 INFO - Return code: 0 22:32:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:32:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:32:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3cd1a799dd33761986c7ac1e60a1296b4ad6f44f79305fabcbe91cffc6f2796647a102461bb7f82d2d6222e3a5776b1ddac3547bad95c276b10f37039460d432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/511424dec9db8425ae051c6d0303a81ee5dd6532cb4a6679d90cb1fcd9eae1b1d6b7d4bea7d732c5b600c8af0c943f859311a842a9e130a22393345661a76f47"} 22:32:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:32:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:32:44 INFO - Contents: 22:32:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3cd1a799dd33761986c7ac1e60a1296b4ad6f44f79305fabcbe91cffc6f2796647a102461bb7f82d2d6222e3a5776b1ddac3547bad95c276b10f37039460d432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/511424dec9db8425ae051c6d0303a81ee5dd6532cb4a6679d90cb1fcd9eae1b1d6b7d4bea7d732c5b600c8af0c943f859311a842a9e130a22393345661a76f47"} 22:32:44 INFO - Running post-run listener: copy_logs_to_upload_dir 22:32:44 INFO - Copying logs to upload dir... 22:32:44 INFO - mkdir: /builds/slave/test/build/upload/logs 22:32:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.969681 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-03-17 22:32:44.595566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 22:32:44.598666) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530 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/3cd1a799dd33761986c7ac1e60a1296b4ad6f44f79305fabcbe91cffc6f2796647a102461bb7f82d2d6222e3a5776b1ddac3547bad95c276b10f37039460d432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/511424dec9db8425ae051c6d0303a81ee5dd6532cb4a6679d90cb1fcd9eae1b1d6b7d4bea7d732c5b600c8af0c943f859311a842a9e130a22393345661a76f47"} build_url:https://queue.taskcluster.net/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011502 build_url: 'https://queue.taskcluster.net/v1/task/bEcDILjCTtScLBI5g1eClQ/artifacts/public/build/firefox-48.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/3cd1a799dd33761986c7ac1e60a1296b4ad6f44f79305fabcbe91cffc6f2796647a102461bb7f82d2d6222e3a5776b1ddac3547bad95c276b10f37039460d432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/511424dec9db8425ae051c6d0303a81ee5dd6532cb4a6679d90cb1fcd9eae1b1d6b7d4bea7d732c5b600c8af0c943f859311a842a9e130a22393345661a76f47"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-17 22:32:44.623190) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:32:44.623531) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1458277619.711754-1692512530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-17 22:32:44.708210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 22:32:44.708524) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-17 22:32:44.708819) ========= ========= Total master_lag: 0.31 =========