builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1459300811.18 results: success (0) buildid: 20160329174740 builduid: 7ca549fe467f48e6b0ce07b9f091c64e revision: 494289c72ba3997183e7b5beaca3e0447ecaf96d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.178025) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.178412) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.178740) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006365 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.204682) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.204951) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.221735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.221983) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.274878) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.275139) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.275467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.275748) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-29 18:20:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-03-29 18:20:12 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142415 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.437895) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.438429) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022507 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:11.497035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 18:20:11.497330) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 494289c72ba3997183e7b5beaca3e0447ecaf96d --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 494289c72ba3997183e7b5beaca3e0447ecaf96d --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=82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-29 18:20:12,166 truncating revision to first 12 chars 2016-03-29 18:20:12,166 Setting DEBUG logging. 2016-03-29 18:20:12,166 attempt 1/10 2016-03-29 18:20:12,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/494289c72ba3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 18:20:13,495 unpacking tar archive at: fx-team-494289c72ba3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.625456 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 18:20:13.136715) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:13.137037) ========= echo 494289c72ba3997183e7b5beaca3e0447ecaf96d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'494289c72ba3997183e7b5beaca3e0447ecaf96d'] 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=82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 494289c72ba3997183e7b5beaca3e0447ecaf96d program finished with exit code 0 elapsedTime=0.004722 script_repo_revision: '494289c72ba3997183e7b5beaca3e0447ecaf96d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:13.187857) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:13.188147) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 18:20:13.197605) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-03-29 18:20:13.197880) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:20:13 INFO - MultiFileLogger online at 20160329 18:20:13 in /builds/slave/test 18:20:13 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 18:20:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:20:13 INFO - {'append_to_log': False, 18:20:13 INFO - 'base_work_dir': '/builds/slave/test', 18:20:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:20:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:20:13 INFO - 'branch': 'Fx-Team-Non-PGO', 18:20:13 INFO - 'buildbot_json_path': 'buildprops.json', 18:20:13 INFO - 'config_files': ('talos/linux_config.py',), 18:20:13 INFO - 'default_actions': ('clobber', 18:20:13 INFO - 'read-buildbot-config', 18:20:13 INFO - 'download-and-extract', 18:20:13 INFO - 'populate-webroot', 18:20:13 INFO - 'create-virtualenv', 18:20:13 INFO - 'install', 18:20:13 INFO - 'run-tests'), 18:20:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:20:13 INFO - 'download_minidump_stackwalk': True, 18:20:13 INFO - 'download_symbols': 'ondemand', 18:20:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:20:13 INFO - 'tooltool.py': '/tools/tooltool.py', 18:20:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:20:13 INFO - '/tools/misc-python/virtualenv.py')}, 18:20:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:20:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:20:13 INFO - 'installer_path': 'installer.exe', 18:20:13 INFO - 'log_level': 'info', 18:20:13 INFO - 'log_name': 'talos', 18:20:13 INFO - 'log_to_console': True, 18:20:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:20:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:20:13 INFO - 'opt_config_files': (), 18:20:13 INFO - 'pip_index': False, 18:20:13 INFO - 'sps_profile': False, 18:20:13 INFO - 'sps_profile_interval': 0, 18:20:13 INFO - 'suite': 'dromaeojs', 18:20:13 INFO - 'system_bits': '32', 18:20:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:20:13 INFO - 'title': 'talos-linux64-ix-066', 18:20:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:20:13 INFO - 'use_talos_json': True, 18:20:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:20:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:20:13 INFO - 'work_dir': 'build'} 18:20:13 INFO - ##### 18:20:13 INFO - ##### Running clobber step. 18:20:13 INFO - ##### 18:20:13 INFO - Running pre-action listener: _resource_record_pre_action 18:20:13 INFO - Running main action method: clobber 18:20:13 INFO - rmtree: /builds/slave/test/build 18:20:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:20:14 INFO - Running post-action listener: _resource_record_post_action 18:20:14 INFO - ##### 18:20:14 INFO - ##### Running read-buildbot-config step. 18:20:14 INFO - ##### 18:20:14 INFO - Running pre-action listener: _resource_record_pre_action 18:20:14 INFO - Running main action method: read_buildbot_config 18:20:14 INFO - Using buildbot properties: 18:20:14 INFO - { 18:20:14 INFO - "project": "", 18:20:14 INFO - "product": "firefox", 18:20:14 INFO - "script_repo_revision": "production", 18:20:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:20:14 INFO - "repository": "", 18:20:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:20:14 INFO - "buildid": "20160329174740", 18:20:14 INFO - "pgo_build": "False", 18:20:14 INFO - "basedir": "/builds/slave/test", 18:20:14 INFO - "buildnumber": 2723, 18:20:14 INFO - "slavename": "talos-linux64-ix-066", 18:20:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:20:14 INFO - "platform": "ubuntu64_hw", 18:20:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:20:14 INFO - "branch": "fx-team", 18:20:14 INFO - "repo_path": "integration/fx-team", 18:20:14 INFO - "revision": "494289c72ba3997183e7b5beaca3e0447ecaf96d", 18:20:14 INFO - "stage_platform": "linux64", 18:20:14 INFO - "builduid": "7ca549fe467f48e6b0ce07b9f091c64e", 18:20:14 INFO - "slavebuilddir": "test" 18:20:14 INFO - } 18:20:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:20:14 INFO - Running post-action listener: _resource_record_post_action 18:20:14 INFO - ##### 18:20:14 INFO - ##### Running download-and-extract step. 18:20:14 INFO - ##### 18:20:14 INFO - Running pre-action listener: _resource_record_pre_action 18:20:14 INFO - Running main action method: download_and_extract 18:20:14 INFO - mkdir: /builds/slave/test/build/tests 18:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:14 INFO - https://queue.taskcluster.net/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:20:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:20:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:20:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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 18:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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 18:20:17 INFO - Downloaded 1361 bytes. 18:20:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:20:17 INFO - Using the following test package requirements: 18:20:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:20:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:20:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:17 INFO - u'jsshell-linux-x86_64.zip'], 18:20:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:20:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:20:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:20:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:20:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:20:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:17 INFO - https://queue.taskcluster.net/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:20:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:20:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:20:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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 18:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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 18:20:18 INFO - Downloaded 22100669 bytes. 18:20:18 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'] 18:20:18 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 18:20:19 INFO - Return code: 0 18:20:19 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 18:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:19 INFO - https://queue.taskcluster.net/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:20:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:20:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:20:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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 18:20:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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 18:20:20 INFO - Downloaded 22100669 bytes. 18:20:20 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'] 18:20:20 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 18:20:21 INFO - Return code: 0 18:20: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')]} 18:20:21 INFO - https://queue.taskcluster.net/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:20:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:20:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:20:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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 18:20:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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 18:20:22 INFO - Downloaded 10847531 bytes. 18:20:22 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'] 18:20:22 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 18:20:23 INFO - Return code: 0 18:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:23 INFO - https://queue.taskcluster.net/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:20:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:20:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:20:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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 18:20:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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 18:20:27 INFO - Downloaded 54252692 bytes. 18:20:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:20:27 INFO - mkdir: /builds/slave/test/properties 18:20:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:20:27 INFO - Writing to file /builds/slave/test/properties/build_url 18:20:27 INFO - Contents: 18:20:27 INFO - build_url:https://queue.taskcluster.net/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:20:27 INFO - Running post-action listener: _resource_record_post_action 18:20:27 INFO - Running post-action listener: set_extra_try_arguments 18:20:27 INFO - ##### 18:20:27 INFO - ##### Running populate-webroot step. 18:20:27 INFO - ##### 18:20:27 INFO - Running pre-action listener: _resource_record_pre_action 18:20:27 INFO - Running main action method: populate_webroot 18:20:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:20:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:20:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:20:28 INFO - '--tppagecycles', 18:20:28 INFO - '7'], 18:20:28 INFO - 'tests': ['tsvgm']}}, 18:20:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:20:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:20:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:20:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:20:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:20:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:20:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:28 INFO - 'talos_options': ['--e10s'], 18:20:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:28 INFO - 'tests': ['damp', 'tps']}, 18:20:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:28 INFO - 'talos_options': ['--e10s'], 18:20:28 INFO - 'tests': ['damp', 'tps']}, 18:20:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:20:28 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 18:20:28 INFO - 'tests': ['dromaeo_dom']}, 18:20:28 INFO - 'other': {'tests': ['a11yr', 18:20:28 INFO - 'ts_paint', 18:20:28 INFO - 'tpaint', 18:20:28 INFO - 'sessionrestore', 18:20:28 INFO - 'sessionrestore_no_auto_restore', 18:20:28 INFO - 'tabpaint']}, 18:20:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:20:28 INFO - 'tests': ['a11yr', 18:20:28 INFO - 'ts_paint', 18:20:28 INFO - 'tpaint', 18:20:28 INFO - 'sessionrestore', 18:20:28 INFO - 'sessionrestore_no_auto_restore', 18:20:28 INFO - 'tabpaint']}, 18:20:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:20:28 INFO - 'tests': ['a11yr', 18:20:28 INFO - 'ts_paint', 18:20:28 INFO - 'tpaint', 18:20:28 INFO - 'sessionrestore', 18:20:28 INFO - 'sessionrestore_no_auto_restore', 18:20:28 INFO - 'tabpaint']}, 18:20:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:20:28 INFO - 'tests': ['a11yr', 18:20:28 INFO - 'ts_paint', 18:20:28 INFO - 'tpaint', 18:20:28 INFO - 'sessionrestore', 18:20:28 INFO - 'sessionrestore_no_auto_restore', 18:20:28 INFO - 'tabpaint']}, 18:20:28 INFO - 'other_l64': {'tests': ['a11yr', 18:20:28 INFO - 'ts_paint', 18:20:28 INFO - 'tpaint', 18:20:28 INFO - 'sessionrestore', 18:20:28 INFO - 'sessionrestore_no_auto_restore', 18:20:28 INFO - 'tabpaint']}, 18:20:28 INFO - 'other_nol64': {'tests': ['a11yr', 18:20:28 INFO - 'ts_paint', 18:20:28 INFO - 'tpaint', 18:20:28 INFO - 'sessionrestore', 18:20:28 INFO - 'sessionrestore_no_auto_restore', 18:20:28 INFO - 'tabpaint']}, 18:20:28 INFO - 'svgr': {'tests': ['tsvgx', 18:20:28 INFO - 'tsvgr_opacity', 18:20:28 INFO - 'tart', 18:20:28 INFO - 'tscrollx', 18:20:28 INFO - 'cart']}, 18:20:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:20:28 INFO - 'tests': ['tsvgx', 18:20:28 INFO - 'tsvgr_opacity', 18:20:28 INFO - 'tart', 18:20:28 INFO - 'tscrollx', 18:20:28 INFO - 'cart']}, 18:20:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:28 INFO - 'tests': ['tp5o']}, 18:20:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:28 INFO - 'talos_options': ['--e10s'], 18:20:28 INFO - 'tests': ['tp5o']}, 18:20:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:28 INFO - 'talos_options': ['--xperf_path', 18:20:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:28 INFO - 'tests': ['tp5n']}, 18:20:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:20:28 INFO - 'talos_options': ['--e10s', 18:20:28 INFO - '--xperf_path', 18:20:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:28 INFO - 'tests': ['tp5n']}}, 18:20:28 INFO - 'talos.zip': {'path': '', 18:20:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:20:28 INFO - Running post-action listener: _resource_record_post_action 18:20:28 INFO - ##### 18:20:28 INFO - ##### Running create-virtualenv step. 18:20:28 INFO - ##### 18:20:28 INFO - Running pre-action listener: _resource_record_pre_action 18:20:28 INFO - Running main action method: create_virtualenv 18:20:28 INFO - Creating virtualenv /builds/slave/test/build/venv 18:20:28 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 18:20:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:20:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:20:28 INFO - Using real prefix '/usr' 18:20:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:20:28 INFO - Installing distribute.............................................................................................................................................................................................done. 18:20:30 INFO - Installing pip.................done. 18:20:30 INFO - Return code: 0 18:20:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:20:30 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')]} 18:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:30 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')]} 18:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:30 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 0x7fa5ad7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16475a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6410>, '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 0x16d7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d77a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', '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 18:20:30 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 18:20:30 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 18:20:30 INFO - Using env: {'DISPLAY': ':0', 18:20:30 INFO - 'HOME': '/home/cltbld', 18:20:30 INFO - 'LANG': 'en_US.UTF-8', 18:20:30 INFO - 'LANGUAGE': 'en_US:en', 18:20:30 INFO - 'LOGNAME': 'cltbld', 18:20:30 INFO - 'MAIL': '/var/mail/cltbld', 18:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:30 INFO - 'MOZ_NO_REMOTE': '1', 18:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:30 INFO - 'NO_EM_RESTART': '1', 18:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:30 INFO - 'PWD': '/builds/slave/test', 18:20:30 INFO - 'SHELL': '/bin/bash', 18:20:30 INFO - 'SHLVL': '1', 18:20:30 INFO - 'TERM': 'linux', 18:20:30 INFO - 'TMOUT': '86400', 18:20:30 INFO - 'USER': 'cltbld', 18:20:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', 18:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:30 INFO - '_': '/tools/buildbot/bin/python'} 18:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:30 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 18:20:30 INFO - Cleaning up... 18:20:30 INFO - Return code: 0 18:20:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:20:30 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')]} 18:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:30 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')]} 18:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:30 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 0x7fa5ad7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16475a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6410>, '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 0x16d7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d77a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', '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 18:20:30 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 18:20:30 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 18:20:30 INFO - Using env: {'DISPLAY': ':0', 18:20:30 INFO - 'HOME': '/home/cltbld', 18:20:30 INFO - 'LANG': 'en_US.UTF-8', 18:20:30 INFO - 'LANGUAGE': 'en_US:en', 18:20:30 INFO - 'LOGNAME': 'cltbld', 18:20:30 INFO - 'MAIL': '/var/mail/cltbld', 18:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:30 INFO - 'MOZ_NO_REMOTE': '1', 18:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:30 INFO - 'NO_EM_RESTART': '1', 18:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:30 INFO - 'PWD': '/builds/slave/test', 18:20:30 INFO - 'SHELL': '/bin/bash', 18:20:30 INFO - 'SHLVL': '1', 18:20:30 INFO - 'TERM': 'linux', 18:20:30 INFO - 'TMOUT': '86400', 18:20:30 INFO - 'USER': 'cltbld', 18:20:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', 18:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:30 INFO - '_': '/tools/buildbot/bin/python'} 18:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:30 INFO - Downloading/unpacking psutil>=0.7.1 18:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:20:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:32 INFO - Installing collected packages: psutil 18:20:32 INFO - Running setup.py install for psutil 18:20:33 INFO - building 'psutil._psutil_linux' extension 18:20:33 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 18:20:33 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 18:20:33 INFO - building 'psutil._psutil_posix' extension 18:20:33 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 18:20:33 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 18:20:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:33 INFO - Successfully installed psutil 18:20:33 INFO - Cleaning up... 18:20:33 INFO - Return code: 0 18:20:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa5ad7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16475a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6410>, '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 0x16d7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d77a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', '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 18:20:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:20:33 INFO - Using env: {'DISPLAY': ':0', 18:20:33 INFO - 'HOME': '/home/cltbld', 18:20:33 INFO - 'LANG': 'en_US.UTF-8', 18:20:33 INFO - 'LANGUAGE': 'en_US:en', 18:20:33 INFO - 'LOGNAME': 'cltbld', 18:20:33 INFO - 'MAIL': '/var/mail/cltbld', 18:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:33 INFO - 'MOZ_NO_REMOTE': '1', 18:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:33 INFO - 'NO_EM_RESTART': '1', 18:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:33 INFO - 'PWD': '/builds/slave/test', 18:20:33 INFO - 'SHELL': '/bin/bash', 18:20:33 INFO - 'SHLVL': '1', 18:20:33 INFO - 'TERM': 'linux', 18:20:33 INFO - 'TMOUT': '86400', 18:20:33 INFO - 'USER': 'cltbld', 18:20:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', 18:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:33 INFO - '_': '/tools/buildbot/bin/python'} 18:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:20:33 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 18:20:33 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 18:20:33 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 18:20:33 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 18:20:33 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 18:20:33 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 18:20:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:20:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:20:35 INFO - Installing collected packages: mozsystemmonitor 18:20:35 INFO - Running setup.py install for mozsystemmonitor 18:20:35 INFO - Successfully installed mozsystemmonitor 18:20:35 INFO - Cleaning up... 18:20:35 INFO - Return code: 0 18:20:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:35 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 0x7fa5ad7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16475a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6410>, '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 0x16d7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d77a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', '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 18:20:35 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 18:20:35 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 18:20:35 INFO - Using env: {'DISPLAY': ':0', 18:20:35 INFO - 'HOME': '/home/cltbld', 18:20:35 INFO - 'LANG': 'en_US.UTF-8', 18:20:35 INFO - 'LANGUAGE': 'en_US:en', 18:20:35 INFO - 'LOGNAME': 'cltbld', 18:20:35 INFO - 'MAIL': '/var/mail/cltbld', 18:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:35 INFO - 'MOZ_NO_REMOTE': '1', 18:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:35 INFO - 'NO_EM_RESTART': '1', 18:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:35 INFO - 'PWD': '/builds/slave/test', 18:20:35 INFO - 'SHELL': '/bin/bash', 18:20:35 INFO - 'SHLVL': '1', 18:20:35 INFO - 'TERM': 'linux', 18:20:35 INFO - 'TMOUT': '86400', 18:20:35 INFO - 'USER': 'cltbld', 18:20:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', 18:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:35 INFO - '_': '/tools/buildbot/bin/python'} 18:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:35 INFO - Downloading/unpacking blobuploader==1.2.4 18:20:35 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 18:20:35 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 18:20:35 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 18:20:35 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 18:20:35 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 18:20:35 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 18:20:37 INFO - Downloading blobuploader-1.2.4.tar.gz 18:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:20:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:20:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:20:38 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 18:20:38 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 18:20:38 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 18:20:38 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 18:20:38 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 18:20:38 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 18:20:38 INFO - Downloading docopt-0.6.1.tar.gz 18:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:20:38 INFO - Installing collected packages: blobuploader, requests, docopt 18:20:38 INFO - Running setup.py install for blobuploader 18:20:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:20:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:20:38 INFO - Running setup.py install for requests 18:20:38 INFO - Running setup.py install for docopt 18:20:39 INFO - Successfully installed blobuploader requests docopt 18:20:39 INFO - Cleaning up... 18:20:39 INFO - Return code: 0 18:20:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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')]} 18:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:39 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 0x7fa5ad7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16475a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6410>, '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 0x16d7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d77a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', '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 18:20:39 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 18:20:39 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 18:20:39 INFO - Using env: {'DISPLAY': ':0', 18:20:39 INFO - 'HOME': '/home/cltbld', 18:20:39 INFO - 'LANG': 'en_US.UTF-8', 18:20:39 INFO - 'LANGUAGE': 'en_US:en', 18:20:39 INFO - 'LOGNAME': 'cltbld', 18:20:39 INFO - 'MAIL': '/var/mail/cltbld', 18:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:39 INFO - 'MOZ_NO_REMOTE': '1', 18:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:39 INFO - 'NO_EM_RESTART': '1', 18:20:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:39 INFO - 'PWD': '/builds/slave/test', 18:20:39 INFO - 'SHELL': '/bin/bash', 18:20:39 INFO - 'SHLVL': '1', 18:20:39 INFO - 'TERM': 'linux', 18:20:39 INFO - 'TMOUT': '86400', 18:20:39 INFO - 'USER': 'cltbld', 18:20:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', 18:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:39 INFO - '_': '/tools/buildbot/bin/python'} 18:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:39 INFO - Running setup.py (path:/tmp/pip-SP2jXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:39 INFO - Running setup.py (path:/tmp/pip-GsW1VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:39 INFO - Running setup.py (path:/tmp/pip-rKEdqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:39 INFO - Running setup.py (path:/tmp/pip-vldRhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:39 INFO - Running setup.py (path:/tmp/pip-gkqJQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:39 INFO - Running setup.py (path:/tmp/pip-L6S5K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:39 INFO - Running setup.py (path:/tmp/pip-_Ezljc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:39 INFO - Running setup.py (path:/tmp/pip-tWQbDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:39 INFO - Running setup.py (path:/tmp/pip-BCWzbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:40 INFO - Running setup.py (path:/tmp/pip-Jhcwrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:40 INFO - Running setup.py (path:/tmp/pip-Q19kgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:40 INFO - Running setup.py (path:/tmp/pip-4lylg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:40 INFO - Running setup.py (path:/tmp/pip-uicCvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:40 INFO - Running setup.py (path:/tmp/pip-PGBozh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:40 INFO - Running setup.py (path:/tmp/pip-ljiNvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:40 INFO - Running setup.py (path:/tmp/pip-5up2KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:40 INFO - Running setup.py (path:/tmp/pip-nkbJj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:20:40 INFO - Running setup.py install for manifestparser 18:20:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:20:40 INFO - Running setup.py install for mozcrash 18:20:40 INFO - Running setup.py install for mozdebug 18:20:40 INFO - Running setup.py install for mozdevice 18:20:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Running setup.py install for mozfile 18:20:41 INFO - Running setup.py install for mozhttpd 18:20:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Running setup.py install for mozinfo 18:20:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Running setup.py install for mozInstall 18:20:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Running setup.py install for mozleak 18:20:41 INFO - Running setup.py install for mozlog 18:20:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Running setup.py install for moznetwork 18:20:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Running setup.py install for mozprocess 18:20:41 INFO - Running setup.py install for mozprofile 18:20:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:20:41 INFO - Running setup.py install for mozrunner 18:20:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:20:42 INFO - Running setup.py install for mozscreenshot 18:20:42 INFO - Running setup.py install for moztest 18:20:42 INFO - Running setup.py install for mozversion 18:20:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:20:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:20:42 INFO - Cleaning up... 18:20:42 INFO - Return code: 0 18:20:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:42 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 0x7fa5ad7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16475a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6410>, '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 0x16d7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d77a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', '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 18:20:42 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 18:20:42 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 18:20:42 INFO - Using env: {'DISPLAY': ':0', 18:20:42 INFO - 'HOME': '/home/cltbld', 18:20:42 INFO - 'LANG': 'en_US.UTF-8', 18:20:42 INFO - 'LANGUAGE': 'en_US:en', 18:20:42 INFO - 'LOGNAME': 'cltbld', 18:20:42 INFO - 'MAIL': '/var/mail/cltbld', 18:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:42 INFO - 'MOZ_NO_REMOTE': '1', 18:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:42 INFO - 'NO_EM_RESTART': '1', 18:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:42 INFO - 'PWD': '/builds/slave/test', 18:20:42 INFO - 'SHELL': '/bin/bash', 18:20:42 INFO - 'SHLVL': '1', 18:20:42 INFO - 'TERM': 'linux', 18:20:42 INFO - 'TMOUT': '86400', 18:20:42 INFO - 'USER': 'cltbld', 18:20:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', 18:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:42 INFO - '_': '/tools/buildbot/bin/python'} 18:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:42 INFO - Running setup.py (path:/tmp/pip-A_NZLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:42 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)) 18:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:42 INFO - Running setup.py (path:/tmp/pip-oHZCp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:42 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)) 18:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:42 INFO - Running setup.py (path:/tmp/pip-VREZ3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:42 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)) 18:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:42 INFO - Running setup.py (path:/tmp/pip-Sh9c5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:42 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)) 18:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:42 INFO - Running setup.py (path:/tmp/pip-G_b3aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:42 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)) 18:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:42 INFO - Running setup.py (path:/tmp/pip-HOBu2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:43 INFO - Running setup.py (path:/tmp/pip-VY_CyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:43 INFO - Running setup.py (path:/tmp/pip-xwnwBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:43 INFO - Running setup.py (path:/tmp/pip-CYC4IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:43 INFO - Running setup.py (path:/tmp/pip-7EnUzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:43 INFO - Running setup.py (path:/tmp/pip-CP_Wzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:43 INFO - Running setup.py (path:/tmp/pip-kD2fcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:43 INFO - Running setup.py (path:/tmp/pip-WY8HZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:43 INFO - Running setup.py (path:/tmp/pip-w04EgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:43 INFO - Running setup.py (path:/tmp/pip-sMJx4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:43 INFO - Running setup.py (path:/tmp/pip-tuxF97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:43 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)) 18:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:43 INFO - Running setup.py (path:/tmp/pip-YdFRxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:43 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)) 18:20:43 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)) 18:20:43 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)) 18:20:43 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)) 18:20:43 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)) 18:20:43 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)) 18:20:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:20:43 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 18:20:43 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 18:20:43 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 18:20:43 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 18:20:43 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 18:20:43 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 18:20:45 INFO - Downloading blessings-1.6.tar.gz 18:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:20:45 INFO - Installing collected packages: blessings 18:20:45 INFO - Running setup.py install for blessings 18:20:45 INFO - Successfully installed blessings 18:20:45 INFO - Cleaning up... 18:20:46 INFO - Return code: 0 18:20:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:20:46 INFO - Reading from file tmpfile_stdout 18:20:46 INFO - Current package versions: 18:20:46 INFO - argparse == 1.2.1 18:20:46 INFO - blessings == 1.6 18:20:46 INFO - blobuploader == 1.2.4 18:20:46 INFO - docopt == 0.6.1 18:20:46 INFO - manifestparser == 1.1 18:20:46 INFO - mozInstall == 1.12 18:20:46 INFO - mozcrash == 0.17 18:20:46 INFO - mozdebug == 0.1 18:20:46 INFO - mozdevice == 0.48 18:20:46 INFO - mozfile == 1.2 18:20:46 INFO - mozhttpd == 0.7 18:20:46 INFO - mozinfo == 0.9 18:20:46 INFO - mozleak == 0.1 18:20:46 INFO - mozlog == 3.1 18:20:46 INFO - moznetwork == 0.27 18:20:46 INFO - mozprocess == 0.22 18:20:46 INFO - mozprofile == 0.28 18:20:46 INFO - mozrunner == 6.11 18:20:46 INFO - mozscreenshot == 0.1 18:20:46 INFO - mozsystemmonitor == 0.0 18:20:46 INFO - moztest == 0.7 18:20:46 INFO - mozversion == 1.4 18:20:46 INFO - psutil == 3.1.1 18:20:46 INFO - requests == 1.2.3 18:20:46 INFO - wsgiref == 0.1.2 18:20:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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')]} 18:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:46 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 0x7fa5ad7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16475a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6410>, '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 0x16d7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d77a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', '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 18:20:46 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 18:20:46 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 18:20:46 INFO - Using env: {'DISPLAY': ':0', 18:20:46 INFO - 'HOME': '/home/cltbld', 18:20:46 INFO - 'LANG': 'en_US.UTF-8', 18:20:46 INFO - 'LANGUAGE': 'en_US:en', 18:20:46 INFO - 'LOGNAME': 'cltbld', 18:20:46 INFO - 'MAIL': '/var/mail/cltbld', 18:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:46 INFO - 'MOZ_NO_REMOTE': '1', 18:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:46 INFO - 'NO_EM_RESTART': '1', 18:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:46 INFO - 'PWD': '/builds/slave/test', 18:20:46 INFO - 'SHELL': '/bin/bash', 18:20:46 INFO - 'SHLVL': '1', 18:20:46 INFO - 'TERM': 'linux', 18:20:46 INFO - 'TMOUT': '86400', 18:20:46 INFO - 'USER': 'cltbld', 18:20:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', 18:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:46 INFO - '_': '/tools/buildbot/bin/python'} 18:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:46 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)) 18:20:46 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)) 18:20:46 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)) 18:20:46 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)) 18:20:46 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)) 18:20:46 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)) 18:20:46 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)) 18:20:46 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)) 18:20:46 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)) 18:20:46 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)) 18:20:46 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)) 18:20:46 INFO - Cleaning up... 18:20:46 INFO - Return code: 0 18:20:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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')]} 18:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5ad7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16475a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6410>, '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 0x16d7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d77a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', '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 18:20: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', 'jsonschema'] in /builds/slave/test/build 18:20: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 jsonschema 18:20:46 INFO - Using env: {'DISPLAY': ':0', 18:20:46 INFO - 'HOME': '/home/cltbld', 18:20:46 INFO - 'LANG': 'en_US.UTF-8', 18:20:46 INFO - 'LANGUAGE': 'en_US:en', 18:20:46 INFO - 'LOGNAME': 'cltbld', 18:20:46 INFO - 'MAIL': '/var/mail/cltbld', 18:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:46 INFO - 'MOZ_NO_REMOTE': '1', 18:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:46 INFO - 'NO_EM_RESTART': '1', 18:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:46 INFO - 'PWD': '/builds/slave/test', 18:20:46 INFO - 'SHELL': '/bin/bash', 18:20:46 INFO - 'SHLVL': '1', 18:20:46 INFO - 'TERM': 'linux', 18:20:46 INFO - 'TMOUT': '86400', 18:20:46 INFO - 'USER': 'cltbld', 18:20:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', 18:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:46 INFO - '_': '/tools/buildbot/bin/python'} 18:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:46 INFO - Downloading/unpacking jsonschema 18:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:20:48 INFO - Downloading/unpacking functools32 (from jsonschema) 18:20:48 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 18:20:48 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 18:20:48 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 18:20:48 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 18:20:48 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 18:20:48 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 18:20:48 INFO - Downloading functools32-3.2.3-2.tar.gz 18:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:20:48 INFO - warning: no files found matching '*.txt' 18:20:48 INFO - no previously-included directories found matching 'build' 18:20:48 INFO - no previously-included directories found matching 'dist' 18:20:48 INFO - no previously-included directories found matching '.git*' 18:20:48 INFO - Installing collected packages: jsonschema, functools32 18:20:48 INFO - Running setup.py install for functools32 18:20:48 INFO - warning: no files found matching '*.txt' 18:20:48 INFO - no previously-included directories found matching 'build' 18:20:48 INFO - no previously-included directories found matching 'dist' 18:20:48 INFO - no previously-included directories found matching '.git*' 18:20:48 INFO - Successfully installed jsonschema functools32 18:20:48 INFO - Cleaning up... 18:20:49 INFO - Return code: 0 18:20:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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')]} 18:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5ad7c1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16475a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d6410>, '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 0x16d7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d77a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', '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 18:20: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', 'flake8'] in /builds/slave/test/build 18:20: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 flake8 18:20:49 INFO - Using env: {'DISPLAY': ':0', 18:20:49 INFO - 'HOME': '/home/cltbld', 18:20:49 INFO - 'LANG': 'en_US.UTF-8', 18:20:49 INFO - 'LANGUAGE': 'en_US:en', 18:20:49 INFO - 'LOGNAME': 'cltbld', 18:20:49 INFO - 'MAIL': '/var/mail/cltbld', 18:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:49 INFO - 'MOZ_NO_REMOTE': '1', 18:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:49 INFO - 'NO_EM_RESTART': '1', 18:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:49 INFO - 'PWD': '/builds/slave/test', 18:20:49 INFO - 'SHELL': '/bin/bash', 18:20:49 INFO - 'SHLVL': '1', 18:20:49 INFO - 'TERM': 'linux', 18:20:49 INFO - 'TMOUT': '86400', 18:20:49 INFO - 'USER': 'cltbld', 18:20:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', 18:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:49 INFO - '_': '/tools/buildbot/bin/python'} 18:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:49 INFO - Downloading/unpacking flake8 18:20: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 18:20: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 18:20: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 18:20: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 18:20: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 18:20: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 18:20:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:20:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:20:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 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 18:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:20:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:20:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:20:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:20:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:20:51 INFO - no previously-included directories found matching 'docs/_build' 18:20:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:20:51 INFO - Running setup.py install for pep8 18:20:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:20:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:20:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:20:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:20:51 INFO - no previously-included directories found matching 'docs/_build' 18:20:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:20:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:20:51 INFO - Cleaning up... 18:20:52 INFO - Return code: 0 18:20:52 INFO - Running post-action listener: _resource_record_post_action 18:20:52 INFO - Running post-action listener: _start_resource_monitoring 18:20:52 INFO - Starting resource monitoring. 18:20:52 INFO - ##### 18:20:52 INFO - ##### Running install step. 18:20:52 INFO - ##### 18:20:52 INFO - Running pre-action listener: _resource_record_pre_action 18:20:52 INFO - Running main action method: install 18:20:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:20:54 INFO - Reading from file tmpfile_stdout 18:20:54 INFO - Detecting whether we're running mozinstall >=1.0... 18:20:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:20:54 INFO - Reading from file tmpfile_stdout 18:20:54 INFO - Output received: 18:20:54 INFO - Usage: mozinstall [options] installer 18:20:54 INFO - Options: 18:20:54 INFO - -h, --help show this help message and exit 18:20:54 INFO - -d DEST, --destination=DEST 18:20:54 INFO - Directory to install application into. [default: 18:20:54 INFO - "/builds/slave/test"] 18:20:54 INFO - --app=APP Application being installed. [default: firefox] 18:20:54 INFO - mkdir: /builds/slave/test/build/application 18:20:54 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'] 18:20:54 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 18:21:10 INFO - Reading from file tmpfile_stdout 18:21:10 INFO - Output received: 18:21:10 INFO - /builds/slave/test/build/application/firefox/firefox 18:21:10 INFO - Running post-action listener: _resource_record_post_action 18:21:10 INFO - ##### 18:21:10 INFO - ##### Running run-tests step. 18:21:10 INFO - ##### 18:21:10 INFO - Running pre-action listener: _resource_record_pre_action 18:21:10 INFO - Running main action method: run_tests 18:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:21:10 INFO - Python 2.7.3 18:21:10 INFO - Return code: 0 18:21:10 INFO - grabbing minidump binary from tooltool 18:21:10 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')]} 18:21:10 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 0x16d6410>, '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 0x16d7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:21:10 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 18:21:10 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 18:21:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:21:10 INFO - Return code: 0 18:21:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:21:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:21:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:21:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:21:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:21:11 INFO - Return code: 0 18:21:11 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/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 18:21:11 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/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 18:21:11 INFO - Using env: {'DISPLAY': ':0', 18:21:11 INFO - 'HOME': '/home/cltbld', 18:21:11 INFO - 'LANG': 'en_US.UTF-8', 18:21:11 INFO - 'LANGUAGE': 'en_US:en', 18:21:11 INFO - 'LOGNAME': 'cltbld', 18:21:11 INFO - 'MAIL': '/var/mail/cltbld', 18:21:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:21:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:11 INFO - 'MOZ_NO_REMOTE': '1', 18:21:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:11 INFO - 'NO_EM_RESTART': '1', 18:21:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:11 INFO - 'PWD': '/builds/slave/test', 18:21:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:21:11 INFO - 'SHELL': '/bin/bash', 18:21:11 INFO - 'SHLVL': '1', 18:21:11 INFO - 'TERM': 'linux', 18:21:11 INFO - 'TMOUT': '86400', 18:21:11 INFO - 'USER': 'cltbld', 18:21:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201', 18:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:11 INFO - '_': '/tools/buildbot/bin/python'} 18:21:11 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/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 18:21:11 INFO - mozversion application_buildid: 20160329174740 18:21:11 INFO - mozversion application_changeset: 494289c72ba3997183e7b5beaca3e0447ecaf96d 18:21:11 INFO - mozversion application_display_name: Nightly 18:21:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:21:11 INFO - mozversion application_name: Firefox 18:21:11 INFO - mozversion application_remotingname: firefox 18:21:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:21:11 INFO - mozversion application_vendor: Mozilla 18:21:11 INFO - mozversion application_version: 48.0a1 18:21:11 INFO - mozversion platform_buildid: 20160329174740 18:21:11 INFO - mozversion platform_changeset: 494289c72ba3997183e7b5beaca3e0447ecaf96d 18:21:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:21:11 INFO - mozversion platform_version: 48.0a1 18:21:11 INFO - using testdate: 1459300871 18:21:11 INFO - actual date: 1459300871 18:21:11 INFO - starting webserver on 'localhost:45968' 18:21:11 INFO - SUITE-START | Running 2 tests 18:21:11 INFO - TEST-START | dromaeo_css 18:21:11 INFO - operating with platform_type : linux_ 18:21:11 INFO - Initialising browser for dromaeo_css test... 18:21:11 INFO - TEST-INFO | started process 6283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplwqKAB/profile http://localhost:45968/getInfo.html) 18:21:15 INFO - PROCESS | 6283 | __metrics Screen width/height:1600/1200 18:21:15 INFO - PROCESS | 6283 | colorDepth:24 18:21:15 INFO - PROCESS | 6283 | Browser inner width/height: 1024/697 18:21:15 INFO - PROCESS | 6283 | __metrics 18:21:16 ERROR - PROCESS | 6283 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:21:17 INFO - PROCESS | 6283 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 18:21:17 INFO - TEST-INFO | 6283: exit 0 18:21:17 INFO - Browser initialized. 18:21:17 INFO - Running cycle 1/1 for dromaeo_css test... 18:21:17 INFO - TEST-INFO | started process 6376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplwqKAB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:21:29 INFO - PROCESS | 6376 | RSS: Main: 154738688 18:21:29 INFO - PROCESS | 6376 | 18:22:20 INFO - PROCESS | 6376 | 1459300940622 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] 18:24:32 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:45968/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45968/tests/dromaeo/cssquery-ext.html) 18:24:33 INFO - PROCESS | 6376 | RSS: Main: 243286016 18:24:33 INFO - PROCESS | 6376 | 18:27:35 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:45968/tests/dromaeo/cssquery-ext.html (next: http://localhost:45968/tests/dromaeo/cssquery-jquery.html) 18:27:36 INFO - PROCESS | 6376 | RSS: Main: 238002176 18:27:36 INFO - PROCESS | 6376 | 18:30:38 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:45968/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45968/tests/dromaeo/cssquery-mootools.html) 18:30:39 INFO - PROCESS | 6376 | RSS: Main: 242987008 18:30:39 INFO - PROCESS | 6376 | 18:33:41 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:45968/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45968/tests/dromaeo/cssquery-prototype.html) 18:33:41 INFO - PROCESS | 6376 | RSS: Main: 211550208 18:33:41 INFO - PROCESS | 6376 | 18:36:44 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:45968/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45968/tests/dromaeo/cssquery-yui.html) 18:36:44 INFO - PROCESS | 6376 | RSS: Main: 200560640 18:36:44 INFO - PROCESS | 6376 | 18:39:47 INFO - PROCESS | 6376 | Cycle 1(1): loaded http://localhost:45968/tests/dromaeo/cssquery-yui.html (next: http://localhost:45968/tests/dromaeo/cssquery-dojo.html) 18:39:47 INFO - PROCESS | 6376 | RSS: Main: 270606336 18:39:47 INFO - PROCESS | 6376 | 18:39:47 INFO - PROCESS | 6376 | __start_tp_report 18:39:47 INFO - PROCESS | 6376 | _x_x_mozilla_page_load 18:39:47 INFO - PROCESS | 6376 | _x_x_mozilla_page_load_details 18:39:47 INFO - PROCESS | 6376 | |i|pagename|runs| 18:39:47 INFO - PROCESS | 6376 | |0;dojo.html;2578.149210760449;2632.118240389468;2639.3929396238855;2652.4032092779116;2667.66654168229;4454.710443821149;4537.568930951558;4539.523350048247;4540.2508586083295;4554.521775213605;4637.443506779183;4673.088747694201;4701.929471057937;4711.8586442406695;4723.527647235274;4200.957990420087;4255.5318914919335;4277.957220427803;4298.613124818758;4352.086061926999;4209.3054645983375;4340.045190058182;4388.5830846069575;4404.735715857043;4434.955650443502;4185.037441388497;4265.232258193524;4322.44392018873;4335.848245311399;4420.0496893167965;4247.575242475758;4265.658747300239;4278.44380230568;4278.935815962763;4280.486341638992;4243.766592837393;4250.341197114452;4250.362445633149;4253.553376895444;4257.574242575749;4474.306482495186;4495.752733599651;4523.615492683126;4558.179527685015;4577.176108300505;4936.555709986083;4977.278294647292;4978.626603004789;4980.427250866124;5027.49725027498;4858.635602329804;4978.377702787152;4991.550760431543;5006.2740902569285;5008.549230569266;4592.15045216636;4630.282306242538;4631.884202894955;4671.229247174212;4677;5060.3927528696795;5077.644564880497;5109.770060347293;5117.181250999822;5162.406323272797;4808.831690890802;4830.178869592178;4906.509349065136;4915.975420122876;4917.950820491821;4998.775055122528;5018.2974383586325;5020.874478138076;5032.672876263031;5066.06277838601;4954.777035033432;4974;4975.601951843843;4976.90046199074;5020.523050310215;4746.1456937750845;4832.202686556749;4836.806527738921;4939.431965324034;5002.874928126826;4166.625003749617;4169.499660040815;4181.393697913846;4181.937270940938;4185.267578173807;3706.221693444353;3735.533058367704;3738.3831667775057;3739.121306492972;3740.4763333133383;4298.78506074695;4302.65578753699;4375.562443755599;4381.277089280296;4385.693001489865;4875.926861097087;4917.5328343808;4926.014797040606;4930.605551555867;4975.4527002029745;4279.33670281107;4282.743035417885;4286.207051695384;4286.742795432284;4329.502107257706;4324.3513472978675;4454.554544545519;4509.977450112729;4530.478994915627;4554.339620754972;4735.171345014677;4769.42766867978;4779.091972525209;4781.426228852491;4822.831200908022;4873.634477414137;4985.675931064469;4988.351514303117;4993.525615066563;5046.243063540498;4726.621870250303;4764.309175169512;4768.928466073081;4792.329073929723;4818.036392721399;4868.975655121843;4916.557509824133;4917.28699338601;4927.704337739747;4968.627352948471;4804.2073057945045;4853.611711063036;4975.402951645826;4991.925121123259;5048.899022019613;4842.5157484251295;4844.781984810763;4857.562819346276;4869.853904382874;4908.386451693538;4857.222844344888;4860.465348811557;4862.732549709658;4865.537773911473;4901.166801643801;4647.697899636512;4703.270992996091;4785.042991401664;4805.639577031667;4832.057748738962;4778.832740854054;4796.56830885222;4802.231642937113;4804.759762011955;4846.224604063474;4700.153972285021;4705.882352941204;4719.622430205507;4721.291806229093;4757.524247575215 18:39:47 INFO - PROCESS | 6376 | |1;ext.html;514.3365059073794;516.0659206835628;520.6225486522269;537.8870437208186;551.3383939272873;27054.188374348752;35026.474602880946;35424.468632970464;35463;35471.290574188504;38644.806775966084;39152.21695566087;39159.41260881082;39161.41257881134;39180;7317;7715.228477152268;7906.6442010109395;7909.209079092074;9680.75798105046;9786.41281523111;9933.354331968436;9937.900620993805;9942.204623630128;9948.900510994907;9925.957774433653;10008.649697260596;10015.198784097254;10032.347897386646;10052.14556762676;9854.063863932915;9933.3543319684;9946.403215807075;9951.8507222391;9967.152792012688;9813.509324533745;9886.802263954753;9952.154066904322;9959.253056020827;10205.540750666238;37501.62498375009;37924;37969.62030379689;37974;37995.24009519794;3067.2791893904914;3081.876724931;3093.6287645482685;3123.984704970871;3172.936541269185;28830.423391532262;28926;29753.107406777614;29800.552991705143;30306;3475;3503.702185314226;3570.590789532795;3606.1525541497726;3639.1266096137;192412;192537;192832;193184;193814.9999999986;53890.46109538933;53914;54292.72853635706;54300.45699543033;54347.72826135923;57573.71213143991;63463.682681586295;64209;64517;64642.35357646457;14162.929185354213;14922.104673719612;15069;15116.470923517623;15133.729940508792;10476.68569942903;10833.241673082966;10853.403062831461;10855.348679079123;10856.240063195659;19453.708194377097;19498.12258448373;19909.502262443555;20296.797032029786;20327.4918127048;7123.2520585338825;7123.287671232835;7195.13658361;7317.890231646529;7328.251905535424;855.9914400856036;863.9481631102154;869.9652013919373;888.4891187567175;923.9122283383068;24137.275881723577;25218.621720674204;25257.368565785633;25344.746552534238;25423;919.3518569408551;946.1815529566875;992.8858181309242;1023.7952409518126;1048.2138396202847;13318.733625327439;13667.931660341834;13817.447302108005;13891.652708682364;13921.234332111628;354455.82176713157;359606;361550;361715;362504;49222;50163;50261.74869125631;50271;50273.24590131078;1131.2929419113054;1188.1148544334526;1196.126827415991;1211.9333436660893;1243.3348158735034;24871.37821554403;26042.86978565095;26265.4746905057;26446.471070578864;26624.733752662225;36805.63194368022;36965.260694785415;36966.44550331801;37345.813270933475;37712;195215;196420;197590;204923;206327;28736.568951465328;30516.389672206875;31822;32158.623344548487;32301.676983230805;34972;35884.28231435409;36301.818490907375;36366;36366;30245.546316805707;30748.538771918888;32575;33678.158046049044;33789.49315760216;33463.33073338471;33486;33681.494777577864;34010.31979360349;34037.48943765796;33353;33646.495302569994;33837.492437613946;33941;34211.82894085613;28544.143675689764;30085.54871676883;30270.84864575663;30287.242818929702;30308.696913030588;25542.361440964123;26391.736082639694;26400.091784764696;27918;28209.71790282153 18:39:47 INFO - PROCESS | 6376 | |2;jquery.html;341.53721707086896;352.3129896701431;360.4143267190815;368.10366756946837;371.4224381087411;15418.691626167483;15521.223938803058;16599.33602655894;16638.916805415956;16681.165941702897;15520.844791552081;15902.602434939132;16049.438269660564;16051.598710032255;16074.75887861683;5115.079285728568;5190.792368305282;5204.505571970676;5223.738813059351;5250.3699556053325;5012.523810238022;5198.818041368553;5213.061648903196;5229.60777941654;5232.502912223333;5060.671056381342;5167.896642067157;5173.456787037363;5181.041507321158;5182.948170518303;5153.5361817436615;5178.715170665612;5188.429272779991;5215.348081489814;5220.6606570572985;4998.7250701211415;5032.345795046657;5035.521625445577;5042.773075211588;5043.62172837035;11847.170698051139;12162.756744865053;12173.634790956285;12174.391280436032;12185.817212741817;1881.4825922871182;1889.7165425186195;2034.1761586557468;2215.833812464072;2235.0277629231173;9138.360314777969;9153.862692059625;9578.281628877792;9673.806523869554;13163.407646655924;1728.9949471613218;1773.725072613747;1799.2173404569055;1837.2650939624257;1864.7855496617926;56492;58743.706281468316;60721.392786072014;62275;63253.68373158151;9664.95553900519;9670;9791.510424478747;9853.162481189036;9940.403575785476;13316.26760528161;13487.258200798855;13504.729905401837;13523.120997135155;13533.390997404944;7276.818079548054;7335.1197856257595;7383.704651813868;7509.173990861001;7551.320381165611;7098.964505177441;7120.287971202942;7125.3230943060325;7169.462290328246;7252.854942901113;4252.255855225323;4280.07978284664;4297.076128632359;4299.355096735452;4329.964916489245;1721.4835549335148;1747.1962897067237;1779.715245560704;1794.7577077094425;1794.835980525195;792.2038351456864;829.6722794496261;873.7073080517971;907.804821963281;949.8337790886567;15091.698166036618;15752.133632650315;15897.682046359008;16009.43966961174;16396.426125085804;866.7313132928812;881.7839629290864;891.1266958380694;929.6467342409841;945.6122989574242;9019.594118264693;9171.44971301724;9296.116868897443;9325.813483730288;9368.67209647659;382370;385532;391907;392151;394601;40597.79701101535;41225.38161927574;49557.752211238716;63886.36113638897;66242.33757662457;932.9300302477342;933.7945651956559;954.7851733360077;957.5499515227832;958.8465845464692;11616.825747613962;13890.236037017658;14786.778198327249;14936.402543898123;15115.186177658312;23722.525549488568;31704.524432133996;31774.682253177172;32547.34905301928;33546.496802547495;39328.41007384834;40148.7992560047;40204;40213.396799047456;40237.59762402339;7553.206913274027;7649.694012239448;7697.846043079219;7698.307152356315;7713.151553329241;6221.035739460391;8798.76817245599;10074.899251007397;10208.387496750218;11479.655610331703;8971.596278167628;9682.806343873224;9870.358426702242;10313.639022634172;10601.575936962436;9810.460424676712;9830.262730295113;9861.901380986099;10040.748981275527;10089.949550252202;9980;10132.898671013196;10224.591016359262;10363.119134873621;10491.842622360518;7039.1553013638695;7198;7216.7113315466795;7322.5972571506945;7347.228541003332;9027.232685221566;10211.897881021094;10291.691249262534;10364;10435.060844524029 18:39:47 INFO - PROCESS | 6376 | |3;mootools.html;1255.8367412236407;1399.216438794275;1410.4992727581712;1514.7500662390705;1717.5448506145865;7252.311030452105;7462.626868656573;7482.43881708872;7488.513246638971;7510.474266801326;7302.415806735462;7447.627618619074;7462.179160292377;7467.402607791377;7471.178170401252;1959.4317647882096;2213.612617791884;2234.9888250558806;2238.104758096758;2296.5980953333183;2319.7564255753155;2328.836981411302;2333.218371845434;2337.146941366406;2338.5790557699606;2179.455136215946;2210.812080973119;2214.944626384337;2221.622324204889;2224.5773303072447;2204.035248614371;2209.028027667829;2286.6112760830533;2298.276043046435;2308.192132753523;2263.7509873913855;2281.828862835294;2295.219625327397;2295.690081838947;2306.331163962449;7368.410527157815;7404.111506619241;7415.443841711839;7417.22119177484;7429.034225550644;4636.188666983265;4735.57379835813;4739.3838800956;4744.501827308118;4746.406699162605;2945.072302224814;3043.9847800761077;3060.9846950765327;3078.184281165493;3080.799748016394;953.4470007395763;962;970.7621632699963;990.88604810447;1026.9024442677933;10191.286609937308;10240.692779216635;10277.023682750127;10292.897071029269;10340.948295258551;4032.6773858091283;4090.406891000788;4159.812808423628;4191.11986482842;4259.424977628042;8300.045494768057;8470.280026197843;8488;8501.787455313543;8505.10696376884;4058.6144316289906;4736.7631618418945;4767.952320476751;4773.809047638056;4785.808567657325;4242.85150019754;4337.110892267077;4361.738295702268;4361.934570981438;4364.738115713068;3632.2917031179195;3717.516722826015;3730.1607138393642;3756.398976163801;3778.376567866271;1182.798924182891;1188.869224385317;1190.0182349561646;1193.4927655746274;1195.5695949458188;1216.3796463803524;1226.625879106863;1247.0771628994478;1259.5654499197944;1262.110212300326;7202.855942881113;7262.636868156571;7335.816604584821;7343.118825740945;7343.449241306924;457.2615226409325;458.87151597552736;463.7820224494482;466.2563211677369;469.1602032362102;5536.723163841792;5566.582506312043;5571.1086226204425;5580.665160090326;5606.943930560724;8763.780905477413;8789.780255493664;8983.236424903826;8984.281257499384;9082.22801061904;8744.169303916118;8791;8892.33307501927;8909.198172164406;8980.820383592292;6777.8644427111185;6952.96523517369;6960.225142588709;6996.545224560387;7071.080759501232;6755.324467553205;6788.151481064867;6790.626515541692;6818.93181068183;6838.281980392187;7936.484128531627;8100.392470564613;8121;8137;8234.629441675259;8077.5961201940845;8266.297364723825;8307.376946728898;8406.28546573548;8424.578771061544;5764.769409223584;6239.844003899939;6436.742530298923;6653.833654158685;6853.314668533107;7065.682044307916;7123.786286411416;7124.715011399486;7156.713731450892;7163.3552980232025;6409.615423074631;6567.474602031922;6572.934270657423;6579.17760279965;6626.469882409492;6485.124508191522;6599.967000164968;6632.071509988509;6634.867302653824;6693.497987651043;6708.6981085850275;6754.358335958076;6763;6780.694868731018;6794.694238759366;6152.323244443197;6165.907511387243;6230.7507699693315;6268.373162683695;6270.968645156745;6544.247411547733;6549.0176473529355;6553.770618028346;6559.147310849559;6584.308647592125 18:39:47 INFO - PROCESS | 6376 | |4;prototype.html;319.1160485455289;319.36924573966417;319.58294425774363;322.42286307509556;327.2914140884986;5285.339332583422;5343.091674415349;5351.625386222956;5353.00969320675;5354.973225133878;5257.23770053343;5271.657342272759;5282.286891269678;5287.4976877196705;5294.258803767476;3959.802009899508;4034.5360283567325;4122;4148.958510414887;4177.206330797147;4122.175564887035;4131.504219493665;4145.958540414603;4148.2947898857265;4154.210699967011;4096.242195193884;4109.198706252282;4109.21924834282;4109.8972525686795;4150.066235097094;3891.9027024324478;4007.679385649156;4106.137711080677;4107.9178416431805;4118.299889018874;3633.3459977204093;3636.7089683162626;3657.305112028706;3664.0107171063664;3665.120371110941;5000.049990501793;5039.974800125976;5046.4701206373165;5048.040872234264;5052.317937078484;4770.427548694144;4771.475137734847;4777.95222047782;4779.976100119512;4783.808647654089;5577.05190117681;5581.888362232773;5586.888262234733;5592.3009623797025;5602.13166959122;4034.4150098235887;4037.6164264394833;4038.3942408638645;4039.9192016159805;4041.2523683118425;5675.63108397957;5882.705864706791;5893.5579831512805;5894.823155305305;5895.55783316253;3941.8620348288246;3985.860494882665;3990.7206495545615;3990.920181596352;3995.780232087205;4073.429719839225;4074.898127546835;4075.0016246019322;4076.429299898017;4081.0613558881623;4673.813047478063;4679.298105284167;4681;4687.250039993584;4695.131400690883;5598.97200514003;5613.635113717595;5615.943840561624;5623;5623.522000629992;1406.4866323791741;1432.3983926750789;1434.4979257259874;1435.052865109023;1436.346462359624;883.7083762358407;932.4312169576552;934.4346670264528;948.1040416806052;951.8286708392556;4875.293082503017;4912.95087049125;4919.803207871645;4936.90126197474;4948.331975183304;5750.281214848144;5760.769569217268;5765.509931655773;5772.422757724278;5772.826815195551;4935;4936.827211047596;4941.876453088629;4943.382077240345;4944.184209605447;3052.13014290926;3085.9074227773203;3088.9536656950163;3098.550710147061;3098.8760449581764;5483.7806487740845;5493.423190564933;5501.037318469332;5501.449855014546;5513.61404701667;5673.120666296731;5869.618474799125;5876.676782776903;5881.529477641779;5893.941060589339;5446.91829622556;5452.04589196889;5474.233607294982;5478.45215478457;5482;5681.801136960186;5715.199872017838;5716.42835716425;5718.170865224436;5726.513246374105;5621;5622.690752008679;5624.718764061862;5626.156076588544;5632.408597097246;5478.479544443271;5480.972595136999;5491.780328786804;5499.477549632778;5501.339839219319;3899.2396482685604;3943.5859234781083;3972.106276087857;3992.7604343739467;3999.1601763629965;5677.943220567907;5692.373838877637;5702.258706368146;5708.628939118944;5709.571782116275;5513.035218836607;5522.861928451821;5524.66851988882;5527.53015993645;5529.115341545334;5517.889642207053;5519.779208831602;5521.972390138184;5525.585581081355;5536.086545719912;5440.510354068153;5446.291982042309;5447.346318441812;5448.918266226089;5452;5384.9192262116885;5549.805756798492;5550.944490555043;5561.555075594024;5574.358948720949;5400.1089820180805;5426.647267927572;5429.538489228302;5431.37539182999;5440.347158341025 18:39:47 INFO - PROCESS | 6376 | |5;yui.html;668.8428219368448;710.3748701142994;768.5696010234268;790.490133863658;803.971860984866;11638;11680.532778688863;11734.823977640342;11754.118441116918;11765.352905590189;11203.887961120387;11285.153613479002;11732.706682332946;11735.941320293408;11801.055915526758;654.1496055128314;801.9839603207932;804.7947773317795;816.5631387207845;828.0312034919159;807.1524898856206;818.5129847740585;821.322409012567;821.9807438775905;828.2752591482453;850.4897061762955;857.7769779857219;862.8144948835999;865.1824026295153;865.5931712095305;681.1655721740852;828.1470085811624;842.3261390887266;843.3464065349373;845.7082306604211;612.1429998002832;614.8370681769335;617.9926719447272;618.6999305336908;619.3991827926949;12301.200421972542;12312.81530777039;12330.136890417674;12373.814392784025;12383.257004579755;12517.874821251762;12908.290044047573;12960.546380876718;13029.218246905217;13091.149075310075;8903.33225008127;8921.241694455979;8923;8940.73177804667;8952.373333866632;3447.3967055765143;3450.1374656335915;3469.080693616194;3520.524729161556;3534.2578058607724;44120.779396103135;44135.33796993048;44315.77842110801;44434;45707.77146114248;9982.900170998197;10046.095851373411;10119.595216191417;10200.948995255125;10304.227182961158;17268.309267629404;17287.56781080458;17330.480085597454;17331.740023899652;17349.653006939792;6811.489138314646;6820.181578210547;6880.759173428906;6981;7024.192217894905;3625.456181572785;3646.3254297954963;3671.5777685565968;3703.777773333609;3741.0460332615007;2896.52207385779;2915.0526079024403;2920.2991282092144;2929.7802664800224;2942.1026586890775;453.5260652617956;525.7161132988143;531.5588061908607;531.8032328038651;573.5812856614612;546.1071148671871;573.8135106090538;628.6039794929256;632.8702615963716;641.5990006246096;7835.84328313442;7839.843203135905;7880.64537095832;7944.9205507945335;7987.680492780224;499.3757802746567;502.57030239145735;543.8259756877841;578.2280655325104;584.386394285998;3662.5421822272215;3695.2055308108884;3798.6201379862346;3807.048237940515;3821.675157611634;49550.75224623854;50871.23693144606;51054.74472627688;51071.74464127656;51105;42708.14583708309;42820;42970.355444668356;43260.134797304505;43922.560774392485;41450;41637.37543936904;42175.7891210542;43164.13671726548;43380.34929476061;7527.2096429876265;7604.163542010264;7808.843823123392;7855.921440785748;7869.685212591432;30280.5457918127;31698;32565.674343256265;32681.836590817846;32936.835315823264;38657;40215.396769047904;40519;41202.79398602988;41352.58647413487;9132.086791320815;9174.954125229331;9238;9239.214666753402;9376.29677774156;10051.296409251283;10095.747606309607;10106.242031847787;10228.590856365661;10298.485075746332;9295.209907157967;9392.812143757223;9403.43579385239;9589.568469419033;9712.9028709712;9432.764180895532;9452.621895124394;9635.373700709431;9718.562664679965;9766.316357854881;8587.270082043096;8921.01868794445;9059.365844391094;9145.176934075966;9148.817023659623;7875.251851074138;8123.147069557612;8291.83416331658;8332.33341332704;8334.87497687523;8290.544020078954;8554.657813687383;8616.09530999236;8742.956285218534;8818.779530511789 18:39:47 INFO - PROCESS | 6376 | __end_tp_report 18:39:47 INFO - PROCESS | 6376 | __start_cc_report 18:39:47 INFO - PROCESS | 6376 | _x_x_mozilla_cycle_collect,878 18:39:47 INFO - PROCESS | 6376 | __end_cc_report 18:39:47 INFO - PROCESS | 6376 | __startTimestamp1459301987761__endTimestamp 18:39:47 INFO - PROCESS | 6376 | 18:39:47 INFO - PROCESS | 6376 | ------- Summary: start ------- 18:39:47 INFO - PROCESS | 6376 | Number of tests: 6 18:39:47 INFO - PROCESS | 6376 | 18:39:47 INFO - PROCESS | 6376 | [#0] dojo.html Cycles:165 Average:4594.96 Median:4735.17 stddev:471.78 (10.0%) stddev-sans-first:445.91 18:39:47 INFO - PROCESS | 6376 | Values: 2578.1 2632.1 2639.4 2652.4 2667.7 4454.7 4537.6 4539.5 4540.3 4554.5 4637.4 4673.1 4701.9 4711.9 4723.5 4201.0 4255.5 4278.0 4298.6 4352.1 4209.3 4340.0 4388.6 4404.7 4435.0 4185.0 4265.2 4322.4 4335.8 4420.0 4247.6 4265.7 4278.4 4278.9 4280.5 4243.8 4250.3 4250.4 4253.6 4257.6 4474.3 4495.8 4523.6 4558.2 4577.2 4936.6 4977.3 4978.6 4980.4 5027.5 4858.6 4978.4 4991.6 5006.3 5008.5 4592.2 4630.3 4631.9 4671.2 4677.0 5060.4 5077.6 5109.8 5117.2 5162.4 4808.8 4830.2 4906.5 4916.0 4918.0 4998.8 5018.3 5020.9 5032.7 5066.1 4954.8 4974.0 4975.6 4976.9 5020.5 4746.1 4832.2 4836.8 4939.4 5002.9 4166.6 4169.5 4181.4 4181.9 4185.3 3706.2 3735.5 3738.4 3739.1 3740.5 4298.8 4302.7 4375.6 4381.3 4385.7 4875.9 4917.5 4926.0 4930.6 4975.5 4279.3 4282.7 4286.2 4286.7 4329.5 4324.4 4454.6 4510.0 4530.5 4554.3 4735.2 4769.4 4779.1 4781.4 4822.8 4873.6 4985.7 4988.4 4993.5 5046.2 4726.6 4764.3 4768.9 4792.3 4818.0 4869.0 4916.6 4917.3 4927.7 4968.6 4804.2 4853.6 4975.4 4991.9 5048.9 4842.5 4844.8 4857.6 4869.9 4908.4 4857.2 4860.5 4862.7 4865.5 4901.2 4647.7 4703.3 4785.0 4805.6 4832.1 4778.8 4796.6 4802.2 4804.8 4846.2 4700.2 4705.9 4719.6 4721.3 4757.5 18:39:47 INFO - PROCESS | 6376 | 18:39:47 INFO - PROCESS | 6376 | [#1] ext.html Cycles:180 Average:41577.73 Median:34023.90 stddev:68985.43 (202.8%) stddev-sans-first:69110.05 18:39:47 INFO - PROCESS | 6376 | Values: 514.3 516.1 520.6 537.9 551.3 27054.2 35026.5 35424.5 35463.0 35471.3 38644.8 39152.2 39159.4 39161.4 39180.0 7317.0 7715.2 7906.6 7909.2 9680.8 9786.4 9933.4 9937.9 9942.2 9948.9 9926.0 10008.6 10015.2 10032.3 10052.1 9854.1 9933.4 9946.4 9951.9 9967.2 9813.5 9886.8 9952.2 9959.3 10205.5 37501.6 37924.0 37969.6 37974.0 37995.2 3067.3 3081.9 3093.6 3124.0 3172.9 28830.4 28926.0 29753.1 29800.6 30306.0 3475.0 3503.7 3570.6 3606.2 3639.1 192412.0 192537.0 192832.0 193184.0 193815.0 53890.5 53914.0 54292.7 54300.5 54347.7 57573.7 63463.7 64209.0 64517.0 64642.4 14162.9 14922.1 15069.0 15116.5 15133.7 10476.7 10833.2 10853.4 10855.3 10856.2 19453.7 19498.1 19909.5 20296.8 20327.5 7123.3 7123.3 7195.1 7317.9 7328.3 856.0 863.9 870.0 888.5 923.9 24137.3 25218.6 25257.4 25344.7 25423.0 919.4 946.2 992.9 1023.8 1048.2 13318.7 13667.9 13817.4 13891.7 13921.2 354455.8 359606.0 361550.0 361715.0 362504.0 49222.0 50163.0 50261.7 50271.0 50273.2 1131.3 1188.1 1196.1 1211.9 1243.3 24871.4 26042.9 26265.5 26446.5 26624.7 36805.6 36965.3 36966.4 37345.8 37712.0 195215.0 196420.0 197590.0 204923.0 206327.0 28736.6 30516.4 31822.0 32158.6 32301.7 34972.0 35884.3 36301.8 36366.0 36366.0 30245.5 30748.5 32575.0 33678.2 33789.5 33463.3 33486.0 33681.5 34010.3 34037.5 33353.0 33646.5 33837.5 33941.0 34211.8 28544.1 30085.5 30270.8 30287.2 30308.7 25542.4 26391.7 26400.1 27918.0 28209.7 18:39:47 INFO - PROCESS | 6376 | 18:39:47 INFO - PROCESS | 6376 | [#2] jquery.html Cycles:180 Average:22416.63 Median:5022.43 stddev:63642.05 (1267.2%) stddev-sans-first:63799.00 18:39:47 INFO - PROCESS | 6376 | Values: 341.5 352.3 360.4 368.1 371.4 15418.7 15521.2 16599.3 16638.9 16681.2 15520.8 15902.6 16049.4 16051.6 16074.8 5115.1 5190.8 5204.5 5223.7 5250.4 5012.5 5198.8 5213.1 5229.6 5232.5 5060.7 5167.9 5173.5 5181.0 5182.9 5153.5 5178.7 5188.4 5215.3 5220.7 4998.7 5032.3 5035.5 5042.8 5043.6 11847.2 12162.8 12173.6 12174.4 12185.8 1881.5 1889.7 2034.2 2215.8 2235.0 9138.4 9153.9 9578.3 9673.8 13163.4 1729.0 1773.7 1799.2 1837.3 1864.8 56492.0 58743.7 60721.4 62275.0 63253.7 9665.0 9670.0 9791.5 9853.2 9940.4 13316.3 13487.3 13504.7 13523.1 13533.4 7276.8 7335.1 7383.7 7509.2 7551.3 7099.0 7120.3 7125.3 7169.5 7252.9 4252.3 4280.1 4297.1 4299.4 4330.0 1721.5 1747.2 1779.7 1794.8 1794.8 792.2 829.7 873.7 907.8 949.8 15091.7 15752.1 15897.7 16009.4 16396.4 866.7 881.8 891.1 929.6 945.6 9019.6 9171.4 9296.1 9325.8 9368.7 382370.0 385532.0 391907.0 392151.0 394601.0 40597.8 41225.4 49557.8 63886.4 66242.3 932.9 933.8 954.8 957.5 958.8 11616.8 13890.2 14786.8 14936.4 15115.2 23722.5 31704.5 31774.7 32547.3 33546.5 39328.4 40148.8 40204.0 40213.4 40237.6 7553.2 7649.7 7697.8 7698.3 7713.2 6221.0 8798.8 10074.9 10208.4 11479.7 8971.6 9682.8 9870.4 10313.6 10601.6 9810.5 9830.3 9861.9 10040.7 10089.9 9980.0 10132.9 10224.6 10363.1 10491.8 7039.2 7198.0 7216.7 7322.6 7347.2 9027.2 10211.9 10291.7 10364.0 10435.1 18:39:47 INFO - PROCESS | 6376 | 18:39:47 INFO - PROCESS | 6376 | [#3] mootools.html Cycles:180 Average:5256.21 Median:6254.11 stddev:2693.28 (43.1%) stddev-sans-first:2684.05 18:39:47 INFO - PROCESS | 6376 | Values: 1255.8 1399.2 1410.5 1514.8 1717.5 7252.3 7462.6 7482.4 7488.5 7510.5 7302.4 7447.6 7462.2 7467.4 7471.2 1959.4 2213.6 2235.0 2238.1 2296.6 2319.8 2328.8 2333.2 2337.1 2338.6 2179.5 2210.8 2214.9 2221.6 2224.6 2204.0 2209.0 2286.6 2298.3 2308.2 2263.8 2281.8 2295.2 2295.7 2306.3 7368.4 7404.1 7415.4 7417.2 7429.0 4636.2 4735.6 4739.4 4744.5 4746.4 2945.1 3044.0 3061.0 3078.2 3080.8 953.4 962.0 970.8 990.9 1026.9 10191.3 10240.7 10277.0 10292.9 10340.9 4032.7 4090.4 4159.8 4191.1 4259.4 8300.0 8470.3 8488.0 8501.8 8505.1 4058.6 4736.8 4768.0 4773.8 4785.8 4242.9 4337.1 4361.7 4361.9 4364.7 3632.3 3717.5 3730.2 3756.4 3778.4 1182.8 1188.9 1190.0 1193.5 1195.6 1216.4 1226.6 1247.1 1259.6 1262.1 7202.9 7262.6 7335.8 7343.1 7343.4 457.3 458.9 463.8 466.3 469.2 5536.7 5566.6 5571.1 5580.7 5606.9 8763.8 8789.8 8983.2 8984.3 9082.2 8744.2 8791.0 8892.3 8909.2 8980.8 6777.9 6953.0 6960.2 6996.5 7071.1 6755.3 6788.2 6790.6 6818.9 6838.3 7936.5 8100.4 8121.0 8137.0 8234.6 8077.6 8266.3 8307.4 8406.3 8424.6 5764.8 6239.8 6436.7 6653.8 6853.3 7065.7 7123.8 7124.7 7156.7 7163.4 6409.6 6567.5 6572.9 6579.2 6626.5 6485.1 6600.0 6632.1 6634.9 6693.5 6708.7 6754.4 6763.0 6780.7 6794.7 6152.3 6165.9 6230.8 6268.4 6271.0 6544.2 6549.0 6553.8 6559.1 6584.3 18:39:47 INFO - PROCESS | 6376 | 18:39:47 INFO - PROCESS | 6376 | [#4] prototype.html Cycles:180 Average:4622.97 Median:5318.68 stddev:1349.05 (25.4%) stddev-sans-first:1313.58 18:39:47 INFO - PROCESS | 6376 | Values: 319.1 319.4 319.6 322.4 327.3 5285.3 5343.1 5351.6 5353.0 5355.0 5257.2 5271.7 5282.3 5287.5 5294.3 3959.8 4034.5 4122.0 4149.0 4177.2 4122.2 4131.5 4146.0 4148.3 4154.2 4096.2 4109.2 4109.2 4109.9 4150.1 3891.9 4007.7 4106.1 4107.9 4118.3 3633.3 3636.7 3657.3 3664.0 3665.1 5000.0 5040.0 5046.5 5048.0 5052.3 4770.4 4771.5 4778.0 4780.0 4783.8 5577.1 5581.9 5586.9 5592.3 5602.1 4034.4 4037.6 4038.4 4039.9 4041.3 5675.6 5882.7 5893.6 5894.8 5895.6 3941.9 3985.9 3990.7 3990.9 3995.8 4073.4 4074.9 4075.0 4076.4 4081.1 4673.8 4679.3 4681.0 4687.3 4695.1 5599.0 5613.6 5615.9 5623.0 5623.5 1406.5 1432.4 1434.5 1435.1 1436.3 883.7 932.4 934.4 948.1 951.8 4875.3 4913.0 4919.8 4936.9 4948.3 5750.3 5760.8 5765.5 5772.4 5772.8 4935.0 4936.8 4941.9 4943.4 4944.2 3052.1 3085.9 3089.0 3098.6 3098.9 5483.8 5493.4 5501.0 5501.4 5513.6 5673.1 5869.6 5876.7 5881.5 5893.9 5446.9 5452.0 5474.2 5478.5 5482.0 5681.8 5715.2 5716.4 5718.2 5726.5 5621.0 5622.7 5624.7 5626.2 5632.4 5478.5 5481.0 5491.8 5499.5 5501.3 3899.2 3943.6 3972.1 3992.8 3999.2 5677.9 5692.4 5702.3 5708.6 5709.6 5513.0 5522.9 5524.7 5527.5 5529.1 5517.9 5519.8 5522.0 5525.6 5536.1 5440.5 5446.3 5447.3 5448.9 5452.0 5384.9 5549.8 5550.9 5561.6 5574.4 5400.1 5426.6 5429.5 5431.4 5440.3 18:39:47 INFO - PROCESS | 6376 | 18:39:47 INFO - PROCESS | 6376 | [#5] yui.html Cycles:180 Average:12360.77 Median:544.97 stddev:14240.41 (2613.1%) stddev-sans-first:14253.29 18:39:47 INFO - PROCESS | 6376 | Values: 668.8 710.4 768.6 790.5 804.0 11638.0 11680.5 11734.8 11754.1 11765.4 11203.9 11285.2 11732.7 11735.9 11801.1 654.1 802.0 804.8 816.6 828.0 807.2 818.5 821.3 822.0 828.3 850.5 857.8 862.8 865.2 865.6 681.2 828.1 842.3 843.3 845.7 612.1 614.8 618.0 618.7 619.4 12301.2 12312.8 12330.1 12373.8 12383.3 12517.9 12908.3 12960.5 13029.2 13091.1 8903.3 8921.2 8923.0 8940.7 8952.4 3447.4 3450.1 3469.1 3520.5 3534.3 44120.8 44135.3 44315.8 44434.0 45707.8 9982.9 10046.1 10119.6 10200.9 10304.2 17268.3 17287.6 17330.5 17331.7 17349.7 6811.5 6820.2 6880.8 6981.0 7024.2 3625.5 3646.3 3671.6 3703.8 3741.0 2896.5 2915.1 2920.3 2929.8 2942.1 453.5 525.7 531.6 531.8 573.6 546.1 573.8 628.6 632.9 641.6 7835.8 7839.8 7880.6 7944.9 7987.7 499.4 502.6 543.8 578.2 584.4 3662.5 3695.2 3798.6 3807.0 3821.7 49550.8 50871.2 51054.7 51071.7 51105.0 42708.1 42820.0 42970.4 43260.1 43922.6 41450.0 41637.4 42175.8 43164.1 43380.3 7527.2 7604.2 7808.8 7855.9 7869.7 30280.5 31698.0 32565.7 32681.8 32936.8 38657.0 40215.4 40519.0 41202.8 41352.6 9132.1 9175.0 9238.0 9239.2 9376.3 10051.3 10095.7 10106.2 10228.6 10298.5 9295.2 9392.8 9403.4 9589.6 9712.9 9432.8 9452.6 9635.4 9718.6 9766.3 8587.3 8921.0 9059.4 9145.2 9148.8 7875.3 8123.1 8291.8 8332.3 8334.9 8290.5 8554.7 8616.1 8743.0 8818.8 18:39:47 INFO - PROCESS | 6376 | -------- Summary: end -------- 18:39:47 INFO - PROCESS | 6376 | 18:39:48 INFO - TEST-INFO | 6376: exit 0 18:39:48 INFO - TEST-OK | dromaeo_css | took 1117292ms 18:39:48 INFO - TEST-START | kraken 18:39:48 INFO - operating with platform_type : linux_ 18:39:48 INFO - Initialising browser for kraken test... 18:39:48 INFO - TEST-INFO | started process 6552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcLSW43/profile http://localhost:45968/getInfo.html) 18:39:53 INFO - PROCESS | 6552 | __metrics Screen width/height:1600/1200 18:39:53 INFO - PROCESS | 6552 | colorDepth:24 18:39:53 INFO - PROCESS | 6552 | Browser inner width/height: 1024/697 18:39:53 INFO - PROCESS | 6552 | __metrics 18:39:54 ERROR - PROCESS | 6552 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:39:55 INFO - TEST-INFO | 6552: exit 0 18:39:55 INFO - Browser initialized. 18:39:55 INFO - Running cycle 1/1 for kraken test... 18:39:55 INFO - TEST-INFO | started process 6637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcLSW43/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:40:07 INFO - PROCESS | 6637 | RSS: Main: 154918912 18:40:07 INFO - PROCESS | 6637 | 18:40:09 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45968/tests/kraken/driver.html?testName=audio-beat-detection) 18:40:10 INFO - PROCESS | 6637 | RSS: Main: 196825088 18:40:10 INFO - PROCESS | 6637 | 18:40:13 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45968/tests/kraken/driver.html?testName=audio-dft) 18:40:13 INFO - PROCESS | 6637 | RSS: Main: 186273792 18:40:13 INFO - PROCESS | 6637 | 18:40:16 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45968/tests/kraken/driver.html?testName=audio-fft) 18:40:17 INFO - PROCESS | 6637 | RSS: Main: 171786240 18:40:17 INFO - PROCESS | 6637 | 18:40:19 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45968/tests/kraken/driver.html?testName=audio-oscillator) 18:40:19 INFO - PROCESS | 6637 | RSS: Main: 173076480 18:40:19 INFO - PROCESS | 6637 | 18:40:22 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45968/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:40:22 INFO - PROCESS | 6637 | RSS: Main: 173981696 18:40:22 INFO - PROCESS | 6637 | 18:40:25 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45968/tests/kraken/driver.html?testName=imaging-darkroom) 18:40:26 INFO - PROCESS | 6637 | RSS: Main: 174387200 18:40:26 INFO - PROCESS | 6637 | 18:40:29 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45968/tests/kraken/driver.html?testName=imaging-desaturate) 18:40:30 INFO - PROCESS | 6637 | RSS: Main: 173932544 18:40:30 INFO - PROCESS | 6637 | 18:40:33 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45968/tests/kraken/driver.html?testName=json-parse-financial) 18:40:33 INFO - PROCESS | 6637 | RSS: Main: 174440448 18:40:33 INFO - PROCESS | 6637 | 18:40:35 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45968/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:40:36 INFO - PROCESS | 6637 | RSS: Main: 185286656 18:40:36 INFO - PROCESS | 6637 | 18:40:37 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45968/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:40:38 INFO - PROCESS | 6637 | RSS: Main: 183525376 18:40:38 INFO - PROCESS | 6637 | 18:40:40 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45968/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:40:41 INFO - PROCESS | 6637 | RSS: Main: 197492736 18:40:41 INFO - PROCESS | 6637 | 18:40:43 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:40:44 INFO - PROCESS | 6637 | RSS: Main: 201273344 18:40:44 INFO - PROCESS | 6637 | 18:40:46 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:40:47 INFO - PROCESS | 6637 | RSS: Main: 201256960 18:40:47 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | Cycle 1(1): loaded http://localhost:45968/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45968/tests/kraken/driver.html?testName=ai-astar) 18:40:49 INFO - PROCESS | 6637 | RSS: Main: 261951488 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | __start_tp_report 18:40:49 INFO - PROCESS | 6637 | _x_x_mozilla_page_load 18:40:49 INFO - PROCESS | 6637 | _x_x_mozilla_page_load_details 18:40:49 INFO - PROCESS | 6637 | |i|pagename|runs| 18:40:49 INFO - PROCESS | 6637 | |0;ai-astar;111;113;107;111;112;112;101;113;112;114 18:40:49 INFO - PROCESS | 6637 | |1;audio-beat-detection;160;145;166;180;137;163;158;138;193;142 18:40:49 INFO - PROCESS | 6637 | |2;audio-dft;162;160;161;160;162;162;162;159;160;162 18:40:49 INFO - PROCESS | 6637 | |3;audio-fft;73;74;105;103;74;73;74;124;96;79 18:40:49 INFO - PROCESS | 6637 | |4;audio-oscillator;94;94;133;94;94;95;150;94;94;133 18:40:49 INFO - PROCESS | 6637 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;118;118 18:40:49 INFO - PROCESS | 6637 | |6;imaging-darkroom;145;148;147;146;146;147;146;146;146;146 18:40:49 INFO - PROCESS | 6637 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;96;95 18:40:49 INFO - PROCESS | 6637 | |8;json-parse-financial;65;63;63;64;63;64;63;72;61;64 18:40:49 INFO - PROCESS | 6637 | |9;json-stringify-tinderbox;64;64;64;64;64;65;64;64;65;65 18:40:49 INFO - PROCESS | 6637 | |10;stanford-crypto-aes;81;82;82;89;82;82;90;81;83;82 18:40:49 INFO - PROCESS | 6637 | |11;stanford-crypto-ccm;118;124;120;132;118;114;121;125;118;125 18:40:49 INFO - PROCESS | 6637 | |12;stanford-crypto-pbkdf2;142;131;142;141;139;130;131;140;138;139 18:40:49 INFO - PROCESS | 6637 | |13;stanford-crypto-sha256-iterative;66;66;67;66;66;66;67;68;68;66 18:40:49 INFO - PROCESS | 6637 | __end_tp_report 18:40:49 INFO - PROCESS | 6637 | __start_cc_report 18:40:49 INFO - PROCESS | 6637 | _x_x_mozilla_cycle_collect,1175 18:40:49 INFO - PROCESS | 6637 | __end_cc_report 18:40:49 INFO - PROCESS | 6637 | __startTimestamp1459302049547__endTimestamp 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | ------- Summary: start ------- 18:40:49 INFO - PROCESS | 6637 | Number of tests: 14 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.86 (3.5%) stddev-sans-first:4.10 18:40:49 INFO - PROCESS | 6637 | Values: 111.0 113.0 107.0 111.0 112.0 112.0 101.0 113.0 112.0 114.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#1] audio-beat-detection Cycles:10 Average:158.20 Median:161.50 stddev:18.46 (11.4%) stddev-sans-first:19.57 18:40:49 INFO - PROCESS | 6637 | Values: 160.0 145.0 166.0 180.0 137.0 163.0 158.0 138.0 193.0 142.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#2] audio-dft Cycles:10 Average:161.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 18:40:49 INFO - PROCESS | 6637 | Values: 162.0 160.0 161.0 160.0 162.0 162.0 162.0 159.0 160.0 162.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#3] audio-fft Cycles:10 Average:87.50 Median:74.00 stddev:18.23 (24.6%) stddev-sans-first:18.56 18:40:49 INFO - PROCESS | 6637 | Values: 73.0 74.0 105.0 103.0 74.0 73.0 74.0 124.0 96.0 79.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#4] audio-oscillator Cycles:10 Average:107.50 Median:94.00 stddev:22.00 (23.4%) stddev-sans-first:22.79 18:40:49 INFO - PROCESS | 6637 | Values: 94.0 94.0 133.0 94.0 94.0 95.0 150.0 94.0 94.0 133.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 18:40:49 INFO - PROCESS | 6637 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 18:40:49 INFO - PROCESS | 6637 | Values: 145.0 148.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:40:49 INFO - PROCESS | 6637 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.00 stddev:2.94 (4.6%) stddev-sans-first:3.10 18:40:49 INFO - PROCESS | 6637 | Values: 65.0 63.0 63.0 64.0 63.0 64.0 63.0 72.0 61.0 64.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 18:40:49 INFO - PROCESS | 6637 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.00 stddev:3.27 (4.0%) stddev-sans-first:3.35 18:40:49 INFO - PROCESS | 6637 | Values: 81.0 82.0 82.0 89.0 82.0 82.0 90.0 81.0 83.0 82.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:122.50 stddev:5.13 (4.2%) stddev-sans-first:5.28 18:40:49 INFO - PROCESS | 6637 | Values: 118.0 124.0 120.0 132.0 118.0 114.0 121.0 125.0 118.0 125.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.30 Median:139.50 stddev:4.76 (3.4%) stddev-sans-first:4.74 18:40:49 INFO - PROCESS | 6637 | Values: 142.0 131.0 142.0 141.0 139.0 130.0 131.0 140.0 138.0 139.0 18:40:49 INFO - PROCESS | 6637 | 18:40:49 INFO - PROCESS | 6637 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 18:40:49 INFO - PROCESS | 6637 | Values: 66.0 66.0 67.0 66.0 66.0 66.0 67.0 68.0 68.0 66.0 18:40:49 INFO - PROCESS | 6637 | -------- Summary: end -------- 18:40:49 INFO - PROCESS | 6637 | 18:40:50 INFO - TEST-INFO | 6637: exit 0 18:40:50 INFO - TEST-OK | kraken | took 61965ms 18:40:50 INFO - SUITE-END | took 1179s 18:40:50 INFO - Completed test suite (00:19:39) 18:40:50 INFO - javascript benchmark 18:40:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2578.149210760449, 2632.118240389468, 2639.3929396238855, 2652.4032092779116, 2667.66654168229, 4454.710443821149, 4537.568930951558, 4539.523350048247, 4540.2508586083295, 4554.521775213605, 4637.443506779183, 4673.088747694201, 4701.929471057937, 4711.8586442406695, 4723.527647235274, 4200.957990420087, 4255.5318914919335, 4277.957220427803, 4298.613124818758, 4352.086061926999, 4209.3054645983375, 4340.045190058182, 4388.5830846069575, 4404.735715857043, 4434.955650443502, 4185.037441388497, 4265.232258193524, 4322.44392018873, 4335.848245311399, 4420.0496893167965, 4247.575242475758, 4265.658747300239, 4278.44380230568, 4278.935815962763, 4280.486341638992, 4243.766592837393, 4250.341197114452, 4250.362445633149, 4253.553376895444, 4257.574242575749, 4474.306482495186, 4495.752733599651, 4523.615492683126, 4558.179527685015, 4577.176108300505, 4936.555709986083, 4977.278294647292, 4978.626603004789, 4980.427250866124, 5027.49725027498, 4858.635602329804, 4978.377702787152, 4991.550760431543, 5006.2740902569285, 5008.549230569266, 4592.15045216636, 4630.282306242538, 4631.884202894955, 4671.229247174212, 4677.0, 5060.3927528696795, 5077.644564880497, 5109.770060347293, 5117.181250999822, 5162.406323272797, 4808.831690890802, 4830.178869592178, 4906.509349065136, 4915.975420122876, 4917.950820491821, 4998.775055122528, 5018.2974383586325, 5020.874478138076, 5032.672876263031, 5066.06277838601, 4954.777035033432, 4974.0, 4975.601951843843, 4976.90046199074, 5020.523050310215, 4746.1456937750845, 4832.202686556749, 4836.806527738921, 4939.431965324034, 5002.874928126826, 4166.625003749617, 4169.499660040815, 4181.393697913846, 4181.937270940938, 4185.267578173807, 3706.221693444353, 3735.533058367704, 3738.3831667775057, 3739.121306492972, 3740.4763333133383, 4298.78506074695, 4302.65578753699, 4375.562443755599, 4381.277089280296, 4385.693001489865, 4875.926861097087, 4917.5328343808, 4926.014797040606, 4930.605551555867, 4975.4527002029745, 4279.33670281107, 4282.743035417885, 4286.207051695384, 4286.742795432284, 4329.502107257706, 4324.3513472978675, 4454.554544545519, 4509.977450112729, 4530.478994915627, 4554.339620754972, 4735.171345014677, 4769.42766867978, 4779.091972525209, 4781.426228852491, 4822.831200908022, 4873.634477414137, 4985.675931064469, 4988.351514303117, 4993.525615066563, 5046.243063540498, 4726.621870250303, 4764.309175169512, 4768.928466073081, 4792.329073929723, 4818.036392721399, 4868.975655121843, 4916.557509824133, 4917.28699338601, 4927.704337739747, 4968.627352948471, 4804.2073057945045, 4853.611711063036, 4975.402951645826, 4991.925121123259, 5048.899022019613, 4842.5157484251295, 4844.781984810763, 4857.562819346276, 4869.853904382874, 4908.386451693538, 4857.222844344888, 4860.465348811557, 4862.732549709658, 4865.537773911473, 4901.166801643801, 4647.697899636512, 4703.270992996091, 4785.042991401664, 4805.639577031667, 4832.057748738962, 4778.832740854054, 4796.56830885222, 4802.231642937113, 4804.759762011955, 4846.224604063474, 4700.153972285021, 4705.882352941204, 4719.622430205507, 4721.291806229093, 4757.524247575215], "unit": "score", "name": "dojo.html", "value": 4565.637385765925}, {"lowerIsBetter": false, "replicates": [514.3365059073794, 516.0659206835628, 520.6225486522269, 537.8870437208186, 551.3383939272873, 27054.188374348752, 35026.474602880946, 35424.468632970464, 35463.0, 35471.290574188504, 38644.806775966084, 39152.21695566087, 39159.41260881082, 39161.41257881134, 39180.0, 7317.0, 7715.228477152268, 7906.6442010109395, 7909.209079092074, 9680.75798105046, 9786.41281523111, 9933.354331968436, 9937.900620993805, 9942.204623630128, 9948.900510994907, 9925.957774433653, 10008.649697260596, 10015.198784097254, 10032.347897386646, 10052.14556762676, 9854.063863932915, 9933.3543319684, 9946.403215807075, 9951.8507222391, 9967.152792012688, 9813.509324533745, 9886.802263954753, 9952.154066904322, 9959.253056020827, 10205.540750666238, 37501.62498375009, 37924.0, 37969.62030379689, 37974.0, 37995.24009519794, 3067.2791893904914, 3081.876724931, 3093.6287645482685, 3123.984704970871, 3172.936541269185, 28830.423391532262, 28926.0, 29753.107406777614, 29800.552991705143, 30306.0, 3475.0, 3503.702185314226, 3570.590789532795, 3606.1525541497726, 3639.1266096137, 192412.0, 192537.0, 192832.0, 193184.0, 193814.9999999986, 53890.46109538933, 53914.0, 54292.72853635706, 54300.45699543033, 54347.72826135923, 57573.71213143991, 63463.682681586295, 64209.0, 64517.0, 64642.35357646457, 14162.929185354213, 14922.104673719612, 15069.0, 15116.470923517623, 15133.729940508792, 10476.68569942903, 10833.241673082966, 10853.403062831461, 10855.348679079123, 10856.240063195659, 19453.708194377097, 19498.12258448373, 19909.502262443555, 20296.797032029786, 20327.4918127048, 7123.2520585338825, 7123.287671232835, 7195.13658361, 7317.890231646529, 7328.251905535424, 855.9914400856036, 863.9481631102154, 869.9652013919373, 888.4891187567175, 923.9122283383068, 24137.275881723577, 25218.621720674204, 25257.368565785633, 25344.746552534238, 25423.0, 919.3518569408551, 946.1815529566875, 992.8858181309242, 1023.7952409518126, 1048.2138396202847, 13318.733625327439, 13667.931660341834, 13817.447302108005, 13891.652708682364, 13921.234332111628, 354455.82176713157, 359606.0, 361550.0, 361715.0, 362504.0, 49222.0, 50163.0, 50261.74869125631, 50271.0, 50273.24590131078, 1131.2929419113054, 1188.1148544334526, 1196.126827415991, 1211.9333436660893, 1243.3348158735034, 24871.37821554403, 26042.86978565095, 26265.4746905057, 26446.471070578864, 26624.733752662225, 36805.63194368022, 36965.260694785415, 36966.44550331801, 37345.813270933475, 37712.0, 195215.0, 196420.0, 197590.0, 204923.0, 206327.0, 28736.568951465328, 30516.389672206875, 31822.0, 32158.623344548487, 32301.676983230805, 34972.0, 35884.28231435409, 36301.818490907375, 36366.0, 36366.0, 30245.546316805707, 30748.538771918888, 32575.0, 33678.158046049044, 33789.49315760216, 33463.33073338471, 33486.0, 33681.494777577864, 34010.31979360349, 34037.48943765796, 33353.0, 33646.495302569994, 33837.492437613946, 33941.0, 34211.82894085613, 28544.143675689764, 30085.54871676883, 30270.84864575663, 30287.242818929702, 30308.696913030588, 25542.361440964123, 26391.736082639694, 26400.091784764696, 27918.0, 28209.71790282153], "unit": "score", "name": "ext.html", "value": 17367.799281683143}, {"lowerIsBetter": false, "replicates": [341.53721707086896, 352.3129896701431, 360.4143267190815, 368.10366756946837, 371.4224381087411, 15418.691626167483, 15521.223938803058, 16599.33602655894, 16638.916805415956, 16681.165941702897, 15520.844791552081, 15902.602434939132, 16049.438269660564, 16051.598710032255, 16074.75887861683, 5115.079285728568, 5190.792368305282, 5204.505571970676, 5223.738813059351, 5250.3699556053325, 5012.523810238022, 5198.818041368553, 5213.061648903196, 5229.60777941654, 5232.502912223333, 5060.671056381342, 5167.896642067157, 5173.456787037363, 5181.041507321158, 5182.948170518303, 5153.5361817436615, 5178.715170665612, 5188.429272779991, 5215.348081489814, 5220.6606570572985, 4998.7250701211415, 5032.345795046657, 5035.521625445577, 5042.773075211588, 5043.62172837035, 11847.170698051139, 12162.756744865053, 12173.634790956285, 12174.391280436032, 12185.817212741817, 1881.4825922871182, 1889.7165425186195, 2034.1761586557468, 2215.833812464072, 2235.0277629231173, 9138.360314777969, 9153.862692059625, 9578.281628877792, 9673.806523869554, 13163.407646655924, 1728.9949471613218, 1773.725072613747, 1799.2173404569055, 1837.2650939624257, 1864.7855496617926, 56492.0, 58743.706281468316, 60721.392786072014, 62275.0, 63253.68373158151, 9664.95553900519, 9670.0, 9791.510424478747, 9853.162481189036, 9940.403575785476, 13316.26760528161, 13487.258200798855, 13504.729905401837, 13523.120997135155, 13533.390997404944, 7276.818079548054, 7335.1197856257595, 7383.704651813868, 7509.173990861001, 7551.320381165611, 7098.964505177441, 7120.287971202942, 7125.3230943060325, 7169.462290328246, 7252.854942901113, 4252.255855225323, 4280.07978284664, 4297.076128632359, 4299.355096735452, 4329.964916489245, 1721.4835549335148, 1747.1962897067237, 1779.715245560704, 1794.7577077094425, 1794.835980525195, 792.2038351456864, 829.6722794496261, 873.7073080517971, 907.804821963281, 949.8337790886567, 15091.698166036618, 15752.133632650315, 15897.682046359008, 16009.43966961174, 16396.426125085804, 866.7313132928812, 881.7839629290864, 891.1266958380694, 929.6467342409841, 945.6122989574242, 9019.594118264693, 9171.44971301724, 9296.116868897443, 9325.813483730288, 9368.67209647659, 382370.0, 385532.0, 391907.0, 392151.0, 394601.0, 40597.79701101535, 41225.38161927574, 49557.752211238716, 63886.36113638897, 66242.33757662457, 932.9300302477342, 933.7945651956559, 954.7851733360077, 957.5499515227832, 958.8465845464692, 11616.825747613962, 13890.236037017658, 14786.778198327249, 14936.402543898123, 15115.186177658312, 23722.525549488568, 31704.524432133996, 31774.682253177172, 32547.34905301928, 33546.496802547495, 39328.41007384834, 40148.7992560047, 40204.0, 40213.396799047456, 40237.59762402339, 7553.206913274027, 7649.694012239448, 7697.846043079219, 7698.307152356315, 7713.151553329241, 6221.035739460391, 8798.76817245599, 10074.899251007397, 10208.387496750218, 11479.655610331703, 8971.596278167628, 9682.806343873224, 9870.358426702242, 10313.639022634172, 10601.575936962436, 9810.460424676712, 9830.262730295113, 9861.901380986099, 10040.748981275527, 10089.949550252202, 9980.0, 10132.898671013196, 10224.591016359262, 10363.119134873621, 10491.842622360518, 7039.1553013638695, 7198.0, 7216.7113315466795, 7322.5972571506945, 7347.228541003332, 9027.232685221566, 10211.897881021094, 10291.691249262534, 10364.0, 10435.060844524029], "unit": "score", "name": "jquery.html", "value": 7738.064060791554}, {"lowerIsBetter": false, "replicates": [1255.8367412236407, 1399.216438794275, 1410.4992727581712, 1514.7500662390705, 1717.5448506145865, 7252.311030452105, 7462.626868656573, 7482.43881708872, 7488.513246638971, 7510.474266801326, 7302.415806735462, 7447.627618619074, 7462.179160292377, 7467.402607791377, 7471.178170401252, 1959.4317647882096, 2213.612617791884, 2234.9888250558806, 2238.104758096758, 2296.5980953333183, 2319.7564255753155, 2328.836981411302, 2333.218371845434, 2337.146941366406, 2338.5790557699606, 2179.455136215946, 2210.812080973119, 2214.944626384337, 2221.622324204889, 2224.5773303072447, 2204.035248614371, 2209.028027667829, 2286.6112760830533, 2298.276043046435, 2308.192132753523, 2263.7509873913855, 2281.828862835294, 2295.219625327397, 2295.690081838947, 2306.331163962449, 7368.410527157815, 7404.111506619241, 7415.443841711839, 7417.22119177484, 7429.034225550644, 4636.188666983265, 4735.57379835813, 4739.3838800956, 4744.501827308118, 4746.406699162605, 2945.072302224814, 3043.9847800761077, 3060.9846950765327, 3078.184281165493, 3080.799748016394, 953.4470007395763, 962.0, 970.7621632699963, 990.88604810447, 1026.9024442677933, 10191.286609937308, 10240.692779216635, 10277.023682750127, 10292.897071029269, 10340.948295258551, 4032.6773858091283, 4090.406891000788, 4159.812808423628, 4191.11986482842, 4259.424977628042, 8300.045494768057, 8470.280026197843, 8488.0, 8501.787455313543, 8505.10696376884, 4058.6144316289906, 4736.7631618418945, 4767.952320476751, 4773.809047638056, 4785.808567657325, 4242.85150019754, 4337.110892267077, 4361.738295702268, 4361.934570981438, 4364.738115713068, 3632.2917031179195, 3717.516722826015, 3730.1607138393642, 3756.398976163801, 3778.376567866271, 1182.798924182891, 1188.869224385317, 1190.0182349561646, 1193.4927655746274, 1195.5695949458188, 1216.3796463803524, 1226.625879106863, 1247.0771628994478, 1259.5654499197944, 1262.110212300326, 7202.855942881113, 7262.636868156571, 7335.816604584821, 7343.118825740945, 7343.449241306924, 457.2615226409325, 458.87151597552736, 463.7820224494482, 466.2563211677369, 469.1602032362102, 5536.723163841792, 5566.582506312043, 5571.1086226204425, 5580.665160090326, 5606.943930560724, 8763.780905477413, 8789.780255493664, 8983.236424903826, 8984.281257499384, 9082.22801061904, 8744.169303916118, 8791.0, 8892.33307501927, 8909.198172164406, 8980.820383592292, 6777.8644427111185, 6952.96523517369, 6960.225142588709, 6996.545224560387, 7071.080759501232, 6755.324467553205, 6788.151481064867, 6790.626515541692, 6818.93181068183, 6838.281980392187, 7936.484128531627, 8100.392470564613, 8121.0, 8137.0, 8234.629441675259, 8077.5961201940845, 8266.297364723825, 8307.376946728898, 8406.28546573548, 8424.578771061544, 5764.769409223584, 6239.844003899939, 6436.742530298923, 6653.833654158685, 6853.314668533107, 7065.682044307916, 7123.786286411416, 7124.715011399486, 7156.713731450892, 7163.3552980232025, 6409.615423074631, 6567.474602031922, 6572.934270657423, 6579.17760279965, 6626.469882409492, 6485.124508191522, 6599.967000164968, 6632.071509988509, 6634.867302653824, 6693.497987651043, 6708.6981085850275, 6754.358335958076, 6763.0, 6780.694868731018, 6794.694238759366, 6152.323244443197, 6165.907511387243, 6230.7507699693315, 6268.373162683695, 6270.968645156745, 6544.247411547733, 6549.0176473529355, 6553.770618028346, 6559.147310849559, 6584.308647592125], "unit": "score", "name": "mootools.html", "value": 4271.778487705954}, {"lowerIsBetter": false, "replicates": [319.1160485455289, 319.36924573966417, 319.58294425774363, 322.42286307509556, 327.2914140884986, 5285.339332583422, 5343.091674415349, 5351.625386222956, 5353.00969320675, 5354.973225133878, 5257.23770053343, 5271.657342272759, 5282.286891269678, 5287.4976877196705, 5294.258803767476, 3959.802009899508, 4034.5360283567325, 4122.0, 4148.958510414887, 4177.206330797147, 4122.175564887035, 4131.504219493665, 4145.958540414603, 4148.2947898857265, 4154.210699967011, 4096.242195193884, 4109.198706252282, 4109.21924834282, 4109.8972525686795, 4150.066235097094, 3891.9027024324478, 4007.679385649156, 4106.137711080677, 4107.9178416431805, 4118.299889018874, 3633.3459977204093, 3636.7089683162626, 3657.305112028706, 3664.0107171063664, 3665.120371110941, 5000.049990501793, 5039.974800125976, 5046.4701206373165, 5048.040872234264, 5052.317937078484, 4770.427548694144, 4771.475137734847, 4777.95222047782, 4779.976100119512, 4783.808647654089, 5577.05190117681, 5581.888362232773, 5586.888262234733, 5592.3009623797025, 5602.13166959122, 4034.4150098235887, 4037.6164264394833, 4038.3942408638645, 4039.9192016159805, 4041.2523683118425, 5675.63108397957, 5882.705864706791, 5893.5579831512805, 5894.823155305305, 5895.55783316253, 3941.8620348288246, 3985.860494882665, 3990.7206495545615, 3990.920181596352, 3995.780232087205, 4073.429719839225, 4074.898127546835, 4075.0016246019322, 4076.429299898017, 4081.0613558881623, 4673.813047478063, 4679.298105284167, 4681.0, 4687.250039993584, 4695.131400690883, 5598.97200514003, 5613.635113717595, 5615.943840561624, 5623.0, 5623.522000629992, 1406.4866323791741, 1432.3983926750789, 1434.4979257259874, 1435.052865109023, 1436.346462359624, 883.7083762358407, 932.4312169576552, 934.4346670264528, 948.1040416806052, 951.8286708392556, 4875.293082503017, 4912.95087049125, 4919.803207871645, 4936.90126197474, 4948.331975183304, 5750.281214848144, 5760.769569217268, 5765.509931655773, 5772.422757724278, 5772.826815195551, 4935.0, 4936.827211047596, 4941.876453088629, 4943.382077240345, 4944.184209605447, 3052.13014290926, 3085.9074227773203, 3088.9536656950163, 3098.550710147061, 3098.8760449581764, 5483.7806487740845, 5493.423190564933, 5501.037318469332, 5501.449855014546, 5513.61404701667, 5673.120666296731, 5869.618474799125, 5876.676782776903, 5881.529477641779, 5893.941060589339, 5446.91829622556, 5452.04589196889, 5474.233607294982, 5478.45215478457, 5482.0, 5681.801136960186, 5715.199872017838, 5716.42835716425, 5718.170865224436, 5726.513246374105, 5621.0, 5622.690752008679, 5624.718764061862, 5626.156076588544, 5632.408597097246, 5478.479544443271, 5480.972595136999, 5491.780328786804, 5499.477549632778, 5501.339839219319, 3899.2396482685604, 3943.5859234781083, 3972.106276087857, 3992.7604343739467, 3999.1601763629965, 5677.943220567907, 5692.373838877637, 5702.258706368146, 5708.628939118944, 5709.571782116275, 5513.035218836607, 5522.861928451821, 5524.66851988882, 5527.53015993645, 5529.115341545334, 5517.889642207053, 5519.779208831602, 5521.972390138184, 5525.585581081355, 5536.086545719912, 5440.510354068153, 5446.291982042309, 5447.346318441812, 5448.918266226089, 5452.0, 5384.9192262116885, 5549.805756798492, 5550.944490555043, 5561.555075594024, 5574.358948720949, 5400.1089820180805, 5426.647267927572, 5429.538489228302, 5431.37539182999, 5440.347158341025], "unit": "score", "name": "prototype.html", "value": 4191.117312464359}, {"lowerIsBetter": false, "replicates": [668.8428219368448, 710.3748701142994, 768.5696010234268, 790.490133863658, 803.971860984866, 11638.0, 11680.532778688863, 11734.823977640342, 11754.118441116918, 11765.352905590189, 11203.887961120387, 11285.153613479002, 11732.706682332946, 11735.941320293408, 11801.055915526758, 654.1496055128314, 801.9839603207932, 804.7947773317795, 816.5631387207845, 828.0312034919159, 807.1524898856206, 818.5129847740585, 821.322409012567, 821.9807438775905, 828.2752591482453, 850.4897061762955, 857.7769779857219, 862.8144948835999, 865.1824026295153, 865.5931712095305, 681.1655721740852, 828.1470085811624, 842.3261390887266, 843.3464065349373, 845.7082306604211, 612.1429998002832, 614.8370681769335, 617.9926719447272, 618.6999305336908, 619.3991827926949, 12301.200421972542, 12312.81530777039, 12330.136890417674, 12373.814392784025, 12383.257004579755, 12517.874821251762, 12908.290044047573, 12960.546380876718, 13029.218246905217, 13091.149075310075, 8903.33225008127, 8921.241694455979, 8923.0, 8940.73177804667, 8952.373333866632, 3447.3967055765143, 3450.1374656335915, 3469.080693616194, 3520.524729161556, 3534.2578058607724, 44120.779396103135, 44135.33796993048, 44315.77842110801, 44434.0, 45707.77146114248, 9982.900170998197, 10046.095851373411, 10119.595216191417, 10200.948995255125, 10304.227182961158, 17268.309267629404, 17287.56781080458, 17330.480085597454, 17331.740023899652, 17349.653006939792, 6811.489138314646, 6820.181578210547, 6880.759173428906, 6981.0, 7024.192217894905, 3625.456181572785, 3646.3254297954963, 3671.5777685565968, 3703.777773333609, 3741.0460332615007, 2896.52207385779, 2915.0526079024403, 2920.2991282092144, 2929.7802664800224, 2942.1026586890775, 453.5260652617956, 525.7161132988143, 531.5588061908607, 531.8032328038651, 573.5812856614612, 546.1071148671871, 573.8135106090538, 628.6039794929256, 632.8702615963716, 641.5990006246096, 7835.84328313442, 7839.843203135905, 7880.64537095832, 7944.9205507945335, 7987.680492780224, 499.3757802746567, 502.57030239145735, 543.8259756877841, 578.2280655325104, 584.386394285998, 3662.5421822272215, 3695.2055308108884, 3798.6201379862346, 3807.048237940515, 3821.675157611634, 49550.75224623854, 50871.23693144606, 51054.74472627688, 51071.74464127656, 51105.0, 42708.14583708309, 42820.0, 42970.355444668356, 43260.134797304505, 43922.560774392485, 41450.0, 41637.37543936904, 42175.7891210542, 43164.13671726548, 43380.34929476061, 7527.2096429876265, 7604.163542010264, 7808.843823123392, 7855.921440785748, 7869.685212591432, 30280.5457918127, 31698.0, 32565.674343256265, 32681.836590817846, 32936.835315823264, 38657.0, 40215.396769047904, 40519.0, 41202.79398602988, 41352.58647413487, 9132.086791320815, 9174.954125229331, 9238.0, 9239.214666753402, 9376.29677774156, 10051.296409251283, 10095.747606309607, 10106.242031847787, 10228.590856365661, 10298.485075746332, 9295.209907157967, 9392.812143757223, 9403.43579385239, 9589.568469419033, 9712.9028709712, 9432.764180895532, 9452.621895124394, 9635.373700709431, 9718.562664679965, 9766.316357854881, 8587.270082043096, 8921.01868794445, 9059.365844391094, 9145.176934075966, 9148.817023659623, 7875.251851074138, 8123.147069557612, 8291.83416331658, 8332.33341332704, 8334.87497687523, 8290.544020078954, 8554.657813687383, 8616.09530999236, 8742.956285218534, 8818.779530511789], "unit": "score", "name": "yui.html", "value": 5736.669484380982}], "name": "dromaeo_css", "value": 6308.413874760126}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 107.0, 111.0, 112.0, 112.0, 101.0, 113.0, 112.0, 114.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [160.0, 145.0, 166.0, 180.0, 137.0, 163.0, 158.0, 138.0, 193.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 158.2}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 160.0, 162.0, 162.0, 162.0, 159.0, 160.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 105.0, 103.0, 74.0, 73.0, 74.0, 124.0, 96.0, 79.0], "unit": "score", "name": "audio-fft", "value": 87.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 133.0, 94.0, 94.0, 95.0, 150.0, 94.0, 94.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 107.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.3}, {"lowerIsBetter": true, "replicates": [145.0, 148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 72.0, 61.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 64.2}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 89.0, 82.0, 82.0, 90.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [118.0, 124.0, 120.0, 132.0, 118.0, 114.0, 121.0, 125.0, 118.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [142.0, 131.0, 142.0, 141.0, 139.0, 130.0, 131.0, 140.0, 138.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.3}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 68.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1520.8999999999999}]} 18:40:50 INFO - Return code: 0 18:40:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:40:50 ERROR - # TBPL SUCCESS # 18:40:50 INFO - Running post-action listener: _resource_record_post_action 18:40:50 INFO - Running post-run listener: _resource_record_post_run 18:40:51 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 454516736; Read time: 8; Write time: 775148 18:40:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 135294976; Read time: 0; Write time: 382664 18:40:51 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 279818240; Read time: 8; Write time: 266824 18:40:51 INFO - Running post-run listener: _upload_blobber_files 18:40:51 INFO - Blob upload gear active. 18:40:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:40:51 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 18:40:51 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'] 18:40:51 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 18:40:52 INFO - (blobuploader) - INFO - Open directory for files ... 18:40:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:40:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:40:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:53 INFO - (blobuploader) - INFO - Done attempting. 18:40:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:40:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:54 INFO - (blobuploader) - INFO - Done attempting. 18:40:54 INFO - (blobuploader) - INFO - Iteration through files over. 18:40:54 INFO - Return code: 0 18:40:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:40:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:40:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73ed53570a8462f88666502d4d1983a385e3b6716048e9df8c784f0932690b599b96320693554b820e2d69c6264d339c816542b39aa7b63ce731c36dd171b189", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47e902a35a3359c531f4f1afff15911533a8054934a77aff84efcdc76529f5d60cd9d3f350d1d8c9036295b84ebd16341df3b2d71aecd809170b6d2ceca75e81"} 18:40:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:40:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:40:54 INFO - Contents: 18:40:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73ed53570a8462f88666502d4d1983a385e3b6716048e9df8c784f0932690b599b96320693554b820e2d69c6264d339c816542b39aa7b63ce731c36dd171b189", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47e902a35a3359c531f4f1afff15911533a8054934a77aff84efcdc76529f5d60cd9d3f350d1d8c9036295b84ebd16341df3b2d71aecd809170b6d2ceca75e81"} 18:40:54 INFO - Running post-run listener: copy_logs_to_upload_dir 18:40:54 INFO - Copying logs to upload dir... 18:40:54 INFO - mkdir: /builds/slave/test/build/upload/logs 18:40:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.273946 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-03-29 18:40:53.464765) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 18:40:53.468062) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201 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/73ed53570a8462f88666502d4d1983a385e3b6716048e9df8c784f0932690b599b96320693554b820e2d69c6264d339c816542b39aa7b63ce731c36dd171b189", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47e902a35a3359c531f4f1afff15911533a8054934a77aff84efcdc76529f5d60cd9d3f350d1d8c9036295b84ebd16341df3b2d71aecd809170b6d2ceca75e81"} build_url:https://queue.taskcluster.net/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011403 build_url: 'https://queue.taskcluster.net/v1/task/ZbXoD2JKRfC-nddnVLYkcQ/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/73ed53570a8462f88666502d4d1983a385e3b6716048e9df8c784f0932690b599b96320693554b820e2d69c6264d339c816542b39aa7b63ce731c36dd171b189", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47e902a35a3359c531f4f1afff15911533a8054934a77aff84efcdc76529f5d60cd9d3f350d1d8c9036295b84ebd16341df3b2d71aecd809170b6d2ceca75e81"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 18:40:53.493354) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:40:53.493695) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1459300022.362497-930219201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 18:40:53.576753) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 18:40:53.577143) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 18:40:53.577465) ========= ========= Total master_lag: 0.27 =========