builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0010 starttime: 1447160893.88 results: success (0) buildid: 20151110030032 builduid: 892aa74d32e242d287fb187aafc59b99 revision: cc473fe5dc512c450634506f68cbacfb40a06a23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:13.882316) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:13.882732) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:13.883080) ========= 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.yW2WHr40kJ/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.zJEEfDGOKs/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006252 basedir: '/builds/slave/test' ========= master_lag: 0.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.200923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.201414) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.244872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.245370) ========= 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.yW2WHr40kJ/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.zJEEfDGOKs/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.016610 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.299694) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.300035) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.300520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.300863) ========= 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.yW2WHr40kJ/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.zJEEfDGOKs/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:0x0:0x0 using PTY: False --2015-11-10 05:08:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.25, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.69M=0.001s 2015-11-10 05:08:14 (9.69 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.214860 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.532623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.533028) ========= 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.yW2WHr40kJ/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.zJEEfDGOKs/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.175954 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.727178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:14.727604) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cc473fe5dc512c450634506f68cbacfb40a06a23 --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 cc473fe5dc512c450634506f68cbacfb40a06a23 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yW2WHr40kJ/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.zJEEfDGOKs/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:0x0:0x0 using PTY: False 2015-11-10 05:08:14,814 truncating revision to first 12 chars 2015-11-10 05:08:14,815 Setting DEBUG logging. 2015-11-10 05:08:14,815 attempt 1/10 2015-11-10 05:08:14,815 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cc473fe5dc51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-10 05:08:15,065 unpacking tar archive at: mozilla-central-cc473fe5dc51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.512060 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:15.257409) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:15.257867) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:15.273238) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:15.273722) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-10 05:08:15.274380) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-11-10 05:08:15.274854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--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.yW2WHr40kJ/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.zJEEfDGOKs/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:0x0:0x0 using PTY: False 05:08:15 INFO - MultiFileLogger online at 20151110 05:08:15 in /builds/slave/test 05:08:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:08:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:15 INFO - {'append_to_log': False, 05:08:15 INFO - 'base_work_dir': '/builds/slave/test', 05:08:15 INFO - 'blob_upload_branch': 'Firefox', 05:08:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:15 INFO - 'branch': 'Firefox', 05:08:15 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:15 INFO - 'config_files': ('talos/mac_config.py',), 05:08:15 INFO - 'default_actions': ('clobber', 05:08:15 INFO - 'read-buildbot-config', 05:08:15 INFO - 'download-and-extract', 05:08:15 INFO - 'populate-webroot', 05:08:15 INFO - 'create-virtualenv', 05:08:15 INFO - 'install', 05:08:15 INFO - 'run-tests'), 05:08:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:15 INFO - 'download_minidump_stackwalk': True, 05:08:15 INFO - 'download_symbols': 'ondemand', 05:08:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:15 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:15 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:15 INFO - 'installer_path': 'installer.exe', 05:08:15 INFO - 'log_level': 'info', 05:08:15 INFO - 'log_name': 'talos', 05:08:15 INFO - 'log_to_console': True, 05:08:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:08:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:08:15 INFO - 'opt_config_files': (), 05:08:15 INFO - 'pip_index': False, 05:08:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:15 INFO - 'cmd': ('bash', 05:08:15 INFO - '-c', 05:08:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:15 INFO - 'enabled': True, 05:08:15 INFO - 'halt_on_failure': False, 05:08:15 INFO - 'name': 'check_screen_resolution'},), 05:08:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:15 INFO - 'cmd': ('bash', 05:08:15 INFO - '-c', 05:08:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:15 INFO - 'enabled': True, 05:08:15 INFO - 'halt_on_failure': False, 05:08:15 INFO - 'name': 'check_screen_resolution'},), 05:08:15 INFO - 'run_cmd_checks_enabled': True, 05:08:15 INFO - 'sps_profile': False, 05:08:15 INFO - 'sps_profile_interval': 0, 05:08:15 INFO - 'suite': 'dromaeojs', 05:08:15 INFO - 'system_bits': '64', 05:08:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:15 INFO - 'title': 't-yosemite-r5-0010', 05:08:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:15 INFO - 'use_talos_json': True, 05:08:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:15 INFO - 'work_dir': 'build'} 05:08:15 INFO - ##### 05:08:15 INFO - ##### Running clobber step. 05:08:15 INFO - ##### 05:08:15 INFO - Running pre-action listener: _resource_record_pre_action 05:08:15 INFO - Running main action method: clobber 05:08:15 INFO - rmtree: /builds/slave/test/build 05:08:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:19 INFO - Running post-action listener: _resource_record_post_action 05:08:19 INFO - ##### 05:08:19 INFO - ##### Running read-buildbot-config step. 05:08:19 INFO - ##### 05:08:19 INFO - Running pre-action listener: _resource_record_pre_action 05:08:19 INFO - Running main action method: read_buildbot_config 05:08:19 INFO - Using buildbot properties: 05:08:19 INFO - { 05:08:19 INFO - "properties": { 05:08:19 INFO - "buildnumber": 479, 05:08:19 INFO - "product": "firefox", 05:08:19 INFO - "script_repo_revision": "production", 05:08:19 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 05:08:19 INFO - "repository": "", 05:08:19 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 05:08:19 INFO - "buildid": "20151110030032", 05:08:19 INFO - "slavename": "t-yosemite-r5-0010", 05:08:19 INFO - "pgo_build": "False", 05:08:19 INFO - "basedir": "/builds/slave/test", 05:08:19 INFO - "project": "", 05:08:19 INFO - "platform": "yosemite", 05:08:19 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:08:19 INFO - "slavebuilddir": "test", 05:08:19 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:08:19 INFO - "branch": "mozilla-central", 05:08:19 INFO - "repo_path": "mozilla-central", 05:08:19 INFO - "stage_platform": "macosx64", 05:08:19 INFO - "builduid": "892aa74d32e242d287fb187aafc59b99", 05:08:19 INFO - "revision": "cc473fe5dc512c450634506f68cbacfb40a06a23" 05:08:19 INFO - }, 05:08:19 INFO - "sourcestamp": { 05:08:19 INFO - "repository": "", 05:08:19 INFO - "hasPatch": false, 05:08:19 INFO - "project": "", 05:08:19 INFO - "branch": "mozilla-central-macosx64-talos", 05:08:19 INFO - "changes": [ 05:08:19 INFO - { 05:08:19 INFO - "category": null, 05:08:19 INFO - "files": [ 05:08:19 INFO - { 05:08:19 INFO - "url": null, 05:08:19 INFO - "name": "https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:08:19 INFO - } 05:08:19 INFO - ], 05:08:19 INFO - "repository": "", 05:08:19 INFO - "rev": "cc473fe5dc512c450634506f68cbacfb40a06a23", 05:08:19 INFO - "who": "cbook@mozilla.com", 05:08:19 INFO - "when": 1447160339, 05:08:19 INFO - "number": 6642527, 05:08:19 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 05:08:19 INFO - "project": "", 05:08:19 INFO - "at": "Tue 10 Nov 2015 04:58:59", 05:08:19 INFO - "branch": "mozilla-central-macosx64-talos", 05:08:19 INFO - "revlink": "", 05:08:19 INFO - "properties": [ 05:08:19 INFO - [ 05:08:19 INFO - "buildid", 05:08:19 INFO - "20151110030032", 05:08:19 INFO - "Change" 05:08:19 INFO - ], 05:08:19 INFO - [ 05:08:19 INFO - "builduid", 05:08:19 INFO - "892aa74d32e242d287fb187aafc59b99", 05:08:19 INFO - "Change" 05:08:19 INFO - ], 05:08:19 INFO - [ 05:08:19 INFO - "pgo_build", 05:08:19 INFO - "False", 05:08:19 INFO - "Change" 05:08:19 INFO - ] 05:08:19 INFO - ], 05:08:19 INFO - "revision": "cc473fe5dc512c450634506f68cbacfb40a06a23" 05:08:19 INFO - } 05:08:19 INFO - ], 05:08:19 INFO - "revision": "cc473fe5dc512c450634506f68cbacfb40a06a23" 05:08:19 INFO - } 05:08:19 INFO - } 05:08:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:08:19 INFO - Running post-action listener: _resource_record_post_action 05:08:19 INFO - ##### 05:08:19 INFO - ##### Running download-and-extract step. 05:08:19 INFO - ##### 05:08:19 INFO - Running pre-action listener: _resource_record_pre_action 05:08:19 INFO - Running main action method: download_and_extract 05:08:19 INFO - mkdir: /builds/slave/test/build/tests 05:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:19 INFO - https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/test_packages.json 05:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/test_packages.json 05:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:08:20 INFO - Downloaded 1149 bytes. 05:08:20 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:08:20 INFO - Using the following test package requirements: 05:08:20 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:08:20 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:20 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:08:20 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:20 INFO - u'jsshell-mac.zip'], 05:08:20 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:20 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:08:20 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:08:20 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:20 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:08:20 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:20 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:08:20 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:20 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:08:20 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:08:20 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:20 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:08:20 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:08:20 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:08:20 INFO - https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:08:21 INFO - Downloaded 17436604 bytes. 05:08:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:08:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:08:26 INFO - Return code: 0 05:08:26 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:26 INFO - https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:08:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:08:33 INFO - Downloaded 17436604 bytes. 05:08:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:08:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:08:38 INFO - Return code: 0 05:08:38 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:08:38 INFO - https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:08:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:08:40 INFO - Downloaded 11131618 bytes. 05:08:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:08:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:08:40 INFO - Return code: 0 05:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:40 INFO - https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:08:43 INFO - Downloaded 108646808 bytes. 05:08:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:43 INFO - mkdir: /builds/slave/test/properties 05:08:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:43 INFO - Contents: 05:08:43 INFO - build_url:https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:43 INFO - Running post-action listener: _resource_record_post_action 05:08:43 INFO - Running post-action listener: set_extra_try_arguments 05:08:43 INFO - ##### 05:08:43 INFO - ##### Running populate-webroot step. 05:08:43 INFO - ##### 05:08:43 INFO - Running pre-action listener: _resource_record_pre_action 05:08:43 INFO - Running main action method: populate_webroot 05:08:43 INFO - Guessing talos json url... 05:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:43 INFO - https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 05:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 05:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 05:08:44 INFO - Downloaded 99 bytes. 05:08:44 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 05:08:44 INFO - Contents: 05:08:44 INFO - 20151110030032 05:08:44 INFO - https://hg.mozilla.org/mozilla-central/rev/cc473fe5dc512c450634506f68cbacfb40a06a23 05:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:44 INFO - trying https://hg.mozilla.org/mozilla-central/raw-file/cc473fe5dc/testing/talos/talos.json 05:08:44 INFO - Downloading https://hg.mozilla.org/mozilla-central/raw-file/cc473fe5dc/testing/talos/talos.json to /builds/slave/test/build/talos.json 05:08:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/mozilla-central/raw-file/cc473fe5dc/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 05:08:45 INFO - Downloaded 4206 bytes. 05:08:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:08:45 INFO - '../fennec_ids.txt'], 05:08:45 INFO - 'tests': ['tcheck2']}, 05:08:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:45 INFO - '--tppagecycles', 05:08:45 INFO - '7'], 05:08:45 INFO - 'tests': ['tsvgm']}}, 05:08:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:08:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:08:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:08:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:08:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:08:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:45 INFO - 'talos_options': ['--e10s'], 05:08:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:45 INFO - 'tests': ['damp', 'tps']}, 05:08:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:45 INFO - 'talos_options': ['--e10s'], 05:08:45 INFO - 'tests': ['damp', 'tps']}, 05:08:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:08:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:45 INFO - 'other': {'tests': ['a11yr', 05:08:45 INFO - 'ts_paint', 05:08:45 INFO - 'tpaint', 05:08:45 INFO - 'sessionrestore', 05:08:45 INFO - 'sessionrestore_no_auto_restore']}, 05:08:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:08:45 INFO - 'tests': ['a11yr', 05:08:45 INFO - 'ts_paint', 05:08:45 INFO - 'tpaint', 05:08:45 INFO - 'sessionrestore', 05:08:45 INFO - 'sessionrestore_no_auto_restore']}, 05:08:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:08:45 INFO - 'tests': ['a11yr', 05:08:45 INFO - 'ts_paint', 05:08:45 INFO - 'tpaint', 05:08:45 INFO - 'sessionrestore', 05:08:45 INFO - 'sessionrestore_no_auto_restore']}, 05:08:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:08:45 INFO - 'tests': ['a11yr', 05:08:45 INFO - 'ts_paint', 05:08:45 INFO - 'tpaint', 05:08:45 INFO - 'sessionrestore', 05:08:45 INFO - 'sessionrestore_no_auto_restore']}, 05:08:45 INFO - 'other_l64': {'tests': ['a11yr', 05:08:45 INFO - 'ts_paint', 05:08:45 INFO - 'tpaint', 05:08:45 INFO - 'sessionrestore', 05:08:45 INFO - 'sessionrestore_no_auto_restore']}, 05:08:45 INFO - 'other_nol64': {'tests': ['a11yr', 05:08:45 INFO - 'ts_paint', 05:08:45 INFO - 'tpaint', 05:08:45 INFO - 'sessionrestore', 05:08:45 INFO - 'sessionrestore_no_auto_restore']}, 05:08:45 INFO - 'svgr': {'tests': ['tsvgx', 05:08:45 INFO - 'tsvgr_opacity', 05:08:45 INFO - 'tart', 05:08:45 INFO - 'tscrollx', 05:08:45 INFO - 'cart']}, 05:08:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:08:45 INFO - 'tests': ['tsvgx', 05:08:45 INFO - 'tsvgr_opacity', 05:08:45 INFO - 'tart', 05:08:45 INFO - 'tscrollx', 05:08:45 INFO - 'cart']}, 05:08:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:45 INFO - 'tests': ['tp5o']}, 05:08:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:45 INFO - 'talos_options': ['--e10s'], 05:08:45 INFO - 'tests': ['tp5o']}, 05:08:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:45 INFO - 'talos_options': ['--xperf_path', 05:08:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:45 INFO - 'tests': ['tp5n']}, 05:08:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:45 INFO - 'talos_options': ['--e10s', 05:08:45 INFO - '--xperf_path', 05:08:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:45 INFO - 'tests': ['tp5n']}}, 05:08:45 INFO - 'talos.zip': {'path': '', 05:08:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:45 INFO - Running post-action listener: _resource_record_post_action 05:08:45 INFO - ##### 05:08:45 INFO - ##### Running create-virtualenv step. 05:08:45 INFO - ##### 05:08:45 INFO - Running pre-action listener: _resource_record_pre_action 05:08:45 INFO - Running main action method: create_virtualenv 05:08:45 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:45 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:08:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:45 INFO - Using real prefix '/tools/python27' 05:08:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:46 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:50 INFO - Installing pip.................done. 05:08:50 INFO - Return code: 0 05:08:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x107eeda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadf0d16560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea29f0>, '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 0x107c01cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e6c990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/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.zJEEfDGOKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/Render', 05:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:50 INFO - 'HOME': '/Users/cltbld', 05:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:50 INFO - 'LOGNAME': 'cltbld', 05:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:50 INFO - 'MOZ_NO_REMOTE': '1', 05:08:50 INFO - 'NO_EM_RESTART': '1', 05:08:50 INFO - 'PAGER': '/bin/cat', 05:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:50 INFO - 'PWD': '/builds/slave/test', 05:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:50 INFO - 'SHELL': '/bin/bash', 05:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zJEEfDGOKs/Listeners', 05:08:50 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 05:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:50 INFO - 'USER': 'cltbld', 05:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:50 INFO - 'XPC_FLAGS': '0x0', 05:08:50 INFO - 'XPC_SERVICE_NAME': '0', 05:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:50 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:08:50 INFO - Cleaning up... 05:08:50 INFO - Return code: 0 05:08:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x107eeda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadf0d16560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea29f0>, '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 0x107c01cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e6c990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/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.zJEEfDGOKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/Render', 05:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:50 INFO - 'HOME': '/Users/cltbld', 05:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:50 INFO - 'LOGNAME': 'cltbld', 05:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:50 INFO - 'MOZ_NO_REMOTE': '1', 05:08:50 INFO - 'NO_EM_RESTART': '1', 05:08:50 INFO - 'PAGER': '/bin/cat', 05:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:50 INFO - 'PWD': '/builds/slave/test', 05:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:50 INFO - 'SHELL': '/bin/bash', 05:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zJEEfDGOKs/Listeners', 05:08:50 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 05:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:50 INFO - 'USER': 'cltbld', 05:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:50 INFO - 'XPC_FLAGS': '0x0', 05:08:50 INFO - 'XPC_SERVICE_NAME': '0', 05:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:51 INFO - Downloading/unpacking psutil>=0.7.1 05:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:08:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:53 INFO - Installing collected packages: psutil 05:08:53 INFO - Running setup.py install for psutil 05:08:53 INFO - building 'psutil._psutil_osx' extension 05:08:53 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:08:56 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:08:56 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:08:56 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:08:56 INFO - building 'psutil._psutil_posix' extension 05:08:56 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:08:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:56 INFO - ^ 05:08:56 INFO - 1 warning generated. 05:08:56 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:08:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:56 INFO - Successfully installed psutil 05:08:56 INFO - Cleaning up... 05:08:56 INFO - Return code: 0 05:08:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x107eeda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadf0d16560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea29f0>, '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 0x107c01cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e6c990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/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.zJEEfDGOKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:08:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/Render', 05:08:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:56 INFO - 'HOME': '/Users/cltbld', 05:08:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:56 INFO - 'LOGNAME': 'cltbld', 05:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:56 INFO - 'MOZ_NO_REMOTE': '1', 05:08:56 INFO - 'NO_EM_RESTART': '1', 05:08:56 INFO - 'PAGER': '/bin/cat', 05:08:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:56 INFO - 'PWD': '/builds/slave/test', 05:08:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:56 INFO - 'SHELL': '/bin/bash', 05:08:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zJEEfDGOKs/Listeners', 05:08:56 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 05:08:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:56 INFO - 'USER': 'cltbld', 05:08:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:56 INFO - 'XPC_FLAGS': '0x0', 05:08:56 INFO - 'XPC_SERVICE_NAME': '0', 05:08:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:08:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:59 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:08:59 INFO - Installing collected packages: mozsystemmonitor 05:08:59 INFO - Running setup.py install for mozsystemmonitor 05:08:59 INFO - Successfully installed mozsystemmonitor 05:08:59 INFO - Cleaning up... 05:08:59 INFO - Return code: 0 05:08:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:59 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:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:59 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:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x107eeda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadf0d16560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea29f0>, '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 0x107c01cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e6c990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/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.zJEEfDGOKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:08:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/Render', 05:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:59 INFO - 'HOME': '/Users/cltbld', 05:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:59 INFO - 'LOGNAME': 'cltbld', 05:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:59 INFO - 'MOZ_NO_REMOTE': '1', 05:08:59 INFO - 'NO_EM_RESTART': '1', 05:08:59 INFO - 'PAGER': '/bin/cat', 05:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:59 INFO - 'PWD': '/builds/slave/test', 05:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:59 INFO - 'SHELL': '/bin/bash', 05:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zJEEfDGOKs/Listeners', 05:08:59 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 05:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:59 INFO - 'USER': 'cltbld', 05:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:59 INFO - 'XPC_FLAGS': '0x0', 05:08:59 INFO - 'XPC_SERVICE_NAME': '0', 05:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:02 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:09:02 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:09:02 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:09:02 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:09:02 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:09:02 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:09:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:09:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:03 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:09:03 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:09:03 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:09:03 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:09:03 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:09:03 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:09:03 INFO - Downloading docopt-0.6.1.tar.gz 05:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:03 INFO - Running setup.py install for blobuploader 05:09:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:03 INFO - Running setup.py install for requests 05:09:04 INFO - Running setup.py install for docopt 05:09:04 INFO - Successfully installed blobuploader requests docopt 05:09:04 INFO - Cleaning up... 05:09:04 INFO - Return code: 0 05:09:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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:09:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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:09:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x107eeda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadf0d16560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea29f0>, '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 0x107c01cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e6c990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/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.zJEEfDGOKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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:09:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/Render', 05:09:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:04 INFO - 'HOME': '/Users/cltbld', 05:09:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:04 INFO - 'LOGNAME': 'cltbld', 05:09:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:04 INFO - 'MOZ_NO_REMOTE': '1', 05:09:04 INFO - 'NO_EM_RESTART': '1', 05:09:04 INFO - 'PAGER': '/bin/cat', 05:09:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:04 INFO - 'PWD': '/builds/slave/test', 05:09:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:04 INFO - 'SHELL': '/bin/bash', 05:09:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zJEEfDGOKs/Listeners', 05:09:04 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 05:09:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:04 INFO - 'USER': 'cltbld', 05:09:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:04 INFO - 'XPC_FLAGS': '0x0', 05:09:04 INFO - 'XPC_SERVICE_NAME': '0', 05:09:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:04 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-xQYFE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:05 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-zG3ARb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:05 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-XnS7sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:05 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-CT7z9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:05 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-u9rdah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:05 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-GAr1gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:05 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-oJsIcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:05 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-YXMCbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:05 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-nNpn2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:05 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-wLt98r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:06 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-8j5vJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:06 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-rSmehS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:06 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-ZjnfQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:06 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-gU_gMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:06 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-Yq0GlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:06 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-WKlpwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:06 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-qnXZxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:06 INFO - Running setup.py install for manifestparser 05:09:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:06 INFO - Running setup.py install for mozcrash 05:09:07 INFO - Running setup.py install for mozdebug 05:09:07 INFO - Running setup.py install for mozdevice 05:09:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:07 INFO - Running setup.py install for mozfile 05:09:07 INFO - Running setup.py install for mozhttpd 05:09:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:07 INFO - Running setup.py install for mozinfo 05:09:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:07 INFO - Running setup.py install for mozInstall 05:09:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Running setup.py install for mozleak 05:09:08 INFO - Running setup.py install for mozlog 05:09:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Running setup.py install for moznetwork 05:09:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Running setup.py install for mozprocess 05:09:08 INFO - Running setup.py install for mozprofile 05:09:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:08 INFO - Running setup.py install for mozrunner 05:09:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:09 INFO - Running setup.py install for mozscreenshot 05:09:09 INFO - Running setup.py install for moztest 05:09:09 INFO - Running setup.py install for mozversion 05:09:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:09 INFO - Cleaning up... 05:09:09 INFO - Return code: 0 05:09:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x107eeda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadf0d16560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea29f0>, '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 0x107c01cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e6c990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/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.zJEEfDGOKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:09:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/Render', 05:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:09 INFO - 'HOME': '/Users/cltbld', 05:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:09 INFO - 'LOGNAME': 'cltbld', 05:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:09 INFO - 'MOZ_NO_REMOTE': '1', 05:09:09 INFO - 'NO_EM_RESTART': '1', 05:09:09 INFO - 'PAGER': '/bin/cat', 05:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:09 INFO - 'PWD': '/builds/slave/test', 05:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:09 INFO - 'SHELL': '/bin/bash', 05:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zJEEfDGOKs/Listeners', 05:09:09 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 05:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:09 INFO - 'USER': 'cltbld', 05:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:09 INFO - 'XPC_FLAGS': '0x0', 05:09:09 INFO - 'XPC_SERVICE_NAME': '0', 05:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:09 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-Rh7IWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:10 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:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-3XURTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:10 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:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-3I0cBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:10 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:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-WIpIjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-AV5qJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:10 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:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-mvVeyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:10 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:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-whAcJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:10 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:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-8WV5t_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:10 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:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:10 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-Grtqir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:10 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:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-jhu8KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-kbJ6yO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:11 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:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-1Vm6ZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:11 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:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-XFYyix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-l_KbH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:11 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:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-v4uTky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:11 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:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-k8LNcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:11 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:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:11 INFO - Running setup.py (path:/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/pip-3crire-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:11 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:09:11 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:09:11 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:09:11 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:09:11 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:11 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:11 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:09:11 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:09:11 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:09:11 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:09:11 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:09:11 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:09:14 INFO - Downloading blessings-1.5.1.tar.gz 05:09:14 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:14 INFO - Installing collected packages: blessings 05:09:14 INFO - Running setup.py install for blessings 05:09:14 INFO - Successfully installed blessings 05:09:14 INFO - Cleaning up... 05:09:14 INFO - Return code: 0 05:09:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:14 INFO - Reading from file tmpfile_stdout 05:09:14 INFO - Current package versions: 05:09:14 INFO - blessings == 1.5.1 05:09:14 INFO - blobuploader == 1.2.4 05:09:14 INFO - docopt == 0.6.1 05:09:14 INFO - manifestparser == 1.1 05:09:14 INFO - mozInstall == 1.12 05:09:14 INFO - mozcrash == 0.16 05:09:14 INFO - mozdebug == 0.1 05:09:14 INFO - mozdevice == 0.47 05:09:14 INFO - mozfile == 1.2 05:09:14 INFO - mozhttpd == 0.7 05:09:14 INFO - mozinfo == 0.9 05:09:14 INFO - mozleak == 0.1 05:09:14 INFO - mozlog == 3.0 05:09:14 INFO - moznetwork == 0.27 05:09:14 INFO - mozprocess == 0.22 05:09:14 INFO - mozprofile == 0.27 05:09:14 INFO - mozrunner == 6.11 05:09:14 INFO - mozscreenshot == 0.1 05:09:14 INFO - mozsystemmonitor == 0.0 05:09:14 INFO - moztest == 0.7 05:09:14 INFO - mozversion == 1.4 05:09:14 INFO - psutil == 3.1.1 05:09:14 INFO - requests == 1.2.3 05:09:14 INFO - wsgiref == 0.1.2 05:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x107eeda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f5a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fadf0d16560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ea29f0>, '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 0x107c01cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e6c990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/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.zJEEfDGOKs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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:09:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/Render', 05:09:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:14 INFO - 'HOME': '/Users/cltbld', 05:09:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:14 INFO - 'LOGNAME': 'cltbld', 05:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:14 INFO - 'MOZ_NO_REMOTE': '1', 05:09:14 INFO - 'NO_EM_RESTART': '1', 05:09:14 INFO - 'PAGER': '/bin/cat', 05:09:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:14 INFO - 'PWD': '/builds/slave/test', 05:09:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:14 INFO - 'SHELL': '/bin/bash', 05:09:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zJEEfDGOKs/Listeners', 05:09:14 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 05:09:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:14 INFO - 'USER': 'cltbld', 05:09:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:14 INFO - 'XPC_FLAGS': '0x0', 05:09:14 INFO - 'XPC_SERVICE_NAME': '0', 05:09:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:15 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 1)) 05:09:15 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 2)) 05:09:15 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 3)) 05:09:15 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 4)) 05:09:15 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 5)) 05:09:15 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 6)) 05:09:15 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 7)) 05:09:15 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 8)) 05:09:15 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:15 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 3)) 05:09:15 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:15 INFO - Cleaning up... 05:09:15 INFO - Return code: 0 05:09:15 INFO - Running post-action listener: _resource_record_post_action 05:09:15 INFO - Running post-action listener: _start_resource_monitoring 05:09:15 INFO - Starting resource monitoring. 05:09:15 INFO - ##### 05:09:15 INFO - ##### Running install step. 05:09:15 INFO - ##### 05:09:15 INFO - Running pre-action listener: _resource_record_pre_action 05:09:15 INFO - Running main action method: install 05:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:15 INFO - Reading from file tmpfile_stdout 05:09:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:15 INFO - Reading from file tmpfile_stdout 05:09:15 INFO - Output received: 05:09:15 INFO - Usage: mozinstall [options] installer 05:09:15 INFO - Options: 05:09:15 INFO - -h, --help show this help message and exit 05:09:15 INFO - -d DEST, --destination=DEST 05:09:15 INFO - Directory to install application into. [default: 05:09:15 INFO - "/builds/slave/test"] 05:09:15 INFO - --app=APP Application being installed. [default: firefox] 05:09:15 INFO - mkdir: /builds/slave/test/build/application 05:09:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:09:51 INFO - Reading from file tmpfile_stdout 05:09:51 INFO - Output received: 05:09:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:09:51 INFO - Running post-action listener: _resource_record_post_action 05:09:51 INFO - ##### 05:09:51 INFO - ##### Running run-tests step. 05:09:51 INFO - ##### 05:09:51 INFO - Running pre-action listener: _resource_record_pre_action 05:09:51 INFO - Running main action method: run_tests 05:09:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:51 INFO - 2015-11-10 05:09:51.712 screenresolution[1633:7580] starting screenresolution argv=screenresolution get 05:09:51 INFO - 2015-11-10 05:09:51.716 screenresolution[1633:7580] Display 0: 1600x1200x32@60 05:09:51 INFO - 2015-11-10 05:09:51.722 screenresolution[1634:7582] starting screenresolution argv=screenresolution list 05:09:51 INFO - Available Modes on Display 0 05:09:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:51 INFO - Intel HD Graphics 3000: 05:09:51 INFO - Chipset Model: Intel HD Graphics 3000 05:09:51 INFO - Type: GPU 05:09:51 INFO - Bus: Built-In 05:09:51 INFO - VRAM (Total): 512 MB 05:09:51 INFO - VRAM (Dynamic, Max): 10 05:09:51 INFO - Vendor: Intel (0x8086) 05:09:51 INFO - Device ID: 0x0116 05:09:51 INFO - Revision ID: 0x0009 05:09:51 INFO - Displays: 05:09:51 INFO - Display: 05:09:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:51 INFO - Display Serial Number: 1600x1200 60 05:09:51 INFO - Main Display: Yes 05:09:51 INFO - Mirror: Off 05:09:51 INFO - Online: Yes 05:09:51 INFO - Rotation: Supported 05:09:51 INFO - Return code: 0 05:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:51 INFO - Python 2.7.3 05:09:51 INFO - Return code: 0 05:09:51 INFO - grabbing minidump binary from tooltool 05:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:51 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 0x107ea29f0>, '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 0x107c01cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107e6c990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:51 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:09:51 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:09:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:52 INFO - Return code: 0 05:09:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0010', '--webServer', 'localhost'] in /builds/slave/test/build 05:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0010 --webServer localhost 05:09:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yW2WHr40kJ/Render', 05:09:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:52 INFO - 'HOME': '/Users/cltbld', 05:09:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:52 INFO - 'LOGNAME': 'cltbld', 05:09:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:52 INFO - 'MOZ_NO_REMOTE': '1', 05:09:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:52 INFO - 'NO_EM_RESTART': '1', 05:09:52 INFO - 'PAGER': '/bin/cat', 05:09:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:52 INFO - 'PWD': '/builds/slave/test', 05:09:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:52 INFO - 'SHELL': '/bin/bash', 05:09:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zJEEfDGOKs/Listeners', 05:09:52 INFO - 'TMPDIR': '/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/', 05:09:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:52 INFO - 'USER': 'cltbld', 05:09:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:52 INFO - 'XPC_FLAGS': '0x0', 05:09:52 INFO - 'XPC_SERVICE_NAME': '0', 05:09:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0010', '--webServer', 'localhost'] with output_timeout 3600 05:09:52 INFO - mozversion INFO | application_buildid: 20151110030032 05:09:52 INFO - mozversion INFO | application_changeset: cc473fe5dc512c450634506f68cbacfb40a06a23 05:09:52 INFO - mozversion INFO | application_display_name: Nightly 05:09:52 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:52 INFO - mozversion INFO | application_name: Firefox 05:09:52 INFO - mozversion INFO | application_remotingname: firefox 05:09:52 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:09:52 INFO - mozversion INFO | application_vendor: Mozilla 05:09:52 INFO - mozversion INFO | application_version: 45.0a1 05:09:52 INFO - mozversion INFO | platform_buildid: 20151110030032 05:09:52 INFO - mozversion INFO | platform_changeset: cc473fe5dc512c450634506f68cbacfb40a06a23 05:09:52 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:09:52 INFO - mozversion INFO | platform_version: 45.0a1 05:09:52 INFO - 2015-11-10 05:09:52,406 DEBUG : using testdate: 1447160992 05:09:52 INFO - 2015-11-10 05:09:52,406 DEBUG : actual date: 1447160992 05:09:52 INFO - 2015-11-10 05:09:52,416 INFO : starting webserver on 'localhost:49278' 05:09:52 INFO - 2015-11-10 05:09:52,417 INFO : Starting test suite t-yosemite-r5-0010 05:09:52 INFO - 2015-11-10 05:09:52,417 INFO : Starting test dromaeo_css 05:09:52 INFO - 2015-11-10 05:09:52,417 DEBUG : operating with platform_type : mac_ 05:09:52 INFO - 2015-11-10 05:09:52,418 INFO : Initialising browser for dromaeo_css test... 05:09:52 INFO - 2015-11-10 05:09:52,449 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmpHBwnTL/profile http://localhost:49278/getInfo.html 05:09:56 INFO - 2015-11-10 05:09:56,050 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:09:56 INFO - 2015-11-10 05:09:56,051 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:09:56 INFO - 2015-11-10 05:09:56,051 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:09:56 INFO - 2015-11-10 05:09:56,051 DEBUG : BROWSER_OUTPUT: __metrics 05:09:56 INFO - 2015-11-10 05:09:56,067 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:56 INFO - 2015-11-10 05:09:56,787 INFO : Browser initialized. 05:09:56 INFO - 2015-11-10 05:09:56,787 INFO : Running cycle 1/1 for dromaeo_css test... 05:09:56 INFO - 2015-11-10 05:09:56,787 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmpHBwnTL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:10:08 INFO - 2015-11-10 05:10:08,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 229167104 05:10:08 INFO - 2015-11-10 05:10:08,900 DEBUG : BROWSER_OUTPUT: 05:10:59 INFO - 2015-11-10 05:10:59,853 DEBUG : BROWSER_OUTPUT: 1447161059852 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:13:11 INFO - 2015-11-10 05:13:11,182 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 05:13:12 INFO - 2015-11-10 05:13:12,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 341954560 05:13:12 INFO - 2015-11-10 05:13:12,440 DEBUG : BROWSER_OUTPUT: 05:16:15 INFO - 2015-11-10 05:16:15,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 05:16:15 INFO - 2015-11-10 05:16:15,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 364818432 05:16:15 INFO - 2015-11-10 05:16:15,589 DEBUG : BROWSER_OUTPUT: 05:19:17 INFO - 2015-11-10 05:19:17,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 05:19:18 INFO - 2015-11-10 05:19:18,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 334131200 05:19:18 INFO - 2015-11-10 05:19:18,318 DEBUG : BROWSER_OUTPUT: 05:22:20 INFO - 2015-11-10 05:22:20,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 05:22:21 INFO - 2015-11-10 05:22:21,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 316489728 05:22:21 INFO - 2015-11-10 05:22:21,035 DEBUG : BROWSER_OUTPUT: 05:25:23 INFO - 2015-11-10 05:25:23,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 05:25:24 INFO - 2015-11-10 05:25:24,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 319672320 05:25:24 INFO - 2015-11-10 05:25:24,583 DEBUG : BROWSER_OUTPUT: 05:28:27 INFO - 2015-11-10 05:28:27,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 05:28:27 INFO - 2015-11-10 05:28:27,495 DEBUG : BROWSER_OUTPUT: RSS: Main: 423731200 05:28:27 INFO - 2015-11-10 05:28:27,495 DEBUG : BROWSER_OUTPUT: 05:28:27 INFO - 2015-11-10 05:28:27,495 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:28:27 INFO - 2015-11-10 05:28:27,495 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:28:27 INFO - 2015-11-10 05:28:27,496 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:28:27 INFO - 2015-11-10 05:28:27,496 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:28:27 INFO - 2015-11-10 05:28:27,497 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3180.920476988075;3234.450143475609;3255.348930213958;3259.445894197986;3290.3090351026285;5289.814856480024;5384.3538775347015;5437.32033495813;5479.726013699319;5493.2034854946005;5376.462353764621;5458;5458.61789674723;5499.477549632798;5534.280543529346;4939.555440010398;4964.280179373988;5001.14980453322;5022.271770593262;5046.192609182532;5021.447640759514;5055.064813009605;5055.140626093555;5076.771545280471;5174.146265866147;4774.832880849189;4873.610111191097;4889.095517329305;4910.803567857281;4972.328735620681;4840.346553215306;4887.315775791392;4924.359833221658;4948.430930443009;4950.4307004694565;4885.43817460993;4922.433920099199;4936;4952.430470495867;5049.368828896388;5100.464451232641;5291.28567643367;5319.494648008433;5323.041852466555;5329.040772660919;5659.377468478464;5668.603197776158;5690.118031705092;5766.855828604276;5804.854878628068;5736.311642602915;5814.389489103625;5827.999999999957;5833.504152147073;5848;5267.762950667229;5424.457554244584;5465.262189604432;5476.424975377608;5578.219049333096;5705.686187259741;5725.942740572625;5850.707464626752;5856.180134781134;5875.764969401262;5680.829575112753;5682.772689092472;5694.743736531866;5704.11586204139;5781.566382521328;5616.887662246732;5835.79574714883;5866.618669786536;5872.119182122716;5913.49735272498;5596.860078497989;5601.60788744784;5602.523785478198;5641.971790141023;5703.714814259353;5668.319801623831;5715.228444160069;5725.484706376446;5729.1119876419225;5739.799107031234;4327.242732521796;4453.821847126079;4454.443194600675;4521.751303678264;4544.500104988449;3975.6620687241907;3987.840486380512;4027.1140349123148;4068.044009657728;4092.2429350569646;5288.36539615241;5364.356277246678;5370.892582148335;5375.139977603643;5437.945620543823;5598.524125449382;5817.970910145422;5819.912701309484;5833.300003999547;5834.416558344216;5298.894022119536;5312.92030619541;5319.441458646864;5322.654027488278;5381.569474442035;5053.494650534991;5076.568491678248;5085.542301192911;5094.974525127351;5099.3370861787735;5716.199732037601;5896.557758168155;5915.08316210988;5935.139404786368;5941.465268125889;5697.943020569907;5740;5787.189793428839;5867.6772777497645;5909.054551271776;5928.584999050025;5934.495567876779;5945.851353716192;5947.434993675594;6007.609505382136;5577.581681373832;5726.0838265877255;5738.598298119092;5743.569232307677;5780.566457515619;5628.296462942132;5656.830295091154;5682.176084467812;5769.769209231584;5796.82609521715;5545.833624991256;5645.096784514622;5657;5665.688387138582;5667.773289068556;5518.144687573433;5650.23721797552;5651.378348381592;5663.575231857545;5671.943280567141;5453.890922181614;5494.450554944474;5508.641938274;5520.613557051129;5571.554275657856;5616.410276920865;5637.943620563742;5657.915131272952;5665.093585026376;5703;5321.148616221541;5557.944420555743;5561.4716601922755;5569.248151499496;5589.161625756169 05:28:27 INFO - 2015-11-10 05:28:27,500 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.8819903720699;555.0702573189907;570.5093619487241;574.1817909478997;577.0997244298893;31389;31939.520907186383;38483.23033539331;39159;39200.21599568014;40769.59230407702;41201.793991030005;41282.380764288486;41760.791196044054;41887;8174.959125204366;8796.42823216492;8915.643374265022;8981.416207946495;8997.550122493882;8314.916850831505;11117.777644447106;11145.888541114566;11162.832557511643;11200.103991680688;10875.891241087607;10986.340819550813;11026.503807328649;11051.72370690731;11068.00387965083;8424.326053915673;8599.398042137052;10963.397013164273;11044.889551104507;11260.887391126065;10871.347719136877;10980.890191098066;10983.780324393467;11050.557977680963;11104.833427498514;39404;39810;39906.800465997774;40221.59778402208;40344.19311613751;3057.877684892602;3164.841757912095;3295.242094318296;3352.463605823081;3495.8077305748175;26557.601635975476;26680.066197682987;26808.32979175536;26957.865210674016;27827.721722782717;2321.3732292281156;2367.4673198530363;2390.53384590005;2391.1152873436768;2499.762522560354;277740;278628;278642;281440.99999999796;282583;53863.46136538585;54481;57396.71301643465;57656;58077;66965.66517167383;67703;67802.66098669574;67820.6608966952;67859;15828.920855395649;15957.601059973593;16337;16383.09892955875;16465.423710170086;12328.691782705504;12404.875951240552;12415.44130514129;12567.371631418393;12583.182093163916;19118.426447206606;19123.521911952033;19162.616747664968;19215.615687686448;19265.51836204106;8062;8395.832083358298;8414.663413463515;8422.494650321001;8450.112738162527;849.8342823149427;915.4919019943995;1010.3382284603449;1050.2805578178973;1063.4470075560819;27382.178534643994;27459;27470.313242169104;27821.443571128464;27975.860120699268;1015.8780946286493;1035.917126629883;1083.1876092930302;1105.2981356838466;1136.63059505661;14472.565823025327;14506.854931450762;14621.561353159423;14656.706865862836;14681.632959175893;313157;320782;321167;321530;322844;52481.47518524766;52647.736761316715;52673.47326526685;52692.473075269525;52728.736356317975;1361.8910487161004;1370.4381203706432;1371.5542448704011;1375.7523645743863;1393.996322647692;26864.792262715888;27145.45709085847;27431.314217144733;27777.583336250376;27890.163295101178;46828.7658561705;46956.76521617507;47307.526924730315;47340;47358.52641473679;269671;277397;277770;372724;375906;31254;31328.843355783076;31456.370872581963;31497.432872233858;31587.526187106752;40007.39988900227;40361.780102094664;40592.594074058885;40605.1897557261;40662.1867562653;33482.66517334893;33729.49405758965;34675;34809;34938.47592286067;33541;34143.82928085344;34251.31497369989;34578.48132277968;34613.30773384468;34435.311293773484;34464;34467.310653786284;34720.652793471745;34969.475457867644;28381.716182837907;29790.851045744632;30041.248968775955;30128.246793829454;30265.848670756506;22928.31215063551;23176;23202.535949281257;23510.764892350857;23736 05:28:27 INFO - 2015-11-10 05:28:27,502 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.4695962979416;331.6782720760863;337.745002523095;338.387583166213;342.25730165540784;14447.349869255882;14892.180930048842;16825.579360515978;16836.57908552287;17581.560460988483;14191.645208869784;15303.770443443358;17078.829211707878;17103;17472.21375038123;5136.1782114861535;5271.499207575274;5285.867853303679;5308.283381743473;5355.410904800468;3876.980615096935;4023.436718859362;4590.242609969351;5286.259923610698;5358.115910874701;5668.121441176624;5767.192593036978;5796.101604251347;5803.82588522345;5902.498287645555;5737.25415695959;5891.764329426796;5894.410558944114;5957.821265362024;5964.910526342108;5047.697138171721;5055.823046193365;5060.7722652480725;5142.640015198937;5150.995555866608;21069.473263168544;21195.68206476904;21716.13135474579;21717.239896603543;21887;1992.4919145617775;2034.8575599708026;2072.699458578498;2132.680097985299;2213.225371120095;12924.159929604546;13143.408546615425;13508;13651.453941842314;13739.038267321292;1451.7749748788954;1506.5254444849836;1661.900285982845;1669.5742585640585;1692.8307169283096;56865.71567142138;57104;57174.142387864216;57285.71357143271;57460.71269643667;9260.536973151315;9427.811443771086;9462.810743785223;9494.192993595483;9670.371425857438;11542.19204655683;11580.652580422433;11591.84081591851;11628.244164129304;11698.649040528799;7848.9215107848195;7867.252611001945;7912.248336408032;7942.920570794218;7989.44073914832;8010.479318844256;8019.03771547418;8042.879356809653;8079.596020199084;8191.549464779375;5572.0527510323345;5596.356419011784;5637.577181711388;5652.8869422611315;5676.7161641918565;1522.6041229280245;1605.494269305165;1605.614652483419;1641.458318754832;1679.5885008172831;370.5349786018583;379.99430008549894;392.9155231625214;397.75935558986396;944.617429940875;10358.223133264884;10557.9472102639;10563.47182640865;10618.097461715686;10648.574057037787;395.9980200098981;401.15756910487744;406.0457923878861;426.82286850956507;437.71966996535645;5309.41596424393;5556.555475561945;5633.211350410946;5672.09246520563;5699.031164702011;513135;527240;528469;529194;543427;66669.33330666632;68605;70057;70249;70354;477.40562999066384;484.02710551791154;487.2934245344265;488.4187816498427;488.5554145727371;10599.47002649849;10748.731281718019;10778.461076945965;10804.351738895692;10820.945895270474;34063.14842128967;34847.12882177864;34851.65148348585;34957.30085398329;35380;45779.31331029971;46061.539384607066;46301;46365.53634463747;46613.30080048734;5859;6082.057281121433;6157.568970172045;6174.44430001302;6185.319614842454;11337.319760814378;11622.418879056182;11671.241369310968;11722.531098756295;11776.646700598996;9737.269704772028;9996.600135994478;10107.89892101099;10234.437105959243;10261.640842570474;9741.123298903132;9746.220302375934;9886.901130988597;9914.30599858003;10139.64511242103;8620.568971551273;8846.292296616384;8867.379283450096;10082.69751907444;10332.328398654063;5977.880442391215;6088.969555152196;6105.572609917263;6107.236595425572;6122.877542449037;9764.707058788248;9865.26010549226;10161.441120738134;10176.389416635026;10214.948925255327 05:28:27 INFO - 2015-11-10 05:28:27,505 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1292.1988367212318;1731.0911771320057;1805.4222648752395;1816.936407225747;1823.0337920901918;7037.788866334012;7170.749023784162;7417.962910185448;7580.583067931261;7583.582902940336;7424.517406368583;7457.776266712007;7485.288897554724;7493.213212612679;7530.736424225153;1926.9132889019957;1970.290695349673;2135.604913091079;2156.9352919412363;2157.4174972757346;2111.6938043983614;2165.069020321261;2166.19850655257;2173.641349177392;2176.5320456101936;2158.84888057836;2169.8047175754177;2175.673648952662;2184.191849015858;2203.8787866667326;1923.7018262169386;1989.094961792381;2113.651247544153;2174.71728675272;2176.5755677642865;2179.858309209896;2183.814375778061;2203.1407750977132;2205.5699138667965;2223.3330000999636;7367.778966630956;7459.589722565257;7479.626018699043;7480.438967077436;7481.962590187069;4590.74750888701;4689.953100468986;4691.390119284505;4707.964247865464;4728.290756386536;2729.5769155780886;2821.9294517637018;2826.42058378032;2869.813462124955;2896.681365049843;867.5575456517222;881.0748713850495;894.6197865906963;894.6868595991416;905.1582028713294;9669.17811985982;9682.225421966295;9682.322237443383;9684.75788105296;9762.463064531448;4110.219058378899;4122;4182.832686692559;4193.5387107418155;4228.260054490452;8523.147685231428;8541.701040463555;8566.871496927552;8579.442336248125;8591.312694984512;4672.322513235562;4687.929681054787;4689.7655117244685;4695.976520117378;4703.623710103184;4279.358096285519;4285.142971405731;4286.485621725413;4320.395144679747;4322.978385108055;3594.4428613564937;3611.422172452395;3649;3655.9634403656155;3686.944695829565;1160.442987366069;1170.4264910194113;1181.0610564601163;1183.6330737471412;1188.5127097889824;1279.3922886628964;1290.5160564788205;1310.122218113866;1313.6453157647381;1336.7927971164486;6730.293319201512;6918.5502942308585;6959.860802783916;7276.272372762682;7279.490435669452;635.2948227467507;650.1385663995226;652.5823472977298;654.7282877605835;661.1339145719028;5628.802991895346;5756.136579513023;5767.769289228468;5776.220210271644;5794.0439827428;8868.64525418976;8978;8986.820263594691;9003.414778039407;9065.864012039825;8726.91273087261;8905.73282801517;8942.195202431682;8955.731328060168;9025.187733104052;7019.227884932653;7027.086478757728;7048.753293634801;7117.217106118323;7173;6845.315468453115;6869.175698915962;6899.103116594811;6930.826729331606;6937;7947.5231486111015;7996.800079997814;8003;8124.715634952749;8134.796630084058;7660.5403675779635;7919.524828510077;8153.858459815512;8179.550124743197;8231.670733170846;6785.6946437411425;6860.279670634711;6879.690413931285;6885.380315771605;6973.19808222061;7015.193252775996;7125.786226413215;7147.070880785464;7394;7477.92522074794;6639.535232533676;6751.763688270887;6812.591244525344;6817.0456136141975;6840.179178498612;6556.770513032021;6632.83417914556;6663.766768163091;6722.260551339251;6780.1524809398825;6096.878062438637;6315.336889626523;6871.312868713088;6871.656417179221;6885.586864788129;6087.482563982111;6259.78090766821;6286.119943207863;6298.401651843067;6325.399087086719;6262.906056409249;6291.748330066746;6315.210598675166;6327.588706734047;6407.935920640734 05:28:27 INFO - 2015-11-10 05:28:27,506 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.0642591503235;322.8498748082141;323.6908752141705;328.36625313145635;330.2915246795624;6024.608400453978;6045.03279475284;6071.757129714817;6131.448169664729;6158.261008678954;5933.288005439343;6008.87982240356;6053.394660533955;6061.060535616975;6100.877982440348;4484.260097083978;4545.454545454533;4644.187267228239;4665.0669866026765;4714.952850471503;4598.885027874297;4641.605463535603;4671.135839869635;4679.953200468003;4689.742064186468;4581.083783243348;4606.677532572721;4622.329762184481;4637.791299391535;4637.930431043537;4590.88522786933;4601.148787474312;4605.332226827091;4622.144903192903;4624.213883639789;3838.539375274957;3994.1811928554575;4011.618896204856;4019.155977244782;4083.9591604083876;5870.354261031283;5883.17635531026;5922.792702255443;5980.0431930890845;5980.521558275327;5145.614078944057;5177.249298851645;5187.403448603422;5213.4525874782985;5222.060029194743;6090.817275481699;6167.136600875881;6238.095476155932;6301.086342480315;6407.135036770023;4214.304639734441;4249.405083288311;4262.42457268271;4266.893327666802;4322.005938634132;6495.123158373606;6580.111684922522;6592.76925307612;6618.437432818217;6656.966715166442;4221.78891055446;4329.047609525899;4339.913201735948;4341.45731783527;4359.215341238544;4426.0926510066;4426.136903303889;4432.357308190359;4442.178197033559;4449.021215332622;5105.744712764347;5111.846644600668;5117.974410128;5151.665141765773;5183.97408012965;6095.420935011167;6326.019466982625;6350.142730731384;6364.395382438754;6376.617402955838;1521.5815650696147;1557.9532614021598;1569.1761825041945;1570.7408277634063;1578.8736901048119;1000.4447531619875;1015.0052948110745;1015.1472762879217;1025.933314334566;1029.1869423155624;5923.881522369615;5950.285965684059;5963.970180149072;5964.821055368346;5981.401859814071;6511.837204069936;6530.183727034121;6573.211214654177;6574.211094668671;6575.769848055295;5982.73077711504;6012.518998480111;6029.487493563096;6034;6035.698215089228;3531.876384326536;3671.008827616582;3672.57765356982;3712.9814350928073;3719.9442008369897;6799.456043516507;6801.353871382211;6839.726410943606;6859.485538584626;6890.379865812101;6787.660616969132;6792.558483698544;6870.965645171742;6901.344372284625;6907.585544867224;6589.703463344161;6694.799156025327;6830.351116643911;6831.9658401707675;6891.241963384124;6576.210854697467;6622.735090596322;6635.9004614929845;6707.5304728668525;6727.730890764315;6440.774572889926;6487.448566871869;6551.148350714377;6582.473402127914;6588.209414870246;6632.535722499571;6754.2570317266045;6775.559588626724;6790.660466976533;6883.690233939385;4314.0077782109665;4355.607995280313;4361.716488428242;4366.995591014148;4379.386885835922;6672.466202703869;6705.597664140168;6707.564008339442;6765.323467653392;6765.932340676531;6319.083732858801;6344.619322840645;6504.6747662615735;6545.116409284686;6576;6480.254770701241;6507.349265073455;6527.11883895687;6530.020496925499;6566.770163044462;6286.18279623646;6331.303556608677;6380.744770209325;6407.647579383179;6454.322296158835;6351.936480635134;6493.253275873335;6494.383033611799;6496.545241833026;6604.174478190226;6143.293521244936;6335.366463353628;6350.396712312323;6363.140975968185;6372.681365931592 05:28:27 INFO - 2015-11-10 05:28:27,510 DEBUG : BROWSER_OUTPUT: |5;yui.html;653.7189008726249;661.1636280105664;694.319566824512;771.0362047440699;776.359503409687;13533.158036812256;13572.117812342203;13792.448302067905;13831.239281839495;13908.582742517729;12806.103572749887;12875.3562321884;12895.419706113224;12924.353782310895;12931.612051638465;649.8700259948006;685.6982927511879;890.1632465482459;914.6112902016649;918.4581097152678;881.2553392383426;888.6401007591903;897.3718397122008;897.8383890899636;900.5002223765807;911.4075850697067;926.0461724423855;929.066288380177;937.2127412973101;945.3666043750703;673.4376795375891;714.9428045756327;873.6068769053951;900.4372267332917;927.1192367251105;660.3924389561615;664.139938779282;665.7636539028672;671.1074271219267;674.6626686656672;13398.665033374145;13490.662733431645;13491;13538.255395953218;13567.932160339134;11469.827952580717;11736.647900562997;11811.173217874752;11945.044396448264;11995.64013079609;9079;9152.222061124812;9169.679061232891;9261.768455788591;9687.128158465772;3277.3772983133367;3308.338332333519;3311.586051743532;3321.3025264694443;3375.206826395795;46498;46538.5346146541;46706.299405508944;46722.53277467216;46887;9002.729918102468;9150.084991500797;9183.862242066374;9186.448813071238;9703.902960970441;19368;19482;19844;19854;19887.105080271424;6798.898016529756;6849.109615750021;6864.7940561783225;6894.896576551356;6934.7226110955;3806.08653923062;3813.5042444482597;3831.885043448701;3863.4011728182177;3883.650471457582;3024.5916801231992;3038.103759390985;3057.602511673468;3062;3074.492708703039;452.35313501692895;458.3926297655553;463.86547901108975;466.20279322359147;467.28272102322774;524.4991033563015;552.1855263486326;567.3050513121476;583.6614763437196;584.5557376393971;7740.729074482366;8012;8033.3974951878845;8180.226820789729;8288.129746376664;476.6591886800954;562.9605927585112;566.1366416215304;592.431265984651;606.1634943777559;3904.863329783444;3917.138229589543;3932.7050471214775;3935.8476806968924;4125.608067233608;56232.71883640638;56352.436475635535;56363.71818140965;56364.71817640885;56588.717056414454;49661.75169124131;50396.74801626042;50823.49176508262;50828.74585627122;51031.234531482056;46848;47319.29021064687;47376;48831.75584122057;48870.51129488659;8253.463524870864;8271.2142346477;8370.58147092655;8500.957495212484;8613.82772344537;34295;34299.31401372008;34640.30719385648;35529.822350888084;35578.822105890344;42913.5708642922;42928.141437171704;43527.78236108799;46149.538504614524;46340.536594633624;10480.318779279323;10744.623938162127;10775.946120269662;11000.174986876176;11051.441210756702;11133.888661113286;11250.718732031764;11653.067754579783;11992.76014479723;12172.2696638202;10264.58941642326;10450;10725.839112413163;10758.569657213624;11268.267562608733;10349.327293725884;10360.533775979948;10705.625303114353;10771.730706732082;10921.399323037309;10336.689899303034;10562.524686389284;10752.623658172239;10827.621033263798;11355.261907975955;8717.084706106021;8728.69449569262;9317.148708726872;9361.251099912128;9652.083052110038;8102.7164049260355;8257.256846883809;8591.398602098043;8878.289736821169;9412.717618471457 05:28:27 INFO - 2015-11-10 05:28:27,510 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:28:27 INFO - 2015-11-10 05:28:27,510 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:28:27 INFO - 2015-11-10 05:28:27,510 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 05:28:27 INFO - 2015-11-10 05:28:27,510 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:28:27 INFO - 2015-11-10 05:28:27,510 DEBUG : BROWSER_OUTPUT: __startTimestamp1447162107494__endTimestamp 05:28:27 INFO - 2015-11-10 05:28:27,511 DEBUG : BROWSER_OUTPUT: 05:28:27 INFO - 2015-11-10 05:28:27,511 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:28:27 INFO - 2015-11-10 05:28:27,511 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:28:27 INFO - 2015-11-10 05:28:27,511 DEBUG : BROWSER_OUTPUT: 05:28:27 INFO - 2015-11-10 05:28:27,511 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5361.17 Median:5561.47 stddev:570.75 (10.3%) stddev-sans-first:546.27 05:28:27 INFO - 2015-11-10 05:28:27,511 DEBUG : BROWSER_OUTPUT: Values: 3180.9 3234.5 3255.3 3259.4 3290.3 5289.8 5384.4 5437.3 5479.7 5493.2 5376.5 5458.0 5458.6 5499.5 5534.3 4939.6 4964.3 5001.1 5022.3 5046.2 5021.4 5055.1 5055.1 5076.8 5174.1 4774.8 4873.6 4889.1 4910.8 4972.3 4840.3 4887.3 4924.4 4948.4 4950.4 4885.4 4922.4 4936.0 4952.4 5049.4 5100.5 5291.3 5319.5 5323.0 5329.0 5659.4 5668.6 5690.1 5766.9 5804.9 5736.3 5814.4 5828.0 5833.5 5848.0 5267.8 5424.5 5465.3 5476.4 5578.2 5705.7 5725.9 5850.7 5856.2 5875.8 5680.8 5682.8 5694.7 5704.1 5781.6 5616.9 5835.8 5866.6 5872.1 5913.5 5596.9 5601.6 5602.5 5642.0 5703.7 5668.3 5715.2 5725.5 5729.1 5739.8 4327.2 4453.8 4454.4 4521.8 4544.5 3975.7 3987.8 4027.1 4068.0 4092.2 5288.4 5364.4 5370.9 5375.1 5437.9 5598.5 5818.0 5819.9 5833.3 5834.4 5298.9 5312.9 5319.4 5322.7 5381.6 5053.5 5076.6 5085.5 5095.0 5099.3 5716.2 5896.6 5915.1 5935.1 5941.5 5697.9 5740.0 5787.2 5867.7 5909.1 5928.6 5934.5 5945.9 5947.4 6007.6 5577.6 5726.1 5738.6 5743.6 5780.6 5628.3 5656.8 5682.2 5769.8 5796.8 5545.8 5645.1 5657.0 5665.7 5667.8 5518.1 5650.2 5651.4 5663.6 5671.9 5453.9 5494.5 5508.6 5520.6 5571.6 5616.4 5637.9 5657.9 5665.1 5703.0 5321.1 5557.9 5561.5 5569.2 5589.2 05:28:27 INFO - 2015-11-10 05:28:27,512 DEBUG : BROWSER_OUTPUT: 05:28:27 INFO - 2015-11-10 05:28:27,512 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47150.05 Median:172242.92 stddev:80300.62 (46.6%) stddev-sans-first:80449.65 05:28:27 INFO - 2015-11-10 05:28:27,512 DEBUG : BROWSER_OUTPUT: Values: 548.9 555.1 570.5 574.2 577.1 31389.0 31939.5 38483.2 39159.0 39200.2 40769.6 41201.8 41282.4 41760.8 41887.0 8175.0 8796.4 8915.6 8981.4 8997.6 8314.9 11117.8 11145.9 11162.8 11200.1 10875.9 10986.3 11026.5 11051.7 11068.0 8424.3 8599.4 10963.4 11044.9 11260.9 10871.3 10980.9 10983.8 11050.6 11104.8 39404.0 39810.0 39906.8 40221.6 40344.2 3057.9 3164.8 3295.2 3352.5 3495.8 26557.6 26680.1 26808.3 26957.9 27827.7 2321.4 2367.5 2390.5 2391.1 2499.8 277740.0 278628.0 278642.0 281441.0 282583.0 53863.5 54481.0 57396.7 57656.0 58077.0 66965.7 67703.0 67802.7 67820.7 67859.0 15828.9 15957.6 16337.0 16383.1 16465.4 12328.7 12404.9 12415.4 12567.4 12583.2 19118.4 19123.5 19162.6 19215.6 19265.5 8062.0 8395.8 8414.7 8422.5 8450.1 849.8 915.5 1010.3 1050.3 1063.4 27382.2 27459.0 27470.3 27821.4 27975.9 1015.9 1035.9 1083.2 1105.3 1136.6 14472.6 14506.9 14621.6 14656.7 14681.6 313157.0 320782.0 321167.0 321530.0 322844.0 52481.5 52647.7 52673.5 52692.5 52728.7 1361.9 1370.4 1371.6 1375.8 1394.0 26864.8 27145.5 27431.3 27777.6 27890.2 46828.8 46956.8 47307.5 47340.0 47358.5 269671.0 277397.0 277770.0 372724.0 375906.0 31254.0 31328.8 31456.4 31497.4 31587.5 40007.4 40361.8 40592.6 40605.2 40662.2 33482.7 33729.5 34675.0 34809.0 34938.5 33541.0 34143.8 34251.3 34578.5 34613.3 34435.3 34464.0 34467.3 34720.7 34969.5 28381.7 29790.9 30041.2 30128.2 30265.8 22928.3 23176.0 23202.5 23510.8 23736.0 05:28:27 INFO - 2015-11-10 05:28:27,512 DEBUG : BROWSER_OUTPUT: 05:28:27 INFO - 2015-11-10 05:28:27,513 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26926.26 Median:23545.35 stddev:86369.03 (366.8%) stddev-sans-first:86588.22 05:28:27 INFO - 2015-11-10 05:28:27,514 DEBUG : BROWSER_OUTPUT: Values: 330.5 331.7 337.7 338.4 342.3 14447.3 14892.2 16825.6 16836.6 17581.6 14191.6 15303.8 17078.8 17103.0 17472.2 5136.2 5271.5 5285.9 5308.3 5355.4 3877.0 4023.4 4590.2 5286.3 5358.1 5668.1 5767.2 5796.1 5803.8 5902.5 5737.3 5891.8 5894.4 5957.8 5964.9 5047.7 5055.8 5060.8 5142.6 5151.0 21069.5 21195.7 21716.1 21717.2 21887.0 1992.5 2034.9 2072.7 2132.7 2213.2 12924.2 13143.4 13508.0 13651.5 13739.0 1451.8 1506.5 1661.9 1669.6 1692.8 56865.7 57104.0 57174.1 57285.7 57460.7 9260.5 9427.8 9462.8 9494.2 9670.4 11542.2 11580.7 11591.8 11628.2 11698.6 7848.9 7867.3 7912.2 7942.9 7989.4 8010.5 8019.0 8042.9 8079.6 8191.5 5572.1 5596.4 5637.6 5652.9 5676.7 1522.6 1605.5 1605.6 1641.5 1679.6 370.5 380.0 392.9 397.8 944.6 10358.2 10557.9 10563.5 10618.1 10648.6 396.0 401.2 406.0 426.8 437.7 5309.4 5556.6 5633.2 5672.1 5699.0 513135.0 527240.0 528469.0 529194.0 543427.0 66669.3 68605.0 70057.0 70249.0 70354.0 477.4 484.0 487.3 488.4 488.6 10599.5 10748.7 10778.5 10804.4 10820.9 34063.1 34847.1 34851.7 34957.3 35380.0 45779.3 46061.5 46301.0 46365.5 46613.3 5859.0 6082.1 6157.6 6174.4 6185.3 11337.3 11622.4 11671.2 11722.5 11776.6 9737.3 9996.6 10107.9 10234.4 10261.6 9741.1 9746.2 9886.9 9914.3 10139.6 8620.6 8846.3 8867.4 10082.7 10332.3 5977.9 6089.0 6105.6 6107.2 6122.9 9764.7 9865.3 10161.4 10176.4 10214.9 05:28:27 INFO - 2015-11-10 05:28:27,514 DEBUG : BROWSER_OUTPUT: 05:28:27 INFO - 2015-11-10 05:28:27,515 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5241.57 Median:3605.75 stddev:2680.60 (74.3%) stddev-sans-first:2671.68 05:28:27 INFO - 2015-11-10 05:28:27,515 DEBUG : BROWSER_OUTPUT: Values: 1292.2 1731.1 1805.4 1816.9 1823.0 7037.8 7170.7 7418.0 7580.6 7583.6 7424.5 7457.8 7485.3 7493.2 7530.7 1926.9 1970.3 2135.6 2156.9 2157.4 2111.7 2165.1 2166.2 2173.6 2176.5 2158.8 2169.8 2175.7 2184.2 2203.9 1923.7 1989.1 2113.7 2174.7 2176.6 2179.9 2183.8 2203.1 2205.6 2223.3 7367.8 7459.6 7479.6 7480.4 7482.0 4590.7 4690.0 4691.4 4708.0 4728.3 2729.6 2821.9 2826.4 2869.8 2896.7 867.6 881.1 894.6 894.7 905.2 9669.2 9682.2 9682.3 9684.8 9762.5 4110.2 4122.0 4182.8 4193.5 4228.3 8523.1 8541.7 8566.9 8579.4 8591.3 4672.3 4687.9 4689.8 4696.0 4703.6 4279.4 4285.1 4286.5 4320.4 4323.0 3594.4 3611.4 3649.0 3656.0 3686.9 1160.4 1170.4 1181.1 1183.6 1188.5 1279.4 1290.5 1310.1 1313.6 1336.8 6730.3 6918.6 6959.9 7276.3 7279.5 635.3 650.1 652.6 654.7 661.1 5628.8 5756.1 5767.8 5776.2 5794.0 8868.6 8978.0 8986.8 9003.4 9065.9 8726.9 8905.7 8942.2 8955.7 9025.2 7019.2 7027.1 7048.8 7117.2 7173.0 6845.3 6869.2 6899.1 6930.8 6937.0 7947.5 7996.8 8003.0 8124.7 8134.8 7660.5 7919.5 8153.9 8179.6 8231.7 6785.7 6860.3 6879.7 6885.4 6973.2 7015.2 7125.8 7147.1 7394.0 7477.9 6639.5 6751.8 6812.6 6817.0 6840.2 6556.8 6632.8 6663.8 6722.3 6780.2 6096.9 6315.3 6871.3 6871.7 6885.6 6087.5 6259.8 6286.1 6298.4 6325.4 6262.9 6291.7 6315.2 6327.6 6407.9 05:28:27 INFO - 2015-11-10 05:28:27,515 DEBUG : BROWSER_OUTPUT: 05:28:27 INFO - 2015-11-10 05:28:27,517 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5325.89 Median:6031.74 stddev:1634.43 (27.1%) stddev-sans-first:1595.16 05:28:27 INFO - 2015-11-10 05:28:27,517 DEBUG : BROWSER_OUTPUT: Values: 315.1 322.8 323.7 328.4 330.3 6024.6 6045.0 6071.8 6131.4 6158.3 5933.3 6008.9 6053.4 6061.1 6100.9 4484.3 4545.5 4644.2 4665.1 4715.0 4598.9 4641.6 4671.1 4680.0 4689.7 4581.1 4606.7 4622.3 4637.8 4637.9 4590.9 4601.1 4605.3 4622.1 4624.2 3838.5 3994.2 4011.6 4019.2 4084.0 5870.4 5883.2 5922.8 5980.0 5980.5 5145.6 5177.2 5187.4 5213.5 5222.1 6090.8 6167.1 6238.1 6301.1 6407.1 4214.3 4249.4 4262.4 4266.9 4322.0 6495.1 6580.1 6592.8 6618.4 6657.0 4221.8 4329.0 4339.9 4341.5 4359.2 4426.1 4426.1 4432.4 4442.2 4449.0 5105.7 5111.8 5118.0 5151.7 5184.0 6095.4 6326.0 6350.1 6364.4 6376.6 1521.6 1558.0 1569.2 1570.7 1578.9 1000.4 1015.0 1015.1 1025.9 1029.2 5923.9 5950.3 5964.0 5964.8 5981.4 6511.8 6530.2 6573.2 6574.2 6575.8 5982.7 6012.5 6029.5 6034.0 6035.7 3531.9 3671.0 3672.6 3713.0 3719.9 6799.5 6801.4 6839.7 6859.5 6890.4 6787.7 6792.6 6871.0 6901.3 6907.6 6589.7 6694.8 6830.4 6832.0 6891.2 6576.2 6622.7 6635.9 6707.5 6727.7 6440.8 6487.4 6551.1 6582.5 6588.2 6632.5 6754.3 6775.6 6790.7 6883.7 4314.0 4355.6 4361.7 4367.0 4379.4 6672.5 6705.6 6707.6 6765.3 6765.9 6319.1 6344.6 6504.7 6545.1 6576.0 6480.3 6507.3 6527.1 6530.0 6566.8 6286.2 6331.3 6380.7 6407.6 6454.3 6351.9 6493.3 6494.4 6496.5 6604.2 6143.3 6335.4 6350.4 6363.1 6372.7 05:28:27 INFO - 2015-11-10 05:28:27,517 DEBUG : BROWSER_OUTPUT: 05:28:27 INFO - 2015-11-10 05:28:27,517 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13528.94 Median:47103.15 stddev:15880.92 (33.7%) stddev-sans-first:15896.04 05:28:27 INFO - 2015-11-10 05:28:27,519 DEBUG : BROWSER_OUTPUT: Values: 653.7 661.2 694.3 771.0 776.4 13533.2 13572.1 13792.4 13831.2 13908.6 12806.1 12875.4 12895.4 12924.4 12931.6 649.9 685.7 890.2 914.6 918.5 881.3 888.6 897.4 897.8 900.5 911.4 926.0 929.1 937.2 945.4 673.4 714.9 873.6 900.4 927.1 660.4 664.1 665.8 671.1 674.7 13398.7 13490.7 13491.0 13538.3 13567.9 11469.8 11736.6 11811.2 11945.0 11995.6 9079.0 9152.2 9169.7 9261.8 9687.1 3277.4 3308.3 3311.6 3321.3 3375.2 46498.0 46538.5 46706.3 46722.5 46887.0 9002.7 9150.1 9183.9 9186.4 9703.9 19368.0 19482.0 19844.0 19854.0 19887.1 6798.9 6849.1 6864.8 6894.9 6934.7 3806.1 3813.5 3831.9 3863.4 3883.7 3024.6 3038.1 3057.6 3062.0 3074.5 452.4 458.4 463.9 466.2 467.3 524.5 552.2 567.3 583.7 584.6 7740.7 8012.0 8033.4 8180.2 8288.1 476.7 563.0 566.1 592.4 606.2 3904.9 3917.1 3932.7 3935.8 4125.6 56232.7 56352.4 56363.7 56364.7 56588.7 49661.8 50396.7 50823.5 50828.7 51031.2 46848.0 47319.3 47376.0 48831.8 48870.5 8253.5 8271.2 8370.6 8501.0 8613.8 34295.0 34299.3 34640.3 35529.8 35578.8 42913.6 42928.1 43527.8 46149.5 46340.5 10480.3 10744.6 10775.9 11000.2 11051.4 11133.9 11250.7 11653.1 11992.8 12172.3 10264.6 10450.0 10725.8 10758.6 11268.3 10349.3 10360.5 10705.6 10771.7 10921.4 10336.7 10562.5 10752.6 10827.6 11355.3 8717.1 8728.7 9317.1 9361.3 9652.1 8102.7 8257.3 8591.4 8878.3 9412.7 05:28:27 INFO - 2015-11-10 05:28:27,519 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:28:27 INFO - 2015-11-10 05:28:27,519 DEBUG : BROWSER_OUTPUT: 05:28:28 INFO - 2015-11-10 05:28:28,187 INFO : Browser exited with error code: 0 05:28:28 INFO - 2015-11-10 05:28:28,214 INFO : Completed test dromaeo_css (00:18:35) 05:28:28 INFO - 2015-11-10 05:28:28,214 INFO : Starting test kraken 05:28:28 INFO - 2015-11-10 05:28:28,214 DEBUG : operating with platform_type : mac_ 05:28:28 INFO - 2015-11-10 05:28:28,214 INFO : Initialising browser for kraken test... 05:28:28 INFO - 2015-11-10 05:28:28,227 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmpTT8pcG/profile http://localhost:49278/getInfo.html 05:28:30 INFO - 2015-11-10 05:28:30,572 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:28:30 INFO - 2015-11-10 05:28:30,572 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:28:30 INFO - 2015-11-10 05:28:30,572 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:28:30 INFO - 2015-11-10 05:28:30,572 DEBUG : BROWSER_OUTPUT: __metrics 05:28:30 INFO - 2015-11-10 05:28:30,588 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:28:31 INFO - 2015-11-10 05:28:31,240 INFO : Browser initialized. 05:28:31 INFO - 2015-11-10 05:28:31,240 INFO : Running cycle 1/1 for kraken test... 05:28:31 INFO - 2015-11-10 05:28:31,240 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmpTT8pcG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:28:43 INFO - 2015-11-10 05:28:43,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 228102144 05:28:43 INFO - 2015-11-10 05:28:43,241 DEBUG : BROWSER_OUTPUT: 05:28:45 INFO - 2015-11-10 05:28:45,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:46 INFO - 2015-11-10 05:28:46,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 285487104 05:28:46 INFO - 2015-11-10 05:28:46,388 DEBUG : BROWSER_OUTPUT: 05:28:49 INFO - 2015-11-10 05:28:49,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 05:28:49 INFO - 2015-11-10 05:28:49,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 298442752 05:28:49 INFO - 2015-11-10 05:28:49,600 DEBUG : BROWSER_OUTPUT: 05:28:52 INFO - 2015-11-10 05:28:52,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 05:28:53 INFO - 2015-11-10 05:28:53,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 280973312 05:28:53 INFO - 2015-11-10 05:28:53,147 DEBUG : BROWSER_OUTPUT: 05:28:55 INFO - 2015-11-10 05:28:55,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 05:28:55 INFO - 2015-11-10 05:28:55,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 283500544 05:28:55 INFO - 2015-11-10 05:28:55,768 DEBUG : BROWSER_OUTPUT: 05:28:57 INFO - 2015-11-10 05:28:57,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:58 INFO - 2015-11-10 05:28:58,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 284528640 05:28:58 INFO - 2015-11-10 05:28:58,516 DEBUG : BROWSER_OUTPUT: 05:29:01 INFO - 2015-11-10 05:29:01,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:02 INFO - 2015-11-10 05:29:02,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 285175808 05:29:02 INFO - 2015-11-10 05:29:02,127 DEBUG : BROWSER_OUTPUT: 05:29:05 INFO - 2015-11-10 05:29:05,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:05 INFO - 2015-11-10 05:29:05,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 286265344 05:29:05 INFO - 2015-11-10 05:29:05,886 DEBUG : BROWSER_OUTPUT: 05:29:08 INFO - 2015-11-10 05:29:08,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 05:29:09 INFO - 2015-11-10 05:29:09,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 285818880 05:29:09 INFO - 2015-11-10 05:29:09,342 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-10 05:29:10,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:11 INFO - 2015-11-10 05:29:11,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 319889408 05:29:11 INFO - 2015-11-10 05:29:11,477 DEBUG : BROWSER_OUTPUT: 05:29:13 INFO - 2015-11-10 05:29:13,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:13 INFO - 2015-11-10 05:29:13,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 320069632 05:29:13 INFO - 2015-11-10 05:29:13,915 DEBUG : BROWSER_OUTPUT: 05:29:16 INFO - 2015-11-10 05:29:16,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:16 INFO - 2015-11-10 05:29:16,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 327032832 05:29:16 INFO - 2015-11-10 05:29:16,591 DEBUG : BROWSER_OUTPUT: 05:29:19 INFO - 2015-11-10 05:29:19,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:19 INFO - 2015-11-10 05:29:19,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 329396224 05:29:19 INFO - 2015-11-10 05:29:19,740 DEBUG : BROWSER_OUTPUT: 05:29:22 INFO - 2015-11-10 05:29:22,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:22 INFO - 2015-11-10 05:29:22,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 327602176 05:29:22 INFO - 2015-11-10 05:29:22,969 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 05:29:24 INFO - 2015-11-10 05:29:24,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 386146304 05:29:24 INFO - 2015-11-10 05:29:24,965 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,965 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:24 INFO - 2015-11-10 05:29:24,965 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:24 INFO - 2015-11-10 05:29:24,965 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:24 INFO - 2015-11-10 05:29:24,966 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:24 INFO - 2015-11-10 05:29:24,966 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;106;102;108;108;106;97;107;97;107 05:29:24 INFO - 2015-11-10 05:29:24,966 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;128;148;164;127;150;148;125;159;126 05:29:24 INFO - 2015-11-10 05:29:24,966 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;162;162;162;163;163;160;161 05:29:24 INFO - 2015-11-10 05:29:24,966 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;78;89;84;67;70;71;76;82;66 05:29:24 INFO - 2015-11-10 05:29:24,966 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;100;134;88;88;90;121;87;87;124 05:29:24 INFO - 2015-11-10 05:29:24,966 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;116;114;114;120;114;120;120;114;114 05:29:24 INFO - 2015-11-10 05:29:24,966 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;124;126;125;124;125;125;124;125;125;125 05:29:24 INFO - 2015-11-10 05:29:24,967 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;99;101;101;99;101;101;101;100;101;99 05:29:24 INFO - 2015-11-10 05:29:24,967 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;57;56;56;57;57;66;56;56 05:29:24 INFO - 2015-11-10 05:29:24,967 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;65;68;68;67;67;67;67;67 05:29:24 INFO - 2015-11-10 05:29:24,967 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;84;85;84;85;85;85;85;86 05:29:24 INFO - 2015-11-10 05:29:24,967 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;131;121;120;125;131;122;125;131;132 05:29:24 INFO - 2015-11-10 05:29:24,967 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;158;157;155;156;150;145;155;158;147 05:29:24 INFO - 2015-11-10 05:29:24,967 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;73;73;73;73;72;72;74;72 05:29:24 INFO - 2015-11-10 05:29:24,968 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:24 INFO - 2015-11-10 05:29:24,968 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:29:24 INFO - 2015-11-10 05:29:24,968 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,915 05:29:24 INFO - 2015-11-10 05:29:24,968 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:29:24 INFO - 2015-11-10 05:29:24,968 DEBUG : BROWSER_OUTPUT: __startTimestamp1447162164964__endTimestamp 05:29:24 INFO - 2015-11-10 05:29:24,969 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,969 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:24 INFO - 2015-11-10 05:29:24,969 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:29:24 INFO - 2015-11-10 05:29:24,969 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,970 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:104.30 Median:107.50 stddev:4.22 (3.9%) stddev-sans-first:4.47 05:29:24 INFO - 2015-11-10 05:29:24,970 DEBUG : BROWSER_OUTPUT: Values: 105.0 106.0 102.0 108.0 108.0 106.0 97.0 107.0 97.0 107.0 05:29:24 INFO - 2015-11-10 05:29:24,970 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,971 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.10 Median:149.00 stddev:15.13 (10.2%) stddev-sans-first:15.31 05:29:24 INFO - 2015-11-10 05:29:24,971 DEBUG : BROWSER_OUTPUT: Values: 156.0 128.0 148.0 164.0 127.0 150.0 148.0 125.0 159.0 126.0 05:29:24 INFO - 2015-11-10 05:29:24,971 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,971 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 05:29:24 INFO - 2015-11-10 05:29:24,972 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 162.0 162.0 162.0 163.0 163.0 160.0 161.0 05:29:24 INFO - 2015-11-10 05:29:24,972 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,972 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.00 Median:77.50 stddev:7.57 (9.8%) stddev-sans-first:8.02 05:29:24 INFO - 2015-11-10 05:29:24,972 DEBUG : BROWSER_OUTPUT: Values: 77.0 78.0 89.0 84.0 67.0 70.0 71.0 76.0 82.0 66.0 05:29:24 INFO - 2015-11-10 05:29:24,972 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,972 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.80 Median:87.50 stddev:17.85 (20.4%) stddev-sans-first:18.90 05:29:24 INFO - 2015-11-10 05:29:24,972 DEBUG : BROWSER_OUTPUT: Values: 99.0 100.0 134.0 88.0 88.0 90.0 121.0 87.0 87.0 124.0 05:29:24 INFO - 2015-11-10 05:29:24,973 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,973 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:118.00 stddev:2.99 (2.5%) stddev-sans-first:2.91 05:29:24 INFO - 2015-11-10 05:29:24,973 DEBUG : BROWSER_OUTPUT: Values: 120.0 116.0 114.0 114.0 120.0 114.0 120.0 120.0 114.0 114.0 05:29:24 INFO - 2015-11-10 05:29:24,973 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,973 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.80 Median:125.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 05:29:24 INFO - 2015-11-10 05:29:24,973 DEBUG : BROWSER_OUTPUT: Values: 124.0 126.0 125.0 124.0 125.0 125.0 124.0 125.0 125.0 125.0 05:29:24 INFO - 2015-11-10 05:29:24,974 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,974 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.30 Median:101.00 stddev:0.95 (0.9%) stddev-sans-first:0.88 05:29:24 INFO - 2015-11-10 05:29:24,974 DEBUG : BROWSER_OUTPUT: Values: 99.0 101.0 101.0 99.0 101.0 101.0 101.0 100.0 101.0 99.0 05:29:24 INFO - 2015-11-10 05:29:24,974 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,974 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.00 stddev:3.03 (5.3%) stddev-sans-first:3.21 05:29:24 INFO - 2015-11-10 05:29:24,974 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 57.0 56.0 56.0 57.0 57.0 66.0 56.0 56.0 05:29:24 INFO - 2015-11-10 05:29:24,975 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,975 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 05:29:24 INFO - 2015-11-10 05:29:24,975 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 65.0 68.0 68.0 67.0 67.0 67.0 67.0 67.0 05:29:24 INFO - 2015-11-10 05:29:24,975 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,976 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 05:29:24 INFO - 2015-11-10 05:29:24,976 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 84.0 85.0 84.0 85.0 85.0 85.0 85.0 86.0 05:29:24 INFO - 2015-11-10 05:29:24,977 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,977 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:128.00 stddev:4.70 (3.7%) stddev-sans-first:4.85 05:29:24 INFO - 2015-11-10 05:29:24,977 DEBUG : BROWSER_OUTPUT: Values: 123.0 131.0 121.0 120.0 125.0 131.0 122.0 125.0 131.0 132.0 05:29:24 INFO - 2015-11-10 05:29:24,977 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,977 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.40 Median:155.50 stddev:5.66 (3.6%) stddev-sans-first:4.88 05:29:24 INFO - 2015-11-10 05:29:24,977 DEBUG : BROWSER_OUTPUT: Values: 143.0 158.0 157.0 155.0 156.0 150.0 145.0 155.0 158.0 147.0 05:29:24 INFO - 2015-11-10 05:29:24,977 DEBUG : BROWSER_OUTPUT: 05:29:24 INFO - 2015-11-10 05:29:24,977 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 05:29:24 INFO - 2015-11-10 05:29:24,978 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 73.0 73.0 73.0 72.0 72.0 74.0 72.0 05:29:24 INFO - 2015-11-10 05:29:24,978 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:24 INFO - 2015-11-10 05:29:24,978 DEBUG : BROWSER_OUTPUT: 05:29:25 INFO - 2015-11-10 05:29:25,616 INFO : Browser exited with error code: 0 05:29:25 INFO - 2015-11-10 05:29:25,665 INFO : Completed test kraken (00:00:57) 05:29:25 INFO - 2015-11-10 05:29:25,665 INFO : Starting test v8_7 05:29:25 INFO - 2015-11-10 05:29:25,665 DEBUG : operating with platform_type : mac_ 05:29:25 INFO - 2015-11-10 05:29:25,665 INFO : Initialising browser for v8_7 test... 05:29:25 INFO - 2015-11-10 05:29:25,678 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmporXH33/profile http://localhost:49278/getInfo.html 05:29:27 INFO - 2015-11-10 05:29:27,949 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:29:27 INFO - 2015-11-10 05:29:27,949 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:29:27 INFO - 2015-11-10 05:29:27,950 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:29:27 INFO - 2015-11-10 05:29:27,950 DEBUG : BROWSER_OUTPUT: __metrics 05:29:27 INFO - 2015-11-10 05:29:27,966 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:29:28 INFO - 2015-11-10 05:29:28,619 INFO : Browser initialized. 05:29:28 INFO - 2015-11-10 05:29:28,619 INFO : Running cycle 1/1 for v8_7 test... 05:29:28 INFO - 2015-11-10 05:29:28,619 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/T/tmporXH33/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:29:40 INFO - 2015-11-10 05:29:40,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 227676160 05:29:40 INFO - 2015-11-10 05:29:40,608 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49278/tests/v8_7/run.html (next: http://localhost:49278/tests/v8_7/run.html) 05:30:02 INFO - 2015-11-10 05:30:02,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 693997568 05:30:02 INFO - 2015-11-10 05:30:02,295 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,295 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:30:02 INFO - 2015-11-10 05:30:02,295 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:30:02 INFO - 2015-11-10 05:30:02,295 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:30:02 INFO - 2015-11-10 05:30:02,296 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:30:02 INFO - 2015-11-10 05:30:02,296 DEBUG : BROWSER_OUTPUT: |0;Richards;166.41704110500916 05:30:02 INFO - 2015-11-10 05:30:02,296 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.5850962454736 05:30:02 INFO - 2015-11-10 05:30:02,296 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.4149040026033 05:30:02 INFO - 2015-11-10 05:30:02,296 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5758.620689655172 05:30:02 INFO - 2015-11-10 05:30:02,296 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1892.249527410208 05:30:02 INFO - 2015-11-10 05:30:02,296 DEBUG : BROWSER_OUTPUT: |5;Earley;919.1176470588235 05:30:02 INFO - 2015-11-10 05:30:02,297 DEBUG : BROWSER_OUTPUT: |6;Boyer;12550 05:30:02 INFO - 2015-11-10 05:30:02,297 DEBUG : BROWSER_OUTPUT: |7;RegExp;29057.14285714286 05:30:02 INFO - 2015-11-10 05:30:02,297 DEBUG : BROWSER_OUTPUT: |8;Splay;643.3161953727506 05:30:02 INFO - 2015-11-10 05:30:02,297 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5797.687861271676 05:30:02 INFO - 2015-11-10 05:30:02,297 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:30:02 INFO - 2015-11-10 05:30:02,298 DEBUG : BROWSER_OUTPUT: __startTimestamp1447162202293__endTimestamp 05:30:02 INFO - 2015-11-10 05:30:02,298 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,298 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:30:02 INFO - 2015-11-10 05:30:02,298 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:30:02 INFO - 2015-11-10 05:30:02,298 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,299 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 05:30:02 INFO - 2015-11-10 05:30:02,299 DEBUG : BROWSER_OUTPUT: Values: 166.4 05:30:02 INFO - 2015-11-10 05:30:02,299 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,299 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.59 Median:190.59 stddev:0.00 (0.0%) 05:30:02 INFO - 2015-11-10 05:30:02,299 DEBUG : BROWSER_OUTPUT: Values: 190.6 05:30:02 INFO - 2015-11-10 05:30:02,299 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,299 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.41 Median:325.41 stddev:0.00 (0.0%) 05:30:02 INFO - 2015-11-10 05:30:02,300 DEBUG : BROWSER_OUTPUT: Values: 325.4 05:30:02 INFO - 2015-11-10 05:30:02,300 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,300 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5758.62 Median:5758.62 stddev:0.00 (0.0%) 05:30:02 INFO - 2015-11-10 05:30:02,300 DEBUG : BROWSER_OUTPUT: Values: 5758.6 05:30:02 INFO - 2015-11-10 05:30:02,300 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,300 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1892.25 Median:1892.25 stddev:0.00 (0.0%) 05:30:02 INFO - 2015-11-10 05:30:02,301 DEBUG : BROWSER_OUTPUT: Values: 1892.2 05:30:02 INFO - 2015-11-10 05:30:02,301 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,301 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:919.12 Median:919.12 stddev:0.00 (0.0%) 05:30:02 INFO - 2015-11-10 05:30:02,301 DEBUG : BROWSER_OUTPUT: Values: 919.1 05:30:02 INFO - 2015-11-10 05:30:02,301 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,302 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12550.00 Median:12550.00 stddev:0.00 (0.0%) 05:30:02 INFO - 2015-11-10 05:30:02,302 DEBUG : BROWSER_OUTPUT: Values: 12550.0 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29057.14 Median:29057.14 stddev:0.00 (0.0%) 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: Values: 29057.1 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:643.32 Median:643.32 stddev:0.00 (0.0%) 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: Values: 643.3 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: Values: 5797.7 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:30:02 INFO - 2015-11-10 05:30:02,303 DEBUG : BROWSER_OUTPUT: 05:30:02 INFO - 2015-11-10 05:30:02,973 INFO : Browser exited with error code: 0 05:30:02 INFO - 2015-11-10 05:30:02,993 INFO : Completed test v8_7 (00:00:37) 05:30:03 INFO - 2015-11-10 05:30:03,469 INFO : Completed test suite (00:20:11) 05:30:03 INFO - 2015-11-10 05:30:03,469 DEBUG : Working with test: dromaeo_css 05:30:03 INFO - 2015-11-10 05:30:03,470 DEBUG : Generating results file: dromaeo_css 05:30:03 INFO - 2015-11-10 05:30:03,470 DEBUG : Working with test: kraken 05:30:03 INFO - 2015-11-10 05:30:03,470 DEBUG : Generating results file: kraken 05:30:03 INFO - 2015-11-10 05:30:03,470 INFO : javascript benchmark 05:30:03 INFO - 2015-11-10 05:30:03,471 DEBUG : Working with test: v8_7 05:30:03 INFO - 2015-11-10 05:30:03,471 DEBUG : Generating results file: v8_7 05:30:03 INFO - 2015-11-10 05:30:03,471 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:30:06 INFO - 2015-11-10 05:30:06,091 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 05:30:06 INFO - 2015-11-10 05:30:06,091 DEBUG : process_Request line: dromaeo_css 6701.58 graph.html#tests=[[72,1,55]] 05:30:06 INFO - 2015-11-10 05:30:06,091 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:30:07 INFO - 2015-11-10 05:30:07,368 DEBUG : process_Request line: kraken 1489.10 graph.html#tests=[[232,1,55]] 05:30:07 INFO - 2015-11-10 05:30:07,369 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:30:07 INFO - 2015-11-10 05:30:07,396 DEBUG : process_Request line: v8_7 18396.99 graph.html#tests=[[230,1,55]] 05:30:07 INFO - 2015-11-10 05:30:07,396 INFO : javascript benchmark 05:30:07 INFO - 2015-11-10 05:30:07,398 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [330.4695962979416, 331.6782720760863, 337.745002523095, 338.387583166213, 342.25730165540784, 14447.349869255882, 14892.180930048842, 16825.579360515978, 16836.57908552287, 17581.560460988483, 14191.645208869784, 15303.770443443358, 17078.829211707878, 17103.0, 17472.21375038123, 5136.1782114861535, 5271.499207575274, 5285.867853303679, 5308.283381743473, 5355.410904800468, 3876.980615096935, 4023.436718859362, 4590.242609969351, 5286.259923610698, 5358.115910874701, 5668.121441176624, 5767.192593036978, 5796.101604251347, 5803.82588522345, 5902.498287645555, 5737.25415695959, 5891.764329426796, 5894.410558944114, 5957.821265362024, 5964.910526342108, 5047.697138171721, 5055.823046193365, 5060.7722652480725, 5142.640015198937, 5150.995555866608, 21069.473263168544, 21195.68206476904, 21716.13135474579, 21717.239896603543, 21887.0, 1992.4919145617775, 2034.8575599708026, 2072.699458578498, 2132.680097985299, 2213.225371120095, 12924.159929604546, 13143.408546615425, 13508.0, 13651.453941842314, 13739.038267321292, 1451.7749748788954, 1506.5254444849836, 1661.900285982845, 1669.5742585640585, 1692.8307169283096, 56865.71567142138, 57104.0, 57174.142387864216, 57285.71357143271, 57460.71269643667, 9260.536973151315, 9427.811443771086, 9462.810743785223, 9494.192993595483, 9670.371425857438, 11542.19204655683, 11580.652580422433, 11591.84081591851, 11628.244164129304, 11698.649040528799, 7848.9215107848195, 7867.252611001945, 7912.248336408032, 7942.920570794218, 7989.44073914832, 8010.479318844256, 8019.03771547418, 8042.879356809653, 8079.596020199084, 8191.549464779375, 5572.0527510323345, 5596.356419011784, 5637.577181711388, 5652.8869422611315, 5676.7161641918565, 1522.6041229280245, 1605.494269305165, 1605.614652483419, 1641.458318754832, 1679.5885008172831, 370.5349786018583, 379.99430008549894, 392.9155231625214, 397.75935558986396, 944.617429940875, 10358.223133264884, 10557.9472102639, 10563.47182640865, 10618.097461715686, 10648.574057037787, 395.9980200098981, 401.15756910487744, 406.0457923878861, 426.82286850956507, 437.71966996535645, 5309.41596424393, 5556.555475561945, 5633.211350410946, 5672.09246520563, 5699.031164702011, 513135.0, 527240.0, 528469.0, 529194.0, 543427.0, 66669.33330666632, 68605.0, 70057.0, 70249.0, 70354.0, 477.40562999066384, 484.02710551791154, 487.2934245344265, 488.4187816498427, 488.5554145727371, 10599.47002649849, 10748.731281718019, 10778.461076945965, 10804.351738895692, 10820.945895270474, 34063.14842128967, 34847.12882177864, 34851.65148348585, 34957.30085398329, 35380.0, 45779.31331029971, 46061.539384607066, 46301.0, 46365.53634463747, 46613.30080048734, 5859.0, 6082.057281121433, 6157.568970172045, 6174.44430001302, 6185.319614842454, 11337.319760814378, 11622.418879056182, 11671.241369310968, 11722.531098756295, 11776.646700598996, 9737.269704772028, 9996.600135994478, 10107.89892101099, 10234.437105959243, 10261.640842570474, 9741.123298903132, 9746.220302375934, 9886.901130988597, 9914.30599858003, 10139.64511242103, 8620.568971551273, 8846.292296616384, 8867.379283450096, 10082.69751907444, 10332.328398654063, 5977.880442391215, 6088.969555152196, 6105.572609917263, 6107.236595425572, 6122.877542449037, 9764.707058788248, 9865.26010549226, 10161.441120738134, 10176.389416635026, 10214.948925255327], "dojo.html": [3180.920476988075, 3234.450143475609, 3255.348930213958, 3259.445894197986, 3290.3090351026285, 5289.814856480024, 5384.3538775347015, 5437.32033495813, 5479.726013699319, 5493.2034854946005, 5376.462353764621, 5458.0, 5458.61789674723, 5499.477549632798, 5534.280543529346, 4939.555440010398, 4964.280179373988, 5001.14980453322, 5022.271770593262, 5046.192609182532, 5021.447640759514, 5055.064813009605, 5055.140626093555, 5076.771545280471, 5174.146265866147, 4774.832880849189, 4873.610111191097, 4889.095517329305, 4910.803567857281, 4972.328735620681, 4840.346553215306, 4887.315775791392, 4924.359833221658, 4948.430930443009, 4950.4307004694565, 4885.43817460993, 4922.433920099199, 4936.0, 4952.430470495867, 5049.368828896388, 5100.464451232641, 5291.28567643367, 5319.494648008433, 5323.041852466555, 5329.040772660919, 5659.377468478464, 5668.603197776158, 5690.118031705092, 5766.855828604276, 5804.854878628068, 5736.311642602915, 5814.389489103625, 5827.999999999957, 5833.504152147073, 5848.0, 5267.762950667229, 5424.457554244584, 5465.262189604432, 5476.424975377608, 5578.219049333096, 5705.686187259741, 5725.942740572625, 5850.707464626752, 5856.180134781134, 5875.764969401262, 5680.829575112753, 5682.772689092472, 5694.743736531866, 5704.11586204139, 5781.566382521328, 5616.887662246732, 5835.79574714883, 5866.618669786536, 5872.119182122716, 5913.49735272498, 5596.860078497989, 5601.60788744784, 5602.523785478198, 5641.971790141023, 5703.714814259353, 5668.319801623831, 5715.228444160069, 5725.484706376446, 5729.1119876419225, 5739.799107031234, 4327.242732521796, 4453.821847126079, 4454.443194600675, 4521.751303678264, 4544.500104988449, 3975.6620687241907, 3987.840486380512, 4027.1140349123148, 4068.044009657728, 4092.2429350569646, 5288.36539615241, 5364.356277246678, 5370.892582148335, 5375.139977603643, 5437.945620543823, 5598.524125449382, 5817.970910145422, 5819.912701309484, 5833.300003999547, 5834.416558344216, 5298.894022119536, 5312.92030619541, 5319.441458646864, 5322.654027488278, 5381.569474442035, 5053.494650534991, 5076.568491678248, 5085.542301192911, 5094.974525127351, 5099.3370861787735, 5716.199732037601, 5896.557758168155, 5915.08316210988, 5935.139404786368, 5941.465268125889, 5697.943020569907, 5740.0, 5787.189793428839, 5867.6772777497645, 5909.054551271776, 5928.584999050025, 5934.495567876779, 5945.851353716192, 5947.434993675594, 6007.609505382136, 5577.581681373832, 5726.0838265877255, 5738.598298119092, 5743.569232307677, 5780.566457515619, 5628.296462942132, 5656.830295091154, 5682.176084467812, 5769.769209231584, 5796.82609521715, 5545.833624991256, 5645.096784514622, 5657.0, 5665.688387138582, 5667.773289068556, 5518.144687573433, 5650.23721797552, 5651.378348381592, 5663.575231857545, 5671.943280567141, 5453.890922181614, 5494.450554944474, 5508.641938274, 5520.613557051129, 5571.554275657856, 5616.410276920865, 5637.943620563742, 5657.915131272952, 5665.093585026376, 5703.0, 5321.148616221541, 5557.944420555743, 5561.4716601922755, 5569.248151499496, 5589.161625756169], "mootools.html": [1292.1988367212318, 1731.0911771320057, 1805.4222648752395, 1816.936407225747, 1823.0337920901918, 7037.788866334012, 7170.749023784162, 7417.962910185448, 7580.583067931261, 7583.582902940336, 7424.517406368583, 7457.776266712007, 7485.288897554724, 7493.213212612679, 7530.736424225153, 1926.9132889019957, 1970.290695349673, 2135.604913091079, 2156.9352919412363, 2157.4174972757346, 2111.6938043983614, 2165.069020321261, 2166.19850655257, 2173.641349177392, 2176.5320456101936, 2158.84888057836, 2169.8047175754177, 2175.673648952662, 2184.191849015858, 2203.8787866667326, 1923.7018262169386, 1989.094961792381, 2113.651247544153, 2174.71728675272, 2176.5755677642865, 2179.858309209896, 2183.814375778061, 2203.1407750977132, 2205.5699138667965, 2223.3330000999636, 7367.778966630956, 7459.589722565257, 7479.626018699043, 7480.438967077436, 7481.962590187069, 4590.74750888701, 4689.953100468986, 4691.390119284505, 4707.964247865464, 4728.290756386536, 2729.5769155780886, 2821.9294517637018, 2826.42058378032, 2869.813462124955, 2896.681365049843, 867.5575456517222, 881.0748713850495, 894.6197865906963, 894.6868595991416, 905.1582028713294, 9669.17811985982, 9682.225421966295, 9682.322237443383, 9684.75788105296, 9762.463064531448, 4110.219058378899, 4122.0, 4182.832686692559, 4193.5387107418155, 4228.260054490452, 8523.147685231428, 8541.701040463555, 8566.871496927552, 8579.442336248125, 8591.312694984512, 4672.322513235562, 4687.929681054787, 4689.7655117244685, 4695.976520117378, 4703.623710103184, 4279.358096285519, 4285.142971405731, 4286.485621725413, 4320.395144679747, 4322.978385108055, 3594.4428613564937, 3611.422172452395, 3649.0, 3655.9634403656155, 3686.944695829565, 1160.442987366069, 1170.4264910194113, 1181.0610564601163, 1183.6330737471412, 1188.5127097889824, 1279.3922886628964, 1290.5160564788205, 1310.122218113866, 1313.6453157647381, 1336.7927971164486, 6730.293319201512, 6918.5502942308585, 6959.860802783916, 7276.272372762682, 7279.490435669452, 635.2948227467507, 650.1385663995226, 652.5823472977298, 654.7282877605835, 661.1339145719028, 5628.802991895346, 5756.136579513023, 5767.769289228468, 5776.220210271644, 5794.0439827428, 8868.64525418976, 8978.0, 8986.820263594691, 9003.414778039407, 9065.864012039825, 8726.91273087261, 8905.73282801517, 8942.195202431682, 8955.731328060168, 9025.187733104052, 7019.227884932653, 7027.086478757728, 7048.753293634801, 7117.217106118323, 7173.0, 6845.315468453115, 6869.175698915962, 6899.103116594811, 6930.826729331606, 6937.0, 7947.5231486111015, 7996.800079997814, 8003.0, 8124.715634952749, 8134.796630084058, 7660.5403675779635, 7919.524828510077, 8153.858459815512, 8179.550124743197, 8231.670733170846, 6785.6946437411425, 6860.279670634711, 6879.690413931285, 6885.380315771605, 6973.19808222061, 7015.193252775996, 7125.786226413215, 7147.070880785464, 7394.0, 7477.92522074794, 6639.535232533676, 6751.763688270887, 6812.591244525344, 6817.0456136141975, 6840.179178498612, 6556.770513032021, 6632.83417914556, 6663.766768163091, 6722.260551339251, 6780.1524809398825, 6096.878062438637, 6315.336889626523, 6871.312868713088, 6871.656417179221, 6885.586864788129, 6087.482563982111, 6259.78090766821, 6286.119943207863, 6298.401651843067, 6325.399087086719, 6262.906056409249, 6291.748330066746, 6315.210598675166, 6327.588706734047, 6407.935920640734], "ext.html": [548.8819903720699, 555.0702573189907, 570.5093619487241, 574.1817909478997, 577.0997244298893, 31389.0, 31939.520907186383, 38483.23033539331, 39159.0, 39200.21599568014, 40769.59230407702, 41201.793991030005, 41282.380764288486, 41760.791196044054, 41887.0, 8174.959125204366, 8796.42823216492, 8915.643374265022, 8981.416207946495, 8997.550122493882, 8314.916850831505, 11117.777644447106, 11145.888541114566, 11162.832557511643, 11200.103991680688, 10875.891241087607, 10986.340819550813, 11026.503807328649, 11051.72370690731, 11068.00387965083, 8424.326053915673, 8599.398042137052, 10963.397013164273, 11044.889551104507, 11260.887391126065, 10871.347719136877, 10980.890191098066, 10983.780324393467, 11050.557977680963, 11104.833427498514, 39404.0, 39810.0, 39906.800465997774, 40221.59778402208, 40344.19311613751, 3057.877684892602, 3164.841757912095, 3295.242094318296, 3352.463605823081, 3495.8077305748175, 26557.601635975476, 26680.066197682987, 26808.32979175536, 26957.865210674016, 27827.721722782717, 2321.3732292281156, 2367.4673198530363, 2390.53384590005, 2391.1152873436768, 2499.762522560354, 277740.0, 278628.0, 278642.0, 281440.99999999796, 282583.0, 53863.46136538585, 54481.0, 57396.71301643465, 57656.0, 58077.0, 66965.66517167383, 67703.0, 67802.66098669574, 67820.6608966952, 67859.0, 15828.920855395649, 15957.601059973593, 16337.0, 16383.09892955875, 16465.423710170086, 12328.691782705504, 12404.875951240552, 12415.44130514129, 12567.371631418393, 12583.182093163916, 19118.426447206606, 19123.521911952033, 19162.616747664968, 19215.615687686448, 19265.51836204106, 8062.0, 8395.832083358298, 8414.663413463515, 8422.494650321001, 8450.112738162527, 849.8342823149427, 915.4919019943995, 1010.3382284603449, 1050.2805578178973, 1063.4470075560819, 27382.178534643994, 27459.0, 27470.313242169104, 27821.443571128464, 27975.860120699268, 1015.8780946286493, 1035.917126629883, 1083.1876092930302, 1105.2981356838466, 1136.63059505661, 14472.565823025327, 14506.854931450762, 14621.561353159423, 14656.706865862836, 14681.632959175893, 313157.0, 320782.0, 321167.0, 321530.0, 322844.0, 52481.47518524766, 52647.736761316715, 52673.47326526685, 52692.473075269525, 52728.736356317975, 1361.8910487161004, 1370.4381203706432, 1371.5542448704011, 1375.7523645743863, 1393.996322647692, 26864.792262715888, 27145.45709085847, 27431.314217144733, 27777.583336250376, 27890.163295101178, 46828.7658561705, 46956.76521617507, 47307.526924730315, 47340.0, 47358.52641473679, 269671.0, 277397.0, 277770.0, 372724.0, 375906.0, 31254.0, 31328.843355783076, 31456.370872581963, 31497.432872233858, 31587.526187106752, 40007.39988900227, 40361.780102094664, 40592.594074058885, 40605.1897557261, 40662.1867562653, 33482.66517334893, 33729.49405758965, 34675.0, 34809.0, 34938.47592286067, 33541.0, 34143.82928085344, 34251.31497369989, 34578.48132277968, 34613.30773384468, 34435.311293773484, 34464.0, 34467.310653786284, 34720.652793471745, 34969.475457867644, 28381.716182837907, 29790.851045744632, 30041.248968775955, 30128.246793829454, 30265.848670756506, 22928.31215063551, 23176.0, 23202.535949281257, 23510.764892350857, 23736.0], "prototype.html": [315.0642591503235, 322.8498748082141, 323.6908752141705, 328.36625313145635, 330.2915246795624, 6024.608400453978, 6045.03279475284, 6071.757129714817, 6131.448169664729, 6158.261008678954, 5933.288005439343, 6008.87982240356, 6053.394660533955, 6061.060535616975, 6100.877982440348, 4484.260097083978, 4545.454545454533, 4644.187267228239, 4665.0669866026765, 4714.952850471503, 4598.885027874297, 4641.605463535603, 4671.135839869635, 4679.953200468003, 4689.742064186468, 4581.083783243348, 4606.677532572721, 4622.329762184481, 4637.791299391535, 4637.930431043537, 4590.88522786933, 4601.148787474312, 4605.332226827091, 4622.144903192903, 4624.213883639789, 3838.539375274957, 3994.1811928554575, 4011.618896204856, 4019.155977244782, 4083.9591604083876, 5870.354261031283, 5883.17635531026, 5922.792702255443, 5980.0431930890845, 5980.521558275327, 5145.614078944057, 5177.249298851645, 5187.403448603422, 5213.4525874782985, 5222.060029194743, 6090.817275481699, 6167.136600875881, 6238.095476155932, 6301.086342480315, 6407.135036770023, 4214.304639734441, 4249.405083288311, 4262.42457268271, 4266.893327666802, 4322.005938634132, 6495.123158373606, 6580.111684922522, 6592.76925307612, 6618.437432818217, 6656.966715166442, 4221.78891055446, 4329.047609525899, 4339.913201735948, 4341.45731783527, 4359.215341238544, 4426.0926510066, 4426.136903303889, 4432.357308190359, 4442.178197033559, 4449.021215332622, 5105.744712764347, 5111.846644600668, 5117.974410128, 5151.665141765773, 5183.97408012965, 6095.420935011167, 6326.019466982625, 6350.142730731384, 6364.395382438754, 6376.617402955838, 1521.5815650696147, 1557.9532614021598, 1569.1761825041945, 1570.7408277634063, 1578.8736901048119, 1000.4447531619875, 1015.0052948110745, 1015.1472762879217, 1025.933314334566, 1029.1869423155624, 5923.881522369615, 5950.285965684059, 5963.970180149072, 5964.821055368346, 5981.401859814071, 6511.837204069936, 6530.183727034121, 6573.211214654177, 6574.211094668671, 6575.769848055295, 5982.73077711504, 6012.518998480111, 6029.487493563096, 6034.0, 6035.698215089228, 3531.876384326536, 3671.008827616582, 3672.57765356982, 3712.9814350928073, 3719.9442008369897, 6799.456043516507, 6801.353871382211, 6839.726410943606, 6859.485538584626, 6890.379865812101, 6787.660616969132, 6792.558483698544, 6870.965645171742, 6901.344372284625, 6907.585544867224, 6589.703463344161, 6694.799156025327, 6830.351116643911, 6831.9658401707675, 6891.241963384124, 6576.210854697467, 6622.735090596322, 6635.9004614929845, 6707.5304728668525, 6727.730890764315, 6440.774572889926, 6487.448566871869, 6551.148350714377, 6582.473402127914, 6588.209414870246, 6632.535722499571, 6754.2570317266045, 6775.559588626724, 6790.660466976533, 6883.690233939385, 4314.0077782109665, 4355.607995280313, 4361.716488428242, 4366.995591014148, 4379.386885835922, 6672.466202703869, 6705.597664140168, 6707.564008339442, 6765.323467653392, 6765.932340676531, 6319.083732858801, 6344.619322840645, 6504.6747662615735, 6545.116409284686, 6576.0, 6480.254770701241, 6507.349265073455, 6527.11883895687, 6530.020496925499, 6566.770163044462, 6286.18279623646, 6331.303556608677, 6380.744770209325, 6407.647579383179, 6454.322296158835, 6351.936480635134, 6493.253275873335, 6494.383033611799, 6496.545241833026, 6604.174478190226, 6143.293521244936, 6335.366463353628, 6350.396712312323, 6363.140975968185, 6372.681365931592], "yui.html": [653.7189008726249, 661.1636280105664, 694.319566824512, 771.0362047440699, 776.359503409687, 13533.158036812256, 13572.117812342203, 13792.448302067905, 13831.239281839495, 13908.582742517729, 12806.103572749887, 12875.3562321884, 12895.419706113224, 12924.353782310895, 12931.612051638465, 649.8700259948006, 685.6982927511879, 890.1632465482459, 914.6112902016649, 918.4581097152678, 881.2553392383426, 888.6401007591903, 897.3718397122008, 897.8383890899636, 900.5002223765807, 911.4075850697067, 926.0461724423855, 929.066288380177, 937.2127412973101, 945.3666043750703, 673.4376795375891, 714.9428045756327, 873.6068769053951, 900.4372267332917, 927.1192367251105, 660.3924389561615, 664.139938779282, 665.7636539028672, 671.1074271219267, 674.6626686656672, 13398.665033374145, 13490.662733431645, 13491.0, 13538.255395953218, 13567.932160339134, 11469.827952580717, 11736.647900562997, 11811.173217874752, 11945.044396448264, 11995.64013079609, 9079.0, 9152.222061124812, 9169.679061232891, 9261.768455788591, 9687.128158465772, 3277.3772983133367, 3308.338332333519, 3311.586051743532, 3321.3025264694443, 3375.206826395795, 46498.0, 46538.5346146541, 46706.299405508944, 46722.53277467216, 46887.0, 9002.729918102468, 9150.084991500797, 9183.862242066374, 9186.448813071238, 9703.902960970441, 19368.0, 19482.0, 19844.0, 19854.0, 19887.105080271424, 6798.898016529756, 6849.109615750021, 6864.7940561783225, 6894.896576551356, 6934.7226110955, 3806.08653923062, 3813.5042444482597, 3831.885043448701, 3863.4011728182177, 3883.650471457582, 3024.5916801231992, 3038.103759390985, 3057.602511673468, 3062.0, 3074.492708703039, 452.35313501692895, 458.3926297655553, 463.86547901108975, 466.20279322359147, 467.28272102322774, 524.4991033563015, 552.1855263486326, 567.3050513121476, 583.6614763437196, 584.5557376393971, 7740.729074482366, 8012.0, 8033.3974951878845, 8180.226820789729, 8288.129746376664, 476.6591886800954, 562.9605927585112, 566.1366416215304, 592.431265984651, 606.1634943777559, 3904.863329783444, 3917.138229589543, 3932.7050471214775, 3935.8476806968924, 4125.608067233608, 56232.71883640638, 56352.436475635535, 56363.71818140965, 56364.71817640885, 56588.717056414454, 49661.75169124131, 50396.74801626042, 50823.49176508262, 50828.74585627122, 51031.234531482056, 46848.0, 47319.29021064687, 47376.0, 48831.75584122057, 48870.51129488659, 8253.463524870864, 8271.2142346477, 8370.58147092655, 8500.957495212484, 8613.82772344537, 34295.0, 34299.31401372008, 34640.30719385648, 35529.822350888084, 35578.822105890344, 42913.5708642922, 42928.141437171704, 43527.78236108799, 46149.538504614524, 46340.536594633624, 10480.318779279323, 10744.623938162127, 10775.946120269662, 11000.174986876176, 11051.441210756702, 11133.888661113286, 11250.718732031764, 11653.067754579783, 11992.76014479723, 12172.2696638202, 10264.58941642326, 10450.0, 10725.839112413163, 10758.569657213624, 11268.267562608733, 10349.327293725884, 10360.533775979948, 10705.625303114353, 10771.730706732082, 10921.399323037309, 10336.689899303034, 10562.524686389284, 10752.623658172239, 10827.621033263798, 11355.261907975955, 8717.084706106021, 8728.69449569262, 9317.148708726872, 9361.251099912128, 9652.083052110038, 8102.7164049260355, 8257.256846883809, 8591.398602098043, 8878.289736821169, 9412.717618471457]}, "summary": {"lowerIsBetter": false, "suite": 6701.580453650103, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7399.763567060811, "unit": "ms", "value": 7399.763567060811}, "dojo.html": {"lowerIsBetter": false, "filtered": 5325.572452373987, "unit": "ms", "value": 5325.572452373987}, "mootools.html": {"lowerIsBetter": false, "filtered": 4282.910281351271, "unit": "ms", "value": 4282.910281351271}, "ext.html": {"lowerIsBetter": false, "filtered": 18477.599412248503, "unit": "ms", "value": 18477.599412248503}, "prototype.html": {"lowerIsBetter": false, "filtered": 4784.402908630606, "unit": "ms", "value": 4784.402908630606}, "yui.html": {"lowerIsBetter": false, "filtered": 6070.554794055232, "unit": "ms", "value": 6070.554794055232}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0010"}, "testrun": {"date": 1447160992, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151110030032", "branch": "Firefox", "revision": "cc473fe5dc512c450634506f68cbacfb40a06a23"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0, 163.0, 160.0, 161.0], "ai-astar": [105.0, 106.0, 102.0, 108.0, 108.0, 106.0, 97.0, 107.0, 97.0, 107.0], "imaging-gaussian-blur": [120.0, 116.0, 114.0, 114.0, 120.0, 114.0, 120.0, 120.0, 114.0, 114.0], "audio-beat-detection": [156.0, 128.0, 148.0, 164.0, 127.0, 150.0, 148.0, 125.0, 159.0, 126.0], "json-stringify-tinderbox": [66.0, 66.0, 65.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0], "stanford-crypto-pbkdf2": [143.0, 158.0, 157.0, 155.0, 156.0, 150.0, 145.0, 155.0, 158.0, 147.0], "json-parse-financial": [58.0, 57.0, 57.0, 56.0, 56.0, 57.0, 57.0, 66.0, 56.0, 56.0], "stanford-crypto-sha256-iterative": [72.0, 72.0, 73.0, 73.0, 73.0, 73.0, 72.0, 72.0, 74.0, 72.0], "audio-fft": [77.0, 78.0, 89.0, 84.0, 67.0, 70.0, 71.0, 76.0, 82.0, 66.0], "imaging-darkroom": [124.0, 126.0, 125.0, 124.0, 125.0, 125.0, 124.0, 125.0, 125.0, 125.0], "stanford-crypto-ccm": [123.0, 131.0, 121.0, 120.0, 125.0, 131.0, 122.0, 125.0, 131.0, 132.0], "audio-oscillator": [99.0, 100.0, 134.0, 88.0, 88.0, 90.0, 121.0, 87.0, 87.0, 124.0], "stanford-crypto-aes": [86.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 86.0], "imaging-desaturate": [99.0, 101.0, 101.0, 99.0, 101.0, 101.0, 101.0, 100.0, 101.0, 99.0]}, "summary": {"lowerIsBetter": true, "suite": 1489.1, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 76.0, "unit": "ms", "value": 76.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 152.4, "unit": "ms", "value": 152.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.1, "unit": "ms", "value": 143.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 126.1, "unit": "ms", "value": 126.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 124.8, "unit": "ms", "value": 124.8}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 57.6, "unit": "ms", "value": 57.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 101.8, "unit": "ms", "value": 101.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 104.3, "unit": "ms", "value": 104.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.7, "unit": "ms", "value": 161.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 72.6, "unit": "ms", "value": 72.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 66.8, "unit": "ms", "value": 66.8}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 116.6, "unit": "ms", "value": 116.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.0, "unit": "ms", "value": 85.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 100.3, "unit": "ms", "value": 100.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0010"}, "testrun": {"date": 1447160992, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151110030032", "branch": "Firefox", "revision": "cc473fe5dc512c450634506f68cbacfb40a06a23"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.5850962454736], "Encrypt": [325.4149040026033], "NavierStokes": [5797.687861271676], "Decrypt": [5758.620689655172], "Splay": [643.3161953727506], "Richards": [166.41704110500916], "RegExp": [29057.14285714286], "Earley": [919.1176470588235], "Boyer": [12550.0], "RayTrace": [1892.249527410208]}, "summary": {"lowerIsBetter": false, "suite": 18396.987083517077, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 346.9211459999999, "unit": "score", "value": 346.9211459999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 817.9742130000002, "unit": "score", "value": 817.9742130000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 255.96410767696923, "unit": "score", "value": 255.96410767696923}, "Decrypt": {"lowerIsBetter": false, "filtered": 46.22304790419163, "unit": "score", "value": 46.22304790419163}, "Splay": {"lowerIsBetter": false, "filtered": 126.67332267732264, "unit": "score", "value": 126.67332267732264}, "RegExp": {"lowerIsBetter": false, "filtered": 31.35149950835789, "unit": "score", "value": 31.35149950835789}, "Richards": {"lowerIsBetter": false, "filtered": 212.1297179999999, "unit": "score", "value": 212.1297179999999}, "Earley": {"lowerIsBetter": false, "filtered": 725.111744, "unit": "score", "value": 725.111744}, "Boyer": {"lowerIsBetter": false, "filtered": 53.10462151394425, "unit": "score", "value": 53.10462151394425}, "RayTrace": {"lowerIsBetter": false, "filtered": 391.0631178821179, "unit": "score", "value": 391.0631178821179}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0010"}, "testrun": {"date": 1447160992, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151110030032", "branch": "Firefox", "revision": "cc473fe5dc512c450634506f68cbacfb40a06a23"}}] 05:30:07 INFO - RETURN: dromaeo_css: 6701.58 05:30:07 INFO - RETURN: kraken: 1489.10 05:30:07 INFO - RETURN: v8_7: 18396.99 05:30:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "18396.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1489.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "6701.58"}}} 05:30:07 INFO - Return code: 0 05:30:07 INFO - # TBPL SUCCESS # 05:30:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:30:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:30:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:30:07 INFO - 2015-11-10 05:30:07.491 screenresolution[1662:9932] starting screenresolution argv=screenresolution get 05:30:07 INFO - 2015-11-10 05:30:07.495 screenresolution[1662:9932] Display 0: 1600x1200x32@60 05:30:07 INFO - 2015-11-10 05:30:07.501 screenresolution[1663:9935] starting screenresolution argv=screenresolution list 05:30:07 INFO - Available Modes on Display 0 05:30:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:30:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:30:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:30:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:30:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:30:07 INFO - Intel HD Graphics 3000: 05:30:07 INFO - Chipset Model: Intel HD Graphics 3000 05:30:07 INFO - Type: GPU 05:30:07 INFO - Bus: Built-In 05:30:07 INFO - VRAM (Total): 512 MB 05:30:07 INFO - VRAM (Dynamic, Max): 10 05:30:07 INFO - Vendor: Intel (0x8086) 05:30:07 INFO - Device ID: 0x0116 05:30:07 INFO - Revision ID: 0x0009 05:30:07 INFO - Displays: 05:30:07 INFO - Display: 05:30:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:30:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:30:07 INFO - Display Serial Number: 1600x1200 60 05:30:07 INFO - Main Display: Yes 05:30:07 INFO - Mirror: Off 05:30:07 INFO - Online: Yes 05:30:07 INFO - Rotation: Supported 05:30:07 INFO - Return code: 0 05:30:07 INFO - Running post-action listener: _resource_record_post_action 05:30:07 INFO - Running post-run listener: _resource_record_post_run 05:30:08 INFO - Total resource usage - Wall time: 1252s; CPU: 30.0%; Read bytes: 41022464; Write bytes: 687076352; Read time: 5055; Write time: 45211 05:30:08 INFO - install - Wall time: 36s; CPU: 30.0%; Read bytes: 339614208; Write bytes: 335480832; Read time: 32037; Write time: 5909 05:30:08 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 38773760; Write bytes: 340401152; Read time: 4621; Write time: 38195 05:30:08 INFO - Running post-run listener: _upload_blobber_files 05:30:08 INFO - Blob upload gear active. 05:30:08 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:30:08 INFO - Copying logs to upload dir... 05:30:08 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1313.594230 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-11-10 05:30:08.907249) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-10 05:30:08.910744) ========= 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.yW2WHr40kJ/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.zJEEfDGOKs/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010013 build_url: 'https://queue.taskcluster.net/v1/task/yVMrqs2GTeKVzQ_jyMMSaQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-10 05:30:08.937513) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:30:08.937881) ========= 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.yW2WHr40kJ/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.zJEEfDGOKs/Listeners TMPDIR=/var/folders/__/r_52kyh12_vcgl0mxh6bjblh00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005239 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-10 05:30:08.987676) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 05:30:08.988075) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-10 05:30:08.988620) ========= ========= Total master_lag: 0.50 =========