builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0053 starttime: 1458994432.74 results: success (0) buildid: 20160326030430 builduid: e71aebb474d24e9f8020819b46b1cbf5 revision: 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:52.741127) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:52.741643) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:52.742491) ========= 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.fMCqA1MayX/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.rg8iyV8cK8/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005484 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:52.827424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:52.827738) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:53.120727) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:53.121111) ========= 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.fMCqA1MayX/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.rg8iyV8cK8/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005279 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:53.209335) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:53.209636) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:53.210033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:53.210343) ========= 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.fMCqA1MayX/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.rg8iyV8cK8/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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-26 05:13:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 170M=0s 2016-03-26 05:13:53 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.469689 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:53.708340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:53.708657) ========= 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.fMCqA1MayX/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.rg8iyV8cK8/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.024791 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:53.757035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-26 05:13:53.757432) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fMCqA1MayX/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.rg8iyV8cK8/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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-26 05:13:53,827 truncating revision to first 12 chars 2016-03-26 05:13:53,827 Setting DEBUG logging. 2016-03-26 05:13:53,827 attempt 1/10 2016-03-26 05:13:53,827 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a4359ad909f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-26 05:13:55,179 unpacking tar archive at: mozilla-central-8a4359ad909f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.040006 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-26 05:13:55.814469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:55.814880) ========= echo 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8a4359ad909fe0cffcfea512770483ffdf8cd4e6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fMCqA1MayX/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.rg8iyV8cK8/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 program finished with exit code 0 elapsedTime=0.005454 script_repo_revision: '8a4359ad909fe0cffcfea512770483ffdf8cd4e6' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:55.866498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:55.866819) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-26 05:13:55.884709) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-26 05:13:55.885045) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fMCqA1MayX/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.rg8iyV8cK8/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:13:56 INFO - MultiFileLogger online at 20160326 05:13:56 in /builds/slave/test 05:13:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:13:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:13:56 INFO - {'append_to_log': False, 05:13:56 INFO - 'base_work_dir': '/builds/slave/test', 05:13:56 INFO - 'blob_upload_branch': 'Firefox', 05:13:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:13:56 INFO - 'branch': 'Firefox', 05:13:56 INFO - 'buildbot_json_path': 'buildprops.json', 05:13:56 INFO - 'config_files': ('talos/mac_config.py',), 05:13:56 INFO - 'default_actions': ('clobber', 05:13:56 INFO - 'read-buildbot-config', 05:13:56 INFO - 'download-and-extract', 05:13:56 INFO - 'populate-webroot', 05:13:56 INFO - 'create-virtualenv', 05:13:56 INFO - 'install', 05:13:56 INFO - 'run-tests'), 05:13:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:13:56 INFO - 'download_minidump_stackwalk': True, 05:13:56 INFO - 'download_symbols': 'ondemand', 05:13:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:13:56 INFO - 'tooltool.py': '/tools/tooltool.py', 05:13:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:13:56 INFO - '/tools/misc-python/virtualenv.py')}, 05:13:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:13:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:13:56 INFO - 'installer_path': 'installer.exe', 05:13:56 INFO - 'log_level': 'info', 05:13:56 INFO - 'log_name': 'talos', 05:13:56 INFO - 'log_to_console': True, 05:13:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:13:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:13:56 INFO - 'opt_config_files': (), 05:13:56 INFO - 'pip_index': False, 05:13:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:13:56 INFO - 'cmd': ('bash', 05:13:56 INFO - '-c', 05:13:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:13:56 INFO - 'enabled': True, 05:13:56 INFO - 'halt_on_failure': False, 05:13:56 INFO - 'name': 'check_screen_resolution'},), 05:13:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:13:56 INFO - 'cmd': ('bash', 05:13:56 INFO - '-c', 05:13:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:13:56 INFO - 'enabled': True, 05:13:56 INFO - 'halt_on_failure': False, 05:13:56 INFO - 'name': 'check_screen_resolution'},), 05:13:56 INFO - 'run_cmd_checks_enabled': True, 05:13:56 INFO - 'sps_profile': False, 05:13:56 INFO - 'sps_profile_interval': 0, 05:13:56 INFO - 'suite': 'dromaeojs', 05:13:56 INFO - 'system_bits': '32', 05:13:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:13:56 INFO - 'title': 't-yosemite-r7-0053', 05:13:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:13:56 INFO - 'use_talos_json': True, 05:13:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:13:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:13:56 INFO - 'work_dir': 'build'} 05:13:56 INFO - ##### 05:13:56 INFO - ##### Running clobber step. 05:13:56 INFO - ##### 05:13:56 INFO - Running pre-action listener: _resource_record_pre_action 05:13:56 INFO - Running main action method: clobber 05:13:56 INFO - rmtree: /builds/slave/test/build 05:13:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:13:57 INFO - Running post-action listener: _resource_record_post_action 05:13:57 INFO - ##### 05:13:57 INFO - ##### Running read-buildbot-config step. 05:13:57 INFO - ##### 05:13:57 INFO - Running pre-action listener: _resource_record_pre_action 05:13:57 INFO - Running main action method: read_buildbot_config 05:13:57 INFO - Using buildbot properties: 05:13:57 INFO - { 05:13:57 INFO - "project": "", 05:13:57 INFO - "product": "firefox", 05:13:57 INFO - "script_repo_revision": "production", 05:13:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:13:57 INFO - "repository": "", 05:13:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:13:57 INFO - "buildid": "20160326030430", 05:13:57 INFO - "stage_platform": "macosx64", 05:13:57 INFO - "basedir": "/builds/slave/test", 05:13:57 INFO - "nightly_build": "True", 05:13:57 INFO - "buildnumber": 186, 05:13:57 INFO - "slavename": "t-yosemite-r7-0053", 05:13:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:13:57 INFO - "platform": "yosemite_r7", 05:13:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:13:57 INFO - "branch": "mozilla-central", 05:13:57 INFO - "repo_path": "mozilla-central", 05:13:57 INFO - "revision": "8a4359ad909fe0cffcfea512770483ffdf8cd4e6", 05:13:57 INFO - "pgo_build": "False", 05:13:57 INFO - "builduid": "e71aebb474d24e9f8020819b46b1cbf5", 05:13:57 INFO - "slavebuilddir": "test" 05:13:57 INFO - } 05:13:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:13:57 INFO - Running post-action listener: _resource_record_post_action 05:13:57 INFO - ##### 05:13:57 INFO - ##### Running download-and-extract step. 05:13:57 INFO - ##### 05:13:57 INFO - Running pre-action listener: _resource_record_pre_action 05:13:57 INFO - Running main action method: download_and_extract 05:13:57 INFO - mkdir: /builds/slave/test/build/tests 05:13:57 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')]} 05:13:57 INFO - https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:13:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:13:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:13:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:13:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:14:00 INFO - Downloaded 1199 bytes. 05:14:00 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:14:00 INFO - Using the following test package requirements: 05:14:00 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:14:00 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:00 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:14:00 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:00 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:14:00 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:00 INFO - u'jsshell-mac.zip'], 05:14:00 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:00 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:14:00 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:14:00 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:00 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:14:00 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:00 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:14:00 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:00 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:14:00 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:14:00 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:14:00 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:14:00 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')]} 05:14:00 INFO - https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:14:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:14:02 INFO - Downloaded 17943988 bytes. 05:14:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:14:05 INFO - Return code: 0 05:14:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:05 INFO - https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:14:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:14:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:14:08 INFO - Downloaded 17943988 bytes. 05:14:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:14:11 INFO - Return code: 0 05:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:11 INFO - https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:14:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:14:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:14:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:14:13 INFO - Downloaded 10847531 bytes. 05:14:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:14:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:14:14 INFO - Return code: 0 05:14: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')]} 05:14:14 INFO - https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:14:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:14:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:14:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:14:17 INFO - Downloaded 111525417 bytes. 05:14:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:14:17 INFO - mkdir: /builds/slave/test/properties 05:14:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:17 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:17 INFO - Contents: 05:14:17 INFO - build_url:https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:14:18 INFO - Running post-action listener: _resource_record_post_action 05:14:18 INFO - Running post-action listener: set_extra_try_arguments 05:14:18 INFO - ##### 05:14:18 INFO - ##### Running populate-webroot step. 05:14:18 INFO - ##### 05:14:18 INFO - Running pre-action listener: _resource_record_pre_action 05:14:18 INFO - Running main action method: populate_webroot 05:14:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:18 INFO - '--tppagecycles', 05:14:18 INFO - '7'], 05:14:18 INFO - 'tests': ['tsvgm']}}, 05:14:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:14:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:14:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:14:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:14:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:18 INFO - 'talos_options': ['--e10s'], 05:14:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:18 INFO - 'tests': ['damp', 'tps']}, 05:14:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:18 INFO - 'talos_options': ['--e10s'], 05:14:18 INFO - 'tests': ['damp', 'tps']}, 05:14:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:14:18 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 05:14:18 INFO - 'tests': ['dromaeo_dom']}, 05:14:18 INFO - 'other': {'tests': ['a11yr', 05:14:18 INFO - 'ts_paint', 05:14:18 INFO - 'tpaint', 05:14:18 INFO - 'sessionrestore', 05:14:18 INFO - 'sessionrestore_no_auto_restore', 05:14:18 INFO - 'tabpaint']}, 05:14:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:14:18 INFO - 'tests': ['a11yr', 05:14:18 INFO - 'ts_paint', 05:14:18 INFO - 'tpaint', 05:14:18 INFO - 'sessionrestore', 05:14:18 INFO - 'sessionrestore_no_auto_restore', 05:14:18 INFO - 'tabpaint']}, 05:14:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:14:18 INFO - 'tests': ['a11yr', 05:14:18 INFO - 'ts_paint', 05:14:18 INFO - 'tpaint', 05:14:18 INFO - 'sessionrestore', 05:14:18 INFO - 'sessionrestore_no_auto_restore', 05:14:18 INFO - 'tabpaint']}, 05:14:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:14:18 INFO - 'tests': ['a11yr', 05:14:18 INFO - 'ts_paint', 05:14:18 INFO - 'tpaint', 05:14:18 INFO - 'sessionrestore', 05:14:18 INFO - 'sessionrestore_no_auto_restore', 05:14:18 INFO - 'tabpaint']}, 05:14:18 INFO - 'other_l64': {'tests': ['a11yr', 05:14:18 INFO - 'ts_paint', 05:14:18 INFO - 'tpaint', 05:14:18 INFO - 'sessionrestore', 05:14:18 INFO - 'sessionrestore_no_auto_restore', 05:14:18 INFO - 'tabpaint']}, 05:14:18 INFO - 'other_nol64': {'tests': ['a11yr', 05:14:18 INFO - 'ts_paint', 05:14:18 INFO - 'tpaint', 05:14:18 INFO - 'sessionrestore', 05:14:18 INFO - 'sessionrestore_no_auto_restore', 05:14:18 INFO - 'tabpaint']}, 05:14:18 INFO - 'svgr': {'tests': ['tsvgx', 05:14:18 INFO - 'tsvgr_opacity', 05:14:18 INFO - 'tart', 05:14:18 INFO - 'tscrollx', 05:14:18 INFO - 'cart']}, 05:14:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:14:18 INFO - 'tests': ['tsvgx', 05:14:18 INFO - 'tsvgr_opacity', 05:14:18 INFO - 'tart', 05:14:18 INFO - 'tscrollx', 05:14:18 INFO - 'cart']}, 05:14:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:18 INFO - 'tests': ['tp5o']}, 05:14:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:18 INFO - 'talos_options': ['--e10s'], 05:14:18 INFO - 'tests': ['tp5o']}, 05:14:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:18 INFO - 'talos_options': ['--xperf_path', 05:14:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:18 INFO - 'tests': ['tp5n']}, 05:14:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:18 INFO - 'talos_options': ['--e10s', 05:14:18 INFO - '--xperf_path', 05:14:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:18 INFO - 'tests': ['tp5n']}}, 05:14:18 INFO - 'talos.zip': {'path': '', 05:14:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:18 INFO - Running post-action listener: _resource_record_post_action 05:14:18 INFO - ##### 05:14:18 INFO - ##### Running create-virtualenv step. 05:14:18 INFO - ##### 05:14:18 INFO - Running pre-action listener: _resource_record_pre_action 05:14:18 INFO - Running main action method: create_virtualenv 05:14:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:18 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 05:14:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:18 INFO - Using real prefix '/tools/python27' 05:14:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:19 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:22 INFO - Installing pip.................done. 05:14:22 INFO - Return code: 0 05:14:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14: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')]} 05:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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')]} 05:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:22 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 0x1063a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bbcbe4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106240e00>, '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 0x106069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623bb20>, '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.fMCqA1MayX/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.rg8iyV8cK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:14:22 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 05:14:22 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 05:14:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMCqA1MayX/Render', 05:14:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:22 INFO - 'HOME': '/Users/cltbld', 05:14:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:22 INFO - 'LOGNAME': 'cltbld', 05:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:22 INFO - 'MOZ_NO_REMOTE': '1', 05:14:22 INFO - 'NO_EM_RESTART': '1', 05:14:22 INFO - 'PAGER': '/bin/cat', 05:14:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:22 INFO - 'PWD': '/builds/slave/test', 05:14:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:22 INFO - 'SHELL': '/bin/bash', 05:14:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rg8iyV8cK8/Listeners', 05:14:22 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:14:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:22 INFO - 'USER': 'cltbld', 05:14:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:22 INFO - 'XPC_FLAGS': '0x0', 05:14:22 INFO - 'XPC_SERVICE_NAME': '0', 05:14:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:22 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 05:14:22 INFO - Cleaning up... 05:14:22 INFO - Return code: 0 05:14:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:14: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')]} 05:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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')]} 05:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:22 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 0x1063a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bbcbe4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106240e00>, '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 0x106069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623bb20>, '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.fMCqA1MayX/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.rg8iyV8cK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:14:22 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 05:14:22 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 05:14:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMCqA1MayX/Render', 05:14:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:22 INFO - 'HOME': '/Users/cltbld', 05:14:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:22 INFO - 'LOGNAME': 'cltbld', 05:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:22 INFO - 'MOZ_NO_REMOTE': '1', 05:14:22 INFO - 'NO_EM_RESTART': '1', 05:14:22 INFO - 'PAGER': '/bin/cat', 05:14:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:22 INFO - 'PWD': '/builds/slave/test', 05:14:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:22 INFO - 'SHELL': '/bin/bash', 05:14:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rg8iyV8cK8/Listeners', 05:14:22 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:14:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:22 INFO - 'USER': 'cltbld', 05:14:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:22 INFO - 'XPC_FLAGS': '0x0', 05:14:22 INFO - 'XPC_SERVICE_NAME': '0', 05:14:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:22 INFO - Downloading/unpacking psutil>=0.7.1 05:14:22 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 05:14:22 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 05:14:22 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 05:14:22 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 05:14:22 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 05:14:22 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 05:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:25 INFO - Installing collected packages: psutil 05:14:25 INFO - Running setup.py install for psutil 05:14:25 INFO - building 'psutil._psutil_osx' extension 05:14:25 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 05:14:26 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 05:14:26 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 05:14:26 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 05:14:26 INFO - building 'psutil._psutil_posix' extension 05:14:26 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 05:14:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:14:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:14:26 INFO - ^ 05:14:26 INFO - 1 warning generated. 05:14:26 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 05:14:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:27 INFO - Successfully installed psutil 05:14:27 INFO - Cleaning up... 05:14:27 INFO - Return code: 0 05:14:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:14:27 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')]} 05:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:27 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')]} 05:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:27 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 0x1063a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bbcbe4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106240e00>, '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 0x106069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623bb20>, '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.fMCqA1MayX/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.rg8iyV8cK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:14:27 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 05:14:27 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 05:14:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMCqA1MayX/Render', 05:14:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:27 INFO - 'HOME': '/Users/cltbld', 05:14:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:27 INFO - 'LOGNAME': 'cltbld', 05:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:27 INFO - 'MOZ_NO_REMOTE': '1', 05:14:27 INFO - 'NO_EM_RESTART': '1', 05:14:27 INFO - 'PAGER': '/bin/cat', 05:14:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:27 INFO - 'PWD': '/builds/slave/test', 05:14:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:27 INFO - 'SHELL': '/bin/bash', 05:14:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rg8iyV8cK8/Listeners', 05:14:27 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:14:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:27 INFO - 'USER': 'cltbld', 05:14:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:27 INFO - 'XPC_FLAGS': '0x0', 05:14:27 INFO - 'XPC_SERVICE_NAME': '0', 05:14:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:14:27 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 05:14:27 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 05:14:27 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 05:14:27 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 05:14:27 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 05:14:27 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 05:14:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:14:29 INFO - Installing collected packages: mozsystemmonitor 05:14:29 INFO - Running setup.py install for mozsystemmonitor 05:14:29 INFO - Successfully installed mozsystemmonitor 05:14:29 INFO - Cleaning up... 05:14:30 INFO - Return code: 0 05:14:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1063a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bbcbe4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106240e00>, '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 0x106069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623bb20>, '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.fMCqA1MayX/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.rg8iyV8cK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:14:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:14:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:14:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMCqA1MayX/Render', 05:14:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:30 INFO - 'HOME': '/Users/cltbld', 05:14:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:30 INFO - 'LOGNAME': 'cltbld', 05:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:30 INFO - 'MOZ_NO_REMOTE': '1', 05:14:30 INFO - 'NO_EM_RESTART': '1', 05:14:30 INFO - 'PAGER': '/bin/cat', 05:14:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:30 INFO - 'PWD': '/builds/slave/test', 05:14:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:30 INFO - 'SHELL': '/bin/bash', 05:14:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rg8iyV8cK8/Listeners', 05:14:30 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:14:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:30 INFO - 'USER': 'cltbld', 05:14:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:30 INFO - 'XPC_FLAGS': '0x0', 05:14:30 INFO - 'XPC_SERVICE_NAME': '0', 05:14:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:30 INFO - Downloading/unpacking blobuploader==1.2.4 05:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:32 INFO - Downloading blobuploader-1.2.4.tar.gz 05:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:14:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14: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 05:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:14:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:33 INFO - Downloading docopt-0.6.1.tar.gz 05:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:14:33 INFO - Installing collected packages: blobuploader, requests, docopt 05:14:33 INFO - Running setup.py install for blobuploader 05:14:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:14:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:14:34 INFO - Running setup.py install for requests 05:14:34 INFO - Running setup.py install for docopt 05:14:34 INFO - Successfully installed blobuploader requests docopt 05:14:34 INFO - Cleaning up... 05:14:34 INFO - Return code: 0 05:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:34 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')]} 05:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:34 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')]} 05:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:34 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 0x1063a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bbcbe4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106240e00>, '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 0x106069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623bb20>, '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.fMCqA1MayX/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.rg8iyV8cK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:14:34 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 05:14:34 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 05:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMCqA1MayX/Render', 05:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:34 INFO - 'HOME': '/Users/cltbld', 05:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:34 INFO - 'LOGNAME': 'cltbld', 05:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:34 INFO - 'MOZ_NO_REMOTE': '1', 05:14:34 INFO - 'NO_EM_RESTART': '1', 05:14:34 INFO - 'PAGER': '/bin/cat', 05:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:34 INFO - 'PWD': '/builds/slave/test', 05:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:34 INFO - 'SHELL': '/bin/bash', 05:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rg8iyV8cK8/Listeners', 05:14:34 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:34 INFO - 'USER': 'cltbld', 05:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:34 INFO - 'XPC_FLAGS': '0x0', 05:14:34 INFO - 'XPC_SERVICE_NAME': '0', 05:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-sKdrlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-7AiIvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-IxrZx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-G9FuSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-qSNlaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-EFctJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-xllAcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ChgARf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:35 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-s59Www-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-zdLCki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-fpFh2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-qADeyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-t_CNg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-YcmK7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-4uWqJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-plaDTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:36 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-n74hu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:14:36 INFO - Running setup.py install for manifestparser 05:14:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:14:37 INFO - Running setup.py install for mozcrash 05:14:37 INFO - Running setup.py install for mozdebug 05:14:37 INFO - Running setup.py install for mozdevice 05:14:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:14:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:14:37 INFO - Running setup.py install for mozfile 05:14:37 INFO - Running setup.py install for mozhttpd 05:14:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:14:37 INFO - Running setup.py install for mozinfo 05:14:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:14:37 INFO - Running setup.py install for mozInstall 05:14:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:14:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:14:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:14:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:14:38 INFO - Running setup.py install for mozleak 05:14:38 INFO - Running setup.py install for mozlog 05:14:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:14:38 INFO - Running setup.py install for moznetwork 05:14:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:14:38 INFO - Running setup.py install for mozprocess 05:14:38 INFO - Running setup.py install for mozprofile 05:14:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:14:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:14:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:14:38 INFO - Running setup.py install for mozrunner 05:14:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:14:38 INFO - Running setup.py install for mozscreenshot 05:14:39 INFO - Running setup.py install for moztest 05:14:39 INFO - Running setup.py install for mozversion 05:14:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:14:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:14:39 INFO - Cleaning up... 05:14:39 INFO - Return code: 0 05:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:39 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 0x1063a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bbcbe4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106240e00>, '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 0x106069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623bb20>, '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.fMCqA1MayX/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.rg8iyV8cK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:14:39 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 05:14:39 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 05:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMCqA1MayX/Render', 05:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:39 INFO - 'HOME': '/Users/cltbld', 05:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:39 INFO - 'LOGNAME': 'cltbld', 05:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:39 INFO - 'MOZ_NO_REMOTE': '1', 05:14:39 INFO - 'NO_EM_RESTART': '1', 05:14:39 INFO - 'PAGER': '/bin/cat', 05:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:39 INFO - 'PWD': '/builds/slave/test', 05:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:39 INFO - 'SHELL': '/bin/bash', 05:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rg8iyV8cK8/Listeners', 05:14:39 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:39 INFO - 'USER': 'cltbld', 05:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:39 INFO - 'XPC_FLAGS': '0x0', 05:14:39 INFO - 'XPC_SERVICE_NAME': '0', 05:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-S7UJba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:39 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)) 05:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-a1V0DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:39 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)) 05:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:39 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Nk9pqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:40 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)) 05:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:40 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ufFPSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:40 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)) 05:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:40 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-jcOnny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:40 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)) 05:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:40 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-vkV4uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:40 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)) 05:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:40 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-k4QrUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:40 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)) 05:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:40 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-5Ve_Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:40 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)) 05:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:40 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Kp77xL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:40 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)) 05:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:40 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-sj5iLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:40 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)) 05:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:40 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-PW3fTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:40 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)) 05:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:40 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-ij0UZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:40 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)) 05:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:40 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-qPwiaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:41 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)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:41 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-Isxyhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:41 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)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:41 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-6ChZOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:41 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)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:41 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-1O9R_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:41 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)) 05:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:41 INFO - Running setup.py (path:/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/pip-tbZ4BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:41 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)) 05:14:41 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)) 05:14:41 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)) 05:14:41 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)) 05:14:41 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)) 05:14:41 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)) 05:14:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:43 INFO - Downloading blessings-1.6.tar.gz 05:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:14:44 INFO - Installing collected packages: blessings 05:14:44 INFO - Running setup.py install for blessings 05:14:44 INFO - Successfully installed blessings 05:14:44 INFO - Cleaning up... 05:14:44 INFO - Return code: 0 05:14:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:44 INFO - Reading from file tmpfile_stdout 05:14:44 INFO - Current package versions: 05:14:44 INFO - blessings == 1.6 05:14:44 INFO - blobuploader == 1.2.4 05:14:44 INFO - docopt == 0.6.1 05:14:44 INFO - manifestparser == 1.1 05:14:44 INFO - mozInstall == 1.12 05:14:44 INFO - mozcrash == 0.17 05:14:44 INFO - mozdebug == 0.1 05:14:44 INFO - mozdevice == 0.48 05:14:44 INFO - mozfile == 1.2 05:14:44 INFO - mozhttpd == 0.7 05:14:44 INFO - mozinfo == 0.9 05:14:44 INFO - mozleak == 0.1 05:14:44 INFO - mozlog == 3.1 05:14:44 INFO - moznetwork == 0.27 05:14:44 INFO - mozprocess == 0.22 05:14:44 INFO - mozprofile == 0.28 05:14:44 INFO - mozrunner == 6.11 05:14:44 INFO - mozscreenshot == 0.1 05:14:44 INFO - mozsystemmonitor == 0.0 05:14:44 INFO - moztest == 0.7 05:14:44 INFO - mozversion == 1.4 05:14:44 INFO - psutil == 3.1.1 05:14:44 INFO - requests == 1.2.3 05:14:44 INFO - wsgiref == 0.1.2 05:14:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:44 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')]} 05:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 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')]} 05:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 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 0x1063a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bbcbe4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106240e00>, '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 0x106069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623bb20>, '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.fMCqA1MayX/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.rg8iyV8cK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:14:44 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 05:14:44 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 05:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMCqA1MayX/Render', 05:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:44 INFO - 'HOME': '/Users/cltbld', 05:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:44 INFO - 'LOGNAME': 'cltbld', 05:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:44 INFO - 'MOZ_NO_REMOTE': '1', 05:14:44 INFO - 'NO_EM_RESTART': '1', 05:14:44 INFO - 'PAGER': '/bin/cat', 05:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:44 INFO - 'PWD': '/builds/slave/test', 05:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:44 INFO - 'SHELL': '/bin/bash', 05:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rg8iyV8cK8/Listeners', 05:14:44 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:44 INFO - 'USER': 'cltbld', 05:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:44 INFO - 'XPC_FLAGS': '0x0', 05:14:44 INFO - 'XPC_SERVICE_NAME': '0', 05:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:44 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)) 05:14:44 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)) 05:14:44 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)) 05:14:44 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)) 05:14:44 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)) 05:14:44 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)) 05:14:44 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)) 05:14:44 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)) 05:14:44 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)) 05:14:44 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)) 05:14:44 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)) 05:14:44 INFO - Cleaning up... 05:14:44 INFO - Return code: 0 05:14:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:14:44 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')]} 05:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 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')]} 05:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 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 0x1063a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bbcbe4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106240e00>, '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 0x106069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623bb20>, '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.fMCqA1MayX/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.rg8iyV8cK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:14:44 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 05:14:44 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 05:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMCqA1MayX/Render', 05:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:44 INFO - 'HOME': '/Users/cltbld', 05:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:44 INFO - 'LOGNAME': 'cltbld', 05:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:44 INFO - 'MOZ_NO_REMOTE': '1', 05:14:44 INFO - 'NO_EM_RESTART': '1', 05:14:44 INFO - 'PAGER': '/bin/cat', 05:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:44 INFO - 'PWD': '/builds/slave/test', 05:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:44 INFO - 'SHELL': '/bin/bash', 05:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rg8iyV8cK8/Listeners', 05:14:44 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:44 INFO - 'USER': 'cltbld', 05:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:44 INFO - 'XPC_FLAGS': '0x0', 05:14:44 INFO - 'XPC_SERVICE_NAME': '0', 05:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:45 INFO - Downloading/unpacking jsonschema 05:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:14:47 INFO - Downloading/unpacking functools32 (from jsonschema) 05:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:14:47 INFO - warning: no files found matching '*.txt' 05:14:47 INFO - no previously-included directories found matching 'build' 05:14:47 INFO - no previously-included directories found matching 'dist' 05:14:47 INFO - no previously-included directories found matching '.git*' 05:14:47 INFO - Installing collected packages: jsonschema, functools32 05:14:48 INFO - Running setup.py install for functools32 05:14:48 INFO - warning: no files found matching '*.txt' 05:14:48 INFO - no previously-included directories found matching 'build' 05:14:48 INFO - no previously-included directories found matching 'dist' 05:14:48 INFO - no previously-included directories found matching '.git*' 05:14:48 INFO - Successfully installed jsonschema functools32 05:14:48 INFO - Cleaning up... 05:14:48 INFO - Return code: 0 05:14:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:48 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 0x1063a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b1420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1bbcbe4f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106240e00>, '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 0x106069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623bb20>, '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.fMCqA1MayX/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.rg8iyV8cK8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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 05:14:48 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 05:14:48 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 05:14:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMCqA1MayX/Render', 05:14:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:48 INFO - 'HOME': '/Users/cltbld', 05:14:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:48 INFO - 'LOGNAME': 'cltbld', 05:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:48 INFO - 'MOZ_NO_REMOTE': '1', 05:14:48 INFO - 'NO_EM_RESTART': '1', 05:14:48 INFO - 'PAGER': '/bin/cat', 05:14:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:48 INFO - 'PWD': '/builds/slave/test', 05:14:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:48 INFO - 'SHELL': '/bin/bash', 05:14:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rg8iyV8cK8/Listeners', 05:14:48 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:14:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:48 INFO - 'USER': 'cltbld', 05:14:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:48 INFO - 'XPC_FLAGS': '0x0', 05:14:48 INFO - 'XPC_SERVICE_NAME': '0', 05:14:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:48 INFO - Downloading/unpacking flake8 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:14:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:14:50 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 05:14:50 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 05:14:50 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 05:14:50 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 05:14:50 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 05:14:50 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 05:14:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:14:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:14:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:14:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:14:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:14:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:14:52 INFO - no previously-included directories found matching 'docs/_build' 05:14:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:14:52 INFO - Running setup.py install for pep8 05:14:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:14:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:14:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:14:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:14:52 INFO - no previously-included directories found matching 'docs/_build' 05:14:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:14:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:14:52 INFO - Cleaning up... 05:14:52 INFO - Return code: 0 05:14:52 INFO - Running post-action listener: _resource_record_post_action 05:14:52 INFO - Running post-action listener: _start_resource_monitoring 05:14:52 INFO - Starting resource monitoring. 05:14:52 INFO - ##### 05:14:52 INFO - ##### Running install step. 05:14:52 INFO - ##### 05:14:52 INFO - Running pre-action listener: _resource_record_pre_action 05:14:52 INFO - Running main action method: install 05:14:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:52 INFO - Reading from file tmpfile_stdout 05:14:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:14:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:14:52 INFO - Reading from file tmpfile_stdout 05:14:52 INFO - Output received: 05:14:52 INFO - Usage: mozinstall [options] installer 05:14:52 INFO - Options: 05:14:52 INFO - -h, --help show this help message and exit 05:14:52 INFO - -d DEST, --destination=DEST 05:14:52 INFO - Directory to install application into. [default: 05:14:52 INFO - "/builds/slave/test"] 05:14:52 INFO - --app=APP Application being installed. [default: firefox] 05:14:52 INFO - mkdir: /builds/slave/test/build/application 05:14:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:14:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:15:26 INFO - Reading from file tmpfile_stdout 05:15:26 INFO - Output received: 05:15:26 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:15:26 INFO - Running post-action listener: _resource_record_post_action 05:15:26 INFO - ##### 05:15:26 INFO - ##### Running run-tests step. 05:15:26 INFO - ##### 05:15:26 INFO - Running pre-action listener: _resource_record_pre_action 05:15:26 INFO - Running main action method: run_tests 05:15:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:15:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:15:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:15:26 INFO - 2016-03-26 05:15:26.660 screenresolution[1688:10886] starting screenresolution argv=screenresolution get 05:15:26 INFO - 2016-03-26 05:15:26.663 screenresolution[1688:10886] Display 0: 1600x1200x32@60 05:15:26 INFO - 2016-03-26 05:15:26.669 screenresolution[1689:10888] starting screenresolution argv=screenresolution list 05:15:26 INFO - Available Modes on Display 0 05:15:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:15:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:15:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:15:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:15:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:15:26 INFO - Intel Iris: 05:15:26 INFO - Chipset Model: Intel Iris 05:15:26 INFO - Type: GPU 05:15:26 INFO - Bus: Built-In 05:15:26 INFO - VRAM (Dynamic, Max): 1536 MB 05:15:26 INFO - Vendor: Intel (0x8086) 05:15:26 INFO - Device ID: 0x0a2e 05:15:26 INFO - Revision ID: 0x0009 05:15:26 INFO - Displays: 05:15:26 INFO - Display: 05:15:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:15:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:15:26 INFO - Display Serial Number: 1600x1200 60 05:15:26 INFO - Main Display: Yes 05:15:26 INFO - Mirror: Off 05:15:26 INFO - Online: Yes 05:15:26 INFO - Rotation: Supported 05:15:26 INFO - Return code: 0 05:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:26 INFO - Python 2.7.3 05:15:26 INFO - Return code: 0 05:15:26 INFO - grabbing minidump binary from tooltool 05:15: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')]} 05:15:26 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 0x106240e00>, '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 0x106069db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:26 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 05:15:26 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 05:15:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:26 INFO - Return code: 0 05:15:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:15:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:15:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:15:28 INFO - Return code: 0 05:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--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 05:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0053 --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 05:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fMCqA1MayX/Render', 05:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:28 INFO - 'HOME': '/Users/cltbld', 05:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:28 INFO - 'LOGNAME': 'cltbld', 05:15:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:28 INFO - 'MOZ_NO_REMOTE': '1', 05:15:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:28 INFO - 'NO_EM_RESTART': '1', 05:15:28 INFO - 'PAGER': '/bin/cat', 05:15:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:28 INFO - 'PWD': '/builds/slave/test', 05:15:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:28 INFO - 'SHELL': '/bin/bash', 05:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rg8iyV8cK8/Listeners', 05:15:28 INFO - 'TMPDIR': '/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/', 05:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:28 INFO - 'USER': 'cltbld', 05:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:28 INFO - 'XPC_FLAGS': '0x0', 05:15:28 INFO - 'XPC_SERVICE_NAME': '0', 05:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0053', '--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 05:15:28 INFO - mozversion application_buildid: 20160326030430 05:15:28 INFO - mozversion application_changeset: 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 05:15:28 INFO - mozversion application_display_name: Nightly 05:15:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:28 INFO - mozversion application_name: Firefox 05:15:28 INFO - mozversion application_remotingname: firefox 05:15:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:15:28 INFO - mozversion application_vendor: Mozilla 05:15:28 INFO - mozversion application_version: 48.0a1 05:15:28 INFO - mozversion platform_buildid: 20160326030430 05:15:28 INFO - mozversion platform_changeset: 8a4359ad909fe0cffcfea512770483ffdf8cd4e6 05:15:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:15:28 INFO - mozversion platform_version: 48.0a1 05:15:28 INFO - using testdate: 1458994528 05:15:28 INFO - actual date: 1458994528 05:15:28 INFO - starting webserver on 'localhost:49275' 05:15:28 INFO - SUITE-START | Running 2 tests 05:15:28 INFO - TEST-START | dromaeo_css 05:15:28 INFO - operating with platform_type : mac_ 05:15:28 INFO - Initialising browser for dromaeo_css test... 05:15:28 INFO - TEST-INFO | started process 1707 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpC0YlgU/profile http://localhost:49275/getInfo.html) 05:15:30 INFO - PROCESS | 1707 | __metrics Screen width/height:1600/1200 05:15:30 INFO - PROCESS | 1707 | colorDepth:24 05:15:30 INFO - PROCESS | 1707 | Browser inner width/height: 1024/689 05:15:30 INFO - PROCESS | 1707 | __metrics 05:15:31 INFO - PROCESS | 1707 | 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" 05:15:31 ERROR - PROCESS | 1707 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:15:31 INFO - TEST-INFO | 1707: exit 0 05:15:31 INFO - Browser initialized. 05:15:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:31 INFO - TEST-INFO | started process 1712 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpC0YlgU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:43 INFO - PROCESS | 1712 | RSS: Main: 244359168 05:15:43 INFO - PROCESS | 1712 | 05:16:34 INFO - PROCESS | 1712 | 1458994594560 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] 05:18:44 INFO - PROCESS | 1712 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 05:18:46 INFO - PROCESS | 1712 | RSS: Main: 341241856 05:18:46 INFO - PROCESS | 1712 | 05:21:48 INFO - PROCESS | 1712 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 05:21:49 INFO - PROCESS | 1712 | RSS: Main: 376504320 05:21:49 INFO - PROCESS | 1712 | 05:24:51 INFO - PROCESS | 1712 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:24:51 INFO - PROCESS | 1712 | RSS: Main: 378925056 05:24:51 INFO - PROCESS | 1712 | 05:27:53 INFO - PROCESS | 1712 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:27:54 INFO - PROCESS | 1712 | RSS: Main: 334077952 05:27:54 INFO - PROCESS | 1712 | 05:30:57 INFO - PROCESS | 1712 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:30:58 INFO - PROCESS | 1712 | RSS: Main: 334499840 05:30:58 INFO - PROCESS | 1712 | 05:34:01 INFO - PROCESS | 1712 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 05:34:01 INFO - PROCESS | 1712 | RSS: Main: 384335872 05:34:01 INFO - PROCESS | 1712 | 05:34:01 INFO - PROCESS | 1712 | __start_tp_report 05:34:01 INFO - PROCESS | 1712 | _x_x_mozilla_page_load 05:34:01 INFO - PROCESS | 1712 | _x_x_mozilla_page_load_details 05:34:01 INFO - PROCESS | 1712 | |i|pagename|runs| 05:34:01 INFO - PROCESS | 1712 | |0;dojo.html;3391.3047825195836;3464.2551851351955;3498.212902097028;3506.1059429845386;3537.752357334986;5455.208994695767;5565.109582466806;5604.243427137335;5630.268065151529;5684.48839604436;5582.581306402016;5646.153077038446;5736.282964629421;5762.020456522391;5768.480836724694;5039.244113382985;5075.84772456826;5102.617303702219;5114.872128196787;5239.240310155044;4334.284843000901;5208.062548741225;5234.371875374942;5271.341082364705;5306.495882891119;5049.419316778581;5106.029854327666;5159.613029022801;5172.922406163911;5234.73826308685;5144;5153.56194723449;5156.226566015091;5167.767450464738;5239.659422137587;5127.230915362688;5130.256112863613;5135.743212839343;5143.27994080829;5161.200013997836;5442.482964118402;5567.248421463091;5579.8884022319735;5584.385717571064;5615.747291371898;6199.690015499252;6218.191635087455;6218.253809542839;6233.096201050822;6241.875162496724;6184.907226391608;6235.532335074888;6260.718267677966;6286.46565041972;6294.968525157345;5663.008973429674;5724.942750572524;5774.82675519735;5786.971065144689;5799.101139323411;6186.19579454668;6253.812385628438;6258.561900666909;6273.404026617555;6283.2460104787715;6036.9698151508965;6067.878642427215;6125.509959203253;6125.816225513242;6152.661603611755;6118.101457354478;6118.253719382667;6253.093301471261;6259.6870156492;6268.905966410507;5047.318611987408;6169.321374648785;6180.690965451709;6191.133241346215;6223.813285601439;6213.099100630383;6214.689265536705;6215.098810672427;6230.532710046765;6245.750169993149;4770.833020844254;4845.6123510119105;4851.902961940741;4867.221244600847;4882.853514394503;4354.107407981356;4429.579189976947;4444.044530425974;4465.062336909221;4467.218236808546;5522.66863988162;5583.69289689071;5584.078627026495;5589.916151257653;5656.462636049569;6181.81454556364;6205.596636218631;6229.190205273286;6231.594946328565;6240.126382306481;5594.832155035356;5596.2165296858475;5600.0759874620235;5610.607257491936;5622.353429355677;5235.110031294689;5306.177542480922;5308.654937429054;5328.147496400635;5365.356157261153;6236.719347629459;6243.937560624336;6257.78097766576;6266.561340706106;6267.435930766253;6171.413715697002;6215.875682486416;6232.906506402498;6237.189165408649;6238.532110091671;6151.538634602333;6186.566940314315;6257.78097766576;6258;6296.401841825019;6142.9078563820685;6179.320274769681;6182.350853160533;6194.876102478015;6218.9378106218355;5267.552258058108;6221.377862213742;6241.563090583615;6242.250929888442;6255.186825712628;5871.530277577698;6024.487918526799;6120.479759220338;6129.988551888889;6137.662428566472;5825.475707186373;6022.126791615279;6068.605540639845;6084.087386891824;6093.177421048102;5807.680577568274;5908.172855800105;5935.643861368331;5941.732622032106;5942.64344139353;6070.817875463743;6098.3414614785315;6106.786262480792;6119.908201377072;6132.816015519542;5864.706764661835;5914.290285165807;5932.525397968066;5934;6000.699965001645 05:34:01 INFO - PROCESS | 1712 | |1;ext.html;481.1315575386426;537.1486194381902;576.3314555116064;642.579110682503;647.2912161183503;35105.47341789875;38084.80957595215;38103.61896381035;38154.04614884626;38173.80913095434;38716.612833871724;39165;39260.62587809427;39313.213735725265;39353.21293574127;9321.813563728738;9663.613455461807;9666.951665241699;9676.806463870753;9680.515974201262;9527.523623818815;9687.467189304585;9725.465099419529;9835.409875407498;9849.01509849013;9663.903360966406;9748.805023899518;9757.463339516324;9835.409875407462;9862.408255504657;9619.711408657751;9700.951495242549;9705.61177552897;9727.221822254274;9821.066998635119;9498.95250523743;9611.855822162674;9642.469664168468;9743.220542356665;9744.805103897883;38750;39050.21899562021;39105.60894391077;39120.60879391198;39159.41260881089;3287.260366417561;3390.0507857799857;3393.4400823864034;3393.7963722176746;3479.2693534357813;29150.562741558893;29739.405211895642;29793.702062979526;30050.84974575135;30155.849220753757;2758.613794068812;2788.9442211155865;2832.886684532616;2838.233676907244;2850.5439129739143;468615;470716;472717.99999999657;472788;473633;61870.38129618736;62036;62893.685531572046;62916.685416572625;63010.68494657498;65867;65967.67016164889;66003.33996660067;66072;66144;13681.726365472634;17259.654806904044;17466.91266543659;17475.825241747672;17520.737188942177;13279.800802987962;13286.069975101844;13299;13310.534131305552;13330.533431329857;19112.421636890696;19231.423057308304;19524.511887202934;19532.80467195338;19536.380811483534;6354.3010268870385;7390.817469205009;8194.590270486451;8389.622466989;8403.95798021006;918.3984490158956;933.5518950903469;1024.8923862994427;1058.1587637827945;1094.3762055628215;29517;29581;29892.70107298943;29942.85028574843;30315.393692126476;871.7210492642421;1088.5319312695617;1101.4712937789907;1138.459231864874;1157.9305241685527;14847.777283340758;14866.31711011028;14887.776683349759;15187.848121518864;15208.543743687707;532635;533561;539576;539644;539816;59453.702731486934;59910;59920.00799919973;60086;60102;1342.1946831900782;1443.5380678183092;1460.780882867557;1461.3496993837853;1494.4022391043452;21723.456913577287;25916.740832592186;28566.571501427912;29271;29329.560056599596;46845;47694;48253;48325.791855203905;48486.5151348482;327492;328286;328935;328954;329521;28711.995080172095;31623.367532649678;32308.86918957825;33019;33514;41191.382129268684;41927.58072419237;42049.36925946052;43067;43260;34287.79992700244;35031.64968350284;35492.82253588716;35931.82034089813;35975;34467.13832154216;34819;34852.825735871156;35696;35739;36045.45931810972;36456.088597784204;36837;37090.62909370872;37109.257814844095;29032.548372580863;30878.53682194814;31511.684883150876;31540.526892097096;31565.842170788997;22378.552428951654;23688.88155559211;23879;24010.27969160928;24417.51164976726 05:34:01 INFO - PROCESS | 1712 | |2;jquery.html;362.96733294003536;363.7471956989891;367.5442451360313;374.2197518174606;374.71147216643186;19713.21147154114;20757.688634670456;20905.895470522646;20952.26667066653;21281.255156069503;20229.59540809183;20261.898690506565;21188;21200.89399553;21202.575948481022;5629.7185140743;5801.564882633798;5812.128180772876;5836.037053886103;5861.1208318752315;5410.648307859996;5665.886682266352;5669.6314739542;5679.574031947621;5790.218320526717;5654.943450565504;5657.547396208293;5658.603897727161;5658.858528536799;5662.094064949609;5563.749631266563;5568.9443105569035;5649.971750141264;5666.546676265889;5738.995675756726;5482;5500.779968801243;5501.697406642633;5505.229267902497;5508.944910550923;12574.874251257554;13905.678960498737;21354.572908541897;25320.366990825194;25329.746702532924;1975.636810600681;2001.8198362147477;2126.766055733868;2215.8338124640554;2865.5701644753453;9475;9588.328816982814;9823.36148150368;10037.69886903394;10067.244956628208;1603.190388853633;1756.3413719855055;1779.065990355061;1780.2611916054823;1785.9821401786076;71062.64468677624;102623.48688256586;104206.91586168234;115992.42003790011;116374;9798.559064842098;10412.114970227616;10676.412797296069;10806.243562950518;11013.889861101286;12451.813222801666;12989.610311690665;13417.798733019012;13428.26144562039;13436.798448023288;6411.3909178627955;7428.4428667850125;8439.493630382196;8524.06235314115;8560.315174786003;6936.895946560806;6998.405135563432;8567.828643427096;8568.143185681382;8592.269657079094;4283.957160428418;4362.323839804835;4372.628326592212;4404.845830395985;4407.206702793464;1798.5593529585335;1843.5667618109733;1863.1243315641627;1878.6806242938733;1894.725264836591;890.3100097424548;929.121979729163;933.5985526223789;1018.3024628129607;1080.6595922284455;19252.22991080369;20185.49536261576;20321.695174572393;20332.288369906983;20785;779.6647441600053;980.8921018687938;982.6757170133839;989.094978095035;996.0885789502524;10831.891681083245;10948.288361256493;10962.177836662282;10974.890251097388;11025.61410350634;520487;626085.4782904407;635731;644060;644171;119671.40164299123;122007;122581.38709306397;126404;127283.45315109161;1010.3129871687323;1016.0702956794598;1029.9485025748684;1032.7314898126542;1050.2228351020037;17966.640667186846;18264.45206643803;18324.90837545857;18449.08308626111;18567.35014274548;37547.33065043656;45612.77193614011;52456.68858278573;52770.47229527656;54265;70331.59336813337;71268;71643.92534112096;71819.20451988743;72002;7583.393328533593;7714.190010048864;7767.92232077672;7776.533407995538;7922.009748781403;9100.408473449204;12081.75836483283;12214.38928053576;12252.693682657648;12468.937655311665;10201.538952236675;10439.321444106108;10764.569417223536;10831.620893268699;10855.30251665124;10046.8492972604;10316.48417579103;10433.686989390331;10565.317913302139;10883.292585981886;10710.464476776286;10739.355638661706;10910.78178436411;10972.615958441416;11101.5559377624;5551.9722401387735;7492.438067145095;7543.019407477213;7694.192109828611;7944;9117.726468205965;10071.546780395047;10261.692149235534;10305.433201174008;10347.43089130105 05:34:01 INFO - PROCESS | 1712 | |3;mootools.html;1436.3751767980937;1569.8351673074326;1594.242734701017;1847.261095561776;1983.5537004174062;8049.35605151588;8776.868346974792;8987.966383865858;9010.098990100987;9031;8548.786280342994;8816.955915220431;8823.338249631272;8825.117488251171;8825.779355516099;2175.869447833127;2235.7987781099696;2244.2930476899724;2444.242284891685;2472.1223965492172;1987.4335814292929;2513.17065368428;2517.546841568517;2517.874106294687;2518.5970244760842;2397.2688330059327;2428.3322086426288;2435.232901635979;2450.3996520852415;2466.3957330454064;2049.815516603513;2402.4114092047384;2424.442378253003;2433.85396876188;2445.730969593343;2475.9752402476106;2481.5161043596504;2498.088197807805;2500.8621077409734;2501.962470562943;8939.374243802937;8998.235150012257;9002.86495702565;9006.504642244674;9060.637574497012;5104.157813960692;5224.973875130638;5471.097268950618;5544;5620.1288800236025;3453.913652158716;3615;3632.400653892105;3698.5945340770336;3701.7223708221723;1054.7784965157325;1606.2852030846277;1646.3743777364646;1658.78435803346;1687.687777761118;11353.489092990836;11568.190226684135;11577.305361678325;11585.536578536849;11618.767624647544;4639.768011599474;4672.859814205579;4699.083678682624;4733.810647574127;4774.207088852991;9467.90532094684;9475.431474111576;9477.431354118775;9481.956984731674;9486.478243696525;5428.9185662215095;5430.375506816767;5431.918521222185;5459.235707001023;5517.310336207974;4469.262571675702;4592.816287348469;4828.879278018007;5090.77091530882;5101.20931255656;3724.888253352404;3750.493683352767;3784.564775050849;3821.6178382162116;3826.215625796705;1172.5485688010008;1173.3839734139644;1175.1597607710528;1187.958421455245;1189.881011898803;1092.4264761000538;1128.3455595754442;1128.700894263021;1232.420762241745;1306.1575283941804;8200.097989221182;8309.501429914224;8463.365247606454;8487.915120848837;8514.276286515591;1040.6305761454726;1202.500962100736;1208.667616405478;1224.6938265433641;1230.3725100198783;6349.301576826545;6410.583312084793;6470.547061705635;6477.578957367756;6486.35136486357;10483.213758967955;10860.511276992554;10860.945695271632;11024.338539687644;11030.007299343097;10826.729331766612;10896.945515272373;10897.509612067475;10927.781444371227;11050.226484146033;8409.705660301983;8556.657733690583;8590.441621294722;8630.827383452295;8645.178708022728;7924.564148971862;8135.633896474555;8215.917840821754;8226.62980165882;8230.259276665129;9548.140667339972;9862.408255504693;9886;9985.051420115367;10041.698749037541;8582.356323275904;10013.299069065095;10235.7441063974;10239.283250172417;10397;6274.654893980693;6819.863602728017;7105.32499412555;7140.107486564179;7290;8254.257116859271;8446.197611226924;8471.449355791854;8517.020542637676;8541.91458085436;7452;7564.205758395289;7637.007189065386;7642.579658118634;7670.8082297943;7337.26627337262;7421.925780742124;7450.776476705708;7543.547387156788;7657.157712651492;6683.532152749261;7895.092064412436;7909.1695371985115;7954.204579542231;8003.079645840803;7099.112610923635;7142.25006374344;7183.138023437221;7208.026916366433;7211.459140564583;6988.440924726111;7277.490575659653;7337.486375953632;7346.008288881147;7366.005589245598 05:34:01 INFO - PROCESS | 1712 | |4;prototype.html;270.18943170488535;329.84167599552217;330.4399043621062;334.70378714837364;337.4112174255924;6365.745370185193;6481.351864813516;6516.999999999994;6520.891448453763;6550.672466376686;6423.486121110312;6483.870322593545;6604.504662150334;6618.470522358211;6619.933800661992;4652.395188625491;4697.506761790014;4759.405074365704;4825.069972011197;4863.665440588519;4805.222067834889;4810.9037819243595;4812.68717533361;4838.975805120969;4839.975800120995;4776.307435421879;4790.449098353682;4800.183968725308;4808.855734327958;4835.734034628094;4511.70673906195;4675.322078298662;4680.4149481314835;4709.670323077386;4802.807887684488;3298.455754800455;3979.880603581897;4031.1937612477623;4096.549379568245;4098.364753463218;5059.898802023976;6195.628262304231;6208.2239720034995;6235.314115447297;6249.156363890862;5620.747066382022;5621.437856214387;5632.239647647597;5644.3508996465525;5645.520130788888;6877.58734475933;6900.308335040729;6900.447964162855;6912.135983002125;6912.205096413926;4308.944308644403;4474.351219073249;4500;4517.6160026397465;4588.678792484528;7222.638868056629;7257.201707812136;7307.342339189446;7310.305520975498;7320.597367144805;4569.634429245652;4570.063137056895;4572.268437050056;4573.405457290597;4587.655925805578;4611.308303754464;4616.722996620214;4628.467726211529;4647.883802904887;4657.1617108920045;5502.477264659851;5517.227588137664;5523.867607140526;5525.944740552543;5539.335279766454;6648.16897887764;6929.965350173317;6940.618265995418;7000.859982800315;7014.614196219155;1584.4612831637069;1594.4180374163348;1609.2436554819217;1612.9193440394963;1613.3304678558268;1007.1539906478447;1012.8987101289812;1034.3276870034538;1035.5236591168148;1039.5166247694858;5265.789368425297;5285.339332583427;6203.379662033851;6417.550771446047;6474.190726159136;6933.653317334113;7057.329553692391;7130.215676275606;7143.178534468499;7144.749933752294;6341.207349081365;6345.07996340528;6381.64900930444;6425.903611445832;6439.22729272481;3757.868474603376;3801.372773492398;3806.6193380662266;3808.638179372955;3815.923681526354;7195.424366050704;7543.924560754323;7546.320831125116;7547.28300811422;7550;7417.962910185414;7447.664855081534;7454.776356709307;7455.478116531899;7465.06686664167;6446.839568877647;7233.819154521179;7552.433567482351;7553.244675532403;7577.355924746458;7214.531055481377;7224.494285400182;7234.348908598251;7237.819054523679;7238.0952380952385;6827.556208846409;7079.68141433647;7097.645117744195;7110.893336599852;7139.678714457758;7468.365188958999;7513.924860751323;7543.358814500829;7559.508631938907;7587.279208475186;4699.624030077517;4770.546798054179;4775.856724298276;4785.114753770564;4793.161196790478;7175.677094530654;7178;7181.928180718126;7184.533005354635;7202.423806095605;5669.716514174357;6673.366030227121;6862.4853136014;6951.895721564281;6962.686679099352;5786.884262314646;5811.7214212873105;6315.621062736251;6708.966455167693;6910.928806035073;6743.662816859235;6777.423918966746;6777.762778302736;6787.490938179755;6805.353491418307;6871.828204294733;6923.584584924921;6953.582785032711;6953.826154346182;6953.860922781617;5493.945060549343;5534.612577119563;6520.902186467112;6571.145751052524;6796.864062718817 05:34:01 INFO - PROCESS | 1712 | |5;yui.html;595.1314663322784;732.0922056649756;737.4469148138896;747.3199388556411;803.3332334162645;11907;15453.45912893049;15455.381784728612;15464.613384665388;15465.149416782073;14224.146551206935;14291.499797507064;14299.356528956196;14301;14329.641758956031;715.5885365914594;734.7281505842845;903.3541018172006;924.1497822003772;926.1201858234671;912.9543522823832;922.7923717163618;924.117467818232;924.3483344242327;926.874871892296;971.8639390485338;973.0658567774944;974.5468357213894;975.1272611013139;976.5703090640131;763.9885401718951;888.0453512474116;907.3240435875249;910.0990019880337;968.6222373274429;677.6848765324148;677.8407074337526;678.0744284052282;680.2789043613785;682.1575354437266;15237.923810380988;15276.236188190545;15292.770608440882;15323.31045102973;15329.463468778651;10044.698659040241;12440.440180191914;12600.936995315056;12817;12868.678283042906;9973.96454408141;10014.3490673106;10112;10316.896831031669;10970.341779493176;3466.739994500397;3995.9400608990886;4153.314703073989;4293.699441039129;4301.483821941387;92064.53967730186;93055;93686;94494;94828;9317.906820931705;9483.668071617598;9756.609735610497;9808.362456440309;9813.754656133511;21384.358469245948;21420;21461.67807482889;21495.677564836227;21545.245916393163;7372.410207183412;7424.888626670604;7438.66526006331;7479.364254038468;7509.849803004018;3938.980305098456;4016.8995775105273;4059.2084543513733;4158.8336466540995;4160.812763425653;3645.3802853514967;3670.724695647837;3675.761075530082;3681.2821499807283;3686.115332320224;559.8992181407385;638.3552611862053;647.6535053746223;648.7761722205831;657.3328072006917;527.0118527760449;549.5191707256151;550.8677917299899;555.555555555554;615.1633778061832;7856.489328193649;8073.596320183968;8231.46495477792;8375.288100511403;8376.455530390505;578.8668606220593;582.7173820696959;598.3687209993499;603.4739454094292;623.4139908486009;3690.926181476409;3860.1700634363747;3868.6905047596124;3895.3962135868987;3929.390944403622;92594;92755.07244927599;97163.51418242864;98054.52918206232;98183.50908245413;80494;80584;80975;81139.59430202929;84615;74572;74935;75042.62478687572;75079.62460187664;76088.61955690186;7617.885731713918;7637.694492220471;7840.215978402114;7939.0870049945;8037.8392432152195;48746.5125348742;49607;49765.253521196486;49915.50084499108;50856.491435085176;70810;73384.63307683427;73386;74477;75277;10021.248406369406;10089.646862359783;10237.18102551809;10354.482275886025;10623.681289561326;11088;11103.38931358783;11255.606053788078;11506.30962142274;11997.700057498632;10195.949020254851;10592.993665601756;10709.357438553712;10777.568897244022;10799;10090.94954525252;10252.38485690861;10380.117689996436;10402.58389664405;11255.324680519196;10155.847662284923;10192.439415832201;10234.6417875374;10246.6413675521;10547.156227501628;8862.689805856764;8898.55507224649;9228.815423691623;9229.769255768659;9253.682308492613;7917.445778795429;8902.73291801247;8907.554622268732;8920.687775927812;9116.726498205064 05:34:01 INFO - PROCESS | 1712 | __end_tp_report 05:34:01 INFO - PROCESS | 1712 | __start_cc_report 05:34:01 INFO - PROCESS | 1712 | _x_x_mozilla_cycle_collect,1085 05:34:01 INFO - PROCESS | 1712 | __end_cc_report 05:34:01 INFO - PROCESS | 1712 | __startTimestamp1458995641516__endTimestamp 05:34:01 INFO - PROCESS | 1712 | 05:34:01 INFO - PROCESS | 1712 | ------- Summary: start ------- 05:34:01 INFO - PROCESS | 1712 | Number of tests: 6 05:34:01 INFO - PROCESS | 1712 | 05:34:01 INFO - PROCESS | 1712 | [#0] dojo.html Cycles:165 Average:5693.28 Median:5914.29 stddev:636.84 (10.8%) stddev-sans-first:612.65 05:34:01 INFO - PROCESS | 1712 | Values: 3391.3 3464.3 3498.2 3506.1 3537.8 5455.2 5565.1 5604.2 5630.3 5684.5 5582.6 5646.2 5736.3 5762.0 5768.5 5039.2 5075.8 5102.6 5114.9 5239.2 4334.3 5208.1 5234.4 5271.3 5306.5 5049.4 5106.0 5159.6 5172.9 5234.7 5144.0 5153.6 5156.2 5167.8 5239.7 5127.2 5130.3 5135.7 5143.3 5161.2 5442.5 5567.2 5579.9 5584.4 5615.7 6199.7 6218.2 6218.3 6233.1 6241.9 6184.9 6235.5 6260.7 6286.5 6295.0 5663.0 5724.9 5774.8 5787.0 5799.1 6186.2 6253.8 6258.6 6273.4 6283.2 6037.0 6067.9 6125.5 6125.8 6152.7 6118.1 6118.3 6253.1 6259.7 6268.9 5047.3 6169.3 6180.7 6191.1 6223.8 6213.1 6214.7 6215.1 6230.5 6245.8 4770.8 4845.6 4851.9 4867.2 4882.9 4354.1 4429.6 4444.0 4465.1 4467.2 5522.7 5583.7 5584.1 5589.9 5656.5 6181.8 6205.6 6229.2 6231.6 6240.1 5594.8 5596.2 5600.1 5610.6 5622.4 5235.1 5306.2 5308.7 5328.1 5365.4 6236.7 6243.9 6257.8 6266.6 6267.4 6171.4 6215.9 6232.9 6237.2 6238.5 6151.5 6186.6 6257.8 6258.0 6296.4 6142.9 6179.3 6182.4 6194.9 6218.9 5267.6 6221.4 6241.6 6242.3 6255.2 5871.5 6024.5 6120.5 6130.0 6137.7 5825.5 6022.1 6068.6 6084.1 6093.2 5807.7 5908.2 5935.6 5941.7 5942.6 6070.8 6098.3 6106.8 6119.9 6132.8 5864.7 5914.3 5932.5 5934.0 6000.7 05:34:01 INFO - PROCESS | 1712 | 05:34:01 INFO - PROCESS | 1712 | [#1] ext.html Cycles:180 Average:59522.80 Median:36963.81 stddev:120784.80 (326.8%) stddev-sans-first:121042.29 05:34:01 INFO - PROCESS | 1712 | Values: 481.1 537.1 576.3 642.6 647.3 35105.5 38084.8 38103.6 38154.0 38173.8 38716.6 39165.0 39260.6 39313.2 39353.2 9321.8 9663.6 9667.0 9676.8 9680.5 9527.5 9687.5 9725.5 9835.4 9849.0 9663.9 9748.8 9757.5 9835.4 9862.4 9619.7 9701.0 9705.6 9727.2 9821.1 9499.0 9611.9 9642.5 9743.2 9744.8 38750.0 39050.2 39105.6 39120.6 39159.4 3287.3 3390.1 3393.4 3393.8 3479.3 29150.6 29739.4 29793.7 30050.8 30155.8 2758.6 2788.9 2832.9 2838.2 2850.5 468615.0 470716.0 472718.0 472788.0 473633.0 61870.4 62036.0 62893.7 62916.7 63010.7 65867.0 65967.7 66003.3 66072.0 66144.0 13681.7 17259.7 17466.9 17475.8 17520.7 13279.8 13286.1 13299.0 13310.5 13330.5 19112.4 19231.4 19524.5 19532.8 19536.4 6354.3 7390.8 8194.6 8389.6 8404.0 918.4 933.6 1024.9 1058.2 1094.4 29517.0 29581.0 29892.7 29942.9 30315.4 871.7 1088.5 1101.5 1138.5 1157.9 14847.8 14866.3 14887.8 15187.8 15208.5 532635.0 533561.0 539576.0 539644.0 539816.0 59453.7 59910.0 59920.0 60086.0 60102.0 1342.2 1443.5 1460.8 1461.3 1494.4 21723.5 25916.7 28566.6 29271.0 29329.6 46845.0 47694.0 48253.0 48325.8 48486.5 327492.0 328286.0 328935.0 328954.0 329521.0 28712.0 31623.4 32308.9 33019.0 33514.0 41191.4 41927.6 42049.4 43067.0 43260.0 34287.8 35031.6 35492.8 35931.8 35975.0 34467.1 34819.0 34852.8 35696.0 35739.0 36045.5 36456.1 36837.0 37090.6 37109.3 29032.5 30878.5 31511.7 31540.5 31565.8 22378.6 23688.9 23879.0 24010.3 24417.5 05:34:01 INFO - PROCESS | 1712 | 05:34:01 INFO - PROCESS | 1712 | [#2] jquery.html Cycles:180 Average:34166.46 Median:11785.20 stddev:102256.32 (867.7%) stddev-sans-first:102511.67 05:34:01 INFO - PROCESS | 1712 | Values: 363.0 363.7 367.5 374.2 374.7 19713.2 20757.7 20905.9 20952.3 21281.3 20229.6 20261.9 21188.0 21200.9 21202.6 5629.7 5801.6 5812.1 5836.0 5861.1 5410.6 5665.9 5669.6 5679.6 5790.2 5654.9 5657.5 5658.6 5658.9 5662.1 5563.7 5568.9 5650.0 5666.5 5739.0 5482.0 5500.8 5501.7 5505.2 5508.9 12574.9 13905.7 21354.6 25320.4 25329.7 1975.6 2001.8 2126.8 2215.8 2865.6 9475.0 9588.3 9823.4 10037.7 10067.2 1603.2 1756.3 1779.1 1780.3 1786.0 71062.6 102623.5 104206.9 115992.4 116374.0 9798.6 10412.1 10676.4 10806.2 11013.9 12451.8 12989.6 13417.8 13428.3 13436.8 6411.4 7428.4 8439.5 8524.1 8560.3 6936.9 6998.4 8567.8 8568.1 8592.3 4284.0 4362.3 4372.6 4404.8 4407.2 1798.6 1843.6 1863.1 1878.7 1894.7 890.3 929.1 933.6 1018.3 1080.7 19252.2 20185.5 20321.7 20332.3 20785.0 779.7 980.9 982.7 989.1 996.1 10831.9 10948.3 10962.2 10974.9 11025.6 520487.0 626085.5 635731.0 644060.0 644171.0 119671.4 122007.0 122581.4 126404.0 127283.5 1010.3 1016.1 1029.9 1032.7 1050.2 17966.6 18264.5 18324.9 18449.1 18567.4 37547.3 45612.8 52456.7 52770.5 54265.0 70331.6 71268.0 71643.9 71819.2 72002.0 7583.4 7714.2 7767.9 7776.5 7922.0 9100.4 12081.8 12214.4 12252.7 12468.9 10201.5 10439.3 10764.6 10831.6 10855.3 10046.8 10316.5 10433.7 10565.3 10883.3 10710.5 10739.4 10910.8 10972.6 11101.6 5552.0 7492.4 7543.0 7694.2 7944.0 9117.7 10071.5 10261.7 10305.4 10347.4 05:34:01 INFO - PROCESS | 1712 | 05:34:01 INFO - PROCESS | 1712 | [#3] mootools.html Cycles:180 Average:6103.69 Median:5164.57 stddev:3206.08 (62.1%) stddev-sans-first:3195.88 05:34:01 INFO - PROCESS | 1712 | Values: 1436.4 1569.8 1594.2 1847.3 1983.6 8049.4 8776.9 8988.0 9010.1 9031.0 8548.8 8817.0 8823.3 8825.1 8825.8 2175.9 2235.8 2244.3 2444.2 2472.1 1987.4 2513.2 2517.5 2517.9 2518.6 2397.3 2428.3 2435.2 2450.4 2466.4 2049.8 2402.4 2424.4 2433.9 2445.7 2476.0 2481.5 2498.1 2500.9 2502.0 8939.4 8998.2 9002.9 9006.5 9060.6 5104.2 5225.0 5471.1 5544.0 5620.1 3453.9 3615.0 3632.4 3698.6 3701.7 1054.8 1606.3 1646.4 1658.8 1687.7 11353.5 11568.2 11577.3 11585.5 11618.8 4639.8 4672.9 4699.1 4733.8 4774.2 9467.9 9475.4 9477.4 9482.0 9486.5 5428.9 5430.4 5431.9 5459.2 5517.3 4469.3 4592.8 4828.9 5090.8 5101.2 3724.9 3750.5 3784.6 3821.6 3826.2 1172.5 1173.4 1175.2 1188.0 1189.9 1092.4 1128.3 1128.7 1232.4 1306.2 8200.1 8309.5 8463.4 8487.9 8514.3 1040.6 1202.5 1208.7 1224.7 1230.4 6349.3 6410.6 6470.5 6477.6 6486.4 10483.2 10860.5 10860.9 11024.3 11030.0 10826.7 10896.9 10897.5 10927.8 11050.2 8409.7 8556.7 8590.4 8630.8 8645.2 7924.6 8135.6 8215.9 8226.6 8230.3 9548.1 9862.4 9886.0 9985.1 10041.7 8582.4 10013.3 10235.7 10239.3 10397.0 6274.7 6819.9 7105.3 7140.1 7290.0 8254.3 8446.2 8471.4 8517.0 8541.9 7452.0 7564.2 7637.0 7642.6 7670.8 7337.3 7421.9 7450.8 7543.5 7657.2 6683.5 7895.1 7909.2 7954.2 8003.1 7099.1 7142.3 7183.1 7208.0 7211.5 6988.4 7277.5 7337.5 7346.0 7366.0 05:34:01 INFO - PROCESS | 1712 | 05:34:01 INFO - PROCESS | 1712 | [#4] prototype.html Cycles:180 Average:5634.70 Median:6355.41 stddev:1800.53 (28.3%) stddev-sans-first:1759.98 05:34:01 INFO - PROCESS | 1712 | Values: 270.2 329.8 330.4 334.7 337.4 6365.7 6481.4 6517.0 6520.9 6550.7 6423.5 6483.9 6604.5 6618.5 6619.9 4652.4 4697.5 4759.4 4825.1 4863.7 4805.2 4810.9 4812.7 4839.0 4840.0 4776.3 4790.4 4800.2 4808.9 4835.7 4511.7 4675.3 4680.4 4709.7 4802.8 3298.5 3979.9 4031.2 4096.5 4098.4 5059.9 6195.6 6208.2 6235.3 6249.2 5620.7 5621.4 5632.2 5644.4 5645.5 6877.6 6900.3 6900.4 6912.1 6912.2 4308.9 4474.4 4500.0 4517.6 4588.7 7222.6 7257.2 7307.3 7310.3 7320.6 4569.6 4570.1 4572.3 4573.4 4587.7 4611.3 4616.7 4628.5 4647.9 4657.2 5502.5 5517.2 5523.9 5525.9 5539.3 6648.2 6930.0 6940.6 7000.9 7014.6 1584.5 1594.4 1609.2 1612.9 1613.3 1007.2 1012.9 1034.3 1035.5 1039.5 5265.8 5285.3 6203.4 6417.6 6474.2 6933.7 7057.3 7130.2 7143.2 7144.7 6341.2 6345.1 6381.6 6425.9 6439.2 3757.9 3801.4 3806.6 3808.6 3815.9 7195.4 7543.9 7546.3 7547.3 7550.0 7418.0 7447.7 7454.8 7455.5 7465.1 6446.8 7233.8 7552.4 7553.2 7577.4 7214.5 7224.5 7234.3 7237.8 7238.1 6827.6 7079.7 7097.6 7110.9 7139.7 7468.4 7513.9 7543.4 7559.5 7587.3 4699.6 4770.5 4775.9 4785.1 4793.2 7175.7 7178.0 7181.9 7184.5 7202.4 5669.7 6673.4 6862.5 6951.9 6962.7 5786.9 5811.7 6315.6 6709.0 6910.9 6743.7 6777.4 6777.8 6787.5 6805.4 6871.8 6923.6 6953.6 6953.8 6953.9 5493.9 5534.6 6520.9 6571.1 6796.9 05:34:01 INFO - PROCESS | 1712 | 05:34:01 INFO - PROCESS | 1712 | [#5] yui.html Cycles:180 Average:18998.38 Median:630.88 stddev:27748.80 (4398.4%) stddev-sans-first:27792.23 05:34:01 INFO - PROCESS | 1712 | Values: 595.1 732.1 737.4 747.3 803.3 11907.0 15453.5 15455.4 15464.6 15465.1 14224.1 14291.5 14299.4 14301.0 14329.6 715.6 734.7 903.4 924.1 926.1 913.0 922.8 924.1 924.3 926.9 971.9 973.1 974.5 975.1 976.6 764.0 888.0 907.3 910.1 968.6 677.7 677.8 678.1 680.3 682.2 15237.9 15276.2 15292.8 15323.3 15329.5 10044.7 12440.4 12600.9 12817.0 12868.7 9974.0 10014.3 10112.0 10316.9 10970.3 3466.7 3995.9 4153.3 4293.7 4301.5 92064.5 93055.0 93686.0 94494.0 94828.0 9317.9 9483.7 9756.6 9808.4 9813.8 21384.4 21420.0 21461.7 21495.7 21545.2 7372.4 7424.9 7438.7 7479.4 7509.8 3939.0 4016.9 4059.2 4158.8 4160.8 3645.4 3670.7 3675.8 3681.3 3686.1 559.9 638.4 647.7 648.8 657.3 527.0 549.5 550.9 555.6 615.2 7856.5 8073.6 8231.5 8375.3 8376.5 578.9 582.7 598.4 603.5 623.4 3690.9 3860.2 3868.7 3895.4 3929.4 92594.0 92755.1 97163.5 98054.5 98183.5 80494.0 80584.0 80975.0 81139.6 84615.0 74572.0 74935.0 75042.6 75079.6 76088.6 7617.9 7637.7 7840.2 7939.1 8037.8 48746.5 49607.0 49765.3 49915.5 50856.5 70810.0 73384.6 73386.0 74477.0 75277.0 10021.2 10089.6 10237.2 10354.5 10623.7 11088.0 11103.4 11255.6 11506.3 11997.7 10195.9 10593.0 10709.4 10777.6 10799.0 10090.9 10252.4 10380.1 10402.6 11255.3 10155.8 10192.4 10234.6 10246.6 10547.2 8862.7 8898.6 9228.8 9229.8 9253.7 7917.4 8902.7 8907.6 8920.7 9116.7 05:34:01 INFO - PROCESS | 1712 | -------- Summary: end -------- 05:34:01 INFO - PROCESS | 1712 | 05:34:02 INFO - TEST-INFO | 1712: exit 0 05:34:02 INFO - TEST-OK | dromaeo_css | took 1113712ms 05:34:02 INFO - TEST-START | kraken 05:34:02 INFO - operating with platform_type : mac_ 05:34:02 INFO - Initialising browser for kraken test... 05:34:02 INFO - TEST-INFO | started process 1721 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpYzPnHv/profile http://localhost:49275/getInfo.html) 05:34:04 INFO - PROCESS | 1721 | __metrics Screen width/height:1600/1200 05:34:04 INFO - PROCESS | 1721 | colorDepth:24 05:34:04 INFO - PROCESS | 1721 | Browser inner width/height: 1024/689 05:34:04 INFO - PROCESS | 1721 | __metrics 05:34:04 INFO - PROCESS | 1721 | 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" 05:34:04 ERROR - PROCESS | 1721 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:34:05 INFO - TEST-INFO | 1721: exit 0 05:34:05 INFO - Browser initialized. 05:34:05 INFO - Running cycle 1/1 for kraken test... 05:34:05 INFO - TEST-INFO | started process 1724 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/T/tmpYzPnHv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:16 INFO - PROCESS | 1724 | RSS: Main: 244346880 05:34:16 INFO - PROCESS | 1724 | 05:34:19 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:20 INFO - PROCESS | 1724 | RSS: Main: 290353152 05:34:20 INFO - PROCESS | 1724 | 05:34:22 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 05:34:23 INFO - PROCESS | 1724 | RSS: Main: 300773376 05:34:23 INFO - PROCESS | 1724 | 05:34:26 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 05:34:27 INFO - PROCESS | 1724 | RSS: Main: 286203904 05:34:27 INFO - PROCESS | 1724 | 05:34:29 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 05:34:29 INFO - PROCESS | 1724 | RSS: Main: 288776192 05:34:29 INFO - PROCESS | 1724 | 05:34:32 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:32 INFO - PROCESS | 1724 | RSS: Main: 288800768 05:34:32 INFO - PROCESS | 1724 | 05:34:35 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:35 INFO - PROCESS | 1724 | RSS: Main: 288784384 05:34:35 INFO - PROCESS | 1724 | 05:34:38 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:39 INFO - PROCESS | 1724 | RSS: Main: 288972800 05:34:39 INFO - PROCESS | 1724 | 05:34:42 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 05:34:42 INFO - PROCESS | 1724 | RSS: Main: 289333248 05:34:42 INFO - PROCESS | 1724 | 05:34:44 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:34:44 INFO - PROCESS | 1724 | RSS: Main: 323821568 05:34:44 INFO - PROCESS | 1724 | 05:34:46 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:34:47 INFO - PROCESS | 1724 | RSS: Main: 322658304 05:34:47 INFO - PROCESS | 1724 | 05:34:49 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:34:50 INFO - PROCESS | 1724 | RSS: Main: 331718656 05:34:50 INFO - PROCESS | 1724 | 05:34:52 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:34:53 INFO - PROCESS | 1724 | RSS: Main: 332120064 05:34:53 INFO - PROCESS | 1724 | 05:34:56 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:34:56 INFO - PROCESS | 1724 | RSS: Main: 332152832 05:34:56 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 05:34:58 INFO - PROCESS | 1724 | RSS: Main: 394031104 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | __start_tp_report 05:34:58 INFO - PROCESS | 1724 | _x_x_mozilla_page_load 05:34:58 INFO - PROCESS | 1724 | _x_x_mozilla_page_load_details 05:34:58 INFO - PROCESS | 1724 | |i|pagename|runs| 05:34:58 INFO - PROCESS | 1724 | |0;ai-astar;111;111;110;110;110;112;117;112;110;111 05:34:58 INFO - PROCESS | 1724 | |1;audio-beat-detection;159;122;144;160;118;146;165;149;172;120 05:34:58 INFO - PROCESS | 1724 | |2;audio-dft;186;182;183;183;183;183;184;185;182;182 05:34:58 INFO - PROCESS | 1724 | |3;audio-fft;74;76;83;80;75;74;84;114;99;57 05:34:58 INFO - PROCESS | 1724 | |4;audio-oscillator;89;99;131;78;80;82;114;80;80;118 05:34:58 INFO - PROCESS | 1724 | |5;imaging-gaussian-blur;86;83;87;84;86;83;87;84;86;84 05:34:58 INFO - PROCESS | 1724 | |6;imaging-darkroom;92;93;93;101;141;149;104;94;92;101 05:34:58 INFO - PROCESS | 1724 | |7;imaging-desaturate;93;85;84;84;86;85;88;83;85;84 05:34:58 INFO - PROCESS | 1724 | |8;json-parse-financial;56;54;54;54;55;55;53;67;55;53 05:34:58 INFO - PROCESS | 1724 | |9;json-stringify-tinderbox;65;64;75;75;70;69;70;69;70;69 05:34:58 INFO - PROCESS | 1724 | |10;stanford-crypto-aes;101;110;115;85;85;83;83;83;84;83 05:34:58 INFO - PROCESS | 1724 | |11;stanford-crypto-ccm;134;135;133;137;137;136;111;122;121;124 05:34:58 INFO - PROCESS | 1724 | |12;stanford-crypto-pbkdf2;164;175;141;139;140;179;154;139;137;178 05:34:58 INFO - PROCESS | 1724 | |13;stanford-crypto-sha256-iterative;68;68;67;89;56;60;70;94;97;98 05:34:58 INFO - PROCESS | 1724 | __end_tp_report 05:34:58 INFO - PROCESS | 1724 | __start_cc_report 05:34:58 INFO - PROCESS | 1724 | _x_x_mozilla_cycle_collect,1242 05:34:58 INFO - PROCESS | 1724 | __end_cc_report 05:34:58 INFO - PROCESS | 1724 | __startTimestamp1458995698735__endTimestamp 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | ------- Summary: start ------- 05:34:58 INFO - PROCESS | 1724 | Number of tests: 14 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 05:34:58 INFO - PROCESS | 1724 | Values: 111.0 111.0 110.0 110.0 110.0 112.0 117.0 112.0 110.0 111.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:154.00 stddev:19.57 (12.7%) stddev-sans-first:20.14 05:34:58 INFO - PROCESS | 1724 | Values: 159.0 122.0 144.0 160.0 118.0 146.0 165.0 149.0 172.0 120.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.00 stddev:1.34 (0.7%) stddev-sans-first:1.00 05:34:58 INFO - PROCESS | 1724 | Values: 186.0 182.0 183.0 183.0 183.0 183.0 184.0 185.0 182.0 182.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#3] audio-fft Cycles:10 Average:81.60 Median:78.00 stddev:15.49 (19.9%) stddev-sans-first:16.18 05:34:58 INFO - PROCESS | 1724 | Values: 74.0 76.0 83.0 80.0 75.0 74.0 84.0 114.0 99.0 57.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:80.00 stddev:19.35 (24.2%) stddev-sans-first:20.40 05:34:58 INFO - PROCESS | 1724 | Values: 89.0 99.0 131.0 78.0 80.0 82.0 114.0 80.0 80.0 118.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 05:34:58 INFO - PROCESS | 1724 | Values: 86.0 83.0 87.0 84.0 86.0 83.0 87.0 84.0 86.0 84.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#6] imaging-darkroom Cycles:10 Average:106.00 Median:92.00 stddev:21.09 (22.9%) stddev-sans-first:21.75 05:34:58 INFO - PROCESS | 1724 | Values: 92.0 93.0 93.0 101.0 141.0 149.0 104.0 94.0 92.0 101.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:85.00 stddev:2.91 (3.4%) stddev-sans-first:1.45 05:34:58 INFO - PROCESS | 1724 | Values: 93.0 85.0 84.0 84.0 86.0 85.0 88.0 83.0 85.0 84.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:4.12 (7.5%) stddev-sans-first:4.36 05:34:58 INFO - PROCESS | 1724 | Values: 56.0 54.0 54.0 54.0 55.0 55.0 53.0 67.0 55.0 53.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:3.53 (5.0%) stddev-sans-first:3.33 05:34:58 INFO - PROCESS | 1724 | Values: 65.0 64.0 75.0 75.0 70.0 69.0 70.0 69.0 70.0 69.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:83.00 stddev:12.53 (15.1%) stddev-sans-first:12.78 05:34:58 INFO - PROCESS | 1724 | Values: 101.0 110.0 115.0 85.0 85.0 83.0 83.0 83.0 84.0 83.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:134.50 stddev:8.92 (6.6%) stddev-sans-first:9.28 05:34:58 INFO - PROCESS | 1724 | Values: 134.0 135.0 133.0 137.0 137.0 136.0 111.0 122.0 121.0 124.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:159.00 stddev:17.77 (11.2%) stddev-sans-first:18.52 05:34:58 INFO - PROCESS | 1724 | Values: 164.0 175.0 141.0 139.0 140.0 179.0 154.0 139.0 137.0 178.0 05:34:58 INFO - PROCESS | 1724 | 05:34:58 INFO - PROCESS | 1724 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:79.50 stddev:16.04 (20.2%) stddev-sans-first:16.70 05:34:58 INFO - PROCESS | 1724 | Values: 68.0 68.0 67.0 89.0 56.0 60.0 70.0 94.0 97.0 98.0 05:34:58 INFO - PROCESS | 1724 | -------- Summary: end -------- 05:34:58 INFO - PROCESS | 1724 | 05:34:59 INFO - TEST-INFO | 1724: exit 0 05:34:59 INFO - TEST-OK | kraken | took 57384ms 05:34:59 INFO - SUITE-END | took 1171s 05:34:59 INFO - Completed test suite (00:19:31) 05:34:59 INFO - javascript benchmark 05:34:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3391.3047825195836, 3464.2551851351955, 3498.212902097028, 3506.1059429845386, 3537.752357334986, 5455.208994695767, 5565.109582466806, 5604.243427137335, 5630.268065151529, 5684.48839604436, 5582.581306402016, 5646.153077038446, 5736.282964629421, 5762.020456522391, 5768.480836724694, 5039.244113382985, 5075.84772456826, 5102.617303702219, 5114.872128196787, 5239.240310155044, 4334.284843000901, 5208.062548741225, 5234.371875374942, 5271.341082364705, 5306.495882891119, 5049.419316778581, 5106.029854327666, 5159.613029022801, 5172.922406163911, 5234.73826308685, 5144.0, 5153.56194723449, 5156.226566015091, 5167.767450464738, 5239.659422137587, 5127.230915362688, 5130.256112863613, 5135.743212839343, 5143.27994080829, 5161.200013997836, 5442.482964118402, 5567.248421463091, 5579.8884022319735, 5584.385717571064, 5615.747291371898, 6199.690015499252, 6218.191635087455, 6218.253809542839, 6233.096201050822, 6241.875162496724, 6184.907226391608, 6235.532335074888, 6260.718267677966, 6286.46565041972, 6294.968525157345, 5663.008973429674, 5724.942750572524, 5774.82675519735, 5786.971065144689, 5799.101139323411, 6186.19579454668, 6253.812385628438, 6258.561900666909, 6273.404026617555, 6283.2460104787715, 6036.9698151508965, 6067.878642427215, 6125.509959203253, 6125.816225513242, 6152.661603611755, 6118.101457354478, 6118.253719382667, 6253.093301471261, 6259.6870156492, 6268.905966410507, 5047.318611987408, 6169.321374648785, 6180.690965451709, 6191.133241346215, 6223.813285601439, 6213.099100630383, 6214.689265536705, 6215.098810672427, 6230.532710046765, 6245.750169993149, 4770.833020844254, 4845.6123510119105, 4851.902961940741, 4867.221244600847, 4882.853514394503, 4354.107407981356, 4429.579189976947, 4444.044530425974, 4465.062336909221, 4467.218236808546, 5522.66863988162, 5583.69289689071, 5584.078627026495, 5589.916151257653, 5656.462636049569, 6181.81454556364, 6205.596636218631, 6229.190205273286, 6231.594946328565, 6240.126382306481, 5594.832155035356, 5596.2165296858475, 5600.0759874620235, 5610.607257491936, 5622.353429355677, 5235.110031294689, 5306.177542480922, 5308.654937429054, 5328.147496400635, 5365.356157261153, 6236.719347629459, 6243.937560624336, 6257.78097766576, 6266.561340706106, 6267.435930766253, 6171.413715697002, 6215.875682486416, 6232.906506402498, 6237.189165408649, 6238.532110091671, 6151.538634602333, 6186.566940314315, 6257.78097766576, 6258.0, 6296.401841825019, 6142.9078563820685, 6179.320274769681, 6182.350853160533, 6194.876102478015, 6218.9378106218355, 5267.552258058108, 6221.377862213742, 6241.563090583615, 6242.250929888442, 6255.186825712628, 5871.530277577698, 6024.487918526799, 6120.479759220338, 6129.988551888889, 6137.662428566472, 5825.475707186373, 6022.126791615279, 6068.605540639845, 6084.087386891824, 6093.177421048102, 5807.680577568274, 5908.172855800105, 5935.643861368331, 5941.732622032106, 5942.64344139353, 6070.817875463743, 6098.3414614785315, 6106.786262480792, 6119.908201377072, 6132.816015519542, 5864.706764661835, 5914.290285165807, 5932.525397968066, 5934.0, 6000.699965001645], "unit": "score", "name": "dojo.html", "value": 5653.963352911161}, {"lowerIsBetter": false, "replicates": [481.1315575386426, 537.1486194381902, 576.3314555116064, 642.579110682503, 647.2912161183503, 35105.47341789875, 38084.80957595215, 38103.61896381035, 38154.04614884626, 38173.80913095434, 38716.612833871724, 39165.0, 39260.62587809427, 39313.213735725265, 39353.21293574127, 9321.813563728738, 9663.613455461807, 9666.951665241699, 9676.806463870753, 9680.515974201262, 9527.523623818815, 9687.467189304585, 9725.465099419529, 9835.409875407498, 9849.01509849013, 9663.903360966406, 9748.805023899518, 9757.463339516324, 9835.409875407462, 9862.408255504657, 9619.711408657751, 9700.951495242549, 9705.61177552897, 9727.221822254274, 9821.066998635119, 9498.95250523743, 9611.855822162674, 9642.469664168468, 9743.220542356665, 9744.805103897883, 38750.0, 39050.21899562021, 39105.60894391077, 39120.60879391198, 39159.41260881089, 3287.260366417561, 3390.0507857799857, 3393.4400823864034, 3393.7963722176746, 3479.2693534357813, 29150.562741558893, 29739.405211895642, 29793.702062979526, 30050.84974575135, 30155.849220753757, 2758.613794068812, 2788.9442211155865, 2832.886684532616, 2838.233676907244, 2850.5439129739143, 468615.0, 470716.0, 472717.99999999657, 472788.0, 473633.0, 61870.38129618736, 62036.0, 62893.685531572046, 62916.685416572625, 63010.68494657498, 65867.0, 65967.67016164889, 66003.33996660067, 66072.0, 66144.0, 13681.726365472634, 17259.654806904044, 17466.91266543659, 17475.825241747672, 17520.737188942177, 13279.800802987962, 13286.069975101844, 13299.0, 13310.534131305552, 13330.533431329857, 19112.421636890696, 19231.423057308304, 19524.511887202934, 19532.80467195338, 19536.380811483534, 6354.3010268870385, 7390.817469205009, 8194.590270486451, 8389.622466989, 8403.95798021006, 918.3984490158956, 933.5518950903469, 1024.8923862994427, 1058.1587637827945, 1094.3762055628215, 29517.0, 29581.0, 29892.70107298943, 29942.85028574843, 30315.393692126476, 871.7210492642421, 1088.5319312695617, 1101.4712937789907, 1138.459231864874, 1157.9305241685527, 14847.777283340758, 14866.31711011028, 14887.776683349759, 15187.848121518864, 15208.543743687707, 532635.0, 533561.0, 539576.0, 539644.0, 539816.0, 59453.702731486934, 59910.0, 59920.00799919973, 60086.0, 60102.0, 1342.1946831900782, 1443.5380678183092, 1460.780882867557, 1461.3496993837853, 1494.4022391043452, 21723.456913577287, 25916.740832592186, 28566.571501427912, 29271.0, 29329.560056599596, 46845.0, 47694.0, 48253.0, 48325.791855203905, 48486.5151348482, 327492.0, 328286.0, 328935.0, 328954.0, 329521.0, 28711.995080172095, 31623.367532649678, 32308.86918957825, 33019.0, 33514.0, 41191.382129268684, 41927.58072419237, 42049.36925946052, 43067.0, 43260.0, 34287.79992700244, 35031.64968350284, 35492.82253588716, 35931.82034089813, 35975.0, 34467.13832154216, 34819.0, 34852.825735871156, 35696.0, 35739.0, 36045.45931810972, 36456.088597784204, 36837.0, 37090.62909370872, 37109.257814844095, 29032.548372580863, 30878.53682194814, 31511.684883150876, 31540.526892097096, 31565.842170788997, 22378.552428951654, 23688.88155559211, 23879.0, 24010.27969160928, 24417.51164976726], "unit": "score", "name": "ext.html", "value": 19385.26184254027}, {"lowerIsBetter": false, "replicates": [362.96733294003536, 363.7471956989891, 367.5442451360313, 374.2197518174606, 374.71147216643186, 19713.21147154114, 20757.688634670456, 20905.895470522646, 20952.26667066653, 21281.255156069503, 20229.59540809183, 20261.898690506565, 21188.0, 21200.89399553, 21202.575948481022, 5629.7185140743, 5801.564882633798, 5812.128180772876, 5836.037053886103, 5861.1208318752315, 5410.648307859996, 5665.886682266352, 5669.6314739542, 5679.574031947621, 5790.218320526717, 5654.943450565504, 5657.547396208293, 5658.603897727161, 5658.858528536799, 5662.094064949609, 5563.749631266563, 5568.9443105569035, 5649.971750141264, 5666.546676265889, 5738.995675756726, 5482.0, 5500.779968801243, 5501.697406642633, 5505.229267902497, 5508.944910550923, 12574.874251257554, 13905.678960498737, 21354.572908541897, 25320.366990825194, 25329.746702532924, 1975.636810600681, 2001.8198362147477, 2126.766055733868, 2215.8338124640554, 2865.5701644753453, 9475.0, 9588.328816982814, 9823.36148150368, 10037.69886903394, 10067.244956628208, 1603.190388853633, 1756.3413719855055, 1779.065990355061, 1780.2611916054823, 1785.9821401786076, 71062.64468677624, 102623.48688256586, 104206.91586168234, 115992.42003790011, 116374.0, 9798.559064842098, 10412.114970227616, 10676.412797296069, 10806.243562950518, 11013.889861101286, 12451.813222801666, 12989.610311690665, 13417.798733019012, 13428.26144562039, 13436.798448023288, 6411.3909178627955, 7428.4428667850125, 8439.493630382196, 8524.06235314115, 8560.315174786003, 6936.895946560806, 6998.405135563432, 8567.828643427096, 8568.143185681382, 8592.269657079094, 4283.957160428418, 4362.323839804835, 4372.628326592212, 4404.845830395985, 4407.206702793464, 1798.5593529585335, 1843.5667618109733, 1863.1243315641627, 1878.6806242938733, 1894.725264836591, 890.3100097424548, 929.121979729163, 933.5985526223789, 1018.3024628129607, 1080.6595922284455, 19252.22991080369, 20185.49536261576, 20321.695174572393, 20332.288369906983, 20785.0, 779.6647441600053, 980.8921018687938, 982.6757170133839, 989.094978095035, 996.0885789502524, 10831.891681083245, 10948.288361256493, 10962.177836662282, 10974.890251097388, 11025.61410350634, 520487.0, 626085.4782904407, 635731.0, 644060.0, 644171.0, 119671.40164299123, 122007.0, 122581.38709306397, 126404.0, 127283.45315109161, 1010.3129871687323, 1016.0702956794598, 1029.9485025748684, 1032.7314898126542, 1050.2228351020037, 17966.640667186846, 18264.45206643803, 18324.90837545857, 18449.08308626111, 18567.35014274548, 37547.33065043656, 45612.77193614011, 52456.68858278573, 52770.47229527656, 54265.0, 70331.59336813337, 71268.0, 71643.92534112096, 71819.20451988743, 72002.0, 7583.393328533593, 7714.190010048864, 7767.92232077672, 7776.533407995538, 7922.009748781403, 9100.408473449204, 12081.75836483283, 12214.38928053576, 12252.693682657648, 12468.937655311665, 10201.538952236675, 10439.321444106108, 10764.569417223536, 10831.620893268699, 10855.30251665124, 10046.8492972604, 10316.48417579103, 10433.686989390331, 10565.317913302139, 10883.292585981886, 10710.464476776286, 10739.355638661706, 10910.78178436411, 10972.615958441416, 11101.5559377624, 5551.9722401387735, 7492.438067145095, 7543.019407477213, 7694.192109828611, 7944.0, 9117.726468205965, 10071.546780395047, 10261.692149235534, 10305.433201174008, 10347.43089130105], "unit": "score", "name": "jquery.html", "value": 9139.030783373173}, {"lowerIsBetter": false, "replicates": [1436.3751767980937, 1569.8351673074326, 1594.242734701017, 1847.261095561776, 1983.5537004174062, 8049.35605151588, 8776.868346974792, 8987.966383865858, 9010.098990100987, 9031.0, 8548.786280342994, 8816.955915220431, 8823.338249631272, 8825.117488251171, 8825.779355516099, 2175.869447833127, 2235.7987781099696, 2244.2930476899724, 2444.242284891685, 2472.1223965492172, 1987.4335814292929, 2513.17065368428, 2517.546841568517, 2517.874106294687, 2518.5970244760842, 2397.2688330059327, 2428.3322086426288, 2435.232901635979, 2450.3996520852415, 2466.3957330454064, 2049.815516603513, 2402.4114092047384, 2424.442378253003, 2433.85396876188, 2445.730969593343, 2475.9752402476106, 2481.5161043596504, 2498.088197807805, 2500.8621077409734, 2501.962470562943, 8939.374243802937, 8998.235150012257, 9002.86495702565, 9006.504642244674, 9060.637574497012, 5104.157813960692, 5224.973875130638, 5471.097268950618, 5544.0, 5620.1288800236025, 3453.913652158716, 3615.0, 3632.400653892105, 3698.5945340770336, 3701.7223708221723, 1054.7784965157325, 1606.2852030846277, 1646.3743777364646, 1658.78435803346, 1687.687777761118, 11353.489092990836, 11568.190226684135, 11577.305361678325, 11585.536578536849, 11618.767624647544, 4639.768011599474, 4672.859814205579, 4699.083678682624, 4733.810647574127, 4774.207088852991, 9467.90532094684, 9475.431474111576, 9477.431354118775, 9481.956984731674, 9486.478243696525, 5428.9185662215095, 5430.375506816767, 5431.918521222185, 5459.235707001023, 5517.310336207974, 4469.262571675702, 4592.816287348469, 4828.879278018007, 5090.77091530882, 5101.20931255656, 3724.888253352404, 3750.493683352767, 3784.564775050849, 3821.6178382162116, 3826.215625796705, 1172.5485688010008, 1173.3839734139644, 1175.1597607710528, 1187.958421455245, 1189.881011898803, 1092.4264761000538, 1128.3455595754442, 1128.700894263021, 1232.420762241745, 1306.1575283941804, 8200.097989221182, 8309.501429914224, 8463.365247606454, 8487.915120848837, 8514.276286515591, 1040.6305761454726, 1202.500962100736, 1208.667616405478, 1224.6938265433641, 1230.3725100198783, 6349.301576826545, 6410.583312084793, 6470.547061705635, 6477.578957367756, 6486.35136486357, 10483.213758967955, 10860.511276992554, 10860.945695271632, 11024.338539687644, 11030.007299343097, 10826.729331766612, 10896.945515272373, 10897.509612067475, 10927.781444371227, 11050.226484146033, 8409.705660301983, 8556.657733690583, 8590.441621294722, 8630.827383452295, 8645.178708022728, 7924.564148971862, 8135.633896474555, 8215.917840821754, 8226.62980165882, 8230.259276665129, 9548.140667339972, 9862.408255504693, 9886.0, 9985.051420115367, 10041.698749037541, 8582.356323275904, 10013.299069065095, 10235.7441063974, 10239.283250172417, 10397.0, 6274.654893980693, 6819.863602728017, 7105.32499412555, 7140.107486564179, 7290.0, 8254.257116859271, 8446.197611226924, 8471.449355791854, 8517.020542637676, 8541.91458085436, 7452.0, 7564.205758395289, 7637.007189065386, 7642.579658118634, 7670.8082297943, 7337.26627337262, 7421.925780742124, 7450.776476705708, 7543.547387156788, 7657.157712651492, 6683.532152749261, 7895.092064412436, 7909.1695371985115, 7954.204579542231, 8003.079645840803, 7099.112610923635, 7142.25006374344, 7183.138023437221, 7208.026916366433, 7211.459140564583, 6988.440924726111, 7277.490575659653, 7337.486375953632, 7346.008288881147, 7366.005589245598], "unit": "score", "name": "mootools.html", "value": 4990.1855493188195}, {"lowerIsBetter": false, "replicates": [270.18943170488535, 329.84167599552217, 330.4399043621062, 334.70378714837364, 337.4112174255924, 6365.745370185193, 6481.351864813516, 6516.999999999994, 6520.891448453763, 6550.672466376686, 6423.486121110312, 6483.870322593545, 6604.504662150334, 6618.470522358211, 6619.933800661992, 4652.395188625491, 4697.506761790014, 4759.405074365704, 4825.069972011197, 4863.665440588519, 4805.222067834889, 4810.9037819243595, 4812.68717533361, 4838.975805120969, 4839.975800120995, 4776.307435421879, 4790.449098353682, 4800.183968725308, 4808.855734327958, 4835.734034628094, 4511.70673906195, 4675.322078298662, 4680.4149481314835, 4709.670323077386, 4802.807887684488, 3298.455754800455, 3979.880603581897, 4031.1937612477623, 4096.549379568245, 4098.364753463218, 5059.898802023976, 6195.628262304231, 6208.2239720034995, 6235.314115447297, 6249.156363890862, 5620.747066382022, 5621.437856214387, 5632.239647647597, 5644.3508996465525, 5645.520130788888, 6877.58734475933, 6900.308335040729, 6900.447964162855, 6912.135983002125, 6912.205096413926, 4308.944308644403, 4474.351219073249, 4500.0, 4517.6160026397465, 4588.678792484528, 7222.638868056629, 7257.201707812136, 7307.342339189446, 7310.305520975498, 7320.597367144805, 4569.634429245652, 4570.063137056895, 4572.268437050056, 4573.405457290597, 4587.655925805578, 4611.308303754464, 4616.722996620214, 4628.467726211529, 4647.883802904887, 4657.1617108920045, 5502.477264659851, 5517.227588137664, 5523.867607140526, 5525.944740552543, 5539.335279766454, 6648.16897887764, 6929.965350173317, 6940.618265995418, 7000.859982800315, 7014.614196219155, 1584.4612831637069, 1594.4180374163348, 1609.2436554819217, 1612.9193440394963, 1613.3304678558268, 1007.1539906478447, 1012.8987101289812, 1034.3276870034538, 1035.5236591168148, 1039.5166247694858, 5265.789368425297, 5285.339332583427, 6203.379662033851, 6417.550771446047, 6474.190726159136, 6933.653317334113, 7057.329553692391, 7130.215676275606, 7143.178534468499, 7144.749933752294, 6341.207349081365, 6345.07996340528, 6381.64900930444, 6425.903611445832, 6439.22729272481, 3757.868474603376, 3801.372773492398, 3806.6193380662266, 3808.638179372955, 3815.923681526354, 7195.424366050704, 7543.924560754323, 7546.320831125116, 7547.28300811422, 7550.0, 7417.962910185414, 7447.664855081534, 7454.776356709307, 7455.478116531899, 7465.06686664167, 6446.839568877647, 7233.819154521179, 7552.433567482351, 7553.244675532403, 7577.355924746458, 7214.531055481377, 7224.494285400182, 7234.348908598251, 7237.819054523679, 7238.0952380952385, 6827.556208846409, 7079.68141433647, 7097.645117744195, 7110.893336599852, 7139.678714457758, 7468.365188958999, 7513.924860751323, 7543.358814500829, 7559.508631938907, 7587.279208475186, 4699.624030077517, 4770.546798054179, 4775.856724298276, 4785.114753770564, 4793.161196790478, 7175.677094530654, 7178.0, 7181.928180718126, 7184.533005354635, 7202.423806095605, 5669.716514174357, 6673.366030227121, 6862.4853136014, 6951.895721564281, 6962.686679099352, 5786.884262314646, 5811.7214212873105, 6315.621062736251, 6708.966455167693, 6910.928806035073, 6743.662816859235, 6777.423918966746, 6777.762778302736, 6787.490938179755, 6805.353491418307, 6871.828204294733, 6923.584584924921, 6953.582785032711, 6953.826154346182, 6953.860922781617, 5493.945060549343, 5534.612577119563, 6520.902186467112, 6571.145751052524, 6796.864062718817], "unit": "score", "name": "prototype.html", "value": 5031.518697326197}, {"lowerIsBetter": false, "replicates": [595.1314663322784, 732.0922056649756, 737.4469148138896, 747.3199388556411, 803.3332334162645, 11907.0, 15453.45912893049, 15455.381784728612, 15464.613384665388, 15465.149416782073, 14224.146551206935, 14291.499797507064, 14299.356528956196, 14301.0, 14329.641758956031, 715.5885365914594, 734.7281505842845, 903.3541018172006, 924.1497822003772, 926.1201858234671, 912.9543522823832, 922.7923717163618, 924.117467818232, 924.3483344242327, 926.874871892296, 971.8639390485338, 973.0658567774944, 974.5468357213894, 975.1272611013139, 976.5703090640131, 763.9885401718951, 888.0453512474116, 907.3240435875249, 910.0990019880337, 968.6222373274429, 677.6848765324148, 677.8407074337526, 678.0744284052282, 680.2789043613785, 682.1575354437266, 15237.923810380988, 15276.236188190545, 15292.770608440882, 15323.31045102973, 15329.463468778651, 10044.698659040241, 12440.440180191914, 12600.936995315056, 12817.0, 12868.678283042906, 9973.96454408141, 10014.3490673106, 10112.0, 10316.896831031669, 10970.341779493176, 3466.739994500397, 3995.9400608990886, 4153.314703073989, 4293.699441039129, 4301.483821941387, 92064.53967730186, 93055.0, 93686.0, 94494.0, 94828.0, 9317.906820931705, 9483.668071617598, 9756.609735610497, 9808.362456440309, 9813.754656133511, 21384.358469245948, 21420.0, 21461.67807482889, 21495.677564836227, 21545.245916393163, 7372.410207183412, 7424.888626670604, 7438.66526006331, 7479.364254038468, 7509.849803004018, 3938.980305098456, 4016.8995775105273, 4059.2084543513733, 4158.8336466540995, 4160.812763425653, 3645.3802853514967, 3670.724695647837, 3675.761075530082, 3681.2821499807283, 3686.115332320224, 559.8992181407385, 638.3552611862053, 647.6535053746223, 648.7761722205831, 657.3328072006917, 527.0118527760449, 549.5191707256151, 550.8677917299899, 555.555555555554, 615.1633778061832, 7856.489328193649, 8073.596320183968, 8231.46495477792, 8375.288100511403, 8376.455530390505, 578.8668606220593, 582.7173820696959, 598.3687209993499, 603.4739454094292, 623.4139908486009, 3690.926181476409, 3860.1700634363747, 3868.6905047596124, 3895.3962135868987, 3929.390944403622, 92594.0, 92755.07244927599, 97163.51418242864, 98054.52918206232, 98183.50908245413, 80494.0, 80584.0, 80975.0, 81139.59430202929, 84615.0, 74572.0, 74935.0, 75042.62478687572, 75079.62460187664, 76088.61955690186, 7617.885731713918, 7637.694492220471, 7840.215978402114, 7939.0870049945, 8037.8392432152195, 48746.5125348742, 49607.0, 49765.253521196486, 49915.50084499108, 50856.491435085176, 70810.0, 73384.63307683427, 73386.0, 74477.0, 75277.0, 10021.248406369406, 10089.646862359783, 10237.18102551809, 10354.482275886025, 10623.681289561326, 11088.0, 11103.38931358783, 11255.606053788078, 11506.30962142274, 11997.700057498632, 10195.949020254851, 10592.993665601756, 10709.357438553712, 10777.568897244022, 10799.0, 10090.94954525252, 10252.38485690861, 10380.117689996436, 10402.58389664405, 11255.324680519196, 10155.847662284923, 10192.439415832201, 10234.6417875374, 10246.6413675521, 10547.156227501628, 8862.689805856764, 8898.55507224649, 9228.815423691623, 9229.769255768659, 9253.682308492613, 7917.445778795429, 8902.73291801247, 8907.554622268732, 8920.687775927812, 9116.726498205064], "unit": "score", "name": "yui.html", "value": 6874.026675328925}], "name": "dromaeo_css", "value": 7463.874394152395}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 110.0, 110.0, 112.0, 117.0, 112.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [159.0, 122.0, 144.0, 160.0, 118.0, 146.0, 165.0, 149.0, 172.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 145.5}, {"lowerIsBetter": true, "replicates": [186.0, 182.0, 183.0, 183.0, 183.0, 183.0, 184.0, 185.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.3}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 83.0, 80.0, 75.0, 74.0, 84.0, 114.0, 99.0, 57.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [89.0, 99.0, 131.0, 78.0, 80.0, 82.0, 114.0, 80.0, 80.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 95.1}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 87.0, 84.0, 86.0, 83.0, 87.0, 84.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.0}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 101.0, 141.0, 149.0, 104.0, 94.0, 92.0, 101.0], "unit": "score", "name": "imaging-darkroom", "value": 106.0}, {"lowerIsBetter": true, "replicates": [93.0, 85.0, 84.0, 84.0, 86.0, 85.0, 88.0, 83.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.7}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 54.0, 54.0, 55.0, 55.0, 53.0, 67.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 75.0, 75.0, 70.0, 69.0, 70.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [101.0, 110.0, 115.0, 85.0, 85.0, 83.0, 83.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.2}, {"lowerIsBetter": true, "replicates": [134.0, 135.0, 133.0, 137.0, 137.0, 136.0, 111.0, 122.0, 121.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.0}, {"lowerIsBetter": true, "replicates": [164.0, 175.0, 141.0, 139.0, 140.0, 179.0, 154.0, 139.0, 137.0, 178.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 89.0, 56.0, 60.0, 70.0, 94.0, 97.0, 98.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.7}], "name": "kraken", "value": 1470.3}]} 05:34:59 INFO - Return code: 0 05:34:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:34:59 ERROR - # TBPL SUCCESS # 05:34:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:34:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:34:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:34:59 INFO - 2016-03-26 05:34:59.981 screenresolution[1728:13211] starting screenresolution argv=screenresolution get 05:34:59 INFO - 2016-03-26 05:34:59.984 screenresolution[1728:13211] Display 0: 1600x1200x32@60 05:34:59 INFO - 2016-03-26 05:34:59.990 screenresolution[1729:13214] starting screenresolution argv=screenresolution list 05:34:59 INFO - Available Modes on Display 0 05:34:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:34:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:34:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:34:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:35:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:35:00 INFO - Intel Iris: 05:35:00 INFO - Chipset Model: Intel Iris 05:35:00 INFO - Type: GPU 05:35:00 INFO - Bus: Built-In 05:35:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:35:00 INFO - Vendor: Intel (0x8086) 05:35:00 INFO - Device ID: 0x0a2e 05:35:00 INFO - Revision ID: 0x0009 05:35:00 INFO - Displays: 05:35:00 INFO - Display: 05:35:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:35:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:35:00 INFO - Display Serial Number: 1600x1200 60 05:35:00 INFO - Main Display: Yes 05:35:00 INFO - Mirror: Off 05:35:00 INFO - Online: Yes 05:35:00 INFO - Rotation: Supported 05:35:00 INFO - Return code: 0 05:35:00 INFO - Running post-action listener: _resource_record_post_action 05:35:00 INFO - Running post-run listener: _resource_record_post_run 05:35:01 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34913792; Write bytes: 707271168; Read time: 371; Write time: 1906 05:35:01 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403218944; Write bytes: 405341696; Read time: 30114; Write time: 780 05:35:01 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 33132032; Write bytes: 301081600; Read time: 353; Write time: 1124 05:35:01 INFO - Running post-run listener: _upload_blobber_files 05:35:01 INFO - Blob upload gear active. 05:35:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:01 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 05:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:35:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:35:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:35:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:02 INFO - (blobuploader) - INFO - Done attempting. 05:35:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:35:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:35:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:03 INFO - (blobuploader) - INFO - Done attempting. 05:35:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:03 INFO - Return code: 0 05:35:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dab81192cd0ef44721321c0ec2eda37ca495cb1ba26bda2fbb69a73be4c43c6b1177d941ab743039623b4847570522e8ff6f2c8706480f87055d5b58c0aeb681", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab7d1564a33f55be2961b74e0106169366915aa42832bf09f223539854ac10404b9abbb91bbe727de7ca4a422e4e98f61d1b5d715ac2a369d6e2969f6bb8323"} 05:35:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:03 INFO - Contents: 05:35:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dab81192cd0ef44721321c0ec2eda37ca495cb1ba26bda2fbb69a73be4c43c6b1177d941ab743039623b4847570522e8ff6f2c8706480f87055d5b58c0aeb681", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab7d1564a33f55be2961b74e0106169366915aa42832bf09f223539854ac10404b9abbb91bbe727de7ca4a422e4e98f61d1b5d715ac2a369d6e2969f6bb8323"} 05:35:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:03 INFO - Copying logs to upload dir... 05:35:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.003715 ========= master_lag: 2.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-03-26 05:35:05.972724) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-26 05:35:05.976249) ========= 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.fMCqA1MayX/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.rg8iyV8cK8/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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/Firefox/sha512/dab81192cd0ef44721321c0ec2eda37ca495cb1ba26bda2fbb69a73be4c43c6b1177d941ab743039623b4847570522e8ff6f2c8706480f87055d5b58c0aeb681", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab7d1564a33f55be2961b74e0106169366915aa42832bf09f223539854ac10404b9abbb91bbe727de7ca4a422e4e98f61d1b5d715ac2a369d6e2969f6bb8323"} build_url:https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010432 build_url: 'https://queue.taskcluster.net/v1/task/eXNp6_gsR7SNzNwvA-IlKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dab81192cd0ef44721321c0ec2eda37ca495cb1ba26bda2fbb69a73be4c43c6b1177d941ab743039623b4847570522e8ff6f2c8706480f87055d5b58c0aeb681", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ab7d1564a33f55be2961b74e0106169366915aa42832bf09f223539854ac10404b9abbb91bbe727de7ca4a422e4e98f61d1b5d715ac2a369d6e2969f6bb8323"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-26 05:35:06.030915) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 05:35:06.031235) ========= 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.fMCqA1MayX/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.rg8iyV8cK8/Listeners TMPDIR=/var/folders/j1/s9lsnw715dxdjl4nwk5gg7qw00000w/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.005110 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-26 05:35:06.080745) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-26 05:35:06.081274) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-26 05:35:06.081992) ========= ========= Total master_lag: 2.45 =========