builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0017 starttime: 1454070823.19 results: success (0) buildid: 20160129024728 builduid: 68fcf99630844ff288d4a1f3b164ba05 revision: ac21d6f878e6fdd69ec4140d1b63a94601524abe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.187302) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.188071) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.188387) ========= 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.4vKhmkKmLw/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.7N4uONB5iB/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005498 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.248553) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.248864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.269732) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.270023) ========= 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.4vKhmkKmLw/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.7N4uONB5iB/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005587 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.371591) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.371894) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.372283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.372607) ========= 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.4vKhmkKmLw/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.7N4uONB5iB/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-01-29 04:33:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 108M=0s 2016-01-29 04:33:43 (108 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.572385 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.960180) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:43.960518) ========= 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.4vKhmkKmLw/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.7N4uONB5iB/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.025902 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:44.022811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:44.023154) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ac21d6f878e6fdd69ec4140d1b63a94601524abe --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 ac21d6f878e6fdd69ec4140d1b63a94601524abe --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4vKhmkKmLw/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.7N4uONB5iB/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-01-29 04:33:44,093 truncating revision to first 12 chars 2016-01-29 04:33:44,093 Setting DEBUG logging. 2016-01-29 04:33:44,094 attempt 1/10 2016-01-29 04:33:44,094 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ac21d6f878e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-29 04:33:44,749 unpacking tar archive at: mozilla-central-ac21d6f878e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.891931 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:44.933967) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:44.934616) ========= echo ac21d6f878e6fdd69ec4140d1b63a94601524abe in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ac21d6f878e6fdd69ec4140d1b63a94601524abe'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4vKhmkKmLw/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.7N4uONB5iB/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 ac21d6f878e6fdd69ec4140d1b63a94601524abe program finished with exit code 0 elapsedTime=0.005518 script_repo_revision: 'ac21d6f878e6fdd69ec4140d1b63a94601524abe' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:44.992083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:44.992522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 04:33:45.016283) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-29 04:33:45.016590) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.4vKhmkKmLw/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.7N4uONB5iB/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:33:45 INFO - MultiFileLogger online at 20160129 04:33:45 in /builds/slave/test 04:33:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:33:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:45 INFO - {'append_to_log': False, 04:33:45 INFO - 'base_work_dir': '/builds/slave/test', 04:33:45 INFO - 'blob_upload_branch': 'Firefox', 04:33:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:45 INFO - 'branch': 'Firefox', 04:33:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:45 INFO - 'config_files': ('talos/mac_config.py',), 04:33:45 INFO - 'default_actions': ('clobber', 04:33:45 INFO - 'read-buildbot-config', 04:33:45 INFO - 'download-and-extract', 04:33:45 INFO - 'populate-webroot', 04:33:45 INFO - 'create-virtualenv', 04:33:45 INFO - 'install', 04:33:45 INFO - 'run-tests'), 04:33:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:45 INFO - 'download_minidump_stackwalk': True, 04:33:45 INFO - 'download_symbols': 'ondemand', 04:33:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:45 INFO - 'installer_path': 'installer.exe', 04:33:45 INFO - 'log_level': 'info', 04:33:45 INFO - 'log_name': 'talos', 04:33:45 INFO - 'log_to_console': True, 04:33:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:33:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:33:45 INFO - 'opt_config_files': (), 04:33:45 INFO - 'pip_index': False, 04:33:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:33:45 INFO - 'cmd': ('bash', 04:33:45 INFO - '-c', 04:33:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:33:45 INFO - 'enabled': True, 04:33:45 INFO - 'halt_on_failure': False, 04:33:45 INFO - 'name': 'check_screen_resolution'},), 04:33:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:33:45 INFO - 'cmd': ('bash', 04:33:45 INFO - '-c', 04:33:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:33:45 INFO - 'enabled': True, 04:33:45 INFO - 'halt_on_failure': False, 04:33:45 INFO - 'name': 'check_screen_resolution'},), 04:33:45 INFO - 'run_cmd_checks_enabled': True, 04:33:45 INFO - 'sps_profile': False, 04:33:45 INFO - 'sps_profile_interval': 0, 04:33:45 INFO - 'suite': 'dromaeojs-e10s', 04:33:45 INFO - 'system_bits': '32', 04:33:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:45 INFO - 'title': 't-yosemite-r7-0017', 04:33:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:45 INFO - 'use_talos_json': True, 04:33:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:45 INFO - 'work_dir': 'build'} 04:33:45 INFO - ##### 04:33:45 INFO - ##### Running clobber step. 04:33:45 INFO - ##### 04:33:45 INFO - Running pre-action listener: _resource_record_pre_action 04:33:45 INFO - Running main action method: clobber 04:33:45 INFO - rmtree: /builds/slave/test/build 04:33:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:46 INFO - Running post-action listener: _resource_record_post_action 04:33:46 INFO - ##### 04:33:46 INFO - ##### Running read-buildbot-config step. 04:33:46 INFO - ##### 04:33:46 INFO - Running pre-action listener: _resource_record_pre_action 04:33:46 INFO - Running main action method: read_buildbot_config 04:33:46 INFO - Using buildbot properties: 04:33:46 INFO - { 04:33:46 INFO - "project": "", 04:33:46 INFO - "product": "firefox", 04:33:46 INFO - "script_repo_revision": "production", 04:33:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:33:46 INFO - "repository": "", 04:33:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:33:46 INFO - "buildid": "20160129024728", 04:33:46 INFO - "pgo_build": "False", 04:33:46 INFO - "basedir": "/builds/slave/test", 04:33:46 INFO - "buildnumber": 110, 04:33:46 INFO - "slavename": "t-yosemite-r7-0017", 04:33:46 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:33:46 INFO - "platform": "yosemite_r7", 04:33:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:33:46 INFO - "branch": "mozilla-central", 04:33:46 INFO - "repo_path": "mozilla-central", 04:33:46 INFO - "revision": "ac21d6f878e6fdd69ec4140d1b63a94601524abe", 04:33:46 INFO - "stage_platform": "macosx64", 04:33:46 INFO - "builduid": "68fcf99630844ff288d4a1f3b164ba05", 04:33:46 INFO - "slavebuilddir": "test" 04:33:46 INFO - } 04:33:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:33:46 INFO - Running post-action listener: _resource_record_post_action 04:33:46 INFO - ##### 04:33:46 INFO - ##### Running download-and-extract step. 04:33:46 INFO - ##### 04:33:46 INFO - Running pre-action listener: _resource_record_pre_action 04:33:46 INFO - Running main action method: download_and_extract 04:33:46 INFO - mkdir: /builds/slave/test/build/tests 04:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:46 INFO - https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:33:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/test_packages.json 04:33:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/test_packages.json 04:33:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:33:53 INFO - Downloaded 1277 bytes. 04:33:53 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:33:53 INFO - Using the following test package requirements: 04:33:53 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:33:53 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:33:53 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:33:53 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:33:53 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:33:53 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:33:53 INFO - u'jsshell-mac.zip'], 04:33:53 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:33:53 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:33:53 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:33:53 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:33:53 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:33:53 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:33:53 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:33:53 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:33:53 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:33:53 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:33:53 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:33:53 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:33:53 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:33:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:53 INFO - https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:33:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:33:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:33:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:33:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:33:58 INFO - Downloaded 16722337 bytes. 04:33:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:33:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:34:01 INFO - Return code: 0 04:34:01 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:34:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:01 INFO - https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:34:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:34:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:34:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:34:04 INFO - Downloaded 16722337 bytes. 04:34:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:34:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:34:08 INFO - Return code: 0 04:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:08 INFO - https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:34:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:34:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:34:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:34:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:34:09 INFO - Downloaded 10706582 bytes. 04:34:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:34:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:34:09 INFO - Return code: 0 04:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:09 INFO - https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:34:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:34:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:34:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:34:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:34:15 INFO - Downloaded 111023019 bytes. 04:34:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:34:15 INFO - mkdir: /builds/slave/test/properties 04:34:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:15 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:15 INFO - Contents: 04:34:15 INFO - build_url:https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:34:15 INFO - Running post-action listener: _resource_record_post_action 04:34:15 INFO - Running post-action listener: set_extra_try_arguments 04:34:15 INFO - ##### 04:34:15 INFO - ##### Running populate-webroot step. 04:34:15 INFO - ##### 04:34:15 INFO - Running pre-action listener: _resource_record_pre_action 04:34:15 INFO - Running main action method: populate_webroot 04:34:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:15 INFO - '--tppagecycles', 04:34:15 INFO - '7'], 04:34:15 INFO - 'tests': ['tsvgm']}}, 04:34:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:34:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:34:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:34:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:34:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:15 INFO - 'talos_options': ['--e10s'], 04:34:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:15 INFO - 'tests': ['damp', 'tps']}, 04:34:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:15 INFO - 'talos_options': ['--e10s'], 04:34:15 INFO - 'tests': ['damp', 'tps']}, 04:34:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:34:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:15 INFO - 'other': {'tests': ['a11yr', 04:34:15 INFO - 'ts_paint', 04:34:15 INFO - 'tpaint', 04:34:15 INFO - 'sessionrestore', 04:34:15 INFO - 'sessionrestore_no_auto_restore']}, 04:34:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:34:15 INFO - 'tests': ['a11yr', 04:34:15 INFO - 'ts_paint', 04:34:15 INFO - 'tpaint', 04:34:15 INFO - 'sessionrestore', 04:34:15 INFO - 'sessionrestore_no_auto_restore']}, 04:34:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:34:15 INFO - 'tests': ['a11yr', 04:34:15 INFO - 'ts_paint', 04:34:15 INFO - 'tpaint', 04:34:15 INFO - 'sessionrestore', 04:34:15 INFO - 'sessionrestore_no_auto_restore']}, 04:34:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:34:15 INFO - 'tests': ['a11yr', 04:34:15 INFO - 'ts_paint', 04:34:15 INFO - 'tpaint', 04:34:15 INFO - 'sessionrestore', 04:34:15 INFO - 'sessionrestore_no_auto_restore']}, 04:34:15 INFO - 'other_l64': {'tests': ['a11yr', 04:34:15 INFO - 'ts_paint', 04:34:15 INFO - 'tpaint', 04:34:15 INFO - 'sessionrestore', 04:34:15 INFO - 'sessionrestore_no_auto_restore']}, 04:34:15 INFO - 'other_nol64': {'tests': ['a11yr', 04:34:15 INFO - 'ts_paint', 04:34:15 INFO - 'tpaint', 04:34:15 INFO - 'sessionrestore', 04:34:15 INFO - 'sessionrestore_no_auto_restore']}, 04:34:15 INFO - 'svgr': {'tests': ['tsvgx', 04:34:15 INFO - 'tsvgr_opacity', 04:34:15 INFO - 'tart', 04:34:15 INFO - 'tscrollx', 04:34:15 INFO - 'cart']}, 04:34:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:34:15 INFO - 'tests': ['tsvgx', 04:34:15 INFO - 'tsvgr_opacity', 04:34:15 INFO - 'tart', 04:34:15 INFO - 'tscrollx', 04:34:15 INFO - 'cart']}, 04:34:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:15 INFO - 'tests': ['tp5o']}, 04:34:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:15 INFO - 'talos_options': ['--e10s'], 04:34:15 INFO - 'tests': ['tp5o']}, 04:34:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:15 INFO - 'talos_options': ['--xperf_path', 04:34:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:15 INFO - 'tests': ['tp5n']}, 04:34:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:15 INFO - 'talos_options': ['--e10s', 04:34:15 INFO - '--xperf_path', 04:34:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:15 INFO - 'tests': ['tp5n']}}, 04:34:15 INFO - 'talos.zip': {'path': '', 04:34:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:15 INFO - Running post-action listener: _resource_record_post_action 04:34:15 INFO - ##### 04:34:15 INFO - ##### Running create-virtualenv step. 04:34:15 INFO - ##### 04:34:15 INFO - Running pre-action listener: _resource_record_pre_action 04:34:15 INFO - Running main action method: create_virtualenv 04:34:15 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:34:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:15 INFO - Using real prefix '/tools/python27' 04:34:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:18 INFO - Installing pip.................done. 04:34:18 INFO - Return code: 0 04:34:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:18 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 0x1035fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f53db0580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a2d30>, '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 0x103305db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498b20>, '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.4vKhmkKmLw/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.7N4uONB5iB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:34:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:34:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4vKhmkKmLw/Render', 04:34:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:18 INFO - 'HOME': '/Users/cltbld', 04:34:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:18 INFO - 'LOGNAME': 'cltbld', 04:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:18 INFO - 'MOZ_NO_REMOTE': '1', 04:34:18 INFO - 'NO_EM_RESTART': '1', 04:34:18 INFO - 'PAGER': '/bin/cat', 04:34:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:18 INFO - 'PWD': '/builds/slave/test', 04:34:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:18 INFO - 'SHELL': '/bin/bash', 04:34:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7N4uONB5iB/Listeners', 04:34:18 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 04:34:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:18 INFO - 'USER': 'cltbld', 04:34:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:18 INFO - 'XPC_FLAGS': '0x0', 04:34:18 INFO - 'XPC_SERVICE_NAME': '0', 04:34:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:34:19 INFO - Cleaning up... 04:34:19 INFO - Return code: 0 04:34:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:19 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 0x1035fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f53db0580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a2d30>, '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 0x103305db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498b20>, '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.4vKhmkKmLw/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.7N4uONB5iB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4vKhmkKmLw/Render', 04:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:19 INFO - 'HOME': '/Users/cltbld', 04:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:19 INFO - 'LOGNAME': 'cltbld', 04:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:19 INFO - 'MOZ_NO_REMOTE': '1', 04:34:19 INFO - 'NO_EM_RESTART': '1', 04:34:19 INFO - 'PAGER': '/bin/cat', 04:34:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:19 INFO - 'PWD': '/builds/slave/test', 04:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:19 INFO - 'SHELL': '/bin/bash', 04:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7N4uONB5iB/Listeners', 04:34:19 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 04:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:19 INFO - 'USER': 'cltbld', 04:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:19 INFO - 'XPC_FLAGS': '0x0', 04:34:19 INFO - 'XPC_SERVICE_NAME': '0', 04:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:19 INFO - Downloading/unpacking psutil>=0.7.1 04:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:22 INFO - Installing collected packages: psutil 04:34:22 INFO - Running setup.py install for psutil 04:34:22 INFO - building 'psutil._psutil_osx' extension 04:34:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:34:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:34:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:34:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:34:23 INFO - building 'psutil._psutil_posix' extension 04:34:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:34:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:34:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:34:23 INFO - ^ 04:34:23 INFO - 1 warning generated. 04:34:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:34:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:23 INFO - Successfully installed psutil 04:34:23 INFO - Cleaning up... 04:34:23 INFO - Return code: 0 04:34:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:23 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 0x1035fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f53db0580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a2d30>, '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 0x103305db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498b20>, '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.4vKhmkKmLw/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.7N4uONB5iB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4vKhmkKmLw/Render', 04:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:23 INFO - 'HOME': '/Users/cltbld', 04:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:23 INFO - 'LOGNAME': 'cltbld', 04:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:23 INFO - 'MOZ_NO_REMOTE': '1', 04:34:23 INFO - 'NO_EM_RESTART': '1', 04:34:23 INFO - 'PAGER': '/bin/cat', 04:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:23 INFO - 'PWD': '/builds/slave/test', 04:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:23 INFO - 'SHELL': '/bin/bash', 04:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7N4uONB5iB/Listeners', 04:34:23 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 04:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:23 INFO - 'USER': 'cltbld', 04:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:23 INFO - 'XPC_FLAGS': '0x0', 04:34:23 INFO - 'XPC_SERVICE_NAME': '0', 04:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:34:26 INFO - Installing collected packages: mozsystemmonitor 04:34:26 INFO - Running setup.py install for mozsystemmonitor 04:34:26 INFO - Successfully installed mozsystemmonitor 04:34:26 INFO - Cleaning up... 04:34:26 INFO - Return code: 0 04:34:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:26 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 0x1035fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f53db0580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a2d30>, '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 0x103305db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498b20>, '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.4vKhmkKmLw/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.7N4uONB5iB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4vKhmkKmLw/Render', 04:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:26 INFO - 'HOME': '/Users/cltbld', 04:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:26 INFO - 'LOGNAME': 'cltbld', 04:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:26 INFO - 'MOZ_NO_REMOTE': '1', 04:34:26 INFO - 'NO_EM_RESTART': '1', 04:34:26 INFO - 'PAGER': '/bin/cat', 04:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:26 INFO - 'PWD': '/builds/slave/test', 04:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:26 INFO - 'SHELL': '/bin/bash', 04:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7N4uONB5iB/Listeners', 04:34:26 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 04:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:26 INFO - 'USER': 'cltbld', 04:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:26 INFO - 'XPC_FLAGS': '0x0', 04:34:26 INFO - 'XPC_SERVICE_NAME': '0', 04:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:29 INFO - Downloading docopt-0.6.1.tar.gz 04:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:30 INFO - Running setup.py install for blobuploader 04:34:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:30 INFO - Running setup.py install for requests 04:34:30 INFO - Running setup.py install for docopt 04:34:30 INFO - Successfully installed blobuploader requests docopt 04:34:30 INFO - Cleaning up... 04:34:30 INFO - Return code: 0 04:34:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34: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')]} 04:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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')]} 04:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:30 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 0x1035fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f53db0580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a2d30>, '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 0x103305db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498b20>, '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.4vKhmkKmLw/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.7N4uONB5iB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:34:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4vKhmkKmLw/Render', 04:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:30 INFO - 'HOME': '/Users/cltbld', 04:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:30 INFO - 'LOGNAME': 'cltbld', 04:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:30 INFO - 'MOZ_NO_REMOTE': '1', 04:34:30 INFO - 'NO_EM_RESTART': '1', 04:34:30 INFO - 'PAGER': '/bin/cat', 04:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:30 INFO - 'PWD': '/builds/slave/test', 04:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:30 INFO - 'SHELL': '/bin/bash', 04:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7N4uONB5iB/Listeners', 04:34:30 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 04:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:30 INFO - 'USER': 'cltbld', 04:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:30 INFO - 'XPC_FLAGS': '0x0', 04:34:30 INFO - 'XPC_SERVICE_NAME': '0', 04:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:31 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-CfojVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:31 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-XV7oZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:31 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-T4hpdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:31 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-2_p6hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:31 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-J0MwWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:31 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-0_y6uB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:31 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-U5k8Jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:31 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-1MetJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-vFvQSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Wrxy28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-vrFNUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-zaiUA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-eDhqvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-IRc3JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-S6uYos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-11Wi2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:32 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-8yxRz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:33 INFO - Running setup.py install for manifestparser 04:34:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:33 INFO - Running setup.py install for mozcrash 04:34:33 INFO - Running setup.py install for mozdebug 04:34:33 INFO - Running setup.py install for mozdevice 04:34:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:34:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:33 INFO - Running setup.py install for mozfile 04:34:33 INFO - Running setup.py install for mozhttpd 04:34:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:33 INFO - Running setup.py install for mozinfo 04:34:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for mozInstall 04:34:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for mozleak 04:34:34 INFO - Running setup.py install for mozlog 04:34:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for moznetwork 04:34:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for mozprocess 04:34:34 INFO - Running setup.py install for mozprofile 04:34:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for mozrunner 04:34:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:35 INFO - Running setup.py install for mozscreenshot 04:34:35 INFO - Running setup.py install for moztest 04:34:35 INFO - Running setup.py install for mozversion 04:34:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:35 INFO - Cleaning up... 04:34:35 INFO - Return code: 0 04:34:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:35 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 0x1035fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f53db0580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a2d30>, '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 0x103305db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498b20>, '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.4vKhmkKmLw/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.7N4uONB5iB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:34:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4vKhmkKmLw/Render', 04:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:35 INFO - 'HOME': '/Users/cltbld', 04:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:35 INFO - 'LOGNAME': 'cltbld', 04:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:35 INFO - 'MOZ_NO_REMOTE': '1', 04:34:35 INFO - 'NO_EM_RESTART': '1', 04:34:35 INFO - 'PAGER': '/bin/cat', 04:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:35 INFO - 'PWD': '/builds/slave/test', 04:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:35 INFO - 'SHELL': '/bin/bash', 04:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7N4uONB5iB/Listeners', 04:34:35 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 04:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:35 INFO - 'USER': 'cltbld', 04:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:35 INFO - 'XPC_FLAGS': '0x0', 04:34:35 INFO - 'XPC_SERVICE_NAME': '0', 04:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:35 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-jj2GxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:35 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-3j0AQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:36 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-7M7rJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:36 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-dt8PI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:36 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-7paKQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:36 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-2dGJ7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:36 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-mXC6qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:36 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-oEBl1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:36 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-wGONYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:36 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-8sKswk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:36 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-H4JtSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-mLXX9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-eyzSml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-z4Am23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-eRZlt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-ssh49K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:37 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-ow_Zu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:34:37 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:37 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:34:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:39 INFO - Downloading blessings-1.6.tar.gz 04:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:34:39 INFO - Installing collected packages: blessings 04:34:39 INFO - Running setup.py install for blessings 04:34:40 INFO - Successfully installed blessings 04:34:40 INFO - Cleaning up... 04:34:40 INFO - Return code: 0 04:34:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:34:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:40 INFO - Reading from file tmpfile_stdout 04:34:40 INFO - Current package versions: 04:34:40 INFO - blessings == 1.6 04:34:40 INFO - blobuploader == 1.2.4 04:34:40 INFO - docopt == 0.6.1 04:34:40 INFO - manifestparser == 1.1 04:34:40 INFO - mozInstall == 1.12 04:34:40 INFO - mozcrash == 0.16 04:34:40 INFO - mozdebug == 0.1 04:34:40 INFO - mozdevice == 0.48 04:34:40 INFO - mozfile == 1.2 04:34:40 INFO - mozhttpd == 0.7 04:34:40 INFO - mozinfo == 0.9 04:34:40 INFO - mozleak == 0.1 04:34:40 INFO - mozlog == 3.1 04:34:40 INFO - moznetwork == 0.27 04:34:40 INFO - mozprocess == 0.22 04:34:40 INFO - mozprofile == 0.28 04:34:40 INFO - mozrunner == 6.11 04:34:40 INFO - mozscreenshot == 0.1 04:34:40 INFO - mozsystemmonitor == 0.0 04:34:40 INFO - moztest == 0.7 04:34:40 INFO - mozversion == 1.4 04:34:40 INFO - psutil == 3.1.1 04:34:40 INFO - requests == 1.2.3 04:34:40 INFO - wsgiref == 0.1.2 04:34:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:40 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 0x1035fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f53db0580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a2d30>, '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 0x103305db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498b20>, '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.4vKhmkKmLw/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.7N4uONB5iB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4vKhmkKmLw/Render', 04:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:40 INFO - 'HOME': '/Users/cltbld', 04:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:40 INFO - 'LOGNAME': 'cltbld', 04:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:40 INFO - 'MOZ_NO_REMOTE': '1', 04:34:40 INFO - 'NO_EM_RESTART': '1', 04:34:40 INFO - 'PAGER': '/bin/cat', 04:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:40 INFO - 'PWD': '/builds/slave/test', 04:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:40 INFO - 'SHELL': '/bin/bash', 04:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7N4uONB5iB/Listeners', 04:34:40 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 04:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:40 INFO - 'USER': 'cltbld', 04:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:40 INFO - 'XPC_FLAGS': '0x0', 04:34:40 INFO - 'XPC_SERVICE_NAME': '0', 04:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:34:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:34:40 INFO - Cleaning up... 04:34:40 INFO - Return code: 0 04:34:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f53db0580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a2d30>, '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 0x103305db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498b20>, '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.4vKhmkKmLw/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.7N4uONB5iB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4vKhmkKmLw/Render', 04:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:40 INFO - 'HOME': '/Users/cltbld', 04:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:40 INFO - 'LOGNAME': 'cltbld', 04:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:40 INFO - 'MOZ_NO_REMOTE': '1', 04:34:40 INFO - 'NO_EM_RESTART': '1', 04:34:40 INFO - 'PAGER': '/bin/cat', 04:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:40 INFO - 'PWD': '/builds/slave/test', 04:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:40 INFO - 'SHELL': '/bin/bash', 04:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7N4uONB5iB/Listeners', 04:34:40 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 04:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:40 INFO - 'USER': 'cltbld', 04:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:40 INFO - 'XPC_FLAGS': '0x0', 04:34:40 INFO - 'XPC_SERVICE_NAME': '0', 04:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:41 INFO - Downloading/unpacking jsonschema 04:34: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 04:34: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 04:34: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 04:34: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 04:34: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 04:34: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 04:34:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:43 INFO - Downloading/unpacking functools32 (from jsonschema) 04:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:43 INFO - warning: no files found matching '*.txt' 04:34:43 INFO - no previously-included directories found matching 'build' 04:34:43 INFO - no previously-included directories found matching 'dist' 04:34:43 INFO - no previously-included directories found matching '.git*' 04:34:43 INFO - Installing collected packages: jsonschema, functools32 04:34:43 INFO - Running setup.py install for functools32 04:34:43 INFO - warning: no files found matching '*.txt' 04:34:43 INFO - no previously-included directories found matching 'build' 04:34:43 INFO - no previously-included directories found matching 'dist' 04:34:43 INFO - no previously-included directories found matching '.git*' 04:34:43 INFO - Successfully installed jsonschema functools32 04:34:43 INFO - Cleaning up... 04:34:43 INFO - Return code: 0 04:34:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:43 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 0x1035fda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036044c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f53db0580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034a2d30>, '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 0x103305db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498b20>, '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.4vKhmkKmLw/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.7N4uONB5iB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:34:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4vKhmkKmLw/Render', 04:34:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:43 INFO - 'HOME': '/Users/cltbld', 04:34:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:43 INFO - 'LOGNAME': 'cltbld', 04:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:43 INFO - 'MOZ_NO_REMOTE': '1', 04:34:43 INFO - 'NO_EM_RESTART': '1', 04:34:43 INFO - 'PAGER': '/bin/cat', 04:34:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:43 INFO - 'PWD': '/builds/slave/test', 04:34:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:43 INFO - 'SHELL': '/bin/bash', 04:34:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7N4uONB5iB/Listeners', 04:34:43 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 04:34:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:43 INFO - 'USER': 'cltbld', 04:34:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:43 INFO - 'XPC_FLAGS': '0x0', 04:34:43 INFO - 'XPC_SERVICE_NAME': '0', 04:34:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:44 INFO - Downloading/unpacking flake8 04:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:34:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:34:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:34: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 04:34: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 04:34: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 04:34: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 04:34: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 04:34: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 04:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:34:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:34:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:34:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:34:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:34:47 INFO - no previously-included directories found matching 'docs/_build' 04:34:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:34:47 INFO - Running setup.py install for pep8 04:34:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:34:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:34:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:34:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:34:47 INFO - no previously-included directories found matching 'docs/_build' 04:34:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:34:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:34:47 INFO - Cleaning up... 04:34:47 INFO - Return code: 0 04:34:47 INFO - Running post-action listener: _resource_record_post_action 04:34:47 INFO - Running post-action listener: _start_resource_monitoring 04:34:47 INFO - Starting resource monitoring. 04:34:47 INFO - ##### 04:34:47 INFO - ##### Running install step. 04:34:47 INFO - ##### 04:34:47 INFO - Running pre-action listener: _resource_record_pre_action 04:34:47 INFO - Running main action method: install 04:34:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:48 INFO - Reading from file tmpfile_stdout 04:34:48 INFO - Detecting whether we're running mozinstall >=1.0... 04:34:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:34:48 INFO - Reading from file tmpfile_stdout 04:34:48 INFO - Output received: 04:34:48 INFO - Usage: mozinstall [options] installer 04:34:48 INFO - Options: 04:34:48 INFO - -h, --help show this help message and exit 04:34:48 INFO - -d DEST, --destination=DEST 04:34:48 INFO - Directory to install application into. [default: 04:34:48 INFO - "/builds/slave/test"] 04:34:48 INFO - --app=APP Application being installed. [default: firefox] 04:34:48 INFO - mkdir: /builds/slave/test/build/application 04:34:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:34:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:35:22 INFO - Reading from file tmpfile_stdout 04:35:22 INFO - Output received: 04:35:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:35:22 INFO - Running post-action listener: _resource_record_post_action 04:35:22 INFO - ##### 04:35:22 INFO - ##### Running run-tests step. 04:35:22 INFO - ##### 04:35:22 INFO - Running pre-action listener: _resource_record_pre_action 04:35:22 INFO - Running main action method: run_tests 04:35:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:35:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:35:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:35:22 INFO - 2016-01-29 04:35:22.776 screenresolution[1660:8094] starting screenresolution argv=screenresolution get 04:35:22 INFO - 2016-01-29 04:35:22.778 screenresolution[1660:8094] Display 0: 1600x1200x32@50 04:35:22 INFO - 2016-01-29 04:35:22.784 screenresolution[1661:8098] starting screenresolution argv=screenresolution list 04:35:22 INFO - Available Modes on Display 0 04:35:22 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 04:35:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:35:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:35:22 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 04:35:22 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 04:35:23 INFO - Graphics/Displays: 04:35:23 INFO - Intel Iris: 04:35:23 INFO - Chipset Model: Intel Iris 04:35:23 INFO - Type: GPU 04:35:23 INFO - Bus: Built-In 04:35:23 INFO - VRAM (Dynamic, Max): 1536 MB 04:35:23 INFO - Vendor: Intel (0x8086) 04:35:23 INFO - Device ID: 0x0a2e 04:35:23 INFO - Revision ID: 0x0009 04:35:23 INFO - Displays: 04:35:23 INFO - Display: 04:35:23 INFO - Resolution: 1600 x 1200 @ 50 Hz 04:35:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:35:23 INFO - Display Serial Number: 1600x1200 50 04:35:23 INFO - Main Display: Yes 04:35:23 INFO - Mirror: Off 04:35:23 INFO - Online: Yes 04:35:23 INFO - Rotation: Supported 04:35:23 INFO - Return code: 0 04:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:35:23 INFO - Python 2.7.3 04:35:23 INFO - Return code: 0 04:35:23 INFO - grabbing minidump binary from tooltool 04:35:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:35:23 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 0x1034a2d30>, '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 0x103305db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103498b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:35:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:35:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:35:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:35:23 INFO - Return code: 0 04:35:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:35:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:35:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:35:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:35:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:35:24 INFO - Return code: 0 04:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4vKhmkKmLw/Render', 04:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:24 INFO - 'HOME': '/Users/cltbld', 04:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:24 INFO - 'LOGNAME': 'cltbld', 04:35:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:35:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:24 INFO - 'MOZ_NO_REMOTE': '1', 04:35:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:35:24 INFO - 'NO_EM_RESTART': '1', 04:35:24 INFO - 'PAGER': '/bin/cat', 04:35:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:24 INFO - 'PWD': '/builds/slave/test', 04:35:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:24 INFO - 'SHELL': '/bin/bash', 04:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7N4uONB5iB/Listeners', 04:35:24 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 04:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:24 INFO - 'USER': 'cltbld', 04:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:24 INFO - 'XPC_FLAGS': '0x0', 04:35:24 INFO - 'XPC_SERVICE_NAME': '0', 04:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:35:24 INFO - mozversion application_buildid: 20160129024728 04:35:24 INFO - mozversion application_changeset: ac21d6f878e6fdd69ec4140d1b63a94601524abe 04:35:24 INFO - mozversion application_display_name: Nightly 04:35:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:35:24 INFO - mozversion application_name: Firefox 04:35:24 INFO - mozversion application_remotingname: firefox 04:35:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:35:24 INFO - mozversion application_vendor: Mozilla 04:35:24 INFO - mozversion application_version: 47.0a1 04:35:24 INFO - mozversion platform_buildid: 20160129024728 04:35:24 INFO - mozversion platform_changeset: ac21d6f878e6fdd69ec4140d1b63a94601524abe 04:35:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:35:24 INFO - mozversion platform_version: 47.0a1 04:35:24 INFO - using testdate: 1454070924 04:35:24 INFO - actual date: 1454070924 04:35:24 INFO - starting webserver on 'localhost:49287' 04:35:24 INFO - SUITE-START | Running 2 tests 04:35:24 INFO - TEST-START | dromaeo_css 04:35:24 INFO - operating with platform_type : mac_ 04:35:24 INFO - Initialising browser for dromaeo_css test... 04:35:24 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmp2s4GDj/profile http://localhost:49287/getInfo.html) 04:35:28 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 04:35:28 INFO - PROCESS | 1679 | colorDepth:24 04:35:28 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 04:35:28 INFO - PROCESS | 1679 | __metrics 04:35:28 INFO - PROCESS | 1679 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:35:28 INFO - TEST-INFO | 1679: exit 0 04:35:28 INFO - Browser initialized. 04:35:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:35:28 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmp2s4GDj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:40 INFO - PROCESS | 1684 | RSS: Main: 255037440 04:35:40 INFO - PROCESS | 1684 | 04:36:30 INFO - PROCESS | 1684 | 1454070990599 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:38:41 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49287/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49287/tests/dromaeo/cssquery-ext.html) 04:38:42 INFO - PROCESS | 1684 | RSS: Main: 269996032 04:38:42 INFO - PROCESS | 1684 | 04:41:44 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49287/tests/dromaeo/cssquery-ext.html (next: http://localhost:49287/tests/dromaeo/cssquery-jquery.html) 04:41:45 INFO - PROCESS | 1684 | RSS: Main: 282238976 04:41:45 INFO - PROCESS | 1684 | 04:44:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49287/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49287/tests/dromaeo/cssquery-mootools.html) 04:44:47 INFO - PROCESS | 1684 | RSS: Main: 283496448 04:44:47 INFO - PROCESS | 1684 | 04:47:49 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49287/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49287/tests/dromaeo/cssquery-prototype.html) 04:47:49 INFO - PROCESS | 1684 | RSS: Main: 285356032 04:47:49 INFO - PROCESS | 1684 | 04:50:52 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49287/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49287/tests/dromaeo/cssquery-yui.html) 04:50:53 INFO - PROCESS | 1684 | RSS: Main: 288894976 04:50:53 INFO - PROCESS | 1684 | 04:53:55 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49287/tests/dromaeo/cssquery-yui.html (next: http://localhost:49287/tests/dromaeo/cssquery-dojo.html) 04:53:55 INFO - PROCESS | 1684 | RSS: Main: 289882112 04:53:55 INFO - PROCESS | 1684 | 04:53:55 INFO - PROCESS | 1684 | __start_tp_report 04:53:55 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 04:53:55 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 04:53:55 INFO - PROCESS | 1684 | |i|pagename|runs| 04:53:55 INFO - PROCESS | 1684 | |0;dojo.html;3358.4794356874686;3532.7527073104893;3566.982165089174;3596.4425514045333;3597;5741.598088133827;5787.305523337205;5804.796832110877;5811.506021988131;5816.505597024258;4551.317302404633;5708.1437784332375;5747.856303592413;5775.075987841946;5826.475617194462;5138.614603904722;5180.119379705449;5202.687838729669;5225.085610018251;5289.471052894718;5274.26160337553;5276.841694749144;5295.0468915595175;5329.094054010808;5358.276632654581;5085.491450854922;5109.156989096795;5157.381114266274;5196.064708352514;5223.608229382811;5191.22131680251;5200.193969934666;5205.063088644042;5214.009338225725;5240;5149.176131818891;5186.222066690027;5212.895742085175;5229.581633469314;5233.241180028875;4853.150698627726;5423.023855705971;5621.831345059655;5641.802536911229;5733.140028995643;5144.665596736238;5477.877035207773;6042.305134909454;6208.813735587894;6256.343083976162;5685.971570142165;6270.341614130496;6275.811725648238;6281.748730050793;6295.968520157416;5399.919001214985;5874.23634927461;5890.499307558863;5994.880102397928;6034;6250.62416362077;6276;6293.056041593798;6293.213348331458;6316.905246421307;6062.484688801413;6161.41466560685;6181.721822517998;6193.411625895533;6199.442050215503;6105.511559075263;6143.911070236141;6210.5652604317265;6224.688765561704;6253.5622506425025;6064.575479716377;6135.815925522242;6142.877142457126;6160.537959653044;6161.507079433634;6112.358202388774;6116.061877111602;6151.292601350812;6224.844378890564;6248.218972628421;4905.607551395879;4942.703437793743;4943.3573635427165;4950.628702847229;5002.624803139779;4453.732776033448;4453.886528367908;4462.754548499799;4466.307722302983;4496.865094047183;5683.77264909399;5784.074548072288;5849.736761845727;5863.912041319383;5883;6207.379262073847;6212.627242365382;6213.937860621336;6217.906731399033;6218.22272215973;4657.441107067174;5812.59311848175;5854.2096816930025;5857.238558987305;5866.178734977107;5355.946440535623;5375.946240537544;5399;5424.83725488236;5480.671159730349;6305.180326557518;6351.301356850743;6351.491880649444;6361.427471527585;6365.077063825812;6249.312575616587;6259.906101408392;6267.6866156692895;6289.119523266655;6294.590851594632;5969.582129250911;6167.876642467036;6267.937320626917;6293.779717709858;6329.30377658448;6179.907301390393;6218.129461875432;6234.314225435289;6236.220472440945;6239.376062393724;6111.135969295249;6285.120083188449;6304.401081897213;6306.842328941813;6327.746890124344;5453.909218156464;6126.785562505291;6140.20177376956;6217.813465596039;6278.215223097113;4837.612990960785;6172.5679202457195;6177.4749146323065;6188.628682279078;6206.348333424925;4970;5785.247917770663;5867.765289388547;6041.577089603861;6068.241469816273;6143.047827586731;6158.291796443287;6196.256449226122;6213.782517611862;6217.440430361108;5882.558808089496;5918.204488778055;5929.140274660064;5940.495057920125;5980.850478738066 04:53:55 INFO - PROCESS | 1684 | |1;ext.html;446.04101182457714;478.36855350936764;497.9701217926922;566.6231955749427;566.798786430817;31099.68900310996;38409.84770456891;38710.419343709866;38831.311025452575;38893.83318500446;41660.79169604155;41689.791551042275;42138.789306053506;42201;42327.36508952368;9517.809643807137;9667.95166024169;9760.755981100494;9763.658271960483;9763.755906102333;9741.464219467962;9783.217342612574;9791.363561368524;9836.458994755285;9846.163076138537;8592;9866.753331166707;9874.456904870229;9875.555599998017;9960.053794889474;8485.151484851496;9909.851352229722;9972.95013524935;9977.75055623608;9978.101970822625;9645.324827262095;9667.951660241724;9800.215982721365;9809.362391444605;9829.115379615869;40159;40846.591534084575;41033.589664103274;41168.79415602903;41194.58805411938;3211.7591180661543;3219.098652377338;3223.5325877747828;3348.7990720556845;3468.8959331219853;28860.8556957216;29123.980660676985;29224.561631575543;29427.558586621217;29429.55855662167;2738.548139556971;2744.890204391822;2807.354308509054;2954.3057381515328;2975.0479846449143;378876;379827;381666;382641;382948;57785.42214577801;58541.70729146327;64615;65222.347776522576;65540;72994;73387.63306183541;73689;73814;73967.26032739712;15880;16495.670086598202;16508;16510.75233871493;16741.911775734538;12387.256764594153;12545.996320294355;12587.496500139892;12630.494780208872;12635.873641263654;18617.88292702442;19341.80658193428;20827.1669133236;21027.894860525907;21699.34901952944;7556.886646700304;8801.867971980426;8894.155055269739;8965.910340896638;9012.954935225282;959.8656188133667;965.584798536622;988.5403287471361;1002.4236064262932;1128.6219116596033;29713;29727.40545189084;30064.24839379033;30555;30604;1090.6564432203832;1092.7213560542011;1157.432857899623;1184.7393573413835;1220.0605533738972;15265;15301.387944482318;15330.923345383202;15426.768598471032;15706;542123;547956;548477;548896;551463;58266.7086664564;58373.416265837644;58735.825283494094;59093.40906590879;59506;1314.8685131486775;1365.9550443910416;1432.6991331820227;1449.8332691740163;1456.0462896802612;24386.87806560956;29093.41813163767;30361.69638303677;31481.370372591962;31744.206394840312;53302.46697532975;53805.92388152293;53874.730626346616;54016.72991635017;54021;505408;511044;511932;512422;513575;43618.56381436272;44127.77936110299;44558;45208.77395613001;45306.32040519461;42960;43093.13813723771;43558;44080;44153.33769993517;35277.47083793694;36431.817840910626;36658.08354791151;36891.26217475689;38165.618343816204;37264.25471490609;37410.8129459351;37449.62550374462;37449.78322262496;37746.62253377431;37338.06654833651;37515;38148.23703525969;38408;38502;30335.696643033287;31902.840485797424;34443.655563444045;34958.82520587381;35176;24431.38921526905;25175.622365664894;25357.732113394624;25630.871845640653;25761.96952121894 04:53:55 INFO - PROCESS | 1684 | |2;jquery.html;338.9847456864441;358.24053007623843;362.64823121572084;363.894470603525;365.1710616899636;15413.92293038536;17531;18681.252749890005;18962.431127066175;19450;18397;19010.809891901077;19059.523511912175;19138.42584722457;19395.030248487554;5508.944910550903;5814.651120932736;5815.970920145414;5819.592628516006;5832.591718579701;4043.5147782266167;4135.214309281242;5052.570531504826;5738.512226460756;5971.283445986488;5909.793157239497;6135.570510064297;6326.525510586702;6339.968300158493;6344.873102537947;6372.522060845432;6385.648789316586;6412.454941329993;6422.357764223587;6425.550211485198;5375.946240537583;5460.6177567570285;5488.204210389511;5540.335159780811;5559.722013899329;24618.384540386454;24775.25674229776;25033.87483062591;25233;25260.98956041756;2251.8311126665403;2273.5111950930464;2485.254423672891;2706.851123188224;2868.5983962245305;9391.953040234755;9579.473128977903;9741.928387877328;9897.307188496809;9939.65211217611;1571.5599632103028;1721.1136264823626;1784.0722824131508;1805.6208196278797;1861.2089861808813;94789;95492.52253738687;96229.03770962342;96356.9999999993;97688;10953.507092180871;11137.05335046514;11202.495887685074;11208.495617697223;11250.156238281998;13225.603231903058;13244.006699497577;13272;13303.46786128544;13342.266175360448;8433.915660843435;8443.408961372768;8491.108433614505;8512.233898949124;8566.957165214259;8576.185262400062;8591.09793471689;8615;8664;8676.440450067244;4012.7391719538136;4341.826326946887;4357;4415.757133357696;4459.531749166355;1777.2002598830577;1817.1096162880094;1857.3870622694478;1879.793222745497;1889.0177107903812;400.94787677601727;404.119020535236;432.87879393769794;754.9698012079565;952.2524818017823;10903.672889813319;11586.841315868514;11655.30068195911;20200;20849.58300833975;926.5876684875166;1004.1514919892825;1021.371856308365;1024.1448390593937;1099.395332567085;8944;9790.5594248259;10904.454777261106;10966;11091.55633774656;721141;733944;740421;775697;778612;123127;123399;123781.38109309397;124994.37502812428;128356;1207.5169932027084;1211.8000529912642;1261.2810697902291;1264.4120483974996;1289.4842063174617;17630.559236019202;17928.92426454417;17946.282148713904;18081.638367232845;18318.816811832243;51270.230946535085;52179.47820521746;52391.73804130955;52521.47478525166;52947;73776.63111684407;74743.25256747362;76169;77874.61062694651;83940;10018.749531261778;10954.726131846768;10958.232923695265;10983.231173817756;11085.501152447998;8296.253337199681;8664.220220180214;8720.869186962074;12135.817962730744;12213.938930305292;7528.661210245443;7772.7668169954995;7783.494072885244;7840.529568225925;7855.489393189425;6930.653467326714;7513.549187048795;7654.8086297843;7771.145174030739;7787.844243114992;7390.002349682724;7816.10114836801;7827.178146294557;7899.802504937193;8043.638036288498;10927.945360273148;11005.394703291397;11039.006489415991;11220.1023918088;11293.322400655987;9070.773230669287;10868.347899125762;10891.836622450512;11069.944650276697;11231.21381503287 04:53:55 INFO - PROCESS | 1684 | |3;mootools.html;1536.316339229043;1543.4675037112195;1778.4753497718173;1873.6252749450123;1899.9335023274189;7904.565248911322;7977.321927636158;8855.512946787932;9079.228265597432;9088.182063614273;8525.78685532862;8579.742607721762;8607.182317679826;8740.606672699729;8780.868286975685;2453.153661986616;2461.1386014894824;2486.465409936863;2486.825922185448;2497.650328953948;2432.136591510015;2492.0779311654715;2494.4262819551514;2496.014074440595;2499.2252401755422;2466.260121963404;2486.415692312305;2503.849769013856;2510.447701505666;2512.824102312839;2238.238998740428;2329.4409341758023;2498.0132847525215;2511.982647027938;2513.648089267504;2071.8135367816967;2471.6045432730857;2495.8502489850666;2499.9125030624023;2504.6368276599974;8984.955075224647;8989.775255618597;8991;8996.280297576179;9015.909840901639;5412.56699464042;5574.637648552831;5585.776568937237;5594.356648985378;5618.269624948731;3686.189038411572;3773.056735816046;3811.7712937223578;3827.5598306194865;3837.9808100959317;1057.836035414512;1076.2412499188054;1077.175960390302;1105.4362275239685;1107.3189988157305;12137.575184868576;12203.694907627292;12354.629361119181;12390.690232744164;12399.814002789966;4997.825076122318;5008.899822003539;5039.118154322979;5055.443901170868;5060.291559181717;9215.677451289306;9752.829660440651;9956.655851460106;10170.033846784543;10444.268901176996;4198.433211516467;4655.185342565038;5420.701861397582;5489.862753431196;5557.055300598827;4437.400950871591;4574.5425457453985;4878.756062196876;4989.950100499022;5021.59827213822;3997;4003.2794097062224;4063.431119643193;4069.694772892045;4085.387191921176;1325.2578556008666;1327.561904571489;1336.6123824090905;1342.8724271194221;1344.1061693973593;1139.6979800352913;1353.3909740616762;1357.0907491980397;1378.827646544182;1385.3350391811784;8207.95896020528;8253.13342099083;8269.751907442665;8274.917250827535;8381.203785640355;511.6674161794789;514.8018013064922;516.9327987361619;517.647999360431;518.1166111779407;6097.17688112108;6169.383061693795;6220.530648125989;6228.34602366754;6235.750569977241;10912.727181820517;11085;11192.552297908156;11321.547138114383;11322.094232461382;9313.53432328381;10880.782384352427;10890.673279801618;10921.453927303603;11086.722831929266;8362.661974084118;8487;8506.957465212634;8553.486790792573;8593.570321483901;7969.402294827795;7995.400344974267;8009.719659812112;8095.595220238847;8127.878081828895;9608.423494590346;9835.852462213215;9931.900680993098;9944.701658950244;10063.39619622825;10027.392877851666;10262.794744105226;10263.384196948207;10277.486125693835;10399.84400233982;7434.182239953492;7627.618619068913;7673.271039251262;7680.308772210527;7690.6539205737;6833.4191593715095;8233.83532329362;8279.254867061993;8327.541985190872;8351.582420879053;7607.809804754926;7739.92260077392;7757.107932587599;7857.764267071997;7996.920030799618;7667.923320766721;7681.078270607562;7754.651040703069;7779.4554381192775;7841.843163136819;7792.415568832247;7854.803629909298;7903.091144518454;7905.4466187368635;7970.4819186752675;7034.5427547209265;7115.217326094229;7144.571325720473;7194.280571942764;7215.67529461186;7061.364477197077;7081.221065682667;7120.252373500708;7161.21226665056;7175.103112110986 04:53:55 INFO - PROCESS | 1684 | |4;prototype.html;324.8278412441406;329.59789057350025;332.15300982494665;335.13367943865114;338.5074716287803;5379.67721936684;5574.358948720893;6858.862822743542;6962.268961759012;7089.822754431136;6704.56420332678;6883.3460821222025;6887;6943.1668199816095;6962;4331.588499092589;4833.984863178736;5021.447640759514;5033.823816166435;5058.570021548173;4939.703617782927;5003.899142188713;5056.79772809089;5069.974650126745;5100.974495127519;4965.7020578765205;4993.875153121183;5001.17480615698;5013.373328333958;5048.2175262834135;5008.69947803133;5008.774605142778;5012.248162775594;5031.471695471996;5051.419086805027;3496.8776092836883;4166.375043743433;4169.56219596944;4179.6029377209115;4322.330038843953;5913.994620914455;6568.507361947825;6635.601863888182;6649.135612370361;6652.733890644368;5445.945540544583;6000.159977603139;6046.969765151146;6053.214301780941;6058;7219.855602887966;7440.85118297631;7441.7023319067175;7445.553266804009;7486;4893.755312234374;4896.485868983741;4904.681195722303;4905.068037072945;4906.190478571031;7854.1753115922575;7861.371090312761;7882.487638303492;7906.288434040964;7907.44647874649;4844.4798016525865;4930.630202734809;4981.551660350586;4982.451930287665;5008.373953255843;5093.745312734349;5103.489651034941;5104.081265372194;5110.97444512775;5116.258142569381;6022.488088512438;6027.276726792813;6031.698415079229;6041.365656606081;6051.878962420815;7216.314450127335;7474.439417043744;7483.4761566690895;7486.288802563748;7491.475596708287;1744.8516876065676;1761.9471415857545;1762.8765986381086;1767.558110472382;1768.5578605348662;1121.764429469804;1127.0476447401932;1129.1474936423112;1129.4635048351968;1149.2989276541302;6898.724051037902;6898.793036208821;6904.929735890945;6905.551139176038;6960.164780226405;5512.3385193777;7793.415493837985;7799.454038217384;7815.765527034198;7822;5725.856853578611;6387.8501869663905;6871.759488417882;6888.035675005503;6967.477439192081;4013.3979903014783;4079.551249362568;4101;4121.52602450716;4141.751494910315;8002.9599852000365;8097.514149151069;8138.959305203436;8141.674333026613;8174.9182508175345;7991.2807847294025;8003.759887203277;8008.7597372078935;8010.639521221559;8020.238077382639;7879.369650427952;8219.794505137299;8226.62980165882;8234.341252699769;8245.670173193004;6695.4308883745425;7863.882041769263;7877.330426913776;7922.326602238643;7930.682772689028;5943.465088142088;7442.813929651802;7669.923300766921;7685.577293248925;7694.1536430993665;8121.593920303843;8135.674573017013;8144.271668990955;8157.306628936607;8195.71315003972;4966.255061740768;5022.598192144546;5042.193249080129;5075.746212689277;5079.796808127633;7551.207123251979;7708.113566939649;7730.7680769577;7775.455718099679;7827.9608601956625;6271.811845644638;7378.631068446449;7546.396288297033;7568.924310756822;7572.545647261182;6503.406665367015;7048.259932707197;7243.927560724325;7472.738454154079;7493.475456717977;7345.265473452612;7347.485676002629;7356.448266379936;7370.852582948418;7398.482106252511;7557.2820582044615;7579.924200757921;7585.317321441097;7586.431017673807;7612.581308028111;7142.714291428285;7388.556686598821;7393.8890916637365;7413.592252425952;7430.405567554691 04:53:55 INFO - PROCESS | 1684 | |5;yui.html;677.5629718831353;719.1442183801277;722.2813300765739;729.3071581997101;729.7117638532783;13815.309234538283;13955.58133256004;14449.855501444983;14750.114993100422;14758.557243282705;15233.542993710178;15401.537953861374;15454.459093931715;15505.922470387632;15511.146886921215;837.7068026190846;839.7858546070759;845.0662018469595;846.5217152308957;855.1277696749312;846.919542643451;852.0159216105408;853.1937319233296;855.9443636163629;859.1108203009886;875.0549406640813;894.6332003878412;903.8011637439753;905.4069584422214;906.1074841281365;886.9379143459961;896.2695403246333;901.0448924140433;904.2539904578716;906.8594367872957;659.515256286629;667.7896462614309;668.6656671664168;668.8060462465879;671.4024518178825;12224.266544007389;14303.427862885472;14317;14351.641208969755;14360.066595671353;11538.826917596243;12179.512819487298;12363.62909112728;12595.181313214613;12876.22742635445;10060;10109.292349535535;10157.441340726256;10190.133838623726;10373.896261037444;3447.276072024878;3474.1835668618105;3490.441529355291;3688.2807852468777;3688.907777305562;75695.6215218926;77641;78454;83009.16990830074;83312.91717707046;9470.452724857249;9646.372985755903;9989.350692204984;10017.04838040385;10286.639967601099;19140.617187656168;19165.32921347746;20955.05702243372;20970.475738106365;21012.15951361959;7361.852762944711;7431.479796414307;7459.776206713807;7634.580098094658;7731.381489480828;4066.268071747055;4110.05468742191;4112.485939257593;4298.183345164472;4343.869683909487;3563.964360356363;3566.4828599853395;3579.19468119671;3592.6946209571956;3596.82015899204;640.4844100499143;658.1279804259375;661.2362721057186;668.7157957867984;673.8618583190532;609.4027852704374;616.0881894795727;621.0559948877681;624.5316012990257;629.2951893878885;8296.253337199681;8475.962497506434;8726.345524085718;8785.956070219609;8908.643654253887;519.7764961066702;537.6263496869637;555.7999120316683;585.8125399872085;608.5466327585976;3995.300822356076;4034.5561988181275;4041.516039611802;4096.569860164699;4130.896727581834;92779;93141.53429232947;95376;95949.52025239829;96329.51835240779;62854.114376568774;78604.60697696474;82178;82202.3559528806;83538.58230708807;68004;69299.26751831143;70531;70918.64540677263;71922.64038679878;6924.892017277211;8074.515529068275;8169;8355.289800367036;8429.747107586782;49370.75314623404;49454.75272623614;50337;50441.73895652638;51132.23301650404;65505;69464;69565.00002499575;70468;71991;9882.703518894445;10065.899341006496;10150;10221.642242521773;10520.526576303932;10708.196885233483;10859;10861.945690271814;10961.616343427942;11044.613438529614;9066.957299910595;9417.246620270225;10338.844917326396;10437.947810261205;10539.841902371623;10260.846087308548;10300;10692.62575809843;11065.114790816877;11108.333499990027;10232.897671023493;10340;10350.482475876026;10534.841977370192;10556.683299501028;8503.149685031447;8610.870836937576;8647.783805404915;8773.692920747742;8914.55427228623;8114.634841432032;8865.423747456394;8900.510471924106;8992.28061755071;9197.632094716137 04:53:55 INFO - PROCESS | 1684 | __end_tp_report 04:53:55 INFO - PROCESS | 1684 | __start_cc_report 04:53:55 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,351 04:53:55 INFO - PROCESS | 1684 | __end_cc_report 04:53:55 INFO - PROCESS | 1684 | __startTimestamp1454072035565__endTimestamp 04:53:55 INFO - PROCESS | 1684 | 04:53:55 INFO - PROCESS | 1684 | ------- Summary: start ------- 04:53:55 INFO - PROCESS | 1684 | Number of tests: 6 04:53:55 INFO - PROCESS | 1684 | 04:53:55 INFO - PROCESS | 1684 | [#0] dojo.html Cycles:165 Average:5719.35 Median:5918.20 stddev:639.30 (10.8%) stddev-sans-first:613.85 04:53:55 INFO - PROCESS | 1684 | Values: 3358.5 3532.8 3567.0 3596.4 3597.0 5741.6 5787.3 5804.8 5811.5 5816.5 4551.3 5708.1 5747.9 5775.1 5826.5 5138.6 5180.1 5202.7 5225.1 5289.5 5274.3 5276.8 5295.0 5329.1 5358.3 5085.5 5109.2 5157.4 5196.1 5223.6 5191.2 5200.2 5205.1 5214.0 5240.0 5149.2 5186.2 5212.9 5229.6 5233.2 4853.2 5423.0 5621.8 5641.8 5733.1 5144.7 5477.9 6042.3 6208.8 6256.3 5686.0 6270.3 6275.8 6281.7 6296.0 5399.9 5874.2 5890.5 5994.9 6034.0 6250.6 6276.0 6293.1 6293.2 6316.9 6062.5 6161.4 6181.7 6193.4 6199.4 6105.5 6143.9 6210.6 6224.7 6253.6 6064.6 6135.8 6142.9 6160.5 6161.5 6112.4 6116.1 6151.3 6224.8 6248.2 4905.6 4942.7 4943.4 4950.6 5002.6 4453.7 4453.9 4462.8 4466.3 4496.9 5683.8 5784.1 5849.7 5863.9 5883.0 6207.4 6212.6 6213.9 6217.9 6218.2 4657.4 5812.6 5854.2 5857.2 5866.2 5355.9 5375.9 5399.0 5424.8 5480.7 6305.2 6351.3 6351.5 6361.4 6365.1 6249.3 6259.9 6267.7 6289.1 6294.6 5969.6 6167.9 6267.9 6293.8 6329.3 6179.9 6218.1 6234.3 6236.2 6239.4 6111.1 6285.1 6304.4 6306.8 6327.7 5453.9 6126.8 6140.2 6217.8 6278.2 4837.6 6172.6 6177.5 6188.6 6206.3 4970.0 5785.2 5867.8 6041.6 6068.2 6143.0 6158.3 6196.3 6213.8 6217.4 5882.6 5918.2 5929.1 5940.5 5980.9 04:53:55 INFO - PROCESS | 1684 | 04:53:55 INFO - PROCESS | 1684 | [#1] ext.html Cycles:180 Average:63560.78 Median:38862.57 stddev:128979.28 (331.9%) stddev-sans-first:129254.05 04:53:55 INFO - PROCESS | 1684 | Values: 446.0 478.4 498.0 566.6 566.8 31099.7 38409.8 38710.4 38831.3 38893.8 41660.8 41689.8 42138.8 42201.0 42327.4 9517.8 9668.0 9760.8 9763.7 9763.8 9741.5 9783.2 9791.4 9836.5 9846.2 8592.0 9866.8 9874.5 9875.6 9960.1 8485.2 9909.9 9973.0 9977.8 9978.1 9645.3 9668.0 9800.2 9809.4 9829.1 40159.0 40846.6 41033.6 41168.8 41194.6 3211.8 3219.1 3223.5 3348.8 3468.9 28860.9 29124.0 29224.6 29427.6 29429.6 2738.5 2744.9 2807.4 2954.3 2975.0 378876.0 379827.0 381666.0 382641.0 382948.0 57785.4 58541.7 64615.0 65222.3 65540.0 72994.0 73387.6 73689.0 73814.0 73967.3 15880.0 16495.7 16508.0 16510.8 16741.9 12387.3 12546.0 12587.5 12630.5 12635.9 18617.9 19341.8 20827.2 21027.9 21699.3 7556.9 8801.9 8894.2 8965.9 9013.0 959.9 965.6 988.5 1002.4 1128.6 29713.0 29727.4 30064.2 30555.0 30604.0 1090.7 1092.7 1157.4 1184.7 1220.1 15265.0 15301.4 15330.9 15426.8 15706.0 542123.0 547956.0 548477.0 548896.0 551463.0 58266.7 58373.4 58735.8 59093.4 59506.0 1314.9 1366.0 1432.7 1449.8 1456.0 24386.9 29093.4 30361.7 31481.4 31744.2 53302.5 53805.9 53874.7 54016.7 54021.0 505408.0 511044.0 511932.0 512422.0 513575.0 43618.6 44127.8 44558.0 45208.8 45306.3 42960.0 43093.1 43558.0 44080.0 44153.3 35277.5 36431.8 36658.1 36891.3 38165.6 37264.3 37410.8 37449.6 37449.8 37746.6 37338.1 37515.0 38148.2 38408.0 38502.0 30335.7 31902.8 34443.7 34958.8 35176.0 24431.4 25175.6 25357.7 25630.9 25762.0 04:53:55 INFO - PROCESS | 1684 | 04:53:55 INFO - PROCESS | 1684 | [#2] jquery.html Cycles:180 Average:37918.55 Median:2223.82 stddev:123734.19 (5564.0%) stddev-sans-first:124049.12 04:53:55 INFO - PROCESS | 1684 | Values: 339.0 358.2 362.6 363.9 365.2 15413.9 17531.0 18681.3 18962.4 19450.0 18397.0 19010.8 19059.5 19138.4 19395.0 5508.9 5814.7 5816.0 5819.6 5832.6 4043.5 4135.2 5052.6 5738.5 5971.3 5909.8 6135.6 6326.5 6340.0 6344.9 6372.5 6385.6 6412.5 6422.4 6425.6 5375.9 5460.6 5488.2 5540.3 5559.7 24618.4 24775.3 25033.9 25233.0 25261.0 2251.8 2273.5 2485.3 2706.9 2868.6 9392.0 9579.5 9741.9 9897.3 9939.7 1571.6 1721.1 1784.1 1805.6 1861.2 94789.0 95492.5 96229.0 96357.0 97688.0 10953.5 11137.1 11202.5 11208.5 11250.2 13225.6 13244.0 13272.0 13303.5 13342.3 8433.9 8443.4 8491.1 8512.2 8567.0 8576.2 8591.1 8615.0 8664.0 8676.4 4012.7 4341.8 4357.0 4415.8 4459.5 1777.2 1817.1 1857.4 1879.8 1889.0 400.9 404.1 432.9 755.0 952.3 10903.7 11586.8 11655.3 20200.0 20849.6 926.6 1004.2 1021.4 1024.1 1099.4 8944.0 9790.6 10904.5 10966.0 11091.6 721141.0 733944.0 740421.0 775697.0 778612.0 123127.0 123399.0 123781.4 124994.4 128356.0 1207.5 1211.8 1261.3 1264.4 1289.5 17630.6 17928.9 17946.3 18081.6 18318.8 51270.2 52179.5 52391.7 52521.5 52947.0 73776.6 74743.3 76169.0 77874.6 83940.0 10018.7 10954.7 10958.2 10983.2 11085.5 8296.3 8664.2 8720.9 12135.8 12213.9 7528.7 7772.8 7783.5 7840.5 7855.5 6930.7 7513.5 7654.8 7771.1 7787.8 7390.0 7816.1 7827.2 7899.8 8043.6 10927.9 11005.4 11039.0 11220.1 11293.3 9070.8 10868.3 10891.8 11069.9 11231.2 04:53:55 INFO - PROCESS | 1684 | 04:53:55 INFO - PROCESS | 1684 | [#3] mootools.html Cycles:180 Average:6144.09 Median:515.87 stddev:3281.49 (636.1%) stddev-sans-first:3272.42 04:53:55 INFO - PROCESS | 1684 | Values: 1536.3 1543.5 1778.5 1873.6 1899.9 7904.6 7977.3 8855.5 9079.2 9088.2 8525.8 8579.7 8607.2 8740.6 8780.9 2453.2 2461.1 2486.5 2486.8 2497.7 2432.1 2492.1 2494.4 2496.0 2499.2 2466.3 2486.4 2503.8 2510.4 2512.8 2238.2 2329.4 2498.0 2512.0 2513.6 2071.8 2471.6 2495.9 2499.9 2504.6 8985.0 8989.8 8991.0 8996.3 9015.9 5412.6 5574.6 5585.8 5594.4 5618.3 3686.2 3773.1 3811.8 3827.6 3838.0 1057.8 1076.2 1077.2 1105.4 1107.3 12137.6 12203.7 12354.6 12390.7 12399.8 4997.8 5008.9 5039.1 5055.4 5060.3 9215.7 9752.8 9956.7 10170.0 10444.3 4198.4 4655.2 5420.7 5489.9 5557.1 4437.4 4574.5 4878.8 4990.0 5021.6 3997.0 4003.3 4063.4 4069.7 4085.4 1325.3 1327.6 1336.6 1342.9 1344.1 1139.7 1353.4 1357.1 1378.8 1385.3 8208.0 8253.1 8269.8 8274.9 8381.2 511.7 514.8 516.9 517.6 518.1 6097.2 6169.4 6220.5 6228.3 6235.8 10912.7 11085.0 11192.6 11321.5 11322.1 9313.5 10880.8 10890.7 10921.5 11086.7 8362.7 8487.0 8507.0 8553.5 8593.6 7969.4 7995.4 8009.7 8095.6 8127.9 9608.4 9835.9 9931.9 9944.7 10063.4 10027.4 10262.8 10263.4 10277.5 10399.8 7434.2 7627.6 7673.3 7680.3 7690.7 6833.4 8233.8 8279.3 8327.5 8351.6 7607.8 7739.9 7757.1 7857.8 7996.9 7667.9 7681.1 7754.7 7779.5 7841.8 7792.4 7854.8 7903.1 7905.4 7970.5 7034.5 7115.2 7144.6 7194.3 7215.7 7061.4 7081.2 7120.3 7161.2 7175.1 04:53:55 INFO - PROCESS | 1684 | 04:53:55 INFO - PROCESS | 1684 | [#4] prototype.html Cycles:180 Average:6065.24 Median:6865.31 stddev:1965.41 (28.6%) stddev-sans-first:1923.12 04:53:55 INFO - PROCESS | 1684 | Values: 324.8 329.6 332.2 335.1 338.5 5379.7 5574.4 6858.9 6962.3 7089.8 6704.6 6883.3 6887.0 6943.2 6962.0 4331.6 4834.0 5021.4 5033.8 5058.6 4939.7 5003.9 5056.8 5070.0 5101.0 4965.7 4993.9 5001.2 5013.4 5048.2 5008.7 5008.8 5012.2 5031.5 5051.4 3496.9 4166.4 4169.6 4179.6 4322.3 5914.0 6568.5 6635.6 6649.1 6652.7 5445.9 6000.2 6047.0 6053.2 6058.0 7219.9 7440.9 7441.7 7445.6 7486.0 4893.8 4896.5 4904.7 4905.1 4906.2 7854.2 7861.4 7882.5 7906.3 7907.4 4844.5 4930.6 4981.6 4982.5 5008.4 5093.7 5103.5 5104.1 5111.0 5116.3 6022.5 6027.3 6031.7 6041.4 6051.9 7216.3 7474.4 7483.5 7486.3 7491.5 1744.9 1761.9 1762.9 1767.6 1768.6 1121.8 1127.0 1129.1 1129.5 1149.3 6898.7 6898.8 6904.9 6905.6 6960.2 5512.3 7793.4 7799.5 7815.8 7822.0 5725.9 6387.9 6871.8 6888.0 6967.5 4013.4 4079.6 4101.0 4121.5 4141.8 8003.0 8097.5 8139.0 8141.7 8174.9 7991.3 8003.8 8008.8 8010.6 8020.2 7879.4 8219.8 8226.6 8234.3 8245.7 6695.4 7863.9 7877.3 7922.3 7930.7 5943.5 7442.8 7669.9 7685.6 7694.2 8121.6 8135.7 8144.3 8157.3 8195.7 4966.3 5022.6 5042.2 5075.7 5079.8 7551.2 7708.1 7730.8 7775.5 7828.0 6271.8 7378.6 7546.4 7568.9 7572.5 6503.4 7048.3 7243.9 7472.7 7493.5 7345.3 7347.5 7356.4 7370.9 7398.5 7557.3 7579.9 7585.3 7586.4 7612.6 7142.7 7388.6 7393.9 7413.6 7430.4 04:53:55 INFO - PROCESS | 1684 | 04:53:55 INFO - PROCESS | 1684 | [#5] yui.html Cycles:180 Average:18168.22 Median:33072.74 stddev:25988.24 (78.6%) stddev-sans-first:26027.96 04:53:55 INFO - PROCESS | 1684 | Values: 677.6 719.1 722.3 729.3 729.7 13815.3 13955.6 14449.9 14750.1 14758.6 15233.5 15401.5 15454.5 15505.9 15511.1 837.7 839.8 845.1 846.5 855.1 846.9 852.0 853.2 855.9 859.1 875.1 894.6 903.8 905.4 906.1 886.9 896.3 901.0 904.3 906.9 659.5 667.8 668.7 668.8 671.4 12224.3 14303.4 14317.0 14351.6 14360.1 11538.8 12179.5 12363.6 12595.2 12876.2 10060.0 10109.3 10157.4 10190.1 10373.9 3447.3 3474.2 3490.4 3688.3 3688.9 75695.6 77641.0 78454.0 83009.2 83312.9 9470.5 9646.4 9989.4 10017.0 10286.6 19140.6 19165.3 20955.1 20970.5 21012.2 7361.9 7431.5 7459.8 7634.6 7731.4 4066.3 4110.1 4112.5 4298.2 4343.9 3564.0 3566.5 3579.2 3592.7 3596.8 640.5 658.1 661.2 668.7 673.9 609.4 616.1 621.1 624.5 629.3 8296.3 8476.0 8726.3 8786.0 8908.6 519.8 537.6 555.8 585.8 608.5 3995.3 4034.6 4041.5 4096.6 4130.9 92779.0 93141.5 95376.0 95949.5 96329.5 62854.1 78604.6 82178.0 82202.4 83538.6 68004.0 69299.3 70531.0 70918.6 71922.6 6924.9 8074.5 8169.0 8355.3 8429.7 49370.8 49454.8 50337.0 50441.7 51132.2 65505.0 69464.0 69565.0 70468.0 71991.0 9882.7 10065.9 10150.0 10221.6 10520.5 10708.2 10859.0 10861.9 10961.6 11044.6 9067.0 9417.2 10338.8 10437.9 10539.8 10260.8 10300.0 10692.6 11065.1 11108.3 10232.9 10340.0 10350.5 10534.8 10556.7 8503.1 8610.9 8647.8 8773.7 8914.6 8114.6 8865.4 8900.5 8992.3 9197.6 04:53:55 INFO - PROCESS | 1684 | -------- Summary: end -------- 04:53:55 INFO - PROCESS | 1684 | 04:53:56 INFO - TEST-INFO | 1684: exit 0 04:53:56 INFO - TEST-OK | dromaeo_css | took 1111135ms 04:53:56 INFO - TEST-START | kraken 04:53:56 INFO - operating with platform_type : mac_ 04:53:56 INFO - Initialising browser for kraken test... 04:53:56 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpwn6C_4/profile http://localhost:49287/getInfo.html) 04:53:59 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 04:53:59 INFO - PROCESS | 1691 | colorDepth:24 04:53:59 INFO - PROCESS | 1691 | Browser inner width/height: 1024/689 04:53:59 INFO - PROCESS | 1691 | __metrics 04:53:59 INFO - PROCESS | 1691 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:53:59 INFO - TEST-INFO | 1691: exit 0 04:53:59 INFO - Browser initialized. 04:53:59 INFO - Running cycle 1/1 for kraken test... 04:53:59 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpwn6C_4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:11 INFO - PROCESS | 1694 | RSS: Main: 255897600 04:54:11 INFO - PROCESS | 1694 | 04:54:14 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49287/tests/kraken/driver.html?testName=audio-beat-detection) 04:54:15 INFO - PROCESS | 1694 | RSS: Main: 269283328 04:54:15 INFO - PROCESS | 1694 | 04:54:18 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49287/tests/kraken/driver.html?testName=audio-dft) 04:54:18 INFO - PROCESS | 1694 | RSS: Main: 278667264 04:54:18 INFO - PROCESS | 1694 | 04:54:21 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49287/tests/kraken/driver.html?testName=audio-fft) 04:54:22 INFO - PROCESS | 1694 | RSS: Main: 280997888 04:54:22 INFO - PROCESS | 1694 | 04:54:24 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49287/tests/kraken/driver.html?testName=audio-oscillator) 04:54:24 INFO - PROCESS | 1694 | RSS: Main: 282210304 04:54:24 INFO - PROCESS | 1694 | 04:54:26 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49287/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:54:27 INFO - PROCESS | 1694 | RSS: Main: 282447872 04:54:27 INFO - PROCESS | 1694 | 04:54:30 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49287/tests/kraken/driver.html?testName=imaging-darkroom) 04:54:30 INFO - PROCESS | 1694 | RSS: Main: 282431488 04:54:30 INFO - PROCESS | 1694 | 04:54:34 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49287/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:34 INFO - PROCESS | 1694 | RSS: Main: 283058176 04:54:34 INFO - PROCESS | 1694 | 04:54:37 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49287/tests/kraken/driver.html?testName=json-parse-financial) 04:54:38 INFO - PROCESS | 1694 | RSS: Main: 282779648 04:54:38 INFO - PROCESS | 1694 | 04:54:39 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49287/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:40 INFO - PROCESS | 1694 | RSS: Main: 284262400 04:54:40 INFO - PROCESS | 1694 | 04:54:41 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49287/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:54:42 INFO - PROCESS | 1694 | RSS: Main: 283353088 04:54:42 INFO - PROCESS | 1694 | 04:54:44 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49287/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:54:45 INFO - PROCESS | 1694 | RSS: Main: 285175808 04:54:45 INFO - PROCESS | 1694 | 04:54:47 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:54:48 INFO - PROCESS | 1694 | RSS: Main: 284127232 04:54:48 INFO - PROCESS | 1694 | 04:54:50 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:51 INFO - PROCESS | 1694 | RSS: Main: 284094464 04:54:51 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49287/tests/kraken/driver.html?testName=ai-astar) 04:54:53 INFO - PROCESS | 1694 | RSS: Main: 285884416 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | __start_tp_report 04:54:53 INFO - PROCESS | 1694 | _x_x_mozilla_page_load 04:54:53 INFO - PROCESS | 1694 | _x_x_mozilla_page_load_details 04:54:53 INFO - PROCESS | 1694 | |i|pagename|runs| 04:54:53 INFO - PROCESS | 1694 | |0;ai-astar;114;106;114;113;115;123;149;169;94;165 04:54:53 INFO - PROCESS | 1694 | |1;audio-beat-detection;159;120;149;173;150;176;127;153;188;153 04:54:53 INFO - PROCESS | 1694 | |2;audio-dft;195;192;195;215;208;195;199;193;206;197 04:54:53 INFO - PROCESS | 1694 | |3;audio-fft;74;71;74;107;57;58;57;61;115;59 04:54:53 INFO - PROCESS | 1694 | |4;audio-oscillator;82;83;116;80;82;81;119;64;84;147 04:54:53 INFO - PROCESS | 1694 | |5;imaging-gaussian-blur;90;95;89;96;91;95;89;96;89;95 04:54:53 INFO - PROCESS | 1694 | |6;imaging-darkroom;104;109;108;151;152;116;152;105;139;151 04:54:53 INFO - PROCESS | 1694 | |7;imaging-desaturate;91;94;90;92;94;97;92;92;92;91 04:54:53 INFO - PROCESS | 1694 | |8;json-parse-financial;56;57;56;54;56;56;55;61;54;54 04:54:53 INFO - PROCESS | 1694 | |9;json-stringify-tinderbox;65;67;68;77;74;72;67;67;68;66 04:54:53 INFO - PROCESS | 1694 | |10;stanford-crypto-aes;86;85;87;85;85;86;86;89;87;85 04:54:53 INFO - PROCESS | 1694 | |11;stanford-crypto-ccm;130;128;132;127;132;127;132;122;111;128 04:54:53 INFO - PROCESS | 1694 | |12;stanford-crypto-pbkdf2;160;146;142;139;151;170;172;153;136;130 04:54:53 INFO - PROCESS | 1694 | |13;stanford-crypto-sha256-iterative;69;78;89;93;86;67;67;67;67;74 04:54:53 INFO - PROCESS | 1694 | __end_tp_report 04:54:53 INFO - PROCESS | 1694 | __start_cc_report 04:54:53 INFO - PROCESS | 1694 | _x_x_mozilla_cycle_collect,891 04:54:53 INFO - PROCESS | 1694 | __end_cc_report 04:54:53 INFO - PROCESS | 1694 | __startTimestamp1454072093548__endTimestamp 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | ------- Summary: start ------- 04:54:53 INFO - PROCESS | 1694 | Number of tests: 14 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#0] ai-astar Cycles:10 Average:126.20 Median:136.00 stddev:25.62 (18.8%) stddev-sans-first:26.80 04:54:53 INFO - PROCESS | 1694 | Values: 114.0 106.0 114.0 113.0 115.0 123.0 149.0 169.0 94.0 165.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:156.00 stddev:20.94 (13.4%) stddev-sans-first:22.16 04:54:53 INFO - PROCESS | 1694 | Values: 159.0 120.0 149.0 173.0 150.0 176.0 127.0 153.0 188.0 153.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#2] audio-dft Cycles:10 Average:199.50 Median:198.00 stddev:7.60 (3.8%) stddev-sans-first:7.89 04:54:53 INFO - PROCESS | 1694 | Values: 195.0 192.0 195.0 215.0 208.0 195.0 199.0 193.0 206.0 197.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#3] audio-fft Cycles:10 Average:73.30 Median:60.00 stddev:21.09 (35.1%) stddev-sans-first:22.37 04:54:53 INFO - PROCESS | 1694 | Values: 74.0 71.0 74.0 107.0 57.0 58.0 57.0 61.0 115.0 59.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:81.50 stddev:25.15 (30.9%) stddev-sans-first:26.31 04:54:53 INFO - PROCESS | 1694 | Values: 82.0 83.0 116.0 80.0 82.0 81.0 119.0 64.0 84.0 147.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:95.00 stddev:3.14 (3.3%) stddev-sans-first:3.19 04:54:53 INFO - PROCESS | 1694 | Values: 90.0 95.0 89.0 96.0 91.0 95.0 89.0 96.0 89.0 95.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#6] imaging-darkroom Cycles:10 Average:128.70 Median:145.00 stddev:21.95 (15.1%) stddev-sans-first:21.38 04:54:53 INFO - PROCESS | 1694 | Values: 104.0 109.0 108.0 151.0 152.0 116.0 152.0 105.0 139.0 151.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#7] imaging-desaturate Cycles:10 Average:92.50 Median:92.00 stddev:2.01 (2.2%) stddev-sans-first:2.06 04:54:53 INFO - PROCESS | 1694 | Values: 91.0 94.0 90.0 92.0 94.0 97.0 92.0 92.0 92.0 91.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:2.08 (3.7%) stddev-sans-first:2.20 04:54:53 INFO - PROCESS | 1694 | Values: 56.0 57.0 56.0 54.0 56.0 56.0 55.0 61.0 54.0 54.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.00 stddev:3.90 (5.7%) stddev-sans-first:3.84 04:54:53 INFO - PROCESS | 1694 | Values: 65.0 67.0 68.0 77.0 74.0 72.0 67.0 67.0 68.0 66.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:1.29 (1.5%) stddev-sans-first:1.36 04:54:53 INFO - PROCESS | 1694 | Values: 86.0 85.0 87.0 85.0 85.0 86.0 86.0 89.0 87.0 85.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:129.00 stddev:6.38 (4.9%) stddev-sans-first:6.67 04:54:53 INFO - PROCESS | 1694 | Values: 130.0 128.0 132.0 127.0 132.0 127.0 132.0 122.0 111.0 128.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:152.00 stddev:14.11 (9.3%) stddev-sans-first:14.48 04:54:53 INFO - PROCESS | 1694 | Values: 160.0 146.0 142.0 139.0 151.0 170.0 172.0 153.0 136.0 130.0 04:54:53 INFO - PROCESS | 1694 | 04:54:53 INFO - PROCESS | 1694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:76.00 stddev:10.21 (13.4%) stddev-sans-first:10.54 04:54:53 INFO - PROCESS | 1694 | Values: 69.0 78.0 89.0 93.0 86.0 67.0 67.0 67.0 67.0 74.0 04:54:53 INFO - PROCESS | 1694 | -------- Summary: end -------- 04:54:53 INFO - PROCESS | 1694 | 04:54:54 INFO - TEST-INFO | 1694: exit 0 04:54:54 INFO - TEST-OK | kraken | took 58384ms 04:54:54 INFO - SUITE-END | took 1169s 04:54:54 INFO - Completed test suite (00:19:29) 04:54:54 INFO - Working with test: dromaeo_css 04:54:54 INFO - Generating results file: dromaeo_css 04:54:54 INFO - Working with test: kraken 04:54:54 INFO - Generating results file: kraken 04:54:54 INFO - javascript benchmark 04:54:54 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:54:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 04:54:54 INFO - process_Request line: dromaeo_css 7559.08 graph.html#tests=[[72,1,61]] 04:54:54 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:54:54 INFO - process_Request line: kraken 1524.90 graph.html#tests=[[232,1,61]] 04:54:54 INFO - RETURN: dromaeo_css: 7559.08 04:54:54 INFO - RETURN: kraken: 1524.90 04:54:54 INFO - javascript benchmark 04:54:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3358.4794356874686, 3532.7527073104893, 3566.982165089174, 3596.4425514045333, 3597.0, 5741.598088133827, 5787.305523337205, 5804.796832110877, 5811.506021988131, 5816.505597024258, 4551.317302404633, 5708.1437784332375, 5747.856303592413, 5775.075987841946, 5826.475617194462, 5138.614603904722, 5180.119379705449, 5202.687838729669, 5225.085610018251, 5289.471052894718, 5274.26160337553, 5276.841694749144, 5295.0468915595175, 5329.094054010808, 5358.276632654581, 5085.491450854922, 5109.156989096795, 5157.381114266274, 5196.064708352514, 5223.608229382811, 5191.22131680251, 5200.193969934666, 5205.063088644042, 5214.009338225725, 5240.0, 5149.176131818891, 5186.222066690027, 5212.895742085175, 5229.581633469314, 5233.241180028875, 4853.150698627726, 5423.023855705971, 5621.831345059655, 5641.802536911229, 5733.140028995643, 5144.665596736238, 5477.877035207773, 6042.305134909454, 6208.813735587894, 6256.343083976162, 5685.971570142165, 6270.341614130496, 6275.811725648238, 6281.748730050793, 6295.968520157416, 5399.919001214985, 5874.23634927461, 5890.499307558863, 5994.880102397928, 6034.0, 6250.62416362077, 6276.0, 6293.056041593798, 6293.213348331458, 6316.905246421307, 6062.484688801413, 6161.41466560685, 6181.721822517998, 6193.411625895533, 6199.442050215503, 6105.511559075263, 6143.911070236141, 6210.5652604317265, 6224.688765561704, 6253.5622506425025, 6064.575479716377, 6135.815925522242, 6142.877142457126, 6160.537959653044, 6161.507079433634, 6112.358202388774, 6116.061877111602, 6151.292601350812, 6224.844378890564, 6248.218972628421, 4905.607551395879, 4942.703437793743, 4943.3573635427165, 4950.628702847229, 5002.624803139779, 4453.732776033448, 4453.886528367908, 4462.754548499799, 4466.307722302983, 4496.865094047183, 5683.77264909399, 5784.074548072288, 5849.736761845727, 5863.912041319383, 5883.0, 6207.379262073847, 6212.627242365382, 6213.937860621336, 6217.906731399033, 6218.22272215973, 4657.441107067174, 5812.59311848175, 5854.2096816930025, 5857.238558987305, 5866.178734977107, 5355.946440535623, 5375.946240537544, 5399.0, 5424.83725488236, 5480.671159730349, 6305.180326557518, 6351.301356850743, 6351.491880649444, 6361.427471527585, 6365.077063825812, 6249.312575616587, 6259.906101408392, 6267.6866156692895, 6289.119523266655, 6294.590851594632, 5969.582129250911, 6167.876642467036, 6267.937320626917, 6293.779717709858, 6329.30377658448, 6179.907301390393, 6218.129461875432, 6234.314225435289, 6236.220472440945, 6239.376062393724, 6111.135969295249, 6285.120083188449, 6304.401081897213, 6306.842328941813, 6327.746890124344, 5453.909218156464, 6126.785562505291, 6140.20177376956, 6217.813465596039, 6278.215223097113, 4837.612990960785, 6172.5679202457195, 6177.4749146323065, 6188.628682279078, 6206.348333424925, 4970.0, 5785.247917770663, 5867.765289388547, 6041.577089603861, 6068.241469816273, 6143.047827586731, 6158.291796443287, 6196.256449226122, 6213.782517611862, 6217.440430361108, 5882.558808089496, 5918.204488778055, 5929.140274660064, 5940.495057920125, 5980.850478738066], "unit": "score", "name": "dojo.html", "value": 5682.641396589903}, {"lowerIsBetter": false, "replicates": [446.04101182457714, 478.36855350936764, 497.9701217926922, 566.6231955749427, 566.798786430817, 31099.68900310996, 38409.84770456891, 38710.419343709866, 38831.311025452575, 38893.83318500446, 41660.79169604155, 41689.791551042275, 42138.789306053506, 42201.0, 42327.36508952368, 9517.809643807137, 9667.95166024169, 9760.755981100494, 9763.658271960483, 9763.755906102333, 9741.464219467962, 9783.217342612574, 9791.363561368524, 9836.458994755285, 9846.163076138537, 8592.0, 9866.753331166707, 9874.456904870229, 9875.555599998017, 9960.053794889474, 8485.151484851496, 9909.851352229722, 9972.95013524935, 9977.75055623608, 9978.101970822625, 9645.324827262095, 9667.951660241724, 9800.215982721365, 9809.362391444605, 9829.115379615869, 40159.0, 40846.591534084575, 41033.589664103274, 41168.79415602903, 41194.58805411938, 3211.7591180661543, 3219.098652377338, 3223.5325877747828, 3348.7990720556845, 3468.8959331219853, 28860.8556957216, 29123.980660676985, 29224.561631575543, 29427.558586621217, 29429.55855662167, 2738.548139556971, 2744.890204391822, 2807.354308509054, 2954.3057381515328, 2975.0479846449143, 378876.0, 379827.0, 381666.0, 382641.0, 382948.0, 57785.42214577801, 58541.70729146327, 64615.0, 65222.347776522576, 65540.0, 72994.0, 73387.63306183541, 73689.0, 73814.0, 73967.26032739712, 15880.0, 16495.670086598202, 16508.0, 16510.75233871493, 16741.911775734538, 12387.256764594153, 12545.996320294355, 12587.496500139892, 12630.494780208872, 12635.873641263654, 18617.88292702442, 19341.80658193428, 20827.1669133236, 21027.894860525907, 21699.34901952944, 7556.886646700304, 8801.867971980426, 8894.155055269739, 8965.910340896638, 9012.954935225282, 959.8656188133667, 965.584798536622, 988.5403287471361, 1002.4236064262932, 1128.6219116596033, 29713.0, 29727.40545189084, 30064.24839379033, 30555.0, 30604.0, 1090.6564432203832, 1092.7213560542011, 1157.432857899623, 1184.7393573413835, 1220.0605533738972, 15265.0, 15301.387944482318, 15330.923345383202, 15426.768598471032, 15706.0, 542123.0, 547956.0, 548477.0, 548896.0, 551463.0, 58266.7086664564, 58373.416265837644, 58735.825283494094, 59093.40906590879, 59506.0, 1314.8685131486775, 1365.9550443910416, 1432.6991331820227, 1449.8332691740163, 1456.0462896802612, 24386.87806560956, 29093.41813163767, 30361.69638303677, 31481.370372591962, 31744.206394840312, 53302.46697532975, 53805.92388152293, 53874.730626346616, 54016.72991635017, 54021.0, 505408.0, 511044.0, 511932.0, 512422.0, 513575.0, 43618.56381436272, 44127.77936110299, 44558.0, 45208.77395613001, 45306.32040519461, 42960.0, 43093.13813723771, 43558.0, 44080.0, 44153.33769993517, 35277.47083793694, 36431.817840910626, 36658.08354791151, 36891.26217475689, 38165.618343816204, 37264.25471490609, 37410.8129459351, 37449.62550374462, 37449.78322262496, 37746.62253377431, 37338.06654833651, 37515.0, 38148.23703525969, 38408.0, 38502.0, 30335.696643033287, 31902.840485797424, 34443.655563444045, 34958.82520587381, 35176.0, 24431.38921526905, 25175.622365664894, 25357.732113394624, 25630.871845640653, 25761.96952121894], "unit": "score", "name": "ext.html", "value": 20101.27098987058}, {"lowerIsBetter": false, "replicates": [338.9847456864441, 358.24053007623843, 362.64823121572084, 363.894470603525, 365.1710616899636, 15413.92293038536, 17531.0, 18681.252749890005, 18962.431127066175, 19450.0, 18397.0, 19010.809891901077, 19059.523511912175, 19138.42584722457, 19395.030248487554, 5508.944910550903, 5814.651120932736, 5815.970920145414, 5819.592628516006, 5832.591718579701, 4043.5147782266167, 4135.214309281242, 5052.570531504826, 5738.512226460756, 5971.283445986488, 5909.793157239497, 6135.570510064297, 6326.525510586702, 6339.968300158493, 6344.873102537947, 6372.522060845432, 6385.648789316586, 6412.454941329993, 6422.357764223587, 6425.550211485198, 5375.946240537583, 5460.6177567570285, 5488.204210389511, 5540.335159780811, 5559.722013899329, 24618.384540386454, 24775.25674229776, 25033.87483062591, 25233.0, 25260.98956041756, 2251.8311126665403, 2273.5111950930464, 2485.254423672891, 2706.851123188224, 2868.5983962245305, 9391.953040234755, 9579.473128977903, 9741.928387877328, 9897.307188496809, 9939.65211217611, 1571.5599632103028, 1721.1136264823626, 1784.0722824131508, 1805.6208196278797, 1861.2089861808813, 94789.0, 95492.52253738687, 96229.03770962342, 96356.9999999993, 97688.0, 10953.507092180871, 11137.05335046514, 11202.495887685074, 11208.495617697223, 11250.156238281998, 13225.603231903058, 13244.006699497577, 13272.0, 13303.46786128544, 13342.266175360448, 8433.915660843435, 8443.408961372768, 8491.108433614505, 8512.233898949124, 8566.957165214259, 8576.185262400062, 8591.09793471689, 8615.0, 8664.0, 8676.440450067244, 4012.7391719538136, 4341.826326946887, 4357.0, 4415.757133357696, 4459.531749166355, 1777.2002598830577, 1817.1096162880094, 1857.3870622694478, 1879.793222745497, 1889.0177107903812, 400.94787677601727, 404.119020535236, 432.87879393769794, 754.9698012079565, 952.2524818017823, 10903.672889813319, 11586.841315868514, 11655.30068195911, 20200.0, 20849.58300833975, 926.5876684875166, 1004.1514919892825, 1021.371856308365, 1024.1448390593937, 1099.395332567085, 8944.0, 9790.5594248259, 10904.454777261106, 10966.0, 11091.55633774656, 721141.0, 733944.0, 740421.0, 775697.0, 778612.0, 123127.0, 123399.0, 123781.38109309397, 124994.37502812428, 128356.0, 1207.5169932027084, 1211.8000529912642, 1261.2810697902291, 1264.4120483974996, 1289.4842063174617, 17630.559236019202, 17928.92426454417, 17946.282148713904, 18081.638367232845, 18318.816811832243, 51270.230946535085, 52179.47820521746, 52391.73804130955, 52521.47478525166, 52947.0, 73776.63111684407, 74743.25256747362, 76169.0, 77874.61062694651, 83940.0, 10018.749531261778, 10954.726131846768, 10958.232923695265, 10983.231173817756, 11085.501152447998, 8296.253337199681, 8664.220220180214, 8720.869186962074, 12135.817962730744, 12213.938930305292, 7528.661210245443, 7772.7668169954995, 7783.494072885244, 7840.529568225925, 7855.489393189425, 6930.653467326714, 7513.549187048795, 7654.8086297843, 7771.145174030739, 7787.844243114992, 7390.002349682724, 7816.10114836801, 7827.178146294557, 7899.802504937193, 8043.638036288498, 10927.945360273148, 11005.394703291397, 11039.006489415991, 11220.1023918088, 11293.322400655987, 9070.773230669287, 10868.347899125762, 10891.836622450512, 11069.944650276697, 11231.21381503287], "unit": "score", "name": "jquery.html", "value": 9082.360795930266}, {"lowerIsBetter": false, "replicates": [1536.316339229043, 1543.4675037112195, 1778.4753497718173, 1873.6252749450123, 1899.9335023274189, 7904.565248911322, 7977.321927636158, 8855.512946787932, 9079.228265597432, 9088.182063614273, 8525.78685532862, 8579.742607721762, 8607.182317679826, 8740.606672699729, 8780.868286975685, 2453.153661986616, 2461.1386014894824, 2486.465409936863, 2486.825922185448, 2497.650328953948, 2432.136591510015, 2492.0779311654715, 2494.4262819551514, 2496.014074440595, 2499.2252401755422, 2466.260121963404, 2486.415692312305, 2503.849769013856, 2510.447701505666, 2512.824102312839, 2238.238998740428, 2329.4409341758023, 2498.0132847525215, 2511.982647027938, 2513.648089267504, 2071.8135367816967, 2471.6045432730857, 2495.8502489850666, 2499.9125030624023, 2504.6368276599974, 8984.955075224647, 8989.775255618597, 8991.0, 8996.280297576179, 9015.909840901639, 5412.56699464042, 5574.637648552831, 5585.776568937237, 5594.356648985378, 5618.269624948731, 3686.189038411572, 3773.056735816046, 3811.7712937223578, 3827.5598306194865, 3837.9808100959317, 1057.836035414512, 1076.2412499188054, 1077.175960390302, 1105.4362275239685, 1107.3189988157305, 12137.575184868576, 12203.694907627292, 12354.629361119181, 12390.690232744164, 12399.814002789966, 4997.825076122318, 5008.899822003539, 5039.118154322979, 5055.443901170868, 5060.291559181717, 9215.677451289306, 9752.829660440651, 9956.655851460106, 10170.033846784543, 10444.268901176996, 4198.433211516467, 4655.185342565038, 5420.701861397582, 5489.862753431196, 5557.055300598827, 4437.400950871591, 4574.5425457453985, 4878.756062196876, 4989.950100499022, 5021.59827213822, 3997.0, 4003.2794097062224, 4063.431119643193, 4069.694772892045, 4085.387191921176, 1325.2578556008666, 1327.561904571489, 1336.6123824090905, 1342.8724271194221, 1344.1061693973593, 1139.6979800352913, 1353.3909740616762, 1357.0907491980397, 1378.827646544182, 1385.3350391811784, 8207.95896020528, 8253.13342099083, 8269.751907442665, 8274.917250827535, 8381.203785640355, 511.6674161794789, 514.8018013064922, 516.9327987361619, 517.647999360431, 518.1166111779407, 6097.17688112108, 6169.383061693795, 6220.530648125989, 6228.34602366754, 6235.750569977241, 10912.727181820517, 11085.0, 11192.552297908156, 11321.547138114383, 11322.094232461382, 9313.53432328381, 10880.782384352427, 10890.673279801618, 10921.453927303603, 11086.722831929266, 8362.661974084118, 8487.0, 8506.957465212634, 8553.486790792573, 8593.570321483901, 7969.402294827795, 7995.400344974267, 8009.719659812112, 8095.595220238847, 8127.878081828895, 9608.423494590346, 9835.852462213215, 9931.900680993098, 9944.701658950244, 10063.39619622825, 10027.392877851666, 10262.794744105226, 10263.384196948207, 10277.486125693835, 10399.84400233982, 7434.182239953492, 7627.618619068913, 7673.271039251262, 7680.308772210527, 7690.6539205737, 6833.4191593715095, 8233.83532329362, 8279.254867061993, 8327.541985190872, 8351.582420879053, 7607.809804754926, 7739.92260077392, 7757.107932587599, 7857.764267071997, 7996.920030799618, 7667.923320766721, 7681.078270607562, 7754.651040703069, 7779.4554381192775, 7841.843163136819, 7792.415568832247, 7854.803629909298, 7903.091144518454, 7905.4466187368635, 7970.4819186752675, 7034.5427547209265, 7115.217326094229, 7144.571325720473, 7194.280571942764, 7215.67529461186, 7061.364477197077, 7081.221065682667, 7120.252373500708, 7161.21226665056, 7175.103112110986], "unit": "score", "name": "mootools.html", "value": 4917.694926321277}, {"lowerIsBetter": false, "replicates": [324.8278412441406, 329.59789057350025, 332.15300982494665, 335.13367943865114, 338.5074716287803, 5379.67721936684, 5574.358948720893, 6858.862822743542, 6962.268961759012, 7089.822754431136, 6704.56420332678, 6883.3460821222025, 6887.0, 6943.1668199816095, 6962.0, 4331.588499092589, 4833.984863178736, 5021.447640759514, 5033.823816166435, 5058.570021548173, 4939.703617782927, 5003.899142188713, 5056.79772809089, 5069.974650126745, 5100.974495127519, 4965.7020578765205, 4993.875153121183, 5001.17480615698, 5013.373328333958, 5048.2175262834135, 5008.69947803133, 5008.774605142778, 5012.248162775594, 5031.471695471996, 5051.419086805027, 3496.8776092836883, 4166.375043743433, 4169.56219596944, 4179.6029377209115, 4322.330038843953, 5913.994620914455, 6568.507361947825, 6635.601863888182, 6649.135612370361, 6652.733890644368, 5445.945540544583, 6000.159977603139, 6046.969765151146, 6053.214301780941, 6058.0, 7219.855602887966, 7440.85118297631, 7441.7023319067175, 7445.553266804009, 7486.0, 4893.755312234374, 4896.485868983741, 4904.681195722303, 4905.068037072945, 4906.190478571031, 7854.1753115922575, 7861.371090312761, 7882.487638303492, 7906.288434040964, 7907.44647874649, 4844.4798016525865, 4930.630202734809, 4981.551660350586, 4982.451930287665, 5008.373953255843, 5093.745312734349, 5103.489651034941, 5104.081265372194, 5110.97444512775, 5116.258142569381, 6022.488088512438, 6027.276726792813, 6031.698415079229, 6041.365656606081, 6051.878962420815, 7216.314450127335, 7474.439417043744, 7483.4761566690895, 7486.288802563748, 7491.475596708287, 1744.8516876065676, 1761.9471415857545, 1762.8765986381086, 1767.558110472382, 1768.5578605348662, 1121.764429469804, 1127.0476447401932, 1129.1474936423112, 1129.4635048351968, 1149.2989276541302, 6898.724051037902, 6898.793036208821, 6904.929735890945, 6905.551139176038, 6960.164780226405, 5512.3385193777, 7793.415493837985, 7799.454038217384, 7815.765527034198, 7822.0, 5725.856853578611, 6387.8501869663905, 6871.759488417882, 6888.035675005503, 6967.477439192081, 4013.3979903014783, 4079.551249362568, 4101.0, 4121.52602450716, 4141.751494910315, 8002.9599852000365, 8097.514149151069, 8138.959305203436, 8141.674333026613, 8174.9182508175345, 7991.2807847294025, 8003.759887203277, 8008.7597372078935, 8010.639521221559, 8020.238077382639, 7879.369650427952, 8219.794505137299, 8226.62980165882, 8234.341252699769, 8245.670173193004, 6695.4308883745425, 7863.882041769263, 7877.330426913776, 7922.326602238643, 7930.682772689028, 5943.465088142088, 7442.813929651802, 7669.923300766921, 7685.577293248925, 7694.1536430993665, 8121.593920303843, 8135.674573017013, 8144.271668990955, 8157.306628936607, 8195.71315003972, 4966.255061740768, 5022.598192144546, 5042.193249080129, 5075.746212689277, 5079.796808127633, 7551.207123251979, 7708.113566939649, 7730.7680769577, 7775.455718099679, 7827.9608601956625, 6271.811845644638, 7378.631068446449, 7546.396288297033, 7568.924310756822, 7572.545647261182, 6503.406665367015, 7048.259932707197, 7243.927560724325, 7472.738454154079, 7493.475456717977, 7345.265473452612, 7347.485676002629, 7356.448266379936, 7370.852582948418, 7398.482106252511, 7557.2820582044615, 7579.924200757921, 7585.317321441097, 7586.431017673807, 7612.581308028111, 7142.714291428285, 7388.556686598821, 7393.8890916637365, 7413.592252425952, 7430.405567554691], "unit": "score", "name": "prototype.html", "value": 5409.2779322748}, {"lowerIsBetter": false, "replicates": [677.5629718831353, 719.1442183801277, 722.2813300765739, 729.3071581997101, 729.7117638532783, 13815.309234538283, 13955.58133256004, 14449.855501444983, 14750.114993100422, 14758.557243282705, 15233.542993710178, 15401.537953861374, 15454.459093931715, 15505.922470387632, 15511.146886921215, 837.7068026190846, 839.7858546070759, 845.0662018469595, 846.5217152308957, 855.1277696749312, 846.919542643451, 852.0159216105408, 853.1937319233296, 855.9443636163629, 859.1108203009886, 875.0549406640813, 894.6332003878412, 903.8011637439753, 905.4069584422214, 906.1074841281365, 886.9379143459961, 896.2695403246333, 901.0448924140433, 904.2539904578716, 906.8594367872957, 659.515256286629, 667.7896462614309, 668.6656671664168, 668.8060462465879, 671.4024518178825, 12224.266544007389, 14303.427862885472, 14317.0, 14351.641208969755, 14360.066595671353, 11538.826917596243, 12179.512819487298, 12363.62909112728, 12595.181313214613, 12876.22742635445, 10060.0, 10109.292349535535, 10157.441340726256, 10190.133838623726, 10373.896261037444, 3447.276072024878, 3474.1835668618105, 3490.441529355291, 3688.2807852468777, 3688.907777305562, 75695.6215218926, 77641.0, 78454.0, 83009.16990830074, 83312.91717707046, 9470.452724857249, 9646.372985755903, 9989.350692204984, 10017.04838040385, 10286.639967601099, 19140.617187656168, 19165.32921347746, 20955.05702243372, 20970.475738106365, 21012.15951361959, 7361.852762944711, 7431.479796414307, 7459.776206713807, 7634.580098094658, 7731.381489480828, 4066.268071747055, 4110.05468742191, 4112.485939257593, 4298.183345164472, 4343.869683909487, 3563.964360356363, 3566.4828599853395, 3579.19468119671, 3592.6946209571956, 3596.82015899204, 640.4844100499143, 658.1279804259375, 661.2362721057186, 668.7157957867984, 673.8618583190532, 609.4027852704374, 616.0881894795727, 621.0559948877681, 624.5316012990257, 629.2951893878885, 8296.253337199681, 8475.962497506434, 8726.345524085718, 8785.956070219609, 8908.643654253887, 519.7764961066702, 537.6263496869637, 555.7999120316683, 585.8125399872085, 608.5466327585976, 3995.300822356076, 4034.5561988181275, 4041.516039611802, 4096.569860164699, 4130.896727581834, 92779.0, 93141.53429232947, 95376.0, 95949.52025239829, 96329.51835240779, 62854.114376568774, 78604.60697696474, 82178.0, 82202.3559528806, 83538.58230708807, 68004.0, 69299.26751831143, 70531.0, 70918.64540677263, 71922.64038679878, 6924.892017277211, 8074.515529068275, 8169.0, 8355.289800367036, 8429.747107586782, 49370.75314623404, 49454.75272623614, 50337.0, 50441.73895652638, 51132.23301650404, 65505.0, 69464.0, 69565.00002499575, 70468.0, 71991.0, 9882.703518894445, 10065.899341006496, 10150.0, 10221.642242521773, 10520.526576303932, 10708.196885233483, 10859.0, 10861.945690271814, 10961.616343427942, 11044.613438529614, 9066.957299910595, 9417.246620270225, 10338.844917326396, 10437.947810261205, 10539.841902371623, 10260.846087308548, 10300.0, 10692.62575809843, 11065.114790816877, 11108.333499990027, 10232.897671023493, 10340.0, 10350.482475876026, 10534.841977370192, 10556.683299501028, 8503.149685031447, 8610.870836937576, 8647.783805404915, 8773.692920747742, 8914.55427228623, 8114.634841432032, 8865.423747456394, 8900.510471924106, 8992.28061755071, 9197.632094716137], "unit": "score", "name": "yui.html", "value": 6759.361570846395}], "name": "dromaeo_css", "value": 7559.078250732533}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 114.0, 113.0, 115.0, 123.0, 149.0, 169.0, 94.0, 165.0], "unit": "score", "name": "ai-astar", "value": 126.2}, {"lowerIsBetter": true, "replicates": [159.0, 120.0, 149.0, 173.0, 150.0, 176.0, 127.0, 153.0, 188.0, 153.0], "unit": "score", "name": "audio-beat-detection", "value": 154.8}, {"lowerIsBetter": true, "replicates": [195.0, 192.0, 195.0, 215.0, 208.0, 195.0, 199.0, 193.0, 206.0, 197.0], "unit": "score", "name": "audio-dft", "value": 199.5}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 74.0, 107.0, 57.0, 58.0, 57.0, 61.0, 115.0, 59.0], "unit": "score", "name": "audio-fft", "value": 73.3}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 116.0, 80.0, 82.0, 81.0, 119.0, 64.0, 84.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [90.0, 95.0, 89.0, 96.0, 91.0, 95.0, 89.0, 96.0, 89.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.5}, {"lowerIsBetter": true, "replicates": [104.0, 109.0, 108.0, 151.0, 152.0, 116.0, 152.0, 105.0, 139.0, 151.0], "unit": "score", "name": "imaging-darkroom", "value": 128.7}, {"lowerIsBetter": true, "replicates": [91.0, 94.0, 90.0, 92.0, 94.0, 97.0, 92.0, 92.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 92.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 56.0, 54.0, 56.0, 56.0, 55.0, 61.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 68.0, 77.0, 74.0, 72.0, 67.0, 67.0, 68.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 87.0, 85.0, 85.0, 86.0, 86.0, 89.0, 87.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [130.0, 128.0, 132.0, 127.0, 132.0, 127.0, 132.0, 122.0, 111.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [160.0, 146.0, 142.0, 139.0, 151.0, 170.0, 172.0, 153.0, 136.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.9}, {"lowerIsBetter": true, "replicates": [69.0, 78.0, 89.0, 93.0, 86.0, 67.0, 67.0, 67.0, 67.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.7}], "name": "kraken", "value": 1524.9}]} 04:54:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1524.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7559.08"}}} 04:54:54 INFO - Return code: 0 04:54:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:54:54 INFO - # TBPL SUCCESS # 04:54:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:54:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:54:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:54:54 INFO - 2016-01-29 04:54:54.971 screenresolution[1699:10803] starting screenresolution argv=screenresolution get 04:54:54 INFO - 2016-01-29 04:54:54.974 screenresolution[1699:10803] Display 0: 1600x1200x32@50 04:54:54 INFO - 2016-01-29 04:54:54.980 screenresolution[1700:10806] starting screenresolution argv=screenresolution list 04:54:54 INFO - Available Modes on Display 0 04:54:54 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 04:54:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:54:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:54:54 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 04:54:54 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 04:54:55 INFO - Graphics/Displays: 04:54:55 INFO - Intel Iris: 04:54:55 INFO - Chipset Model: Intel Iris 04:54:55 INFO - Type: GPU 04:54:55 INFO - Bus: Built-In 04:54:55 INFO - VRAM (Dynamic, Max): 1536 MB 04:54:55 INFO - Vendor: Intel (0x8086) 04:54:55 INFO - Device ID: 0x0a2e 04:54:55 INFO - Revision ID: 0x0009 04:54:55 INFO - Displays: 04:54:55 INFO - Display: 04:54:55 INFO - Resolution: 1600 x 1200 @ 50 Hz 04:54:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:54:55 INFO - Display Serial Number: 1600x1200 50 04:54:55 INFO - Main Display: Yes 04:54:55 INFO - Mirror: Off 04:54:55 INFO - Online: Yes 04:54:55 INFO - Rotation: Supported 04:54:55 INFO - Return code: 0 04:54:55 INFO - Running post-action listener: _resource_record_post_action 04:54:55 INFO - Running post-run listener: _resource_record_post_run 04:54:56 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 33951232; Write bytes: 711186944; Read time: 353; Write time: 1983 04:54:56 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388999680; Write bytes: 383706624; Read time: 29729; Write time: 688 04:54:56 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 33013248; Write bytes: 304481280; Read time: 339; Write time: 1247 04:54:56 INFO - Running post-run listener: _upload_blobber_files 04:54:56 INFO - Blob upload gear active. 04:54:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:54:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:54:56 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'] 04:54:56 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 04:54:56 INFO - (blobuploader) - INFO - Open directory for files ... 04:54:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:54:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:54:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:57 INFO - (blobuploader) - INFO - Done attempting. 04:54:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:54:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:54:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:58 INFO - (blobuploader) - INFO - Done attempting. 04:54:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:58 INFO - Return code: 0 04:54:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c432f5b2dd9441fbbbc7e50a7487948b1789c2a67aa7fe481c34f8c47c181216d8252cb6673a2be7be20503e2116b1e1e0264b3fb2c2d8fe1b45e5500ea43615", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a848b402c00a407c840a232eb72e035da5e142406fe2d22c3441567e83001e58bf796a65a47c1f980d1fcc0aa6f9c3a5ddb89a0bcecbbb79410805ad27448437"} 04:54:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:58 INFO - Contents: 04:54:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c432f5b2dd9441fbbbc7e50a7487948b1789c2a67aa7fe481c34f8c47c181216d8252cb6673a2be7be20503e2116b1e1e0264b3fb2c2d8fe1b45e5500ea43615", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a848b402c00a407c840a232eb72e035da5e142406fe2d22c3441567e83001e58bf796a65a47c1f980d1fcc0aa6f9c3a5ddb89a0bcecbbb79410805ad27448437"} 04:54:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:54:58 INFO - Copying logs to upload dir... 04:54:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:54:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.881769 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-01-29 04:54:58.942230) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 04:54:58.945800) ========= 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.4vKhmkKmLw/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.7N4uONB5iB/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c432f5b2dd9441fbbbc7e50a7487948b1789c2a67aa7fe481c34f8c47c181216d8252cb6673a2be7be20503e2116b1e1e0264b3fb2c2d8fe1b45e5500ea43615", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a848b402c00a407c840a232eb72e035da5e142406fe2d22c3441567e83001e58bf796a65a47c1f980d1fcc0aa6f9c3a5ddb89a0bcecbbb79410805ad27448437"} build_url:https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011511 build_url: 'https://queue.taskcluster.net/v1/task/VrX_OJGkQX63m-tDya-jGg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c432f5b2dd9441fbbbc7e50a7487948b1789c2a67aa7fe481c34f8c47c181216d8252cb6673a2be7be20503e2116b1e1e0264b3fb2c2d8fe1b45e5500ea43615", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a848b402c00a407c840a232eb72e035da5e142406fe2d22c3441567e83001e58bf796a65a47c1f980d1fcc0aa6f9c3a5ddb89a0bcecbbb79410805ad27448437"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 04:54:58.975083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:54:58.975564) ========= 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.4vKhmkKmLw/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.7N4uONB5iB/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005305 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 04:54:59.029995) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 04:54:59.030331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 04:54:59.030739) ========= ========= Total master_lag: 0.38 =========