builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0042 starttime: 1457010897.48 results: success (0) buildid: 20160303030253 builduid: c789c432c721404fbc1fe450f5d61cd6 revision: 2b5237c178ea02133a777396c24dd2b713f2b8ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:57.478326) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:57.478760) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:57.479096) ========= 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.4C2PdgTh0u/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.jaong0YtkY/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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.006002 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:57.550785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:57.551144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:57.694811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:57.695116) ========= 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.4C2PdgTh0u/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.jaong0YtkY/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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.005839 ========= master_lag: 0.52 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:58.220460) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:58.220757) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:58.221140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:58.221445) ========= 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.4C2PdgTh0u/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.jaong0YtkY/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-03 05:14:58-- 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% 28.6M=0s 2016-03-03 05:14:58 (28.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.529484 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:58.929464) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:58.929822) ========= 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.4C2PdgTh0u/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.jaong0YtkY/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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.026701 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:14:58.998854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 05:14:58.999265) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2b5237c178ea02133a777396c24dd2b713f2b8ee --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 2b5237c178ea02133a777396c24dd2b713f2b8ee --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4C2PdgTh0u/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.jaong0YtkY/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-03 05:14:59,078 truncating revision to first 12 chars 2016-03-03 05:14:59,078 Setting DEBUG logging. 2016-03-03 05:14:59,078 attempt 1/10 2016-03-03 05:14:59,078 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2b5237c178ea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 05:15:00,167 unpacking tar archive at: mozilla-central-2b5237c178ea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.341843 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 05:15:00.376989) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 05:15:00.377382) ========= echo 2b5237c178ea02133a777396c24dd2b713f2b8ee in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2b5237c178ea02133a777396c24dd2b713f2b8ee'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4C2PdgTh0u/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.jaong0YtkY/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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 2b5237c178ea02133a777396c24dd2b713f2b8ee program finished with exit code 0 elapsedTime=0.005268 script_repo_revision: '2b5237c178ea02133a777396c24dd2b713f2b8ee' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 05:15:00.434940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 05:15:00.435277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 05:15:00.454181) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-03 05:15:00.454518) ========= /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.4C2PdgTh0u/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.jaong0YtkY/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:15:00 INFO - MultiFileLogger online at 20160303 05:15:00 in /builds/slave/test 05:15:00 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 05:15:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:00 INFO - {'append_to_log': False, 05:15:00 INFO - 'base_work_dir': '/builds/slave/test', 05:15:00 INFO - 'blob_upload_branch': 'Firefox', 05:15:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:00 INFO - 'branch': 'Firefox', 05:15:00 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:00 INFO - 'config_files': ('talos/mac_config.py',), 05:15:00 INFO - 'default_actions': ('clobber', 05:15:00 INFO - 'read-buildbot-config', 05:15:00 INFO - 'download-and-extract', 05:15:00 INFO - 'populate-webroot', 05:15:00 INFO - 'create-virtualenv', 05:15:00 INFO - 'install', 05:15:00 INFO - 'run-tests'), 05:15:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:00 INFO - 'download_minidump_stackwalk': True, 05:15:00 INFO - 'download_symbols': 'ondemand', 05:15:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:00 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:00 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:00 INFO - 'installer_path': 'installer.exe', 05:15:00 INFO - 'log_level': 'info', 05:15:00 INFO - 'log_name': 'talos', 05:15:00 INFO - 'log_to_console': True, 05:15:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:15:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:15:00 INFO - 'opt_config_files': (), 05:15:00 INFO - 'pip_index': False, 05:15:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:00 INFO - 'cmd': ('bash', 05:15:00 INFO - '-c', 05:15:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:00 INFO - 'enabled': True, 05:15:00 INFO - 'halt_on_failure': False, 05:15:00 INFO - 'name': 'check_screen_resolution'},), 05:15:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:00 INFO - 'cmd': ('bash', 05:15:00 INFO - '-c', 05:15:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:00 INFO - 'enabled': True, 05:15:00 INFO - 'halt_on_failure': False, 05:15:00 INFO - 'name': 'check_screen_resolution'},), 05:15:00 INFO - 'run_cmd_checks_enabled': True, 05:15:00 INFO - 'sps_profile': False, 05:15:00 INFO - 'sps_profile_interval': 0, 05:15:00 INFO - 'suite': 'dromaeojs-e10s', 05:15:00 INFO - 'system_bits': '32', 05:15:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:00 INFO - 'title': 't-yosemite-r7-0042', 05:15:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:00 INFO - 'use_talos_json': True, 05:15:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:00 INFO - 'work_dir': 'build'} 05:15:00 INFO - ##### 05:15:00 INFO - ##### Running clobber step. 05:15:00 INFO - ##### 05:15:00 INFO - Running pre-action listener: _resource_record_pre_action 05:15:00 INFO - Running main action method: clobber 05:15:00 INFO - rmtree: /builds/slave/test/build 05:15:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:02 INFO - Running post-action listener: _resource_record_post_action 05:15:02 INFO - ##### 05:15:02 INFO - ##### Running read-buildbot-config step. 05:15:02 INFO - ##### 05:15:02 INFO - Running pre-action listener: _resource_record_pre_action 05:15:02 INFO - Running main action method: read_buildbot_config 05:15:02 INFO - Using buildbot properties: 05:15:02 INFO - { 05:15:02 INFO - "project": "", 05:15:02 INFO - "product": "firefox", 05:15:02 INFO - "script_repo_revision": "production", 05:15:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:15:02 INFO - "repository": "", 05:15:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:15:02 INFO - "buildid": "20160303030253", 05:15:02 INFO - "stage_platform": "macosx64", 05:15:02 INFO - "basedir": "/builds/slave/test", 05:15:02 INFO - "nightly_build": "True", 05:15:02 INFO - "buildnumber": 159, 05:15:02 INFO - "slavename": "t-yosemite-r7-0042", 05:15:02 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:15:02 INFO - "platform": "yosemite_r7", 05:15:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:15:02 INFO - "branch": "mozilla-central", 05:15:02 INFO - "repo_path": "mozilla-central", 05:15:02 INFO - "revision": "2b5237c178ea02133a777396c24dd2b713f2b8ee", 05:15:02 INFO - "pgo_build": "False", 05:15:02 INFO - "builduid": "c789c432c721404fbc1fe450f5d61cd6", 05:15:02 INFO - "slavebuilddir": "test" 05:15:02 INFO - } 05:15:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:15:02 INFO - Running post-action listener: _resource_record_post_action 05:15:02 INFO - ##### 05:15:02 INFO - ##### Running download-and-extract step. 05:15:02 INFO - ##### 05:15:02 INFO - Running pre-action listener: _resource_record_pre_action 05:15:02 INFO - Running main action method: download_and_extract 05:15:02 INFO - mkdir: /builds/slave/test/build/tests 05:15:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:02 INFO - https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:15:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 05:15:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 05:15:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 05:15:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 05:15:04 INFO - Downloaded 1277 bytes. 05:15:04 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 05:15:04 INFO - Using the following test package requirements: 05:15:04 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:15:04 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:04 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:15:04 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:04 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:15:04 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:04 INFO - u'jsshell-mac.zip'], 05:15:04 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:04 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:15:04 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:15:04 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:04 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:15:04 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:04 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:15:04 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:04 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:15:04 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:15:04 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:15:04 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:15:04 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:15:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:04 INFO - https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:15:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:15:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:15:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/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 05:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/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 05:15:05 INFO - Downloaded 17855186 bytes. 05:15:05 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'] 05:15:05 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 05:15:08 INFO - Return code: 0 05:15:08 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 05:15: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')]} 05:15:08 INFO - https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:15:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:15:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:15:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/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 05:15:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/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 05:15:09 INFO - Downloaded 17855186 bytes. 05:15:09 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'] 05:15:09 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 05:15:13 INFO - Return code: 0 05:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:13 INFO - https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:15:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:15:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:15:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/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 05:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/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 05:15:14 INFO - Downloaded 10808282 bytes. 05:15:14 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'] 05:15:14 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 05:15:14 INFO - Return code: 0 05:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:14 INFO - https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:15:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:15:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:15:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:15:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy6zxHToS7Su41uqgl2-EQ/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 05:15:19 INFO - Downloaded 111088650 bytes. 05:15:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:15:19 INFO - mkdir: /builds/slave/test/properties 05:15:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:15:19 INFO - Writing to file /builds/slave/test/properties/build_url 05:15:19 INFO - Contents: 05:15:19 INFO - build_url:https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:15:20 INFO - Running post-action listener: _resource_record_post_action 05:15:20 INFO - Running post-action listener: set_extra_try_arguments 05:15:20 INFO - ##### 05:15:20 INFO - ##### Running populate-webroot step. 05:15:20 INFO - ##### 05:15:20 INFO - Running pre-action listener: _resource_record_pre_action 05:15:20 INFO - Running main action method: populate_webroot 05:15:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:15:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:15:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:15:20 INFO - '--tppagecycles', 05:15:20 INFO - '7'], 05:15:20 INFO - 'tests': ['tsvgm']}}, 05:15:20 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:15:20 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:15:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:15:20 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:15:20 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:15:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:15:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:20 INFO - 'talos_options': ['--e10s'], 05:15:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:15:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:20 INFO - 'tests': ['damp', 'tps']}, 05:15:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:20 INFO - 'talos_options': ['--e10s'], 05:15:20 INFO - 'tests': ['damp', 'tps']}, 05:15:20 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:15:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:15:20 INFO - 'other': {'tests': ['a11yr', 05:15:20 INFO - 'ts_paint', 05:15:20 INFO - 'tpaint', 05:15:20 INFO - 'sessionrestore', 05:15:20 INFO - 'sessionrestore_no_auto_restore']}, 05:15:20 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:15:20 INFO - 'tests': ['a11yr', 05:15:20 INFO - 'ts_paint', 05:15:20 INFO - 'tpaint', 05:15:20 INFO - 'sessionrestore', 05:15:20 INFO - 'sessionrestore_no_auto_restore']}, 05:15:20 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:15:20 INFO - 'tests': ['a11yr', 05:15:20 INFO - 'ts_paint', 05:15:20 INFO - 'tpaint', 05:15:20 INFO - 'sessionrestore', 05:15:20 INFO - 'sessionrestore_no_auto_restore']}, 05:15:20 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:15:20 INFO - 'tests': ['a11yr', 05:15:20 INFO - 'ts_paint', 05:15:20 INFO - 'tpaint', 05:15:20 INFO - 'sessionrestore', 05:15:20 INFO - 'sessionrestore_no_auto_restore']}, 05:15:20 INFO - 'other_l64': {'tests': ['a11yr', 05:15:20 INFO - 'ts_paint', 05:15:20 INFO - 'tpaint', 05:15:20 INFO - 'sessionrestore', 05:15:20 INFO - 'sessionrestore_no_auto_restore']}, 05:15:20 INFO - 'other_nol64': {'tests': ['a11yr', 05:15:20 INFO - 'ts_paint', 05:15:20 INFO - 'tpaint', 05:15:20 INFO - 'sessionrestore', 05:15:20 INFO - 'sessionrestore_no_auto_restore']}, 05:15:20 INFO - 'svgr': {'tests': ['tsvgx', 05:15:20 INFO - 'tsvgr_opacity', 05:15:20 INFO - 'tart', 05:15:20 INFO - 'tscrollx', 05:15:20 INFO - 'cart']}, 05:15:20 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:15:20 INFO - 'tests': ['tsvgx', 05:15:20 INFO - 'tsvgr_opacity', 05:15:20 INFO - 'tart', 05:15:20 INFO - 'tscrollx', 05:15:20 INFO - 'cart']}, 05:15:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:20 INFO - 'tests': ['tp5o']}, 05:15:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:20 INFO - 'talos_options': ['--e10s'], 05:15:20 INFO - 'tests': ['tp5o']}, 05:15:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:20 INFO - 'talos_options': ['--xperf_path', 05:15:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:20 INFO - 'tests': ['tp5n']}, 05:15:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:15:20 INFO - 'talos_options': ['--e10s', 05:15:20 INFO - '--xperf_path', 05:15:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:15:20 INFO - 'tests': ['tp5n']}}, 05:15:20 INFO - 'talos.zip': {'path': '', 05:15:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:15:20 INFO - Running post-action listener: _resource_record_post_action 05:15:20 INFO - ##### 05:15:20 INFO - ##### Running create-virtualenv step. 05:15:20 INFO - ##### 05:15:20 INFO - Running pre-action listener: _resource_record_pre_action 05:15:20 INFO - Running main action method: create_virtualenv 05:15:20 INFO - Creating virtualenv /builds/slave/test/build/venv 05:15:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:15:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:15:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:15:21 INFO - Using real prefix '/tools/python27' 05:15:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:15:21 INFO - Installing distribute.............................................................................................................................................................................................done. 05:15:24 INFO - Installing pip.................done. 05:15:24 INFO - Return code: 0 05:15:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:24 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 0x10dc86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1da5d72b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2ad30>, '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 0x10d94edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db21b20>, '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.4C2PdgTh0u/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.jaong0YtkY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:15:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4C2PdgTh0u/Render', 05:15:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:24 INFO - 'HOME': '/Users/cltbld', 05:15:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:24 INFO - 'LOGNAME': 'cltbld', 05:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:24 INFO - 'MOZ_NO_REMOTE': '1', 05:15:24 INFO - 'NO_EM_RESTART': '1', 05:15:24 INFO - 'PAGER': '/bin/cat', 05:15:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:24 INFO - 'PWD': '/builds/slave/test', 05:15:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:24 INFO - 'SHELL': '/bin/bash', 05:15:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaong0YtkY/Listeners', 05:15:24 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 05:15:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:24 INFO - 'USER': 'cltbld', 05:15:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:24 INFO - 'XPC_FLAGS': '0x0', 05:15:24 INFO - 'XPC_SERVICE_NAME': '0', 05:15:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:15:24 INFO - Cleaning up... 05:15:24 INFO - Return code: 0 05:15:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:24 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 0x10dc86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1da5d72b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2ad30>, '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 0x10d94edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db21b20>, '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.4C2PdgTh0u/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.jaong0YtkY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:15:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4C2PdgTh0u/Render', 05:15:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:24 INFO - 'HOME': '/Users/cltbld', 05:15:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:24 INFO - 'LOGNAME': 'cltbld', 05:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:24 INFO - 'MOZ_NO_REMOTE': '1', 05:15:24 INFO - 'NO_EM_RESTART': '1', 05:15:24 INFO - 'PAGER': '/bin/cat', 05:15:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:24 INFO - 'PWD': '/builds/slave/test', 05:15:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:24 INFO - 'SHELL': '/bin/bash', 05:15:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaong0YtkY/Listeners', 05:15:24 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 05:15:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:24 INFO - 'USER': 'cltbld', 05:15:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:24 INFO - 'XPC_FLAGS': '0x0', 05:15:24 INFO - 'XPC_SERVICE_NAME': '0', 05:15:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:25 INFO - Downloading/unpacking psutil>=0.7.1 05:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:15:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:27 INFO - Installing collected packages: psutil 05:15:27 INFO - Running setup.py install for psutil 05:15:27 INFO - building 'psutil._psutil_osx' extension 05:15:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:15:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:15:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:15:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:15:28 INFO - building 'psutil._psutil_posix' extension 05:15:28 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:15:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:15:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:15:28 INFO - ^ 05:15:28 INFO - 1 warning generated. 05:15:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:15:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:15:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:15:28 INFO - Successfully installed psutil 05:15:28 INFO - Cleaning up... 05:15:28 INFO - Return code: 0 05:15:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:28 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 0x10dc86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1da5d72b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2ad30>, '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 0x10d94edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db21b20>, '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.4C2PdgTh0u/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.jaong0YtkY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4C2PdgTh0u/Render', 05:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:28 INFO - 'HOME': '/Users/cltbld', 05:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:28 INFO - 'LOGNAME': 'cltbld', 05:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:28 INFO - 'MOZ_NO_REMOTE': '1', 05:15:28 INFO - 'NO_EM_RESTART': '1', 05:15:28 INFO - 'PAGER': '/bin/cat', 05:15:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:28 INFO - 'PWD': '/builds/slave/test', 05:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:28 INFO - 'SHELL': '/bin/bash', 05:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaong0YtkY/Listeners', 05:15:28 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 05:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:28 INFO - 'USER': 'cltbld', 05:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:28 INFO - 'XPC_FLAGS': '0x0', 05:15:28 INFO - 'XPC_SERVICE_NAME': '0', 05:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:15:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:15:31 INFO - Installing collected packages: mozsystemmonitor 05:15:31 INFO - Running setup.py install for mozsystemmonitor 05:15:31 INFO - Successfully installed mozsystemmonitor 05:15:31 INFO - Cleaning up... 05:15:31 INFO - Return code: 0 05:15:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:31 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 0x10dc86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1da5d72b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2ad30>, '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 0x10d94edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db21b20>, '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.4C2PdgTh0u/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.jaong0YtkY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:15:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4C2PdgTh0u/Render', 05:15:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:31 INFO - 'HOME': '/Users/cltbld', 05:15:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:31 INFO - 'LOGNAME': 'cltbld', 05:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:31 INFO - 'MOZ_NO_REMOTE': '1', 05:15:31 INFO - 'NO_EM_RESTART': '1', 05:15:31 INFO - 'PAGER': '/bin/cat', 05:15:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:31 INFO - 'PWD': '/builds/slave/test', 05:15:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:31 INFO - 'SHELL': '/bin/bash', 05:15:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaong0YtkY/Listeners', 05:15:31 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 05:15:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:31 INFO - 'USER': 'cltbld', 05:15:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:31 INFO - 'XPC_FLAGS': '0x0', 05:15:31 INFO - 'XPC_SERVICE_NAME': '0', 05:15:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:32 INFO - Downloading/unpacking blobuploader==1.2.4 05:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:34 INFO - Downloading blobuploader-1.2.4.tar.gz 05:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:15:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:15:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:35 INFO - Downloading docopt-0.6.1.tar.gz 05:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:15:35 INFO - Installing collected packages: blobuploader, requests, docopt 05:15:35 INFO - Running setup.py install for blobuploader 05:15:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:15:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:15:35 INFO - Running setup.py install for requests 05:15:36 INFO - Running setup.py install for docopt 05:15:36 INFO - Successfully installed blobuploader requests docopt 05:15:36 INFO - Cleaning up... 05:15:36 INFO - Return code: 0 05:15:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:36 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 0x10dc86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1da5d72b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2ad30>, '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 0x10d94edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db21b20>, '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.4C2PdgTh0u/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.jaong0YtkY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4C2PdgTh0u/Render', 05:15:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:36 INFO - 'HOME': '/Users/cltbld', 05:15:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:36 INFO - 'LOGNAME': 'cltbld', 05:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:36 INFO - 'MOZ_NO_REMOTE': '1', 05:15:36 INFO - 'NO_EM_RESTART': '1', 05:15:36 INFO - 'PAGER': '/bin/cat', 05:15:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:36 INFO - 'PWD': '/builds/slave/test', 05:15:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:36 INFO - 'SHELL': '/bin/bash', 05:15:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaong0YtkY/Listeners', 05:15:36 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 05:15:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:36 INFO - 'USER': 'cltbld', 05:15:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:36 INFO - 'XPC_FLAGS': '0x0', 05:15:36 INFO - 'XPC_SERVICE_NAME': '0', 05:15:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:36 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-B7dfmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:36 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-n179qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:36 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-utv50m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-Tl5KZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-voV1HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-qHltvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-JFhDZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-Vjxyai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-45YB81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-7F4eRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-rvcDaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-RjMDtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:37 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-92evwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-7v741E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-yAK3vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-HQHZn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:38 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-1itdM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:15:38 INFO - Running setup.py install for manifestparser 05:15:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:15:38 INFO - Running setup.py install for mozcrash 05:15:38 INFO - Running setup.py install for mozdebug 05:15:38 INFO - Running setup.py install for mozdevice 05:15:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:15:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:15:39 INFO - Running setup.py install for mozfile 05:15:39 INFO - Running setup.py install for mozhttpd 05:15:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:15:39 INFO - Running setup.py install for mozinfo 05:15:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:15:39 INFO - Running setup.py install for mozInstall 05:15:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:15:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:15:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:15:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:15:39 INFO - Running setup.py install for mozleak 05:15:39 INFO - Running setup.py install for mozlog 05:15:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:39 INFO - Running setup.py install for moznetwork 05:15:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:40 INFO - Running setup.py install for mozprocess 05:15:40 INFO - Running setup.py install for mozprofile 05:15:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:40 INFO - Running setup.py install for mozrunner 05:15:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:40 INFO - Running setup.py install for mozscreenshot 05:15:40 INFO - Running setup.py install for moztest 05:15:40 INFO - Running setup.py install for mozversion 05:15:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:41 INFO - Cleaning up... 05:15:41 INFO - Return code: 0 05:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:41 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 0x10dc86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1da5d72b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2ad30>, '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 0x10d94edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db21b20>, '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.4C2PdgTh0u/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.jaong0YtkY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4C2PdgTh0u/Render', 05:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:41 INFO - 'HOME': '/Users/cltbld', 05:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:41 INFO - 'LOGNAME': 'cltbld', 05:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:41 INFO - 'MOZ_NO_REMOTE': '1', 05:15:41 INFO - 'NO_EM_RESTART': '1', 05:15:41 INFO - 'PAGER': '/bin/cat', 05:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:41 INFO - 'PWD': '/builds/slave/test', 05:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:41 INFO - 'SHELL': '/bin/bash', 05:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaong0YtkY/Listeners', 05:15:41 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 05:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:41 INFO - 'USER': 'cltbld', 05:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:41 INFO - 'XPC_FLAGS': '0x0', 05:15:41 INFO - 'XPC_SERVICE_NAME': '0', 05:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:41 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-pL0oZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:41 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-3hLZDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:41 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)) 05:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:41 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-EWdabw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:41 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-EloSoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:41 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-mkAjjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:41 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-Ry6pXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:41 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-YVzKc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-mnWbDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-kcLXRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-GHdAM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-aMXHFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-1LdzAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-JOBZAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-T10WpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-FFmqQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:42 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-CRXeVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:43 INFO - Running setup.py (path:/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/pip-5Vc3NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:15:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:45 INFO - Downloading blessings-1.6.tar.gz 05:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:45 INFO - Installing collected packages: blessings 05:15:45 INFO - Running setup.py install for blessings 05:15:45 INFO - Successfully installed blessings 05:15:45 INFO - Cleaning up... 05:15:45 INFO - Return code: 0 05:15:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:46 INFO - Reading from file tmpfile_stdout 05:15:46 INFO - Current package versions: 05:15:46 INFO - blessings == 1.6 05:15:46 INFO - blobuploader == 1.2.4 05:15:46 INFO - docopt == 0.6.1 05:15:46 INFO - manifestparser == 1.1 05:15:46 INFO - mozInstall == 1.12 05:15:46 INFO - mozcrash == 0.16 05:15:46 INFO - mozdebug == 0.1 05:15:46 INFO - mozdevice == 0.48 05:15:46 INFO - mozfile == 1.2 05:15:46 INFO - mozhttpd == 0.7 05:15:46 INFO - mozinfo == 0.9 05:15:46 INFO - mozleak == 0.1 05:15:46 INFO - mozlog == 3.1 05:15:46 INFO - moznetwork == 0.27 05:15:46 INFO - mozprocess == 0.22 05:15:46 INFO - mozprofile == 0.28 05:15:46 INFO - mozrunner == 6.11 05:15:46 INFO - mozscreenshot == 0.1 05:15:46 INFO - mozsystemmonitor == 0.0 05:15:46 INFO - moztest == 0.7 05:15:46 INFO - mozversion == 1.4 05:15:46 INFO - psutil == 3.1.1 05:15:46 INFO - requests == 1.2.3 05:15:46 INFO - wsgiref == 0.1.2 05:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1da5d72b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2ad30>, '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 0x10d94edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db21b20>, '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.4C2PdgTh0u/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.jaong0YtkY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4C2PdgTh0u/Render', 05:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:46 INFO - 'HOME': '/Users/cltbld', 05:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:46 INFO - 'LOGNAME': 'cltbld', 05:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:46 INFO - 'MOZ_NO_REMOTE': '1', 05:15:46 INFO - 'NO_EM_RESTART': '1', 05:15:46 INFO - 'PAGER': '/bin/cat', 05:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:46 INFO - 'PWD': '/builds/slave/test', 05:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:46 INFO - 'SHELL': '/bin/bash', 05:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaong0YtkY/Listeners', 05:15:46 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 05:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:46 INFO - 'USER': 'cltbld', 05:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:46 INFO - 'XPC_FLAGS': '0x0', 05:15:46 INFO - 'XPC_SERVICE_NAME': '0', 05:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:15:46 INFO - Cleaning up... 05:15:46 INFO - Return code: 0 05:15:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15: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')]} 05:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15: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')]} 05:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1da5d72b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2ad30>, '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 0x10d94edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db21b20>, '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.4C2PdgTh0u/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.jaong0YtkY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:15:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4C2PdgTh0u/Render', 05:15:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:46 INFO - 'HOME': '/Users/cltbld', 05:15:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:46 INFO - 'LOGNAME': 'cltbld', 05:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:46 INFO - 'MOZ_NO_REMOTE': '1', 05:15:46 INFO - 'NO_EM_RESTART': '1', 05:15:46 INFO - 'PAGER': '/bin/cat', 05:15:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:46 INFO - 'PWD': '/builds/slave/test', 05:15:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:46 INFO - 'SHELL': '/bin/bash', 05:15:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaong0YtkY/Listeners', 05:15:46 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 05:15:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:46 INFO - 'USER': 'cltbld', 05:15:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:46 INFO - 'XPC_FLAGS': '0x0', 05:15:46 INFO - 'XPC_SERVICE_NAME': '0', 05:15:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:46 INFO - Downloading/unpacking jsonschema 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15: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 05:15:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:15:48 INFO - Downloading/unpacking functools32 (from jsonschema) 05:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:49 INFO - Downloading functools32-3.2.3-2.tar.gz 05:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:15:49 INFO - warning: no files found matching '*.txt' 05:15:49 INFO - no previously-included directories found matching 'build' 05:15:49 INFO - no previously-included directories found matching 'dist' 05:15:49 INFO - no previously-included directories found matching '.git*' 05:15:49 INFO - Installing collected packages: jsonschema, functools32 05:15:49 INFO - Running setup.py install for functools32 05:15:49 INFO - warning: no files found matching '*.txt' 05:15:49 INFO - no previously-included directories found matching 'build' 05:15:49 INFO - no previously-included directories found matching 'dist' 05:15:49 INFO - no previously-included directories found matching '.git*' 05:15:49 INFO - Successfully installed jsonschema functools32 05:15:49 INFO - Cleaning up... 05:15:49 INFO - Return code: 0 05:15:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10dc86a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc8d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1da5d72b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db2ad30>, '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 0x10d94edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db21b20>, '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.4C2PdgTh0u/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.jaong0YtkY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:15:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4C2PdgTh0u/Render', 05:15:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:49 INFO - 'HOME': '/Users/cltbld', 05:15:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:49 INFO - 'LOGNAME': 'cltbld', 05:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:49 INFO - 'MOZ_NO_REMOTE': '1', 05:15:49 INFO - 'NO_EM_RESTART': '1', 05:15:49 INFO - 'PAGER': '/bin/cat', 05:15:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:49 INFO - 'PWD': '/builds/slave/test', 05:15:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:49 INFO - 'SHELL': '/bin/bash', 05:15:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaong0YtkY/Listeners', 05:15:49 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 05:15:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:49 INFO - 'USER': 'cltbld', 05:15:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:49 INFO - 'XPC_FLAGS': '0x0', 05:15:49 INFO - 'XPC_SERVICE_NAME': '0', 05:15:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:49 INFO - Downloading/unpacking flake8 05:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:15:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:15:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:15:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:53 INFO - no previously-included directories found matching 'docs/_build' 05:15:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:15:53 INFO - Running setup.py install for pep8 05:15:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:15:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:15:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:15:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:15:53 INFO - no previously-included directories found matching 'docs/_build' 05:15:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:15:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:15:53 INFO - Cleaning up... 05:15:53 INFO - Return code: 0 05:15:53 INFO - Running post-action listener: _resource_record_post_action 05:15:53 INFO - Running post-action listener: _start_resource_monitoring 05:15:53 INFO - Starting resource monitoring. 05:15:53 INFO - ##### 05:15:53 INFO - ##### Running install step. 05:15:53 INFO - ##### 05:15:53 INFO - Running pre-action listener: _resource_record_pre_action 05:15:53 INFO - Running main action method: install 05:15:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:54 INFO - Reading from file tmpfile_stdout 05:15:54 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:54 INFO - Reading from file tmpfile_stdout 05:15:54 INFO - Output received: 05:15:54 INFO - Usage: mozinstall [options] installer 05:15:54 INFO - Options: 05:15:54 INFO - -h, --help show this help message and exit 05:15:54 INFO - -d DEST, --destination=DEST 05:15:54 INFO - Directory to install application into. [default: 05:15:54 INFO - "/builds/slave/test"] 05:15:54 INFO - --app=APP Application being installed. [default: firefox] 05:15:54 INFO - mkdir: /builds/slave/test/build/application 05:15:54 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'] 05:15:54 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 05:16:28 INFO - Reading from file tmpfile_stdout 05:16:28 INFO - Output received: 05:16:28 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:16:28 INFO - Running post-action listener: _resource_record_post_action 05:16:28 INFO - ##### 05:16:28 INFO - ##### Running run-tests step. 05:16:28 INFO - ##### 05:16:28 INFO - Running pre-action listener: _resource_record_pre_action 05:16:28 INFO - Running main action method: run_tests 05:16:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:16:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:16:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:16:28 INFO - 2016-03-03 05:16:28.040 screenresolution[1646:8134] starting screenresolution argv=screenresolution get 05:16:28 INFO - 2016-03-03 05:16:28.043 screenresolution[1646:8134] Display 0: 1600x1200x32@60 05:16:28 INFO - 2016-03-03 05:16:28.049 screenresolution[1647:8136] starting screenresolution argv=screenresolution list 05:16:28 INFO - Available Modes on Display 0 05:16:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:16:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:16:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:16:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:16:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:16:28 INFO - Intel Iris: 05:16:28 INFO - Chipset Model: Intel Iris 05:16:28 INFO - Type: GPU 05:16:28 INFO - Bus: Built-In 05:16:28 INFO - VRAM (Dynamic, Max): 1536 MB 05:16:28 INFO - Vendor: Intel (0x8086) 05:16:28 INFO - Device ID: 0x0a2e 05:16:28 INFO - Revision ID: 0x0009 05:16:28 INFO - Displays: 05:16:28 INFO - Display: 05:16:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:16:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:16:28 INFO - Display Serial Number: 1600x1200 60 05:16:28 INFO - Main Display: Yes 05:16:28 INFO - Mirror: Off 05:16:28 INFO - Online: Yes 05:16:28 INFO - Rotation: Supported 05:16:28 INFO - Return code: 0 05:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:16:28 INFO - Python 2.7.3 05:16:28 INFO - Return code: 0 05:16:28 INFO - grabbing minidump binary from tooltool 05:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:28 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 0x10db2ad30>, '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 0x10d94edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10db21b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:16:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:16:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:16:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:16:28 INFO - Return code: 0 05:16:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:16:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:16:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:16:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:16:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:16:29 INFO - Return code: 0 05:16:29 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0042', '--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 05:16:29 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0042 --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 05:16:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4C2PdgTh0u/Render', 05:16:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:29 INFO - 'HOME': '/Users/cltbld', 05:16:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:29 INFO - 'LOGNAME': 'cltbld', 05:16:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:16:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:29 INFO - 'MOZ_NO_REMOTE': '1', 05:16:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:16:29 INFO - 'NO_EM_RESTART': '1', 05:16:29 INFO - 'PAGER': '/bin/cat', 05:16:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:29 INFO - 'PWD': '/builds/slave/test', 05:16:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:16:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:29 INFO - 'SHELL': '/bin/bash', 05:16:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jaong0YtkY/Listeners', 05:16:29 INFO - 'TMPDIR': '/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/', 05:16:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:29 INFO - 'USER': 'cltbld', 05:16:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:29 INFO - 'XPC_FLAGS': '0x0', 05:16:29 INFO - 'XPC_SERVICE_NAME': '0', 05:16:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:29 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0042', '--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 05:16:29 INFO - mozversion application_buildid: 20160303030253 05:16:29 INFO - mozversion application_changeset: 2b5237c178ea02133a777396c24dd2b713f2b8ee 05:16:29 INFO - mozversion application_display_name: Nightly 05:16:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:16:29 INFO - mozversion application_name: Firefox 05:16:29 INFO - mozversion application_remotingname: firefox 05:16:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:16:29 INFO - mozversion application_vendor: Mozilla 05:16:29 INFO - mozversion application_version: 47.0a1 05:16:29 INFO - mozversion platform_buildid: 20160303030253 05:16:29 INFO - mozversion platform_changeset: 2b5237c178ea02133a777396c24dd2b713f2b8ee 05:16:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:16:29 INFO - mozversion platform_version: 47.0a1 05:16:29 INFO - using testdate: 1457010989 05:16:29 INFO - actual date: 1457010989 05:16:29 INFO - starting webserver on 'localhost:49270' 05:16:29 INFO - SUITE-START | Running 2 tests 05:16:29 INFO - TEST-START | dromaeo_css 05:16:29 INFO - operating with platform_type : mac_ 05:16:29 INFO - Initialising browser for dromaeo_css test... 05:16:29 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpn9TIN9/profile http://localhost:49270/getInfo.html) 05:16:32 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 05:16:32 INFO - PROCESS | 1665 | colorDepth:24 05:16:32 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 05:16:32 INFO - PROCESS | 1665 | __metrics 05:16:33 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:16:33 INFO - TEST-INFO | 1665: exit 0 05:16:33 INFO - Browser initialized. 05:16:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:16:33 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmpn9TIN9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:45 INFO - PROCESS | 1671 | RSS: Main: 254164992 05:16:45 INFO - PROCESS | 1671 | 05:17:35 INFO - PROCESS | 1671 | 1457011055162 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:19:45 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 05:19:46 INFO - PROCESS | 1671 | RSS: Main: 268996608 05:19:46 INFO - PROCESS | 1671 | 05:22:48 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 05:22:49 INFO - PROCESS | 1671 | RSS: Main: 281522176 05:22:49 INFO - PROCESS | 1671 | 05:25:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 05:25:51 INFO - PROCESS | 1671 | RSS: Main: 281825280 05:25:51 INFO - PROCESS | 1671 | 05:28:53 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 05:28:54 INFO - PROCESS | 1671 | RSS: Main: 283643904 05:28:54 INFO - PROCESS | 1671 | 05:31:56 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 05:31:57 INFO - PROCESS | 1671 | RSS: Main: 288153600 05:31:57 INFO - PROCESS | 1671 | 05:34:59 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:34:59 INFO - PROCESS | 1671 | RSS: Main: 288751616 05:34:59 INFO - PROCESS | 1671 | 05:34:59 INFO - PROCESS | 1671 | __start_tp_report 05:34:59 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 05:34:59 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 05:34:59 INFO - PROCESS | 1671 | |i|pagename|runs| 05:34:59 INFO - PROCESS | 1671 | |0;dojo.html;2963.6295463067117;3512.736544759143;3536.451849963255;3566.7146628269743;3569.500269962205;5758.539316854647;5789.855253618662;5803.274590676166;5811.360750317473;5818.854528636786;4551.840685576006;5640.266765320513;5759.337676167242;5806.941930580693;5867.383924687911;5185.87035324118;5210.114280572293;5229.163333866582;5254.159334506479;5267.815626453075;5208.218767184915;5322.095243808542;5365.704886231256;5368.0605893968595;5385.3537575491;4294.828206871722;5110.386753589556;5179.2749015137915;5239.816606418776;5250.05499010178;5216.582673386158;5221.034108689904;5223;5227.3465816772905;5235.842924712265;5183.092958732207;5201.791928322863;5210.921836172461;5244.895102097975;5272.92090618641;4675.275332323496;5003.974980125113;5209.801745598534;5679.977604031273;5684.147377893308;5019.774110165052;6236.625802451822;6260.906086408708;6289.654069026202;6306.306306306303;5068.4424713281505;6282.4974002079725;6297.527685423565;6297.905531417033;6318;4945.480724523945;5827.659638283176;5857.26784151981;5858.443447872445;5888.941110588882;5270.78916843322;6318.589291696025;6341.017142342944;6354.9514330135935;6357.364263573606;5073.086844367976;6095.75616975316;6223.0354295084335;6228.128062071313;6234.594751341148;6272.1219029335925;6299.118123462719;6312.905306420407;6319.9368006320265;6339.11252424661;5308.513616187473;5942.8811423771285;6045.063015232646;6207.689615519206;6287.245530536365;6124.502994489374;6143.419763699257;6169.290531588835;6275.497960163176;6324.588901721373;4840.903181936412;4890.559849613552;4902.460729319772;4918.704877707349;4961.107000739901;4390.319500477431;4406.471223453142;4417.867463976086;4429.955700443019;4436.822527098944;5657.660540367591;5828.737706803204;5839;5840;5920.851978700567;6241.157443745127;6247.2815626202655;6288.056791481315;6296.181496405529;6318.368163183737;5868.677222752704;5928.614640048383;5928.8990254614855;5935.0207215808905;5994.040953447515;5296.232046353257;5333.706646134422;5396.9190462142315;5401.513863752281;5438.347398312228;6373.649449280241;6402.551821372459;6408.647524386203;6438.67806609677;6450.741970321228;5264.605154613496;6264.937350626617;6295.716692748929;6308.653024083719;6317.873642527215;6216.689165541795;6293.276273228637;6352.36476352361;6390.968045159744;6394.616323020634;6183.783567575113;6202.81391558254;6209.782657606962;6240.843978900382;6241.750329986931;6140.933729672948;6283.874322513433;6317.494600432046;6328;6358.046293056079;6061.848453788691;6127.769884593299;6132.998044146438;6140.078988151813;6205.503559715302;6131.877362452637;6133.854967164949;6135.110408990582;6146;6146.938530614637;5792.218050563289;5798.478136967693;5931.911021334769;5950.910736338872;5990.430909063632;6122.764110201883;6159.351478864131;6167.537434692326;6189.50483961273;6200.81397558074;6051.6369017857305;6081.300650425258;6082.130743832223;6093.0121820563945;6104.4505994460715 05:34:59 INFO - PROCESS | 1671 | |1;ext.html;483.4029972983367;550.9476599723025;574.2133277409946;585.5754577931001;648.3095503288997;28632.713672863265;37468.81265593675;37544.624553754424;37683.81158094209;37885.62114378855;39926.00184995377;40805.18389632206;40855.79572102143;40889.795551022275;40918.38622420659;8219.424640275183;9393.107654772803;9595.80808383832;9631.181349585293;9670.081342272473;9402.670906518273;9524.71425857222;9540.236781057498;9555;9556.23550115989;9543.80912381752;9615.903840961606;9627.518624068804;9634.807303853919;9663.613455461773;9361.20429763471;9377.718668439958;9382.906170938306;9404.435733855922;9404.717858464188;9374.109459601395;9422.764430889214;9486;9532.95233523835;9553;37510;37647.4352884707;37849.810750946344;38078.61921380806;38146.61853381458;2586.961195582068;2616.2805228562106;3078.7844850860447;3438.1748380388776;3539.1152211947015;22038.779612203994;26186.73813261862;26388.86805565979;26894.731052689418;27283.86358068197;2695.5417579011614;2697.2582539801515;2734.4667789781;2736.5484695025298;2814.1838866728626;354967;354992;356136.21931890177;356592;357165;60635;60833.69583152144;60878.086828697604;60973.69513152406;61052;70322.29677703157;70853.64573177205;71287.64356178186;71356.286437136;71439.64280178565;16396.508104756875;16448.013119212646;16501.09243991568;16545.83454165467;16580.336786528645;12500.624981250578;12610.558630448073;12697;12715.96544552867;12726.17279876805;19112.426627201206;21185.470363241042;21365.67951480729;21402.464938376666;21449.356519304445;7736.7292144774665;9002.549872506348;9215.156968606305;9218.446893186296;9234.445933244027;943.5376665433888;1030;1073.7100982734773;1088.6244245735209;1088.983665245022;22092;28624.713752862623;28805.99179028724;29280.853595731885;29762.40475190484;1055.2613170780485;1127.4926283172606;1164.5865717670274;1199.8860108289698;1254.7804134276464;14682.926585367004;14746.483873064606;14805.64965550276;14824.481143159937;15039.699206015819;518869;526912;531281;537023;542950;45878.54121458809;56732.43267567354;56828;56980.86038279211;57697.42302577005;1425.201886943315;1425.5723283015054;1451.1800832529798;1466.0543949152736;1470.2134358118142;21832.781672183075;28301.57547636828;28794.568081479214;28852.278693032844;28960.565591516566;40164.19671606493;40622.79688601538;40798.79600601978;41421;45238.77380613076;494053;497538;498825;499655.5017225036;500432;32263;32397.838010809795;32494.350112997134;32779;32822;43409.78295108504;43941.78029109834;43965.78017109894;44261;44978;36558;36581.63418365782;36859.815700921325;37425.4386184202;37479.62520374871;35605.1098722534;35739.46390804088;36175.63824361723;36191.91424257276;36495;29748.851255743582;30485.695143048284;35414.114647134025;35422.46866296956;36071.27857442784;29727.55408668915;30196.24509387283;30811.691883080883;31497;31547.369052619277;19005.619887601893;23839.404014899766;24083.879580602686;24314.51370972606;24450 05:34:59 INFO - PROCESS | 1671 | |2;jquery.html;325.4808580314398;350.62658268943574;363.0234668741087;364.5607043512568;365.71291536144133;19453.3191338303;19657.213711451543;20887.99999999998;20951.847648379335;21033.36899893002;19669;19833.70249446256;20672.27647032354;20714.067866945985;20750.821163777775;4331.935020974695;5383.838484845461;5436.864078398052;5438.456154384569;5440.238366628675;3986.8604598839047;5381.273528073719;5727.3699893011735;5994.400559944014;5995.190649262359;5846.619969701977;5937.020391635375;5944.375840536746;5962.1951036609935;5972.3131839838325;5877.265341832271;6354.904676429857;6380.234371875382;6381.329960354165;6405.583637063576;5545.085060964976;5607.439256074401;5666.320041595035;5673.6879471629045;5691.4877661010705;23917.923693433662;24124.75875241243;24525.754742452526;24812.635305058215;24887.502249954898;2151.6772484127505;2177.085624037908;2245.7305123385136;2250.8086812620945;2734.8632568371504;9553.474558899257;9763;10102.14131798798;13154.671133221651;13414.725601067883;1416.8653977872086;1557.3459147158107;1670.8638126074266;1709.1198033013009;1757.165346460421;94008;97407.02592974121;99484.50257748738;100299;100416;10463.267571270091;11210.495527701272;11466.02538784196;11635.825462618068;11752.647420577396;12516.49934002648;13510.932445337907;13757.38091785872;13793.24137172465;13809.24049177305;8430.494170349799;8503.277221436247;8505.95747021261;8522.105178956244;8564.828703425897;8577.099404562556;8634.870476942851;8655.74032779005;8707.303415726727;8727.781805454915;4425.424694789656;4479.193745125844;4505.752183629932;4506.684532082722;4565.977170114194;1560.305663979541;1800.612868233336;1884.6324966631375;1928.257620815996;1968.9606207875763;818.9877151842727;906.5829718329642;945.2390825385493;993.015986959183;1007.7178390050798;17446.865953712968;19326.710099348522;19756.308529201408;19904.800951990583;20388.28640997558;900.2977677411629;971.1890571372842;975.8341082016075;980.2648013989508;1012.1143999000874;10519.52662130206;10637.361758294526;10657.946710266398;10699.518521666543;10699.625513107005;645696;648037;658497;660549;661702;95879;114104;115857;118061;122036;965.0831709875506;968.2350942755286;976.829054915387;979.3878825733916;988.7379844341256;17520.912395437943;17637.647247055243;17817.10914454298;18034.549136271697;18041.548961276072;51126.74436627793;51412;51743.482565173865;51893.22160167525;52967.735161323944;75074;75326;75456;75626;76344.47311053636;7783.571903545359;7880.5271683696865;8145.307648849915;8201.30288925424;8365.874511882448;9531.618735250513;11080.445977700922;11336.716582085513;12493;13397.732045359233;11091;11419.828702569303;11654.53381864716;11690.70773230676;11693.649190524298;11185.944070279596;11410.714732131763;11417.543298267976;11736.530538778354;11853.229540079867;10000.499975001367;11468.139889508153;11790.587329443428;11822.527098916291;12014.33921134346;6729;8116.553589552631;8300.252977231836;8312;8315.667373305;10314.329568578018;11614.419279036183;11677.06583473337;11797.115216358636;11868.347240901834 05:34:59 INFO - PROCESS | 1671 | |3;mootools.html;1585.5877471857316;1604.3662753212484;1851.3797877710965;1924.3457224543652;1936.351322307027;7905.525668459896;7991.001124859393;8160.714374996869;8517.446365986207;8775.859138312018;8630.309575233981;8657.480551166918;8708.43395179313;8727.345449091312;8752.29981601472;2433.8904749286235;2446.4617784087563;2467.802575793932;2468.160825319391;2471;2409.951671023102;2425.842320249178;2461.396957745355;2480.913168039119;2498.1631153563576;2068.6896965455153;2443.3402981195068;2452.1172377943926;2454.9386265343333;2473.5547601431736;2047.3857842647221;2442.4626582151986;2444.1934161726676;2445.3886528367907;2485.1923124984273;2453.4479742057893;2467.7408872068354;2471.6292556116546;2473.6536884836137;2474.616434452663;8841.16008979146;8867.113288671146;8891.911080889173;8896;8903.866442003375;5353.411124776271;5399.9730001350135;5417.377001644822;5493.505584497414;5496.5053145217125;3553.076200187944;3633.8728144514816;3679.5400574928135;3691.9815400923094;3697.0572504011307;871.3160169267095;921.6405601815297;1058.714147180257;1069.36907224737;1074.8065348237315;11842.052635789203;11847.170698051139;11958.88041119595;12020.759584808342;12021.15851890368;4802.183628783116;4878.780454879468;4923.532264434873;4930.433000205022;4930.802767889316;9063.36556441056;9988.05113514215;10074.294799364121;10154.898451015542;10206.744831379276;5356.143017117321;5441.59188060897;5451.918221226605;5465.043617366945;5500.064988951888;4443;4800.831970881072;4930.964497455575;4965.255211718199;4994.101061808837;3566.7694645347315;3638.308721342936;3931.3709806431407;3932.134930315326;3994.6005399459823;1306.6341424401182;1316.2760481735008;1319.6700824793802;1324.9602511924659;1325.3439547424086;1341.8792308692264;1351.196038357176;1358.721462100267;1367.2001878900955;1371.2526672963259;6991.650417479105;8099.271065604124;8242.17578242183;8273.255407013277;8285.212904774036;504.47282589693856;517.6247220764915;519.5376115257424;520.0560981817988;520.5445235419008;5988.28140623128;6071.574989750675;6154.107654390088;6219.40915613016;6275.623462592259;10634.361938283728;10946.945265273622;10979.505922233519;10992.28550144238;11015.944920275348;10612.310199836986;10639.308444951053;10702.785944281071;10736.194785391126;10916.617918372818;8341.8331633367;8376.53929033909;8394.790130246793;8396.538190399586;8399.706010289488;7804.492707973964;7847.646855891385;7869.48848324857;7879.330256927996;7915.84168316642;9491.145796878314;9639.614415423304;9749.512524373611;9759.56081976327;9773.657921972697;9928.354656947275;10009.24930630191;10117.645882394081;10138;10274.897251027693;6640.83397915056;7374.963125184339;7401.851962960603;7439.2188820173105;7476.21499742541;6997.230304666585;8293.216958353742;8298.502089874626;8323.83352332962;8324.70863519774;7161.928380716126;7249.637518124178;7257.782266532013;7383;7409;7228.9277107230355;7265.910113482809;7270.600116993616;7299.270072992658;7338.853222935618;7622.618869056636;7718.343940765098;7753.10839253493;7773.533587984739;7777.1833957433655;6929.514933954575;6953.548019378724;6955.23492415844;6981.127359080115;7031.472639552157;7066.752663656953;7106.964465177641;7110.075690160246;7135.928640713734;7154.499185056996 05:34:59 INFO - PROCESS | 1671 | |4;prototype.html;324.247745231064;324.56508278906267;328.0830079926605;329.13437658956957;330.33602459057295;6773.627450490228;6823.624700641462;6826.419754320877;6831.146106736658;6840.179178498574;6711.36242057005;6825.897611535831;6826.351496607826;6853.28040555742;6877;4269.957300426987;4493.887652808673;4935.235038569028;4981.601471882241;5027.723475208872;4230.640395566381;4288.592583704543;4317.179735850194;4982.701037937717;5000.124978128831;4896.290037944496;4911.82808601699;4919;4931.063098011385;4950.455449900508;4938.876528086791;4952.975235123838;4959.876003099916;4967.875803104916;4971.925421118686;3453.8273086345835;3533.152043509565;4262.1688770689725;4263.97868010661;4277.101808620194;6262.12330273762;6547.9345206547805;6550.312217217219;6554.868902621968;6564.081028655992;5789.623674461189;5795.623284486537;5804.361520232771;5822.039363505017;5879.1475236090955;5922.58541902067;7304.342609165147;7341.632918354061;7347.1550771661405;7359.411247100273;4663;4664.673472856902;4667.13657973276;4668.393108895856;4688.624910007191;7662.540247585107;7704.191059938682;7746.573938433384;7760.883586746203;7779.222077792232;4507.143642707941;4526.117407105583;4618.56123668251;4682.899518613123;4698.36572062774;4788.066327066189;4817;4822.541858523435;4839.2983017462275;4854.344663470457;5776.595638305278;5828;5830.562707796932;5837.620554663933;5845.853853653608;7292.161401438902;7384.556926584422;7388.778336649909;7399.260073992666;7408.9629551851895;1640.6620565693838;1673.1132499775138;1673.1717799688988;1673.916304184786;1680.0927499150323;1028.9742756431149;1066.2323127348297;1068.3803394031443;1073.6295977887617;1084.5390708948664;5634.633748806396;6848.178218613699;6889.793306200822;6930.861382772317;6943.479239057091;6394.8721025579225;7292.34368906801;7565.508241964255;7580.886286705704;7625.275598818103;5667.433256674382;5687.345955215121;6754.784138854955;6932.202796678345;6962.373386395248;3725.925481490355;3854.5952674969285;4014;4033.5361433435532;4041.939370909439;6343.968280158662;7963.721269755531;7975.122736498981;8014.278714915686;8049.678012879536;7749.302562769265;7788.961055194801;7800.843983120306;7802.882956755653;7827.060752709711;6295.496360291166;6699.832504187434;7858.035491127218;7962.840743185104;7969.561674107864;6791.864162716619;7195.6761945713615;7530.510516816389;7551.660175292235;7629.847403052019;7394.4454165936695;7399.593022383605;7423.665935032828;7431.739889103856;7447.776566702791;6686.832829179115;7951.3638908886;7965.163657816078;7977.361811054986;7995.440319177602;3827.4641550183555;3998.5001874765653;4738.763061846963;4746.264329029006;4747.881302967454;6855.828604284933;7509.5869727163345;7512.286332798375;7547.660355283915;7558.13081495635;7328.303811137934;7328.670209840463;7353.77938661841;7402.148752893271;7414.147373052168;7373.571289350478;7405.518641288299;7413.258674132544;7424.220456851953;7469.402447804271;7191.280871912767;7196;7205.891911621435;7207.819804504929;7233.891491627524;7091.680874360769;7377.151627562899;7388;7392.7042918284815;7398.667059982206;7144.571325720473;7210.9278907210255;7217.350438460564;7223.566586004857;7224.602646854473 05:34:59 INFO - PROCESS | 1671 | |5;yui.html;682.7746843541629;704.362551890539;704.988341729618;732.1763016606318;773.1572585881388;13891.513797017107;14703.485378011772;15044.774328385056;15113.622159446006;15125.621859453506;13483.325833708324;13600.455981760717;15475.071495710265;15811.367545298202;15851.445199418024;872.1888643561485;883.6112110671316;886.6674996876171;887.8801361816137;888.0985799413601;705.5272967112022;720.9387202087829;864.7276108025983;865.35098675993;866.9826603467927;913.3150137396952;914.8993610702818;921.3918813583036;931.4830269200625;933.174140885318;884.0938038510513;907.1200935092983;923.6351641101794;923.8660394242797;924.7641851327902;673.7742856143198;677.190757045331;677.9931801275103;688.8760023195823;690.3407246079981;15006.249687515581;15277.236138193046;15374.923755337131;15378.3079761411;15386.692266154727;12347.876521234852;12455.25626412303;12460.626181214579;12599.559015434415;12686.936565317206;10085.142762865093;10101.848472272923;10161.33951293171;10199.847002294971;10492.737681557946;3419.111031131899;3437.123533498967;3489.284696637183;3515.9648403515894;3563.5367402237544;82073;82474.58762706148;84414.57792711059;84937;84969.57515212447;7827.765167044998;8440.860483834604;9192.402493837879;9198.95400522993;9240.815183696288;17363.739543906853;19004.334848280243;20861.895690521753;20918.58162836735;21013.579728405348;6986.93013069873;7091.503594748421;7206.675699593531;7249.238829922782;7390.778276651709;3975.8608448704736;3984.0438294809614;3999.5800440953863;4023.456833327522;4038.374052021941;3264.037109052835;3273.1489812648883;3275.19757659375;3294.7034766870615;3311.1556553078813;524.3105316508855;572.5877368294904;603.0291231117897;603.1284793473476;604.6100265328838;542.8425756530562;549.1405949688724;555.872149405639;563.7012383436785;577.3101144132805;7968.721094761656;8008.599570021475;8025.640513608977;8126.512409255463;8195.464771347215;559.6809818403552;565.7778702575172;566.8979583674978;593.175486074357;594.1770647653032;3093.2576181716677;3555.5733312002208;3727.459518369821;3766.114962983697;3817;86679;87010;88146;88467;92600;80489.59755201187;80696.19303806887;80829.59585202036;81657.87565932579;82045.76931346035;64884;65588.67205664037;66501.33498665049;66825.6658716713;70948;7886.250806173404;7899.407544434305;8075.636596353061;8141.22658347456;8157.55133467665;45590;46993;49821.252681210535;50186.498135018184;51215;63770.68114659582;68948.65525672339;68985;69054;69328;10325.070743633109;10397.896021039995;10511.789764204826;10595.682129536126;11198;11449.828252576051;11622.6513204604;11630.302181869114;11659.88340116588;11992.100592455427;10911.345319280868;10982.505787239754;11259.774804504028;11314.83027754568;11436.19946603763;10989.945050274697;11025.779484410106;11321.433928303717;11390.202685811913;11406.600768973047;10776.892231077589;10796.838047429452;10820.837687434538;11128.554857805597;11232.887671123184;9076.364654474124;9126;9281.76795580089;9357.251419886257;9479.952600236955;8825.470471771714;9140.954295228481;9224.308176886627;9278.072192780668;9314.115159059878 05:34:59 INFO - PROCESS | 1671 | __end_tp_report 05:34:59 INFO - PROCESS | 1671 | __start_cc_report 05:34:59 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,341 05:34:59 INFO - PROCESS | 1671 | __end_cc_report 05:34:59 INFO - PROCESS | 1671 | __startTimestamp1457012099958__endTimestamp 05:34:59 INFO - PROCESS | 1671 | 05:34:59 INFO - PROCESS | 1671 | ------- Summary: start ------- 05:34:59 INFO - PROCESS | 1671 | Number of tests: 6 05:34:59 INFO - PROCESS | 1671 | 05:34:59 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5721.80 Median:5935.02 stddev:676.80 (11.4%) stddev-sans-first:643.36 05:34:59 INFO - PROCESS | 1671 | Values: 2963.6 3512.7 3536.5 3566.7 3569.5 5758.5 5789.9 5803.3 5811.4 5818.9 4551.8 5640.3 5759.3 5806.9 5867.4 5185.9 5210.1 5229.2 5254.2 5267.8 5208.2 5322.1 5365.7 5368.1 5385.4 4294.8 5110.4 5179.3 5239.8 5250.1 5216.6 5221.0 5223.0 5227.3 5235.8 5183.1 5201.8 5210.9 5244.9 5272.9 4675.3 5004.0 5209.8 5680.0 5684.1 5019.8 6236.6 6260.9 6289.7 6306.3 5068.4 6282.5 6297.5 6297.9 6318.0 4945.5 5827.7 5857.3 5858.4 5888.9 5270.8 6318.6 6341.0 6355.0 6357.4 5073.1 6095.8 6223.0 6228.1 6234.6 6272.1 6299.1 6312.9 6319.9 6339.1 5308.5 5942.9 6045.1 6207.7 6287.2 6124.5 6143.4 6169.3 6275.5 6324.6 4840.9 4890.6 4902.5 4918.7 4961.1 4390.3 4406.5 4417.9 4430.0 4436.8 5657.7 5828.7 5839.0 5840.0 5920.9 6241.2 6247.3 6288.1 6296.2 6318.4 5868.7 5928.6 5928.9 5935.0 5994.0 5296.2 5333.7 5396.9 5401.5 5438.3 6373.6 6402.6 6408.6 6438.7 6450.7 5264.6 6264.9 6295.7 6308.7 6317.9 6216.7 6293.3 6352.4 6391.0 6394.6 6183.8 6202.8 6209.8 6240.8 6241.8 6140.9 6283.9 6317.5 6328.0 6358.0 6061.8 6127.8 6133.0 6140.1 6205.5 6131.9 6133.9 6135.1 6146.0 6146.9 5792.2 5798.5 5931.9 5950.9 5990.4 6122.8 6159.4 6167.5 6189.5 6200.8 6051.6 6081.3 6082.1 6093.0 6104.5 05:34:59 INFO - PROCESS | 1671 | 05:34:59 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:60475.73 Median:36569.82 stddev:124582.80 (340.7%) stddev-sans-first:124850.86 05:34:59 INFO - PROCESS | 1671 | Values: 483.4 550.9 574.2 585.6 648.3 28632.7 37468.8 37544.6 37683.8 37885.6 39926.0 40805.2 40855.8 40889.8 40918.4 8219.4 9393.1 9595.8 9631.2 9670.1 9402.7 9524.7 9540.2 9555.0 9556.2 9543.8 9615.9 9627.5 9634.8 9663.6 9361.2 9377.7 9382.9 9404.4 9404.7 9374.1 9422.8 9486.0 9533.0 9553.0 37510.0 37647.4 37849.8 38078.6 38146.6 2587.0 2616.3 3078.8 3438.2 3539.1 22038.8 26186.7 26388.9 26894.7 27283.9 2695.5 2697.3 2734.5 2736.5 2814.2 354967.0 354992.0 356136.2 356592.0 357165.0 60635.0 60833.7 60878.1 60973.7 61052.0 70322.3 70853.6 71287.6 71356.3 71439.6 16396.5 16448.0 16501.1 16545.8 16580.3 12500.6 12610.6 12697.0 12716.0 12726.2 19112.4 21185.5 21365.7 21402.5 21449.4 7736.7 9002.5 9215.2 9218.4 9234.4 943.5 1030.0 1073.7 1088.6 1089.0 22092.0 28624.7 28806.0 29280.9 29762.4 1055.3 1127.5 1164.6 1199.9 1254.8 14682.9 14746.5 14805.6 14824.5 15039.7 518869.0 526912.0 531281.0 537023.0 542950.0 45878.5 56732.4 56828.0 56980.9 57697.4 1425.2 1425.6 1451.2 1466.1 1470.2 21832.8 28301.6 28794.6 28852.3 28960.6 40164.2 40622.8 40798.8 41421.0 45238.8 494053.0 497538.0 498825.0 499655.5 500432.0 32263.0 32397.8 32494.4 32779.0 32822.0 43409.8 43941.8 43965.8 44261.0 44978.0 36558.0 36581.6 36859.8 37425.4 37479.6 35605.1 35739.5 36175.6 36191.9 36495.0 29748.9 30485.7 35414.1 35422.5 36071.3 29727.6 30196.2 30811.7 31497.0 31547.4 19005.6 23839.4 24083.9 24314.5 24450.0 05:34:59 INFO - PROCESS | 1671 | 05:34:59 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:35428.03 Median:338.05 stddev:108122.94 (31984.0%) stddev-sans-first:108394.13 05:34:59 INFO - PROCESS | 1671 | Values: 325.5 350.6 363.0 364.6 365.7 19453.3 19657.2 20888.0 20951.8 21033.4 19669.0 19833.7 20672.3 20714.1 20750.8 4331.9 5383.8 5436.9 5438.5 5440.2 3986.9 5381.3 5727.4 5994.4 5995.2 5846.6 5937.0 5944.4 5962.2 5972.3 5877.3 6354.9 6380.2 6381.3 6405.6 5545.1 5607.4 5666.3 5673.7 5691.5 23917.9 24124.8 24525.8 24812.6 24887.5 2151.7 2177.1 2245.7 2250.8 2734.9 9553.5 9763.0 10102.1 13154.7 13414.7 1416.9 1557.3 1670.9 1709.1 1757.2 94008.0 97407.0 99484.5 100299.0 100416.0 10463.3 11210.5 11466.0 11635.8 11752.6 12516.5 13510.9 13757.4 13793.2 13809.2 8430.5 8503.3 8506.0 8522.1 8564.8 8577.1 8634.9 8655.7 8707.3 8727.8 4425.4 4479.2 4505.8 4506.7 4566.0 1560.3 1800.6 1884.6 1928.3 1969.0 819.0 906.6 945.2 993.0 1007.7 17446.9 19326.7 19756.3 19904.8 20388.3 900.3 971.2 975.8 980.3 1012.1 10519.5 10637.4 10657.9 10699.5 10699.6 645696.0 648037.0 658497.0 660549.0 661702.0 95879.0 114104.0 115857.0 118061.0 122036.0 965.1 968.2 976.8 979.4 988.7 17520.9 17637.6 17817.1 18034.5 18041.5 51126.7 51412.0 51743.5 51893.2 52967.7 75074.0 75326.0 75456.0 75626.0 76344.5 7783.6 7880.5 8145.3 8201.3 8365.9 9531.6 11080.4 11336.7 12493.0 13397.7 11091.0 11419.8 11654.5 11690.7 11693.6 11185.9 11410.7 11417.5 11736.5 11853.2 10000.5 11468.1 11790.6 11822.5 12014.3 6729.0 8116.6 8300.3 8312.0 8315.7 10314.3 11614.4 11677.1 11797.1 11868.3 05:34:59 INFO - PROCESS | 1671 | 05:34:59 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:6036.74 Median:5354.78 stddev:3215.45 (60.0%) stddev-sans-first:3207.07 05:34:59 INFO - PROCESS | 1671 | Values: 1585.6 1604.4 1851.4 1924.3 1936.4 7905.5 7991.0 8160.7 8517.4 8775.9 8630.3 8657.5 8708.4 8727.3 8752.3 2433.9 2446.5 2467.8 2468.2 2471.0 2410.0 2425.8 2461.4 2480.9 2498.2 2068.7 2443.3 2452.1 2454.9 2473.6 2047.4 2442.5 2444.2 2445.4 2485.2 2453.4 2467.7 2471.6 2473.7 2474.6 8841.2 8867.1 8891.9 8896.0 8903.9 5353.4 5400.0 5417.4 5493.5 5496.5 3553.1 3633.9 3679.5 3692.0 3697.1 871.3 921.6 1058.7 1069.4 1074.8 11842.1 11847.2 11958.9 12020.8 12021.2 4802.2 4878.8 4923.5 4930.4 4930.8 9063.4 9988.1 10074.3 10154.9 10206.7 5356.1 5441.6 5451.9 5465.0 5500.1 4443.0 4800.8 4931.0 4965.3 4994.1 3566.8 3638.3 3931.4 3932.1 3994.6 1306.6 1316.3 1319.7 1325.0 1325.3 1341.9 1351.2 1358.7 1367.2 1371.3 6991.7 8099.3 8242.2 8273.3 8285.2 504.5 517.6 519.5 520.1 520.5 5988.3 6071.6 6154.1 6219.4 6275.6 10634.4 10946.9 10979.5 10992.3 11015.9 10612.3 10639.3 10702.8 10736.2 10916.6 8341.8 8376.5 8394.8 8396.5 8399.7 7804.5 7847.6 7869.5 7879.3 7915.8 9491.1 9639.6 9749.5 9759.6 9773.7 9928.4 10009.2 10117.6 10138.0 10274.9 6640.8 7375.0 7401.9 7439.2 7476.2 6997.2 8293.2 8298.5 8323.8 8324.7 7161.9 7249.6 7257.8 7383.0 7409.0 7228.9 7265.9 7270.6 7299.3 7338.9 7622.6 7718.3 7753.1 7773.5 7777.2 6929.5 6953.5 6955.2 6981.1 7031.5 7066.8 7107.0 7110.1 7135.9 7154.5 05:34:59 INFO - PROCESS | 1671 | 05:34:59 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:5892.87 Median:6764.21 stddev:1941.62 (28.7%) stddev-sans-first:1901.55 05:34:59 INFO - PROCESS | 1671 | Values: 324.2 324.6 328.1 329.1 330.3 6773.6 6823.6 6826.4 6831.1 6840.2 6711.4 6825.9 6826.4 6853.3 6877.0 4270.0 4493.9 4935.2 4981.6 5027.7 4230.6 4288.6 4317.2 4982.7 5000.1 4896.3 4911.8 4919.0 4931.1 4950.5 4938.9 4953.0 4959.9 4967.9 4971.9 3453.8 3533.2 4262.2 4264.0 4277.1 6262.1 6547.9 6550.3 6554.9 6564.1 5789.6 5795.6 5804.4 5822.0 5879.1 5922.6 7304.3 7341.6 7347.2 7359.4 4663.0 4664.7 4667.1 4668.4 4688.6 7662.5 7704.2 7746.6 7760.9 7779.2 4507.1 4526.1 4618.6 4682.9 4698.4 4788.1 4817.0 4822.5 4839.3 4854.3 5776.6 5828.0 5830.6 5837.6 5845.9 7292.2 7384.6 7388.8 7399.3 7409.0 1640.7 1673.1 1673.2 1673.9 1680.1 1029.0 1066.2 1068.4 1073.6 1084.5 5634.6 6848.2 6889.8 6930.9 6943.5 6394.9 7292.3 7565.5 7580.9 7625.3 5667.4 5687.3 6754.8 6932.2 6962.4 3725.9 3854.6 4014.0 4033.5 4041.9 6344.0 7963.7 7975.1 8014.3 8049.7 7749.3 7789.0 7800.8 7802.9 7827.1 6295.5 6699.8 7858.0 7962.8 7969.6 6791.9 7195.7 7530.5 7551.7 7629.8 7394.4 7399.6 7423.7 7431.7 7447.8 6686.8 7951.4 7965.2 7977.4 7995.4 3827.5 3998.5 4738.8 4746.3 4747.9 6855.8 7509.6 7512.3 7547.7 7558.1 7328.3 7328.7 7353.8 7402.1 7414.1 7373.6 7405.5 7413.3 7424.2 7469.4 7191.3 7196.0 7205.9 7207.8 7233.9 7091.7 7377.2 7388.0 7392.7 7398.7 7144.6 7210.9 7217.4 7223.6 7224.6 05:34:59 INFO - PROCESS | 1671 | 05:34:59 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18105.70 Median:593.68 stddev:25669.09 (4323.8%) stddev-sans-first:25707.76 05:34:59 INFO - PROCESS | 1671 | Values: 682.8 704.4 705.0 732.2 773.2 13891.5 14703.5 15044.8 15113.6 15125.6 13483.3 13600.5 15475.1 15811.4 15851.4 872.2 883.6 886.7 887.9 888.1 705.5 720.9 864.7 865.4 867.0 913.3 914.9 921.4 931.5 933.2 884.1 907.1 923.6 923.9 924.8 673.8 677.2 678.0 688.9 690.3 15006.2 15277.2 15374.9 15378.3 15386.7 12347.9 12455.3 12460.6 12599.6 12686.9 10085.1 10101.8 10161.3 10199.8 10492.7 3419.1 3437.1 3489.3 3516.0 3563.5 82073.0 82474.6 84414.6 84937.0 84969.6 7827.8 8440.9 9192.4 9199.0 9240.8 17363.7 19004.3 20861.9 20918.6 21013.6 6986.9 7091.5 7206.7 7249.2 7390.8 3975.9 3984.0 3999.6 4023.5 4038.4 3264.0 3273.1 3275.2 3294.7 3311.2 524.3 572.6 603.0 603.1 604.6 542.8 549.1 555.9 563.7 577.3 7968.7 8008.6 8025.6 8126.5 8195.5 559.7 565.8 566.9 593.2 594.2 3093.3 3555.6 3727.5 3766.1 3817.0 86679.0 87010.0 88146.0 88467.0 92600.0 80489.6 80696.2 80829.6 81657.9 82045.8 64884.0 65588.7 66501.3 66825.7 70948.0 7886.3 7899.4 8075.6 8141.2 8157.6 45590.0 46993.0 49821.3 50186.5 51215.0 63770.7 68948.7 68985.0 69054.0 69328.0 10325.1 10397.9 10511.8 10595.7 11198.0 11449.8 11622.7 11630.3 11659.9 11992.1 10911.3 10982.5 11259.8 11314.8 11436.2 10989.9 11025.8 11321.4 11390.2 11406.6 10776.9 10796.8 10820.8 11128.6 11232.9 9076.4 9126.0 9281.8 9357.3 9480.0 8825.5 9141.0 9224.3 9278.1 9314.1 05:34:59 INFO - PROCESS | 1671 | -------- Summary: end -------- 05:34:59 INFO - PROCESS | 1671 | 05:35:00 INFO - TEST-INFO | 1671: exit 0 05:35:00 INFO - TEST-OK | dromaeo_css | took 1110546ms 05:35:00 INFO - TEST-START | kraken 05:35:00 INFO - operating with platform_type : mac_ 05:35:00 INFO - Initialising browser for kraken test... 05:35:00 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmp8TDkNY/profile http://localhost:49270/getInfo.html) 05:35:03 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 05:35:03 INFO - PROCESS | 1680 | colorDepth:24 05:35:03 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 05:35:03 INFO - PROCESS | 1680 | __metrics 05:35:03 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:35:03 INFO - TEST-INFO | 1680: exit 0 05:35:03 INFO - Browser initialized. 05:35:03 INFO - Running cycle 1/1 for kraken test... 05:35:03 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/T/tmp8TDkNY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:15 INFO - PROCESS | 1684 | RSS: Main: 254193664 05:35:15 INFO - PROCESS | 1684 | 05:35:18 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:19 INFO - PROCESS | 1684 | RSS: Main: 268914688 05:35:19 INFO - PROCESS | 1684 | 05:35:22 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 05:35:22 INFO - PROCESS | 1684 | RSS: Main: 276561920 05:35:22 INFO - PROCESS | 1684 | 05:35:25 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 05:35:26 INFO - PROCESS | 1684 | RSS: Main: 281026560 05:35:26 INFO - PROCESS | 1684 | 05:35:28 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 05:35:29 INFO - PROCESS | 1684 | RSS: Main: 283439104 05:35:29 INFO - PROCESS | 1684 | 05:35:31 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:35:31 INFO - PROCESS | 1684 | RSS: Main: 282161152 05:35:31 INFO - PROCESS | 1684 | 05:35:34 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 05:35:35 INFO - PROCESS | 1684 | RSS: Main: 283500544 05:35:35 INFO - PROCESS | 1684 | 05:35:38 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 05:35:38 INFO - PROCESS | 1684 | RSS: Main: 283533312 05:35:38 INFO - PROCESS | 1684 | 05:35:41 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 05:35:42 INFO - PROCESS | 1684 | RSS: Main: 283811840 05:35:42 INFO - PROCESS | 1684 | 05:35:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:35:44 INFO - PROCESS | 1684 | RSS: Main: 283070464 05:35:44 INFO - PROCESS | 1684 | 05:35:45 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:35:46 INFO - PROCESS | 1684 | RSS: Main: 282386432 05:35:46 INFO - PROCESS | 1684 | 05:35:48 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:35:49 INFO - PROCESS | 1684 | RSS: Main: 283324416 05:35:49 INFO - PROCESS | 1684 | 05:35:51 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:52 INFO - PROCESS | 1684 | RSS: Main: 284463104 05:35:52 INFO - PROCESS | 1684 | 05:35:54 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:55 INFO - PROCESS | 1684 | RSS: Main: 283017216 05:35:55 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 05:35:57 INFO - PROCESS | 1684 | RSS: Main: 284667904 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | __start_tp_report 05:35:57 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 05:35:57 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 05:35:57 INFO - PROCESS | 1684 | |i|pagename|runs| 05:35:57 INFO - PROCESS | 1684 | |0;ai-astar;118;107;116;116;116;125;113;115;115;115 05:35:57 INFO - PROCESS | 1684 | |1;audio-beat-detection;158;123;150;162;148;176;169;130;191;147 05:35:57 INFO - PROCESS | 1684 | |2;audio-dft;192;198;201;218;225;214;198;200;196;256 05:35:57 INFO - PROCESS | 1684 | |3;audio-fft;66;80;87;143;82;78;58;64;70;59 05:35:57 INFO - PROCESS | 1684 | |4;audio-oscillator;83;89;123;78;81;82;119;79;78;118 05:35:57 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;89;85;109;129;88;85;88;87;88;85 05:35:57 INFO - PROCESS | 1684 | |6;imaging-darkroom;94;94;102;99;152;151;94;94;95;97 05:35:57 INFO - PROCESS | 1684 | |7;imaging-desaturate;91;92;93;90;93;94;139;159;91;90 05:35:57 INFO - PROCESS | 1684 | |8;json-parse-financial;55;58;57;55;58;56;56;64;60;55 05:35:57 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;65;72;66;65;72;70;62;67;66;65 05:35:57 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;85;85;84;85;84;86;83;87;84;88 05:35:57 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;128;127;124;122;131;127;122;127;137;131 05:35:57 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;132;143;143;145;142;146;147;141;143;131 05:35:57 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;70;68;71;67;69;67;67;69;69;66 05:35:57 INFO - PROCESS | 1684 | __end_tp_report 05:35:57 INFO - PROCESS | 1684 | __start_cc_report 05:35:57 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,889 05:35:57 INFO - PROCESS | 1684 | __end_cc_report 05:35:57 INFO - PROCESS | 1684 | __startTimestamp1457012157407__endTimestamp 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | ------- Summary: start ------- 05:35:57 INFO - PROCESS | 1684 | Number of tests: 14 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.00 stddev:4.43 (3.8%) stddev-sans-first:4.61 05:35:57 INFO - PROCESS | 1684 | Values: 118.0 107.0 116.0 116.0 116.0 125.0 113.0 115.0 115.0 115.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:160.00 stddev:20.48 (12.8%) stddev-sans-first:21.71 05:35:57 INFO - PROCESS | 1684 | Values: 158.0 123.0 150.0 162.0 148.0 176.0 169.0 130.0 191.0 147.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:209.80 Median:207.50 stddev:19.46 (9.4%) stddev-sans-first:19.55 05:35:57 INFO - PROCESS | 1684 | Values: 192.0 198.0 201.0 218.0 225.0 214.0 198.0 200.0 196.0 256.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:78.70 Median:74.00 stddev:24.69 (33.4%) stddev-sans-first:25.76 05:35:57 INFO - PROCESS | 1684 | Values: 66.0 80.0 87.0 143.0 82.0 78.0 58.0 64.0 70.0 59.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:80.00 stddev:18.94 (23.7%) stddev-sans-first:19.74 05:35:57 INFO - PROCESS | 1684 | Values: 83.0 89.0 123.0 78.0 81.0 82.0 119.0 79.0 78.0 118.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:93.30 Median:87.50 stddev:14.41 (16.5%) stddev-sans-first:15.21 05:35:57 INFO - PROCESS | 1684 | Values: 89.0 85.0 109.0 129.0 88.0 85.0 88.0 87.0 88.0 85.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:94.00 stddev:23.50 (25.0%) stddev-sans-first:24.43 05:35:57 INFO - PROCESS | 1684 | Values: 94.0 94.0 102.0 99.0 152.0 151.0 94.0 94.0 95.0 97.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:103.20 Median:91.50 stddev:24.63 (26.9%) stddev-sans-first:25.73 05:35:57 INFO - PROCESS | 1684 | Values: 91.0 92.0 93.0 90.0 93.0 94.0 139.0 159.0 91.0 90.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:2.84 (4.9%) stddev-sans-first:2.87 05:35:57 INFO - PROCESS | 1684 | Values: 55.0 58.0 57.0 55.0 58.0 56.0 56.0 64.0 60.0 55.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:66.50 stddev:3.30 (5.0%) stddev-sans-first:3.42 05:35:57 INFO - PROCESS | 1684 | Values: 65.0 72.0 66.0 65.0 72.0 70.0 62.0 67.0 66.0 65.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:1.52 (1.8%) stddev-sans-first:1.62 05:35:57 INFO - PROCESS | 1684 | Values: 85.0 85.0 84.0 85.0 84.0 86.0 83.0 87.0 84.0 88.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:127.50 stddev:4.58 (3.6%) stddev-sans-first:4.85 05:35:57 INFO - PROCESS | 1684 | Values: 128.0 127.0 124.0 122.0 131.0 127.0 122.0 127.0 137.0 131.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.30 Median:143.00 stddev:5.48 (3.8%) stddev-sans-first:4.66 05:35:57 INFO - PROCESS | 1684 | Values: 132.0 143.0 143.0 145.0 142.0 146.0 147.0 141.0 143.0 131.0 05:35:57 INFO - PROCESS | 1684 | 05:35:57 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.57 (2.3%) stddev-sans-first:1.54 05:35:57 INFO - PROCESS | 1684 | Values: 70.0 68.0 71.0 67.0 69.0 67.0 67.0 69.0 69.0 66.0 05:35:57 INFO - PROCESS | 1684 | -------- Summary: end -------- 05:35:57 INFO - PROCESS | 1684 | 05:35:58 INFO - TEST-INFO | 1684: exit 0 05:35:58 INFO - TEST-OK | kraken | took 57640ms 05:35:58 INFO - SUITE-END | took 1168s 05:35:58 INFO - Completed test suite (00:19:28) 05:35:58 INFO - Working with test: dromaeo_css 05:35:58 INFO - Generating results file: dromaeo_css 05:35:58 INFO - Working with test: kraken 05:35:58 INFO - Generating results file: kraken 05:35:58 INFO - javascript benchmark 05:35:58 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:35:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:35:59 INFO - process_Request line: dromaeo_css 7476.07 graph.html#tests=[[72,1,61]] 05:35:59 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:35:59 INFO - process_Request line: kraken 1502.90 graph.html#tests=[[232,1,61]] 05:35:59 INFO - RETURN: dromaeo_css: 7476.07 05:35:59 INFO - RETURN: kraken: 1502.90 05:35:59 INFO - javascript benchmark 05:35:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2963.6295463067117, 3512.736544759143, 3536.451849963255, 3566.7146628269743, 3569.500269962205, 5758.539316854647, 5789.855253618662, 5803.274590676166, 5811.360750317473, 5818.854528636786, 4551.840685576006, 5640.266765320513, 5759.337676167242, 5806.941930580693, 5867.383924687911, 5185.87035324118, 5210.114280572293, 5229.163333866582, 5254.159334506479, 5267.815626453075, 5208.218767184915, 5322.095243808542, 5365.704886231256, 5368.0605893968595, 5385.3537575491, 4294.828206871722, 5110.386753589556, 5179.2749015137915, 5239.816606418776, 5250.05499010178, 5216.582673386158, 5221.034108689904, 5223.0, 5227.3465816772905, 5235.842924712265, 5183.092958732207, 5201.791928322863, 5210.921836172461, 5244.895102097975, 5272.92090618641, 4675.275332323496, 5003.974980125113, 5209.801745598534, 5679.977604031273, 5684.147377893308, 5019.774110165052, 6236.625802451822, 6260.906086408708, 6289.654069026202, 6306.306306306303, 5068.4424713281505, 6282.4974002079725, 6297.527685423565, 6297.905531417033, 6318.0, 4945.480724523945, 5827.659638283176, 5857.26784151981, 5858.443447872445, 5888.941110588882, 5270.78916843322, 6318.589291696025, 6341.017142342944, 6354.9514330135935, 6357.364263573606, 5073.086844367976, 6095.75616975316, 6223.0354295084335, 6228.128062071313, 6234.594751341148, 6272.1219029335925, 6299.118123462719, 6312.905306420407, 6319.9368006320265, 6339.11252424661, 5308.513616187473, 5942.8811423771285, 6045.063015232646, 6207.689615519206, 6287.245530536365, 6124.502994489374, 6143.419763699257, 6169.290531588835, 6275.497960163176, 6324.588901721373, 4840.903181936412, 4890.559849613552, 4902.460729319772, 4918.704877707349, 4961.107000739901, 4390.319500477431, 4406.471223453142, 4417.867463976086, 4429.955700443019, 4436.822527098944, 5657.660540367591, 5828.737706803204, 5839.0, 5840.0, 5920.851978700567, 6241.157443745127, 6247.2815626202655, 6288.056791481315, 6296.181496405529, 6318.368163183737, 5868.677222752704, 5928.614640048383, 5928.8990254614855, 5935.0207215808905, 5994.040953447515, 5296.232046353257, 5333.706646134422, 5396.9190462142315, 5401.513863752281, 5438.347398312228, 6373.649449280241, 6402.551821372459, 6408.647524386203, 6438.67806609677, 6450.741970321228, 5264.605154613496, 6264.937350626617, 6295.716692748929, 6308.653024083719, 6317.873642527215, 6216.689165541795, 6293.276273228637, 6352.36476352361, 6390.968045159744, 6394.616323020634, 6183.783567575113, 6202.81391558254, 6209.782657606962, 6240.843978900382, 6241.750329986931, 6140.933729672948, 6283.874322513433, 6317.494600432046, 6328.0, 6358.046293056079, 6061.848453788691, 6127.769884593299, 6132.998044146438, 6140.078988151813, 6205.503559715302, 6131.877362452637, 6133.854967164949, 6135.110408990582, 6146.0, 6146.938530614637, 5792.218050563289, 5798.478136967693, 5931.911021334769, 5950.910736338872, 5990.430909063632, 6122.764110201883, 6159.351478864131, 6167.537434692326, 6189.50483961273, 6200.81397558074, 6051.6369017857305, 6081.300650425258, 6082.130743832223, 6093.0121820563945, 6104.4505994460715], "unit": "score", "name": "dojo.html", "value": 5681.132421344028}, {"lowerIsBetter": false, "replicates": [483.4029972983367, 550.9476599723025, 574.2133277409946, 585.5754577931001, 648.3095503288997, 28632.713672863265, 37468.81265593675, 37544.624553754424, 37683.81158094209, 37885.62114378855, 39926.00184995377, 40805.18389632206, 40855.79572102143, 40889.795551022275, 40918.38622420659, 8219.424640275183, 9393.107654772803, 9595.80808383832, 9631.181349585293, 9670.081342272473, 9402.670906518273, 9524.71425857222, 9540.236781057498, 9555.0, 9556.23550115989, 9543.80912381752, 9615.903840961606, 9627.518624068804, 9634.807303853919, 9663.613455461773, 9361.20429763471, 9377.718668439958, 9382.906170938306, 9404.435733855922, 9404.717858464188, 9374.109459601395, 9422.764430889214, 9486.0, 9532.95233523835, 9553.0, 37510.0, 37647.4352884707, 37849.810750946344, 38078.61921380806, 38146.61853381458, 2586.961195582068, 2616.2805228562106, 3078.7844850860447, 3438.1748380388776, 3539.1152211947015, 22038.779612203994, 26186.73813261862, 26388.86805565979, 26894.731052689418, 27283.86358068197, 2695.5417579011614, 2697.2582539801515, 2734.4667789781, 2736.5484695025298, 2814.1838866728626, 354967.0, 354992.0, 356136.21931890177, 356592.0, 357165.0, 60635.0, 60833.69583152144, 60878.086828697604, 60973.69513152406, 61052.0, 70322.29677703157, 70853.64573177205, 71287.64356178186, 71356.286437136, 71439.64280178565, 16396.508104756875, 16448.013119212646, 16501.09243991568, 16545.83454165467, 16580.336786528645, 12500.624981250578, 12610.558630448073, 12697.0, 12715.96544552867, 12726.17279876805, 19112.426627201206, 21185.470363241042, 21365.67951480729, 21402.464938376666, 21449.356519304445, 7736.7292144774665, 9002.549872506348, 9215.156968606305, 9218.446893186296, 9234.445933244027, 943.5376665433888, 1030.0, 1073.7100982734773, 1088.6244245735209, 1088.983665245022, 22092.0, 28624.713752862623, 28805.99179028724, 29280.853595731885, 29762.40475190484, 1055.2613170780485, 1127.4926283172606, 1164.5865717670274, 1199.8860108289698, 1254.7804134276464, 14682.926585367004, 14746.483873064606, 14805.64965550276, 14824.481143159937, 15039.699206015819, 518869.0, 526912.0, 531281.0, 537023.0, 542950.0, 45878.54121458809, 56732.43267567354, 56828.0, 56980.86038279211, 57697.42302577005, 1425.201886943315, 1425.5723283015054, 1451.1800832529798, 1466.0543949152736, 1470.2134358118142, 21832.781672183075, 28301.57547636828, 28794.568081479214, 28852.278693032844, 28960.565591516566, 40164.19671606493, 40622.79688601538, 40798.79600601978, 41421.0, 45238.77380613076, 494053.0, 497538.0, 498825.0, 499655.5017225036, 500432.0, 32263.0, 32397.838010809795, 32494.350112997134, 32779.0, 32822.0, 43409.78295108504, 43941.78029109834, 43965.78017109894, 44261.0, 44978.0, 36558.0, 36581.63418365782, 36859.815700921325, 37425.4386184202, 37479.62520374871, 35605.1098722534, 35739.46390804088, 36175.63824361723, 36191.91424257276, 36495.0, 29748.851255743582, 30485.695143048284, 35414.114647134025, 35422.46866296956, 36071.27857442784, 29727.55408668915, 30196.24509387283, 30811.691883080883, 31497.0, 31547.369052619277, 19005.619887601893, 23839.404014899766, 24083.879580602686, 24314.51370972606, 24450.0], "unit": "score", "name": "ext.html", "value": 19226.07235426744}, {"lowerIsBetter": false, "replicates": [325.4808580314398, 350.62658268943574, 363.0234668741087, 364.5607043512568, 365.71291536144133, 19453.3191338303, 19657.213711451543, 20887.99999999998, 20951.847648379335, 21033.36899893002, 19669.0, 19833.70249446256, 20672.27647032354, 20714.067866945985, 20750.821163777775, 4331.935020974695, 5383.838484845461, 5436.864078398052, 5438.456154384569, 5440.238366628675, 3986.8604598839047, 5381.273528073719, 5727.3699893011735, 5994.400559944014, 5995.190649262359, 5846.619969701977, 5937.020391635375, 5944.375840536746, 5962.1951036609935, 5972.3131839838325, 5877.265341832271, 6354.904676429857, 6380.234371875382, 6381.329960354165, 6405.583637063576, 5545.085060964976, 5607.439256074401, 5666.320041595035, 5673.6879471629045, 5691.4877661010705, 23917.923693433662, 24124.75875241243, 24525.754742452526, 24812.635305058215, 24887.502249954898, 2151.6772484127505, 2177.085624037908, 2245.7305123385136, 2250.8086812620945, 2734.8632568371504, 9553.474558899257, 9763.0, 10102.14131798798, 13154.671133221651, 13414.725601067883, 1416.8653977872086, 1557.3459147158107, 1670.8638126074266, 1709.1198033013009, 1757.165346460421, 94008.0, 97407.02592974121, 99484.50257748738, 100299.0, 100416.0, 10463.267571270091, 11210.495527701272, 11466.02538784196, 11635.825462618068, 11752.647420577396, 12516.49934002648, 13510.932445337907, 13757.38091785872, 13793.24137172465, 13809.24049177305, 8430.494170349799, 8503.277221436247, 8505.95747021261, 8522.105178956244, 8564.828703425897, 8577.099404562556, 8634.870476942851, 8655.74032779005, 8707.303415726727, 8727.781805454915, 4425.424694789656, 4479.193745125844, 4505.752183629932, 4506.684532082722, 4565.977170114194, 1560.305663979541, 1800.612868233336, 1884.6324966631375, 1928.257620815996, 1968.9606207875763, 818.9877151842727, 906.5829718329642, 945.2390825385493, 993.015986959183, 1007.7178390050798, 17446.865953712968, 19326.710099348522, 19756.308529201408, 19904.800951990583, 20388.28640997558, 900.2977677411629, 971.1890571372842, 975.8341082016075, 980.2648013989508, 1012.1143999000874, 10519.52662130206, 10637.361758294526, 10657.946710266398, 10699.518521666543, 10699.625513107005, 645696.0, 648037.0, 658497.0, 660549.0, 661702.0, 95879.0, 114104.0, 115857.0, 118061.0, 122036.0, 965.0831709875506, 968.2350942755286, 976.829054915387, 979.3878825733916, 988.7379844341256, 17520.912395437943, 17637.647247055243, 17817.10914454298, 18034.549136271697, 18041.548961276072, 51126.74436627793, 51412.0, 51743.482565173865, 51893.22160167525, 52967.735161323944, 75074.0, 75326.0, 75456.0, 75626.0, 76344.47311053636, 7783.571903545359, 7880.5271683696865, 8145.307648849915, 8201.30288925424, 8365.874511882448, 9531.618735250513, 11080.445977700922, 11336.716582085513, 12493.0, 13397.732045359233, 11091.0, 11419.828702569303, 11654.53381864716, 11690.70773230676, 11693.649190524298, 11185.944070279596, 11410.714732131763, 11417.543298267976, 11736.530538778354, 11853.229540079867, 10000.499975001367, 11468.139889508153, 11790.587329443428, 11822.527098916291, 12014.33921134346, 6729.0, 8116.553589552631, 8300.252977231836, 8312.0, 8315.667373305, 10314.329568578018, 11614.419279036183, 11677.06583473337, 11797.115216358636, 11868.347240901834], "unit": "score", "name": "jquery.html", "value": 9377.17604756588}, {"lowerIsBetter": false, "replicates": [1585.5877471857316, 1604.3662753212484, 1851.3797877710965, 1924.3457224543652, 1936.351322307027, 7905.525668459896, 7991.001124859393, 8160.714374996869, 8517.446365986207, 8775.859138312018, 8630.309575233981, 8657.480551166918, 8708.43395179313, 8727.345449091312, 8752.29981601472, 2433.8904749286235, 2446.4617784087563, 2467.802575793932, 2468.160825319391, 2471.0, 2409.951671023102, 2425.842320249178, 2461.396957745355, 2480.913168039119, 2498.1631153563576, 2068.6896965455153, 2443.3402981195068, 2452.1172377943926, 2454.9386265343333, 2473.5547601431736, 2047.3857842647221, 2442.4626582151986, 2444.1934161726676, 2445.3886528367907, 2485.1923124984273, 2453.4479742057893, 2467.7408872068354, 2471.6292556116546, 2473.6536884836137, 2474.616434452663, 8841.16008979146, 8867.113288671146, 8891.911080889173, 8896.0, 8903.866442003375, 5353.411124776271, 5399.9730001350135, 5417.377001644822, 5493.505584497414, 5496.5053145217125, 3553.076200187944, 3633.8728144514816, 3679.5400574928135, 3691.9815400923094, 3697.0572504011307, 871.3160169267095, 921.6405601815297, 1058.714147180257, 1069.36907224737, 1074.8065348237315, 11842.052635789203, 11847.170698051139, 11958.88041119595, 12020.759584808342, 12021.15851890368, 4802.183628783116, 4878.780454879468, 4923.532264434873, 4930.433000205022, 4930.802767889316, 9063.36556441056, 9988.05113514215, 10074.294799364121, 10154.898451015542, 10206.744831379276, 5356.143017117321, 5441.59188060897, 5451.918221226605, 5465.043617366945, 5500.064988951888, 4443.0, 4800.831970881072, 4930.964497455575, 4965.255211718199, 4994.101061808837, 3566.7694645347315, 3638.308721342936, 3931.3709806431407, 3932.134930315326, 3994.6005399459823, 1306.6341424401182, 1316.2760481735008, 1319.6700824793802, 1324.9602511924659, 1325.3439547424086, 1341.8792308692264, 1351.196038357176, 1358.721462100267, 1367.2001878900955, 1371.2526672963259, 6991.650417479105, 8099.271065604124, 8242.17578242183, 8273.255407013277, 8285.212904774036, 504.47282589693856, 517.6247220764915, 519.5376115257424, 520.0560981817988, 520.5445235419008, 5988.28140623128, 6071.574989750675, 6154.107654390088, 6219.40915613016, 6275.623462592259, 10634.361938283728, 10946.945265273622, 10979.505922233519, 10992.28550144238, 11015.944920275348, 10612.310199836986, 10639.308444951053, 10702.785944281071, 10736.194785391126, 10916.617918372818, 8341.8331633367, 8376.53929033909, 8394.790130246793, 8396.538190399586, 8399.706010289488, 7804.492707973964, 7847.646855891385, 7869.48848324857, 7879.330256927996, 7915.84168316642, 9491.145796878314, 9639.614415423304, 9749.512524373611, 9759.56081976327, 9773.657921972697, 9928.354656947275, 10009.24930630191, 10117.645882394081, 10138.0, 10274.897251027693, 6640.83397915056, 7374.963125184339, 7401.851962960603, 7439.2188820173105, 7476.21499742541, 6997.230304666585, 8293.216958353742, 8298.502089874626, 8323.83352332962, 8324.70863519774, 7161.928380716126, 7249.637518124178, 7257.782266532013, 7383.0, 7409.0, 7228.9277107230355, 7265.910113482809, 7270.600116993616, 7299.270072992658, 7338.853222935618, 7622.618869056636, 7718.343940765098, 7753.10839253493, 7773.533587984739, 7777.1833957433655, 6929.514933954575, 6953.548019378724, 6955.23492415844, 6981.127359080115, 7031.472639552157, 7066.752663656953, 7106.964465177641, 7110.075690160246, 7135.928640713734, 7154.499185056996], "unit": "score", "name": "mootools.html", "value": 4838.8033211425645}, {"lowerIsBetter": false, "replicates": [324.247745231064, 324.56508278906267, 328.0830079926605, 329.13437658956957, 330.33602459057295, 6773.627450490228, 6823.624700641462, 6826.419754320877, 6831.146106736658, 6840.179178498574, 6711.36242057005, 6825.897611535831, 6826.351496607826, 6853.28040555742, 6877.0, 4269.957300426987, 4493.887652808673, 4935.235038569028, 4981.601471882241, 5027.723475208872, 4230.640395566381, 4288.592583704543, 4317.179735850194, 4982.701037937717, 5000.124978128831, 4896.290037944496, 4911.82808601699, 4919.0, 4931.063098011385, 4950.455449900508, 4938.876528086791, 4952.975235123838, 4959.876003099916, 4967.875803104916, 4971.925421118686, 3453.8273086345835, 3533.152043509565, 4262.1688770689725, 4263.97868010661, 4277.101808620194, 6262.12330273762, 6547.9345206547805, 6550.312217217219, 6554.868902621968, 6564.081028655992, 5789.623674461189, 5795.623284486537, 5804.361520232771, 5822.039363505017, 5879.1475236090955, 5922.58541902067, 7304.342609165147, 7341.632918354061, 7347.1550771661405, 7359.411247100273, 4663.0, 4664.673472856902, 4667.13657973276, 4668.393108895856, 4688.624910007191, 7662.540247585107, 7704.191059938682, 7746.573938433384, 7760.883586746203, 7779.222077792232, 4507.143642707941, 4526.117407105583, 4618.56123668251, 4682.899518613123, 4698.36572062774, 4788.066327066189, 4817.0, 4822.541858523435, 4839.2983017462275, 4854.344663470457, 5776.595638305278, 5828.0, 5830.562707796932, 5837.620554663933, 5845.853853653608, 7292.161401438902, 7384.556926584422, 7388.778336649909, 7399.260073992666, 7408.9629551851895, 1640.6620565693838, 1673.1132499775138, 1673.1717799688988, 1673.916304184786, 1680.0927499150323, 1028.9742756431149, 1066.2323127348297, 1068.3803394031443, 1073.6295977887617, 1084.5390708948664, 5634.633748806396, 6848.178218613699, 6889.793306200822, 6930.861382772317, 6943.479239057091, 6394.8721025579225, 7292.34368906801, 7565.508241964255, 7580.886286705704, 7625.275598818103, 5667.433256674382, 5687.345955215121, 6754.784138854955, 6932.202796678345, 6962.373386395248, 3725.925481490355, 3854.5952674969285, 4014.0, 4033.5361433435532, 4041.939370909439, 6343.968280158662, 7963.721269755531, 7975.122736498981, 8014.278714915686, 8049.678012879536, 7749.302562769265, 7788.961055194801, 7800.843983120306, 7802.882956755653, 7827.060752709711, 6295.496360291166, 6699.832504187434, 7858.035491127218, 7962.840743185104, 7969.561674107864, 6791.864162716619, 7195.6761945713615, 7530.510516816389, 7551.660175292235, 7629.847403052019, 7394.4454165936695, 7399.593022383605, 7423.665935032828, 7431.739889103856, 7447.776566702791, 6686.832829179115, 7951.3638908886, 7965.163657816078, 7977.361811054986, 7995.440319177602, 3827.4641550183555, 3998.5001874765653, 4738.763061846963, 4746.264329029006, 4747.881302967454, 6855.828604284933, 7509.5869727163345, 7512.286332798375, 7547.660355283915, 7558.13081495635, 7328.303811137934, 7328.670209840463, 7353.77938661841, 7402.148752893271, 7414.147373052168, 7373.571289350478, 7405.518641288299, 7413.258674132544, 7424.220456851953, 7469.402447804271, 7191.280871912767, 7196.0, 7205.891911621435, 7207.819804504929, 7233.891491627524, 7091.680874360769, 7377.151627562899, 7388.0, 7392.7042918284815, 7398.667059982206, 7144.571325720473, 7210.9278907210255, 7217.350438460564, 7223.566586004857, 7224.602646854473], "unit": "score", "name": "prototype.html", "value": 5241.808453091321}, {"lowerIsBetter": false, "replicates": [682.7746843541629, 704.362551890539, 704.988341729618, 732.1763016606318, 773.1572585881388, 13891.513797017107, 14703.485378011772, 15044.774328385056, 15113.622159446006, 15125.621859453506, 13483.325833708324, 13600.455981760717, 15475.071495710265, 15811.367545298202, 15851.445199418024, 872.1888643561485, 883.6112110671316, 886.6674996876171, 887.8801361816137, 888.0985799413601, 705.5272967112022, 720.9387202087829, 864.7276108025983, 865.35098675993, 866.9826603467927, 913.3150137396952, 914.8993610702818, 921.3918813583036, 931.4830269200625, 933.174140885318, 884.0938038510513, 907.1200935092983, 923.6351641101794, 923.8660394242797, 924.7641851327902, 673.7742856143198, 677.190757045331, 677.9931801275103, 688.8760023195823, 690.3407246079981, 15006.249687515581, 15277.236138193046, 15374.923755337131, 15378.3079761411, 15386.692266154727, 12347.876521234852, 12455.25626412303, 12460.626181214579, 12599.559015434415, 12686.936565317206, 10085.142762865093, 10101.848472272923, 10161.33951293171, 10199.847002294971, 10492.737681557946, 3419.111031131899, 3437.123533498967, 3489.284696637183, 3515.9648403515894, 3563.5367402237544, 82073.0, 82474.58762706148, 84414.57792711059, 84937.0, 84969.57515212447, 7827.765167044998, 8440.860483834604, 9192.402493837879, 9198.95400522993, 9240.815183696288, 17363.739543906853, 19004.334848280243, 20861.895690521753, 20918.58162836735, 21013.579728405348, 6986.93013069873, 7091.503594748421, 7206.675699593531, 7249.238829922782, 7390.778276651709, 3975.8608448704736, 3984.0438294809614, 3999.5800440953863, 4023.456833327522, 4038.374052021941, 3264.037109052835, 3273.1489812648883, 3275.19757659375, 3294.7034766870615, 3311.1556553078813, 524.3105316508855, 572.5877368294904, 603.0291231117897, 603.1284793473476, 604.6100265328838, 542.8425756530562, 549.1405949688724, 555.872149405639, 563.7012383436785, 577.3101144132805, 7968.721094761656, 8008.599570021475, 8025.640513608977, 8126.512409255463, 8195.464771347215, 559.6809818403552, 565.7778702575172, 566.8979583674978, 593.175486074357, 594.1770647653032, 3093.2576181716677, 3555.5733312002208, 3727.459518369821, 3766.114962983697, 3817.0, 86679.0, 87010.0, 88146.0, 88467.0, 92600.0, 80489.59755201187, 80696.19303806887, 80829.59585202036, 81657.87565932579, 82045.76931346035, 64884.0, 65588.67205664037, 66501.33498665049, 66825.6658716713, 70948.0, 7886.250806173404, 7899.407544434305, 8075.636596353061, 8141.22658347456, 8157.55133467665, 45590.0, 46993.0, 49821.252681210535, 50186.498135018184, 51215.0, 63770.68114659582, 68948.65525672339, 68985.0, 69054.0, 69328.0, 10325.070743633109, 10397.896021039995, 10511.789764204826, 10595.682129536126, 11198.0, 11449.828252576051, 11622.6513204604, 11630.302181869114, 11659.88340116588, 11992.100592455427, 10911.345319280868, 10982.505787239754, 11259.774804504028, 11314.83027754568, 11436.19946603763, 10989.945050274697, 11025.779484410106, 11321.433928303717, 11390.202685811913, 11406.600768973047, 10776.892231077589, 10796.838047429452, 10820.837687434538, 11128.554857805597, 11232.887671123184, 9076.364654474124, 9126.0, 9281.76795580089, 9357.251419886257, 9479.952600236955, 8825.470471771714, 9140.954295228481, 9224.308176886627, 9278.072192780668, 9314.115159059878], "unit": "score", "name": "yui.html", "value": 6720.30784812213}], "name": "dromaeo_css", "value": 7476.069153117033}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [118.0, 107.0, 116.0, 116.0, 116.0, 125.0, 113.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.6}, {"lowerIsBetter": true, "replicates": [158.0, 123.0, 150.0, 162.0, 148.0, 176.0, 169.0, 130.0, 191.0, 147.0], "unit": "score", "name": "audio-beat-detection", "value": 155.4}, {"lowerIsBetter": true, "replicates": [192.0, 198.0, 201.0, 218.0, 225.0, 214.0, 198.0, 200.0, 196.0, 256.0], "unit": "score", "name": "audio-dft", "value": 209.8}, {"lowerIsBetter": true, "replicates": [66.0, 80.0, 87.0, 143.0, 82.0, 78.0, 58.0, 64.0, 70.0, 59.0], "unit": "score", "name": "audio-fft", "value": 78.7}, {"lowerIsBetter": true, "replicates": [83.0, 89.0, 123.0, 78.0, 81.0, 82.0, 119.0, 79.0, 78.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 93.0}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 109.0, 129.0, 88.0, 85.0, 88.0, 87.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 102.0, 99.0, 152.0, 151.0, 94.0, 94.0, 95.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 107.2}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 93.0, 90.0, 93.0, 94.0, 139.0, 159.0, 91.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 103.2}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 57.0, 55.0, 58.0, 56.0, 56.0, 64.0, 60.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [65.0, 72.0, 66.0, 65.0, 72.0, 70.0, 62.0, 67.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 84.0, 85.0, 84.0, 86.0, 83.0, 87.0, 84.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [128.0, 127.0, 124.0, 122.0, 131.0, 127.0, 122.0, 127.0, 137.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.6}, {"lowerIsBetter": true, "replicates": [132.0, 143.0, 143.0, 145.0, 142.0, 146.0, 147.0, 141.0, 143.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.3}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 71.0, 67.0, 69.0, 67.0, 67.0, 69.0, 69.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1502.8999999999996}]} 05:35:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1502.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7476.07"}}} 05:35:59 INFO - Return code: 0 05:35:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:35:59 ERROR - # TBPL SUCCESS # 05:35:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:35:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:35:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:35:59 INFO - 2016-03-03 05:35:59.234 screenresolution[1689:10965] starting screenresolution argv=screenresolution get 05:35:59 INFO - 2016-03-03 05:35:59.237 screenresolution[1689:10965] Display 0: 1600x1200x32@60 05:35:59 INFO - 2016-03-03 05:35:59.243 screenresolution[1690:10968] starting screenresolution argv=screenresolution list 05:35:59 INFO - Available Modes on Display 0 05:35:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:35:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:35:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:35:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:35:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:35:59 INFO - Intel Iris: 05:35:59 INFO - Chipset Model: Intel Iris 05:35:59 INFO - Type: GPU 05:35:59 INFO - Bus: Built-In 05:35:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:35:59 INFO - Vendor: Intel (0x8086) 05:35:59 INFO - Device ID: 0x0a2e 05:35:59 INFO - Revision ID: 0x0009 05:35:59 INFO - Displays: 05:35:59 INFO - Display: 05:35:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:35:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:35:59 INFO - Display Serial Number: 1600x1200 60 05:35:59 INFO - Main Display: Yes 05:35:59 INFO - Mirror: Off 05:35:59 INFO - Online: Yes 05:35:59 INFO - Rotation: Supported 05:35:59 INFO - Return code: 0 05:35:59 INFO - Running post-action listener: _resource_record_post_action 05:35:59 INFO - Running post-run listener: _resource_record_post_run 05:36:00 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 35319296; Write bytes: 710023680; Read time: 382; Write time: 1897 05:36:00 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402151936; Write bytes: 404321792; Read time: 30143; Write time: 752 05:36:00 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 33537536; Write bytes: 304854016; Read time: 362; Write time: 1142 05:36:00 INFO - Running post-run listener: _upload_blobber_files 05:36:00 INFO - Blob upload gear active. 05:36:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:36:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:36:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:36:00 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:36:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:02 INFO - (blobuploader) - INFO - Done attempting. 05:36:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:36:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:36:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:03 INFO - (blobuploader) - INFO - Done attempting. 05:36:03 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:03 INFO - Return code: 0 05:36:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4fb9c1c707ae0590577cc1b450c95a851525ebd6b0956e5075fbeb84ed150ebc4dab655ef65888480c5fb70594a70edd2ada55463c19e4735e795607a663bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23e59113077e14da3bb422bcce484a21fb37d7640377ab1a4d53ff816a7a31efdc5a0f86b4f81438d6af6ec24285374cb08b81833ae1efaa34d41b96602db579"} 05:36:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:03 INFO - Contents: 05:36:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad4fb9c1c707ae0590577cc1b450c95a851525ebd6b0956e5075fbeb84ed150ebc4dab655ef65888480c5fb70594a70edd2ada55463c19e4735e795607a663bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23e59113077e14da3bb422bcce484a21fb37d7640377ab1a4d53ff816a7a31efdc5a0f86b4f81438d6af6ec24285374cb08b81833ae1efaa34d41b96602db579"} 05:36:03 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:03 INFO - Copying logs to upload dir... 05:36:03 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.725487 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-03 05:36:03.218448) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 05:36:03.221589) ========= 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.4C2PdgTh0u/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.jaong0YtkY/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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/ad4fb9c1c707ae0590577cc1b450c95a851525ebd6b0956e5075fbeb84ed150ebc4dab655ef65888480c5fb70594a70edd2ada55463c19e4735e795607a663bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23e59113077e14da3bb422bcce484a21fb37d7640377ab1a4d53ff816a7a31efdc5a0f86b4f81438d6af6ec24285374cb08b81833ae1efaa34d41b96602db579"} build_url:https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010736 build_url: 'https://queue.taskcluster.net/v1/task/cy6zxHToS7Su41uqgl2-EQ/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/ad4fb9c1c707ae0590577cc1b450c95a851525ebd6b0956e5075fbeb84ed150ebc4dab655ef65888480c5fb70594a70edd2ada55463c19e4735e795607a663bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23e59113077e14da3bb422bcce484a21fb37d7640377ab1a4d53ff816a7a31efdc5a0f86b4f81438d6af6ec24285374cb08b81833ae1efaa34d41b96602db579"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 05:36:03.251367) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:36:03.252061) ========= 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.4C2PdgTh0u/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.jaong0YtkY/Listeners TMPDIR=/var/folders/tq/gxc_mw6n779fd3_fqt4jn6lc00000w/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.005190 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 05:36:03.305033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 05:36:03.305821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 05:36:03.306282) ========= ========= Total master_lag: 1.00 =========