builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1457915524.63 results: success (0) buildid: 20160313160424 builduid: ebdc27b3a52348b5a6eb4131bb06199b revision: 985daf7c2e1ee1e08a005bf72fd8731c5f26a6bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.632792) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.633252) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.633925) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006367 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.665826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.666140) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.722914) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.723245) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004628 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.775762) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.776063) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.776468) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.776802) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-13 17:32:06-- 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% 88.4M=0s 2016-03-13 17:32:07 (88.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201289 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.990815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:04.991156) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014302 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:05.041359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:05.041738) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 985daf7c2e1ee1e08a005bf72fd8731c5f26a6bc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 985daf7c2e1ee1e08a005bf72fd8731c5f26a6bc --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=74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-13 17:32:07,180 truncating revision to first 12 chars 2016-03-13 17:32:07,180 Setting DEBUG logging. 2016-03-13 17:32:07,180 attempt 1/10 2016-03-13 17:32:07,180 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/985daf7c2e1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-13 17:32:07,473 unpacking tar archive at: mozilla-central-985daf7c2e1e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:05.626827) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:05.627219) ========= echo 985daf7c2e1ee1e08a005bf72fd8731c5f26a6bc in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'985daf7c2e1ee1e08a005bf72fd8731c5f26a6bc'] 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=74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 985daf7c2e1ee1e08a005bf72fd8731c5f26a6bc program finished with exit code 0 elapsedTime=0.003991 script_repo_revision: '985daf7c2e1ee1e08a005bf72fd8731c5f26a6bc' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:05.682998) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:05.683345) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-13 17:32:05.701550) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-03-13 17:32:05.701859) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:32:07 INFO - MultiFileLogger online at 20160313 17:32:07 in /builds/slave/test 17:32:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:32:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:32:07 INFO - {'append_to_log': False, 17:32:07 INFO - 'base_work_dir': '/builds/slave/test', 17:32:07 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:32:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:32:07 INFO - 'branch': 'Firefox-Non-PGO', 17:32:07 INFO - 'buildbot_json_path': 'buildprops.json', 17:32:07 INFO - 'config_files': ('talos/linux_config.py',), 17:32:07 INFO - 'default_actions': ('clobber', 17:32:07 INFO - 'read-buildbot-config', 17:32:07 INFO - 'download-and-extract', 17:32:07 INFO - 'populate-webroot', 17:32:07 INFO - 'create-virtualenv', 17:32:07 INFO - 'install', 17:32:07 INFO - 'run-tests'), 17:32:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:32:07 INFO - 'download_minidump_stackwalk': True, 17:32:07 INFO - 'download_symbols': 'ondemand', 17:32:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:32:07 INFO - 'tooltool.py': '/tools/tooltool.py', 17:32:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:32:07 INFO - '/tools/misc-python/virtualenv.py')}, 17:32:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:32:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:32:07 INFO - 'installer_path': 'installer.exe', 17:32:07 INFO - 'log_level': 'info', 17:32:07 INFO - 'log_name': 'talos', 17:32:07 INFO - 'log_to_console': True, 17:32:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:32:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:32:07 INFO - 'opt_config_files': (), 17:32:07 INFO - 'pip_index': False, 17:32:07 INFO - 'sps_profile': False, 17:32:07 INFO - 'sps_profile_interval': 0, 17:32:07 INFO - 'suite': 'dromaeojs', 17:32:07 INFO - 'system_bits': '32', 17:32:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:32:07 INFO - 'title': 'talos-linux64-ix-042', 17:32:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:32:07 INFO - 'use_talos_json': True, 17:32:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:32:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:32:07 INFO - 'work_dir': 'build'} 17:32:07 INFO - ##### 17:32:07 INFO - ##### Running clobber step. 17:32:07 INFO - ##### 17:32:07 INFO - Running pre-action listener: _resource_record_pre_action 17:32:07 INFO - Running main action method: clobber 17:32:07 INFO - rmtree: /builds/slave/test/build 17:32:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:32:08 INFO - Running post-action listener: _resource_record_post_action 17:32:08 INFO - ##### 17:32:08 INFO - ##### Running read-buildbot-config step. 17:32:08 INFO - ##### 17:32:08 INFO - Running pre-action listener: _resource_record_pre_action 17:32:08 INFO - Running main action method: read_buildbot_config 17:32:08 INFO - Using buildbot properties: 17:32:08 INFO - { 17:32:08 INFO - "project": "", 17:32:08 INFO - "product": "firefox", 17:32:08 INFO - "script_repo_revision": "production", 17:32:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:32:08 INFO - "repository": "", 17:32:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:32:08 INFO - "buildid": "20160313160424", 17:32:08 INFO - "pgo_build": "False", 17:32:08 INFO - "basedir": "/builds/slave/test", 17:32:08 INFO - "buildnumber": 36, 17:32:08 INFO - "slavename": "talos-linux64-ix-042", 17:32:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:32:08 INFO - "platform": "ubuntu64_hw", 17:32:08 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:32:08 INFO - "branch": "mozilla-central", 17:32:08 INFO - "repo_path": "mozilla-central", 17:32:08 INFO - "revision": "985daf7c2e1ee1e08a005bf72fd8731c5f26a6bc", 17:32:08 INFO - "stage_platform": "linux64", 17:32:08 INFO - "builduid": "ebdc27b3a52348b5a6eb4131bb06199b", 17:32:08 INFO - "slavebuilddir": "test" 17:32:08 INFO - } 17:32:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:32:08 INFO - Running post-action listener: _resource_record_post_action 17:32:08 INFO - ##### 17:32:08 INFO - ##### Running download-and-extract step. 17:32:08 INFO - ##### 17:32:08 INFO - Running pre-action listener: _resource_record_pre_action 17:32:08 INFO - Running main action method: download_and_extract 17:32:08 INFO - mkdir: /builds/slave/test/build/tests 17:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:08 INFO - https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:32:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:32:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:32:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/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 17:32:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/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 17:32:15 INFO - Downloaded 1361 bytes. 17:32:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:32:15 INFO - Using the following test package requirements: 17:32:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:32:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:32:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:32:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:15 INFO - u'jsshell-linux-x86_64.zip'], 17:32:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:32:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:32:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:32:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:32:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:32:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:32:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:32:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:15 INFO - https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/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 17:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/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 17:32:30 INFO - Downloaded 21981050 bytes. 17:32:30 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'] 17:32:30 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 17:32:31 INFO - Return code: 0 17:32:31 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 17:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:31 INFO - https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:32:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:32:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:32:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/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 17:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/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 17:32:32 INFO - Downloaded 21981050 bytes. 17:32:32 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'] 17:32:32 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 17:32:33 INFO - Return code: 0 17:32: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')]} 17:32:33 INFO - https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:32:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:32:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:32:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/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 17:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/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 17:32:35 INFO - Downloaded 10845263 bytes. 17:32:35 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'] 17:32:35 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 17:32:35 INFO - Return code: 0 17:32: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')]} 17:32:35 INFO - https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:32:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:32:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:32:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/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 17:32:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I94NRMJBRSaQOEZZgPFbSw/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 17:32:36 INFO - Downloaded 54106832 bytes. 17:32:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:32:36 INFO - mkdir: /builds/slave/test/properties 17:32:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:32:36 INFO - Writing to file /builds/slave/test/properties/build_url 17:32:36 INFO - Contents: 17:32:36 INFO - build_url:https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:32:37 INFO - Running post-action listener: _resource_record_post_action 17:32:37 INFO - Running post-action listener: set_extra_try_arguments 17:32:37 INFO - ##### 17:32:37 INFO - ##### Running populate-webroot step. 17:32:37 INFO - ##### 17:32:37 INFO - Running pre-action listener: _resource_record_pre_action 17:32:37 INFO - Running main action method: populate_webroot 17:32:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:32:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:32:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:32:37 INFO - '--tppagecycles', 17:32:37 INFO - '7'], 17:32:37 INFO - 'tests': ['tsvgm']}}, 17:32:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:32:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:32:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:32:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:32:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:32:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:32:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:32:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:37 INFO - 'talos_options': ['--e10s'], 17:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:32:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:37 INFO - 'tests': ['damp', 'tps']}, 17:32:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:37 INFO - 'talos_options': ['--e10s'], 17:32:37 INFO - 'tests': ['damp', 'tps']}, 17:32:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:32:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:32:37 INFO - 'other': {'tests': ['a11yr', 17:32:37 INFO - 'ts_paint', 17:32:37 INFO - 'tpaint', 17:32:37 INFO - 'sessionrestore', 17:32:37 INFO - 'sessionrestore_no_auto_restore', 17:32:37 INFO - 'tabpaint']}, 17:32:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:32:37 INFO - 'tests': ['a11yr', 17:32:37 INFO - 'ts_paint', 17:32:37 INFO - 'tpaint', 17:32:37 INFO - 'sessionrestore', 17:32:37 INFO - 'sessionrestore_no_auto_restore', 17:32:37 INFO - 'tabpaint']}, 17:32:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:32:37 INFO - 'tests': ['a11yr', 17:32:37 INFO - 'ts_paint', 17:32:37 INFO - 'tpaint', 17:32:37 INFO - 'sessionrestore', 17:32:37 INFO - 'sessionrestore_no_auto_restore', 17:32:37 INFO - 'tabpaint']}, 17:32:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:32:37 INFO - 'tests': ['a11yr', 17:32:37 INFO - 'ts_paint', 17:32:37 INFO - 'tpaint', 17:32:37 INFO - 'sessionrestore', 17:32:37 INFO - 'sessionrestore_no_auto_restore', 17:32:37 INFO - 'tabpaint']}, 17:32:37 INFO - 'other_l64': {'tests': ['a11yr', 17:32:37 INFO - 'ts_paint', 17:32:37 INFO - 'tpaint', 17:32:37 INFO - 'sessionrestore', 17:32:37 INFO - 'sessionrestore_no_auto_restore', 17:32:37 INFO - 'tabpaint']}, 17:32:37 INFO - 'other_nol64': {'tests': ['a11yr', 17:32:37 INFO - 'ts_paint', 17:32:37 INFO - 'tpaint', 17:32:37 INFO - 'sessionrestore', 17:32:37 INFO - 'sessionrestore_no_auto_restore', 17:32:37 INFO - 'tabpaint']}, 17:32:37 INFO - 'svgr': {'tests': ['tsvgx', 17:32:37 INFO - 'tsvgr_opacity', 17:32:37 INFO - 'tart', 17:32:37 INFO - 'tscrollx', 17:32:37 INFO - 'cart']}, 17:32:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:32:37 INFO - 'tests': ['tsvgx', 17:32:37 INFO - 'tsvgr_opacity', 17:32:37 INFO - 'tart', 17:32:37 INFO - 'tscrollx', 17:32:37 INFO - 'cart']}, 17:32:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:37 INFO - 'tests': ['tp5o']}, 17:32:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:37 INFO - 'talos_options': ['--e10s'], 17:32:37 INFO - 'tests': ['tp5o']}, 17:32:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:37 INFO - 'talos_options': ['--xperf_path', 17:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:32:37 INFO - 'tests': ['tp5n']}, 17:32:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:32:37 INFO - 'talos_options': ['--e10s', 17:32:37 INFO - '--xperf_path', 17:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:32:37 INFO - 'tests': ['tp5n']}}, 17:32:37 INFO - 'talos.zip': {'path': '', 17:32:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:32:37 INFO - Running post-action listener: _resource_record_post_action 17:32:37 INFO - ##### 17:32:37 INFO - ##### Running create-virtualenv step. 17:32:37 INFO - ##### 17:32:37 INFO - Running pre-action listener: _resource_record_pre_action 17:32:37 INFO - Running main action method: create_virtualenv 17:32:37 INFO - Creating virtualenv /builds/slave/test/build/venv 17:32:37 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 17:32:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:32:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:32:37 INFO - Using real prefix '/usr' 17:32:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:32:37 INFO - Installing distribute.............................................................................................................................................................................................done. 17:32:39 INFO - Installing pip.................done. 17:32:39 INFO - Return code: 0 17:32:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:32: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')]} 17:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32: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')]} 17:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7203076f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2159160>, '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 0x215a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', '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 17:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:32:39 INFO - Using env: {'DISPLAY': ':0', 17:32:39 INFO - 'HOME': '/home/cltbld', 17:32:39 INFO - 'LANG': 'en_US.UTF-8', 17:32:39 INFO - 'LANGUAGE': 'en_US:en', 17:32:39 INFO - 'LOGNAME': 'cltbld', 17:32:39 INFO - 'MAIL': '/var/mail/cltbld', 17:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:39 INFO - 'MOZ_NO_REMOTE': '1', 17:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:39 INFO - 'NO_EM_RESTART': '1', 17:32:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:39 INFO - 'PWD': '/builds/slave/test', 17:32:39 INFO - 'SHELL': '/bin/bash', 17:32:39 INFO - 'SHLVL': '1', 17:32:39 INFO - 'TERM': 'linux', 17:32:39 INFO - 'TMOUT': '86400', 17:32:39 INFO - 'USER': 'cltbld', 17:32:39 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', 17:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:39 INFO - '_': '/tools/buildbot/bin/python'} 17:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:40 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 17:32:40 INFO - Cleaning up... 17:32:40 INFO - Return code: 0 17:32:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:40 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 0x7f7203076f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2159160>, '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 0x215a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', '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 17:32:40 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 17:32:40 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 17:32:40 INFO - Using env: {'DISPLAY': ':0', 17:32:40 INFO - 'HOME': '/home/cltbld', 17:32:40 INFO - 'LANG': 'en_US.UTF-8', 17:32:40 INFO - 'LANGUAGE': 'en_US:en', 17:32:40 INFO - 'LOGNAME': 'cltbld', 17:32:40 INFO - 'MAIL': '/var/mail/cltbld', 17:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:40 INFO - 'MOZ_NO_REMOTE': '1', 17:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:40 INFO - 'NO_EM_RESTART': '1', 17:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:40 INFO - 'PWD': '/builds/slave/test', 17:32:40 INFO - 'SHELL': '/bin/bash', 17:32:40 INFO - 'SHLVL': '1', 17:32:40 INFO - 'TERM': 'linux', 17:32:40 INFO - 'TMOUT': '86400', 17:32:40 INFO - 'USER': 'cltbld', 17:32:40 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', 17:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:40 INFO - '_': '/tools/buildbot/bin/python'} 17:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:40 INFO - Downloading/unpacking psutil>=0.7.1 17:32:40 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 17:32:40 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 17:32:40 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 17:32:40 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 17:32:40 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 17:32:40 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 17:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:42 INFO - Installing collected packages: psutil 17:32:42 INFO - Running setup.py install for psutil 17:32:42 INFO - building 'psutil._psutil_linux' extension 17:32:42 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 17:32:42 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 17:32:42 INFO - building 'psutil._psutil_posix' extension 17:32:42 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 17:32:42 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 17:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:32:42 INFO - Successfully installed psutil 17:32:42 INFO - Cleaning up... 17:32:42 INFO - Return code: 0 17:32:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:32: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')]} 17:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32: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')]} 17:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7203076f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2159160>, '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 0x215a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', '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 17:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:32:42 INFO - Using env: {'DISPLAY': ':0', 17:32:42 INFO - 'HOME': '/home/cltbld', 17:32:42 INFO - 'LANG': 'en_US.UTF-8', 17:32:42 INFO - 'LANGUAGE': 'en_US:en', 17:32:42 INFO - 'LOGNAME': 'cltbld', 17:32:42 INFO - 'MAIL': '/var/mail/cltbld', 17:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:42 INFO - 'MOZ_NO_REMOTE': '1', 17:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:42 INFO - 'NO_EM_RESTART': '1', 17:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:42 INFO - 'PWD': '/builds/slave/test', 17:32:42 INFO - 'SHELL': '/bin/bash', 17:32:42 INFO - 'SHLVL': '1', 17:32:42 INFO - 'TERM': 'linux', 17:32:42 INFO - 'TMOUT': '86400', 17:32:42 INFO - 'USER': 'cltbld', 17:32:42 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', 17:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:42 INFO - '_': '/tools/buildbot/bin/python'} 17:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:32:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:32:44 INFO - Installing collected packages: mozsystemmonitor 17:32:44 INFO - Running setup.py install for mozsystemmonitor 17:32:45 INFO - Successfully installed mozsystemmonitor 17:32:45 INFO - Cleaning up... 17:32:45 INFO - Return code: 0 17:32:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:32:45 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')]} 17:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:45 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')]} 17:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:45 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 0x7f7203076f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2159160>, '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 0x215a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', '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 17:32:45 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 17:32:45 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 17:32:45 INFO - Using env: {'DISPLAY': ':0', 17:32:45 INFO - 'HOME': '/home/cltbld', 17:32:45 INFO - 'LANG': 'en_US.UTF-8', 17:32:45 INFO - 'LANGUAGE': 'en_US:en', 17:32:45 INFO - 'LOGNAME': 'cltbld', 17:32:45 INFO - 'MAIL': '/var/mail/cltbld', 17:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:45 INFO - 'MOZ_NO_REMOTE': '1', 17:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:45 INFO - 'NO_EM_RESTART': '1', 17:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:45 INFO - 'PWD': '/builds/slave/test', 17:32:45 INFO - 'SHELL': '/bin/bash', 17:32:45 INFO - 'SHLVL': '1', 17:32:45 INFO - 'TERM': 'linux', 17:32:45 INFO - 'TMOUT': '86400', 17:32:45 INFO - 'USER': 'cltbld', 17:32:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', 17:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:45 INFO - '_': '/tools/buildbot/bin/python'} 17:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:45 INFO - Downloading/unpacking blobuploader==1.2.4 17:32:45 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 17:32:45 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 17:32:45 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 17:32:45 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 17:32:45 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 17:32:45 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 17:32:47 INFO - Downloading blobuploader-1.2.4.tar.gz 17:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:32:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:32:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:47 INFO - Downloading docopt-0.6.1.tar.gz 17:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:32:47 INFO - Installing collected packages: blobuploader, requests, docopt 17:32:47 INFO - Running setup.py install for blobuploader 17:32:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:32:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:32:47 INFO - Running setup.py install for requests 17:32:48 INFO - Running setup.py install for docopt 17:32:48 INFO - Successfully installed blobuploader requests docopt 17:32:48 INFO - Cleaning up... 17:32:48 INFO - Return code: 0 17:32:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:48 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')]} 17:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:48 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')]} 17:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:48 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 0x7f7203076f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2159160>, '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 0x215a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', '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 17:32:48 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 17:32:48 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 17:32:48 INFO - Using env: {'DISPLAY': ':0', 17:32:48 INFO - 'HOME': '/home/cltbld', 17:32:48 INFO - 'LANG': 'en_US.UTF-8', 17:32:48 INFO - 'LANGUAGE': 'en_US:en', 17:32:48 INFO - 'LOGNAME': 'cltbld', 17:32:48 INFO - 'MAIL': '/var/mail/cltbld', 17:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:48 INFO - 'MOZ_NO_REMOTE': '1', 17:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:48 INFO - 'NO_EM_RESTART': '1', 17:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:48 INFO - 'PWD': '/builds/slave/test', 17:32:48 INFO - 'SHELL': '/bin/bash', 17:32:48 INFO - 'SHLVL': '1', 17:32:48 INFO - 'TERM': 'linux', 17:32:48 INFO - 'TMOUT': '86400', 17:32:48 INFO - 'USER': 'cltbld', 17:32:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', 17:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:48 INFO - '_': '/tools/buildbot/bin/python'} 17:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:48 INFO - Running setup.py (path:/tmp/pip-W7n7r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:48 INFO - Running setup.py (path:/tmp/pip-BZHxVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:48 INFO - Running setup.py (path:/tmp/pip-vNaojB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:48 INFO - Running setup.py (path:/tmp/pip-Twpx5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:48 INFO - Running setup.py (path:/tmp/pip-U1hglD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:49 INFO - Running setup.py (path:/tmp/pip-wYLBwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:49 INFO - Running setup.py (path:/tmp/pip-A5kFr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:49 INFO - Running setup.py (path:/tmp/pip-G1q0is-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:49 INFO - Running setup.py (path:/tmp/pip-yo6CMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:49 INFO - Running setup.py (path:/tmp/pip-hZZHf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:49 INFO - Running setup.py (path:/tmp/pip-e1EoxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:49 INFO - Running setup.py (path:/tmp/pip-dVBczq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:49 INFO - Running setup.py (path:/tmp/pip-J1HU5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:49 INFO - Running setup.py (path:/tmp/pip-YDi0V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:49 INFO - Running setup.py (path:/tmp/pip-mgtrCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:49 INFO - Running setup.py (path:/tmp/pip-BpCzp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:49 INFO - Running setup.py (path:/tmp/pip-9NIKRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:32:49 INFO - Running setup.py install for manifestparser 17:32:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:32:50 INFO - Running setup.py install for mozcrash 17:32:50 INFO - Running setup.py install for mozdebug 17:32:50 INFO - Running setup.py install for mozdevice 17:32:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:32:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:32:50 INFO - Running setup.py install for mozfile 17:32:50 INFO - Running setup.py install for mozhttpd 17:32:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:32:50 INFO - Running setup.py install for mozinfo 17:32:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:32:50 INFO - Running setup.py install for mozInstall 17:32:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:32:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:32:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:32:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:32:50 INFO - Running setup.py install for mozleak 17:32:50 INFO - Running setup.py install for mozlog 17:32:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:32:50 INFO - Running setup.py install for moznetwork 17:32:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:32:51 INFO - Running setup.py install for mozprocess 17:32:51 INFO - Running setup.py install for mozprofile 17:32:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:32:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:32:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:32:51 INFO - Running setup.py install for mozrunner 17:32:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:32:51 INFO - Running setup.py install for mozscreenshot 17:32:51 INFO - Running setup.py install for moztest 17:32:51 INFO - Running setup.py install for mozversion 17:32:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:32:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:32:51 INFO - Cleaning up... 17:32:51 INFO - Return code: 0 17:32:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:51 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 0x7f7203076f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2159160>, '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 0x215a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', '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 17:32:51 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 17:32:51 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 17:32:51 INFO - Using env: {'DISPLAY': ':0', 17:32:51 INFO - 'HOME': '/home/cltbld', 17:32:51 INFO - 'LANG': 'en_US.UTF-8', 17:32:51 INFO - 'LANGUAGE': 'en_US:en', 17:32:51 INFO - 'LOGNAME': 'cltbld', 17:32:51 INFO - 'MAIL': '/var/mail/cltbld', 17:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:51 INFO - 'MOZ_NO_REMOTE': '1', 17:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:51 INFO - 'NO_EM_RESTART': '1', 17:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:51 INFO - 'PWD': '/builds/slave/test', 17:32:51 INFO - 'SHELL': '/bin/bash', 17:32:51 INFO - 'SHLVL': '1', 17:32:51 INFO - 'TERM': 'linux', 17:32:51 INFO - 'TMOUT': '86400', 17:32:51 INFO - 'USER': 'cltbld', 17:32:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', 17:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:51 INFO - '_': '/tools/buildbot/bin/python'} 17:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:51 INFO - Running setup.py (path:/tmp/pip-Nzm34m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:51 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)) 17:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:51 INFO - Running setup.py (path:/tmp/pip-9sgTP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:52 INFO - Running setup.py (path:/tmp/pip-VTwei0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:52 INFO - Running setup.py (path:/tmp/pip-2f93QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:52 INFO - Running setup.py (path:/tmp/pip-_2JE1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:52 INFO - Running setup.py (path:/tmp/pip-d5AnsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:52 INFO - Running setup.py (path:/tmp/pip-amNACu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:52 INFO - Running setup.py (path:/tmp/pip-6LpecJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:52 INFO - Running setup.py (path:/tmp/pip-_iDGKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:52 INFO - Running setup.py (path:/tmp/pip-ec5d_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:52 INFO - Running setup.py (path:/tmp/pip-IltmYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:52 INFO - Running setup.py (path:/tmp/pip-GZmq1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:52 INFO - Running setup.py (path:/tmp/pip-08ATLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:52 INFO - Running setup.py (path:/tmp/pip-TPOhLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:52 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)) 17:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:52 INFO - Running setup.py (path:/tmp/pip-KfE21f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:53 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)) 17:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:53 INFO - Running setup.py (path:/tmp/pip-EjWbE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:53 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)) 17:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:53 INFO - Running setup.py (path:/tmp/pip-EB9dFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:53 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)) 17:32:53 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)) 17:32:53 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)) 17:32:53 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)) 17:32:53 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)) 17:32:53 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)) 17:32:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:32:53 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 17:32:53 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 17:32:53 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 17:32:53 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 17:32:53 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 17:32:53 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 17:32:55 INFO - Downloading blessings-1.6.tar.gz 17:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:32:55 INFO - Installing collected packages: blessings 17:32:55 INFO - Running setup.py install for blessings 17:32:55 INFO - Successfully installed blessings 17:32:55 INFO - Cleaning up... 17:32:55 INFO - Return code: 0 17:32:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:55 INFO - Reading from file tmpfile_stdout 17:32:55 INFO - Current package versions: 17:32:55 INFO - argparse == 1.2.1 17:32:55 INFO - blessings == 1.6 17:32:55 INFO - blobuploader == 1.2.4 17:32:55 INFO - docopt == 0.6.1 17:32:55 INFO - manifestparser == 1.1 17:32:55 INFO - mozInstall == 1.12 17:32:55 INFO - mozcrash == 0.17 17:32:55 INFO - mozdebug == 0.1 17:32:55 INFO - mozdevice == 0.48 17:32:55 INFO - mozfile == 1.2 17:32:55 INFO - mozhttpd == 0.7 17:32:55 INFO - mozinfo == 0.9 17:32:55 INFO - mozleak == 0.1 17:32:55 INFO - mozlog == 3.1 17:32:55 INFO - moznetwork == 0.27 17:32:55 INFO - mozprocess == 0.22 17:32:55 INFO - mozprofile == 0.28 17:32:55 INFO - mozrunner == 6.11 17:32:55 INFO - mozscreenshot == 0.1 17:32:55 INFO - mozsystemmonitor == 0.0 17:32:55 INFO - moztest == 0.7 17:32:55 INFO - mozversion == 1.4 17:32:55 INFO - psutil == 3.1.1 17:32:55 INFO - requests == 1.2.3 17:32:55 INFO - wsgiref == 0.1.2 17:32:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:55 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 0x7f7203076f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2159160>, '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 0x215a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', '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 17:32:55 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 17:32:55 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 17:32:55 INFO - Using env: {'DISPLAY': ':0', 17:32:55 INFO - 'HOME': '/home/cltbld', 17:32:55 INFO - 'LANG': 'en_US.UTF-8', 17:32:55 INFO - 'LANGUAGE': 'en_US:en', 17:32:55 INFO - 'LOGNAME': 'cltbld', 17:32:55 INFO - 'MAIL': '/var/mail/cltbld', 17:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:55 INFO - 'MOZ_NO_REMOTE': '1', 17:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:55 INFO - 'NO_EM_RESTART': '1', 17:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:55 INFO - 'PWD': '/builds/slave/test', 17:32:55 INFO - 'SHELL': '/bin/bash', 17:32:55 INFO - 'SHLVL': '1', 17:32:55 INFO - 'TERM': 'linux', 17:32:55 INFO - 'TMOUT': '86400', 17:32:55 INFO - 'USER': 'cltbld', 17:32:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', 17:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:55 INFO - '_': '/tools/buildbot/bin/python'} 17:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:55 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)) 17:32:55 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)) 17:32:55 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)) 17:32:55 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)) 17:32:55 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)) 17:32:55 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)) 17:32:55 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)) 17:32:55 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)) 17:32:55 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)) 17:32:55 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)) 17:32:55 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)) 17:32:55 INFO - Cleaning up... 17:32:55 INFO - Return code: 0 17:32:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:55 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 0x7f7203076f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2159160>, '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 0x215a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', '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 17:32:55 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 17:32:55 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 17:32:55 INFO - Using env: {'DISPLAY': ':0', 17:32:55 INFO - 'HOME': '/home/cltbld', 17:32:55 INFO - 'LANG': 'en_US.UTF-8', 17:32:55 INFO - 'LANGUAGE': 'en_US:en', 17:32:55 INFO - 'LOGNAME': 'cltbld', 17:32:55 INFO - 'MAIL': '/var/mail/cltbld', 17:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:55 INFO - 'MOZ_NO_REMOTE': '1', 17:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:55 INFO - 'NO_EM_RESTART': '1', 17:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:55 INFO - 'PWD': '/builds/slave/test', 17:32:55 INFO - 'SHELL': '/bin/bash', 17:32:55 INFO - 'SHLVL': '1', 17:32:55 INFO - 'TERM': 'linux', 17:32:55 INFO - 'TMOUT': '86400', 17:32:55 INFO - 'USER': 'cltbld', 17:32:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', 17:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:55 INFO - '_': '/tools/buildbot/bin/python'} 17:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:56 INFO - Downloading/unpacking jsonschema 17:32:56 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 17:32:56 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 17:32:56 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 17:32:56 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 17:32:56 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 17:32:56 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 17:32:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:32:57 INFO - Downloading/unpacking functools32 (from jsonschema) 17:32:57 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 17:32:57 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 17:32:57 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 17:32:57 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 17:32:57 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 17:32:57 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 17:32:58 INFO - Downloading functools32-3.2.3-2.tar.gz 17:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:32:58 INFO - warning: no files found matching '*.txt' 17:32:58 INFO - no previously-included directories found matching 'build' 17:32:58 INFO - no previously-included directories found matching 'dist' 17:32:58 INFO - no previously-included directories found matching '.git*' 17:32:58 INFO - Installing collected packages: jsonschema, functools32 17:32:58 INFO - Running setup.py install for functools32 17:32:58 INFO - warning: no files found matching '*.txt' 17:32:58 INFO - no previously-included directories found matching 'build' 17:32:58 INFO - no previously-included directories found matching 'dist' 17:32:58 INFO - no previously-included directories found matching '.git*' 17:32:58 INFO - Successfully installed jsonschema functools32 17:32:58 INFO - Cleaning up... 17:32:58 INFO - Return code: 0 17:32:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:58 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 0x7f7203076f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20ca410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2159160>, '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 0x215a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a4f0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', '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 17:32:58 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 17:32:58 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 17:32:58 INFO - Using env: {'DISPLAY': ':0', 17:32:58 INFO - 'HOME': '/home/cltbld', 17:32:58 INFO - 'LANG': 'en_US.UTF-8', 17:32:58 INFO - 'LANGUAGE': 'en_US:en', 17:32:58 INFO - 'LOGNAME': 'cltbld', 17:32:58 INFO - 'MAIL': '/var/mail/cltbld', 17:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:58 INFO - 'MOZ_NO_REMOTE': '1', 17:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:58 INFO - 'NO_EM_RESTART': '1', 17:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:58 INFO - 'PWD': '/builds/slave/test', 17:32:58 INFO - 'SHELL': '/bin/bash', 17:32:58 INFO - 'SHLVL': '1', 17:32:58 INFO - 'TERM': 'linux', 17:32:58 INFO - 'TMOUT': '86400', 17:32:58 INFO - 'USER': 'cltbld', 17:32:58 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', 17:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:58 INFO - '_': '/tools/buildbot/bin/python'} 17:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:58 INFO - Downloading/unpacking flake8 17:32:58 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 17:32:58 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 17:32:58 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 17:32:58 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 17:32:58 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 17:32:58 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 17:33:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:33:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:33:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:33:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:33:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:33:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:33:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:33:01 INFO - no previously-included directories found matching 'docs/_build' 17:33:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:33:01 INFO - Running setup.py install for pep8 17:33:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:33:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:33:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:33:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:33:01 INFO - no previously-included directories found matching 'docs/_build' 17:33:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:33:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:33:01 INFO - Cleaning up... 17:33:01 INFO - Return code: 0 17:33:01 INFO - Running post-action listener: _resource_record_post_action 17:33:01 INFO - Running post-action listener: _start_resource_monitoring 17:33:01 INFO - Starting resource monitoring. 17:33:01 INFO - ##### 17:33:01 INFO - ##### Running install step. 17:33:01 INFO - ##### 17:33:01 INFO - Running pre-action listener: _resource_record_pre_action 17:33:01 INFO - Running main action method: install 17:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:33:01 INFO - Reading from file tmpfile_stdout 17:33:01 INFO - Detecting whether we're running mozinstall >=1.0... 17:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:33:01 INFO - Reading from file tmpfile_stdout 17:33:01 INFO - Output received: 17:33:01 INFO - Usage: mozinstall [options] installer 17:33:01 INFO - Options: 17:33:01 INFO - -h, --help show this help message and exit 17:33:01 INFO - -d DEST, --destination=DEST 17:33:01 INFO - Directory to install application into. [default: 17:33:01 INFO - "/builds/slave/test"] 17:33:01 INFO - --app=APP Application being installed. [default: firefox] 17:33:01 INFO - mkdir: /builds/slave/test/build/application 17:33:01 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'] 17:33:01 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 17:33:17 INFO - Reading from file tmpfile_stdout 17:33:17 INFO - Output received: 17:33:17 INFO - /builds/slave/test/build/application/firefox/firefox 17:33:17 INFO - Running post-action listener: _resource_record_post_action 17:33:17 INFO - ##### 17:33:17 INFO - ##### Running run-tests step. 17:33:17 INFO - ##### 17:33:17 INFO - Running pre-action listener: _resource_record_pre_action 17:33:17 INFO - Running main action method: run_tests 17:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:33:17 INFO - Python 2.7.3 17:33:17 INFO - Return code: 0 17:33:17 INFO - grabbing minidump binary from tooltool 17:33: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')]} 17:33:17 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 0x2159160>, '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 0x215a060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215a4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:33:17 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 17:33:17 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 17:33:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:33:17 INFO - Return code: 0 17:33:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:33:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:33:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:33:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:33:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:33:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:33:18 INFO - Return code: 0 17:33:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 17:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 17:33:18 INFO - Using env: {'DISPLAY': ':0', 17:33:18 INFO - 'HOME': '/home/cltbld', 17:33:18 INFO - 'LANG': 'en_US.UTF-8', 17:33:18 INFO - 'LANGUAGE': 'en_US:en', 17:33:18 INFO - 'LOGNAME': 'cltbld', 17:33:18 INFO - 'MAIL': '/var/mail/cltbld', 17:33:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:33:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:33:18 INFO - 'MOZ_NO_REMOTE': '1', 17:33:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:33:18 INFO - 'NO_EM_RESTART': '1', 17:33:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:33:18 INFO - 'PWD': '/builds/slave/test', 17:33:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:33:18 INFO - 'SHELL': '/bin/bash', 17:33:18 INFO - 'SHLVL': '1', 17:33:18 INFO - 'TERM': 'linux', 17:33:18 INFO - 'TMOUT': '86400', 17:33:18 INFO - 'USER': 'cltbld', 17:33:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615', 17:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:33:18 INFO - '_': '/tools/buildbot/bin/python'} 17:33:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 17:33:18 INFO - mozversion application_buildid: 20160313160424 17:33:18 INFO - mozversion application_changeset: 985daf7c2e1ee1e08a005bf72fd8731c5f26a6bc 17:33:18 INFO - mozversion application_display_name: Nightly 17:33:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:33:18 INFO - mozversion application_name: Firefox 17:33:18 INFO - mozversion application_remotingname: firefox 17:33:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:33:18 INFO - mozversion application_vendor: Mozilla 17:33:18 INFO - mozversion application_version: 48.0a1 17:33:18 INFO - mozversion platform_buildid: 20160313160424 17:33:18 INFO - mozversion platform_changeset: 985daf7c2e1ee1e08a005bf72fd8731c5f26a6bc 17:33:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:33:18 INFO - mozversion platform_version: 48.0a1 17:33:18 INFO - using testdate: 1457915598 17:33:18 INFO - actual date: 1457915598 17:33:18 INFO - starting webserver on 'localhost:36830' 17:33:18 INFO - SUITE-START | Running 2 tests 17:33:18 INFO - TEST-START | dromaeo_css 17:33:18 INFO - operating with platform_type : linux_ 17:33:18 INFO - Initialising browser for dromaeo_css test... 17:33:18 INFO - TEST-INFO | started process 7258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1By6ez/profile http://localhost:36830/getInfo.html) 17:33:22 INFO - PROCESS | 7258 | __metrics Screen width/height:1600/1200 17:33:22 INFO - PROCESS | 7258 | colorDepth:24 17:33:22 INFO - PROCESS | 7258 | Browser inner width/height: 1024/697 17:33:22 INFO - PROCESS | 7258 | __metrics 17:33:23 ERROR - PROCESS | 7258 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:33:25 INFO - TEST-INFO | 7258: exit 0 17:33:25 INFO - Browser initialized. 17:33:25 INFO - Running cycle 1/1 for dromaeo_css test... 17:33:25 INFO - TEST-INFO | started process 7353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1By6ez/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:33:37 INFO - PROCESS | 7353 | RSS: Main: 154103808 17:33:37 INFO - PROCESS | 7353 | 17:34:28 INFO - PROCESS | 7353 | 1457915668129 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] 17:36:39 INFO - PROCESS | 7353 | Cycle 1(1): loaded http://localhost:36830/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36830/tests/dromaeo/cssquery-ext.html) 17:36:40 INFO - PROCESS | 7353 | RSS: Main: 246345728 17:36:40 INFO - PROCESS | 7353 | 17:39:42 INFO - PROCESS | 7353 | Cycle 1(1): loaded http://localhost:36830/tests/dromaeo/cssquery-ext.html (next: http://localhost:36830/tests/dromaeo/cssquery-jquery.html) 17:39:43 INFO - PROCESS | 7353 | RSS: Main: 241385472 17:39:43 INFO - PROCESS | 7353 | 17:42:45 INFO - PROCESS | 7353 | Cycle 1(1): loaded http://localhost:36830/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36830/tests/dromaeo/cssquery-mootools.html) 17:42:45 INFO - PROCESS | 7353 | RSS: Main: 241729536 17:42:45 INFO - PROCESS | 7353 | 17:45:47 INFO - PROCESS | 7353 | Cycle 1(1): loaded http://localhost:36830/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36830/tests/dromaeo/cssquery-prototype.html) 17:45:48 INFO - PROCESS | 7353 | RSS: Main: 225927168 17:45:48 INFO - PROCESS | 7353 | 17:48:51 INFO - PROCESS | 7353 | Cycle 1(1): loaded http://localhost:36830/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36830/tests/dromaeo/cssquery-yui.html) 17:48:51 INFO - PROCESS | 7353 | RSS: Main: 225144832 17:48:51 INFO - PROCESS | 7353 | 17:51:54 INFO - PROCESS | 7353 | Cycle 1(1): loaded http://localhost:36830/tests/dromaeo/cssquery-yui.html (next: http://localhost:36830/tests/dromaeo/cssquery-dojo.html) 17:51:54 INFO - PROCESS | 7353 | RSS: Main: 291430400 17:51:54 INFO - PROCESS | 7353 | 17:51:54 INFO - PROCESS | 7353 | __start_tp_report 17:51:54 INFO - PROCESS | 7353 | _x_x_mozilla_page_load 17:51:54 INFO - PROCESS | 7353 | _x_x_mozilla_page_load_details 17:51:54 INFO - PROCESS | 7353 | |i|pagename|runs| 17:51:54 INFO - PROCESS | 7353 | |0;dojo.html;2567.820252582319;2595.4938786936555;2627.0279996401337;2628.8028397870157;2637.2483842105003;4513.323001549769;4535.410396648435;4541.250693635555;4586;4601.286800545912;4497.325401189823;4510.07543453592;4510.774461276931;4520.11857687751;4572.794224259908;4195.580441955811;4225.6619470442365;4268.957310426903;4305.311150215966;4306.590873866993;4141.130362623852;4225.619694227519;4275.957240427602;4281.978590107045;4283.935740963888;4179.164167166578;4206.768627725474;4213.5786421357925;4236.279832428495;4245.12974840157;4224.239636865363;4234.237837189305;4245.066085461224;4260.552641972579;4268.445102136702;4095.9590404096175;4129.731567448106;4214.136102099063;4233.301505251629;4281.293586558214;4460.643148548108;4481.462224533045;4485.882311793305;4489.842855500075;4521;4890.437599676047;4897.14299997499;4905.779239934212;4913.14020046494;4939.629527785431;4861.124997500448;4863.343448634424;4912.164931961575;4946.40643122824;4980.526849949249;4550.226461501553;4560.977195114069;4566.794494247767;4570.977145114286;4610.101030299093;4978;4984.102861484967;4988.55103040728;4991.151504244287;5025.170846810235;4703.952960470351;4789.425268967746;4795.496472870368;4842.443119041355;4856.39295088114;4872.025594880967;4882.7558622068755;4890.902181956341;4899.730514821647;4947.134251505972;4822.734749588736;4839;4845;4847.297141914402;4897.975510122426;4732.290156476487;4811.08589368019;4850.975745121252;4884.682495637772;4886.144924638174;4166.979165104155;4173.5409104998425;4173.874783756492;4202.201581699467;4210.831566737357;3623.637636236408;3653.342398368266;3654.1595433050547;3679.889603311905;3682.208325210093;4198.874033778991;4206.894827629334;4220.409142720022;4226.302660061056;4267.76527291002;4915.631327650441;4933.333999910038;4933.925991110136;4937.876553086202;4965.627577931597;4180.519240287345;4254.553271906405;4258.233517966733;4289;4294.892627684333;4413.7793110344355;4437.400950871655;4442.800073996678;4481.775911204427;4482.596566308983;4659.4175728034;4670.953290467051;4672.929906051412;4701.177293973609;4719.787609557647;4816;4881.365422495053;4939.950600493949;4950.4059512858685;4953.900921981468;4632.652551058617;4638.930416043694;4646.163690535736;4647.628189744744;4692.648051396227;4840.080384726891;4840.29815676732;4846.975765121293;4849.418069831643;4892.143874821963;4728.905421891612;4899;4907.533784290486;4910.950890491049;4921.212605983025;4785.066911952136;4800.855974320776;4804.807807687793;4805.927911081267;4846.442659094108;4767.880802979953;4790.640701947298;4791.496892826203;4795.304680821331;4841.927371089507;4594.770261486846;4643.4892161862845;4691.835785747482;4706.76466176683;4726.834560790356;4780.545848144421;4783.425988881357;4802.471728109975;4806.591439727662;4846.442659094249;4730;4733.9053218936115;4734.100520901018;4770.952290477189;4783.56947874679 17:51:54 INFO - PROCESS | 7353 | |1;ext.html;528.2340606121126;534.3988013484831;545.372821255556;555.4639772619421;556.4407770190959;27671.584926226096;28043.29891752707;28083.859580702094;35282.647173528254;36025.2794944101;38973.61026389735;39314;39374.409383859194;39445;39463.210735785266;7710.267524585155;7842.647080881374;7852.05775306964;7877.739561670134;7904.328132108749;7758;7873.763787086396;7880.881786773203;7885.684572617117;7888.290053895148;7845.215478452166;7927.246911543394;7927.3658107351275;8128.959355203216;8137.145599712034;8014.959925200365;8063;8076.434649574532;8082.1513741057515;8086.595670216466;8008.7597372078935;8129.105798362176;8133.471324363956;8133.715319963832;8137.145599712004;39597.208055838724;39902.20195596072;40020.79989600033;40070;40123.19753604911;3155.54244634529;3227.467467867799;3337.098983274502;3413.5221069050353;3553.4847447120023;27792.58311125335;29776.10671679853;29998.550021749692;30261.243468913453;30782;3403.0981789825714;3428.194374322032;3493.807840568768;3532.364174448598;3543.291341731638;249405;249747;250039;250124;250599.99999999817;42973;57945.42054579485;58394.70802645959;58399.41600584025;58432;41559.37660935088;41689;41732.1653566927;41781.582184178376;41811.372829407585;14295.213763243122;14798.334074966653;14920.70158596822;14929.850701493064;14940.92529537367;9501.762455938657;9524.14282714559;9535.2371810255;9535.761605959768;9696.70909872705;14481.710365792625;14529.564113076625;14961.850381496264;15065.623359415884;15149.469768558047;5821.708914554255;5949.9107513387335;6018.307894592091;6026.849328766816;6076.969615151896;844.4511067805976;860.4192170285032;974.201155052864;999.8050380175941;1034.6275340877278;27034.459310814065;28096.298843357225;28323.716762832108;28326.15021549357;28435.146945591667;990.1089019882164;1005.1908213887745;1031.257494603884;1034.8654674892366;1087.9456027198607;14460.421583136556;14610.26948652563;14649;14686.412543498354;14868.70262594742;309529;311904;314407;315788;315873;49292.26061609079;49829.50170498321;49892;49949;49952;1071.164491696478;1135.3528488761326;1234.7715672600598;1236.8824961628632;1265.3040827544814;24517.877410612833;25508.744912550635;25546.594937278627;25797.226083217534;25805.870970645028;39253;39638;39643.207135856544;39687.40468892911;39689.60310396859;199779;202931;203290;203752;203807;27118;31098.378032439676;31206.843965780026;31770.36459270848;32550.348993019532;35940.28119437544;35955.280894382486;36392;36656.633433666386;36744.448833268056;31156;34058.82970585131;34407.65592344045;34578.65421345754;34748.65251347454;33373.666263338026;33474.33051338911;33915.43887891834;33915.66084339224;33965.83017084899;33259.66740332566;34036.48945265872;34199.31601368009;34353.65646343504;34357.48463773095;27933;28314;30064.54903176498;30540;30644.84677576598;23916.641250381606;24160.87919560391;24186.87906560456;24356.391090222885;24389.878050609634 17:51:54 INFO - PROCESS | 7353 | |2;jquery.html;356.6362310443347;358.5822516767964;360.9693176080033;368.51540224604645;369.5362320288038;15389.69220615587;15780.447684331051;16800.24398902051;17173.570660733487;17192.226349814257;15986.440474583393;16619.169041547906;16625.090609143383;16638.251278692456;16646.83353166468;4739.620830333565;5008.849734507961;5162.535371816536;5904.586678932455;5923.644581325134;5907.379725128864;5943.346231914507;5947.434993675594;5954.642721436706;5963.731632076567;5717.514011309044;5898.233229680136;5972.581919265654;5987.940120598803;5988.2215312009375;5894.204282421861;5934.139549765303;5935.347111817697;5941.792037278675;5959.463648271655;5078.187490001619;5110.131277682803;5134.255532947702;5186.507281808223;5194.3766747990485;18792.71810922837;19296.517587060294;19453.124609392613;19579.412617621496;19597.80402195974;1941.8737782044122;1993.990030049855;2060.781131345013;2239.171017559974;2508.598624220116;12680.492780288778;12796.808047879289;12920.547780827626;13347.265900375476;13386.799198012037;1699.17589968865;1752.5793809485758;1796.9550761230944;1822.334847780564;1843.2811203630595;43555.346669799976;50016.749916250184;52630;53576.46423535754;54079;9852.113309802153;9854.113129818208;10167.491625418847;10388.220883433773;10565.471726413649;11960.521579136912;12556;12955.935220324027;13258.204507729373;13289.269090200132;7486.85026299471;7603;7607.695692172251;7759.495632783851;7766.223377662302;7444.85110297791;7452.925470745223;7500.324970752658;7601.733939312208;7631.3513351365755;4411.205982923105;4415.050764085737;4427.446569178853;4430.490493593214;4495.977520112378;1750.8511776498885;1808.6653969015774;1811.0673003403258;1855.2671694680796;1867.7478540397144;855.6534603485599;866.2506931504204;885.2431171348404;967.685502211784;975.6926568131016;15205.923970380078;15243.847561524464;15709.293081811345;15948.601284967737;16413.261403236884;858.4806192253722;880.5201165364891;883.0551310098133;916;980.161961522902;8775.692850750193;9253.352265341362;9260.351775375659;9387.671431499864;9402.837347410134;290756;299349;300794;301189;405834;70116;74927;75094.24905750982;75688;75831.24168758352;970.4371464550685;977.296346630425;981.7692842182224;1002.2910936852794;1003.2225025605069;14723.411063557338;15043.398264069314;15212.923935380251;15273.541793746206;15512.37950481968;34111;34270.65729342774;34368.50103983351;35251.47122793109;35367.646323536435;42628.360574590784;44563.77718111518;45031.54968450274;45468.772656136505;48845.2673209895;7462.179160292472;7533.886991695239;7545.886811697719;7643.770686879402;7712.730054448291;9416.576254068446;11158;11449.542018319175;11503.712407189887;11569.537218511165;9242.537873106452;9306.255499560155;9551.761205969906;9593.856092158483;10086.646967356108;9498;9598.184154346958;9640.228781697588;9804.950975245078;10326.638567650096;4709.646776491708;5153.5361817436615;9720.951395242979;9919.40483570988;10827;7110;7252.854942901007;7287.1984081752025;7439.590822504814;7544.321011109027;7682.923170768444;9925.156361709336;10316.27786054969;10341.844872327072;10582.788344233226 17:51:54 INFO - PROCESS | 7353 | |3;mootools.html;1307.4574051768516;1420.6448387903026;1428.0931608428648;1580.2098950524737;1777.0936822220672;7000.859982800341;7147.642617869099;7152.892706609398;7166.6774995125215;7172.892406613905;6971.651417429121;7198.8560228795395;7203.675834587443;7204.675789589468;7210.351068403843;1808.6382723455297;1858.005966807758;1862.5436767991794;2218.256883943877;2246.1352379333994;2173.8369622278315;2223.54417344444;2225.343523660516;2225.499262665903;2225.7662945390744;2140.4969832089446;2172.6089303925287;2178.172294528077;2179.8365122615787;2201.7137772089604;2202.592520383726;2206.977930220701;2208.1498623030247;2208.823294136473;2217.678436626696;2174.92387766429;2242.6972358731527;2245.69683092782;2249.7750224977535;2254.447660323215;7298.1607115181905;7315.634218289118;7348.669309881068;7353.4484913631695;7356.852862942711;4456.242438785414;4552.521985191574;4595.793189306489;4595.8391456299205;4597.839075632371;2849.2307077089276;2919.7080291970847;2935.7064293570684;2957.245902294901;2960.052783109406;915.3318077803175;923;930.7812664023949;958.0132463562542;963.2919803944095;9999.300048996573;10026.498675066217;10033.648822291185;10034.147097496721;10052.597896084148;4164.875053748392;4214.367844823301;4323.48118225815;4340.023494713727;4344.847930322424;7664.501807382502;7679.19368466303;7713.7685869424;7728.072631284282;7745.07059152894;4448.55514448559;4458.866234012985;4470.709403888737;4482.39487669167;4482.843100491467;3580.3197392495345;4013.7190396672536;4148.896277593024;4160.854370097032;4163.91672166555;3269.9182520436702;3332.9166770830925;3333.5333053372547;3347.2134048498583;3361.815100169465;1046.7121541576128;1048.3343077146067;1054.1882750282239;1059.1526778577108;1059.7297689089387;1072.6835583502886;1204.114975493012;1208.7280361918497;1217.4399776102914;1248.818921256431;6783.796486105425;6996.650167491707;7019.543729657556;7044.22513523512;7060.470464715167;466.46589654845013;470.3532642616402;471.6604045087532;474.1820359879181;474.65587449099127;5423.5932305076485;5431.21247419122;5454.754536045887;5534.7786088556;5540.058190107611;8610.526421046903;8888.37781355312;9027.277817774562;9084.40951338174;9147.313951453534;8919.375643705009;8928.419652722552;8962.238209752244;8992.325575581857;8996.460212387146;6900.861982760317;7000.36996670292;7039.979203015534;7080.256573059754;7081.07945967021;6723.5293529452465;6735.225449073419;6747.021681856201;6763.729450821912;6818.113645226089;7938.404619653665;8039.196080391914;8246.83506329858;8249.752507424786;8270.751877443687;8220.794480138044;8371.246587807127;8378.916210837813;8425;8518.574071296287;5259.815906443256;5854.063349864001;6106.755729770759;6205.906911396242;6226.377362263737;6906.482013849082;6908.5509441886115;6942.51402401827;6970.825729356807;6976.407005404394;6108.72510737009;6181.96909015452;6331.746730130743;6355.396237357444;6376.139221205078;6128.693565321627;6186.505079593711;6187.752489900354;6267;6267.62394256346;6471.514636402195;6487.3188315226225;6537.411632953057;6540.803775886731;6543.640099794557;6046;6082.057281121433;6088.6042407243385;6095.969520152371;6097.878042439215;5926.7925622603;6134.478569321657;6145.0782382642965;6147.0779383092895;6153.969230153821 17:51:54 INFO - PROCESS | 7353 | |4;prototype.html;310.3931813304988;310.8570057773424;315.96208454985396;316.76559346083906;316.92710676544397;5339.119045357516;5359.437259087798;5503.834884953458;5520.392756796749;5528.75120619572;5325.520703136717;5360.812371566996;5377.4084850666395;5400.054990376678;5418.593605479585;3951;4022.175454031931;4098.323776576861;4106.137711080677;4122.711410201287;4101.589841015904;4135.214309281242;4145.709800313979;4152.252594532983;4159.043420013399;4077.22532718784;4087.7547347159116;4088.3458646616546;4097.856575019875;4097.934537020381;3892.6691231245236;4012.1574469361467;4082.3672330788777;4100.7334523255895;4103.261412945669;3562.6615471530163;3570.3751843427294;3571.8928432147077;3578.7137029037613;3581.8209089545417;5184.092783762826;5192.4547922468355;5193.8961220775755;5194.92207616886;5202.817901373472;4713.787879545429;4722.126406614753;4722.858314250578;4724.173269677793;4727.716337019755;5639.041362968305;5652.802151924704;5657.23627310312;5658.830235092953;5662.915056274159;3898.2593307271527;3908.5895980922164;3909.061825161969;3913.745606535566;3917.9216415671526;5748.856278593027;5873.559483038746;5941.851453713692;5946.256717910304;5950.1372301016545;3939.290927632996;3954.723169378116;3973.821178046937;3976.8210430530694;3978.6618137458063;4023.114914718757;4030.355143177136;4030.496187976503;4031.133306339151;4034.45534852797;4660.300954856799;4661;4672.322513235562;4673.60274376675;4674.602658773974;5621.494065534122;5622.100463925753;5627.493525582717;5631.662100273997;5633.971830140905;1408.1269612840106;1423.978640320396;1424.586869807765;1425.536700572318;1429.7712366021387;939.1031564855547;948.6442584030989;950.1496160935924;976.345848281653;976.8095221431895;4898.877528061756;4909.582685471775;4923.433805112386;4929.211326187793;4930.2851086592245;5769.278840144982;5777.740001699934;5788.450097240755;5860.355360910296;5862.12068189775;4966.776495057658;4972.651914366032;4973.35346404965;4975.726335051607;4978.5768209701855;3114.423831591163;3146;3159.7314228290393;3164.1298642873394;3165.7309128724314;5493.450654934554;5511.3937466878615;5517.531009864127;5522.088855338824;5522.30971128609;5888.911666325009;6117.418845209698;6163.3528479509905;6169.105479705508;6173.135760993375;5525.11598144295;5597.132444471114;5634.126710359901;5638.464345887134;5639.2668953035845;5966.70166491665;5977.9402205977385;6010.1585777991995;6025.969870150621;6032.849178770566;5866.2373891393845;5868.706564671664;5869.325027621878;5875.588708790344;5881.441263080001;5401.6218864679095;5591.04952158126;5624.465675760796;5627.465390787868;5627.5497960162265;4146.91706165881;4191.895202619959;4209.831606735696;4210.221109094705;4211.7472951623;5674.914876276776;5887.264091988502;5899.941000590111;5902.970485147718;5906.291245050621;5537.667739935617;5659.377468478382;5671.744771485375;5730.5129064030025;5736.827895163152;5694.886102278014;5707.8858422832145;5712.571557133315;5715.971420143039;5716.42835716425;5619.775208991595;5634.887302254014;5643.887122257614;5645.125005624135;5651.039323314964;5754.05058165398;5768.307803063659;5770.769169233184;5772.7402266898935;5773.884522309614;5450.209719590716;5585.5531557476115;5603.971980140073;5636.605437619327;5647.407022262603 17:51:54 INFO - PROCESS | 7353 | |5;yui.html;670.4167374384286;732.1836152689746;741.4772585327345;750.984980300394;759.2862709053489;11687.123465740071;11750.706232344195;11788.351640659761;11794.823077653842;11829.881701182985;11214.383208923506;11234.49444774985;13248;13270.867291327084;13317.26755028473;803.57812148622;813.2639960835453;815.7348861619968;816.073756286616;816.7958010497375;650.3853858104094;801.6873419366452;816.8652172391548;821.6302663801283;821.7329367955408;861.2248975921689;862.3833958719514;862.4911302331623;863.3179787967498;863.4517081653132;676.2020815437781;856.546030603781;856.8115014696757;857.1728282207699;857.2541888556933;611.0528680545182;623.5230049012509;626;626.0827887145308;626.4017862940881;11851.82222266658;11901.166918315721;11905.702357441047;11947.820782688266;11955.103367247404;11644.6506604802;11813.586524471602;11885.702857428634;11962.282263064244;12129.454174562166;9308.394954328014;9456.8581471278;9479.099485548863;9518.524073796283;9611.663591774324;3226.2716373527383;3228.96771032289;3270.60752709674;3298.0765385692043;3322.435186018383;41345.58654413447;41758.37362439566;41769.582304176874;45620.08759824818;45820.7708961453;9558.952205239068;9791.265655075898;9813.901860981441;9912.702618921443;9928.205743540499;17303.826961730472;17329;17329.30682772675;17330.566735831453;17349.566260843327;6575.572587781779;6599.637019963948;6702.140947812797;6841.828954276183;6901.89647155283;3773.509443772292;3796.6528325067643;3797.6392242736897;3825.8087095645105;3839.117003089305;2831.4054048650014;2857.914262572126;2861.084452975028;2864.1693908766642;2872.965732336357;347.2863265988418;349.27699661700547;439.69660933956106;503.2702581257192;508.6719066202279;509.7094656046018;603.414687752879;607.547377203977;640.2732898160622;640.5964242527178;6913.3777959983845;6913.861722765517;6999.440044796404;7054.788356349215;7146.428285737128;572.2474945446725;590.8818236352747;595.8897603943284;615.8429600451856;616.608453631938;3272.6072871255124;3418.3676019936393;3421.367047096295;3488.860445582199;3543.3976224041976;56551;57298.7135064322;57351.13973290404;57366;57422.138667920015;47744.5225547747;48363.51636483661;49145;49353.506464935606;49568.75215623971;40100;43473.782631086644;43643.78178109089;43743.34384984164;44625.55374446279;6606.6366349849295;6720.630365329758;6792.72829086831;6885.070515480546;6958.199807022055;33270.334593308486;33280.833595831864;33409.49885751667;33410.33179336351;33546.32907341791;43112.78443607762;43694.78152609216;43893.122137556435;44073.338899917166;44388.334174986754;10238.078572928473;10247.795044098928;10396.116330112025;10426.27016108865;10683.091937185427;11157.72105697364;11288.492017859051;11494;11581.710457238636;11938.940305298765;10446;10502.894971050191;10689.358638481715;10734.355938643706;11147.72130696739;10696.14430845515;10878.292910960763;11029.172812038969;11204.66386008421;11208.383538905438;10815.35107893529;10864.076553493042;11026.558937642725;11158;11169.329840209613;9535.38020028696;9597.664081757104;9622.278329125484;9863.852042219516;10068.093871551595;9629.374090684083;9631.71104866855;9649.517524123625;9706.660266890625;9726.562304696165 17:51:54 INFO - PROCESS | 7353 | __end_tp_report 17:51:54 INFO - PROCESS | 7353 | __start_cc_report 17:51:54 INFO - PROCESS | 7353 | _x_x_mozilla_cycle_collect,857 17:51:54 INFO - PROCESS | 7353 | __end_cc_report 17:51:54 INFO - PROCESS | 7353 | __startTimestamp1457916714371__endTimestamp 17:51:54 INFO - PROCESS | 7353 | 17:51:54 INFO - PROCESS | 7353 | ------- Summary: start ------- 17:51:54 INFO - PROCESS | 7353 | Number of tests: 6 17:51:54 INFO - PROCESS | 7353 | 17:51:54 INFO - PROCESS | 7353 | [#0] dojo.html Cycles:165 Average:4533.85 Median:4670.95 stddev:461.97 (9.9%) stddev-sans-first:436.89 17:51:54 INFO - PROCESS | 7353 | Values: 2567.8 2595.5 2627.0 2628.8 2637.2 4513.3 4535.4 4541.3 4586.0 4601.3 4497.3 4510.1 4510.8 4520.1 4572.8 4195.6 4225.7 4269.0 4305.3 4306.6 4141.1 4225.6 4276.0 4282.0 4283.9 4179.2 4206.8 4213.6 4236.3 4245.1 4224.2 4234.2 4245.1 4260.6 4268.4 4096.0 4129.7 4214.1 4233.3 4281.3 4460.6 4481.5 4485.9 4489.8 4521.0 4890.4 4897.1 4905.8 4913.1 4939.6 4861.1 4863.3 4912.2 4946.4 4980.5 4550.2 4561.0 4566.8 4571.0 4610.1 4978.0 4984.1 4988.6 4991.2 5025.2 4704.0 4789.4 4795.5 4842.4 4856.4 4872.0 4882.8 4890.9 4899.7 4947.1 4822.7 4839.0 4845.0 4847.3 4898.0 4732.3 4811.1 4851.0 4884.7 4886.1 4167.0 4173.5 4173.9 4202.2 4210.8 3623.6 3653.3 3654.2 3679.9 3682.2 4198.9 4206.9 4220.4 4226.3 4267.8 4915.6 4933.3 4933.9 4937.9 4965.6 4180.5 4254.6 4258.2 4289.0 4294.9 4413.8 4437.4 4442.8 4481.8 4482.6 4659.4 4671.0 4672.9 4701.2 4719.8 4816.0 4881.4 4940.0 4950.4 4953.9 4632.7 4638.9 4646.2 4647.6 4692.6 4840.1 4840.3 4847.0 4849.4 4892.1 4728.9 4899.0 4907.5 4911.0 4921.2 4785.1 4800.9 4804.8 4805.9 4846.4 4767.9 4790.6 4791.5 4795.3 4841.9 4594.8 4643.5 4691.8 4706.8 4726.8 4780.5 4783.4 4802.5 4806.6 4846.4 4730.0 4733.9 4734.1 4771.0 4783.6 17:51:54 INFO - PROCESS | 7353 | 17:51:54 INFO - PROCESS | 7353 | [#1] ext.html Cycles:180 Average:41070.04 Median:34382.57 stddev:67838.36 (197.3%) stddev-sans-first:67960.37 17:51:54 INFO - PROCESS | 7353 | Values: 528.2 534.4 545.4 555.5 556.4 27671.6 28043.3 28083.9 35282.6 36025.3 38973.6 39314.0 39374.4 39445.0 39463.2 7710.3 7842.6 7852.1 7877.7 7904.3 7758.0 7873.8 7880.9 7885.7 7888.3 7845.2 7927.2 7927.4 8129.0 8137.1 8015.0 8063.0 8076.4 8082.2 8086.6 8008.8 8129.1 8133.5 8133.7 8137.1 39597.2 39902.2 40020.8 40070.0 40123.2 3155.5 3227.5 3337.1 3413.5 3553.5 27792.6 29776.1 29998.6 30261.2 30782.0 3403.1 3428.2 3493.8 3532.4 3543.3 249405.0 249747.0 250039.0 250124.0 250600.0 42973.0 57945.4 58394.7 58399.4 58432.0 41559.4 41689.0 41732.2 41781.6 41811.4 14295.2 14798.3 14920.7 14929.9 14940.9 9501.8 9524.1 9535.2 9535.8 9696.7 14481.7 14529.6 14961.9 15065.6 15149.5 5821.7 5949.9 6018.3 6026.8 6077.0 844.5 860.4 974.2 999.8 1034.6 27034.5 28096.3 28323.7 28326.2 28435.1 990.1 1005.2 1031.3 1034.9 1087.9 14460.4 14610.3 14649.0 14686.4 14868.7 309529.0 311904.0 314407.0 315788.0 315873.0 49292.3 49829.5 49892.0 49949.0 49952.0 1071.2 1135.4 1234.8 1236.9 1265.3 24517.9 25508.7 25546.6 25797.2 25805.9 39253.0 39638.0 39643.2 39687.4 39689.6 199779.0 202931.0 203290.0 203752.0 203807.0 27118.0 31098.4 31206.8 31770.4 32550.3 35940.3 35955.3 36392.0 36656.6 36744.4 31156.0 34058.8 34407.7 34578.7 34748.7 33373.7 33474.3 33915.4 33915.7 33965.8 33259.7 34036.5 34199.3 34353.7 34357.5 27933.0 28314.0 30064.5 30540.0 30644.8 23916.6 24160.9 24186.9 24356.4 24389.9 17:51:54 INFO - PROCESS | 7353 | 17:51:54 INFO - PROCESS | 7353 | [#2] jquery.html Cycles:180 Average:21470.62 Median:4724.63 stddev:53275.41 (1127.6%) stddev-sans-first:53401.27 17:51:54 INFO - PROCESS | 7353 | Values: 356.6 358.6 361.0 368.5 369.5 15389.7 15780.4 16800.2 17173.6 17192.2 15986.4 16619.2 16625.1 16638.3 16646.8 4739.6 5008.8 5162.5 5904.6 5923.6 5907.4 5943.3 5947.4 5954.6 5963.7 5717.5 5898.2 5972.6 5987.9 5988.2 5894.2 5934.1 5935.3 5941.8 5959.5 5078.2 5110.1 5134.3 5186.5 5194.4 18792.7 19296.5 19453.1 19579.4 19597.8 1941.9 1994.0 2060.8 2239.2 2508.6 12680.5 12796.8 12920.5 13347.3 13386.8 1699.2 1752.6 1797.0 1822.3 1843.3 43555.3 50016.7 52630.0 53576.5 54079.0 9852.1 9854.1 10167.5 10388.2 10565.5 11960.5 12556.0 12955.9 13258.2 13289.3 7486.9 7603.0 7607.7 7759.5 7766.2 7444.9 7452.9 7500.3 7601.7 7631.4 4411.2 4415.1 4427.4 4430.5 4496.0 1750.9 1808.7 1811.1 1855.3 1867.7 855.7 866.3 885.2 967.7 975.7 15205.9 15243.8 15709.3 15948.6 16413.3 858.5 880.5 883.1 916.0 980.2 8775.7 9253.4 9260.4 9387.7 9402.8 290756.0 299349.0 300794.0 301189.0 405834.0 70116.0 74927.0 75094.2 75688.0 75831.2 970.4 977.3 981.8 1002.3 1003.2 14723.4 15043.4 15212.9 15273.5 15512.4 34111.0 34270.7 34368.5 35251.5 35367.6 42628.4 44563.8 45031.5 45468.8 48845.3 7462.2 7533.9 7545.9 7643.8 7712.7 9416.6 11158.0 11449.5 11503.7 11569.5 9242.5 9306.3 9551.8 9593.9 10086.6 9498.0 9598.2 9640.2 9805.0 10326.6 4709.6 5153.5 9721.0 9919.4 10827.0 7110.0 7252.9 7287.2 7439.6 7544.3 7682.9 9925.2 10316.3 10341.8 10582.8 17:51:54 INFO - PROCESS | 7353 | 17:51:54 INFO - PROCESS | 7353 | [#3] mootools.html Cycles:180 Average:5101.23 Median:6096.92 stddev:2654.29 (43.5%) stddev-sans-first:2646.42 17:51:54 INFO - PROCESS | 7353 | Values: 1307.5 1420.6 1428.1 1580.2 1777.1 7000.9 7147.6 7152.9 7166.7 7172.9 6971.7 7198.9 7203.7 7204.7 7210.4 1808.6 1858.0 1862.5 2218.3 2246.1 2173.8 2223.5 2225.3 2225.5 2225.8 2140.5 2172.6 2178.2 2179.8 2201.7 2202.6 2207.0 2208.1 2208.8 2217.7 2174.9 2242.7 2245.7 2249.8 2254.4 7298.2 7315.6 7348.7 7353.4 7356.9 4456.2 4552.5 4595.8 4595.8 4597.8 2849.2 2919.7 2935.7 2957.2 2960.1 915.3 923.0 930.8 958.0 963.3 9999.3 10026.5 10033.6 10034.1 10052.6 4164.9 4214.4 4323.5 4340.0 4344.8 7664.5 7679.2 7713.8 7728.1 7745.1 4448.6 4458.9 4470.7 4482.4 4482.8 3580.3 4013.7 4148.9 4160.9 4163.9 3269.9 3332.9 3333.5 3347.2 3361.8 1046.7 1048.3 1054.2 1059.2 1059.7 1072.7 1204.1 1208.7 1217.4 1248.8 6783.8 6996.7 7019.5 7044.2 7060.5 466.5 470.4 471.7 474.2 474.7 5423.6 5431.2 5454.8 5534.8 5540.1 8610.5 8888.4 9027.3 9084.4 9147.3 8919.4 8928.4 8962.2 8992.3 8996.5 6900.9 7000.4 7040.0 7080.3 7081.1 6723.5 6735.2 6747.0 6763.7 6818.1 7938.4 8039.2 8246.8 8249.8 8270.8 8220.8 8371.2 8378.9 8425.0 8518.6 5259.8 5854.1 6106.8 6205.9 6226.4 6906.5 6908.6 6942.5 6970.8 6976.4 6108.7 6182.0 6331.7 6355.4 6376.1 6128.7 6186.5 6187.8 6267.0 6267.6 6471.5 6487.3 6537.4 6540.8 6543.6 6046.0 6082.1 6088.6 6096.0 6097.9 5926.8 6134.5 6145.1 6147.1 6154.0 17:51:54 INFO - PROCESS | 7353 | 17:51:54 INFO - PROCESS | 7353 | [#4] prototype.html Cycles:180 Average:4695.15 Median:5400.84 stddev:1401.50 (25.9%) stddev-sans-first:1366.25 17:51:54 INFO - PROCESS | 7353 | Values: 310.4 310.9 316.0 316.8 316.9 5339.1 5359.4 5503.8 5520.4 5528.8 5325.5 5360.8 5377.4 5400.1 5418.6 3951.0 4022.2 4098.3 4106.1 4122.7 4101.6 4135.2 4145.7 4152.3 4159.0 4077.2 4087.8 4088.3 4097.9 4097.9 3892.7 4012.2 4082.4 4100.7 4103.3 3562.7 3570.4 3571.9 3578.7 3581.8 5184.1 5192.5 5193.9 5194.9 5202.8 4713.8 4722.1 4722.9 4724.2 4727.7 5639.0 5652.8 5657.2 5658.8 5662.9 3898.3 3908.6 3909.1 3913.7 3917.9 5748.9 5873.6 5941.9 5946.3 5950.1 3939.3 3954.7 3973.8 3976.8 3978.7 4023.1 4030.4 4030.5 4031.1 4034.5 4660.3 4661.0 4672.3 4673.6 4674.6 5621.5 5622.1 5627.5 5631.7 5634.0 1408.1 1424.0 1424.6 1425.5 1429.8 939.1 948.6 950.1 976.3 976.8 4898.9 4909.6 4923.4 4929.2 4930.3 5769.3 5777.7 5788.5 5860.4 5862.1 4966.8 4972.7 4973.4 4975.7 4978.6 3114.4 3146.0 3159.7 3164.1 3165.7 5493.5 5511.4 5517.5 5522.1 5522.3 5888.9 6117.4 6163.4 6169.1 6173.1 5525.1 5597.1 5634.1 5638.5 5639.3 5966.7 5977.9 6010.2 6026.0 6032.8 5866.2 5868.7 5869.3 5875.6 5881.4 5401.6 5591.0 5624.5 5627.5 5627.5 4146.9 4191.9 4209.8 4210.2 4211.7 5674.9 5887.3 5899.9 5903.0 5906.3 5537.7 5659.4 5671.7 5730.5 5736.8 5694.9 5707.9 5712.6 5716.0 5716.4 5619.8 5634.9 5643.9 5645.1 5651.0 5754.1 5768.3 5770.8 5772.7 5773.9 5450.2 5585.6 5604.0 5636.6 5647.4 17:51:54 INFO - PROCESS | 7353 | 17:51:54 INFO - PROCESS | 7353 | [#5] yui.html Cycles:180 Average:13011.56 Median:44506.94 stddev:15295.21 (34.4%) stddev-sans-first:15310.04 17:51:54 INFO - PROCESS | 7353 | Values: 670.4 732.2 741.5 751.0 759.3 11687.1 11750.7 11788.4 11794.8 11829.9 11214.4 11234.5 13248.0 13270.9 13317.3 803.6 813.3 815.7 816.1 816.8 650.4 801.7 816.9 821.6 821.7 861.2 862.4 862.5 863.3 863.5 676.2 856.5 856.8 857.2 857.3 611.1 623.5 626.0 626.1 626.4 11851.8 11901.2 11905.7 11947.8 11955.1 11644.7 11813.6 11885.7 11962.3 12129.5 9308.4 9456.9 9479.1 9518.5 9611.7 3226.3 3229.0 3270.6 3298.1 3322.4 41345.6 41758.4 41769.6 45620.1 45820.8 9559.0 9791.3 9813.9 9912.7 9928.2 17303.8 17329.0 17329.3 17330.6 17349.6 6575.6 6599.6 6702.1 6841.8 6901.9 3773.5 3796.7 3797.6 3825.8 3839.1 2831.4 2857.9 2861.1 2864.2 2873.0 347.3 349.3 439.7 503.3 508.7 509.7 603.4 607.5 640.3 640.6 6913.4 6913.9 6999.4 7054.8 7146.4 572.2 590.9 595.9 615.8 616.6 3272.6 3418.4 3421.4 3488.9 3543.4 56551.0 57298.7 57351.1 57366.0 57422.1 47744.5 48363.5 49145.0 49353.5 49568.8 40100.0 43473.8 43643.8 43743.3 44625.6 6606.6 6720.6 6792.7 6885.1 6958.2 33270.3 33280.8 33409.5 33410.3 33546.3 43112.8 43694.8 43893.1 44073.3 44388.3 10238.1 10247.8 10396.1 10426.3 10683.1 11157.7 11288.5 11494.0 11581.7 11938.9 10446.0 10502.9 10689.4 10734.4 11147.7 10696.1 10878.3 11029.2 11204.7 11208.4 10815.4 10864.1 11026.6 11158.0 11169.3 9535.4 9597.7 9622.3 9863.9 10068.1 9629.4 9631.7 9649.5 9706.7 9726.6 17:51:54 INFO - PROCESS | 7353 | -------- Summary: end -------- 17:51:54 INFO - PROCESS | 7353 | 17:51:55 INFO - TEST-INFO | 7353: exit 0 17:51:55 INFO - TEST-OK | dromaeo_css | took 1116619ms 17:51:55 INFO - TEST-START | kraken 17:51:55 INFO - operating with platform_type : linux_ 17:51:55 INFO - Initialising browser for kraken test... 17:51:55 INFO - TEST-INFO | started process 7532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKiWiAS/profile http://localhost:36830/getInfo.html) 17:51:59 INFO - PROCESS | 7532 | __metrics Screen width/height:1600/1200 17:51:59 INFO - PROCESS | 7532 | colorDepth:24 17:51:59 INFO - PROCESS | 7532 | Browser inner width/height: 1024/697 17:51:59 INFO - PROCESS | 7532 | __metrics 17:52:00 ERROR - PROCESS | 7532 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:52:01 INFO - TEST-INFO | 7532: exit 0 17:52:01 INFO - Browser initialized. 17:52:01 INFO - Running cycle 1/1 for kraken test... 17:52:01 INFO - TEST-INFO | started process 7612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKiWiAS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:52:13 INFO - PROCESS | 7612 | RSS: Main: 153767936 17:52:13 INFO - PROCESS | 7612 | 17:52:15 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36830/tests/kraken/driver.html?testName=audio-beat-detection) 17:52:16 INFO - PROCESS | 7612 | RSS: Main: 194781184 17:52:16 INFO - PROCESS | 7612 | 17:52:19 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36830/tests/kraken/driver.html?testName=audio-dft) 17:52:19 INFO - PROCESS | 7612 | RSS: Main: 185282560 17:52:19 INFO - PROCESS | 7612 | 17:52:22 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36830/tests/kraken/driver.html?testName=audio-fft) 17:52:23 INFO - PROCESS | 7612 | RSS: Main: 172429312 17:52:23 INFO - PROCESS | 7612 | 17:52:25 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36830/tests/kraken/driver.html?testName=audio-oscillator) 17:52:26 INFO - PROCESS | 7612 | RSS: Main: 173875200 17:52:26 INFO - PROCESS | 7612 | 17:52:28 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36830/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:52:28 INFO - PROCESS | 7612 | RSS: Main: 173596672 17:52:28 INFO - PROCESS | 7612 | 17:52:32 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36830/tests/kraken/driver.html?testName=imaging-darkroom) 17:52:32 INFO - PROCESS | 7612 | RSS: Main: 176496640 17:52:32 INFO - PROCESS | 7612 | 17:52:36 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36830/tests/kraken/driver.html?testName=imaging-desaturate) 17:52:36 INFO - PROCESS | 7612 | RSS: Main: 175951872 17:52:36 INFO - PROCESS | 7612 | 17:52:39 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36830/tests/kraken/driver.html?testName=json-parse-financial) 17:52:40 INFO - PROCESS | 7612 | RSS: Main: 175673344 17:52:40 INFO - PROCESS | 7612 | 17:52:41 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36830/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:52:42 INFO - PROCESS | 7612 | RSS: Main: 187260928 17:52:42 INFO - PROCESS | 7612 | 17:52:44 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36830/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:52:44 INFO - PROCESS | 7612 | RSS: Main: 182210560 17:52:44 INFO - PROCESS | 7612 | 17:52:47 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36830/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:52:47 INFO - PROCESS | 7612 | RSS: Main: 193974272 17:52:47 INFO - PROCESS | 7612 | 17:52:50 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:52:50 INFO - PROCESS | 7612 | RSS: Main: 197873664 17:52:50 INFO - PROCESS | 7612 | 17:52:53 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:52:53 INFO - PROCESS | 7612 | RSS: Main: 197931008 17:52:53 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | Cycle 1(1): loaded http://localhost:36830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36830/tests/kraken/driver.html?testName=ai-astar) 17:52:55 INFO - PROCESS | 7612 | RSS: Main: 258592768 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | __start_tp_report 17:52:55 INFO - PROCESS | 7612 | _x_x_mozilla_page_load 17:52:55 INFO - PROCESS | 7612 | _x_x_mozilla_page_load_details 17:52:55 INFO - PROCESS | 7612 | |i|pagename|runs| 17:52:55 INFO - PROCESS | 7612 | |0;ai-astar;112;115;108;113;114;113;103;114;114;113 17:52:55 INFO - PROCESS | 7612 | |1;audio-beat-detection;153;133;157;168;132;159;153;141;183;130 17:52:55 INFO - PROCESS | 7612 | |2;audio-dft;162;160;161;162;162;162;161;163;160;161 17:52:55 INFO - PROCESS | 7612 | |3;audio-fft;77;76;99;102;78;77;73;113;110;77 17:52:55 INFO - PROCESS | 7612 | |4;audio-oscillator;94;94;142;94;95;93;137;94;95;138 17:52:55 INFO - PROCESS | 7612 | |5;imaging-gaussian-blur;117;116;116;117;117;116;118;117;117;116 17:52:55 INFO - PROCESS | 7612 | |6;imaging-darkroom;147;146;147;147;147;146;146;146;147;146 17:52:55 INFO - PROCESS | 7612 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;95;95 17:52:55 INFO - PROCESS | 7612 | |8;json-parse-financial;67;67;69;67;67;67;65;78;64;65 17:52:55 INFO - PROCESS | 7612 | |9;json-stringify-tinderbox;64;65;64;64;64;64;65;65;65;65 17:52:55 INFO - PROCESS | 7612 | |10;stanford-crypto-aes;80;81;82;90;82;81;81;81;82;81 17:52:55 INFO - PROCESS | 7612 | |11;stanford-crypto-ccm;114;116;117;115;114;123;115;125;125;115 17:52:55 INFO - PROCESS | 7612 | |12;stanford-crypto-pbkdf2;140;143;130;143;150;129;136;151;128;139 17:52:55 INFO - PROCESS | 7612 | |13;stanford-crypto-sha256-iterative;69;67;68;66;67;66;67;68;66;66 17:52:55 INFO - PROCESS | 7612 | __end_tp_report 17:52:55 INFO - PROCESS | 7612 | __start_cc_report 17:52:55 INFO - PROCESS | 7612 | _x_x_mozilla_cycle_collect,1103 17:52:55 INFO - PROCESS | 7612 | __end_cc_report 17:52:55 INFO - PROCESS | 7612 | __startTimestamp1457916775729__endTimestamp 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | ------- Summary: start ------- 17:52:55 INFO - PROCESS | 7612 | Number of tests: 14 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.50 stddev:3.67 (3.2%) stddev-sans-first:3.89 17:52:55 INFO - PROCESS | 7612 | Values: 112.0 115.0 108.0 113.0 114.0 113.0 103.0 114.0 114.0 113.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:155.00 stddev:17.15 (11.1%) stddev-sans-first:18.17 17:52:55 INFO - PROCESS | 7612 | Values: 153.0 133.0 157.0 168.0 132.0 159.0 153.0 141.0 183.0 130.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 17:52:55 INFO - PROCESS | 7612 | Values: 162.0 160.0 161.0 162.0 162.0 162.0 161.0 163.0 160.0 161.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#3] audio-fft Cycles:10 Average:88.20 Median:77.00 stddev:15.84 (20.6%) stddev-sans-first:16.27 17:52:55 INFO - PROCESS | 7612 | Values: 77.0 76.0 99.0 102.0 78.0 77.0 73.0 113.0 110.0 77.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:94.00 stddev:21.71 (23.1%) stddev-sans-first:22.46 17:52:55 INFO - PROCESS | 7612 | Values: 94.0 94.0 142.0 94.0 95.0 93.0 137.0 94.0 95.0 138.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:52:55 INFO - PROCESS | 7612 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 118.0 117.0 117.0 116.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:52:55 INFO - PROCESS | 7612 | Values: 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 147.0 146.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:52:55 INFO - PROCESS | 7612 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:67.00 stddev:3.92 (5.9%) stddev-sans-first:4.15 17:52:55 INFO - PROCESS | 7612 | Values: 67.0 67.0 69.0 67.0 67.0 67.0 65.0 78.0 64.0 65.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 17:52:55 INFO - PROCESS | 7612 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 65.0 65.0 65.0 65.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.50 stddev:2.85 (3.5%) stddev-sans-first:2.92 17:52:55 INFO - PROCESS | 7612 | Values: 80.0 81.0 82.0 90.0 82.0 81.0 81.0 81.0 82.0 81.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:116.50 stddev:4.56 (3.9%) stddev-sans-first:4.61 17:52:55 INFO - PROCESS | 7612 | Values: 114.0 116.0 117.0 115.0 114.0 123.0 115.0 125.0 125.0 115.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.90 Median:141.50 stddev:8.23 (5.8%) stddev-sans-first:8.71 17:52:55 INFO - PROCESS | 7612 | Values: 140.0 143.0 130.0 143.0 150.0 129.0 136.0 151.0 128.0 139.0 17:52:55 INFO - PROCESS | 7612 | 17:52:55 INFO - PROCESS | 7612 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.05 (1.6%) stddev-sans-first:0.83 17:52:55 INFO - PROCESS | 7612 | Values: 69.0 67.0 68.0 66.0 67.0 66.0 67.0 68.0 66.0 66.0 17:52:55 INFO - PROCESS | 7612 | -------- Summary: end -------- 17:52:55 INFO - PROCESS | 7612 | 17:52:56 INFO - TEST-INFO | 7612: exit 0 17:52:56 INFO - TEST-OK | kraken | took 61666ms 17:52:56 INFO - SUITE-END | took 1178s 17:52:56 INFO - Completed test suite (00:19:38) 17:52:56 INFO - javascript benchmark 17:52:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2567.820252582319, 2595.4938786936555, 2627.0279996401337, 2628.8028397870157, 2637.2483842105003, 4513.323001549769, 4535.410396648435, 4541.250693635555, 4586.0, 4601.286800545912, 4497.325401189823, 4510.07543453592, 4510.774461276931, 4520.11857687751, 4572.794224259908, 4195.580441955811, 4225.6619470442365, 4268.957310426903, 4305.311150215966, 4306.590873866993, 4141.130362623852, 4225.619694227519, 4275.957240427602, 4281.978590107045, 4283.935740963888, 4179.164167166578, 4206.768627725474, 4213.5786421357925, 4236.279832428495, 4245.12974840157, 4224.239636865363, 4234.237837189305, 4245.066085461224, 4260.552641972579, 4268.445102136702, 4095.9590404096175, 4129.731567448106, 4214.136102099063, 4233.301505251629, 4281.293586558214, 4460.643148548108, 4481.462224533045, 4485.882311793305, 4489.842855500075, 4521.0, 4890.437599676047, 4897.14299997499, 4905.779239934212, 4913.14020046494, 4939.629527785431, 4861.124997500448, 4863.343448634424, 4912.164931961575, 4946.40643122824, 4980.526849949249, 4550.226461501553, 4560.977195114069, 4566.794494247767, 4570.977145114286, 4610.101030299093, 4978.0, 4984.102861484967, 4988.55103040728, 4991.151504244287, 5025.170846810235, 4703.952960470351, 4789.425268967746, 4795.496472870368, 4842.443119041355, 4856.39295088114, 4872.025594880967, 4882.7558622068755, 4890.902181956341, 4899.730514821647, 4947.134251505972, 4822.734749588736, 4839.0, 4845.0, 4847.297141914402, 4897.975510122426, 4732.290156476487, 4811.08589368019, 4850.975745121252, 4884.682495637772, 4886.144924638174, 4166.979165104155, 4173.5409104998425, 4173.874783756492, 4202.201581699467, 4210.831566737357, 3623.637636236408, 3653.342398368266, 3654.1595433050547, 3679.889603311905, 3682.208325210093, 4198.874033778991, 4206.894827629334, 4220.409142720022, 4226.302660061056, 4267.76527291002, 4915.631327650441, 4933.333999910038, 4933.925991110136, 4937.876553086202, 4965.627577931597, 4180.519240287345, 4254.553271906405, 4258.233517966733, 4289.0, 4294.892627684333, 4413.7793110344355, 4437.400950871655, 4442.800073996678, 4481.775911204427, 4482.596566308983, 4659.4175728034, 4670.953290467051, 4672.929906051412, 4701.177293973609, 4719.787609557647, 4816.0, 4881.365422495053, 4939.950600493949, 4950.4059512858685, 4953.900921981468, 4632.652551058617, 4638.930416043694, 4646.163690535736, 4647.628189744744, 4692.648051396227, 4840.080384726891, 4840.29815676732, 4846.975765121293, 4849.418069831643, 4892.143874821963, 4728.905421891612, 4899.0, 4907.533784290486, 4910.950890491049, 4921.212605983025, 4785.066911952136, 4800.855974320776, 4804.807807687793, 4805.927911081267, 4846.442659094108, 4767.880802979953, 4790.640701947298, 4791.496892826203, 4795.304680821331, 4841.927371089507, 4594.770261486846, 4643.4892161862845, 4691.835785747482, 4706.76466176683, 4726.834560790356, 4780.545848144421, 4783.425988881357, 4802.471728109975, 4806.591439727662, 4846.442659094249, 4730.0, 4733.9053218936115, 4734.100520901018, 4770.952290477189, 4783.56947874679], "unit": "score", "name": "dojo.html", "value": 4505.269446920883}, {"lowerIsBetter": false, "replicates": [528.2340606121126, 534.3988013484831, 545.372821255556, 555.4639772619421, 556.4407770190959, 27671.584926226096, 28043.29891752707, 28083.859580702094, 35282.647173528254, 36025.2794944101, 38973.61026389735, 39314.0, 39374.409383859194, 39445.0, 39463.210735785266, 7710.267524585155, 7842.647080881374, 7852.05775306964, 7877.739561670134, 7904.328132108749, 7758.0, 7873.763787086396, 7880.881786773203, 7885.684572617117, 7888.290053895148, 7845.215478452166, 7927.246911543394, 7927.3658107351275, 8128.959355203216, 8137.145599712034, 8014.959925200365, 8063.0, 8076.434649574532, 8082.1513741057515, 8086.595670216466, 8008.7597372078935, 8129.105798362176, 8133.471324363956, 8133.715319963832, 8137.145599712004, 39597.208055838724, 39902.20195596072, 40020.79989600033, 40070.0, 40123.19753604911, 3155.54244634529, 3227.467467867799, 3337.098983274502, 3413.5221069050353, 3553.4847447120023, 27792.58311125335, 29776.10671679853, 29998.550021749692, 30261.243468913453, 30782.0, 3403.0981789825714, 3428.194374322032, 3493.807840568768, 3532.364174448598, 3543.291341731638, 249405.0, 249747.0, 250039.0, 250124.0, 250599.99999999817, 42973.0, 57945.42054579485, 58394.70802645959, 58399.41600584025, 58432.0, 41559.37660935088, 41689.0, 41732.1653566927, 41781.582184178376, 41811.372829407585, 14295.213763243122, 14798.334074966653, 14920.70158596822, 14929.850701493064, 14940.92529537367, 9501.762455938657, 9524.14282714559, 9535.2371810255, 9535.761605959768, 9696.70909872705, 14481.710365792625, 14529.564113076625, 14961.850381496264, 15065.623359415884, 15149.469768558047, 5821.708914554255, 5949.9107513387335, 6018.307894592091, 6026.849328766816, 6076.969615151896, 844.4511067805976, 860.4192170285032, 974.201155052864, 999.8050380175941, 1034.6275340877278, 27034.459310814065, 28096.298843357225, 28323.716762832108, 28326.15021549357, 28435.146945591667, 990.1089019882164, 1005.1908213887745, 1031.257494603884, 1034.8654674892366, 1087.9456027198607, 14460.421583136556, 14610.26948652563, 14649.0, 14686.412543498354, 14868.70262594742, 309529.0, 311904.0, 314407.0, 315788.0, 315873.0, 49292.26061609079, 49829.50170498321, 49892.0, 49949.0, 49952.0, 1071.164491696478, 1135.3528488761326, 1234.7715672600598, 1236.8824961628632, 1265.3040827544814, 24517.877410612833, 25508.744912550635, 25546.594937278627, 25797.226083217534, 25805.870970645028, 39253.0, 39638.0, 39643.207135856544, 39687.40468892911, 39689.60310396859, 199779.0, 202931.0, 203290.0, 203752.0, 203807.0, 27118.0, 31098.378032439676, 31206.843965780026, 31770.36459270848, 32550.348993019532, 35940.28119437544, 35955.280894382486, 36392.0, 36656.633433666386, 36744.448833268056, 31156.0, 34058.82970585131, 34407.65592344045, 34578.65421345754, 34748.65251347454, 33373.666263338026, 33474.33051338911, 33915.43887891834, 33915.66084339224, 33965.83017084899, 33259.66740332566, 34036.48945265872, 34199.31601368009, 34353.65646343504, 34357.48463773095, 27933.0, 28314.0, 30064.54903176498, 30540.0, 30644.84677576598, 23916.641250381606, 24160.87919560391, 24186.87906560456, 24356.391090222885, 24389.878050609634], "unit": "score", "name": "ext.html", "value": 16680.17536571789}, {"lowerIsBetter": false, "replicates": [356.6362310443347, 358.5822516767964, 360.9693176080033, 368.51540224604645, 369.5362320288038, 15389.69220615587, 15780.447684331051, 16800.24398902051, 17173.570660733487, 17192.226349814257, 15986.440474583393, 16619.169041547906, 16625.090609143383, 16638.251278692456, 16646.83353166468, 4739.620830333565, 5008.849734507961, 5162.535371816536, 5904.586678932455, 5923.644581325134, 5907.379725128864, 5943.346231914507, 5947.434993675594, 5954.642721436706, 5963.731632076567, 5717.514011309044, 5898.233229680136, 5972.581919265654, 5987.940120598803, 5988.2215312009375, 5894.204282421861, 5934.139549765303, 5935.347111817697, 5941.792037278675, 5959.463648271655, 5078.187490001619, 5110.131277682803, 5134.255532947702, 5186.507281808223, 5194.3766747990485, 18792.71810922837, 19296.517587060294, 19453.124609392613, 19579.412617621496, 19597.80402195974, 1941.8737782044122, 1993.990030049855, 2060.781131345013, 2239.171017559974, 2508.598624220116, 12680.492780288778, 12796.808047879289, 12920.547780827626, 13347.265900375476, 13386.799198012037, 1699.17589968865, 1752.5793809485758, 1796.9550761230944, 1822.334847780564, 1843.2811203630595, 43555.346669799976, 50016.749916250184, 52630.0, 53576.46423535754, 54079.0, 9852.113309802153, 9854.113129818208, 10167.491625418847, 10388.220883433773, 10565.471726413649, 11960.521579136912, 12556.0, 12955.935220324027, 13258.204507729373, 13289.269090200132, 7486.85026299471, 7603.0, 7607.695692172251, 7759.495632783851, 7766.223377662302, 7444.85110297791, 7452.925470745223, 7500.324970752658, 7601.733939312208, 7631.3513351365755, 4411.205982923105, 4415.050764085737, 4427.446569178853, 4430.490493593214, 4495.977520112378, 1750.8511776498885, 1808.6653969015774, 1811.0673003403258, 1855.2671694680796, 1867.7478540397144, 855.6534603485599, 866.2506931504204, 885.2431171348404, 967.685502211784, 975.6926568131016, 15205.923970380078, 15243.847561524464, 15709.293081811345, 15948.601284967737, 16413.261403236884, 858.4806192253722, 880.5201165364891, 883.0551310098133, 916.0, 980.161961522902, 8775.692850750193, 9253.352265341362, 9260.351775375659, 9387.671431499864, 9402.837347410134, 290756.0, 299349.0, 300794.0, 301189.0, 405834.0, 70116.0, 74927.0, 75094.24905750982, 75688.0, 75831.24168758352, 970.4371464550685, 977.296346630425, 981.7692842182224, 1002.2910936852794, 1003.2225025605069, 14723.411063557338, 15043.398264069314, 15212.923935380251, 15273.541793746206, 15512.37950481968, 34111.0, 34270.65729342774, 34368.50103983351, 35251.47122793109, 35367.646323536435, 42628.360574590784, 44563.77718111518, 45031.54968450274, 45468.772656136505, 48845.2673209895, 7462.179160292472, 7533.886991695239, 7545.886811697719, 7643.770686879402, 7712.730054448291, 9416.576254068446, 11158.0, 11449.542018319175, 11503.712407189887, 11569.537218511165, 9242.537873106452, 9306.255499560155, 9551.761205969906, 9593.856092158483, 10086.646967356108, 9498.0, 9598.184154346958, 9640.228781697588, 9804.950975245078, 10326.638567650096, 4709.646776491708, 5153.5361817436615, 9720.951395242979, 9919.40483570988, 10827.0, 7110.0, 7252.854942901007, 7287.1984081752025, 7439.590822504814, 7544.321011109027, 7682.923170768444, 9925.156361709336, 10316.27786054969, 10341.844872327072, 10582.788344233226], "unit": "score", "name": "jquery.html", "value": 8098.378990426472}, {"lowerIsBetter": false, "replicates": [1307.4574051768516, 1420.6448387903026, 1428.0931608428648, 1580.2098950524737, 1777.0936822220672, 7000.859982800341, 7147.642617869099, 7152.892706609398, 7166.6774995125215, 7172.892406613905, 6971.651417429121, 7198.8560228795395, 7203.675834587443, 7204.675789589468, 7210.351068403843, 1808.6382723455297, 1858.005966807758, 1862.5436767991794, 2218.256883943877, 2246.1352379333994, 2173.8369622278315, 2223.54417344444, 2225.343523660516, 2225.499262665903, 2225.7662945390744, 2140.4969832089446, 2172.6089303925287, 2178.172294528077, 2179.8365122615787, 2201.7137772089604, 2202.592520383726, 2206.977930220701, 2208.1498623030247, 2208.823294136473, 2217.678436626696, 2174.92387766429, 2242.6972358731527, 2245.69683092782, 2249.7750224977535, 2254.447660323215, 7298.1607115181905, 7315.634218289118, 7348.669309881068, 7353.4484913631695, 7356.852862942711, 4456.242438785414, 4552.521985191574, 4595.793189306489, 4595.8391456299205, 4597.839075632371, 2849.2307077089276, 2919.7080291970847, 2935.7064293570684, 2957.245902294901, 2960.052783109406, 915.3318077803175, 923.0, 930.7812664023949, 958.0132463562542, 963.2919803944095, 9999.300048996573, 10026.498675066217, 10033.648822291185, 10034.147097496721, 10052.597896084148, 4164.875053748392, 4214.367844823301, 4323.48118225815, 4340.023494713727, 4344.847930322424, 7664.501807382502, 7679.19368466303, 7713.7685869424, 7728.072631284282, 7745.07059152894, 4448.55514448559, 4458.866234012985, 4470.709403888737, 4482.39487669167, 4482.843100491467, 3580.3197392495345, 4013.7190396672536, 4148.896277593024, 4160.854370097032, 4163.91672166555, 3269.9182520436702, 3332.9166770830925, 3333.5333053372547, 3347.2134048498583, 3361.815100169465, 1046.7121541576128, 1048.3343077146067, 1054.1882750282239, 1059.1526778577108, 1059.7297689089387, 1072.6835583502886, 1204.114975493012, 1208.7280361918497, 1217.4399776102914, 1248.818921256431, 6783.796486105425, 6996.650167491707, 7019.543729657556, 7044.22513523512, 7060.470464715167, 466.46589654845013, 470.3532642616402, 471.6604045087532, 474.1820359879181, 474.65587449099127, 5423.5932305076485, 5431.21247419122, 5454.754536045887, 5534.7786088556, 5540.058190107611, 8610.526421046903, 8888.37781355312, 9027.277817774562, 9084.40951338174, 9147.313951453534, 8919.375643705009, 8928.419652722552, 8962.238209752244, 8992.325575581857, 8996.460212387146, 6900.861982760317, 7000.36996670292, 7039.979203015534, 7080.256573059754, 7081.07945967021, 6723.5293529452465, 6735.225449073419, 6747.021681856201, 6763.729450821912, 6818.113645226089, 7938.404619653665, 8039.196080391914, 8246.83506329858, 8249.752507424786, 8270.751877443687, 8220.794480138044, 8371.246587807127, 8378.916210837813, 8425.0, 8518.574071296287, 5259.815906443256, 5854.063349864001, 6106.755729770759, 6205.906911396242, 6226.377362263737, 6906.482013849082, 6908.5509441886115, 6942.51402401827, 6970.825729356807, 6976.407005404394, 6108.72510737009, 6181.96909015452, 6331.746730130743, 6355.396237357444, 6376.139221205078, 6128.693565321627, 6186.505079593711, 6187.752489900354, 6267.0, 6267.62394256346, 6471.514636402195, 6487.3188315226225, 6537.411632953057, 6540.803775886731, 6543.640099794557, 6046.0, 6082.057281121433, 6088.6042407243385, 6095.969520152371, 6097.878042439215, 5926.7925622603, 6134.478569321657, 6145.0782382642965, 6147.0779383092895, 6153.969230153821], "unit": "score", "name": "mootools.html", "value": 4131.024670993814}, {"lowerIsBetter": false, "replicates": [310.3931813304988, 310.8570057773424, 315.96208454985396, 316.76559346083906, 316.92710676544397, 5339.119045357516, 5359.437259087798, 5503.834884953458, 5520.392756796749, 5528.75120619572, 5325.520703136717, 5360.812371566996, 5377.4084850666395, 5400.054990376678, 5418.593605479585, 3951.0, 4022.175454031931, 4098.323776576861, 4106.137711080677, 4122.711410201287, 4101.589841015904, 4135.214309281242, 4145.709800313979, 4152.252594532983, 4159.043420013399, 4077.22532718784, 4087.7547347159116, 4088.3458646616546, 4097.856575019875, 4097.934537020381, 3892.6691231245236, 4012.1574469361467, 4082.3672330788777, 4100.7334523255895, 4103.261412945669, 3562.6615471530163, 3570.3751843427294, 3571.8928432147077, 3578.7137029037613, 3581.8209089545417, 5184.092783762826, 5192.4547922468355, 5193.8961220775755, 5194.92207616886, 5202.817901373472, 4713.787879545429, 4722.126406614753, 4722.858314250578, 4724.173269677793, 4727.716337019755, 5639.041362968305, 5652.802151924704, 5657.23627310312, 5658.830235092953, 5662.915056274159, 3898.2593307271527, 3908.5895980922164, 3909.061825161969, 3913.745606535566, 3917.9216415671526, 5748.856278593027, 5873.559483038746, 5941.851453713692, 5946.256717910304, 5950.1372301016545, 3939.290927632996, 3954.723169378116, 3973.821178046937, 3976.8210430530694, 3978.6618137458063, 4023.114914718757, 4030.355143177136, 4030.496187976503, 4031.133306339151, 4034.45534852797, 4660.300954856799, 4661.0, 4672.322513235562, 4673.60274376675, 4674.602658773974, 5621.494065534122, 5622.100463925753, 5627.493525582717, 5631.662100273997, 5633.971830140905, 1408.1269612840106, 1423.978640320396, 1424.586869807765, 1425.536700572318, 1429.7712366021387, 939.1031564855547, 948.6442584030989, 950.1496160935924, 976.345848281653, 976.8095221431895, 4898.877528061756, 4909.582685471775, 4923.433805112386, 4929.211326187793, 4930.2851086592245, 5769.278840144982, 5777.740001699934, 5788.450097240755, 5860.355360910296, 5862.12068189775, 4966.776495057658, 4972.651914366032, 4973.35346404965, 4975.726335051607, 4978.5768209701855, 3114.423831591163, 3146.0, 3159.7314228290393, 3164.1298642873394, 3165.7309128724314, 5493.450654934554, 5511.3937466878615, 5517.531009864127, 5522.088855338824, 5522.30971128609, 5888.911666325009, 6117.418845209698, 6163.3528479509905, 6169.105479705508, 6173.135760993375, 5525.11598144295, 5597.132444471114, 5634.126710359901, 5638.464345887134, 5639.2668953035845, 5966.70166491665, 5977.9402205977385, 6010.1585777991995, 6025.969870150621, 6032.849178770566, 5866.2373891393845, 5868.706564671664, 5869.325027621878, 5875.588708790344, 5881.441263080001, 5401.6218864679095, 5591.04952158126, 5624.465675760796, 5627.465390787868, 5627.5497960162265, 4146.91706165881, 4191.895202619959, 4209.831606735696, 4210.221109094705, 4211.7472951623, 5674.914876276776, 5887.264091988502, 5899.941000590111, 5902.970485147718, 5906.291245050621, 5537.667739935617, 5659.377468478382, 5671.744771485375, 5730.5129064030025, 5736.827895163152, 5694.886102278014, 5707.8858422832145, 5712.571557133315, 5715.971420143039, 5716.42835716425, 5619.775208991595, 5634.887302254014, 5643.887122257614, 5645.125005624135, 5651.039323314964, 5754.05058165398, 5768.307803063659, 5770.769169233184, 5772.7402266898935, 5773.884522309614, 5450.209719590716, 5585.5531557476115, 5603.971980140073, 5636.605437619327, 5647.407022262603], "unit": "score", "name": "prototype.html", "value": 4244.845418378497}, {"lowerIsBetter": false, "replicates": [670.4167374384286, 732.1836152689746, 741.4772585327345, 750.984980300394, 759.2862709053489, 11687.123465740071, 11750.706232344195, 11788.351640659761, 11794.823077653842, 11829.881701182985, 11214.383208923506, 11234.49444774985, 13248.0, 13270.867291327084, 13317.26755028473, 803.57812148622, 813.2639960835453, 815.7348861619968, 816.073756286616, 816.7958010497375, 650.3853858104094, 801.6873419366452, 816.8652172391548, 821.6302663801283, 821.7329367955408, 861.2248975921689, 862.3833958719514, 862.4911302331623, 863.3179787967498, 863.4517081653132, 676.2020815437781, 856.546030603781, 856.8115014696757, 857.1728282207699, 857.2541888556933, 611.0528680545182, 623.5230049012509, 626.0, 626.0827887145308, 626.4017862940881, 11851.82222266658, 11901.166918315721, 11905.702357441047, 11947.820782688266, 11955.103367247404, 11644.6506604802, 11813.586524471602, 11885.702857428634, 11962.282263064244, 12129.454174562166, 9308.394954328014, 9456.8581471278, 9479.099485548863, 9518.524073796283, 9611.663591774324, 3226.2716373527383, 3228.96771032289, 3270.60752709674, 3298.0765385692043, 3322.435186018383, 41345.58654413447, 41758.37362439566, 41769.582304176874, 45620.08759824818, 45820.7708961453, 9558.952205239068, 9791.265655075898, 9813.901860981441, 9912.702618921443, 9928.205743540499, 17303.826961730472, 17329.0, 17329.30682772675, 17330.566735831453, 17349.566260843327, 6575.572587781779, 6599.637019963948, 6702.140947812797, 6841.828954276183, 6901.89647155283, 3773.509443772292, 3796.6528325067643, 3797.6392242736897, 3825.8087095645105, 3839.117003089305, 2831.4054048650014, 2857.914262572126, 2861.084452975028, 2864.1693908766642, 2872.965732336357, 347.2863265988418, 349.27699661700547, 439.69660933956106, 503.2702581257192, 508.6719066202279, 509.7094656046018, 603.414687752879, 607.547377203977, 640.2732898160622, 640.5964242527178, 6913.3777959983845, 6913.861722765517, 6999.440044796404, 7054.788356349215, 7146.428285737128, 572.2474945446725, 590.8818236352747, 595.8897603943284, 615.8429600451856, 616.608453631938, 3272.6072871255124, 3418.3676019936393, 3421.367047096295, 3488.860445582199, 3543.3976224041976, 56551.0, 57298.7135064322, 57351.13973290404, 57366.0, 57422.138667920015, 47744.5225547747, 48363.51636483661, 49145.0, 49353.506464935606, 49568.75215623971, 40100.0, 43473.782631086644, 43643.78178109089, 43743.34384984164, 44625.55374446279, 6606.6366349849295, 6720.630365329758, 6792.72829086831, 6885.070515480546, 6958.199807022055, 33270.334593308486, 33280.833595831864, 33409.49885751667, 33410.33179336351, 33546.32907341791, 43112.78443607762, 43694.78152609216, 43893.122137556435, 44073.338899917166, 44388.334174986754, 10238.078572928473, 10247.795044098928, 10396.116330112025, 10426.27016108865, 10683.091937185427, 11157.72105697364, 11288.492017859051, 11494.0, 11581.710457238636, 11938.940305298765, 10446.0, 10502.894971050191, 10689.358638481715, 10734.355938643706, 11147.72130696739, 10696.14430845515, 10878.292910960763, 11029.172812038969, 11204.66386008421, 11208.383538905438, 10815.35107893529, 10864.076553493042, 11026.558937642725, 11158.0, 11169.329840209613, 9535.38020028696, 9597.664081757104, 9622.278329125484, 9863.852042219516, 10068.093871551595, 9629.374090684083, 9631.71104866855, 9649.517524123625, 9706.660266890625, 9726.562304696165], "unit": "score", "name": "yui.html", "value": 5868.079134238865}], "name": "dromaeo_css", "value": 6301.779239593942}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 108.0, 113.0, 114.0, 113.0, 103.0, 114.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [153.0, 133.0, 157.0, 168.0, 132.0, 159.0, 153.0, 141.0, 183.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 162.0, 162.0, 162.0, 161.0, 163.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 99.0, 102.0, 78.0, 77.0, 73.0, 113.0, 110.0, 77.0], "unit": "score", "name": "audio-fft", "value": 88.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 142.0, 94.0, 95.0, 93.0, 137.0, 94.0, 95.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 69.0, 67.0, 67.0, 67.0, 65.0, 78.0, 64.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 67.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 82.0, 90.0, 82.0, 81.0, 81.0, 81.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [114.0, 116.0, 117.0, 115.0, 114.0, 123.0, 115.0, 125.0, 125.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [140.0, 143.0, 130.0, 143.0, 150.0, 129.0, 136.0, 151.0, 128.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.9}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 66.0, 67.0, 66.0, 67.0, 68.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1516.4000000000003}]} 17:52:56 INFO - Return code: 0 17:52:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:52:57 ERROR - # TBPL SUCCESS # 17:52:57 INFO - Running post-action listener: _resource_record_post_action 17:52:57 INFO - Running post-run listener: _resource_record_post_run 17:52:58 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517476352; Read time: 16; Write time: 648932 17:52:58 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 232243200; Read time: 0; Write time: 390836 17:52:58 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285048832; Read time: 16; Write time: 258044 17:52:58 INFO - Running post-run listener: _upload_blobber_files 17:52:58 INFO - Blob upload gear active. 17:52:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:52:58 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 17:52:58 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:52:58 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:52:58 INFO - (blobuploader) - INFO - Open directory for files ... 17:52:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:52:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:52:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:59 INFO - (blobuploader) - INFO - Done attempting. 17:52:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:52:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:53:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:53:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:53:00 INFO - (blobuploader) - INFO - Done attempting. 17:53:00 INFO - (blobuploader) - INFO - Iteration through files over. 17:53:00 INFO - Return code: 0 17:53:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:53:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:53:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abbcae0f2a945f2156a928adfa0edd3c97f38492d93320c44d999b9c33daefbb323f2944a11ecfaae99fc27df325f2c56a0888f7646a54804ccfcd4d8756c596", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c33f043a5ba22bc0d53cb1ad2ff211af6bd5c8f4e3dc581b2f66e538b0828d04ff7f11087b85e42ec9cca6c56ef047e90a3b031a075e2ca452da8611d62fa844"} 17:53:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:53:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:53:00 INFO - Contents: 17:53:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abbcae0f2a945f2156a928adfa0edd3c97f38492d93320c44d999b9c33daefbb323f2944a11ecfaae99fc27df325f2c56a0888f7646a54804ccfcd4d8756c596", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c33f043a5ba22bc0d53cb1ad2ff211af6bd5c8f4e3dc581b2f66e538b0828d04ff7f11087b85e42ec9cca6c56ef047e90a3b031a075e2ca452da8611d62fa844"} 17:53:00 INFO - Running post-run listener: copy_logs_to_upload_dir 17:53:00 INFO - Copying logs to upload dir... 17:53:00 INFO - mkdir: /builds/slave/test/build/upload/logs 17:53:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.516121 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-03-13 17:52:58.228733) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 17:52:58.232670) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abbcae0f2a945f2156a928adfa0edd3c97f38492d93320c44d999b9c33daefbb323f2944a11ecfaae99fc27df325f2c56a0888f7646a54804ccfcd4d8756c596", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c33f043a5ba22bc0d53cb1ad2ff211af6bd5c8f4e3dc581b2f66e538b0828d04ff7f11087b85e42ec9cca6c56ef047e90a3b031a075e2ca452da8611d62fa844"} build_url:https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011537 build_url: 'https://queue.taskcluster.net/v1/task/I94NRMJBRSaQOEZZgPFbSw/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/Firefox-Non-PGO/sha512/abbcae0f2a945f2156a928adfa0edd3c97f38492d93320c44d999b9c33daefbb323f2944a11ecfaae99fc27df325f2c56a0888f7646a54804ccfcd4d8756c596", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c33f043a5ba22bc0d53cb1ad2ff211af6bd5c8f4e3dc581b2f66e538b0828d04ff7f11087b85e42ec9cca6c56ef047e90a3b031a075e2ca452da8611d62fa844"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-13 17:52:58.257839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 17:52:58.258168) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1457910453.548247-496238615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005192 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-13 17:52:58.341162) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 17:52:58.341611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-13 17:52:58.341915) ========= ========= Total master_lag: 0.29 =========