builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1457611547.06 results: success (0) buildid: 20160310030121 builduid: bcf0efdc300842a09b0f494caca21ad6 revision: 79e59014d1725bb530ebef57b60dc668bd217389 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.056868) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.057363) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.057719) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50ji0pVydZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005909 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.083657) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.084189) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.102864) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.103529) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50ji0pVydZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005483 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.155833) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.156478) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.157322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.157969) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50ji0pVydZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-10 04:05:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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% 20.1M=0.001s 2016-03-10 04:05:47 (20.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175319 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.353525) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.353878) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50ji0pVydZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019804 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:47.402274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 04:05:47.402658) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 79e59014d1725bb530ebef57b60dc668bd217389 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 79e59014d1725bb530ebef57b60dc668bd217389 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50ji0pVydZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-10 04:05:47,479 truncating revision to first 12 chars 2016-03-10 04:05:47,479 Setting DEBUG logging. 2016-03-10 04:05:47,479 attempt 1/10 2016-03-10 04:05:47,479 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/79e59014d172?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-10 04:05:48,344 unpacking tar archive at: mozilla-aurora-79e59014d172/testing/mozharness/ program finished with exit code 0 elapsedTime=1.117582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-10 04:05:48.540433) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:48.540943) ========= echo 79e59014d1725bb530ebef57b60dc668bd217389 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'79e59014d1725bb530ebef57b60dc668bd217389'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50ji0pVydZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 79e59014d1725bb530ebef57b60dc668bd217389 program finished with exit code 0 elapsedTime=0.005039 script_repo_revision: '79e59014d1725bb530ebef57b60dc668bd217389' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:48.595276) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:48.595718) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-10 04:05:48.611031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-10 04:05:48.611345) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50ji0pVydZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:05:48 INFO - MultiFileLogger online at 20160310 04:05:48 in /builds/slave/test 04:05:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:05:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:48 INFO - {'append_to_log': False, 04:05:48 INFO - 'base_work_dir': '/builds/slave/test', 04:05:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:05:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:48 INFO - 'branch': 'Mozilla-Aurora', 04:05:48 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:48 INFO - 'config_files': ('talos/mac_config.py',), 04:05:48 INFO - 'default_actions': ('clobber', 04:05:48 INFO - 'read-buildbot-config', 04:05:48 INFO - 'download-and-extract', 04:05:48 INFO - 'populate-webroot', 04:05:48 INFO - 'create-virtualenv', 04:05:48 INFO - 'install', 04:05:48 INFO - 'run-tests'), 04:05:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:48 INFO - 'download_minidump_stackwalk': True, 04:05:48 INFO - 'download_symbols': 'ondemand', 04:05:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:48 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:48 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:48 INFO - 'installer_path': 'installer.exe', 04:05:48 INFO - 'log_level': 'info', 04:05:48 INFO - 'log_name': 'talos', 04:05:48 INFO - 'log_to_console': True, 04:05:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:05:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:05:48 INFO - 'opt_config_files': (), 04:05:48 INFO - 'pip_index': False, 04:05:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:05:48 INFO - 'cmd': ('bash', 04:05:48 INFO - '-c', 04:05:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:05:48 INFO - 'enabled': True, 04:05:48 INFO - 'halt_on_failure': False, 04:05:48 INFO - 'name': 'check_screen_resolution'},), 04:05:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:05:48 INFO - 'cmd': ('bash', 04:05:48 INFO - '-c', 04:05:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:05:48 INFO - 'enabled': True, 04:05:48 INFO - 'halt_on_failure': False, 04:05:48 INFO - 'name': 'check_screen_resolution'},), 04:05:48 INFO - 'run_cmd_checks_enabled': True, 04:05:48 INFO - 'sps_profile': False, 04:05:48 INFO - 'sps_profile_interval': 0, 04:05:48 INFO - 'suite': 'dromaeojs', 04:05:48 INFO - 'system_bits': '32', 04:05:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:48 INFO - 'title': 't-yosemite-r7-0102', 04:05:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:48 INFO - 'use_talos_json': True, 04:05:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:48 INFO - 'work_dir': 'build'} 04:05:48 INFO - ##### 04:05:48 INFO - ##### Running clobber step. 04:05:48 INFO - ##### 04:05:48 INFO - Running pre-action listener: _resource_record_pre_action 04:05:48 INFO - Running main action method: clobber 04:05:48 INFO - rmtree: /builds/slave/test/build 04:05:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:50 INFO - Running post-action listener: _resource_record_post_action 04:05:50 INFO - ##### 04:05:50 INFO - ##### Running read-buildbot-config step. 04:05:50 INFO - ##### 04:05:50 INFO - Running pre-action listener: _resource_record_pre_action 04:05:50 INFO - Running main action method: read_buildbot_config 04:05:50 INFO - Using buildbot properties: 04:05:50 INFO - { 04:05:50 INFO - "project": "", 04:05:50 INFO - "product": "firefox", 04:05:50 INFO - "script_repo_revision": "production", 04:05:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:05:50 INFO - "repository": "", 04:05:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:05:50 INFO - "buildid": "20160310030121", 04:05:50 INFO - "pgo_build": "False", 04:05:50 INFO - "basedir": "/builds/slave/test", 04:05:50 INFO - "buildnumber": 118, 04:05:50 INFO - "slavename": "t-yosemite-r7-0102", 04:05:50 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:05:50 INFO - "platform": "yosemite_r7", 04:05:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:05:50 INFO - "branch": "mozilla-aurora", 04:05:50 INFO - "repo_path": "releases/mozilla-aurora", 04:05:50 INFO - "revision": "79e59014d1725bb530ebef57b60dc668bd217389", 04:05:50 INFO - "stage_platform": "macosx64", 04:05:50 INFO - "builduid": "bcf0efdc300842a09b0f494caca21ad6", 04:05:50 INFO - "slavebuilddir": "test" 04:05:50 INFO - } 04:05:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 04:05:50 INFO - Running post-action listener: _resource_record_post_action 04:05:50 INFO - ##### 04:05:50 INFO - ##### Running download-and-extract step. 04:05:50 INFO - ##### 04:05:50 INFO - Running pre-action listener: _resource_record_pre_action 04:05:50 INFO - Running main action method: download_and_extract 04:05:50 INFO - mkdir: /builds/slave/test/build/tests 04:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:50 INFO - https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:05:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 04:05:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 04:05:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 04:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 04:05:52 INFO - Downloaded 1277 bytes. 04:05:52 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 04:05:52 INFO - Using the following test package requirements: 04:05:52 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 04:05:52 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:05:52 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 04:05:52 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:05:52 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 04:05:52 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:05:52 INFO - u'jsshell-mac.zip'], 04:05:52 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:05:52 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 04:05:52 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 04:05:52 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:05:52 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 04:05:52 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:05:52 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 04:05:52 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:05:52 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 04:05:52 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 04:05:52 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:05:52 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 04:05:52 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:52 INFO - https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:05:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:05:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:05:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:05:53 INFO - Downloaded 17864688 bytes. 04:05:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:05:56 INFO - Return code: 0 04:05:56 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 04:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:56 INFO - https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:05:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:05:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:05:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:05:57 INFO - Downloaded 17864688 bytes. 04:05:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:05:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:06:01 INFO - Return code: 0 04:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:01 INFO - https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:06:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 04:06:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 04:06:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 04:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:06:02 INFO - Downloaded 10845161 bytes. 04:06:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:06:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:06:02 INFO - Return code: 0 04:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:02 INFO - https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 04:06:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:06:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:06:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 04:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 04:06:05 INFO - Downloaded 114972125 bytes. 04:06:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:06:05 INFO - mkdir: /builds/slave/test/properties 04:06:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:05 INFO - Contents: 04:06:05 INFO - build_url:https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:06:06 INFO - Running post-action listener: _resource_record_post_action 04:06:06 INFO - Running post-action listener: set_extra_try_arguments 04:06:06 INFO - ##### 04:06:06 INFO - ##### Running populate-webroot step. 04:06:06 INFO - ##### 04:06:06 INFO - Running pre-action listener: _resource_record_pre_action 04:06:06 INFO - Running main action method: populate_webroot 04:06:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:06 INFO - '--tppagecycles', 04:06:06 INFO - '7'], 04:06:06 INFO - 'tests': ['tsvgm']}}, 04:06:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:06:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:06:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:06:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:06:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:06:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:06 INFO - 'talos_options': ['--e10s'], 04:06:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:06 INFO - 'tests': ['damp', 'tps']}, 04:06:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:06 INFO - 'talos_options': ['--e10s'], 04:06:06 INFO - 'tests': ['damp', 'tps']}, 04:06:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:06:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:06 INFO - 'other': {'tests': ['a11yr', 04:06:06 INFO - 'ts_paint', 04:06:06 INFO - 'tpaint', 04:06:06 INFO - 'sessionrestore', 04:06:06 INFO - 'sessionrestore_no_auto_restore', 04:06:06 INFO - 'tabpaint']}, 04:06:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:06:06 INFO - 'tests': ['a11yr', 04:06:06 INFO - 'ts_paint', 04:06:06 INFO - 'tpaint', 04:06:06 INFO - 'sessionrestore', 04:06:06 INFO - 'sessionrestore_no_auto_restore', 04:06:06 INFO - 'tabpaint']}, 04:06:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:06:06 INFO - 'tests': ['a11yr', 04:06:06 INFO - 'ts_paint', 04:06:06 INFO - 'tpaint', 04:06:06 INFO - 'sessionrestore', 04:06:06 INFO - 'sessionrestore_no_auto_restore', 04:06:06 INFO - 'tabpaint']}, 04:06:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:06:06 INFO - 'tests': ['a11yr', 04:06:06 INFO - 'ts_paint', 04:06:06 INFO - 'tpaint', 04:06:06 INFO - 'sessionrestore', 04:06:06 INFO - 'sessionrestore_no_auto_restore', 04:06:06 INFO - 'tabpaint']}, 04:06:06 INFO - 'other_l64': {'tests': ['a11yr', 04:06:06 INFO - 'ts_paint', 04:06:06 INFO - 'tpaint', 04:06:06 INFO - 'sessionrestore', 04:06:06 INFO - 'sessionrestore_no_auto_restore', 04:06:06 INFO - 'tabpaint']}, 04:06:06 INFO - 'other_nol64': {'tests': ['a11yr', 04:06:06 INFO - 'ts_paint', 04:06:06 INFO - 'tpaint', 04:06:06 INFO - 'sessionrestore', 04:06:06 INFO - 'sessionrestore_no_auto_restore', 04:06:06 INFO - 'tabpaint']}, 04:06:06 INFO - 'svgr': {'tests': ['tsvgx', 04:06:06 INFO - 'tsvgr_opacity', 04:06:06 INFO - 'tart', 04:06:06 INFO - 'tscrollx', 04:06:06 INFO - 'cart']}, 04:06:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:06:06 INFO - 'tests': ['tsvgx', 04:06:06 INFO - 'tsvgr_opacity', 04:06:06 INFO - 'tart', 04:06:06 INFO - 'tscrollx', 04:06:06 INFO - 'cart']}, 04:06:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:06 INFO - 'tests': ['tp5o']}, 04:06:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:06 INFO - 'talos_options': ['--e10s'], 04:06:06 INFO - 'tests': ['tp5o']}, 04:06:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:06 INFO - 'talos_options': ['--xperf_path', 04:06:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:06 INFO - 'tests': ['tp5n']}, 04:06:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:06 INFO - 'talos_options': ['--e10s', 04:06:06 INFO - '--xperf_path', 04:06:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:06 INFO - 'tests': ['tp5n']}}, 04:06:06 INFO - 'talos.zip': {'path': '', 04:06:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:06 INFO - Running post-action listener: _resource_record_post_action 04:06:06 INFO - ##### 04:06:06 INFO - ##### Running create-virtualenv step. 04:06:06 INFO - ##### 04:06:06 INFO - Running pre-action listener: _resource_record_pre_action 04:06:06 INFO - Running main action method: create_virtualenv 04:06:06 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:06 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 04:06:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:06 INFO - Using real prefix '/tools/python27' 04:06:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:07 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:10 INFO - Installing pip.................done. 04:06:10 INFO - Return code: 0 04:06:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:10 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 0x101f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8619d78d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df3d30>, '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 0x101c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101deab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:10 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 04:06:10 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 04:06:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 04:06:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:10 INFO - 'HOME': '/Users/cltbld', 04:06:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:10 INFO - 'LOGNAME': 'cltbld', 04:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:10 INFO - 'MOZ_NO_REMOTE': '1', 04:06:10 INFO - 'NO_EM_RESTART': '1', 04:06:10 INFO - 'PAGER': '/bin/cat', 04:06:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:10 INFO - 'PWD': '/builds/slave/test', 04:06:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:10 INFO - 'SHELL': '/bin/bash', 04:06:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 04:06:10 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 04:06:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:10 INFO - 'USER': 'cltbld', 04:06:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:10 INFO - 'XPC_FLAGS': '0x0', 04:06:10 INFO - 'XPC_SERVICE_NAME': '0', 04:06:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:10 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 04:06:10 INFO - Cleaning up... 04:06:10 INFO - Return code: 0 04:06:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:10 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 0x101f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8619d78d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df3d30>, '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 0x101c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101deab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:10 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 04:06:10 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 04:06:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 04:06:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:10 INFO - 'HOME': '/Users/cltbld', 04:06:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:10 INFO - 'LOGNAME': 'cltbld', 04:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:10 INFO - 'MOZ_NO_REMOTE': '1', 04:06:10 INFO - 'NO_EM_RESTART': '1', 04:06:10 INFO - 'PAGER': '/bin/cat', 04:06:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:10 INFO - 'PWD': '/builds/slave/test', 04:06:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:10 INFO - 'SHELL': '/bin/bash', 04:06:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 04:06:10 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 04:06:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:10 INFO - 'USER': 'cltbld', 04:06:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:10 INFO - 'XPC_FLAGS': '0x0', 04:06:10 INFO - 'XPC_SERVICE_NAME': '0', 04:06:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:10 INFO - Downloading/unpacking psutil>=0.7.1 04:06:10 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 04:06:10 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 04:06:10 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 04:06:10 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 04:06:10 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 04:06:10 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 04:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:13 INFO - Installing collected packages: psutil 04:06:13 INFO - Running setup.py install for psutil 04:06:13 INFO - building 'psutil._psutil_osx' extension 04:06:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:06:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:06:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:06:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:06:14 INFO - building 'psutil._psutil_posix' extension 04:06:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:06:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:06:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:06:14 INFO - ^ 04:06:14 INFO - 1 warning generated. 04:06:14 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:06:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:14 INFO - Successfully installed psutil 04:06:14 INFO - Cleaning up... 04:06:14 INFO - Return code: 0 04:06:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:14 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 0x101f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8619d78d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df3d30>, '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 0x101c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101deab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:14 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 04:06:14 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 04:06:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 04:06:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:14 INFO - 'HOME': '/Users/cltbld', 04:06:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:14 INFO - 'LOGNAME': 'cltbld', 04:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:14 INFO - 'MOZ_NO_REMOTE': '1', 04:06:14 INFO - 'NO_EM_RESTART': '1', 04:06:14 INFO - 'PAGER': '/bin/cat', 04:06:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:14 INFO - 'PWD': '/builds/slave/test', 04:06:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:14 INFO - 'SHELL': '/bin/bash', 04:06:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 04:06:14 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 04:06:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:14 INFO - 'USER': 'cltbld', 04:06:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:14 INFO - 'XPC_FLAGS': '0x0', 04:06:14 INFO - 'XPC_SERVICE_NAME': '0', 04:06:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:06:17 INFO - Installing collected packages: mozsystemmonitor 04:06:17 INFO - Running setup.py install for mozsystemmonitor 04:06:17 INFO - Successfully installed mozsystemmonitor 04:06:17 INFO - Cleaning up... 04:06:17 INFO - Return code: 0 04:06:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8619d78d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df3d30>, '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 0x101c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101deab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:06:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 04:06:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:17 INFO - 'HOME': '/Users/cltbld', 04:06:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:17 INFO - 'LOGNAME': 'cltbld', 04:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:17 INFO - 'MOZ_NO_REMOTE': '1', 04:06:17 INFO - 'NO_EM_RESTART': '1', 04:06:17 INFO - 'PAGER': '/bin/cat', 04:06:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:17 INFO - 'PWD': '/builds/slave/test', 04:06:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:17 INFO - 'SHELL': '/bin/bash', 04:06:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 04:06:17 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 04:06:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:17 INFO - 'USER': 'cltbld', 04:06:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:17 INFO - 'XPC_FLAGS': '0x0', 04:06:17 INFO - 'XPC_SERVICE_NAME': '0', 04:06:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:17 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:20 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 04:06:20 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 04:06:20 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 04:06:20 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 04:06:20 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 04:06:20 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 04:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:20 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 04:06:20 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 04:06:20 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 04:06:20 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 04:06:20 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 04:06:20 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 04:06:21 INFO - Downloading docopt-0.6.1.tar.gz 04:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:21 INFO - Running setup.py install for blobuploader 04:06:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:21 INFO - Running setup.py install for requests 04:06:22 INFO - Running setup.py install for docopt 04:06:22 INFO - Successfully installed blobuploader requests docopt 04:06:22 INFO - Cleaning up... 04:06:22 INFO - Return code: 0 04:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:22 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')]} 04:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:22 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')]} 04:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:22 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 0x101f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8619d78d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df3d30>, '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 0x101c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101deab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:22 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 04:06:22 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 04:06:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 04:06:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:22 INFO - 'HOME': '/Users/cltbld', 04:06:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:22 INFO - 'LOGNAME': 'cltbld', 04:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:22 INFO - 'MOZ_NO_REMOTE': '1', 04:06:22 INFO - 'NO_EM_RESTART': '1', 04:06:22 INFO - 'PAGER': '/bin/cat', 04:06:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:22 INFO - 'PWD': '/builds/slave/test', 04:06:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:22 INFO - 'SHELL': '/bin/bash', 04:06:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 04:06:22 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 04:06:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:22 INFO - 'USER': 'cltbld', 04:06:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:22 INFO - 'XPC_FLAGS': '0x0', 04:06:22 INFO - 'XPC_SERVICE_NAME': '0', 04:06:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-uIwxdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Cw8jlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-A1nSiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-tzHTvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:22 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-FDyylU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-tKZ99J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-MGDdtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-slTD0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-SIvBJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-b9uRgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-TJ1pU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-DZERBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-nBFkT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-wdsgf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-9Uiuy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-wJJKeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-0quOoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:24 INFO - Running setup.py install for manifestparser 04:06:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:24 INFO - Running setup.py install for mozcrash 04:06:24 INFO - Running setup.py install for mozdebug 04:06:24 INFO - Running setup.py install for mozdevice 04:06:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:24 INFO - Running setup.py install for mozfile 04:06:25 INFO - Running setup.py install for mozhttpd 04:06:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for mozinfo 04:06:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for mozInstall 04:06:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for mozleak 04:06:25 INFO - Running setup.py install for mozlog 04:06:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for moznetwork 04:06:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:25 INFO - Running setup.py install for mozprocess 04:06:26 INFO - Running setup.py install for mozprofile 04:06:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:26 INFO - Running setup.py install for mozrunner 04:06:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:26 INFO - Running setup.py install for mozscreenshot 04:06:26 INFO - Running setup.py install for moztest 04:06:26 INFO - Running setup.py install for mozversion 04:06:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:26 INFO - Cleaning up... 04:06:26 INFO - Return code: 0 04:06:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:26 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 0x101f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8619d78d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df3d30>, '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 0x101c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101deab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:26 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 04:06:26 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 04:06:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 04:06:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:26 INFO - 'HOME': '/Users/cltbld', 04:06:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:26 INFO - 'LOGNAME': 'cltbld', 04:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:26 INFO - 'MOZ_NO_REMOTE': '1', 04:06:26 INFO - 'NO_EM_RESTART': '1', 04:06:26 INFO - 'PAGER': '/bin/cat', 04:06:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:26 INFO - 'PWD': '/builds/slave/test', 04:06:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:26 INFO - 'SHELL': '/bin/bash', 04:06:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 04:06:26 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 04:06:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:26 INFO - 'USER': 'cltbld', 04:06:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:26 INFO - 'XPC_FLAGS': '0x0', 04:06:26 INFO - 'XPC_SERVICE_NAME': '0', 04:06:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-mKWKSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ORtjUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-SF8WKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-GKrEhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-I4_CZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Tb407C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-eDGH44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:27 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)) 04:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-vPUT6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:28 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)) 04:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Vs1p_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:28 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)) 04:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Zvjsh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:28 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)) 04:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-8qtvk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:28 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)) 04:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-g7i4NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:28 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)) 04:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Wqmay8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:28 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)) 04:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-k0xrsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:28 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)) 04:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-LYyV4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:28 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)) 04:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-w_aOl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:28 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)) 04:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-VzQelE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:29 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)) 04:06:29 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)) 04:06:29 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)) 04:06:29 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)) 04:06:29 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)) 04:06:29 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)) 04:06:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:29 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 04:06:29 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 04:06:29 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 04:06:29 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 04:06:29 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 04:06:29 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 04:06:31 INFO - Downloading blessings-1.6.tar.gz 04:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:31 INFO - Installing collected packages: blessings 04:06:31 INFO - Running setup.py install for blessings 04:06:31 INFO - Successfully installed blessings 04:06:31 INFO - Cleaning up... 04:06:31 INFO - Return code: 0 04:06:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:31 INFO - Reading from file tmpfile_stdout 04:06:31 INFO - Current package versions: 04:06:31 INFO - blessings == 1.6 04:06:31 INFO - blobuploader == 1.2.4 04:06:31 INFO - docopt == 0.6.1 04:06:31 INFO - manifestparser == 1.1 04:06:31 INFO - mozInstall == 1.12 04:06:31 INFO - mozcrash == 0.17 04:06:31 INFO - mozdebug == 0.1 04:06:31 INFO - mozdevice == 0.48 04:06:31 INFO - mozfile == 1.2 04:06:31 INFO - mozhttpd == 0.7 04:06:31 INFO - mozinfo == 0.9 04:06:31 INFO - mozleak == 0.1 04:06:31 INFO - mozlog == 3.1 04:06:31 INFO - moznetwork == 0.27 04:06:31 INFO - mozprocess == 0.22 04:06:31 INFO - mozprofile == 0.28 04:06:31 INFO - mozrunner == 6.11 04:06:31 INFO - mozscreenshot == 0.1 04:06:31 INFO - mozsystemmonitor == 0.0 04:06:31 INFO - moztest == 0.7 04:06:31 INFO - mozversion == 1.4 04:06:31 INFO - psutil == 3.1.1 04:06:31 INFO - requests == 1.2.3 04:06:31 INFO - wsgiref == 0.1.2 04:06:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:31 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 0x101f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8619d78d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df3d30>, '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 0x101c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101deab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:31 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 04:06:31 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 04:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 04:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:31 INFO - 'HOME': '/Users/cltbld', 04:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:31 INFO - 'LOGNAME': 'cltbld', 04:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:31 INFO - 'MOZ_NO_REMOTE': '1', 04:06:31 INFO - 'NO_EM_RESTART': '1', 04:06:31 INFO - 'PAGER': '/bin/cat', 04:06:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:31 INFO - 'PWD': '/builds/slave/test', 04:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:31 INFO - 'SHELL': '/bin/bash', 04:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 04:06:31 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 04:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:31 INFO - 'USER': 'cltbld', 04:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:31 INFO - 'XPC_FLAGS': '0x0', 04:06:31 INFO - 'XPC_SERVICE_NAME': '0', 04:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:32 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)) 04:06:32 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)) 04:06:32 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)) 04:06:32 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)) 04:06:32 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)) 04:06:32 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)) 04:06:32 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)) 04:06:32 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)) 04:06:32 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)) 04:06:32 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)) 04:06:32 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)) 04:06:32 INFO - Cleaning up... 04:06:32 INFO - Return code: 0 04:06:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:32 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 0x101f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8619d78d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df3d30>, '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 0x101c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101deab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:32 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 04:06:32 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 04:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 04:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:32 INFO - 'HOME': '/Users/cltbld', 04:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:32 INFO - 'LOGNAME': 'cltbld', 04:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:32 INFO - 'MOZ_NO_REMOTE': '1', 04:06:32 INFO - 'NO_EM_RESTART': '1', 04:06:32 INFO - 'PAGER': '/bin/cat', 04:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:32 INFO - 'PWD': '/builds/slave/test', 04:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:32 INFO - 'SHELL': '/bin/bash', 04:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 04:06:32 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 04:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:32 INFO - 'USER': 'cltbld', 04:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:32 INFO - 'XPC_FLAGS': '0x0', 04:06:32 INFO - 'XPC_SERVICE_NAME': '0', 04:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:32 INFO - Downloading/unpacking jsonschema 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:32 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 04:06:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:34 INFO - Downloading/unpacking functools32 (from jsonschema) 04:06:34 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 04:06:34 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 04:06:34 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 04:06:34 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 04:06:34 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 04:06:34 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 04:06:35 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:35 INFO - warning: no files found matching '*.txt' 04:06:35 INFO - no previously-included directories found matching 'build' 04:06:35 INFO - no previously-included directories found matching 'dist' 04:06:35 INFO - no previously-included directories found matching '.git*' 04:06:35 INFO - Installing collected packages: jsonschema, functools32 04:06:35 INFO - Running setup.py install for functools32 04:06:35 INFO - warning: no files found matching '*.txt' 04:06:35 INFO - no previously-included directories found matching 'build' 04:06:35 INFO - no previously-included directories found matching 'dist' 04:06:35 INFO - no previously-included directories found matching '.git*' 04:06:35 INFO - Successfully installed jsonschema functools32 04:06:35 INFO - Cleaning up... 04:06:35 INFO - Return code: 0 04:06:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f4fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f564c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8619d78d80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df3d30>, '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 0x101c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101deab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:06:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:06:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 04:06:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:35 INFO - 'HOME': '/Users/cltbld', 04:06:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:35 INFO - 'LOGNAME': 'cltbld', 04:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:35 INFO - 'MOZ_NO_REMOTE': '1', 04:06:35 INFO - 'NO_EM_RESTART': '1', 04:06:35 INFO - 'PAGER': '/bin/cat', 04:06:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:35 INFO - 'PWD': '/builds/slave/test', 04:06:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:35 INFO - 'SHELL': '/bin/bash', 04:06:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 04:06:35 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 04:06:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:35 INFO - 'USER': 'cltbld', 04:06:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:35 INFO - 'XPC_FLAGS': '0x0', 04:06:35 INFO - 'XPC_SERVICE_NAME': '0', 04:06:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:35 INFO - Downloading/unpacking flake8 04:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:06:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:06:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:39 INFO - no previously-included directories found matching 'docs/_build' 04:06:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:06:39 INFO - Running setup.py install for pep8 04:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:06:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:06:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:06:39 INFO - no previously-included directories found matching 'docs/_build' 04:06:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:06:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:06:39 INFO - Cleaning up... 04:06:39 INFO - Return code: 0 04:06:39 INFO - Running post-action listener: _resource_record_post_action 04:06:39 INFO - Running post-action listener: _start_resource_monitoring 04:06:40 INFO - Starting resource monitoring. 04:06:40 INFO - ##### 04:06:40 INFO - ##### Running install step. 04:06:40 INFO - ##### 04:06:40 INFO - Running pre-action listener: _resource_record_pre_action 04:06:40 INFO - Running main action method: install 04:06:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:40 INFO - Reading from file tmpfile_stdout 04:06:40 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:40 INFO - Reading from file tmpfile_stdout 04:06:40 INFO - Output received: 04:06:40 INFO - Usage: mozinstall [options] installer 04:06:40 INFO - Options: 04:06:40 INFO - -h, --help show this help message and exit 04:06:40 INFO - -d DEST, --destination=DEST 04:06:40 INFO - Directory to install application into. [default: 04:06:40 INFO - "/builds/slave/test"] 04:06:40 INFO - --app=APP Application being installed. [default: firefox] 04:06:40 INFO - mkdir: /builds/slave/test/build/application 04:06:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 04:07:12 INFO - Reading from file tmpfile_stdout 04:07:12 INFO - Output received: 04:07:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:07:12 INFO - Running post-action listener: _resource_record_post_action 04:07:12 INFO - ##### 04:07:12 INFO - ##### Running run-tests step. 04:07:12 INFO - ##### 04:07:12 INFO - Running pre-action listener: _resource_record_pre_action 04:07:12 INFO - Running main action method: run_tests 04:07:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:07:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:07:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:07:12 INFO - 2016-03-10 04:07:12.152 screenresolution[1943:18306] starting screenresolution argv=screenresolution get 04:07:12 INFO - 2016-03-10 04:07:12.155 screenresolution[1943:18306] Display 0: 1600x1200x32@60 04:07:12 INFO - 2016-03-10 04:07:12.161 screenresolution[1944:18308] starting screenresolution argv=screenresolution list 04:07:12 INFO - Available Modes on Display 0 04:07:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:07:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:07:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:07:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:07:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:07:12 INFO - Intel Iris: 04:07:12 INFO - Chipset Model: Intel Iris 04:07:12 INFO - Type: GPU 04:07:12 INFO - Bus: Built-In 04:07:12 INFO - VRAM (Dynamic, Max): 1536 MB 04:07:12 INFO - Vendor: Intel (0x8086) 04:07:12 INFO - Device ID: 0x0a2e 04:07:12 INFO - Revision ID: 0x0009 04:07:12 INFO - Displays: 04:07:12 INFO - Display: 04:07:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:07:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:07:12 INFO - Display Serial Number: 1600x1200 60 04:07:12 INFO - Main Display: Yes 04:07:12 INFO - Mirror: Off 04:07:12 INFO - Online: Yes 04:07:12 INFO - Rotation: Supported 04:07:12 INFO - Return code: 0 04:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:12 INFO - Python 2.7.3 04:07:12 INFO - Return code: 0 04:07:12 INFO - grabbing minidump binary from tooltool 04:07:12 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')]} 04:07:12 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101df3d30>, '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 0x101c57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101deab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:12 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:07:12 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:07:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:12 INFO - Return code: 0 04:07:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:07:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:07:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:07:13 INFO - Return code: 0 04:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 04:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 04:07:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.50ji0pVydZ/Render', 04:07:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:13 INFO - 'HOME': '/Users/cltbld', 04:07:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:13 INFO - 'LOGNAME': 'cltbld', 04:07:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:13 INFO - 'MOZ_NO_REMOTE': '1', 04:07:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:13 INFO - 'NO_EM_RESTART': '1', 04:07:13 INFO - 'PAGER': '/bin/cat', 04:07:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:13 INFO - 'PWD': '/builds/slave/test', 04:07:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:13 INFO - 'SHELL': '/bin/bash', 04:07:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners', 04:07:13 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 04:07:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:13 INFO - 'USER': 'cltbld', 04:07:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:13 INFO - 'XPC_FLAGS': '0x0', 04:07:13 INFO - 'XPC_SERVICE_NAME': '0', 04:07:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 04:07:13 INFO - mozversion application_buildid: 20160310030121 04:07:13 INFO - mozversion application_changeset: 79e59014d1725bb530ebef57b60dc668bd217389 04:07:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:07:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:13 INFO - mozversion application_name: Firefox 04:07:13 INFO - mozversion application_remotingname: firefox-dev 04:07:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:07:13 INFO - mozversion application_vendor: Mozilla 04:07:13 INFO - mozversion application_version: 47.0a2 04:07:13 INFO - mozversion platform_buildid: 20160310030121 04:07:13 INFO - mozversion platform_changeset: 79e59014d1725bb530ebef57b60dc668bd217389 04:07:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:07:13 INFO - mozversion platform_version: 47.0a2 04:07:13 INFO - using testdate: 1457611633 04:07:13 INFO - actual date: 1457611633 04:07:13 INFO - starting webserver on 'localhost:57283' 04:07:13 INFO - SUITE-START | Running 2 tests 04:07:13 INFO - TEST-START | dromaeo_css 04:07:13 INFO - operating with platform_type : mac_ 04:07:13 INFO - Initialising browser for dromaeo_css test... 04:07:13 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpQHiS5J/profile http://localhost:57283/getInfo.html) 04:07:16 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 04:07:16 INFO - PROCESS | 1962 | colorDepth:24 04:07:16 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 04:07:16 INFO - PROCESS | 1962 | __metrics 04:07:16 INFO - PROCESS | 1962 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:07:16 INFO - PROCESS | 1962 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:16 INFO - TEST-INFO | 1962: exit 0 04:07:16 INFO - Browser initialized. 04:07:16 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:16 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpQHiS5J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:28 INFO - PROCESS | 1964 | RSS: Main: 210485248 04:07:28 INFO - PROCESS | 1964 | 04:08:19 INFO - PROCESS | 1964 | 1457611699803 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] 04:10:30 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57283/tests/dromaeo/cssquery-ext.html) 04:10:31 INFO - PROCESS | 1964 | RSS: Main: 330600448 04:10:31 INFO - PROCESS | 1964 | 04:13:33 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-ext.html (next: http://localhost:57283/tests/dromaeo/cssquery-jquery.html) 04:13:34 INFO - PROCESS | 1964 | RSS: Main: 345931776 04:13:34 INFO - PROCESS | 1964 | 04:16:36 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57283/tests/dromaeo/cssquery-mootools.html) 04:16:36 INFO - PROCESS | 1964 | RSS: Main: 348536832 04:16:36 INFO - PROCESS | 1964 | 04:19:38 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57283/tests/dromaeo/cssquery-prototype.html) 04:19:39 INFO - PROCESS | 1964 | RSS: Main: 305311744 04:19:39 INFO - PROCESS | 1964 | 04:22:42 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57283/tests/dromaeo/cssquery-yui.html) 04:22:43 INFO - PROCESS | 1964 | RSS: Main: 309235712 04:22:43 INFO - PROCESS | 1964 | 04:25:45 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:57283/tests/dromaeo/cssquery-yui.html (next: http://localhost:57283/tests/dromaeo/cssquery-dojo.html) 04:25:46 INFO - PROCESS | 1964 | RSS: Main: 357060608 04:25:46 INFO - PROCESS | 1964 | 04:25:46 INFO - PROCESS | 1964 | __start_tp_report 04:25:46 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 04:25:46 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 04:25:46 INFO - PROCESS | 1964 | |i|pagename|runs| 04:25:46 INFO - PROCESS | 1964 | |0;dojo.html;3403.9829800850994;3418.282160746244;3423.263998240378;3463.9653603463958;3467.5838899332066;5682.488576028157;5796.913046304308;5798.768049278029;5807.216025836511;5827.592068555203;5779.62432441891;5804.941950580493;5834.941650583492;5839.211706419643;5856;4344.522102568715;5155.999999999991;5156.071907056728;5176.223566465042;5194.68831870089;5258.921116183241;5266.289050978107;5268.367795864501;5273.156294992802;5273.288106105665;5242.947570524284;5271.815486457975;5283.365996080475;5292.5765938725;5298.788048478056;4440.822367105328;5075.264086707407;5280.603954703393;5304.787808487656;5335.839924802262;5044.899102017976;5191.792328306901;5247.291615631879;5259.237410575445;5322.973385133088;5644.096944488903;5651.7739290428335;5695.743691533891;5730.08318669011;5739.368669446358;6213.316535181127;6293.779717709858;6302.590331628429;6304;6331.588446750947;6223.190985171944;6228.159198508234;6297.4962003039645;6313.400226978476;6320.925442674757;5912.054071348563;5935.080062590306;5953.791617293374;5956.761729530814;5964.493018093423;6243.282022567463;6271.529635277372;6327.525435592349;6345.587536810185;6349.809505714836;6247.5939063960695;6273.592216505913;6285.622862628257;6289.308176100625;6305.716242769086;6203.7828675996125;6256.624602523863;6264.436200741955;6276.9372306276355;6312.7790527332245;5282.524572788468;6222.471089957405;6226.034964580497;6260.154879091356;6317.052442133717;6309.495240380758;6315.684215789284;6330.430261276507;6332.0818481320875;6353.174087368612;4908.631852611068;4924.4090709115135;4927.457979622239;4932.334134891816;4954.628402869799;4418.33724941255;4452.977735111303;4471;4520.321951707205;4528.592426681615;5822.1266809978;5843.620164689281;5845.41545845412;5848.883022339614;5855.912161317584;6195.380461953859;6258.593191442542;6282.748690052346;6284.340144284784;6308.905366419507;5706.201131841545;5834.3290521589715;5835.2414186156375;5902.026165682614;5940.495057920125;5423.945760542344;5424.376196737347;5428.5928555358505;5437.075697131497;5437.918431223456;6414.069959855795;6464.385883341075;6468.676566171673;6470.935290647128;6502.642354670538;6214.25428948529;6219.440250377488;6275.246970363585;6363.96818015907;6446.838829029124;6404.135441715309;6424.293327734039;6430.935690643221;6445.774397896051;6485.708143133476;5115.846524604268;6146.477549408171;6284.497240220863;6289.779857704958;6347.365263473615;6138.048602466625;6193.84515387119;6242.344553821965;6280.811575652738;6285.371462853678;6173.59871608344;6210.906836397548;6214;6231.22109736283;6239.500839932885;5998.520118390431;6115.453310713017;6200.472959798468;6224.253089629274;6229.314775374614;6095.024796032613;6097.847553811191;6104.11490333908;6118;6140.969295153495;6208.782692605737;6251.937480625317;6269;6270.2475702915945;6275.592086514362;5994.970025150021;6087.05650624154;6114.969425152845;6117.571769976059;6145.262568491809 04:25:46 INFO - PROCESS | 1964 | |1;ext.html;503.35067762586266;593.2762030323005;594.1948659566287;664.3093327481561;668.4692055193607;31351;31661.52507712383;41676.37485437717;41697.7915110424;41767.79116104423;45417;45952;45993;46038.8490287743;46056;9510.809783804338;9839.163671087967;9843.557039933221;9849;9850.261230407748;8228.341732661404;9782.413055216673;9782.413055216673;9802.313838031341;9877.160441362494;9869.062439068277;9879.506024698772;9946.154576860976;9961.60153593859;9988.300818942676;9875.012498750104;9918.3553069051;9922.255830812717;9927.106560409598;9931.404115753006;9882.160016398615;9957.701268961942;9963;9976.451295178835;9998.45008524531;43135;43504.56495435069;43504.782476087734;43648.56351436477;43704.781476092736;3221.548983142362;3236.304194598149;3400.1329660936303;3482.8084455354947;3715.442683597455;30250.54624180639;30361.785528578832;30591.847040764875;30718.692813071808;30821.92123275697;2717.633119528858;2771.76440002598;2811.6063751074867;2830.9292267693268;2851.657801063865;504338;509979;510860;510991;512539;73362.26637733555;73690.63154684192;73766;73773.63113184508;73823.63088184525;77941;78665;81684.59157704173;81910.59044704738;82175.5891220552;18540.980246086594;18579.628407432047;18793.872367657983;18801.05994700287;18803;11772.17594768358;13793.931030344784;14056.508022219377;14158.50445234412;14164.787528187086;23546.411339716302;23586;23712.814359281965;23763.81180940946;23780.524389512113;9669.178119859891;9906.80186396268;9917.851232231522;9919.256055795844;9930.751731206634;964.9517524123765;993.2997236947934;1004.8593196952432;1035.8549803027581;1050.6270274052754;25342.366440839127;25544.616830747553;30647.846760766053;30716.232094197378;31363.609094726755;941.6468824190929;1151.7696460707891;1181.527389044389;1202.9879701202876;1228.42264135856;15532.689346213012;15759.369625214864;15809;16144.609631977417;16217.35130594763;555572;561280;562716;563416.1829190828;563591;64494;64947;64977;65171;65271.67364163149;1407.3948202272916;1427.4789701758991;1522.87055600273;1527.2821773766311;1562.3672412672659;28139;30034.49482577631;32107.357852842346;32698;33050.18223997607;61306.69346653238;61748;62581;62586;62592;496498;499039.0384384729;501080;501426;501575;39399.40900886431;47255;47563;47736.52263477321;48114;38190.045248867886;45854.77072614749;45950.54049459596;46057.76971115123;47500.57498275057;36820.81589592035;37399.06502337354;38213.61786382212;38373.808130959165;39143.21713565656;30633.846830765702;37712.62287377201;37813.81093094517;37887.62112378841;38559.6144038556;32842.83578582092;39171.80414097911;39509.80245098871;40258;40389;28222.85888570544;33885.3222935535;34749.82625086858;35360.469592956644;35362.292754144255;26370.07704730402;26411.207663770118;26433.603495947962;26642.600360994213;26658.866705666347 04:25:46 INFO - PROCESS | 1964 | |2;jquery.html;379.7246995927953;387.0575149510943;389.79146156806104;390.18451436497713;392.5446482080787;16604.335826566952;16830.915845420757;19874;20959.371218863438;21396.89301553492;17180.570485737862;20158.790472571654;20613.381598552067;20648.896755516238;21754.912254387258;5180.378354597454;5847.619904706191;6057.818265452043;6125.938740612603;6131.662758548278;5928.970355148218;6014.789482368118;6061.969690151543;6092.055731361646;6151.292601350835;6019.367966363513;6082.513398928075;6090.421409966046;6108.786192483264;6111.694415279218;5876.559258055663;6068.846919085382;6117.143599896018;6125.754969801203;6130.295016073164;5829.504492118175;5842;5848;5849.473547380756;5859.8535036624;14430.278486075655;18488.72266915997;20507.077181526867;22156.88921555382;26650.200493985212;2160.1899287767087;2312.9653055204185;2348.213348528245;2390.0200917623692;2666.520026395248;8570.48577085377;9913.405195688281;10017.549210285555;10295.124914382286;10558.630447934362;1619.9190040497929;1635.8200597934217;1769.9380521681808;1787.2046939112101;1802.3241284518306;102639;113209.43395283053;113236;116163;116709.8329016716;11900.226485278428;11966.222195557435;11969.581064662869;12005.219660722025;12034.097442691833;12058.879411205775;14701.191434471206;14703.632409189855;14724.55826325212;14765.33555989983;7418.703251869865;9105.361035013628;9164.266858651425;9241.861372079424;9260;9371.437713737198;9418.905810941802;9421;9478.57346419399;9495.525223738785;4669.649776266726;4675.976620116878;4677.22825733757;4678.274867395559;4713.34013238147;1679.378629906918;1914.9904250478658;1959.2163134746215;1971.044043638834;1994.4914046918234;902.8149229407956;923.5474617437408;1045.696747943088;1088.7278180454887;1122.1303489795473;20563.691544626843;21261.893690531757;21502.677459838116;21605.135794568356;21724.674129888066;1004.4224570871778;1015.6851376073441;1024.2522958240527;1077.1705786544317;1140.3670962615827;11155.609553665583;11565.190436669352;11630.185886987998;11638.70903227426;11655.184137110491;651170;657273;657366;664343;673154;72889.6355518219;110804;110936;124563.37718311531;132302;1047.0681093826502;1051.6687243518268;1067.5516283161091;1068.2842495528014;1075.7418219627389;19479.90260048691;19601.31395401154;19748.90125549363;19790.307339243056;19818;54667.45332546624;54727.17909231285;54959.72520137374;56061;56828.431715682316;72883;73706.63146684233;77389.83915241389;79707.20292796998;81614.18385816303;8081.191880811872;8301.128381519853;8322.750317490485;8397.874031889405;8716;9836.557354918903;13434.596962091153;13811.654708632364;14032.64918377008;14224.786628200793;11820;11990.760184796429;12057.457414416547;12078.758424831278;12192.57325993586;11697.2981621103;11710.882891170979;11890.583829565923;11978.820317695066;12141.575044873387;12042.63872083839;12047.156699030984;12106.213096149075;12303.323317217639;12504.312262825268;8378.24595786382;8523.360747943805;8548.059713431641;8616.698415555426;8758.255548278468;9056.773580660536;12049.879501204876;12056.819147712968;12221.75556488883;12340.382980850742 04:25:46 INFO - PROCESS | 1964 | |3;mootools.html;1491.5301679970814;1632.355219688223;1661.0531996761847;2004.7494063242095;2089.9895500522503;8420.494770313779;9153.31350148739;9330.393524420908;9342.859857102141;9367.437953722765;9009.369344145913;9061.32040096992;9151.816963660724;9176.17414432701;9195.310351723614;2277.2598905355744;2516.7860731837814;2568.4477837264985;2598.6491823603856;2601.4406902515957;2575.214559559334;2580.213035024326;2586.5602847515966;2587.4954383895056;2590.922272331833;2502.174282486775;2546.2234018624404;2576.046862660818;2576.4847030593864;2585.935351616215;2525.229804909502;2564.397366618843;2575.7166711661794;2594.779443747284;2596.039465397796;2553;2576.6263891735593;2594;2596.07839217079;2599.4411201591747;9285.257179425696;9367.625294988193;9385.624575016991;9397.483138427384;9406.529673516297;5703.344115426696;5931.614445061057;5931.881362372728;5935.465808077251;5940.168376427304;3710.7402481826284;3804.1060350817534;3855.9421608675893;3868.4390763339156;3882.4758657581147;1043.982117435502;1058.359692386103;1058.4760543530924;1065.5471424644572;1098.8791232964447;12715.427805748672;12720.236785792882;12743.553975610808;12781.360931953364;12814.038947079007;5131.153359695609;5146.845594632167;5202.4277329493725;5210.505002024802;5261.13191323435;10838.132949364031;10845.728856778485;10854.185936054828;10869.076128529005;10884.07485363753;5802.042662960649;5859.560532960045;5865.237519122486;5872.324682661463;5875.706214689334;4645.605123564467;4811.422629284439;4987.152184128707;5154.768035438415;5270.631055826056;4060.796960151981;4118.423420721101;4125.257453658311;4152.418661387408;4174.248635245685;1349.3927732520406;1351.4459071780523;1353.8781509664177;1354.850966393696;1366.3851266929921;1417.6030711400824;1439.2659743530664;1449.311577000916;1467.9045862018934;1474.2039298778755;8592.140785921483;8606.526641034803;8653.307735381155;8662.220400164015;8664.393492455467;527.3671594087111;539.919012148181;544.0506316477772;546.1698218707543;547.0945585056737;6345.619262844244;6390.488760899117;6402;6427.100205971168;6429.22849258092;10923.890761092447;11291.096712262999;11437.828432573519;11454.713632159095;11469.369184694755;10407.791844163074;10753.978372054642;11056.889431105747;11267;11303.434828258554;8617.61220745068;8722.040575536686;8836.381453298336;8849.99999999987;8862.0251772305;7619.69521219145;8060.435769496079;8477.915220847712;8524.318054555497;8623.482591044558;9967.750806229902;10067.395956242648;10070.647527336509;10192;10261.84607230907;10219.795604087727;10636.468176590985;10644.574217031543;10873.945630271797;10908.34549927007;7130.180029296697;7328.560286382834;7529.171791103084;7569.659365328684;7816.53100813953;8617.95691021541;8627.6980305689;8652.09153038947;8657.610407531802;8660.740177794676;7483.289087536676;7614.695412183451;7677.61611919413;7685.423593230642;7732.690692372467;6243.719032643451;7401.185869554237;7433.1823499416105;7466.664000120117;7603.88594171099;8045.356371490149;8150.75547733569;8196.54918979462;8209.343252539902;8209.71266005687;7354.926450735638;7407.666655000646;7411.8147046324275;7416.295451932057;7474.701011959461;6318.304986451579;7509.774706758806;7541.35898448638;7542.396608271215;7560.017197764256 04:25:46 INFO - PROCESS | 1964 | |4;prototype.html;284.6370877131657;342.3973806101261;345.8875865343764;346.0949616752194;349.7831344566369;6518.967405162974;6604.174478190226;6605.735770569184;6634.436072933794;6647.268800431949;4939.481354457784;6367.33143019982;6536.444402225805;6584.67076646167;6587.3412658734105;4636.698614590057;4724.976375118137;4799.064182484417;4870.586000189979;4889.437714662824;4853.441854186761;4856.271559266121;4890.8043678252825;4892.217245240762;4892.877678058041;4835.782389792468;4839.27410888366;4839.854804355875;4841.24960631101;4852.344933433994;4606.516315786845;4627.768611569425;4799.208130658437;4801.255805350176;4827.85516434504;4142.937855932163;4145.0880806222585;4156.044109854751;4158.168366326717;4162.229987452331;6276.152719382916;6289.056641503766;6296.370362963667;6299.5275354348605;6317.368263173692;5727.856803579903;5746.454086861741;5753.223314852483;5756.309242890838;5778.855528611776;6759.493038022168;7011.544249623758;7020.684069216846;7031.226565077837;7033.683484243222;4695.248760198352;4727.881802954919;4737.692050016738;4742.027884283713;4746.5490778376;7365.631718414058;7407.592582407965;7411.740589079411;7416.479621677543;7428.777136685854;3960.861369852099;4800.375951126401;4804.711717296974;4805.3512775775525;4806.759662016885;4863.197572400585;4877.561019508261;4878.707277563358;4892.51074892515;4896.926546101811;5728.427157284238;5737.397573254748;5746.913796293059;5747.4252574742195;5757.453041961007;6799.762008329685;7113.679884405215;7119.974011045285;7125.2874712529365;7139.607321597362;1634.9427770027992;1667.9749803752954;1669.1570756767755;1669.8330166983205;1670.941517046922;997.835357166074;1031.6698656430021;1050.9106725928382;1061.601899287767;1085.5440714899762;5179.559737422362;6351.777687780906;6361.681915904186;6440.516961227833;6605.372489613479;7358.816029599303;7379.741709040158;7385.7045718170675;7387.150477695134;7415.666295016737;6533.020046992894;6533.607983521004;6548.8035358939305;6557.639329836905;6566.047923051131;3849.8845034649007;3896.7077469189358;3898.5516665583255;3898.90252743678;3907.8241479133508;6799.558028728117;7205.387542058984;7403.22266162056;7716.2669546393;7737.264959828807;7544.735934242385;7583.582902940391;7593.810154746065;7603.9619801900635;7619.352355049772;7677.27065928747;7681.654325555363;7683.308502234826;7684.9615751922;7691.615419229128;5963.701814909324;7131.572105673677;7374.520656157332;7389.630518474162;7397.778066658009;6188;7234.131904171533;7256.2018178001435;7264.418846492374;7281.672324745293;6933.687984040831;7660;7678.001859758196;7678.692852285846;7683.769486915401;4630.814767409266;4685.835995740133;4692;4706.341112244357;4719.339292499121;5916.467517923407;7058.25888281723;7314.853702926018;7333.706651733871;7334.4132469403385;5714.5999780015;7026.543274687129;7073.398761105158;7096.8935465967015;7115.644217789193;7035.296470353129;7080.8937865933085;7081.468889833386;7088.589879441015;7097.716091356495;6893.241743408322;6904.516683832285;6907.447404207752;6908.689108990007;6930.480213984072;6836.658167091526;7096.503244772816;7100.857982840417;7102.786916392516;7105.538140020882;6581.440577550962;6705.664716764045;6811.114555107804;6959.58242505431;7005.964970175117 04:25:46 INFO - PROCESS | 1964 | |5;yui.html;705.8941158826177;738.7635956493922;782.3467404717057;793.4445887878486;799.9040115186178;15489.225538723062;15700.528984130466;15701.92149039256;15707.371705131782;15741.685166296667;16394.426195083175;16767.24547395367;16810.32758689651;16847.241874115665;16859;804.264098350012;813.9064007639108;981.249344251648;989.4063561862861;1013.2350075692841;987.7728122531822;991.0733464210949;993.9552720127575;995.1292618958412;995.3182070281844;1060.9151267898549;1062.6705721226444;1066.8879767624403;1066.9946650266777;1067.2955849139569;817.6034623207739;850.7617866997251;863.3567991846115;1031.7730099378125;1056.9947150264238;783.0094929913664;784.247122762149;784.6037750935798;785.9410544209208;788.7081779741475;15793.684126317525;15839.208039597974;15855;15867.841321586868;15876.12681302528;13288.402021909038;13305.40125694346;13422.463101475929;13519.86480135196;13582.320883955861;10082.747931301776;10362.63730769427;10492.580296788119;10559.102476289525;10714.892851071467;3607.927841443183;3651.1784848408897;3657.65252301031;3660.2130541933348;3677.3196958562753;90405.31554817848;90881.09118908792;91452.54273728655;92412;92888;9837.016298370248;9977.950110249401;10069.446180459998;10096.798064038678;11285.153613479022;19788.307409240897;24273.150439734523;24331;24344;24413.877930610233;7556.65995030225;7583.165851756413;7636.50362726421;7671.769846904602;7876.921230787733;4132.504099508018;4138.91722165561;4190.685698572619;4199.181159673834;4281.743095414286;3756;3805.37211360128;3814.237152569497;3815.008097894512;3818.885433437001;648.1217949678212;659.7525927777084;661.5237029338869;670.2125003121313;684.2917580304461;540.351578106274;586.3960121075299;589.3723184808166;606.9757209711562;640.6604499615212;8138.959305203436;8519.74440766778;8586.09845966177;8614.095519970313;8678.349123815613;530.1755769777956;596.9373215812363;611.5963464113663;618.9597676151126;620.7889317632026;3922.9607703922597;3970.9205815884097;3979.5025621797276;4000.0399904023407;4089.8159582818844;93144.53427732817;93978.53010734903;94217.528912355;94946;103883.48058259812;85860.57069714737;86457.13542864617;86710;87217;88874;69900;73790.89313660192;73821;74329.6283518579;74418;7549.50928189666;7873.976383070393;7914.881276780968;8010.279074883056;8021.639026243716;53159.936801262986;53194.202086967955;53915.921681566935;54040.48736832093;55327;69753;71648.64175679088;71917.28082719106;72440;73245;10311.020453056948;10380.948095259475;10558.996895294935;10822.783544329226;10890.836637450286;10652.520636571528;10919.39943303126;10977.725556861142;11117.284073096895;11267.887321126684;10447.68656940293;10591.258611897094;10609.363438193424;10737.463126843782;10880.238383313408;10461.05850473461;10516.263861529926;10552.577896884039;10652.946735266583;10867.456627168767;10282.177425806067;10364.948175259075;10506.369617822955;10660.307080039773;10931.6720498382;8925.553722313989;9038;9091.181793638605;9289.814203715752;9398.389104708172;8798.780030499289;8909.109089091038;9011.594478248626;9069.909300906906;9144.817103658022 04:25:46 INFO - PROCESS | 1964 | __end_tp_report 04:25:46 INFO - PROCESS | 1964 | __start_cc_report 04:25:46 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,1051 04:25:46 INFO - PROCESS | 1964 | __end_cc_report 04:25:46 INFO - PROCESS | 1964 | __startTimestamp1457612746119__endTimestamp 04:25:46 INFO - PROCESS | 1964 | 04:25:46 INFO - PROCESS | 1964 | ------- Summary: start ------- 04:25:46 INFO - PROCESS | 1964 | Number of tests: 6 04:25:46 INFO - PROCESS | 1964 | 04:25:46 INFO - PROCESS | 1964 | [#0] dojo.html Cycles:165 Average:5800.72 Median:6104.11 stddev:669.86 (11.0%) stddev-sans-first:644.98 04:25:46 INFO - PROCESS | 1964 | Values: 3404.0 3418.3 3423.3 3464.0 3467.6 5682.5 5796.9 5798.8 5807.2 5827.6 5779.6 5804.9 5834.9 5839.2 5856.0 4344.5 5156.0 5156.1 5176.2 5194.7 5258.9 5266.3 5268.4 5273.2 5273.3 5242.9 5271.8 5283.4 5292.6 5298.8 4440.8 5075.3 5280.6 5304.8 5335.8 5044.9 5191.8 5247.3 5259.2 5323.0 5644.1 5651.8 5695.7 5730.1 5739.4 6213.3 6293.8 6302.6 6304.0 6331.6 6223.2 6228.2 6297.5 6313.4 6320.9 5912.1 5935.1 5953.8 5956.8 5964.5 6243.3 6271.5 6327.5 6345.6 6349.8 6247.6 6273.6 6285.6 6289.3 6305.7 6203.8 6256.6 6264.4 6276.9 6312.8 5282.5 6222.5 6226.0 6260.2 6317.1 6309.5 6315.7 6330.4 6332.1 6353.2 4908.6 4924.4 4927.5 4932.3 4954.6 4418.3 4453.0 4471.0 4520.3 4528.6 5822.1 5843.6 5845.4 5848.9 5855.9 6195.4 6258.6 6282.7 6284.3 6308.9 5706.2 5834.3 5835.2 5902.0 5940.5 5423.9 5424.4 5428.6 5437.1 5437.9 6414.1 6464.4 6468.7 6470.9 6502.6 6214.3 6219.4 6275.2 6364.0 6446.8 6404.1 6424.3 6430.9 6445.8 6485.7 5115.8 6146.5 6284.5 6289.8 6347.4 6138.0 6193.8 6242.3 6280.8 6285.4 6173.6 6210.9 6214.0 6231.2 6239.5 5998.5 6115.5 6200.5 6224.3 6229.3 6095.0 6097.8 6104.1 6118.0 6141.0 6208.8 6251.9 6269.0 6270.2 6275.6 5995.0 6087.1 6115.0 6117.6 6145.3 04:25:46 INFO - PROCESS | 1964 | 04:25:46 INFO - PROCESS | 1964 | [#1] ext.html Cycles:180 Average:68742.24 Median:43504.67 stddev:139343.02 (320.3%) stddev-sans-first:139639.73 04:25:46 INFO - PROCESS | 1964 | Values: 503.4 593.3 594.2 664.3 668.5 31351.0 31661.5 41676.4 41697.8 41767.8 45417.0 45952.0 45993.0 46038.8 46056.0 9510.8 9839.2 9843.6 9849.0 9850.3 8228.3 9782.4 9782.4 9802.3 9877.2 9869.1 9879.5 9946.2 9961.6 9988.3 9875.0 9918.4 9922.3 9927.1 9931.4 9882.2 9957.7 9963.0 9976.5 9998.5 43135.0 43504.6 43504.8 43648.6 43704.8 3221.5 3236.3 3400.1 3482.8 3715.4 30250.5 30361.8 30591.8 30718.7 30821.9 2717.6 2771.8 2811.6 2830.9 2851.7 504338.0 509979.0 510860.0 510991.0 512539.0 73362.3 73690.6 73766.0 73773.6 73823.6 77941.0 78665.0 81684.6 81910.6 82175.6 18541.0 18579.6 18793.9 18801.1 18803.0 11772.2 13793.9 14056.5 14158.5 14164.8 23546.4 23586.0 23712.8 23763.8 23780.5 9669.2 9906.8 9917.9 9919.3 9930.8 965.0 993.3 1004.9 1035.9 1050.6 25342.4 25544.6 30647.8 30716.2 31363.6 941.6 1151.8 1181.5 1203.0 1228.4 15532.7 15759.4 15809.0 16144.6 16217.4 555572.0 561280.0 562716.0 563416.2 563591.0 64494.0 64947.0 64977.0 65171.0 65271.7 1407.4 1427.5 1522.9 1527.3 1562.4 28139.0 30034.5 32107.4 32698.0 33050.2 61306.7 61748.0 62581.0 62586.0 62592.0 496498.0 499039.0 501080.0 501426.0 501575.0 39399.4 47255.0 47563.0 47736.5 48114.0 38190.0 45854.8 45950.5 46057.8 47500.6 36820.8 37399.1 38213.6 38373.8 39143.2 30633.8 37712.6 37813.8 37887.6 38559.6 32842.8 39171.8 39509.8 40258.0 40389.0 28222.9 33885.3 34749.8 35360.5 35362.3 26370.1 26411.2 26433.6 26642.6 26658.9 04:25:46 INFO - PROCESS | 1964 | 04:25:46 INFO - PROCESS | 1964 | [#2] jquery.html Cycles:180 Average:36226.14 Median:21329.39 stddev:109270.31 (512.3%) stddev-sans-first:109543.69 04:25:46 INFO - PROCESS | 1964 | Values: 379.7 387.1 389.8 390.2 392.5 16604.3 16830.9 19874.0 20959.4 21396.9 17180.6 20158.8 20613.4 20648.9 21754.9 5180.4 5847.6 6057.8 6125.9 6131.7 5929.0 6014.8 6062.0 6092.1 6151.3 6019.4 6082.5 6090.4 6108.8 6111.7 5876.6 6068.8 6117.1 6125.8 6130.3 5829.5 5842.0 5848.0 5849.5 5859.9 14430.3 18488.7 20507.1 22156.9 26650.2 2160.2 2313.0 2348.2 2390.0 2666.5 8570.5 9913.4 10017.5 10295.1 10558.6 1619.9 1635.8 1769.9 1787.2 1802.3 102639.0 113209.4 113236.0 116163.0 116709.8 11900.2 11966.2 11969.6 12005.2 12034.1 12058.9 14701.2 14703.6 14724.6 14765.3 7418.7 9105.4 9164.3 9241.9 9260.0 9371.4 9418.9 9421.0 9478.6 9495.5 4669.6 4676.0 4677.2 4678.3 4713.3 1679.4 1915.0 1959.2 1971.0 1994.5 902.8 923.5 1045.7 1088.7 1122.1 20563.7 21261.9 21502.7 21605.1 21724.7 1004.4 1015.7 1024.3 1077.2 1140.4 11155.6 11565.2 11630.2 11638.7 11655.2 651170.0 657273.0 657366.0 664343.0 673154.0 72889.6 110804.0 110936.0 124563.4 132302.0 1047.1 1051.7 1067.6 1068.3 1075.7 19479.9 19601.3 19748.9 19790.3 19818.0 54667.5 54727.2 54959.7 56061.0 56828.4 72883.0 73706.6 77389.8 79707.2 81614.2 8081.2 8301.1 8322.8 8397.9 8716.0 9836.6 13434.6 13811.7 14032.6 14224.8 11820.0 11990.8 12057.5 12078.8 12192.6 11697.3 11710.9 11890.6 11978.8 12141.6 12042.6 12047.2 12106.2 12303.3 12504.3 8378.2 8523.4 8548.1 8616.7 8758.3 9056.8 12049.9 12056.8 12221.8 12340.4 04:25:46 INFO - PROCESS | 1964 | 04:25:46 INFO - PROCESS | 1964 | [#3] mootools.html Cycles:180 Average:6362.47 Median:5206.47 stddev:3396.41 (65.2%) stddev-sans-first:3386.21 04:25:46 INFO - PROCESS | 1964 | Values: 1491.5 1632.4 1661.1 2004.7 2090.0 8420.5 9153.3 9330.4 9342.9 9367.4 9009.4 9061.3 9151.8 9176.2 9195.3 2277.3 2516.8 2568.4 2598.6 2601.4 2575.2 2580.2 2586.6 2587.5 2590.9 2502.2 2546.2 2576.0 2576.5 2585.9 2525.2 2564.4 2575.7 2594.8 2596.0 2553.0 2576.6 2594.0 2596.1 2599.4 9285.3 9367.6 9385.6 9397.5 9406.5 5703.3 5931.6 5931.9 5935.5 5940.2 3710.7 3804.1 3855.9 3868.4 3882.5 1044.0 1058.4 1058.5 1065.5 1098.9 12715.4 12720.2 12743.6 12781.4 12814.0 5131.2 5146.8 5202.4 5210.5 5261.1 10838.1 10845.7 10854.2 10869.1 10884.1 5802.0 5859.6 5865.2 5872.3 5875.7 4645.6 4811.4 4987.2 5154.8 5270.6 4060.8 4118.4 4125.3 4152.4 4174.2 1349.4 1351.4 1353.9 1354.9 1366.4 1417.6 1439.3 1449.3 1467.9 1474.2 8592.1 8606.5 8653.3 8662.2 8664.4 527.4 539.9 544.1 546.2 547.1 6345.6 6390.5 6402.0 6427.1 6429.2 10923.9 11291.1 11437.8 11454.7 11469.4 10407.8 10754.0 11056.9 11267.0 11303.4 8617.6 8722.0 8836.4 8850.0 8862.0 7619.7 8060.4 8477.9 8524.3 8623.5 9967.8 10067.4 10070.6 10192.0 10261.8 10219.8 10636.5 10644.6 10873.9 10908.3 7130.2 7328.6 7529.2 7569.7 7816.5 8618.0 8627.7 8652.1 8657.6 8660.7 7483.3 7614.7 7677.6 7685.4 7732.7 6243.7 7401.2 7433.2 7466.7 7603.9 8045.4 8150.8 8196.5 8209.3 8209.7 7354.9 7407.7 7411.8 7416.3 7474.7 6318.3 7509.8 7541.4 7542.4 7560.0 04:25:46 INFO - PROCESS | 1964 | 04:25:46 INFO - PROCESS | 1964 | [#4] prototype.html Cycles:180 Average:5758.94 Median:6533.31 stddev:1827.85 (28.0%) stddev-sans-first:1786.20 04:25:46 INFO - PROCESS | 1964 | Values: 284.6 342.4 345.9 346.1 349.8 6519.0 6604.2 6605.7 6634.4 6647.3 4939.5 6367.3 6536.4 6584.7 6587.3 4636.7 4725.0 4799.1 4870.6 4889.4 4853.4 4856.3 4890.8 4892.2 4892.9 4835.8 4839.3 4839.9 4841.2 4852.3 4606.5 4627.8 4799.2 4801.3 4827.9 4142.9 4145.1 4156.0 4158.2 4162.2 6276.2 6289.1 6296.4 6299.5 6317.4 5727.9 5746.5 5753.2 5756.3 5778.9 6759.5 7011.5 7020.7 7031.2 7033.7 4695.2 4727.9 4737.7 4742.0 4746.5 7365.6 7407.6 7411.7 7416.5 7428.8 3960.9 4800.4 4804.7 4805.4 4806.8 4863.2 4877.6 4878.7 4892.5 4896.9 5728.4 5737.4 5746.9 5747.4 5757.5 6799.8 7113.7 7120.0 7125.3 7139.6 1634.9 1668.0 1669.2 1669.8 1670.9 997.8 1031.7 1050.9 1061.6 1085.5 5179.6 6351.8 6361.7 6440.5 6605.4 7358.8 7379.7 7385.7 7387.2 7415.7 6533.0 6533.6 6548.8 6557.6 6566.0 3849.9 3896.7 3898.6 3898.9 3907.8 6799.6 7205.4 7403.2 7716.3 7737.3 7544.7 7583.6 7593.8 7604.0 7619.4 7677.3 7681.7 7683.3 7685.0 7691.6 5963.7 7131.6 7374.5 7389.6 7397.8 6188.0 7234.1 7256.2 7264.4 7281.7 6933.7 7660.0 7678.0 7678.7 7683.8 4630.8 4685.8 4692.0 4706.3 4719.3 5916.5 7058.3 7314.9 7333.7 7334.4 5714.6 7026.5 7073.4 7096.9 7115.6 7035.3 7080.9 7081.5 7088.6 7097.7 6893.2 6904.5 6907.4 6908.7 6930.5 6836.7 7096.5 7100.9 7102.8 7105.5 6581.4 6705.7 6811.1 6959.6 7006.0 04:25:46 INFO - PROCESS | 1964 | 04:25:46 INFO - PROCESS | 1964 | [#5] yui.html Cycles:180 Average:19387.73 Median:27228.14 stddev:27879.94 (102.4%) stddev-sans-first:27922.86 04:25:46 INFO - PROCESS | 1964 | Values: 705.9 738.8 782.3 793.4 799.9 15489.2 15700.5 15701.9 15707.4 15741.7 16394.4 16767.2 16810.3 16847.2 16859.0 804.3 813.9 981.2 989.4 1013.2 987.8 991.1 994.0 995.1 995.3 1060.9 1062.7 1066.9 1067.0 1067.3 817.6 850.8 863.4 1031.8 1057.0 783.0 784.2 784.6 785.9 788.7 15793.7 15839.2 15855.0 15867.8 15876.1 13288.4 13305.4 13422.5 13519.9 13582.3 10082.7 10362.6 10492.6 10559.1 10714.9 3607.9 3651.2 3657.7 3660.2 3677.3 90405.3 90881.1 91452.5 92412.0 92888.0 9837.0 9978.0 10069.4 10096.8 11285.2 19788.3 24273.2 24331.0 24344.0 24413.9 7556.7 7583.2 7636.5 7671.8 7876.9 4132.5 4138.9 4190.7 4199.2 4281.7 3756.0 3805.4 3814.2 3815.0 3818.9 648.1 659.8 661.5 670.2 684.3 540.4 586.4 589.4 607.0 640.7 8139.0 8519.7 8586.1 8614.1 8678.3 530.2 596.9 611.6 619.0 620.8 3923.0 3970.9 3979.5 4000.0 4089.8 93144.5 93978.5 94217.5 94946.0 103883.5 85860.6 86457.1 86710.0 87217.0 88874.0 69900.0 73790.9 73821.0 74329.6 74418.0 7549.5 7874.0 7914.9 8010.3 8021.6 53159.9 53194.2 53915.9 54040.5 55327.0 69753.0 71648.6 71917.3 72440.0 73245.0 10311.0 10380.9 10559.0 10822.8 10890.8 10652.5 10919.4 10977.7 11117.3 11267.9 10447.7 10591.3 10609.4 10737.5 10880.2 10461.1 10516.3 10552.6 10652.9 10867.5 10282.2 10364.9 10506.4 10660.3 10931.7 8925.6 9038.0 9091.2 9289.8 9398.4 8798.8 8909.1 9011.6 9069.9 9144.8 04:25:46 INFO - PROCESS | 1964 | -------- Summary: end -------- 04:25:46 INFO - PROCESS | 1964 | 04:25:46 INFO - TEST-INFO | 1964: exit 0 04:25:46 INFO - TEST-OK | dromaeo_css | took 1112853ms 04:25:46 INFO - TEST-START | kraken 04:25:46 INFO - operating with platform_type : mac_ 04:25:46 INFO - Initialising browser for kraken test... 04:25:46 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpZk2yky/profile http://localhost:57283/getInfo.html) 04:25:48 INFO - PROCESS | 1967 | __metrics Screen width/height:1600/1200 04:25:48 INFO - PROCESS | 1967 | colorDepth:24 04:25:48 INFO - PROCESS | 1967 | Browser inner width/height: 1024/689 04:25:48 INFO - PROCESS | 1967 | __metrics 04:25:49 INFO - PROCESS | 1967 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:25:49 INFO - PROCESS | 1967 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:25:49 INFO - TEST-INFO | 1967: exit 0 04:25:49 INFO - Browser initialized. 04:25:49 INFO - Running cycle 1/1 for kraken test... 04:25:49 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpZk2yky/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:01 INFO - PROCESS | 1969 | RSS: Main: 210378752 04:26:01 INFO - PROCESS | 1969 | 04:26:04 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57283/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:04 INFO - PROCESS | 1969 | RSS: Main: 264417280 04:26:04 INFO - PROCESS | 1969 | 04:26:07 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57283/tests/kraken/driver.html?testName=audio-dft) 04:26:08 INFO - PROCESS | 1969 | RSS: Main: 274309120 04:26:08 INFO - PROCESS | 1969 | 04:26:11 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57283/tests/kraken/driver.html?testName=audio-fft) 04:26:12 INFO - PROCESS | 1969 | RSS: Main: 265400320 04:26:12 INFO - PROCESS | 1969 | 04:26:13 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57283/tests/kraken/driver.html?testName=audio-oscillator) 04:26:14 INFO - PROCESS | 1969 | RSS: Main: 267436032 04:26:14 INFO - PROCESS | 1969 | 04:26:16 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:17 INFO - PROCESS | 1969 | RSS: Main: 268595200 04:26:17 INFO - PROCESS | 1969 | 04:26:20 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57283/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:20 INFO - PROCESS | 1969 | RSS: Main: 268607488 04:26:20 INFO - PROCESS | 1969 | 04:26:23 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57283/tests/kraken/driver.html?testName=imaging-desaturate) 04:26:23 INFO - PROCESS | 1969 | RSS: Main: 268963840 04:26:23 INFO - PROCESS | 1969 | 04:26:26 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57283/tests/kraken/driver.html?testName=json-parse-financial) 04:26:27 INFO - PROCESS | 1969 | RSS: Main: 268496896 04:26:27 INFO - PROCESS | 1969 | 04:26:28 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:26:29 INFO - PROCESS | 1969 | RSS: Main: 301928448 04:26:29 INFO - PROCESS | 1969 | 04:26:31 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:31 INFO - PROCESS | 1969 | RSS: Main: 302198784 04:26:31 INFO - PROCESS | 1969 | 04:26:33 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:34 INFO - PROCESS | 1969 | RSS: Main: 308068352 04:26:34 INFO - PROCESS | 1969 | 04:26:36 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:37 INFO - PROCESS | 1969 | RSS: Main: 310378496 04:26:37 INFO - PROCESS | 1969 | 04:26:40 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:40 INFO - PROCESS | 1969 | RSS: Main: 308867072 04:26:40 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57283/tests/kraken/driver.html?testName=ai-astar) 04:26:42 INFO - PROCESS | 1969 | RSS: Main: 369807360 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | __start_tp_report 04:26:42 INFO - PROCESS | 1969 | _x_x_mozilla_page_load 04:26:42 INFO - PROCESS | 1969 | _x_x_mozilla_page_load_details 04:26:42 INFO - PROCESS | 1969 | |i|pagename|runs| 04:26:42 INFO - PROCESS | 1969 | |0;ai-astar;112;111;111;115;158;145;117;111;110;110 04:26:42 INFO - PROCESS | 1969 | |1;audio-beat-detection;176;157;143;187;153;139;117;153;146;117 04:26:42 INFO - PROCESS | 1969 | |2;audio-dft;182;184;198;262;207;188;184;185;186;186 04:26:42 INFO - PROCESS | 1969 | |3;audio-fft;75;78;73;121;55;56;57;60;117;56 04:26:42 INFO - PROCESS | 1969 | |4;audio-oscillator;93;96;128;81;78;90;115;76;79;117 04:26:42 INFO - PROCESS | 1969 | |5;imaging-gaussian-blur;135;131;87;84;87;83;88;83;87;83 04:26:42 INFO - PROCESS | 1969 | |6;imaging-darkroom;92;92;92;92;92;92;92;91;92;92 04:26:42 INFO - PROCESS | 1969 | |7;imaging-desaturate;85;86;85;85;84;85;87;84;85;84 04:26:42 INFO - PROCESS | 1969 | |8;json-parse-financial;54;57;57;56;57;57;59;69;51;51 04:26:42 INFO - PROCESS | 1969 | |9;json-stringify-tinderbox;66;64;71;78;69;69;64;71;65;65 04:26:42 INFO - PROCESS | 1969 | |10;stanford-crypto-aes;80;81;82;80;80;77;79;74;80;85 04:26:42 INFO - PROCESS | 1969 | |11;stanford-crypto-ccm;116;116;120;126;115;116;120;115;129;127 04:26:42 INFO - PROCESS | 1969 | |12;stanford-crypto-pbkdf2;134;121;131;132;132;165;167;167;132;130 04:26:42 INFO - PROCESS | 1969 | |13;stanford-crypto-sha256-iterative;65;64;65;65;66;66;66;65;65;65 04:26:42 INFO - PROCESS | 1969 | __end_tp_report 04:26:42 INFO - PROCESS | 1969 | __start_cc_report 04:26:42 INFO - PROCESS | 1969 | _x_x_mozilla_cycle_collect,1174 04:26:42 INFO - PROCESS | 1969 | __end_cc_report 04:26:42 INFO - PROCESS | 1969 | __startTimestamp1457612802631__endTimestamp 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | ------- Summary: start ------- 04:26:42 INFO - PROCESS | 1969 | Number of tests: 14 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#0] ai-astar Cycles:10 Average:120.00 Median:113.50 stddev:17.03 (15.0%) stddev-sans-first:17.81 04:26:42 INFO - PROCESS | 1969 | Values: 112.0 111.0 111.0 115.0 158.0 145.0 117.0 111.0 110.0 110.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:153.00 stddev:22.27 (14.6%) stddev-sans-first:21.33 04:26:42 INFO - PROCESS | 1969 | Values: 176.0 157.0 143.0 187.0 153.0 139.0 117.0 153.0 146.0 117.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#2] audio-dft Cycles:10 Average:196.20 Median:187.00 stddev:24.38 (13.0%) stddev-sans-first:25.31 04:26:42 INFO - PROCESS | 1969 | Values: 182.0 184.0 198.0 262.0 207.0 188.0 184.0 185.0 186.0 186.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#3] audio-fft Cycles:10 Average:74.80 Median:58.50 stddev:24.86 (42.5%) stddev-sans-first:26.37 04:26:42 INFO - PROCESS | 1969 | Values: 75.0 78.0 73.0 121.0 55.0 56.0 57.0 60.0 117.0 56.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:80.00 stddev:18.57 (23.2%) stddev-sans-first:19.68 04:26:42 INFO - PROCESS | 1969 | Values: 93.0 96.0 128.0 81.0 78.0 90.0 115.0 76.0 79.0 117.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:85.50 stddev:20.25 (23.7%) stddev-sans-first:15.39 04:26:42 INFO - PROCESS | 1969 | Values: 135.0 131.0 87.0 84.0 87.0 83.0 88.0 83.0 87.0 83.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#6] imaging-darkroom Cycles:10 Average:91.90 Median:92.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:26:42 INFO - PROCESS | 1969 | Values: 92.0 92.0 92.0 92.0 92.0 92.0 92.0 91.0 92.0 92.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 04:26:42 INFO - PROCESS | 1969 | Values: 85.0 86.0 85.0 85.0 84.0 85.0 87.0 84.0 85.0 84.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:5.05 (8.9%) stddev-sans-first:5.25 04:26:42 INFO - PROCESS | 1969 | Values: 54.0 57.0 57.0 56.0 57.0 57.0 59.0 69.0 51.0 51.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:69.00 stddev:4.39 (6.4%) stddev-sans-first:4.59 04:26:42 INFO - PROCESS | 1969 | Values: 66.0 64.0 71.0 78.0 69.0 69.0 64.0 71.0 65.0 65.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:2.90 (3.6%) stddev-sans-first:3.07 04:26:42 INFO - PROCESS | 1969 | Values: 80.0 81.0 82.0 80.0 80.0 77.0 79.0 74.0 80.0 85.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:120.00 stddev:5.42 (4.5%) stddev-sans-first:5.55 04:26:42 INFO - PROCESS | 1969 | Values: 116.0 116.0 120.0 126.0 115.0 116.0 120.0 115.0 129.0 127.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.10 Median:133.00 stddev:17.77 (13.4%) stddev-sans-first:18.66 04:26:42 INFO - PROCESS | 1969 | Values: 134.0 121.0 131.0 132.0 132.0 165.0 167.0 167.0 132.0 130.0 04:26:42 INFO - PROCESS | 1969 | 04:26:42 INFO - PROCESS | 1969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 04:26:42 INFO - PROCESS | 1969 | Values: 65.0 64.0 65.0 65.0 66.0 66.0 66.0 65.0 65.0 65.0 04:26:42 INFO - PROCESS | 1969 | -------- Summary: end -------- 04:26:42 INFO - PROCESS | 1969 | 04:26:43 INFO - TEST-INFO | 1969: exit 0 04:26:43 INFO - TEST-OK | kraken | took 56637ms 04:26:43 INFO - SUITE-END | took 1169s 04:26:43 INFO - Completed test suite (00:19:29) 04:26:43 INFO - javascript benchmark 04:26:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3403.9829800850994, 3418.282160746244, 3423.263998240378, 3463.9653603463958, 3467.5838899332066, 5682.488576028157, 5796.913046304308, 5798.768049278029, 5807.216025836511, 5827.592068555203, 5779.62432441891, 5804.941950580493, 5834.941650583492, 5839.211706419643, 5856.0, 4344.522102568715, 5155.999999999991, 5156.071907056728, 5176.223566465042, 5194.68831870089, 5258.921116183241, 5266.289050978107, 5268.367795864501, 5273.156294992802, 5273.288106105665, 5242.947570524284, 5271.815486457975, 5283.365996080475, 5292.5765938725, 5298.788048478056, 4440.822367105328, 5075.264086707407, 5280.603954703393, 5304.787808487656, 5335.839924802262, 5044.899102017976, 5191.792328306901, 5247.291615631879, 5259.237410575445, 5322.973385133088, 5644.096944488903, 5651.7739290428335, 5695.743691533891, 5730.08318669011, 5739.368669446358, 6213.316535181127, 6293.779717709858, 6302.590331628429, 6304.0, 6331.588446750947, 6223.190985171944, 6228.159198508234, 6297.4962003039645, 6313.400226978476, 6320.925442674757, 5912.054071348563, 5935.080062590306, 5953.791617293374, 5956.761729530814, 5964.493018093423, 6243.282022567463, 6271.529635277372, 6327.525435592349, 6345.587536810185, 6349.809505714836, 6247.5939063960695, 6273.592216505913, 6285.622862628257, 6289.308176100625, 6305.716242769086, 6203.7828675996125, 6256.624602523863, 6264.436200741955, 6276.9372306276355, 6312.7790527332245, 5282.524572788468, 6222.471089957405, 6226.034964580497, 6260.154879091356, 6317.052442133717, 6309.495240380758, 6315.684215789284, 6330.430261276507, 6332.0818481320875, 6353.174087368612, 4908.631852611068, 4924.4090709115135, 4927.457979622239, 4932.334134891816, 4954.628402869799, 4418.33724941255, 4452.977735111303, 4471.0, 4520.321951707205, 4528.592426681615, 5822.1266809978, 5843.620164689281, 5845.41545845412, 5848.883022339614, 5855.912161317584, 6195.380461953859, 6258.593191442542, 6282.748690052346, 6284.340144284784, 6308.905366419507, 5706.201131841545, 5834.3290521589715, 5835.2414186156375, 5902.026165682614, 5940.495057920125, 5423.945760542344, 5424.376196737347, 5428.5928555358505, 5437.075697131497, 5437.918431223456, 6414.069959855795, 6464.385883341075, 6468.676566171673, 6470.935290647128, 6502.642354670538, 6214.25428948529, 6219.440250377488, 6275.246970363585, 6363.96818015907, 6446.838829029124, 6404.135441715309, 6424.293327734039, 6430.935690643221, 6445.774397896051, 6485.708143133476, 5115.846524604268, 6146.477549408171, 6284.497240220863, 6289.779857704958, 6347.365263473615, 6138.048602466625, 6193.84515387119, 6242.344553821965, 6280.811575652738, 6285.371462853678, 6173.59871608344, 6210.906836397548, 6214.0, 6231.22109736283, 6239.500839932885, 5998.520118390431, 6115.453310713017, 6200.472959798468, 6224.253089629274, 6229.314775374614, 6095.024796032613, 6097.847553811191, 6104.11490333908, 6118.0, 6140.969295153495, 6208.782692605737, 6251.937480625317, 6269.0, 6270.2475702915945, 6275.592086514362, 5994.970025150021, 6087.05650624154, 6114.969425152845, 6117.571769976059, 6145.262568491809], "unit": "score", "name": "dojo.html", "value": 5757.349862987501}, {"lowerIsBetter": false, "replicates": [503.35067762586266, 593.2762030323005, 594.1948659566287, 664.3093327481561, 668.4692055193607, 31351.0, 31661.52507712383, 41676.37485437717, 41697.7915110424, 41767.79116104423, 45417.0, 45952.0, 45993.0, 46038.8490287743, 46056.0, 9510.809783804338, 9839.163671087967, 9843.557039933221, 9849.0, 9850.261230407748, 8228.341732661404, 9782.413055216673, 9782.413055216673, 9802.313838031341, 9877.160441362494, 9869.062439068277, 9879.506024698772, 9946.154576860976, 9961.60153593859, 9988.300818942676, 9875.012498750104, 9918.3553069051, 9922.255830812717, 9927.106560409598, 9931.404115753006, 9882.160016398615, 9957.701268961942, 9963.0, 9976.451295178835, 9998.45008524531, 43135.0, 43504.56495435069, 43504.782476087734, 43648.56351436477, 43704.781476092736, 3221.548983142362, 3236.304194598149, 3400.1329660936303, 3482.8084455354947, 3715.442683597455, 30250.54624180639, 30361.785528578832, 30591.847040764875, 30718.692813071808, 30821.92123275697, 2717.633119528858, 2771.76440002598, 2811.6063751074867, 2830.9292267693268, 2851.657801063865, 504338.0, 509979.0, 510860.0, 510991.0, 512539.0, 73362.26637733555, 73690.63154684192, 73766.0, 73773.63113184508, 73823.63088184525, 77941.0, 78665.0, 81684.59157704173, 81910.59044704738, 82175.5891220552, 18540.980246086594, 18579.628407432047, 18793.872367657983, 18801.05994700287, 18803.0, 11772.17594768358, 13793.931030344784, 14056.508022219377, 14158.50445234412, 14164.787528187086, 23546.411339716302, 23586.0, 23712.814359281965, 23763.81180940946, 23780.524389512113, 9669.178119859891, 9906.80186396268, 9917.851232231522, 9919.256055795844, 9930.751731206634, 964.9517524123765, 993.2997236947934, 1004.8593196952432, 1035.8549803027581, 1050.6270274052754, 25342.366440839127, 25544.616830747553, 30647.846760766053, 30716.232094197378, 31363.609094726755, 941.6468824190929, 1151.7696460707891, 1181.527389044389, 1202.9879701202876, 1228.42264135856, 15532.689346213012, 15759.369625214864, 15809.0, 16144.609631977417, 16217.35130594763, 555572.0, 561280.0, 562716.0, 563416.1829190828, 563591.0, 64494.0, 64947.0, 64977.0, 65171.0, 65271.67364163149, 1407.3948202272916, 1427.4789701758991, 1522.87055600273, 1527.2821773766311, 1562.3672412672659, 28139.0, 30034.49482577631, 32107.357852842346, 32698.0, 33050.18223997607, 61306.69346653238, 61748.0, 62581.0, 62586.0, 62592.0, 496498.0, 499039.0384384729, 501080.0, 501426.0, 501575.0, 39399.40900886431, 47255.0, 47563.0, 47736.52263477321, 48114.0, 38190.045248867886, 45854.77072614749, 45950.54049459596, 46057.76971115123, 47500.57498275057, 36820.81589592035, 37399.06502337354, 38213.61786382212, 38373.808130959165, 39143.21713565656, 30633.846830765702, 37712.62287377201, 37813.81093094517, 37887.62112378841, 38559.6144038556, 32842.83578582092, 39171.80414097911, 39509.80245098871, 40258.0, 40389.0, 28222.85888570544, 33885.3222935535, 34749.82625086858, 35360.469592956644, 35362.292754144255, 26370.07704730402, 26411.207663770118, 26433.603495947962, 26642.600360994213, 26658.866705666347], "unit": "score", "name": "ext.html", "value": 21227.59001356576}, {"lowerIsBetter": false, "replicates": [379.7246995927953, 387.0575149510943, 389.79146156806104, 390.18451436497713, 392.5446482080787, 16604.335826566952, 16830.915845420757, 19874.0, 20959.371218863438, 21396.89301553492, 17180.570485737862, 20158.790472571654, 20613.381598552067, 20648.896755516238, 21754.912254387258, 5180.378354597454, 5847.619904706191, 6057.818265452043, 6125.938740612603, 6131.662758548278, 5928.970355148218, 6014.789482368118, 6061.969690151543, 6092.055731361646, 6151.292601350835, 6019.367966363513, 6082.513398928075, 6090.421409966046, 6108.786192483264, 6111.694415279218, 5876.559258055663, 6068.846919085382, 6117.143599896018, 6125.754969801203, 6130.295016073164, 5829.504492118175, 5842.0, 5848.0, 5849.473547380756, 5859.8535036624, 14430.278486075655, 18488.72266915997, 20507.077181526867, 22156.88921555382, 26650.200493985212, 2160.1899287767087, 2312.9653055204185, 2348.213348528245, 2390.0200917623692, 2666.520026395248, 8570.48577085377, 9913.405195688281, 10017.549210285555, 10295.124914382286, 10558.630447934362, 1619.9190040497929, 1635.8200597934217, 1769.9380521681808, 1787.2046939112101, 1802.3241284518306, 102639.0, 113209.43395283053, 113236.0, 116163.0, 116709.8329016716, 11900.226485278428, 11966.222195557435, 11969.581064662869, 12005.219660722025, 12034.097442691833, 12058.879411205775, 14701.191434471206, 14703.632409189855, 14724.55826325212, 14765.33555989983, 7418.703251869865, 9105.361035013628, 9164.266858651425, 9241.861372079424, 9260.0, 9371.437713737198, 9418.905810941802, 9421.0, 9478.57346419399, 9495.525223738785, 4669.649776266726, 4675.976620116878, 4677.22825733757, 4678.274867395559, 4713.34013238147, 1679.378629906918, 1914.9904250478658, 1959.2163134746215, 1971.044043638834, 1994.4914046918234, 902.8149229407956, 923.5474617437408, 1045.696747943088, 1088.7278180454887, 1122.1303489795473, 20563.691544626843, 21261.893690531757, 21502.677459838116, 21605.135794568356, 21724.674129888066, 1004.4224570871778, 1015.6851376073441, 1024.2522958240527, 1077.1705786544317, 1140.3670962615827, 11155.609553665583, 11565.190436669352, 11630.185886987998, 11638.70903227426, 11655.184137110491, 651170.0, 657273.0, 657366.0, 664343.0, 673154.0, 72889.6355518219, 110804.0, 110936.0, 124563.37718311531, 132302.0, 1047.0681093826502, 1051.6687243518268, 1067.5516283161091, 1068.2842495528014, 1075.7418219627389, 19479.90260048691, 19601.31395401154, 19748.90125549363, 19790.307339243056, 19818.0, 54667.45332546624, 54727.17909231285, 54959.72520137374, 56061.0, 56828.431715682316, 72883.0, 73706.63146684233, 77389.83915241389, 79707.20292796998, 81614.18385816303, 8081.191880811872, 8301.128381519853, 8322.750317490485, 8397.874031889405, 8716.0, 9836.557354918903, 13434.596962091153, 13811.654708632364, 14032.64918377008, 14224.786628200793, 11820.0, 11990.760184796429, 12057.457414416547, 12078.758424831278, 12192.57325993586, 11697.2981621103, 11710.882891170979, 11890.583829565923, 11978.820317695066, 12141.575044873387, 12042.63872083839, 12047.156699030984, 12106.213096149075, 12303.323317217639, 12504.312262825268, 8378.24595786382, 8523.360747943805, 8548.059713431641, 8616.698415555426, 8758.255548278468, 9056.773580660536, 12049.879501204876, 12056.819147712968, 12221.75556488883, 12340.382980850742], "unit": "score", "name": "jquery.html", "value": 9771.086670665056}, {"lowerIsBetter": false, "replicates": [1491.5301679970814, 1632.355219688223, 1661.0531996761847, 2004.7494063242095, 2089.9895500522503, 8420.494770313779, 9153.31350148739, 9330.393524420908, 9342.859857102141, 9367.437953722765, 9009.369344145913, 9061.32040096992, 9151.816963660724, 9176.17414432701, 9195.310351723614, 2277.2598905355744, 2516.7860731837814, 2568.4477837264985, 2598.6491823603856, 2601.4406902515957, 2575.214559559334, 2580.213035024326, 2586.5602847515966, 2587.4954383895056, 2590.922272331833, 2502.174282486775, 2546.2234018624404, 2576.046862660818, 2576.4847030593864, 2585.935351616215, 2525.229804909502, 2564.397366618843, 2575.7166711661794, 2594.779443747284, 2596.039465397796, 2553.0, 2576.6263891735593, 2594.0, 2596.07839217079, 2599.4411201591747, 9285.257179425696, 9367.625294988193, 9385.624575016991, 9397.483138427384, 9406.529673516297, 5703.344115426696, 5931.614445061057, 5931.881362372728, 5935.465808077251, 5940.168376427304, 3710.7402481826284, 3804.1060350817534, 3855.9421608675893, 3868.4390763339156, 3882.4758657581147, 1043.982117435502, 1058.359692386103, 1058.4760543530924, 1065.5471424644572, 1098.8791232964447, 12715.427805748672, 12720.236785792882, 12743.553975610808, 12781.360931953364, 12814.038947079007, 5131.153359695609, 5146.845594632167, 5202.4277329493725, 5210.505002024802, 5261.13191323435, 10838.132949364031, 10845.728856778485, 10854.185936054828, 10869.076128529005, 10884.07485363753, 5802.042662960649, 5859.560532960045, 5865.237519122486, 5872.324682661463, 5875.706214689334, 4645.605123564467, 4811.422629284439, 4987.152184128707, 5154.768035438415, 5270.631055826056, 4060.796960151981, 4118.423420721101, 4125.257453658311, 4152.418661387408, 4174.248635245685, 1349.3927732520406, 1351.4459071780523, 1353.8781509664177, 1354.850966393696, 1366.3851266929921, 1417.6030711400824, 1439.2659743530664, 1449.311577000916, 1467.9045862018934, 1474.2039298778755, 8592.140785921483, 8606.526641034803, 8653.307735381155, 8662.220400164015, 8664.393492455467, 527.3671594087111, 539.919012148181, 544.0506316477772, 546.1698218707543, 547.0945585056737, 6345.619262844244, 6390.488760899117, 6402.0, 6427.100205971168, 6429.22849258092, 10923.890761092447, 11291.096712262999, 11437.828432573519, 11454.713632159095, 11469.369184694755, 10407.791844163074, 10753.978372054642, 11056.889431105747, 11267.0, 11303.434828258554, 8617.61220745068, 8722.040575536686, 8836.381453298336, 8849.99999999987, 8862.0251772305, 7619.69521219145, 8060.435769496079, 8477.915220847712, 8524.318054555497, 8623.482591044558, 9967.750806229902, 10067.395956242648, 10070.647527336509, 10192.0, 10261.84607230907, 10219.795604087727, 10636.468176590985, 10644.574217031543, 10873.945630271797, 10908.34549927007, 7130.180029296697, 7328.560286382834, 7529.171791103084, 7569.659365328684, 7816.53100813953, 8617.95691021541, 8627.6980305689, 8652.09153038947, 8657.610407531802, 8660.740177794676, 7483.289087536676, 7614.695412183451, 7677.61611919413, 7685.423593230642, 7732.690692372467, 6243.719032643451, 7401.185869554237, 7433.1823499416105, 7466.664000120117, 7603.88594171099, 8045.356371490149, 8150.75547733569, 8196.54918979462, 8209.343252539902, 8209.71266005687, 7354.926450735638, 7407.666655000646, 7411.8147046324275, 7416.295451932057, 7474.701011959461, 6318.304986451579, 7509.774706758806, 7541.35898448638, 7542.396608271215, 7560.017197764256], "unit": "score", "name": "mootools.html", "value": 5093.895583090208}, {"lowerIsBetter": false, "replicates": [284.6370877131657, 342.3973806101261, 345.8875865343764, 346.0949616752194, 349.7831344566369, 6518.967405162974, 6604.174478190226, 6605.735770569184, 6634.436072933794, 6647.268800431949, 4939.481354457784, 6367.33143019982, 6536.444402225805, 6584.67076646167, 6587.3412658734105, 4636.698614590057, 4724.976375118137, 4799.064182484417, 4870.586000189979, 4889.437714662824, 4853.441854186761, 4856.271559266121, 4890.8043678252825, 4892.217245240762, 4892.877678058041, 4835.782389792468, 4839.27410888366, 4839.854804355875, 4841.24960631101, 4852.344933433994, 4606.516315786845, 4627.768611569425, 4799.208130658437, 4801.255805350176, 4827.85516434504, 4142.937855932163, 4145.0880806222585, 4156.044109854751, 4158.168366326717, 4162.229987452331, 6276.152719382916, 6289.056641503766, 6296.370362963667, 6299.5275354348605, 6317.368263173692, 5727.856803579903, 5746.454086861741, 5753.223314852483, 5756.309242890838, 5778.855528611776, 6759.493038022168, 7011.544249623758, 7020.684069216846, 7031.226565077837, 7033.683484243222, 4695.248760198352, 4727.881802954919, 4737.692050016738, 4742.027884283713, 4746.5490778376, 7365.631718414058, 7407.592582407965, 7411.740589079411, 7416.479621677543, 7428.777136685854, 3960.861369852099, 4800.375951126401, 4804.711717296974, 4805.3512775775525, 4806.759662016885, 4863.197572400585, 4877.561019508261, 4878.707277563358, 4892.51074892515, 4896.926546101811, 5728.427157284238, 5737.397573254748, 5746.913796293059, 5747.4252574742195, 5757.453041961007, 6799.762008329685, 7113.679884405215, 7119.974011045285, 7125.2874712529365, 7139.607321597362, 1634.9427770027992, 1667.9749803752954, 1669.1570756767755, 1669.8330166983205, 1670.941517046922, 997.835357166074, 1031.6698656430021, 1050.9106725928382, 1061.601899287767, 1085.5440714899762, 5179.559737422362, 6351.777687780906, 6361.681915904186, 6440.516961227833, 6605.372489613479, 7358.816029599303, 7379.741709040158, 7385.7045718170675, 7387.150477695134, 7415.666295016737, 6533.020046992894, 6533.607983521004, 6548.8035358939305, 6557.639329836905, 6566.047923051131, 3849.8845034649007, 3896.7077469189358, 3898.5516665583255, 3898.90252743678, 3907.8241479133508, 6799.558028728117, 7205.387542058984, 7403.22266162056, 7716.2669546393, 7737.264959828807, 7544.735934242385, 7583.582902940391, 7593.810154746065, 7603.9619801900635, 7619.352355049772, 7677.27065928747, 7681.654325555363, 7683.308502234826, 7684.9615751922, 7691.615419229128, 5963.701814909324, 7131.572105673677, 7374.520656157332, 7389.630518474162, 7397.778066658009, 6188.0, 7234.131904171533, 7256.2018178001435, 7264.418846492374, 7281.672324745293, 6933.687984040831, 7660.0, 7678.001859758196, 7678.692852285846, 7683.769486915401, 4630.814767409266, 4685.835995740133, 4692.0, 4706.341112244357, 4719.339292499121, 5916.467517923407, 7058.25888281723, 7314.853702926018, 7333.706651733871, 7334.4132469403385, 5714.5999780015, 7026.543274687129, 7073.398761105158, 7096.8935465967015, 7115.644217789193, 7035.296470353129, 7080.8937865933085, 7081.468889833386, 7088.589879441015, 7097.716091356495, 6893.241743408322, 6904.516683832285, 6907.447404207752, 6908.689108990007, 6930.480213984072, 6836.658167091526, 7096.503244772816, 7100.857982840417, 7102.786916392516, 7105.538140020882, 6581.440577550962, 6705.664716764045, 6811.114555107804, 6959.58242505431, 7005.964970175117], "unit": "score", "name": "prototype.html", "value": 5149.648940891504}, {"lowerIsBetter": false, "replicates": [705.8941158826177, 738.7635956493922, 782.3467404717057, 793.4445887878486, 799.9040115186178, 15489.225538723062, 15700.528984130466, 15701.92149039256, 15707.371705131782, 15741.685166296667, 16394.426195083175, 16767.24547395367, 16810.32758689651, 16847.241874115665, 16859.0, 804.264098350012, 813.9064007639108, 981.249344251648, 989.4063561862861, 1013.2350075692841, 987.7728122531822, 991.0733464210949, 993.9552720127575, 995.1292618958412, 995.3182070281844, 1060.9151267898549, 1062.6705721226444, 1066.8879767624403, 1066.9946650266777, 1067.2955849139569, 817.6034623207739, 850.7617866997251, 863.3567991846115, 1031.7730099378125, 1056.9947150264238, 783.0094929913664, 784.247122762149, 784.6037750935798, 785.9410544209208, 788.7081779741475, 15793.684126317525, 15839.208039597974, 15855.0, 15867.841321586868, 15876.12681302528, 13288.402021909038, 13305.40125694346, 13422.463101475929, 13519.86480135196, 13582.320883955861, 10082.747931301776, 10362.63730769427, 10492.580296788119, 10559.102476289525, 10714.892851071467, 3607.927841443183, 3651.1784848408897, 3657.65252301031, 3660.2130541933348, 3677.3196958562753, 90405.31554817848, 90881.09118908792, 91452.54273728655, 92412.0, 92888.0, 9837.016298370248, 9977.950110249401, 10069.446180459998, 10096.798064038678, 11285.153613479022, 19788.307409240897, 24273.150439734523, 24331.0, 24344.0, 24413.877930610233, 7556.65995030225, 7583.165851756413, 7636.50362726421, 7671.769846904602, 7876.921230787733, 4132.504099508018, 4138.91722165561, 4190.685698572619, 4199.181159673834, 4281.743095414286, 3756.0, 3805.37211360128, 3814.237152569497, 3815.008097894512, 3818.885433437001, 648.1217949678212, 659.7525927777084, 661.5237029338869, 670.2125003121313, 684.2917580304461, 540.351578106274, 586.3960121075299, 589.3723184808166, 606.9757209711562, 640.6604499615212, 8138.959305203436, 8519.74440766778, 8586.09845966177, 8614.095519970313, 8678.349123815613, 530.1755769777956, 596.9373215812363, 611.5963464113663, 618.9597676151126, 620.7889317632026, 3922.9607703922597, 3970.9205815884097, 3979.5025621797276, 4000.0399904023407, 4089.8159582818844, 93144.53427732817, 93978.53010734903, 94217.528912355, 94946.0, 103883.48058259812, 85860.57069714737, 86457.13542864617, 86710.0, 87217.0, 88874.0, 69900.0, 73790.89313660192, 73821.0, 74329.6283518579, 74418.0, 7549.50928189666, 7873.976383070393, 7914.881276780968, 8010.279074883056, 8021.639026243716, 53159.936801262986, 53194.202086967955, 53915.921681566935, 54040.48736832093, 55327.0, 69753.0, 71648.64175679088, 71917.28082719106, 72440.0, 73245.0, 10311.020453056948, 10380.948095259475, 10558.996895294935, 10822.783544329226, 10890.836637450286, 10652.520636571528, 10919.39943303126, 10977.725556861142, 11117.284073096895, 11267.887321126684, 10447.68656940293, 10591.258611897094, 10609.363438193424, 10737.463126843782, 10880.238383313408, 10461.05850473461, 10516.263861529926, 10552.577896884039, 10652.946735266583, 10867.456627168767, 10282.177425806067, 10364.948175259075, 10506.369617822955, 10660.307080039773, 10931.6720498382, 8925.553722313989, 9038.0, 9091.181793638605, 9289.814203715752, 9398.389104708172, 8798.780030499289, 8909.109089091038, 9011.594478248626, 9069.909300906906, 9144.817103658022], "unit": "score", "name": "yui.html", "value": 7135.241370103037}], "name": "dromaeo_css", "value": 7790.3410077552835}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 111.0, 111.0, 115.0, 158.0, 145.0, 117.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 120.0}, {"lowerIsBetter": true, "replicates": [176.0, 157.0, 143.0, 187.0, 153.0, 139.0, 117.0, 153.0, 146.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [182.0, 184.0, 198.0, 262.0, 207.0, 188.0, 184.0, 185.0, 186.0, 186.0], "unit": "score", "name": "audio-dft", "value": 196.2}, {"lowerIsBetter": true, "replicates": [75.0, 78.0, 73.0, 121.0, 55.0, 56.0, 57.0, 60.0, 117.0, 56.0], "unit": "score", "name": "audio-fft", "value": 74.8}, {"lowerIsBetter": true, "replicates": [93.0, 96.0, 128.0, 81.0, 78.0, 90.0, 115.0, 76.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 95.3}, {"lowerIsBetter": true, "replicates": [135.0, 131.0, 87.0, 84.0, 87.0, 83.0, 88.0, 83.0, 87.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.8}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 91.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 91.9}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 85.0, 84.0, 85.0, 87.0, 84.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.0}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 57.0, 56.0, 57.0, 57.0, 59.0, 69.0, 51.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 71.0, 78.0, 69.0, 69.0, 64.0, 71.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 82.0, 80.0, 80.0, 77.0, 79.0, 74.0, 80.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 120.0, 126.0, 115.0, 116.0, 120.0, 115.0, 129.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [134.0, 121.0, 131.0, 132.0, 132.0, 165.0, 167.0, 167.0, 132.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.1}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1437.8999999999996}]} 04:26:43 INFO - Return code: 0 04:26:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:26:43 INFO - # TBPL SUCCESS # 04:26:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:26:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:26:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:26:43 INFO - 2016-03-10 04:26:43.932 screenresolution[1973:20372] starting screenresolution argv=screenresolution get 04:26:43 INFO - 2016-03-10 04:26:43.934 screenresolution[1973:20372] Display 0: 1600x1200x32@60 04:26:43 INFO - 2016-03-10 04:26:43.941 screenresolution[1974:20375] starting screenresolution argv=screenresolution list 04:26:43 INFO - Available Modes on Display 0 04:26:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:26:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:26:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:26:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:26:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:26:44 INFO - Intel Iris: 04:26:44 INFO - Chipset Model: Intel Iris 04:26:44 INFO - Type: GPU 04:26:44 INFO - Bus: Built-In 04:26:44 INFO - VRAM (Dynamic, Max): 1536 MB 04:26:44 INFO - Vendor: Intel (0x8086) 04:26:44 INFO - Device ID: 0x0a2e 04:26:44 INFO - Revision ID: 0x0009 04:26:44 INFO - Displays: 04:26:44 INFO - Display: 04:26:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:26:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:26:44 INFO - Display Serial Number: 1600x1200 60 04:26:44 INFO - Main Display: Yes 04:26:44 INFO - Mirror: Off 04:26:44 INFO - Online: Yes 04:26:44 INFO - Rotation: Supported 04:26:44 INFO - Return code: 0 04:26:44 INFO - Running post-action listener: _resource_record_post_action 04:26:44 INFO - Running post-run listener: _resource_record_post_run 04:26:45 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 262144; Write bytes: 662394368; Read time: 7; Write time: 2136 04:26:45 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361357824; Write bytes: 362873344; Read time: 28237; Write time: 676 04:26:45 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 262144; Write bytes: 298230784; Read time: 7; Write time: 1456 04:26:45 INFO - Running post-run listener: _upload_blobber_files 04:26:45 INFO - Blob upload gear active. 04:26:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:45 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 04:26:45 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:26:45 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:26:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:26:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:26:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:46 INFO - (blobuploader) - INFO - Done attempting. 04:26:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:26:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:26:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:47 INFO - (blobuploader) - INFO - Done attempting. 04:26:47 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:47 INFO - Return code: 0 04:26:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0528a1c53ef0e7aa079122d5ae608536bc532e2fa481222585c6208ff932bbf8670c796a5b989643a3b8b37fabbb1589ab90b920bacb5a12754b230ec68f7c52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f21d0f2b016f79e48cd86b221c211db5865e97a906f95d301b963d2ac77eedfa0c063a1849b5e2ec6f9d7c7e9d03057cf33493348892da05ba33c59a823cb24c"} 04:26:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:47 INFO - Contents: 04:26:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0528a1c53ef0e7aa079122d5ae608536bc532e2fa481222585c6208ff932bbf8670c796a5b989643a3b8b37fabbb1589ab90b920bacb5a12754b230ec68f7c52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f21d0f2b016f79e48cd86b221c211db5865e97a906f95d301b963d2ac77eedfa0c063a1849b5e2ec6f9d7c7e9d03057cf33493348892da05ba33c59a823cb24c"} 04:26:47 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:47 INFO - Copying logs to upload dir... 04:26:47 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.105992 ========= master_lag: 2.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-10 04:26:50.505372) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 04:26:50.509611) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50ji0pVydZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0528a1c53ef0e7aa079122d5ae608536bc532e2fa481222585c6208ff932bbf8670c796a5b989643a3b8b37fabbb1589ab90b920bacb5a12754b230ec68f7c52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f21d0f2b016f79e48cd86b221c211db5865e97a906f95d301b963d2ac77eedfa0c063a1849b5e2ec6f9d7c7e9d03057cf33493348892da05ba33c59a823cb24c"} build_url:https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011661 build_url: 'https://queue.taskcluster.net/v1/task/RZe3kmHmS-6LsiCzSe4fMA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0528a1c53ef0e7aa079122d5ae608536bc532e2fa481222585c6208ff932bbf8670c796a5b989643a3b8b37fabbb1589ab90b920bacb5a12754b230ec68f7c52", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f21d0f2b016f79e48cd86b221c211db5865e97a906f95d301b963d2ac77eedfa0c063a1849b5e2ec6f9d7c7e9d03057cf33493348892da05ba33c59a823cb24c"}' ========= master_lag: 0.39 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-10 04:26:50.912267) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 04:26:50.912658) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.50ji0pVydZ/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.ForucvuQ1Z/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004785 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-10 04:26:50.974967) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-10 04:26:50.975282) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-03-10 04:26:55.077367) ========= ========= Total master_lag: 3.42 =========