builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1459543816.06 results: success (0) buildid: 20160401131238 builduid: 079d8dcbb75541d3a56830bc40faf2a9 revision: fd4ef6fe328cfa2a77c9987b10a7e00b711cfaf6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.060330) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.060865) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.061267) ========= 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=6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.087077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.087371) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.124889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.125155) ========= 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=6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.173936) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.174249) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.174609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.174887) ========= 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=6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-01 13:50:16-- 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% 40.3M=0s 2016-04-01 13:50:16 (40.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156488 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.343478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.343782) ========= 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=6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022491 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.396569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.396982) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fd4ef6fe328cfa2a77c9987b10a7e00b711cfaf6 --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 fd4ef6fe328cfa2a77c9987b10a7e00b711cfaf6 --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=6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-01 13:50:17,076 truncating revision to first 12 chars 2016-04-01 13:50:17,076 Setting DEBUG logging. 2016-04-01 13:50:17,076 attempt 1/10 2016-04-01 13:50:17,076 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fd4ef6fe328c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 13:50:17,344 unpacking tar archive at: fx-team-fd4ef6fe328c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547640 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.957552) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:16.957893) ========= echo fd4ef6fe328cfa2a77c9987b10a7e00b711cfaf6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fd4ef6fe328cfa2a77c9987b10a7e00b711cfaf6'] 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=6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fd4ef6fe328cfa2a77c9987b10a7e00b711cfaf6 program finished with exit code 0 elapsedTime=0.004720 script_repo_revision: 'fd4ef6fe328cfa2a77c9987b10a7e00b711cfaf6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:17.012578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:17.012892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 13:50:17.026960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-01 13:50:17.027279) ========= /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=6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:50:17 INFO - MultiFileLogger online at 20160401 13:50:17 in /builds/slave/test 13:50:17 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 13:50:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:17 INFO - {'append_to_log': False, 13:50:17 INFO - 'base_work_dir': '/builds/slave/test', 13:50:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:50:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:17 INFO - 'branch': 'Fx-Team-Non-PGO', 13:50:17 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:17 INFO - 'config_files': ('talos/linux_config.py',), 13:50:17 INFO - 'default_actions': ('clobber', 13:50:17 INFO - 'read-buildbot-config', 13:50:17 INFO - 'download-and-extract', 13:50:17 INFO - 'populate-webroot', 13:50:17 INFO - 'create-virtualenv', 13:50:17 INFO - 'install', 13:50:17 INFO - 'run-tests'), 13:50:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:17 INFO - 'download_minidump_stackwalk': True, 13:50:17 INFO - 'download_symbols': 'ondemand', 13:50:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:17 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:17 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:17 INFO - 'installer_path': 'installer.exe', 13:50:17 INFO - 'log_level': 'info', 13:50:17 INFO - 'log_name': 'talos', 13:50:17 INFO - 'log_to_console': True, 13:50:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:50:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:50:17 INFO - 'opt_config_files': (), 13:50:17 INFO - 'pip_index': False, 13:50:17 INFO - 'sps_profile': False, 13:50:17 INFO - 'sps_profile_interval': 0, 13:50:17 INFO - 'suite': 'dromaeojs', 13:50:17 INFO - 'system_bits': '32', 13:50:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:17 INFO - 'title': 'talos-linux64-ix-023', 13:50:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:17 INFO - 'use_talos_json': True, 13:50:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:17 INFO - 'work_dir': 'build'} 13:50:17 INFO - ##### 13:50:17 INFO - ##### Running clobber step. 13:50:17 INFO - ##### 13:50:17 INFO - Running pre-action listener: _resource_record_pre_action 13:50:17 INFO - Running main action method: clobber 13:50:17 INFO - rmtree: /builds/slave/test/build 13:50:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:18 INFO - Running post-action listener: _resource_record_post_action 13:50:18 INFO - ##### 13:50:18 INFO - ##### Running read-buildbot-config step. 13:50:18 INFO - ##### 13:50:18 INFO - Running pre-action listener: _resource_record_pre_action 13:50:18 INFO - Running main action method: read_buildbot_config 13:50:18 INFO - Using buildbot properties: 13:50:18 INFO - { 13:50:18 INFO - "project": "", 13:50:18 INFO - "product": "firefox", 13:50:18 INFO - "script_repo_revision": "production", 13:50:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:50:18 INFO - "repository": "", 13:50:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:50:18 INFO - "buildid": "20160401131238", 13:50:18 INFO - "pgo_build": "False", 13:50:18 INFO - "basedir": "/builds/slave/test", 13:50:18 INFO - "buildnumber": 1593, 13:50:18 INFO - "slavename": "talos-linux64-ix-023", 13:50:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:50:18 INFO - "platform": "ubuntu64_hw", 13:50:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:50:18 INFO - "branch": "fx-team", 13:50:18 INFO - "repo_path": "integration/fx-team", 13:50:18 INFO - "revision": "fd4ef6fe328cfa2a77c9987b10a7e00b711cfaf6", 13:50:18 INFO - "stage_platform": "linux64", 13:50:18 INFO - "builduid": "079d8dcbb75541d3a56830bc40faf2a9", 13:50:18 INFO - "slavebuilddir": "test" 13:50:18 INFO - } 13:50:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 13:50:18 INFO - Running post-action listener: _resource_record_post_action 13:50:18 INFO - ##### 13:50:18 INFO - ##### Running download-and-extract step. 13:50:18 INFO - ##### 13:50:18 INFO - Running pre-action listener: _resource_record_pre_action 13:50:18 INFO - Running main action method: download_and_extract 13:50:18 INFO - mkdir: /builds/slave/test/build/tests 13:50:18 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')]} 13:50:18 INFO - https://queue.taskcluster.net/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:50:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:50:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:50:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/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 13:50:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/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 13:50:21 INFO - Downloaded 1361 bytes. 13:50:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 13:50:21 INFO - Using the following test package requirements: 13:50:21 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:50:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:50:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:50:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:50:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:50:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:50:21 INFO - u'jsshell-linux-x86_64.zip'], 13:50:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:50:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:50:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 13:50:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:50:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:50:21 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:50:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:50:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:50:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:50:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 13:50:21 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:50:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:21 INFO - https://queue.taskcluster.net/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/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 13:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/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 13:50:28 INFO - Downloaded 22112239 bytes. 13:50:28 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'] 13:50:28 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 13:50:29 INFO - Return code: 0 13:50:29 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 13:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:29 INFO - https://queue.taskcluster.net/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:50:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:50:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 13:50:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/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 13:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/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 13:50:38 INFO - Downloaded 22112239 bytes. 13:50:38 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'] 13:50:38 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 13:50:39 INFO - Return code: 0 13:50: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')]} 13:50:39 INFO - https://queue.taskcluster.net/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:50:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:50:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 13:50:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/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 13:50:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/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 13:50:41 INFO - Downloaded 10847534 bytes. 13:50:41 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'] 13:50:41 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 13:50:41 INFO - Return code: 0 13:50:41 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')]} 13:50:41 INFO - https://queue.taskcluster.net/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:50:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:50:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:50:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/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 13:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K6F7vQr7QYWYi9AGltRcIA/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 13:50:43 INFO - Downloaded 54226386 bytes. 13:50:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:50:43 INFO - mkdir: /builds/slave/test/properties 13:50:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:50:43 INFO - Writing to file /builds/slave/test/properties/build_url 13:50:43 INFO - Contents: 13:50:43 INFO - build_url:https://queue.taskcluster.net/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 13:50:44 INFO - Running post-action listener: _resource_record_post_action 13:50:44 INFO - Running post-action listener: set_extra_try_arguments 13:50:44 INFO - ##### 13:50:44 INFO - ##### Running populate-webroot step. 13:50:44 INFO - ##### 13:50:44 INFO - Running pre-action listener: _resource_record_pre_action 13:50:44 INFO - Running main action method: populate_webroot 13:50:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:50:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:50:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:50:44 INFO - '--tppagecycles', 13:50:44 INFO - '7'], 13:50:44 INFO - 'tests': ['tsvgm']}}, 13:50:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:50:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:50:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:50:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 13:50:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:50:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:50:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:50:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'talos_options': ['--e10s'], 13:50:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:50:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'tests': ['damp', 'tps']}, 13:50:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'talos_options': ['--e10s'], 13:50:44 INFO - 'tests': ['damp', 'tps']}, 13:50:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:50:44 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 13:50:44 INFO - 'tests': ['dromaeo_dom']}, 13:50:44 INFO - 'other': {'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:50:44 INFO - 'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:50:44 INFO - 'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:50:44 INFO - 'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'other_l64': {'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'other_nol64': {'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'svgr': {'tests': ['tsvgx', 13:50:44 INFO - 'tsvgr_opacity', 13:50:44 INFO - 'tart', 13:50:44 INFO - 'tscrollx', 13:50:44 INFO - 'cart']}, 13:50:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:50:44 INFO - 'tests': ['tsvgx', 13:50:44 INFO - 'tsvgr_opacity', 13:50:44 INFO - 'tart', 13:50:44 INFO - 'tscrollx', 13:50:44 INFO - 'cart']}, 13:50:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'tests': ['tp5o']}, 13:50:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'talos_options': ['--e10s'], 13:50:44 INFO - 'tests': ['tp5o']}, 13:50:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'talos_options': ['--xperf_path', 13:50:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:50:44 INFO - 'tests': ['tp5n']}, 13:50:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'talos_options': ['--e10s', 13:50:44 INFO - '--xperf_path', 13:50:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:50:44 INFO - 'tests': ['tp5n']}}, 13:50:44 INFO - 'talos.zip': {'path': '', 13:50:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:50:44 INFO - Running post-action listener: _resource_record_post_action 13:50:44 INFO - ##### 13:50:44 INFO - ##### Running create-virtualenv step. 13:50:44 INFO - ##### 13:50:44 INFO - Running pre-action listener: _resource_record_pre_action 13:50:44 INFO - Running main action method: create_virtualenv 13:50:44 INFO - Creating virtualenv /builds/slave/test/build/venv 13:50:44 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 13:50:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:50:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:50:44 INFO - Using real prefix '/usr' 13:50:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:50:44 INFO - Installing distribute.............................................................................................................................................................................................done. 13:50:46 INFO - Installing pip.................done. 13:50:46 INFO - Return code: 0 13:50:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:50:46 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')]} 13:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:46 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')]} 13:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:46 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 0x7f8c12babf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab410>, '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 0xdac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', '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 13:50:46 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 13:50:46 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 13:50:46 INFO - Using env: {'DISPLAY': ':0', 13:50:46 INFO - 'HOME': '/home/cltbld', 13:50:46 INFO - 'LANG': 'en_US.UTF-8', 13:50:46 INFO - 'LANGUAGE': 'en_US:en', 13:50:46 INFO - 'LOGNAME': 'cltbld', 13:50:46 INFO - 'MAIL': '/var/mail/cltbld', 13:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:46 INFO - 'MOZ_NO_REMOTE': '1', 13:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:46 INFO - 'NO_EM_RESTART': '1', 13:50:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:46 INFO - 'PWD': '/builds/slave/test', 13:50:46 INFO - 'SHELL': '/bin/bash', 13:50:46 INFO - 'SHLVL': '1', 13:50:46 INFO - 'TERM': 'linux', 13:50:46 INFO - 'TMOUT': '86400', 13:50:46 INFO - 'USER': 'cltbld', 13:50:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', 13:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:46 INFO - '_': '/tools/buildbot/bin/python'} 13:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:46 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 13:50:46 INFO - Cleaning up... 13:50:46 INFO - Return code: 0 13:50:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:50:46 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')]} 13:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:46 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')]} 13:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:46 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 0x7f8c12babf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab410>, '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 0xdac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', '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 13:50:46 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 13:50:46 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 13:50:46 INFO - Using env: {'DISPLAY': ':0', 13:50:46 INFO - 'HOME': '/home/cltbld', 13:50:46 INFO - 'LANG': 'en_US.UTF-8', 13:50:46 INFO - 'LANGUAGE': 'en_US:en', 13:50:46 INFO - 'LOGNAME': 'cltbld', 13:50:46 INFO - 'MAIL': '/var/mail/cltbld', 13:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:46 INFO - 'MOZ_NO_REMOTE': '1', 13:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:46 INFO - 'NO_EM_RESTART': '1', 13:50:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:46 INFO - 'PWD': '/builds/slave/test', 13:50:46 INFO - 'SHELL': '/bin/bash', 13:50:46 INFO - 'SHLVL': '1', 13:50:46 INFO - 'TERM': 'linux', 13:50:46 INFO - 'TMOUT': '86400', 13:50:46 INFO - 'USER': 'cltbld', 13:50:46 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', 13:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:46 INFO - '_': '/tools/buildbot/bin/python'} 13:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:47 INFO - Downloading/unpacking psutil>=0.7.1 13:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:50:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:50:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:50:49 INFO - Installing collected packages: psutil 13:50:49 INFO - Running setup.py install for psutil 13:50:49 INFO - building 'psutil._psutil_linux' extension 13:50:49 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 13:50:49 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 13:50:49 INFO - building 'psutil._psutil_posix' extension 13:50:49 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 13:50:49 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 13:50:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:50:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:50:49 INFO - Successfully installed psutil 13:50:49 INFO - Cleaning up... 13:50:49 INFO - Return code: 0 13:50:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:49 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 0x7f8c12babf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab410>, '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 0xdac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', '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 13:50:49 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 13:50:49 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 13:50:49 INFO - Using env: {'DISPLAY': ':0', 13:50:49 INFO - 'HOME': '/home/cltbld', 13:50:49 INFO - 'LANG': 'en_US.UTF-8', 13:50:49 INFO - 'LANGUAGE': 'en_US:en', 13:50:49 INFO - 'LOGNAME': 'cltbld', 13:50:49 INFO - 'MAIL': '/var/mail/cltbld', 13:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:49 INFO - 'MOZ_NO_REMOTE': '1', 13:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:49 INFO - 'NO_EM_RESTART': '1', 13:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:49 INFO - 'PWD': '/builds/slave/test', 13:50:49 INFO - 'SHELL': '/bin/bash', 13:50:49 INFO - 'SHLVL': '1', 13:50:49 INFO - 'TERM': 'linux', 13:50:49 INFO - 'TMOUT': '86400', 13:50:49 INFO - 'USER': 'cltbld', 13:50:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', 13:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:49 INFO - '_': '/tools/buildbot/bin/python'} 13:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:50:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:50:51 INFO - Installing collected packages: mozsystemmonitor 13:50:51 INFO - Running setup.py install for mozsystemmonitor 13:50:51 INFO - Successfully installed mozsystemmonitor 13:50:51 INFO - Cleaning up... 13:50:51 INFO - Return code: 0 13:50:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:50:51 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')]} 13:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:51 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')]} 13:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:51 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 0x7f8c12babf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab410>, '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 0xdac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', '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 13:50:51 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 13:50:51 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 13:50:51 INFO - Using env: {'DISPLAY': ':0', 13:50:51 INFO - 'HOME': '/home/cltbld', 13:50:51 INFO - 'LANG': 'en_US.UTF-8', 13:50:51 INFO - 'LANGUAGE': 'en_US:en', 13:50:51 INFO - 'LOGNAME': 'cltbld', 13:50:51 INFO - 'MAIL': '/var/mail/cltbld', 13:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:51 INFO - 'MOZ_NO_REMOTE': '1', 13:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:51 INFO - 'NO_EM_RESTART': '1', 13:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:51 INFO - 'PWD': '/builds/slave/test', 13:50:51 INFO - 'SHELL': '/bin/bash', 13:50:51 INFO - 'SHLVL': '1', 13:50:51 INFO - 'TERM': 'linux', 13:50:51 INFO - 'TMOUT': '86400', 13:50:51 INFO - 'USER': 'cltbld', 13:50:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', 13:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:51 INFO - '_': '/tools/buildbot/bin/python'} 13:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:50:52 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 13:50:52 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 13:50:52 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 13:50:52 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 13:50:52 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 13:50:52 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 13:50:53 INFO - Downloading blobuploader-1.2.4.tar.gz 13:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:50:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:50:54 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 13:50:54 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 13:50:54 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 13:50:54 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 13:50:54 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 13:50:54 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 13:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:50:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:50:54 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 13:50:54 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 13:50:54 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 13:50:54 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 13:50:54 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 13:50:54 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 13:50:54 INFO - Downloading docopt-0.6.1.tar.gz 13:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:50:54 INFO - Installing collected packages: blobuploader, requests, docopt 13:50:54 INFO - Running setup.py install for blobuploader 13:50:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:50:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:50:54 INFO - Running setup.py install for requests 13:50:55 INFO - Running setup.py install for docopt 13:50:55 INFO - Successfully installed blobuploader requests docopt 13:50:55 INFO - Cleaning up... 13:50:55 INFO - Return code: 0 13:50:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:55 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 0x7f8c12babf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab410>, '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 0xdac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', '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 13:50:55 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 13:50:55 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 13:50:55 INFO - Using env: {'DISPLAY': ':0', 13:50:55 INFO - 'HOME': '/home/cltbld', 13:50:55 INFO - 'LANG': 'en_US.UTF-8', 13:50:55 INFO - 'LANGUAGE': 'en_US:en', 13:50:55 INFO - 'LOGNAME': 'cltbld', 13:50:55 INFO - 'MAIL': '/var/mail/cltbld', 13:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:55 INFO - 'MOZ_NO_REMOTE': '1', 13:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:55 INFO - 'NO_EM_RESTART': '1', 13:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:55 INFO - 'PWD': '/builds/slave/test', 13:50:55 INFO - 'SHELL': '/bin/bash', 13:50:55 INFO - 'SHLVL': '1', 13:50:55 INFO - 'TERM': 'linux', 13:50:55 INFO - 'TMOUT': '86400', 13:50:55 INFO - 'USER': 'cltbld', 13:50:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', 13:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:55 INFO - '_': '/tools/buildbot/bin/python'} 13:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:50:55 INFO - Running setup.py (path:/tmp/pip-WUyu2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:50:55 INFO - Running setup.py (path:/tmp/pip-4TAoMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:50:55 INFO - Running setup.py (path:/tmp/pip-Pjikax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:50:55 INFO - Running setup.py (path:/tmp/pip-f9Yh30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:50:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:50:55 INFO - Running setup.py (path:/tmp/pip-PLlmib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:50:56 INFO - Running setup.py (path:/tmp/pip-f1WX6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:50:56 INFO - Running setup.py (path:/tmp/pip-CAxgJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:50:56 INFO - Running setup.py (path:/tmp/pip-Qx9tTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:50:56 INFO - Running setup.py (path:/tmp/pip-tVfF8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:50:56 INFO - Running setup.py (path:/tmp/pip-HE8wfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:56 INFO - Running setup.py (path:/tmp/pip-JD9guh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:56 INFO - Running setup.py (path:/tmp/pip-b9WpH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:56 INFO - Running setup.py (path:/tmp/pip-ys4ad7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:56 INFO - Running setup.py (path:/tmp/pip-zcpe92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:56 INFO - Running setup.py (path:/tmp/pip-l6D5IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:50:56 INFO - Running setup.py (path:/tmp/pip-F4NHyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:50:56 INFO - Running setup.py (path:/tmp/pip-lR7g04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:50:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:50:56 INFO - Running setup.py install for manifestparser 13:50:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:50:57 INFO - Running setup.py install for mozcrash 13:50:57 INFO - Running setup.py install for mozdebug 13:50:57 INFO - Running setup.py install for mozdevice 13:50:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:50:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:50:57 INFO - Running setup.py install for mozfile 13:50:57 INFO - Running setup.py install for mozhttpd 13:50:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:50:57 INFO - Running setup.py install for mozinfo 13:50:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:50:57 INFO - Running setup.py install for mozInstall 13:50:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:50:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:50:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:50:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:50:57 INFO - Running setup.py install for mozleak 13:50:57 INFO - Running setup.py install for mozlog 13:50:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:50:58 INFO - Running setup.py install for moznetwork 13:50:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:50:58 INFO - Running setup.py install for mozprocess 13:50:58 INFO - Running setup.py install for mozprofile 13:50:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:50:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:50:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:50:58 INFO - Running setup.py install for mozrunner 13:50:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:50:58 INFO - Running setup.py install for mozscreenshot 13:50:58 INFO - Running setup.py install for moztest 13:50:58 INFO - Running setup.py install for mozversion 13:50:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:50:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:50:58 INFO - Cleaning up... 13:50:58 INFO - Return code: 0 13:50:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:58 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 0x7f8c12babf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab410>, '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 0xdac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', '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 13:50:58 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 13:50:58 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 13:50:58 INFO - Using env: {'DISPLAY': ':0', 13:50:58 INFO - 'HOME': '/home/cltbld', 13:50:58 INFO - 'LANG': 'en_US.UTF-8', 13:50:58 INFO - 'LANGUAGE': 'en_US:en', 13:50:58 INFO - 'LOGNAME': 'cltbld', 13:50:58 INFO - 'MAIL': '/var/mail/cltbld', 13:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:58 INFO - 'MOZ_NO_REMOTE': '1', 13:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:50:58 INFO - 'NO_EM_RESTART': '1', 13:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:58 INFO - 'PWD': '/builds/slave/test', 13:50:58 INFO - 'SHELL': '/bin/bash', 13:50:58 INFO - 'SHLVL': '1', 13:50:58 INFO - 'TERM': 'linux', 13:50:58 INFO - 'TMOUT': '86400', 13:50:58 INFO - 'USER': 'cltbld', 13:50:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', 13:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:58 INFO - '_': '/tools/buildbot/bin/python'} 13:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:50:59 INFO - Running setup.py (path:/tmp/pip-hZxaDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:50:59 INFO - Running setup.py (path:/tmp/pip-Q_buP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:50:59 INFO - Running setup.py (path:/tmp/pip-O9PUAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:50:59 INFO - Running setup.py (path:/tmp/pip-co8R2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:50:59 INFO - Running setup.py (path:/tmp/pip-wrNq9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:50:59 INFO - Running setup.py (path:/tmp/pip-0tEuJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:50:59 INFO - Running setup.py (path:/tmp/pip-PbceBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:50:59 INFO - Running setup.py (path:/tmp/pip-QegEE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:50:59 INFO - Running setup.py (path:/tmp/pip-0Q8Qij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:50:59 INFO - Running setup.py (path:/tmp/pip-BIu8S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:59 INFO - Running setup.py (path:/tmp/pip-lKl_lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:59 INFO - Running setup.py (path:/tmp/pip-zqTk53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:59 INFO - Running setup.py (path:/tmp/pip-zhCuqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:59 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)) 13:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:59 INFO - Running setup.py (path:/tmp/pip-jIevgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:00 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)) 13:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:00 INFO - Running setup.py (path:/tmp/pip-8Elhdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:00 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)) 13:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:00 INFO - Running setup.py (path:/tmp/pip-W40f1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:00 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)) 13:51:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:00 INFO - Running setup.py (path:/tmp/pip-kpwaOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:00 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)) 13:51:00 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)) 13:51:00 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)) 13:51:00 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)) 13:51:00 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)) 13:51:00 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)) 13:51:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:02 INFO - Downloading blessings-1.6.tar.gz 13:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:02 INFO - Installing collected packages: blessings 13:51:02 INFO - Running setup.py install for blessings 13:51:02 INFO - Successfully installed blessings 13:51:02 INFO - Cleaning up... 13:51:02 INFO - Return code: 0 13:51:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:02 INFO - Reading from file tmpfile_stdout 13:51:02 INFO - Current package versions: 13:51:02 INFO - argparse == 1.2.1 13:51:02 INFO - blessings == 1.6 13:51:02 INFO - blobuploader == 1.2.4 13:51:02 INFO - docopt == 0.6.1 13:51:02 INFO - manifestparser == 1.1 13:51:02 INFO - mozInstall == 1.12 13:51:02 INFO - mozcrash == 0.17 13:51:02 INFO - mozdebug == 0.1 13:51:02 INFO - mozdevice == 0.48 13:51:02 INFO - mozfile == 1.2 13:51:02 INFO - mozhttpd == 0.7 13:51:02 INFO - mozinfo == 0.9 13:51:02 INFO - mozleak == 0.1 13:51:02 INFO - mozlog == 3.1 13:51:02 INFO - moznetwork == 0.27 13:51:02 INFO - mozprocess == 0.22 13:51:02 INFO - mozprofile == 0.28 13:51:02 INFO - mozrunner == 6.11 13:51:02 INFO - mozscreenshot == 0.1 13:51:02 INFO - mozsystemmonitor == 0.0 13:51:02 INFO - moztest == 0.7 13:51:02 INFO - mozversion == 1.4 13:51:02 INFO - psutil == 3.1.1 13:51:02 INFO - requests == 1.2.3 13:51:02 INFO - wsgiref == 0.1.2 13:51:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:02 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')]} 13:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:02 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')]} 13:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:02 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 0x7f8c12babf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab410>, '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 0xdac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', '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 13:51:02 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 13:51:02 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 13:51:02 INFO - Using env: {'DISPLAY': ':0', 13:51:02 INFO - 'HOME': '/home/cltbld', 13:51:02 INFO - 'LANG': 'en_US.UTF-8', 13:51:02 INFO - 'LANGUAGE': 'en_US:en', 13:51:02 INFO - 'LOGNAME': 'cltbld', 13:51:02 INFO - 'MAIL': '/var/mail/cltbld', 13:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:02 INFO - 'MOZ_NO_REMOTE': '1', 13:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:02 INFO - 'NO_EM_RESTART': '1', 13:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:02 INFO - 'PWD': '/builds/slave/test', 13:51:02 INFO - 'SHELL': '/bin/bash', 13:51:02 INFO - 'SHLVL': '1', 13:51:02 INFO - 'TERM': 'linux', 13:51:02 INFO - 'TMOUT': '86400', 13:51:02 INFO - 'USER': 'cltbld', 13:51:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', 13:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:02 INFO - '_': '/tools/buildbot/bin/python'} 13:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:02 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)) 13:51:02 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)) 13:51:02 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)) 13:51:02 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)) 13:51:02 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)) 13:51:02 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)) 13:51:02 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)) 13:51:02 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)) 13:51:02 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)) 13:51:02 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)) 13:51:02 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)) 13:51:02 INFO - Cleaning up... 13:51:02 INFO - Return code: 0 13:51:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:02 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')]} 13:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:02 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')]} 13:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:02 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 0x7f8c12babf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab410>, '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 0xdac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', '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 13:51:02 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 13:51:02 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 13:51:02 INFO - Using env: {'DISPLAY': ':0', 13:51:02 INFO - 'HOME': '/home/cltbld', 13:51:02 INFO - 'LANG': 'en_US.UTF-8', 13:51:02 INFO - 'LANGUAGE': 'en_US:en', 13:51:02 INFO - 'LOGNAME': 'cltbld', 13:51:02 INFO - 'MAIL': '/var/mail/cltbld', 13:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:02 INFO - 'MOZ_NO_REMOTE': '1', 13:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:02 INFO - 'NO_EM_RESTART': '1', 13:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:02 INFO - 'PWD': '/builds/slave/test', 13:51:02 INFO - 'SHELL': '/bin/bash', 13:51:02 INFO - 'SHLVL': '1', 13:51:02 INFO - 'TERM': 'linux', 13:51:02 INFO - 'TMOUT': '86400', 13:51:02 INFO - 'USER': 'cltbld', 13:51:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', 13:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:02 INFO - '_': '/tools/buildbot/bin/python'} 13:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:02 INFO - Downloading/unpacking jsonschema 13:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:51:04 INFO - Downloading/unpacking functools32 (from jsonschema) 13:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:05 INFO - Downloading functools32-3.2.3-2.tar.gz 13:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:51:05 INFO - warning: no files found matching '*.txt' 13:51:05 INFO - no previously-included directories found matching 'build' 13:51:05 INFO - no previously-included directories found matching 'dist' 13:51:05 INFO - no previously-included directories found matching '.git*' 13:51:05 INFO - Installing collected packages: jsonschema, functools32 13:51:05 INFO - Running setup.py install for functools32 13:51:05 INFO - warning: no files found matching '*.txt' 13:51:05 INFO - no previously-included directories found matching 'build' 13:51:05 INFO - no previously-included directories found matching 'dist' 13:51:05 INFO - no previously-included directories found matching '.git*' 13:51:05 INFO - Successfully installed jsonschema functools32 13:51:05 INFO - Cleaning up... 13:51:05 INFO - Return code: 0 13:51:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:51:05 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')]} 13:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:05 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')]} 13:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:05 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 0x7f8c12babf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdab410>, '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 0xdac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdac7a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', '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 13:51:05 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 13:51:05 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 13:51:05 INFO - Using env: {'DISPLAY': ':0', 13:51:05 INFO - 'HOME': '/home/cltbld', 13:51:05 INFO - 'LANG': 'en_US.UTF-8', 13:51:05 INFO - 'LANGUAGE': 'en_US:en', 13:51:05 INFO - 'LOGNAME': 'cltbld', 13:51:05 INFO - 'MAIL': '/var/mail/cltbld', 13:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:05 INFO - 'MOZ_NO_REMOTE': '1', 13:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:05 INFO - 'NO_EM_RESTART': '1', 13:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:05 INFO - 'PWD': '/builds/slave/test', 13:51:05 INFO - 'SHELL': '/bin/bash', 13:51:05 INFO - 'SHLVL': '1', 13:51:05 INFO - 'TERM': 'linux', 13:51:05 INFO - 'TMOUT': '86400', 13:51:05 INFO - 'USER': 'cltbld', 13:51:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', 13:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:05 INFO - '_': '/tools/buildbot/bin/python'} 13:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:05 INFO - Downloading/unpacking flake8 13:51:05 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 13:51:05 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 13:51:05 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 13:51:05 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 13:51:05 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 13:51:05 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 13:51:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:51:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:51:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 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 13:51:07 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 13:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:51:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:51:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:51:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:51:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:51:08 INFO - no previously-included directories found matching 'docs/_build' 13:51:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:51:08 INFO - Running setup.py install for pep8 13:51:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:51:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:51:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:51:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:51:08 INFO - no previously-included directories found matching 'docs/_build' 13:51:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:51:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:51:08 INFO - Cleaning up... 13:51:08 INFO - Return code: 0 13:51:08 INFO - Running post-action listener: _resource_record_post_action 13:51:08 INFO - Running post-action listener: _start_resource_monitoring 13:51:08 INFO - Starting resource monitoring. 13:51:08 INFO - ##### 13:51:08 INFO - ##### Running install step. 13:51:08 INFO - ##### 13:51:08 INFO - Running pre-action listener: _resource_record_pre_action 13:51:08 INFO - Running main action method: install 13:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:08 INFO - Reading from file tmpfile_stdout 13:51:08 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:08 INFO - Reading from file tmpfile_stdout 13:51:08 INFO - Output received: 13:51:08 INFO - Usage: mozinstall [options] installer 13:51:08 INFO - Options: 13:51:08 INFO - -h, --help show this help message and exit 13:51:08 INFO - -d DEST, --destination=DEST 13:51:08 INFO - Directory to install application into. [default: 13:51:08 INFO - "/builds/slave/test"] 13:51:08 INFO - --app=APP Application being installed. [default: firefox] 13:51:08 INFO - mkdir: /builds/slave/test/build/application 13:51:08 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'] 13:51:08 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 13:51:24 INFO - Reading from file tmpfile_stdout 13:51:24 INFO - Output received: 13:51:24 INFO - /builds/slave/test/build/application/firefox/firefox 13:51:24 INFO - Running post-action listener: _resource_record_post_action 13:51:24 INFO - ##### 13:51:24 INFO - ##### Running run-tests step. 13:51:24 INFO - ##### 13:51:24 INFO - Running pre-action listener: _resource_record_pre_action 13:51:24 INFO - Running main action method: run_tests 13:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:51:24 INFO - Python 2.7.3 13:51:24 INFO - Return code: 0 13:51:24 INFO - grabbing minidump binary from tooltool 13:51:24 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')]} 13:51:24 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 0xdab410>, '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 0xdac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdac7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:51:24 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 13:51:24 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 13:51:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:51:24 INFO - Return code: 0 13:51:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:51:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:51:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:51:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:51:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:51:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:51:25 INFO - Return code: 0 13:51:25 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/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 13:51:25 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/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 13:51:25 INFO - Using env: {'DISPLAY': ':0', 13:51:25 INFO - 'HOME': '/home/cltbld', 13:51:25 INFO - 'LANG': 'en_US.UTF-8', 13:51:25 INFO - 'LANGUAGE': 'en_US:en', 13:51:25 INFO - 'LOGNAME': 'cltbld', 13:51:25 INFO - 'MAIL': '/var/mail/cltbld', 13:51:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:51:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:25 INFO - 'MOZ_NO_REMOTE': '1', 13:51:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:51:25 INFO - 'NO_EM_RESTART': '1', 13:51:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:25 INFO - 'PWD': '/builds/slave/test', 13:51:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:51:25 INFO - 'SHELL': '/bin/bash', 13:51:25 INFO - 'SHLVL': '1', 13:51:25 INFO - 'TERM': 'linux', 13:51:25 INFO - 'TMOUT': '86400', 13:51:25 INFO - 'USER': 'cltbld', 13:51:25 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242', 13:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:25 INFO - '_': '/tools/buildbot/bin/python'} 13:51:25 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/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 13:51:25 INFO - mozversion application_buildid: 20160401131238 13:51:25 INFO - mozversion application_changeset: fd4ef6fe328cfa2a77c9987b10a7e00b711cfaf6 13:51:25 INFO - mozversion application_display_name: Nightly 13:51:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:51:25 INFO - mozversion application_name: Firefox 13:51:25 INFO - mozversion application_remotingname: firefox 13:51:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:51:25 INFO - mozversion application_vendor: Mozilla 13:51:25 INFO - mozversion application_version: 48.0a1 13:51:25 INFO - mozversion platform_buildid: 20160401131238 13:51:25 INFO - mozversion platform_changeset: fd4ef6fe328cfa2a77c9987b10a7e00b711cfaf6 13:51:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:51:25 INFO - mozversion platform_version: 48.0a1 13:51:25 INFO - using testdate: 1459543885 13:51:25 INFO - actual date: 1459543885 13:51:25 INFO - starting webserver on 'localhost:35659' 13:51:25 INFO - SUITE-START | Running 2 tests 13:51:25 INFO - TEST-START | dromaeo_css 13:51:25 INFO - operating with platform_type : linux_ 13:51:25 INFO - Initialising browser for dromaeo_css test... 13:51:25 INFO - TEST-INFO | started process 28235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKbl79W/profile http://localhost:35659/getInfo.html) 13:51:30 INFO - PROCESS | 28235 | __metrics Screen width/height:1600/1200 13:51:30 INFO - PROCESS | 28235 | colorDepth:24 13:51:30 INFO - PROCESS | 28235 | Browser inner width/height: 1024/697 13:51:30 INFO - PROCESS | 28235 | __metrics 13:51:30 ERROR - PROCESS | 28235 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:51:31 INFO - TEST-INFO | 28235: exit 0 13:51:31 INFO - Browser initialized. 13:51:31 INFO - Running cycle 1/1 for dromaeo_css test... 13:51:31 INFO - TEST-INFO | started process 28316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKbl79W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:43 INFO - PROCESS | 28316 | RSS: Main: 154046464 13:51:43 INFO - PROCESS | 28316 | 13:52:35 INFO - PROCESS | 28316 | 1459543955434 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] 13:54:47 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:35659/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35659/tests/dromaeo/cssquery-ext.html) 13:54:48 INFO - PROCESS | 28316 | RSS: Main: 272314368 13:54:48 INFO - PROCESS | 28316 | 13:57:51 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:35659/tests/dromaeo/cssquery-ext.html (next: http://localhost:35659/tests/dromaeo/cssquery-jquery.html) 13:57:51 INFO - PROCESS | 28316 | RSS: Main: 237744128 13:57:51 INFO - PROCESS | 28316 | 14:00:53 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:35659/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35659/tests/dromaeo/cssquery-mootools.html) 14:00:54 INFO - PROCESS | 28316 | RSS: Main: 232898560 14:00:54 INFO - PROCESS | 28316 | 14:03:56 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:35659/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35659/tests/dromaeo/cssquery-prototype.html) 14:03:56 INFO - PROCESS | 28316 | RSS: Main: 218349568 14:03:56 INFO - PROCESS | 28316 | 14:06:59 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:35659/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35659/tests/dromaeo/cssquery-yui.html) 14:06:59 INFO - PROCESS | 28316 | RSS: Main: 198324224 14:06:59 INFO - PROCESS | 28316 | 14:10:02 INFO - PROCESS | 28316 | Cycle 1(1): loaded http://localhost:35659/tests/dromaeo/cssquery-yui.html (next: http://localhost:35659/tests/dromaeo/cssquery-dojo.html) 14:10:02 INFO - PROCESS | 28316 | RSS: Main: 269877248 14:10:02 INFO - PROCESS | 28316 | 14:10:02 INFO - PROCESS | 28316 | __start_tp_report 14:10:02 INFO - PROCESS | 28316 | _x_x_mozilla_page_load 14:10:02 INFO - PROCESS | 28316 | _x_x_mozilla_page_load_details 14:10:02 INFO - PROCESS | 28316 | |i|pagename|runs| 14:10:02 INFO - PROCESS | 28316 | |0;dojo.html;2645.1535508637235;2678.812483126182;2694.6362241097454;2717.2935036890403;2730.3447172678552;4583.656225783063;4630.374899388582;4652.581267685903;4665.626749860003;4701.9059618807605;4602.884927876805;4670.556297151774;4675.228587283103;4693.9061218775605;4710.693804902688;4276.999999999992;4282.31482962726;4309.2027974824605;4338;4466.464024317086;4411.05162390086;4427.645788336941;4433.357163211333;4468.888277793065;4486.057927835159;4242.936355954663;4262.381954616594;4324.545922678137;4330.956690433087;4368.388425620416;4262.2754131797665;4263.0834370610155;4320.503142138631;4323.113761678848;4337.71804832688;4252.596003379674;4255.446791917062;4279.657627389802;4296.806643701041;4301.892452688677;4473.888152796174;4490.685652004361;4509.481409637868;4535.342375355588;4581.816727330903;5023.748812559394;5051.570616497602;5054.519820617073;5076.492350764931;5115;5080.263361812554;5081.872953176163;5089.236614507817;5097.541221290065;5140.023395554833;4621.4223222097235;4622.121796858586;4692.131955588227;4703.529647035303;4705.035467729176;5120.8719782005;5144.459831717691;5149.253358263031;5153.458886816905;5181.145111056709;4916.631252656065;4917.9016419672125;4921.8523444296725;4928.753562321869;4968.130577148984;4924.926126108111;4962.553370196628;5011.273365362002;5022.874428139253;5030.924536131961;4930.8767280818265;4938.506149385104;4961.8511444656715;4968.080905032581;5019.42276638184;4957.281194226817;4963.057019166346;4967.82612608557;4970.105381031449;5013.072581572348;4169.061961058798;4176.979115104405;4235.894102647397;4247.830086796555;4250.213710463574;3703.4444833275224;3718.0518967663074;3734.925301494009;3744.9888530096723;3763.9435408468894;4323.632491238217;4324.9135017300105;4325.394444777734;4328.588784065509;4370;4943.579795717333;5021.472745361758;5079.263506791494;5135.845924622267;5139.511746384088;4267.039916018933;4275.46556680415;4277.679174061957;4279.293916503804;4331.306990881444;4435;4484.798184081724;4496.887577810516;4499.88750281239;4522.751248681354;4711.623070154379;4740.336352910665;4747.192977193954;4790.760461976817;4800.711957282574;4978.303037574815;5004.47453017428;5009.398872135367;5010.273510340907;5063.468335824833;4585.679002469795;4626.514216007271;4756.405449318835;4757.381540399864;4803.903921921612;4931.728754918514;4958.727270000185;4959.429665588359;4981.053599816023;5010.949890501049;5013.172826483589;5028.296038554532;5063.949360506495;5064.9746751267485;5105.489451054865;4724.220503616864;4848.8787780304365;4911.165101932608;4915.361003069721;4977.4524802271;4840.491748366511;4855.34452848875;4862.367892173995;4880.267959806058;4905.386826646669;4719.3628860103445;4731.976340118277;4738.407699037621;4748.430188377417;4818.662693611554;4798.3042458843975;4824.131656301899;4883.975580122076;4884.511548845087;4955.058538877602;4750.168720473835;4790.712557246577;4792.257200133985;4796.928046079382;4808.783604737725 14:10:02 INFO - PROCESS | 28316 | |1;ext.html;533.30403823011;546.6282927609226;556.1241045353564;559.7369236458866;560.1038338658147;27198.86400567997;27599.172024839238;27622.861885690567;27659;36861;39526.209475810465;40418.59581404185;40541.39187912184;40546.79726601363;40612.39081413781;7716;7894.763157105296;7905.525668459882;7908.051033875914;7915.881261781078;7746;7863.724769633064;7866.960665196666;7885.053793544783;7893.250141236602;7861.135275119732;7927.4847134936335;7943;7943.602819859013;7951.602419879012;7816.452848300622;7895.842083158362;7896.131425543157;7898.565578893159;7901.328387087105;7781.41639377049;7836;7865.488743231672;7870.72452464161;7905.18180818415;37557.62442375596;37910.43134352987;37964.62035379638;37972.24055518902;37980.810095949346;3064.7854650174495;3183.1246407237963;3187.5378070179927;3293.637699853014;3399.997000884745;27385.17844464669;28558.286042848886;29006.419871602662;29228;29398.559021614692;3392.8340318775035;3394.7114495267933;3419.956913141491;3429.6741809528053;3479.5824501059783;235377;235748;236355;236631;237119.99999999828;53103.09659744208;53255.73372133192;53299.733501332244;53463.73268133635;53762.193567096525;51720;55965;56156;59976.70011650001;60676.69661651752;12818.487260509663;12962.287074211008;13005.674858128623;13009.674758130934;13010.349482526026;9213.309001824757;9214.769630759285;9231.76920576991;9233.215176710055;9239.584218710173;16231;16876.746848797276;18740.344087956855;19174.13716382766;19245.711314330296;6368.522360822957;6793;6926.58440493572;6957.06079679247;7016.7544135954995;856.267890953226;883.7127933421664;892.2415946445599;965.3242730088966;967.3180407812475;24218.152364667505;24950;25814.483710325687;26550.33624159373;26571.33571660724;970.1026550440814;978.500964508106;1013.6857574152036;1018.2821111116644;1056.5404049238605;13499.460021599027;13625.318734063258;13962.930185349009;13967;14012.439502419993;277717;283599;283788;284127;284445;45223.54776452259;46352.76823615928;46358.30462543065;46359.536404636194;46395.30407043897;1205.6383085074442;1208.8304070389538;1218.62831836289;1225.7793597152597;1237.7400745843295;25383.746162538137;25493.87253063723;25725.871370643028;25806.483870322863;25946.87026564855;40172.3974140394;40564.1887162261;40598.39102413407;40630;40665.186696265315;209478;210526;210969;211217;211234;25806.741932581186;30844.69155308508;30932;31014.379712406077;31234.843825780725;33136;33219.169520762174;34676.959691209304;38216.61783382131;38613.80693096516;32375;32611.836940815145;32718.67281327156;32861.50707739434;33982.49026264658;29346.559801602565;29493.26266843346;29540;29651;30269.545956811107;32579;32766.34467310688;32887.17782055468;32957.835210823796;33125.33749325048;28175.71824281813;30173.245668858453;30315.848420757757;30451.553665973468;32436;23107.537849243257;23187.88406057959;23319.53360932738;23421.88289058544;23557 14:10:02 INFO - PROCESS | 28316 | |2;jquery.html;351.64835164835165;353.3604176440644;355.2716930292899;360.07999561121335;364.42239051103996;15395.538133855975;15925.522234332973;16282.674346513062;16916;16925.915370423132;15779.60550986226;16153.111578863187;16280;16280.75578866315;16290.185490725446;4539.727616343013;4673.3223682566;4688.882777930562;4708.0819240248165;5062.974685126587;5066.74666266687;5069.695818250898;5100.362454693163;5106.157484015133;5111.897762044757;5030.295758593781;5092.719900405476;5097.413797413308;5103.2090026045835;5105.770240339194;6519.674016299166;6777.593344399352;6795.32046795319;6799.830004249884;6802.115724955774;6430.903536446957;6496.252930912959;6509;6513.055606936968;6549.6070235786;21607.567848643095;21736.347909562737;22380.552388952292;22407.551848963092;22414.55170896573;1981.9030649319548;2075.5018795489127;2120.4910821402905;2344.6951896253377;2442.206282958028;13439.193648381128;13533.526326578523;13632.386542605607;13697.246651434167;14156.079854809508;1876.5496280892623;1878.2393130782054;1880.6599677459371;1943.280986035176;2007.5884443689008;64331.356686433006;65640.67179664118;66143;66274;66772.66613666901;14594.71269390427;14643.522253094863;14683.632909177357;14760.704785904221;14775;24413.26760197197;24466.51066978686;24757;24806.875965620417;24831.25506234816;7847.764567062997;7870;7935.6032198391;7937.2459616336355;8015.03819541647;6429.1320671709655;6459.677016149174;6462.709178086998;6566.409023187936;6598.967005165039;7432.702691892264;7501.249375312344;7521.811954701177;7524.623768811538;7597.354224890946;2826.42058378032;2931;3037.104054303986;3079.13784140441;3172.2862355969723;813.6663967773185;850.6937502499095;894.5884892949316;924.7965447601517;985.5318723606373;15079.698406031817;15699.607509812118;15969.281382337822;16026.679466410607;16074.839251607567;849.3502470609989;874.1957399192758;876.386529429402;884.6726711116928;925.4077390470104;8815.868960258367;8930.19628233462;8950.418222815626;8983.865242021375;9059.547022648841;360236;372060;377440;380533;380673;71534.64232678803;73792;74016.62991685007;75031;75096.24903751002;920.963161473547;941.1435593609782;951.3388195204267;954.2652157838426;956.1203692602822;14167.858321416654;14351.425942962165;14468.131912085308;14561.92719036398;14745.410183592536;34167.82916085404;35139.82430087833;35221.999999998974;35388.64611353853;35598.82200588981;47727.5227247737;48133;48179.75910120427;48318.27522587094;48975.08248607831;7686.961565192139;7740.458167928191;7775.766726998199;7786.325939922717;7828.530288182727;10690.305130166515;11345.20583559176;11349.943250284026;11575.594854180063;11591.942040289745;9828.361156524803;9903.653372132228;10061.295709300279;10147.731533558304;10226.181905447398;9985.301028927905;10017.39895606266;10043.497825108861;10287.794244114926;10422.062014418738;10619.787604247716;10657.413842238751;10726.088282495763;10746.73133171677;10817.18871084656;7465.328120469184;7573.583452909922;7604.505707129019;7690.423218258765;7709.3447057000785;9413.435193888388;10375.63685271042;10467.528961196916;10680.946595266974;10918.56325746993 14:10:02 INFO - PROCESS | 28316 | |3;mootools.html;1305.7910734282505;1402.6773842016337;1410.0904916328964;1542.8842836787244;1733.2547004787943;6707.698153583088;7356.852862942745;7484.363829074521;7494.100707915058;7506.7372641957545;7459.47783655143;7591.089069311676;7601.239876012396;7604.771856844303;7612.429067819908;1925.3261358524544;1968.6948522978962;1971.5268335599496;2182.7162468879064;2211.635080211763;2270.5118399544094;2313.063209400187;2318.6058370077044;2318.710161229846;2320.814334853216;2179.8801065941366;2214.269291133922;2214.734231892175;2232.5646498932715;2236.3626366485555;2190.5728382965326;2207.2605677098113;2211.292386436333;2212.314182603382;2213.856099353553;2112.493001679601;2150.0217401082627;2151.9784802151935;2165.783421657837;2173.5870184664864;7725.961370193169;7733.574653394061;7768.689252429953;7783.143854176036;7791.22087791222;4472.753998530112;4591.058832939239;4619.376384188159;4629.051044535862;4632.0967411354795;2833.3483298841174;2940.0738767288235;2946.6022087018405;2961.3781105967773;2962.6741058483767;906.40177482861;940.4122423485321;949.9192568631674;955.3026290807679;970.4759429907841;10561.78876422475;10562.102221311197;10562.735931601772;10581.10060644846;10595.682129536126;4211.684123690736;4441.178381999341;4450.443694538118;4455.933161002587;4460.487043989918;8990.415622984616;9038.09619038091;9060.184583387527;9064.50145242018;9065.728028159167;4566.1552612766745;4611.700239484423;4613.215753321943;4616.6537509686905;4622.14490319292;3646.507721457622;4045.777482238505;4148.79256037197;4149.149424367997;4174.499060112806;3566.8751593694096;3612.9096772580897;3660.066682995819;3669.119411341312;3680.2639472105684;1191.5055252070467;1227.1226073357593;1232.48235740989;1246.2335663566842;1249.9312537810508;995.9900400996042;1013.3615822032073;1014.0366651680932;1032.0917592518535;1117.5138814615668;7004.334588214111;7015.333543313377;7077.256888026786;7117.89323160153;7130.750423735248;478.5525533626001;1112.7106952192325;1118.7986162490668;1130.711668524521;1146.7993101207255;5537.695426751487;5578.944210557924;5605.5515558755205;5620.353659329229;5628.212050312959;9184.081591840895;9315.767105822408;9376.156145946898;9517.857232141523;9520.23838092951;9153.81692366149;9199.77000574991;9259.444433334022;9292.256619470427;9377.953110234404;7176.941029566959;7225.421966242688;7242.384397326181;7317.085364329459;7397.741079062314;6852.931470685428;6920.204176519765;6940.687669055005;6945.444364450933;6972.651367431709;8082.393820463371;8325.666973321;8502.574871256289;8502.617382217692;8524.977002759708;8523.786905327417;8643.481391116553;8776.912230877864;8812.735617931472;8816;6179.073139029002;6320.62076275425;6413.454856337264;6415.743370265137;6431.485481161402;7185.784426467214;7192.712291508281;7211.891821622575;7218.133823941161;7220.638968051681;6600.63696496678;6687.531872769054;6690.698918548775;6749.392554670103;6857.759978400732;6562.245341785756;6603.867922641616;6647.135872336566;6664.300248473841;6664.8000559983275;6629.105070815378;6631.767888123893;6676.666166691549;6676.6995485202315;6679.4656427484715;6003.5797494174985;6106.6336019838955;6107.755689772359;6110.450059494667;6140.3552626975315;6432.581882177644;6485.383888530582;6485.77299794505;6494.870102597827;6502.479801615765 14:10:02 INFO - PROCESS | 28316 | |4;prototype.html;319.62444128149417;324.26553855517244;325.4483650212889;328.86352163852;330.494343654209;5298.390685071218;5341.519263266306;5345.545628621562;5373.462653734625;5377.569794416447;5219.634625576211;5251.947480525194;5270.130428479296;5271.683698978064;5272.841814745564;3951.6245956634075;4046.514418269812;4151.854685086023;4162.937555936648;4173.332266837307;4161.292580261363;4163.916721665565;4167.416561681352;4167.916641667165;4174.060836311821;4135.689823263252;4137.8758637240935;4138.193052354792;4150.564190759972;4160.5007399112;3935.0949281665235;4018.63832255097;4084.7140700151003;4106.07613287011;4111.424400583921;3613.2050948791225;3629.5825980012373;3636.5272514573203;3638.6725194732335;3644.4533320001947;4930.03864246472;4948.950510494885;4989.401271847401;5003.574696150795;5024.673396229234;4768.928466073012;4777.665563410563;4784.378030856001;4792.376990991183;4792.520747925215;5556.333240011184;5560.888782224373;5564.443555644403;5566.582506312043;5572.804951826666;4005.399190121476;4024.5774193709826;4026.396040593905;4027.1744292420276;4028.536718277406;5580.525655319262;5782.710864456761;5792.855178620526;5801.274840644919;5824.30108386992;3958.524977002778;4016.979915100406;4017.276890159741;4019.196160767858;4022.1955608877756;4072.552019277877;4074.1851629674184;4074.266632006267;4075.5313138988804;4078;4662.347271382009;4668.836590719308;4668.929966050512;4677.695949763254;4677.812887484531;5545;5547.694876781816;5550.333959924835;5554.389017208104;5579.69311687861;1401.2713389037644;1427.3148888533353;1431.055503367793;1432.6776475293184;1435.3684378873263;900.2213085680839;932.1331162019252;933.4819175357742;949.8622699708642;955.617752898846;4830.855074347775;4833.854984350475;4849.127157111683;4849.709017458964;4871.853844384674;5712.942870571241;5716.371199168088;5724.4561766632105;5728.828135155952;5734.025215713339;4849.709017458964;4850.878728031827;4856.271559266068;4860.222364421676;4862.3922009748785;3032.2419395151214;3071.5392691096513;3073.185605814461;3074.7847650664685;3077.98461007698;5422.48486393792;5422.728863556886;5427.348718153768;5432.348118225759;5438.401775804658;5694.253775250033;5778.508826749689;5825.533957283407;5862.12068189775;5874.794382196603;5397.460253974571;5401.189821526724;5414.07960646691;5415.214793854948;5419.891602167856;5713.171590119493;5718.370979192202;5720.256366672306;5720.828375148586;5721.456461636138;5580.497755202051;5586.329640443173;5590.413006634245;5590.860228494157;5593.440655934374;5402.783888644567;5404.081306177881;5419.945800542102;5422.539084177889;5424.457554244544;3835.2521258354354;3889.688824893945;3921.843126275031;3938.4289278055094;3942.7831469269468;5640.351359593699;5656.208130861765;5660.830175094754;5670.546356291405;5679.091345384719;5479.0959491683425;5482.533984611353;5495.862603434946;5497.505224529652;5502.422245664147;5494.80768173112;5499.037668407933;5513.8345849624575;5522.97238513821;5526.226328313959;5387.111126664056;5432.0765469871;5435.510804027656;5442.319710036246;5445.047116754473;5412.43169467216;5547;5646.520045795989;5648.068068768607;5665.433456654301;5474.452554744494;5510.614257001971;5511.366192887869;5512.91730624033;5513.2005859151 14:10:02 INFO - PROCESS | 28316 | |5;yui.html;634.6826586706646;645.1902861908308;685.9128281673547;710.1442761472424;774.0324594257179;11989.160758746892;12137.514499420013;12183.32991685457;12250.93874530626;12261;13629.659258518543;13872.791908121386;13903.930480347584;13905.374258158381;13920.930395348008;822.9958850205741;834.5076404921095;837.1586555511702;838.119974027272;839.261449924069;652.0512654088313;802.6107337941094;822.5270469480043;824.2952275804191;825.3232349473434;861.315254372772;861.5132450165636;863.361112776544;864.0020776003726;864.1401805203831;678.8235058884676;843.5234092737584;844.012505368717;844.7888027993001;845.5772113943028;622.6015350175891;627.438442593876;631.7630888416844;632.4940047961659;632.5761739634456;11854.288742675468;11972.161948663597;11975.101867359983;11990.980766634846;12004.819927701092;11049.558017679283;11273.37996410197;11396.829047564293;11646.825297620542;11685.182037257395;9245.260379169651;9429.481378524179;9589.568469418824;9828.312018158731;9911.950440247752;3187.824669643169;3195.568598239231;3234.2884565395575;3235.7573182011206;3238.6275578308323;43509.129817403475;43954.780226098665;44032.77983610093;44099.11801763947;44100.11799764019;9456.57445414958;9510.334276600572;9547.952260238655;9564.330496865292;9791.265655075898;16601.086940218163;16625.584360391087;16657.50027499177;16662.750058749127;16695.415660451825;6671.499637527205;6723.125993620896;6763.830904227335;6888.586684798928;6940.618265995317;3551.9289614207573;3572.089117275078;3576.499290099388;3610.62088480711;3660.652238037382;2833.249188964926;2839.545672692401;2847.601335812988;2861.642294713161;2874.669413017488;521.369143336567;521.9347581552306;527.6412039812888;528.1865926473188;528.9391719952177;606.8209878085976;638.9840253993594;639.86318132897;640.3756337570924;648.6270394523168;7355.632218389059;7460.664270107858;7616.466847320745;7923.564203968837;8121;488.1579275749375;598.1506261109236;606.233115109387;610.1762620462429;611.3977731934042;3543.574771027493;3560;3578.499010138583;3697.9630203698157;3838.1172330363615;45937;50560.74719626379;50764.49235507598;50957;51152;42838.357424638656;43016.784916075216;43748.3437748434;43758.781206094405;44380.3342949856;41060;41211;41436.792816035726;41450.37824432636;41558.79220603878;8470.957645211982;8678.913210867811;8730.607122679368;8833.29333653319;8914.465132092095;29978.400431991675;30528.694713053475;31189;31441.21396965094;32072.35855282928;37018.074548136516;37149.628503714615;38418.615813841505;40738.79630601828;40776.388354174116;10216.744581385525;10760;10914.836277455686;10957.12343012573;11269.211155219056;11792.587259445878;11931.105167112675;12040.698982525508;12185.695357615776;12343.75312493763;8345.749627511184;10986.945065274622;11049.17131215146;11313.604023859125;11434.428278586203;11069.833952490559;11083.889161108285;11196.496157673088;11205.71985700364;11510.48202830858;10949;11113.833292500458;11208.55165793359;11527.596534121265;11735.295882247092;9615.824945992583;9665.420074795535;9924.156446701822;9956.253281003808;10017.39895606266;10085.394876307446;10195.337303075275;10195.490225488547;10252.948735256276;10254.794904102026 14:10:02 INFO - PROCESS | 28316 | __end_tp_report 14:10:02 INFO - PROCESS | 28316 | __start_cc_report 14:10:02 INFO - PROCESS | 28316 | _x_x_mozilla_cycle_collect,1106 14:10:02 INFO - PROCESS | 28316 | __end_cc_report 14:10:02 INFO - PROCESS | 28316 | __startTimestamp1459545002806__endTimestamp 14:10:02 INFO - PROCESS | 28316 | 14:10:02 INFO - PROCESS | 28316 | ------- Summary: start ------- 14:10:02 INFO - PROCESS | 28316 | Number of tests: 6 14:10:02 INFO - PROCESS | 28316 | 14:10:02 INFO - PROCESS | 28316 | [#0] dojo.html Cycles:165 Average:4630.55 Median:4740.34 stddev:477.39 (10.1%) stddev-sans-first:452.73 14:10:02 INFO - PROCESS | 28316 | Values: 2645.2 2678.8 2694.6 2717.3 2730.3 4583.7 4630.4 4652.6 4665.6 4701.9 4602.9 4670.6 4675.2 4693.9 4710.7 4277.0 4282.3 4309.2 4338.0 4466.5 4411.1 4427.6 4433.4 4468.9 4486.1 4242.9 4262.4 4324.5 4331.0 4368.4 4262.3 4263.1 4320.5 4323.1 4337.7 4252.6 4255.4 4279.7 4296.8 4301.9 4473.9 4490.7 4509.5 4535.3 4581.8 5023.7 5051.6 5054.5 5076.5 5115.0 5080.3 5081.9 5089.2 5097.5 5140.0 4621.4 4622.1 4692.1 4703.5 4705.0 5120.9 5144.5 5149.3 5153.5 5181.1 4916.6 4917.9 4921.9 4928.8 4968.1 4924.9 4962.6 5011.3 5022.9 5030.9 4930.9 4938.5 4961.9 4968.1 5019.4 4957.3 4963.1 4967.8 4970.1 5013.1 4169.1 4177.0 4235.9 4247.8 4250.2 3703.4 3718.1 3734.9 3745.0 3763.9 4323.6 4324.9 4325.4 4328.6 4370.0 4943.6 5021.5 5079.3 5135.8 5139.5 4267.0 4275.5 4277.7 4279.3 4331.3 4435.0 4484.8 4496.9 4499.9 4522.8 4711.6 4740.3 4747.2 4790.8 4800.7 4978.3 5004.5 5009.4 5010.3 5063.5 4585.7 4626.5 4756.4 4757.4 4803.9 4931.7 4958.7 4959.4 4981.1 5010.9 5013.2 5028.3 5063.9 5065.0 5105.5 4724.2 4848.9 4911.2 4915.4 4977.5 4840.5 4855.3 4862.4 4880.3 4905.4 4719.4 4732.0 4738.4 4748.4 4818.7 4798.3 4824.1 4884.0 4884.5 4955.1 4750.2 4790.7 4792.3 4796.9 4808.8 14:10:02 INFO - PROCESS | 28316 | 14:10:02 INFO - PROCESS | 28316 | [#1] ext.html Cycles:180 Average:39983.18 Median:33177.58 stddev:63943.66 (192.7%) stddev-sans-first:64054.44 14:10:02 INFO - PROCESS | 28316 | Values: 533.3 546.6 556.1 559.7 560.1 27198.9 27599.2 27622.9 27659.0 36861.0 39526.2 40418.6 40541.4 40546.8 40612.4 7716.0 7894.8 7905.5 7908.1 7915.9 7746.0 7863.7 7867.0 7885.1 7893.3 7861.1 7927.5 7943.0 7943.6 7951.6 7816.5 7895.8 7896.1 7898.6 7901.3 7781.4 7836.0 7865.5 7870.7 7905.2 37557.6 37910.4 37964.6 37972.2 37980.8 3064.8 3183.1 3187.5 3293.6 3400.0 27385.2 28558.3 29006.4 29228.0 29398.6 3392.8 3394.7 3420.0 3429.7 3479.6 235377.0 235748.0 236355.0 236631.0 237120.0 53103.1 53255.7 53299.7 53463.7 53762.2 51720.0 55965.0 56156.0 59976.7 60676.7 12818.5 12962.3 13005.7 13009.7 13010.3 9213.3 9214.8 9231.8 9233.2 9239.6 16231.0 16876.7 18740.3 19174.1 19245.7 6368.5 6793.0 6926.6 6957.1 7016.8 856.3 883.7 892.2 965.3 967.3 24218.2 24950.0 25814.5 26550.3 26571.3 970.1 978.5 1013.7 1018.3 1056.5 13499.5 13625.3 13962.9 13967.0 14012.4 277717.0 283599.0 283788.0 284127.0 284445.0 45223.5 46352.8 46358.3 46359.5 46395.3 1205.6 1208.8 1218.6 1225.8 1237.7 25383.7 25493.9 25725.9 25806.5 25946.9 40172.4 40564.2 40598.4 40630.0 40665.2 209478.0 210526.0 210969.0 211217.0 211234.0 25806.7 30844.7 30932.0 31014.4 31234.8 33136.0 33219.2 34677.0 38216.6 38613.8 32375.0 32611.8 32718.7 32861.5 33982.5 29346.6 29493.3 29540.0 29651.0 30269.5 32579.0 32766.3 32887.2 32957.8 33125.3 28175.7 30173.2 30315.8 30451.6 32436.0 23107.5 23187.9 23319.5 23421.9 23557.0 14:10:02 INFO - PROCESS | 28316 | 14:10:02 INFO - PROCESS | 28316 | [#2] jquery.html Cycles:180 Average:24230.41 Median:192606.36 stddev:61607.75 (32.0%) stddev-sans-first:61754.49 14:10:02 INFO - PROCESS | 28316 | Values: 351.6 353.4 355.3 360.1 364.4 15395.5 15925.5 16282.7 16916.0 16925.9 15779.6 16153.1 16280.0 16280.8 16290.2 4539.7 4673.3 4688.9 4708.1 5063.0 5066.7 5069.7 5100.4 5106.2 5111.9 5030.3 5092.7 5097.4 5103.2 5105.8 6519.7 6777.6 6795.3 6799.8 6802.1 6430.9 6496.3 6509.0 6513.1 6549.6 21607.6 21736.3 22380.6 22407.6 22414.6 1981.9 2075.5 2120.5 2344.7 2442.2 13439.2 13533.5 13632.4 13697.2 14156.1 1876.5 1878.2 1880.7 1943.3 2007.6 64331.4 65640.7 66143.0 66274.0 66772.7 14594.7 14643.5 14683.6 14760.7 14775.0 24413.3 24466.5 24757.0 24806.9 24831.3 7847.8 7870.0 7935.6 7937.2 8015.0 6429.1 6459.7 6462.7 6566.4 6599.0 7432.7 7501.2 7521.8 7524.6 7597.4 2826.4 2931.0 3037.1 3079.1 3172.3 813.7 850.7 894.6 924.8 985.5 15079.7 15699.6 15969.3 16026.7 16074.8 849.4 874.2 876.4 884.7 925.4 8815.9 8930.2 8950.4 8983.9 9059.5 360236.0 372060.0 377440.0 380533.0 380673.0 71534.6 73792.0 74016.6 75031.0 75096.2 921.0 941.1 951.3 954.3 956.1 14167.9 14351.4 14468.1 14561.9 14745.4 34167.8 35139.8 35222.0 35388.6 35598.8 47727.5 48133.0 48179.8 48318.3 48975.1 7687.0 7740.5 7775.8 7786.3 7828.5 10690.3 11345.2 11349.9 11575.6 11591.9 9828.4 9903.7 10061.3 10147.7 10226.2 9985.3 10017.4 10043.5 10287.8 10422.1 10619.8 10657.4 10726.1 10746.7 10817.2 7465.3 7573.6 7604.5 7690.4 7709.3 9413.4 10375.6 10467.5 10680.9 10918.6 14:10:02 INFO - PROCESS | 28316 | 14:10:02 INFO - PROCESS | 28316 | [#3] mootools.html Cycles:180 Average:5328.26 Median:6367.04 stddev:2797.57 (43.9%) stddev-sans-first:2789.07 14:10:02 INFO - PROCESS | 28316 | Values: 1305.8 1402.7 1410.1 1542.9 1733.3 6707.7 7356.9 7484.4 7494.1 7506.7 7459.5 7591.1 7601.2 7604.8 7612.4 1925.3 1968.7 1971.5 2182.7 2211.6 2270.5 2313.1 2318.6 2318.7 2320.8 2179.9 2214.3 2214.7 2232.6 2236.4 2190.6 2207.3 2211.3 2212.3 2213.9 2112.5 2150.0 2152.0 2165.8 2173.6 7726.0 7733.6 7768.7 7783.1 7791.2 4472.8 4591.1 4619.4 4629.1 4632.1 2833.3 2940.1 2946.6 2961.4 2962.7 906.4 940.4 949.9 955.3 970.5 10561.8 10562.1 10562.7 10581.1 10595.7 4211.7 4441.2 4450.4 4455.9 4460.5 8990.4 9038.1 9060.2 9064.5 9065.7 4566.2 4611.7 4613.2 4616.7 4622.1 3646.5 4045.8 4148.8 4149.1 4174.5 3566.9 3612.9 3660.1 3669.1 3680.3 1191.5 1227.1 1232.5 1246.2 1249.9 996.0 1013.4 1014.0 1032.1 1117.5 7004.3 7015.3 7077.3 7117.9 7130.8 478.6 1112.7 1118.8 1130.7 1146.8 5537.7 5578.9 5605.6 5620.4 5628.2 9184.1 9315.8 9376.2 9517.9 9520.2 9153.8 9199.8 9259.4 9292.3 9378.0 7176.9 7225.4 7242.4 7317.1 7397.7 6852.9 6920.2 6940.7 6945.4 6972.7 8082.4 8325.7 8502.6 8502.6 8525.0 8523.8 8643.5 8776.9 8812.7 8816.0 6179.1 6320.6 6413.5 6415.7 6431.5 7185.8 7192.7 7211.9 7218.1 7220.6 6600.6 6687.5 6690.7 6749.4 6857.8 6562.2 6603.9 6647.1 6664.3 6664.8 6629.1 6631.8 6676.7 6676.7 6679.5 6003.6 6106.6 6107.8 6110.5 6140.4 6432.6 6485.4 6485.8 6494.9 6502.5 14:10:02 INFO - PROCESS | 28316 | 14:10:02 INFO - PROCESS | 28316 | [#4] prototype.html Cycles:180 Average:4603.95 Median:5319.95 stddev:1338.75 (25.2%) stddev-sans-first:1303.31 14:10:02 INFO - PROCESS | 28316 | Values: 319.6 324.3 325.4 328.9 330.5 5298.4 5341.5 5345.5 5373.5 5377.6 5219.6 5251.9 5270.1 5271.7 5272.8 3951.6 4046.5 4151.9 4162.9 4173.3 4161.3 4163.9 4167.4 4167.9 4174.1 4135.7 4137.9 4138.2 4150.6 4160.5 3935.1 4018.6 4084.7 4106.1 4111.4 3613.2 3629.6 3636.5 3638.7 3644.5 4930.0 4949.0 4989.4 5003.6 5024.7 4768.9 4777.7 4784.4 4792.4 4792.5 5556.3 5560.9 5564.4 5566.6 5572.8 4005.4 4024.6 4026.4 4027.2 4028.5 5580.5 5782.7 5792.9 5801.3 5824.3 3958.5 4017.0 4017.3 4019.2 4022.2 4072.6 4074.2 4074.3 4075.5 4078.0 4662.3 4668.8 4668.9 4677.7 4677.8 5545.0 5547.7 5550.3 5554.4 5579.7 1401.3 1427.3 1431.1 1432.7 1435.4 900.2 932.1 933.5 949.9 955.6 4830.9 4833.9 4849.1 4849.7 4871.9 5712.9 5716.4 5724.5 5728.8 5734.0 4849.7 4850.9 4856.3 4860.2 4862.4 3032.2 3071.5 3073.2 3074.8 3078.0 5422.5 5422.7 5427.3 5432.3 5438.4 5694.3 5778.5 5825.5 5862.1 5874.8 5397.5 5401.2 5414.1 5415.2 5419.9 5713.2 5718.4 5720.3 5720.8 5721.5 5580.5 5586.3 5590.4 5590.9 5593.4 5402.8 5404.1 5419.9 5422.5 5424.5 3835.3 3889.7 3921.8 3938.4 3942.8 5640.4 5656.2 5660.8 5670.5 5679.1 5479.1 5482.5 5495.9 5497.5 5502.4 5494.8 5499.0 5513.8 5523.0 5526.2 5387.1 5432.1 5435.5 5442.3 5445.0 5412.4 5547.0 5646.5 5648.1 5665.4 5474.5 5510.6 5511.4 5512.9 5513.2 14:10:02 INFO - PROCESS | 28316 | 14:10:02 INFO - PROCESS | 28316 | [#5] yui.html Cycles:180 Average:12575.44 Median:42927.57 stddev:13928.61 (32.4%) stddev-sans-first:13938.81 14:10:02 INFO - PROCESS | 28316 | Values: 634.7 645.2 685.9 710.1 774.0 11989.2 12137.5 12183.3 12250.9 12261.0 13629.7 13872.8 13903.9 13905.4 13920.9 823.0 834.5 837.2 838.1 839.3 652.1 802.6 822.5 824.3 825.3 861.3 861.5 863.4 864.0 864.1 678.8 843.5 844.0 844.8 845.6 622.6 627.4 631.8 632.5 632.6 11854.3 11972.2 11975.1 11991.0 12004.8 11049.6 11273.4 11396.8 11646.8 11685.2 9245.3 9429.5 9589.6 9828.3 9912.0 3187.8 3195.6 3234.3 3235.8 3238.6 43509.1 43954.8 44032.8 44099.1 44100.1 9456.6 9510.3 9548.0 9564.3 9791.3 16601.1 16625.6 16657.5 16662.8 16695.4 6671.5 6723.1 6763.8 6888.6 6940.6 3551.9 3572.1 3576.5 3610.6 3660.7 2833.2 2839.5 2847.6 2861.6 2874.7 521.4 521.9 527.6 528.2 528.9 606.8 639.0 639.9 640.4 648.6 7355.6 7460.7 7616.5 7923.6 8121.0 488.2 598.2 606.2 610.2 611.4 3543.6 3560.0 3578.5 3698.0 3838.1 45937.0 50560.7 50764.5 50957.0 51152.0 42838.4 43016.8 43748.3 43758.8 44380.3 41060.0 41211.0 41436.8 41450.4 41558.8 8471.0 8678.9 8730.6 8833.3 8914.5 29978.4 30528.7 31189.0 31441.2 32072.4 37018.1 37149.6 38418.6 40738.8 40776.4 10216.7 10760.0 10914.8 10957.1 11269.2 11792.6 11931.1 12040.7 12185.7 12343.8 8345.7 10986.9 11049.2 11313.6 11434.4 11069.8 11083.9 11196.5 11205.7 11510.5 10949.0 11113.8 11208.6 11527.6 11735.3 9615.8 9665.4 9924.2 9956.3 10017.4 10085.4 10195.3 10195.5 10252.9 10254.8 14:10:02 INFO - PROCESS | 28316 | -------- Summary: end -------- 14:10:02 INFO - PROCESS | 28316 | 14:10:03 INFO - TEST-INFO | 28316: exit 0 14:10:03 INFO - TEST-OK | dromaeo_css | took 1117864ms 14:10:03 INFO - TEST-START | kraken 14:10:03 INFO - operating with platform_type : linux_ 14:10:03 INFO - Initialising browser for kraken test... 14:10:03 INFO - TEST-INFO | started process 28494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSq27QN/profile http://localhost:35659/getInfo.html) 14:10:07 INFO - PROCESS | 28494 | __metrics Screen width/height:1600/1200 14:10:07 INFO - PROCESS | 28494 | colorDepth:24 14:10:07 INFO - PROCESS | 28494 | Browser inner width/height: 1024/697 14:10:07 INFO - PROCESS | 28494 | __metrics 14:10:08 ERROR - PROCESS | 28494 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:10:09 INFO - TEST-INFO | 28494: exit 0 14:10:09 INFO - Browser initialized. 14:10:09 INFO - Running cycle 1/1 for kraken test... 14:10:09 INFO - TEST-INFO | started process 28575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSq27QN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:21 INFO - PROCESS | 28575 | RSS: Main: 154824704 14:10:21 INFO - PROCESS | 28575 | 14:10:24 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35659/tests/kraken/driver.html?testName=audio-beat-detection) 14:10:24 INFO - PROCESS | 28575 | RSS: Main: 195981312 14:10:24 INFO - PROCESS | 28575 | 14:10:27 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35659/tests/kraken/driver.html?testName=audio-dft) 14:10:28 INFO - PROCESS | 28575 | RSS: Main: 186048512 14:10:28 INFO - PROCESS | 28575 | 14:10:31 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35659/tests/kraken/driver.html?testName=audio-fft) 14:10:31 INFO - PROCESS | 28575 | RSS: Main: 172040192 14:10:31 INFO - PROCESS | 28575 | 14:10:33 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35659/tests/kraken/driver.html?testName=audio-oscillator) 14:10:34 INFO - PROCESS | 28575 | RSS: Main: 173469696 14:10:34 INFO - PROCESS | 28575 | 14:10:36 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35659/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:10:37 INFO - PROCESS | 28575 | RSS: Main: 173748224 14:10:37 INFO - PROCESS | 28575 | 14:10:40 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35659/tests/kraken/driver.html?testName=imaging-darkroom) 14:10:40 INFO - PROCESS | 28575 | RSS: Main: 173920256 14:10:40 INFO - PROCESS | 28575 | 14:10:44 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35659/tests/kraken/driver.html?testName=imaging-desaturate) 14:10:44 INFO - PROCESS | 28575 | RSS: Main: 174264320 14:10:44 INFO - PROCESS | 28575 | 14:10:47 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35659/tests/kraken/driver.html?testName=json-parse-financial) 14:10:48 INFO - PROCESS | 28575 | RSS: Main: 174526464 14:10:48 INFO - PROCESS | 28575 | 14:10:50 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35659/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:10:50 INFO - PROCESS | 28575 | RSS: Main: 183672832 14:10:50 INFO - PROCESS | 28575 | 14:10:52 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35659/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:10:53 INFO - PROCESS | 28575 | RSS: Main: 183599104 14:10:53 INFO - PROCESS | 28575 | 14:10:55 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35659/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:10:55 INFO - PROCESS | 28575 | RSS: Main: 196845568 14:10:55 INFO - PROCESS | 28575 | 14:10:58 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:10:58 INFO - PROCESS | 28575 | RSS: Main: 200806400 14:10:58 INFO - PROCESS | 28575 | 14:11:01 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:02 INFO - PROCESS | 28575 | RSS: Main: 200159232 14:11:02 INFO - PROCESS | 28575 | 14:11:03 INFO - PROCESS | 28575 | Cycle 1(1): loaded http://localhost:35659/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35659/tests/kraken/driver.html?testName=ai-astar) 14:11:04 INFO - PROCESS | 28575 | RSS: Main: 262107136 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | __start_tp_report 14:11:04 INFO - PROCESS | 28575 | _x_x_mozilla_page_load 14:11:04 INFO - PROCESS | 28575 | _x_x_mozilla_page_load_details 14:11:04 INFO - PROCESS | 28575 | |i|pagename|runs| 14:11:04 INFO - PROCESS | 28575 | |0;ai-astar;111;114;107;111;112;111;103;112;111;112 14:11:04 INFO - PROCESS | 28575 | |1;audio-beat-detection;158;133;175;172;138;156;159;132;193;136 14:11:04 INFO - PROCESS | 28575 | |2;audio-dft;161;164;162;161;163;163;161;163;163;162 14:11:04 INFO - PROCESS | 28575 | |3;audio-fft;75;74;74;154;74;74;76;74;152;75 14:11:04 INFO - PROCESS | 28575 | |4;audio-oscillator;94;94;147;93;96;95;139;94;95;144 14:11:04 INFO - PROCESS | 28575 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;116 14:11:04 INFO - PROCESS | 28575 | |6;imaging-darkroom;145;146;146;146;146;146;146;146;146;147 14:11:04 INFO - PROCESS | 28575 | |7;imaging-desaturate;95;95;95;95;96;96;95;95;95;95 14:11:04 INFO - PROCESS | 28575 | |8;json-parse-financial;65;65;68;65;63;65;64;74;64;68 14:11:04 INFO - PROCESS | 28575 | |9;json-stringify-tinderbox;64;73;64;63;64;63;63;64;64;63 14:11:04 INFO - PROCESS | 28575 | |10;stanford-crypto-aes;87;82;81;83;91;81;81;81;86;80 14:11:04 INFO - PROCESS | 28575 | |11;stanford-crypto-ccm;116;119;116;117;116;120;117;114;117;120 14:11:04 INFO - PROCESS | 28575 | |12;stanford-crypto-pbkdf2;141;133;147;141;152;130;142;141;141;154 14:11:04 INFO - PROCESS | 28575 | |13;stanford-crypto-sha256-iterative;66;69;70;68;69;67;65;66;68;65 14:11:04 INFO - PROCESS | 28575 | __end_tp_report 14:11:04 INFO - PROCESS | 28575 | __start_cc_report 14:11:04 INFO - PROCESS | 28575 | _x_x_mozilla_cycle_collect,1172 14:11:04 INFO - PROCESS | 28575 | __end_cc_report 14:11:04 INFO - PROCESS | 28575 | __startTimestamp1459545064078__endTimestamp 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | ------- Summary: start ------- 14:11:04 INFO - PROCESS | 28575 | Number of tests: 14 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.13 (2.8%) stddev-sans-first:3.32 14:11:04 INFO - PROCESS | 28575 | Values: 111.0 114.0 107.0 111.0 112.0 111.0 103.0 112.0 111.0 112.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:158.50 stddev:20.61 (13.0%) stddev-sans-first:21.83 14:11:04 INFO - PROCESS | 28575 | Values: 158.0 133.0 175.0 172.0 138.0 156.0 159.0 132.0 193.0 136.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 14:11:04 INFO - PROCESS | 28575 | Values: 161.0 164.0 162.0 161.0 163.0 163.0 161.0 163.0 163.0 162.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#3] audio-fft Cycles:10 Average:90.20 Median:74.00 stddev:33.11 (44.7%) stddev-sans-first:34.66 14:11:04 INFO - PROCESS | 28575 | Values: 75.0 74.0 74.0 154.0 74.0 74.0 76.0 74.0 152.0 75.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:94.00 stddev:23.71 (25.2%) stddev-sans-first:24.51 14:11:04 INFO - PROCESS | 28575 | Values: 94.0 94.0 147.0 93.0 96.0 95.0 139.0 94.0 95.0 144.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:11:04 INFO - PROCESS | 28575 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 14:11:04 INFO - PROCESS | 28575 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:11:04 INFO - PROCESS | 28575 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.00 stddev:3.21 (4.9%) stddev-sans-first:3.38 14:11:04 INFO - PROCESS | 28575 | Values: 65.0 65.0 68.0 65.0 63.0 65.0 64.0 74.0 64.0 68.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.00 stddev:3.03 (4.7%) stddev-sans-first:3.21 14:11:04 INFO - PROCESS | 28575 | Values: 64.0 73.0 64.0 63.0 64.0 63.0 63.0 64.0 64.0 63.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:3.56 (4.3%) stddev-sans-first:3.52 14:11:04 INFO - PROCESS | 28575 | Values: 87.0 82.0 81.0 83.0 91.0 81.0 81.0 81.0 86.0 80.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#11] stanford-crypto-ccm Cycles:10 Average:117.20 Median:117.00 stddev:1.93 (1.7%) stddev-sans-first:2.00 14:11:04 INFO - PROCESS | 28575 | Values: 116.0 119.0 116.0 117.0 116.0 120.0 117.0 114.0 117.0 120.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:141.50 stddev:7.44 (5.3%) stddev-sans-first:7.87 14:11:04 INFO - PROCESS | 28575 | Values: 141.0 133.0 147.0 141.0 152.0 130.0 142.0 141.0 141.0 154.0 14:11:04 INFO - PROCESS | 28575 | 14:11:04 INFO - PROCESS | 28575 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.77 (2.6%) stddev-sans-first:1.81 14:11:04 INFO - PROCESS | 28575 | Values: 66.0 69.0 70.0 68.0 69.0 67.0 65.0 66.0 68.0 65.0 14:11:04 INFO - PROCESS | 28575 | -------- Summary: end -------- 14:11:04 INFO - PROCESS | 28575 | 14:11:05 INFO - TEST-INFO | 28575: exit 0 14:11:05 INFO - TEST-OK | kraken | took 61545ms 14:11:05 INFO - SUITE-END | took 1179s 14:11:05 INFO - Completed test suite (00:19:39) 14:11:05 INFO - javascript benchmark 14:11:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2645.1535508637235, 2678.812483126182, 2694.6362241097454, 2717.2935036890403, 2730.3447172678552, 4583.656225783063, 4630.374899388582, 4652.581267685903, 4665.626749860003, 4701.9059618807605, 4602.884927876805, 4670.556297151774, 4675.228587283103, 4693.9061218775605, 4710.693804902688, 4276.999999999992, 4282.31482962726, 4309.2027974824605, 4338.0, 4466.464024317086, 4411.05162390086, 4427.645788336941, 4433.357163211333, 4468.888277793065, 4486.057927835159, 4242.936355954663, 4262.381954616594, 4324.545922678137, 4330.956690433087, 4368.388425620416, 4262.2754131797665, 4263.0834370610155, 4320.503142138631, 4323.113761678848, 4337.71804832688, 4252.596003379674, 4255.446791917062, 4279.657627389802, 4296.806643701041, 4301.892452688677, 4473.888152796174, 4490.685652004361, 4509.481409637868, 4535.342375355588, 4581.816727330903, 5023.748812559394, 5051.570616497602, 5054.519820617073, 5076.492350764931, 5115.0, 5080.263361812554, 5081.872953176163, 5089.236614507817, 5097.541221290065, 5140.023395554833, 4621.4223222097235, 4622.121796858586, 4692.131955588227, 4703.529647035303, 4705.035467729176, 5120.8719782005, 5144.459831717691, 5149.253358263031, 5153.458886816905, 5181.145111056709, 4916.631252656065, 4917.9016419672125, 4921.8523444296725, 4928.753562321869, 4968.130577148984, 4924.926126108111, 4962.553370196628, 5011.273365362002, 5022.874428139253, 5030.924536131961, 4930.8767280818265, 4938.506149385104, 4961.8511444656715, 4968.080905032581, 5019.42276638184, 4957.281194226817, 4963.057019166346, 4967.82612608557, 4970.105381031449, 5013.072581572348, 4169.061961058798, 4176.979115104405, 4235.894102647397, 4247.830086796555, 4250.213710463574, 3703.4444833275224, 3718.0518967663074, 3734.925301494009, 3744.9888530096723, 3763.9435408468894, 4323.632491238217, 4324.9135017300105, 4325.394444777734, 4328.588784065509, 4370.0, 4943.579795717333, 5021.472745361758, 5079.263506791494, 5135.845924622267, 5139.511746384088, 4267.039916018933, 4275.46556680415, 4277.679174061957, 4279.293916503804, 4331.306990881444, 4435.0, 4484.798184081724, 4496.887577810516, 4499.88750281239, 4522.751248681354, 4711.623070154379, 4740.336352910665, 4747.192977193954, 4790.760461976817, 4800.711957282574, 4978.303037574815, 5004.47453017428, 5009.398872135367, 5010.273510340907, 5063.468335824833, 4585.679002469795, 4626.514216007271, 4756.405449318835, 4757.381540399864, 4803.903921921612, 4931.728754918514, 4958.727270000185, 4959.429665588359, 4981.053599816023, 5010.949890501049, 5013.172826483589, 5028.296038554532, 5063.949360506495, 5064.9746751267485, 5105.489451054865, 4724.220503616864, 4848.8787780304365, 4911.165101932608, 4915.361003069721, 4977.4524802271, 4840.491748366511, 4855.34452848875, 4862.367892173995, 4880.267959806058, 4905.386826646669, 4719.3628860103445, 4731.976340118277, 4738.407699037621, 4748.430188377417, 4818.662693611554, 4798.3042458843975, 4824.131656301899, 4883.975580122076, 4884.511548845087, 4955.058538877602, 4750.168720473835, 4790.712557246577, 4792.257200133985, 4796.928046079382, 4808.783604737725], "unit": "score", "name": "dojo.html", "value": 4601.11327597662}, {"lowerIsBetter": false, "replicates": [533.30403823011, 546.6282927609226, 556.1241045353564, 559.7369236458866, 560.1038338658147, 27198.86400567997, 27599.172024839238, 27622.861885690567, 27659.0, 36861.0, 39526.209475810465, 40418.59581404185, 40541.39187912184, 40546.79726601363, 40612.39081413781, 7716.0, 7894.763157105296, 7905.525668459882, 7908.051033875914, 7915.881261781078, 7746.0, 7863.724769633064, 7866.960665196666, 7885.053793544783, 7893.250141236602, 7861.135275119732, 7927.4847134936335, 7943.0, 7943.602819859013, 7951.602419879012, 7816.452848300622, 7895.842083158362, 7896.131425543157, 7898.565578893159, 7901.328387087105, 7781.41639377049, 7836.0, 7865.488743231672, 7870.72452464161, 7905.18180818415, 37557.62442375596, 37910.43134352987, 37964.62035379638, 37972.24055518902, 37980.810095949346, 3064.7854650174495, 3183.1246407237963, 3187.5378070179927, 3293.637699853014, 3399.997000884745, 27385.17844464669, 28558.286042848886, 29006.419871602662, 29228.0, 29398.559021614692, 3392.8340318775035, 3394.7114495267933, 3419.956913141491, 3429.6741809528053, 3479.5824501059783, 235377.0, 235748.0, 236355.0, 236631.0, 237119.99999999828, 53103.09659744208, 53255.73372133192, 53299.733501332244, 53463.73268133635, 53762.193567096525, 51720.0, 55965.0, 56156.0, 59976.70011650001, 60676.69661651752, 12818.487260509663, 12962.287074211008, 13005.674858128623, 13009.674758130934, 13010.349482526026, 9213.309001824757, 9214.769630759285, 9231.76920576991, 9233.215176710055, 9239.584218710173, 16231.0, 16876.746848797276, 18740.344087956855, 19174.13716382766, 19245.711314330296, 6368.522360822957, 6793.0, 6926.58440493572, 6957.06079679247, 7016.7544135954995, 856.267890953226, 883.7127933421664, 892.2415946445599, 965.3242730088966, 967.3180407812475, 24218.152364667505, 24950.0, 25814.483710325687, 26550.33624159373, 26571.33571660724, 970.1026550440814, 978.500964508106, 1013.6857574152036, 1018.2821111116644, 1056.5404049238605, 13499.460021599027, 13625.318734063258, 13962.930185349009, 13967.0, 14012.439502419993, 277717.0, 283599.0, 283788.0, 284127.0, 284445.0, 45223.54776452259, 46352.76823615928, 46358.30462543065, 46359.536404636194, 46395.30407043897, 1205.6383085074442, 1208.8304070389538, 1218.62831836289, 1225.7793597152597, 1237.7400745843295, 25383.746162538137, 25493.87253063723, 25725.871370643028, 25806.483870322863, 25946.87026564855, 40172.3974140394, 40564.1887162261, 40598.39102413407, 40630.0, 40665.186696265315, 209478.0, 210526.0, 210969.0, 211217.0, 211234.0, 25806.741932581186, 30844.69155308508, 30932.0, 31014.379712406077, 31234.843825780725, 33136.0, 33219.169520762174, 34676.959691209304, 38216.61783382131, 38613.80693096516, 32375.0, 32611.836940815145, 32718.67281327156, 32861.50707739434, 33982.49026264658, 29346.559801602565, 29493.26266843346, 29540.0, 29651.0, 30269.545956811107, 32579.0, 32766.34467310688, 32887.17782055468, 32957.835210823796, 33125.33749325048, 28175.71824281813, 30173.245668858453, 30315.848420757757, 30451.553665973468, 32436.0, 23107.537849243257, 23187.88406057959, 23319.53360932738, 23421.88289058544, 23557.0], "unit": "score", "name": "ext.html", "value": 16510.845515471225}, {"lowerIsBetter": false, "replicates": [351.64835164835165, 353.3604176440644, 355.2716930292899, 360.07999561121335, 364.42239051103996, 15395.538133855975, 15925.522234332973, 16282.674346513062, 16916.0, 16925.915370423132, 15779.60550986226, 16153.111578863187, 16280.0, 16280.75578866315, 16290.185490725446, 4539.727616343013, 4673.3223682566, 4688.882777930562, 4708.0819240248165, 5062.974685126587, 5066.74666266687, 5069.695818250898, 5100.362454693163, 5106.157484015133, 5111.897762044757, 5030.295758593781, 5092.719900405476, 5097.413797413308, 5103.2090026045835, 5105.770240339194, 6519.674016299166, 6777.593344399352, 6795.32046795319, 6799.830004249884, 6802.115724955774, 6430.903536446957, 6496.252930912959, 6509.0, 6513.055606936968, 6549.6070235786, 21607.567848643095, 21736.347909562737, 22380.552388952292, 22407.551848963092, 22414.55170896573, 1981.9030649319548, 2075.5018795489127, 2120.4910821402905, 2344.6951896253377, 2442.206282958028, 13439.193648381128, 13533.526326578523, 13632.386542605607, 13697.246651434167, 14156.079854809508, 1876.5496280892623, 1878.2393130782054, 1880.6599677459371, 1943.280986035176, 2007.5884443689008, 64331.356686433006, 65640.67179664118, 66143.0, 66274.0, 66772.66613666901, 14594.71269390427, 14643.522253094863, 14683.632909177357, 14760.704785904221, 14775.0, 24413.26760197197, 24466.51066978686, 24757.0, 24806.875965620417, 24831.25506234816, 7847.764567062997, 7870.0, 7935.6032198391, 7937.2459616336355, 8015.03819541647, 6429.1320671709655, 6459.677016149174, 6462.709178086998, 6566.409023187936, 6598.967005165039, 7432.702691892264, 7501.249375312344, 7521.811954701177, 7524.623768811538, 7597.354224890946, 2826.42058378032, 2931.0, 3037.104054303986, 3079.13784140441, 3172.2862355969723, 813.6663967773185, 850.6937502499095, 894.5884892949316, 924.7965447601517, 985.5318723606373, 15079.698406031817, 15699.607509812118, 15969.281382337822, 16026.679466410607, 16074.839251607567, 849.3502470609989, 874.1957399192758, 876.386529429402, 884.6726711116928, 925.4077390470104, 8815.868960258367, 8930.19628233462, 8950.418222815626, 8983.865242021375, 9059.547022648841, 360236.0, 372060.0, 377440.0, 380533.0, 380673.0, 71534.64232678803, 73792.0, 74016.62991685007, 75031.0, 75096.24903751002, 920.963161473547, 941.1435593609782, 951.3388195204267, 954.2652157838426, 956.1203692602822, 14167.858321416654, 14351.425942962165, 14468.131912085308, 14561.92719036398, 14745.410183592536, 34167.82916085404, 35139.82430087833, 35221.999999998974, 35388.64611353853, 35598.82200588981, 47727.5227247737, 48133.0, 48179.75910120427, 48318.27522587094, 48975.08248607831, 7686.961565192139, 7740.458167928191, 7775.766726998199, 7786.325939922717, 7828.530288182727, 10690.305130166515, 11345.20583559176, 11349.943250284026, 11575.594854180063, 11591.942040289745, 9828.361156524803, 9903.653372132228, 10061.295709300279, 10147.731533558304, 10226.181905447398, 9985.301028927905, 10017.39895606266, 10043.497825108861, 10287.794244114926, 10422.062014418738, 10619.787604247716, 10657.413842238751, 10726.088282495763, 10746.73133171677, 10817.18871084656, 7465.328120469184, 7573.583452909922, 7604.505707129019, 7690.423218258765, 7709.3447057000785, 9413.435193888388, 10375.63685271042, 10467.528961196916, 10680.946595266974, 10918.56325746993], "unit": "score", "name": "jquery.html", "value": 8790.764920766307}, {"lowerIsBetter": false, "replicates": [1305.7910734282505, 1402.6773842016337, 1410.0904916328964, 1542.8842836787244, 1733.2547004787943, 6707.698153583088, 7356.852862942745, 7484.363829074521, 7494.100707915058, 7506.7372641957545, 7459.47783655143, 7591.089069311676, 7601.239876012396, 7604.771856844303, 7612.429067819908, 1925.3261358524544, 1968.6948522978962, 1971.5268335599496, 2182.7162468879064, 2211.635080211763, 2270.5118399544094, 2313.063209400187, 2318.6058370077044, 2318.710161229846, 2320.814334853216, 2179.8801065941366, 2214.269291133922, 2214.734231892175, 2232.5646498932715, 2236.3626366485555, 2190.5728382965326, 2207.2605677098113, 2211.292386436333, 2212.314182603382, 2213.856099353553, 2112.493001679601, 2150.0217401082627, 2151.9784802151935, 2165.783421657837, 2173.5870184664864, 7725.961370193169, 7733.574653394061, 7768.689252429953, 7783.143854176036, 7791.22087791222, 4472.753998530112, 4591.058832939239, 4619.376384188159, 4629.051044535862, 4632.0967411354795, 2833.3483298841174, 2940.0738767288235, 2946.6022087018405, 2961.3781105967773, 2962.6741058483767, 906.40177482861, 940.4122423485321, 949.9192568631674, 955.3026290807679, 970.4759429907841, 10561.78876422475, 10562.102221311197, 10562.735931601772, 10581.10060644846, 10595.682129536126, 4211.684123690736, 4441.178381999341, 4450.443694538118, 4455.933161002587, 4460.487043989918, 8990.415622984616, 9038.09619038091, 9060.184583387527, 9064.50145242018, 9065.728028159167, 4566.1552612766745, 4611.700239484423, 4613.215753321943, 4616.6537509686905, 4622.14490319292, 3646.507721457622, 4045.777482238505, 4148.79256037197, 4149.149424367997, 4174.499060112806, 3566.8751593694096, 3612.9096772580897, 3660.066682995819, 3669.119411341312, 3680.2639472105684, 1191.5055252070467, 1227.1226073357593, 1232.48235740989, 1246.2335663566842, 1249.9312537810508, 995.9900400996042, 1013.3615822032073, 1014.0366651680932, 1032.0917592518535, 1117.5138814615668, 7004.334588214111, 7015.333543313377, 7077.256888026786, 7117.89323160153, 7130.750423735248, 478.5525533626001, 1112.7106952192325, 1118.7986162490668, 1130.711668524521, 1146.7993101207255, 5537.695426751487, 5578.944210557924, 5605.5515558755205, 5620.353659329229, 5628.212050312959, 9184.081591840895, 9315.767105822408, 9376.156145946898, 9517.857232141523, 9520.23838092951, 9153.81692366149, 9199.77000574991, 9259.444433334022, 9292.256619470427, 9377.953110234404, 7176.941029566959, 7225.421966242688, 7242.384397326181, 7317.085364329459, 7397.741079062314, 6852.931470685428, 6920.204176519765, 6940.687669055005, 6945.444364450933, 6972.651367431709, 8082.393820463371, 8325.666973321, 8502.574871256289, 8502.617382217692, 8524.977002759708, 8523.786905327417, 8643.481391116553, 8776.912230877864, 8812.735617931472, 8816.0, 6179.073139029002, 6320.62076275425, 6413.454856337264, 6415.743370265137, 6431.485481161402, 7185.784426467214, 7192.712291508281, 7211.891821622575, 7218.133823941161, 7220.638968051681, 6600.63696496678, 6687.531872769054, 6690.698918548775, 6749.392554670103, 6857.759978400732, 6562.245341785756, 6603.867922641616, 6647.135872336566, 6664.300248473841, 6664.8000559983275, 6629.105070815378, 6631.767888123893, 6676.666166691549, 6676.6995485202315, 6679.4656427484715, 6003.5797494174985, 6106.6336019838955, 6107.755689772359, 6110.450059494667, 6140.3552626975315, 6432.581882177644, 6485.383888530582, 6485.77299794505, 6494.870102597827, 6502.479801615765], "unit": "score", "name": "mootools.html", "value": 4352.28068066628}, {"lowerIsBetter": false, "replicates": [319.62444128149417, 324.26553855517244, 325.4483650212889, 328.86352163852, 330.494343654209, 5298.390685071218, 5341.519263266306, 5345.545628621562, 5373.462653734625, 5377.569794416447, 5219.634625576211, 5251.947480525194, 5270.130428479296, 5271.683698978064, 5272.841814745564, 3951.6245956634075, 4046.514418269812, 4151.854685086023, 4162.937555936648, 4173.332266837307, 4161.292580261363, 4163.916721665565, 4167.416561681352, 4167.916641667165, 4174.060836311821, 4135.689823263252, 4137.8758637240935, 4138.193052354792, 4150.564190759972, 4160.5007399112, 3935.0949281665235, 4018.63832255097, 4084.7140700151003, 4106.07613287011, 4111.424400583921, 3613.2050948791225, 3629.5825980012373, 3636.5272514573203, 3638.6725194732335, 3644.4533320001947, 4930.03864246472, 4948.950510494885, 4989.401271847401, 5003.574696150795, 5024.673396229234, 4768.928466073012, 4777.665563410563, 4784.378030856001, 4792.376990991183, 4792.520747925215, 5556.333240011184, 5560.888782224373, 5564.443555644403, 5566.582506312043, 5572.804951826666, 4005.399190121476, 4024.5774193709826, 4026.396040593905, 4027.1744292420276, 4028.536718277406, 5580.525655319262, 5782.710864456761, 5792.855178620526, 5801.274840644919, 5824.30108386992, 3958.524977002778, 4016.979915100406, 4017.276890159741, 4019.196160767858, 4022.1955608877756, 4072.552019277877, 4074.1851629674184, 4074.266632006267, 4075.5313138988804, 4078.0, 4662.347271382009, 4668.836590719308, 4668.929966050512, 4677.695949763254, 4677.812887484531, 5545.0, 5547.694876781816, 5550.333959924835, 5554.389017208104, 5579.69311687861, 1401.2713389037644, 1427.3148888533353, 1431.055503367793, 1432.6776475293184, 1435.3684378873263, 900.2213085680839, 932.1331162019252, 933.4819175357742, 949.8622699708642, 955.617752898846, 4830.855074347775, 4833.854984350475, 4849.127157111683, 4849.709017458964, 4871.853844384674, 5712.942870571241, 5716.371199168088, 5724.4561766632105, 5728.828135155952, 5734.025215713339, 4849.709017458964, 4850.878728031827, 4856.271559266068, 4860.222364421676, 4862.3922009748785, 3032.2419395151214, 3071.5392691096513, 3073.185605814461, 3074.7847650664685, 3077.98461007698, 5422.48486393792, 5422.728863556886, 5427.348718153768, 5432.348118225759, 5438.401775804658, 5694.253775250033, 5778.508826749689, 5825.533957283407, 5862.12068189775, 5874.794382196603, 5397.460253974571, 5401.189821526724, 5414.07960646691, 5415.214793854948, 5419.891602167856, 5713.171590119493, 5718.370979192202, 5720.256366672306, 5720.828375148586, 5721.456461636138, 5580.497755202051, 5586.329640443173, 5590.413006634245, 5590.860228494157, 5593.440655934374, 5402.783888644567, 5404.081306177881, 5419.945800542102, 5422.539084177889, 5424.457554244544, 3835.2521258354354, 3889.688824893945, 3921.843126275031, 3938.4289278055094, 3942.7831469269468, 5640.351359593699, 5656.208130861765, 5660.830175094754, 5670.546356291405, 5679.091345384719, 5479.0959491683425, 5482.533984611353, 5495.862603434946, 5497.505224529652, 5502.422245664147, 5494.80768173112, 5499.037668407933, 5513.8345849624575, 5522.97238513821, 5526.226328313959, 5387.111126664056, 5432.0765469871, 5435.510804027656, 5442.319710036246, 5445.047116754473, 5412.43169467216, 5547.0, 5646.520045795989, 5648.068068768607, 5665.433456654301, 5474.452554744494, 5510.614257001971, 5511.366192887869, 5512.91730624033, 5513.2005859151], "unit": "score", "name": "prototype.html", "value": 4177.48371566832}, {"lowerIsBetter": false, "replicates": [634.6826586706646, 645.1902861908308, 685.9128281673547, 710.1442761472424, 774.0324594257179, 11989.160758746892, 12137.514499420013, 12183.32991685457, 12250.93874530626, 12261.0, 13629.659258518543, 13872.791908121386, 13903.930480347584, 13905.374258158381, 13920.930395348008, 822.9958850205741, 834.5076404921095, 837.1586555511702, 838.119974027272, 839.261449924069, 652.0512654088313, 802.6107337941094, 822.5270469480043, 824.2952275804191, 825.3232349473434, 861.315254372772, 861.5132450165636, 863.361112776544, 864.0020776003726, 864.1401805203831, 678.8235058884676, 843.5234092737584, 844.012505368717, 844.7888027993001, 845.5772113943028, 622.6015350175891, 627.438442593876, 631.7630888416844, 632.4940047961659, 632.5761739634456, 11854.288742675468, 11972.161948663597, 11975.101867359983, 11990.980766634846, 12004.819927701092, 11049.558017679283, 11273.37996410197, 11396.829047564293, 11646.825297620542, 11685.182037257395, 9245.260379169651, 9429.481378524179, 9589.568469418824, 9828.312018158731, 9911.950440247752, 3187.824669643169, 3195.568598239231, 3234.2884565395575, 3235.7573182011206, 3238.6275578308323, 43509.129817403475, 43954.780226098665, 44032.77983610093, 44099.11801763947, 44100.11799764019, 9456.57445414958, 9510.334276600572, 9547.952260238655, 9564.330496865292, 9791.265655075898, 16601.086940218163, 16625.584360391087, 16657.50027499177, 16662.750058749127, 16695.415660451825, 6671.499637527205, 6723.125993620896, 6763.830904227335, 6888.586684798928, 6940.618265995317, 3551.9289614207573, 3572.089117275078, 3576.499290099388, 3610.62088480711, 3660.652238037382, 2833.249188964926, 2839.545672692401, 2847.601335812988, 2861.642294713161, 2874.669413017488, 521.369143336567, 521.9347581552306, 527.6412039812888, 528.1865926473188, 528.9391719952177, 606.8209878085976, 638.9840253993594, 639.86318132897, 640.3756337570924, 648.6270394523168, 7355.632218389059, 7460.664270107858, 7616.466847320745, 7923.564203968837, 8121.0, 488.1579275749375, 598.1506261109236, 606.233115109387, 610.1762620462429, 611.3977731934042, 3543.574771027493, 3560.0, 3578.499010138583, 3697.9630203698157, 3838.1172330363615, 45937.0, 50560.74719626379, 50764.49235507598, 50957.0, 51152.0, 42838.357424638656, 43016.784916075216, 43748.3437748434, 43758.781206094405, 44380.3342949856, 41060.0, 41211.0, 41436.792816035726, 41450.37824432636, 41558.79220603878, 8470.957645211982, 8678.913210867811, 8730.607122679368, 8833.29333653319, 8914.465132092095, 29978.400431991675, 30528.694713053475, 31189.0, 31441.21396965094, 32072.35855282928, 37018.074548136516, 37149.628503714615, 38418.615813841505, 40738.79630601828, 40776.388354174116, 10216.744581385525, 10760.0, 10914.836277455686, 10957.12343012573, 11269.211155219056, 11792.587259445878, 11931.105167112675, 12040.698982525508, 12185.695357615776, 12343.75312493763, 8345.749627511184, 10986.945065274622, 11049.17131215146, 11313.604023859125, 11434.428278586203, 11069.833952490559, 11083.889161108285, 11196.496157673088, 11205.71985700364, 11510.48202830858, 10949.0, 11113.833292500458, 11208.55165793359, 11527.596534121265, 11735.295882247092, 9615.824945992583, 9665.420074795535, 9924.156446701822, 9956.253281003808, 10017.39895606266, 10085.394876307446, 10195.337303075275, 10195.490225488547, 10252.948735256276, 10254.794904102026], "unit": "score", "name": "yui.html", "value": 5919.246169163459}], "name": "dromaeo_css", "value": 6448.123437356175}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 107.0, 111.0, 112.0, 111.0, 103.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [158.0, 133.0, 175.0, 172.0, 138.0, 156.0, 159.0, 132.0, 193.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 155.2}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 162.0, 161.0, 163.0, 163.0, 161.0, 163.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 74.0, 154.0, 74.0, 74.0, 76.0, 74.0, 152.0, 75.0], "unit": "score", "name": "audio-fft", "value": 90.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 147.0, 93.0, 96.0, 95.0, 139.0, 94.0, 95.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.1}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 68.0, 65.0, 63.0, 65.0, 64.0, 74.0, 64.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 66.1}, {"lowerIsBetter": true, "replicates": [64.0, 73.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [87.0, 82.0, 81.0, 83.0, 91.0, 81.0, 81.0, 81.0, 86.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [116.0, 119.0, 116.0, 117.0, 116.0, 120.0, 117.0, 114.0, 117.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.2}, {"lowerIsBetter": true, "replicates": [141.0, 133.0, 147.0, 141.0, 152.0, 130.0, 142.0, 141.0, 141.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 70.0, 68.0, 69.0, 67.0, 65.0, 66.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1525.8}]} 14:11:05 INFO - Return code: 0 14:11:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:11:05 ERROR - # TBPL SUCCESS # 14:11:05 INFO - Running post-action listener: _resource_record_post_action 14:11:05 INFO - Running post-run listener: _resource_record_post_run 14:11:06 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 519909376; Read time: 0; Write time: 372080 14:11:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 233336832; Read time: 0; Write time: 193480 14:11:06 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 286572544; Read time: 0; Write time: 178600 14:11:06 INFO - Running post-run listener: _upload_blobber_files 14:11:06 INFO - Blob upload gear active. 14:11:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:11:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:11:06 INFO - (blobuploader) - INFO - Open directory for files ... 14:11:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:11:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:11:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:07 INFO - (blobuploader) - INFO - Done attempting. 14:11:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:11:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:11:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:08 INFO - (blobuploader) - INFO - Done attempting. 14:11:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:11:08 INFO - Return code: 0 14:11:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:11:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:11:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d3ca31732703ff03e185c642177e1fbdab497009b941cd450932be2f7067c0e96053707b1cf64a63e3f30f6271f18e9a5929464ffbb91b22417276140a88aeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d978e1d5345b50121c2c7d13cf84081e70235ff0743d6e0d07f2c572fe547d6a69cf3f76020d3b185daf37c106fe4bf04d97ab64a4d0b080342013218c4cb37c"} 14:11:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:11:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:11:08 INFO - Contents: 14:11:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d3ca31732703ff03e185c642177e1fbdab497009b941cd450932be2f7067c0e96053707b1cf64a63e3f30f6271f18e9a5929464ffbb91b22417276140a88aeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d978e1d5345b50121c2c7d13cf84081e70235ff0743d6e0d07f2c572fe547d6a69cf3f76020d3b185daf37c106fe4bf04d97ab64a4d0b080342013218c4cb37c"} 14:11:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:11:08 INFO - Copying logs to upload dir... 14:11:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:11:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.839305 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-01 14:11:07.875936) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 14:11:07.879664) ========= 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=6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242 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/8d3ca31732703ff03e185c642177e1fbdab497009b941cd450932be2f7067c0e96053707b1cf64a63e3f30f6271f18e9a5929464ffbb91b22417276140a88aeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d978e1d5345b50121c2c7d13cf84081e70235ff0743d6e0d07f2c572fe547d6a69cf3f76020d3b185daf37c106fe4bf04d97ab64a4d0b080342013218c4cb37c"} build_url:https://queue.taskcluster.net/v1/task/K6F7vQr7QYWYi9AGltRcIA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011221 build_url: 'https://queue.taskcluster.net/v1/task/K6F7vQr7QYWYi9AGltRcIA/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/8d3ca31732703ff03e185c642177e1fbdab497009b941cd450932be2f7067c0e96053707b1cf64a63e3f30f6271f18e9a5929464ffbb91b22417276140a88aeb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d978e1d5345b50121c2c7d13cf84081e70235ff0743d6e0d07f2c572fe547d6a69cf3f76020d3b185daf37c106fe4bf04d97ab64a4d0b080342013218c4cb37c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 14:11:07.904578) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 14:11:07.904913) ========= 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=6d15e502d8e29d5d2676d664000001c3-1459543477.808410-644005242 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 14:11:07.990360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 14:11:07.990765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 14:11:07.991178) ========= ========= Total master_lag: 0.27 =========