builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0011 starttime: 1448282453.9 results: success (0) buildid: 20151123025628 builduid: 8f0f5eef549a45e1833e14b4a4f4b3e0 revision: 8b1fc0961a076e35646d0472a81feefc0074558c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.900677) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.901089) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.901384) ========= 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.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005392 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.922152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.922462) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.946677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.947041) ========= 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.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005417 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.995475) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.995796) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.996132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:53.996397) ========= 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.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-23 04:40:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 53.4M=0s 2015-11-23 04:40:54 (53.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197514 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:54.214014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:54.214390) ========= 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.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025912 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:54.265152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 04:40:54.265501) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b1fc0961a076e35646d0472a81feefc0074558c --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 8b1fc0961a076e35646d0472a81feefc0074558c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-23 04:40:54,337 truncating revision to first 12 chars 2015-11-23 04:40:54,337 Setting DEBUG logging. 2015-11-23 04:40:54,338 attempt 1/10 2015-11-23 04:40:54,338 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b1fc0961a07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 04:40:56,025 unpacking tar archive at: mozilla-central-8b1fc0961a07/testing/mozharness/ program finished with exit code 0 elapsedTime=1.932803 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 04:40:56.213158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:56.213517) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:56.225349) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:56.225781) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:40:56.226302) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-23 04:40:56.226662) ========= /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.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:40:56 INFO - MultiFileLogger online at 20151123 04:40:56 in /builds/slave/test 04:40:56 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 04:40:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:40:56 INFO - {'append_to_log': False, 04:40:56 INFO - 'base_work_dir': '/builds/slave/test', 04:40:56 INFO - 'blob_upload_branch': 'Firefox', 04:40:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:40:56 INFO - 'branch': 'Firefox', 04:40:56 INFO - 'buildbot_json_path': 'buildprops.json', 04:40:56 INFO - 'config_files': ('talos/mac_config.py',), 04:40:56 INFO - 'default_actions': ('clobber', 04:40:56 INFO - 'read-buildbot-config', 04:40:56 INFO - 'download-and-extract', 04:40:56 INFO - 'populate-webroot', 04:40:56 INFO - 'create-virtualenv', 04:40:56 INFO - 'install', 04:40:56 INFO - 'run-tests'), 04:40:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:40:56 INFO - 'download_minidump_stackwalk': True, 04:40:56 INFO - 'download_symbols': 'ondemand', 04:40:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:40:56 INFO - 'tooltool.py': '/tools/tooltool.py', 04:40:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:40:56 INFO - '/tools/misc-python/virtualenv.py')}, 04:40:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:40:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:40:56 INFO - 'installer_path': 'installer.exe', 04:40:56 INFO - 'log_level': 'info', 04:40:56 INFO - 'log_name': 'talos', 04:40:56 INFO - 'log_to_console': True, 04:40:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:40:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:40:56 INFO - 'opt_config_files': (), 04:40:56 INFO - 'pip_index': False, 04:40:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:40:56 INFO - 'cmd': ('bash', 04:40:56 INFO - '-c', 04:40:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:40:56 INFO - 'enabled': True, 04:40:56 INFO - 'halt_on_failure': False, 04:40:56 INFO - 'name': 'check_screen_resolution'},), 04:40:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:40:56 INFO - 'cmd': ('bash', 04:40:56 INFO - '-c', 04:40:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:40:56 INFO - 'enabled': True, 04:40:56 INFO - 'halt_on_failure': False, 04:40:56 INFO - 'name': 'check_screen_resolution'},), 04:40:56 INFO - 'run_cmd_checks_enabled': True, 04:40:56 INFO - 'sps_profile': False, 04:40:56 INFO - 'sps_profile_interval': 0, 04:40:56 INFO - 'suite': 'dromaeojs', 04:40:56 INFO - 'system_bits': '64', 04:40:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:40:56 INFO - 'title': 't-yosemite-r7-0011', 04:40:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:40:56 INFO - 'use_talos_json': True, 04:40:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:40:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:40:56 INFO - 'work_dir': 'build'} 04:40:56 INFO - ##### 04:40:56 INFO - ##### Running clobber step. 04:40:56 INFO - ##### 04:40:56 INFO - Running pre-action listener: _resource_record_pre_action 04:40:56 INFO - Running main action method: clobber 04:40:56 INFO - rmtree: /builds/slave/test/build 04:40:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:40:57 INFO - Running post-action listener: _resource_record_post_action 04:40:57 INFO - ##### 04:40:57 INFO - ##### Running read-buildbot-config step. 04:40:57 INFO - ##### 04:40:57 INFO - Running pre-action listener: _resource_record_pre_action 04:40:57 INFO - Running main action method: read_buildbot_config 04:40:57 INFO - Using buildbot properties: 04:40:57 INFO - { 04:40:57 INFO - "properties": { 04:40:57 INFO - "buildnumber": 6, 04:40:57 INFO - "product": "firefox", 04:40:57 INFO - "script_repo_revision": "production", 04:40:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:40:57 INFO - "repository": "", 04:40:57 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:40:57 INFO - "buildid": "20151123025628", 04:40:57 INFO - "slavename": "t-yosemite-r7-0011", 04:40:57 INFO - "pgo_build": "False", 04:40:57 INFO - "basedir": "/builds/slave/test", 04:40:57 INFO - "project": "", 04:40:57 INFO - "platform": "yosemite_r7", 04:40:57 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:40:57 INFO - "slavebuilddir": "test", 04:40:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:40:57 INFO - "branch": "mozilla-central", 04:40:57 INFO - "repo_path": "mozilla-central", 04:40:57 INFO - "stage_platform": "macosx64", 04:40:57 INFO - "builduid": "8f0f5eef549a45e1833e14b4a4f4b3e0", 04:40:57 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 04:40:57 INFO - }, 04:40:57 INFO - "sourcestamp": { 04:40:57 INFO - "repository": "", 04:40:57 INFO - "hasPatch": false, 04:40:57 INFO - "project": "", 04:40:57 INFO - "branch": "mozilla-central-macosx64-talos", 04:40:57 INFO - "changes": [ 04:40:57 INFO - { 04:40:57 INFO - "category": null, 04:40:57 INFO - "files": [ 04:40:57 INFO - { 04:40:57 INFO - "url": null, 04:40:57 INFO - "name": "https://queue.taskcluster.net/v1/task/cwq3o17mSxCo82KrhYQnHw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 04:40:57 INFO - } 04:40:57 INFO - ], 04:40:57 INFO - "repository": "", 04:40:57 INFO - "rev": "db77a24c37698b4e71f8ba0fba170a0c157fc1f9", 04:40:57 INFO - "who": "cbook@mozilla.com", 04:40:57 INFO - "when": 1448282231, 04:40:57 INFO - "number": 6694696, 04:40:57 INFO - "comments": "merge b2g-inbound to mozilla-central on a CLOSED TREE", 04:40:57 INFO - "project": "", 04:40:57 INFO - "at": "Mon 23 Nov 2015 04:37:11", 04:40:57 INFO - "branch": "mozilla-central-macosx64-talos", 04:40:57 INFO - "revlink": "", 04:40:57 INFO - "properties": [ 04:40:57 INFO - [ 04:40:57 INFO - "buildid", 04:40:57 INFO - "20151123025227", 04:40:57 INFO - "Change" 04:40:57 INFO - ], 04:40:57 INFO - [ 04:40:57 INFO - "builduid", 04:40:57 INFO - "7aa31ee9839b4c6280f36d4a4979eddb", 04:40:57 INFO - "Change" 04:40:57 INFO - ], 04:40:57 INFO - [ 04:40:57 INFO - "pgo_build", 04:40:57 INFO - "False", 04:40:57 INFO - "Change" 04:40:57 INFO - ] 04:40:57 INFO - ], 04:40:57 INFO - "revision": "db77a24c37698b4e71f8ba0fba170a0c157fc1f9" 04:40:57 INFO - }, 04:40:57 INFO - { 04:40:57 INFO - "category": null, 04:40:57 INFO - "files": [ 04:40:57 INFO - { 04:40:57 INFO - "url": null, 04:40:57 INFO - "name": "https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 04:40:57 INFO - } 04:40:57 INFO - ], 04:40:57 INFO - "repository": "", 04:40:57 INFO - "rev": "8b1fc0961a076e35646d0472a81feefc0074558c", 04:40:57 INFO - "who": "cbook@mozilla.com", 04:40:57 INFO - "when": 1448282317, 04:40:57 INFO - "number": 6694704, 04:40:57 INFO - "comments": "merge fx-team to mozilla-central on a CLOSED TREE", 04:40:57 INFO - "project": "", 04:40:57 INFO - "at": "Mon 23 Nov 2015 04:38:37", 04:40:57 INFO - "branch": "mozilla-central-macosx64-talos", 04:40:57 INFO - "revlink": "", 04:40:57 INFO - "properties": [ 04:40:57 INFO - [ 04:40:57 INFO - "buildid", 04:40:57 INFO - "20151123025628", 04:40:57 INFO - "Change" 04:40:57 INFO - ], 04:40:57 INFO - [ 04:40:57 INFO - "builduid", 04:40:57 INFO - "8f0f5eef549a45e1833e14b4a4f4b3e0", 04:40:57 INFO - "Change" 04:40:57 INFO - ], 04:40:57 INFO - [ 04:40:57 INFO - "pgo_build", 04:40:57 INFO - "False", 04:40:57 INFO - "Change" 04:40:57 INFO - ] 04:40:57 INFO - ], 04:40:57 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 04:40:57 INFO - } 04:40:57 INFO - ], 04:40:57 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 04:40:57 INFO - } 04:40:57 INFO - } 04:40:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 04:40:57 INFO - Running post-action listener: _resource_record_post_action 04:40:57 INFO - ##### 04:40:57 INFO - ##### Running download-and-extract step. 04:40:57 INFO - ##### 04:40:57 INFO - Running pre-action listener: _resource_record_pre_action 04:40:57 INFO - Running main action method: download_and_extract 04:40:57 INFO - mkdir: /builds/slave/test/build/tests 04:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:40:57 INFO - https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:40:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/test_packages.json 04:40:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/test_packages.json 04:40:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:40:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:40:59 INFO - Downloaded 1149 bytes. 04:40:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:40:59 INFO - Using the following test package requirements: 04:40:59 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:40:59 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:40:59 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 04:40:59 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:40:59 INFO - u'jsshell-mac.zip'], 04:40:59 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:40:59 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 04:40:59 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:40:59 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:40:59 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 04:40:59 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:40:59 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 04:40:59 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:40:59 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 04:40:59 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:40:59 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:40:59 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 04:40:59 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:40: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')]} 04:40:59 INFO - https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:40:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:40:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:40:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/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 04:40:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/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 04:41:00 INFO - Downloaded 17525336 bytes. 04:41:00 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 04:41:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:41:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:41:03 INFO - Return code: 0 04:41:03 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 04:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:03 INFO - https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:41:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:41:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:41:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/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 04:41:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/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 04:41:04 INFO - Downloaded 17525336 bytes. 04:41:04 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 04:41:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:41:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:41:07 INFO - Return code: 0 04:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:07 INFO - https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:41:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:41:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:41:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/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 04:41:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/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 04:41:09 INFO - Downloaded 11130997 bytes. 04:41:09 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 04:41:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:41:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:41:09 INFO - Return code: 0 04:41:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:09 INFO - https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:41:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:41:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:41:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 04:41:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/InJVvDMbT8uk5AZTcJiNsA/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 04:41:12 INFO - Downloaded 109623813 bytes. 04:41:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:41:12 INFO - mkdir: /builds/slave/test/properties 04:41:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:41:12 INFO - Writing to file /builds/slave/test/properties/build_url 04:41:12 INFO - Contents: 04:41:12 INFO - build_url:https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:41:12 INFO - Running post-action listener: _resource_record_post_action 04:41:12 INFO - Running post-action listener: set_extra_try_arguments 04:41:12 INFO - ##### 04:41:12 INFO - ##### Running populate-webroot step. 04:41:12 INFO - ##### 04:41:12 INFO - Running pre-action listener: _resource_record_pre_action 04:41:12 INFO - Running main action method: populate_webroot 04:41:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:41:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:41:12 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:41:12 INFO - '../fennec_ids.txt'], 04:41:12 INFO - 'tests': ['tcheck2']}, 04:41:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:41:12 INFO - '--tppagecycles', 04:41:12 INFO - '7'], 04:41:12 INFO - 'tests': ['tsvgm']}}, 04:41:12 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:41:12 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:41:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:41:12 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:41:12 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:41:12 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:41:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:12 INFO - 'talos_options': ['--e10s'], 04:41:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:41:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:12 INFO - 'tests': ['damp', 'tps']}, 04:41:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:12 INFO - 'talos_options': ['--e10s'], 04:41:12 INFO - 'tests': ['damp', 'tps']}, 04:41:12 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:41:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:41:12 INFO - 'other': {'tests': ['a11yr', 04:41:12 INFO - 'ts_paint', 04:41:12 INFO - 'tpaint', 04:41:12 INFO - 'sessionrestore', 04:41:12 INFO - 'sessionrestore_no_auto_restore']}, 04:41:12 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:41:12 INFO - 'tests': ['a11yr', 04:41:12 INFO - 'ts_paint', 04:41:12 INFO - 'tpaint', 04:41:12 INFO - 'sessionrestore', 04:41:12 INFO - 'sessionrestore_no_auto_restore']}, 04:41:12 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:41:12 INFO - 'tests': ['a11yr', 04:41:12 INFO - 'ts_paint', 04:41:12 INFO - 'tpaint', 04:41:12 INFO - 'sessionrestore', 04:41:12 INFO - 'sessionrestore_no_auto_restore']}, 04:41:12 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:41:12 INFO - 'tests': ['a11yr', 04:41:12 INFO - 'ts_paint', 04:41:12 INFO - 'tpaint', 04:41:12 INFO - 'sessionrestore', 04:41:12 INFO - 'sessionrestore_no_auto_restore']}, 04:41:12 INFO - 'other_l64': {'tests': ['a11yr', 04:41:12 INFO - 'ts_paint', 04:41:12 INFO - 'tpaint', 04:41:12 INFO - 'sessionrestore', 04:41:12 INFO - 'sessionrestore_no_auto_restore']}, 04:41:12 INFO - 'other_nol64': {'tests': ['a11yr', 04:41:12 INFO - 'ts_paint', 04:41:12 INFO - 'tpaint', 04:41:12 INFO - 'sessionrestore', 04:41:12 INFO - 'sessionrestore_no_auto_restore']}, 04:41:12 INFO - 'svgr': {'tests': ['tsvgx', 04:41:12 INFO - 'tsvgr_opacity', 04:41:12 INFO - 'tart', 04:41:12 INFO - 'tscrollx', 04:41:12 INFO - 'cart']}, 04:41:12 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:41:12 INFO - 'tests': ['tsvgx', 04:41:12 INFO - 'tsvgr_opacity', 04:41:12 INFO - 'tart', 04:41:12 INFO - 'tscrollx', 04:41:12 INFO - 'cart']}, 04:41:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:12 INFO - 'tests': ['tp5o']}, 04:41:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:12 INFO - 'talos_options': ['--e10s'], 04:41:12 INFO - 'tests': ['tp5o']}, 04:41:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:12 INFO - 'talos_options': ['--xperf_path', 04:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:12 INFO - 'tests': ['tp5n']}, 04:41:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:41:12 INFO - 'talos_options': ['--e10s', 04:41:12 INFO - '--xperf_path', 04:41:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:41:12 INFO - 'tests': ['tp5n']}}, 04:41:12 INFO - 'talos.zip': {'path': '', 04:41:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:41:12 INFO - Running post-action listener: _resource_record_post_action 04:41:12 INFO - ##### 04:41:12 INFO - ##### Running create-virtualenv step. 04:41:12 INFO - ##### 04:41:12 INFO - Running pre-action listener: _resource_record_pre_action 04:41:12 INFO - Running main action method: create_virtualenv 04:41:12 INFO - Creating virtualenv /builds/slave/test/build/venv 04:41:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:41:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:41:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:41:12 INFO - Using real prefix '/tools/python27' 04:41:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:41:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:41:16 INFO - Installing pip.................done. 04:41:16 INFO - Return code: 0 04:41:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:16 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 0x10244f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10242c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0bd952b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023739f0>, '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 0x1020d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023668c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:16 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 04:41:16 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 04:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/Render', 04:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:16 INFO - 'HOME': '/Users/cltbld', 04:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:16 INFO - 'LOGNAME': 'cltbld', 04:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:16 INFO - 'MOZ_NO_REMOTE': '1', 04:41:16 INFO - 'NO_EM_RESTART': '1', 04:41:16 INFO - 'PAGER': '/bin/cat', 04:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:16 INFO - 'PWD': '/builds/slave/test', 04:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:16 INFO - 'SHELL': '/bin/bash', 04:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaRQQcOQ0O/Listeners', 04:41:16 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 04:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:16 INFO - 'USER': 'cltbld', 04:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:16 INFO - 'XPC_FLAGS': '0x0', 04:41:16 INFO - 'XPC_SERVICE_NAME': '0', 04:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:41:16 INFO - Cleaning up... 04:41:16 INFO - Return code: 0 04:41:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:16 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 0x10244f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10242c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0bd952b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023739f0>, '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 0x1020d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023668c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:16 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 04:41:16 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 04:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/Render', 04:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:16 INFO - 'HOME': '/Users/cltbld', 04:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:16 INFO - 'LOGNAME': 'cltbld', 04:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:16 INFO - 'MOZ_NO_REMOTE': '1', 04:41:16 INFO - 'NO_EM_RESTART': '1', 04:41:16 INFO - 'PAGER': '/bin/cat', 04:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:16 INFO - 'PWD': '/builds/slave/test', 04:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:16 INFO - 'SHELL': '/bin/bash', 04:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaRQQcOQ0O/Listeners', 04:41:16 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 04:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:16 INFO - 'USER': 'cltbld', 04:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:16 INFO - 'XPC_FLAGS': '0x0', 04:41:16 INFO - 'XPC_SERVICE_NAME': '0', 04:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:16 INFO - Downloading/unpacking psutil>=0.7.1 04:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:41:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:41:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:19 INFO - Installing collected packages: psutil 04:41:19 INFO - Running setup.py install for psutil 04:41:19 INFO - building 'psutil._psutil_osx' extension 04:41:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:41:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:41:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:41:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:41:20 INFO - building 'psutil._psutil_posix' extension 04:41:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:41:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:41:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:41:20 INFO - ^ 04:41:20 INFO - 1 warning generated. 04:41:20 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:41:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:41:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:41:20 INFO - Successfully installed psutil 04:41:20 INFO - Cleaning up... 04:41:20 INFO - Return code: 0 04:41:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:41: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')]} 04:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41: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')]} 04:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:20 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 0x10244f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10242c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0bd952b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023739f0>, '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 0x1020d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023668c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:20 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 04:41:20 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 04:41:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/Render', 04:41:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:20 INFO - 'HOME': '/Users/cltbld', 04:41:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:20 INFO - 'LOGNAME': 'cltbld', 04:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:20 INFO - 'MOZ_NO_REMOTE': '1', 04:41:20 INFO - 'NO_EM_RESTART': '1', 04:41:20 INFO - 'PAGER': '/bin/cat', 04:41:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:20 INFO - 'PWD': '/builds/slave/test', 04:41:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:20 INFO - 'SHELL': '/bin/bash', 04:41:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaRQQcOQ0O/Listeners', 04:41:20 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 04:41:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:20 INFO - 'USER': 'cltbld', 04:41:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:20 INFO - 'XPC_FLAGS': '0x0', 04:41:20 INFO - 'XPC_SERVICE_NAME': '0', 04:41:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:41:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:41:23 INFO - Installing collected packages: mozsystemmonitor 04:41:23 INFO - Running setup.py install for mozsystemmonitor 04:41:23 INFO - Successfully installed mozsystemmonitor 04:41:23 INFO - Cleaning up... 04:41:23 INFO - Return code: 0 04:41:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:23 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 0x10244f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10242c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0bd952b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023739f0>, '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 0x1020d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023668c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:23 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 04:41:23 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 04:41:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/Render', 04:41:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:23 INFO - 'HOME': '/Users/cltbld', 04:41:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:23 INFO - 'LOGNAME': 'cltbld', 04:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:23 INFO - 'MOZ_NO_REMOTE': '1', 04:41:23 INFO - 'NO_EM_RESTART': '1', 04:41:23 INFO - 'PAGER': '/bin/cat', 04:41:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:23 INFO - 'PWD': '/builds/slave/test', 04:41:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:23 INFO - 'SHELL': '/bin/bash', 04:41:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaRQQcOQ0O/Listeners', 04:41:23 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 04:41:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:23 INFO - 'USER': 'cltbld', 04:41:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:23 INFO - 'XPC_FLAGS': '0x0', 04:41:23 INFO - 'XPC_SERVICE_NAME': '0', 04:41:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:23 INFO - Downloading/unpacking blobuploader==1.2.4 04:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:25 INFO - Downloading blobuploader-1.2.4.tar.gz 04:41:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:41:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:41:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:26 INFO - Downloading docopt-0.6.1.tar.gz 04:41:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:41:26 INFO - Installing collected packages: blobuploader, requests, docopt 04:41:26 INFO - Running setup.py install for blobuploader 04:41:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:41:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:41:27 INFO - Running setup.py install for requests 04:41:27 INFO - Running setup.py install for docopt 04:41:27 INFO - Successfully installed blobuploader requests docopt 04:41:27 INFO - Cleaning up... 04:41:27 INFO - Return code: 0 04:41:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:27 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 0x10244f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10242c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0bd952b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023739f0>, '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 0x1020d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023668c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:27 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 04:41:27 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 04:41:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/Render', 04:41:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:27 INFO - 'HOME': '/Users/cltbld', 04:41:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:27 INFO - 'LOGNAME': 'cltbld', 04:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:27 INFO - 'MOZ_NO_REMOTE': '1', 04:41:27 INFO - 'NO_EM_RESTART': '1', 04:41:27 INFO - 'PAGER': '/bin/cat', 04:41:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:27 INFO - 'PWD': '/builds/slave/test', 04:41:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:27 INFO - 'SHELL': '/bin/bash', 04:41:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaRQQcOQ0O/Listeners', 04:41:27 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 04:41:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:27 INFO - 'USER': 'cltbld', 04:41:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:27 INFO - 'XPC_FLAGS': '0x0', 04:41:27 INFO - 'XPC_SERVICE_NAME': '0', 04:41:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:28 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-Pd2CGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:28 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-doEvmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:28 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-RFrbv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:28 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-4SDZjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:28 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-dTCuET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:28 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-uhHXw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:28 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-5WuWJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:28 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-pdLzIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:28 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-_XFmr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:29 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-gHh2Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:29 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-1GhqW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:29 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-YnxayC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:29 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-tjmQ8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:29 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-AvUil8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:29 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-2GoCtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:29 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-8haRU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:29 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-TRPHUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:41:29 INFO - Running setup.py install for manifestparser 04:41:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:41:30 INFO - Running setup.py install for mozcrash 04:41:30 INFO - Running setup.py install for mozdebug 04:41:30 INFO - Running setup.py install for mozdevice 04:41:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:41:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:41:30 INFO - Running setup.py install for mozfile 04:41:30 INFO - Running setup.py install for mozhttpd 04:41:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:41:30 INFO - Running setup.py install for mozinfo 04:41:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:41:30 INFO - Running setup.py install for mozInstall 04:41:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:41:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:41:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:41:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:41:31 INFO - Running setup.py install for mozleak 04:41:31 INFO - Running setup.py install for mozlog 04:41:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:41:31 INFO - Running setup.py install for moznetwork 04:41:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:41:31 INFO - Running setup.py install for mozprocess 04:41:31 INFO - Running setup.py install for mozprofile 04:41:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:41:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:41:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:41:31 INFO - Running setup.py install for mozrunner 04:41:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:41:31 INFO - Running setup.py install for mozscreenshot 04:41:32 INFO - Running setup.py install for moztest 04:41:32 INFO - Running setup.py install for mozversion 04:41:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:41:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:41:32 INFO - Cleaning up... 04:41:32 INFO - Return code: 0 04:41:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:32 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 0x10244f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10242c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0bd952b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023739f0>, '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 0x1020d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023668c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:32 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 04:41:32 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 04:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/Render', 04:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:32 INFO - 'HOME': '/Users/cltbld', 04:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:32 INFO - 'LOGNAME': 'cltbld', 04:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:32 INFO - 'MOZ_NO_REMOTE': '1', 04:41:32 INFO - 'NO_EM_RESTART': '1', 04:41:32 INFO - 'PAGER': '/bin/cat', 04:41:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:32 INFO - 'PWD': '/builds/slave/test', 04:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:32 INFO - 'SHELL': '/bin/bash', 04:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaRQQcOQ0O/Listeners', 04:41:32 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 04:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:32 INFO - 'USER': 'cltbld', 04:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:32 INFO - 'XPC_FLAGS': '0x0', 04:41:32 INFO - 'XPC_SERVICE_NAME': '0', 04:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:41:32 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-t4UAih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:41:32 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-CsdeJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:41:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:41:32 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-eRb8gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:41:33 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-ljPAsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:41:33 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)) 04:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:41:33 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-ps9Zxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:41:33 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-zGKSq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:41:33 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-lWdkMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:41:33 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-dZt4Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:41:33 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-nimd94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:41:33 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-cW_tTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:41:33 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)) 04:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:41:33 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-AfOHgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:41:33 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-m0o6m0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:41:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:41:33 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-HB1tWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:41:34 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)) 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:41:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-hqAncu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-hc9B_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:41:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-7NG4St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:41:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:41:34 INFO - Running setup.py (path:/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/pip-hoXCtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:41:34 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)) 04:41:34 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)) 04:41:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:41:36 INFO - Downloading blessings-1.5.1.tar.gz 04:41:36 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 04:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:41:36 INFO - Installing collected packages: blessings 04:41:36 INFO - Running setup.py install for blessings 04:41:36 INFO - Successfully installed blessings 04:41:36 INFO - Cleaning up... 04:41:36 INFO - Return code: 0 04:41:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:41:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:37 INFO - Reading from file tmpfile_stdout 04:41:37 INFO - Current package versions: 04:41:37 INFO - blessings == 1.5.1 04:41:37 INFO - blobuploader == 1.2.4 04:41:37 INFO - docopt == 0.6.1 04:41:37 INFO - manifestparser == 1.1 04:41:37 INFO - mozInstall == 1.12 04:41:37 INFO - mozcrash == 0.16 04:41:37 INFO - mozdebug == 0.1 04:41:37 INFO - mozdevice == 0.47 04:41:37 INFO - mozfile == 1.2 04:41:37 INFO - mozhttpd == 0.7 04:41:37 INFO - mozinfo == 0.9 04:41:37 INFO - mozleak == 0.1 04:41:37 INFO - mozlog == 3.0 04:41:37 INFO - moznetwork == 0.27 04:41:37 INFO - mozprocess == 0.22 04:41:37 INFO - mozprofile == 0.27 04:41:37 INFO - mozrunner == 6.11 04:41:37 INFO - mozscreenshot == 0.1 04:41:37 INFO - mozsystemmonitor == 0.0 04:41:37 INFO - moztest == 0.7 04:41:37 INFO - mozversion == 1.4 04:41:37 INFO - psutil == 3.1.1 04:41:37 INFO - requests == 1.2.3 04:41:37 INFO - wsgiref == 0.1.2 04:41:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:41:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:41:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:41:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:41:37 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 0x10244f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10242c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b0bd952b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023739f0>, '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 0x1020d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023668c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:41:37 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 04:41:37 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 04:41:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/Render', 04:41:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:41:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:41:37 INFO - 'HOME': '/Users/cltbld', 04:41:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:41:37 INFO - 'LOGNAME': 'cltbld', 04:41:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:41:37 INFO - 'MOZ_NO_REMOTE': '1', 04:41:37 INFO - 'NO_EM_RESTART': '1', 04:41:37 INFO - 'PAGER': '/bin/cat', 04:41:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:41:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:41:37 INFO - 'PWD': '/builds/slave/test', 04:41:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:41:37 INFO - 'SHELL': '/bin/bash', 04:41:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaRQQcOQ0O/Listeners', 04:41:37 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 04:41:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:41:37 INFO - 'USER': 'cltbld', 04:41:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:41:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:41:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:41:37 INFO - 'XPC_FLAGS': '0x0', 04:41:37 INFO - 'XPC_SERVICE_NAME': '0', 04:41:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:41:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:41:37 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)) 04:41:37 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)) 04:41:37 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)) 04:41:37 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)) 04:41:37 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)) 04:41:37 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)) 04:41:37 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)) 04:41:37 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)) 04:41:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:41:37 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)) 04:41:37 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)) 04:41:37 INFO - Cleaning up... 04:41:37 INFO - Return code: 0 04:41:37 INFO - Running post-action listener: _resource_record_post_action 04:41:37 INFO - Running post-action listener: _start_resource_monitoring 04:41:37 INFO - Starting resource monitoring. 04:41:37 INFO - ##### 04:41:37 INFO - ##### Running install step. 04:41:37 INFO - ##### 04:41:37 INFO - Running pre-action listener: _resource_record_pre_action 04:41:37 INFO - Running main action method: install 04:41:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:41:37 INFO - Reading from file tmpfile_stdout 04:41:37 INFO - Detecting whether we're running mozinstall >=1.0... 04:41:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:41:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:41:37 INFO - Reading from file tmpfile_stdout 04:41:37 INFO - Output received: 04:41:37 INFO - Usage: mozinstall [options] installer 04:41:37 INFO - Options: 04:41:37 INFO - -h, --help show this help message and exit 04:41:37 INFO - -d DEST, --destination=DEST 04:41:37 INFO - Directory to install application into. [default: 04:41:37 INFO - "/builds/slave/test"] 04:41:37 INFO - --app=APP Application being installed. [default: firefox] 04:41:37 INFO - mkdir: /builds/slave/test/build/application 04:41:37 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'] 04:41:37 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 04:42:08 INFO - Reading from file tmpfile_stdout 04:42:08 INFO - Output received: 04:42:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:42:08 INFO - Running post-action listener: _resource_record_post_action 04:42:08 INFO - ##### 04:42:08 INFO - ##### Running run-tests step. 04:42:08 INFO - ##### 04:42:08 INFO - Running pre-action listener: _resource_record_pre_action 04:42:08 INFO - Running main action method: run_tests 04:42:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:42:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:42:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:42:08 INFO - 2015-11-23 04:42:08.283 screenresolution[1651:7392] starting screenresolution argv=screenresolution get 04:42:08 INFO - 2015-11-23 04:42:08.285 screenresolution[1651:7392] Display 0: 1600x1200x32@50 04:42:08 INFO - 2015-11-23 04:42:08.291 screenresolution[1652:7394] starting screenresolution argv=screenresolution list 04:42:08 INFO - Available Modes on Display 0 04:42:08 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 04:42:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:42:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:42:08 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 04:42:08 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 04:42:08 INFO - Graphics/Displays: 04:42:08 INFO - Intel Iris: 04:42:08 INFO - Chipset Model: Intel Iris 04:42:08 INFO - Type: GPU 04:42:08 INFO - Bus: Built-In 04:42:08 INFO - VRAM (Dynamic, Max): 1536 MB 04:42:08 INFO - Vendor: Intel (0x8086) 04:42:08 INFO - Device ID: 0x0a2e 04:42:08 INFO - Revision ID: 0x0009 04:42:08 INFO - Displays: 04:42:08 INFO - Display: 04:42:08 INFO - Resolution: 1600 x 1200 @ 50 Hz 04:42:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:42:08 INFO - Display Serial Number: 1600x1200 50 04:42:08 INFO - Main Display: Yes 04:42:08 INFO - Mirror: Off 04:42:08 INFO - Online: Yes 04:42:08 INFO - Rotation: Supported 04:42:08 INFO - Return code: 0 04:42:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:42:08 INFO - Python 2.7.3 04:42:08 INFO - Return code: 0 04:42:08 INFO - grabbing minidump binary from tooltool 04:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:42:08 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 0x1023739f0>, '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 0x1020d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023668c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:42:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:42:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:42:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:42:08 INFO - Return code: 0 04:42:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:42:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:42:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:42:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:42:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:42:08 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/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0011', '--webServer', 'localhost'] in /builds/slave/test/build 04:42:08 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/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0011 --webServer localhost 04:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gXSyEYHd5o/Render', 04:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:08 INFO - 'HOME': '/Users/cltbld', 04:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:08 INFO - 'LOGNAME': 'cltbld', 04:42:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:42:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:08 INFO - 'MOZ_NO_REMOTE': '1', 04:42:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:42:08 INFO - 'NO_EM_RESTART': '1', 04:42:08 INFO - 'PAGER': '/bin/cat', 04:42:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:08 INFO - 'PWD': '/builds/slave/test', 04:42:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:08 INFO - 'SHELL': '/bin/bash', 04:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaRQQcOQ0O/Listeners', 04:42:08 INFO - 'TMPDIR': '/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/', 04:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:08 INFO - 'USER': 'cltbld', 04:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:08 INFO - 'XPC_FLAGS': '0x0', 04:42:08 INFO - 'XPC_SERVICE_NAME': '0', 04:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:08 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/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0011', '--webServer', 'localhost'] with output_timeout 3600 04:42:08 INFO - mozversion INFO | application_buildid: 20151123025628 04:42:08 INFO - mozversion INFO | application_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 04:42:08 INFO - mozversion INFO | application_display_name: Nightly 04:42:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:42:08 INFO - mozversion INFO | application_name: Firefox 04:42:08 INFO - mozversion INFO | application_remotingname: firefox 04:42:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:42:08 INFO - mozversion INFO | application_vendor: Mozilla 04:42:08 INFO - mozversion INFO | application_version: 45.0a1 04:42:08 INFO - mozversion INFO | platform_buildid: 20151123025628 04:42:08 INFO - mozversion INFO | platform_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 04:42:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:42:08 INFO - mozversion INFO | platform_version: 45.0a1 04:42:08 INFO - 2015-11-23 04:42:08,838 DEBUG : using testdate: 1448282528 04:42:08 INFO - 2015-11-23 04:42:08,838 DEBUG : actual date: 1448282528 04:42:09 INFO - 2015-11-23 04:42:09,257 INFO : starting webserver on 'localhost:49266' 04:42:09 INFO - 2015-11-23 04:42:09,258 INFO : Starting test suite t-yosemite-r7-0011 04:42:09 INFO - 2015-11-23 04:42:09,258 INFO : Starting test dromaeo_css 04:42:09 INFO - 2015-11-23 04:42:09,258 DEBUG : operating with platform_type : mac_ 04:42:09 INFO - 2015-11-23 04:42:09,259 INFO : Initialising browser for dromaeo_css test... 04:42:09 INFO - 2015-11-23 04:42:09,272 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmp4ivimn/profile http://localhost:49266/getInfo.html 04:42:11 INFO - 2015-11-23 04:42:11,620 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:42:11 INFO - 2015-11-23 04:42:11,620 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:42:11 INFO - 2015-11-23 04:42:11,621 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:42:11 INFO - 2015-11-23 04:42:11,621 DEBUG : BROWSER_OUTPUT: __metrics 04:42:11 INFO - 2015-11-23 04:42:11,637 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:42:12 INFO - 2015-11-23 04:42:12,273 INFO : Browser initialized. 04:42:12 INFO - 2015-11-23 04:42:12,273 INFO : Running cycle 1/1 for dromaeo_css test... 04:42:12 INFO - 2015-11-23 04:42:12,273 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmp4ivimn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:42:24 INFO - 2015-11-23 04:42:24,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 226398208 04:42:24 INFO - 2015-11-23 04:42:24,071 DEBUG : BROWSER_OUTPUT: 04:43:15 INFO - 2015-11-23 04:43:15,192 DEBUG : BROWSER_OUTPUT: 1448282595190 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:45:26 INFO - 2015-11-23 04:45:26,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 04:45:27 INFO - 2015-11-23 04:45:27,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 336216064 04:45:27 INFO - 2015-11-23 04:45:27,598 DEBUG : BROWSER_OUTPUT: 04:48:30 INFO - 2015-11-23 04:48:30,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 04:48:30 INFO - 2015-11-23 04:48:30,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 358510592 04:48:30 INFO - 2015-11-23 04:48:30,747 DEBUG : BROWSER_OUTPUT: 04:51:32 INFO - 2015-11-23 04:51:32,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 04:51:33 INFO - 2015-11-23 04:51:33,349 DEBUG : BROWSER_OUTPUT: RSS: Main: 353239040 04:51:33 INFO - 2015-11-23 04:51:33,349 DEBUG : BROWSER_OUTPUT: 04:54:35 INFO - 2015-11-23 04:54:35,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 04:54:35 INFO - 2015-11-23 04:54:35,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 318767104 04:54:35 INFO - 2015-11-23 04:54:35,923 DEBUG : BROWSER_OUTPUT: 04:57:38 INFO - 2015-11-23 04:57:38,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 04:57:39 INFO - 2015-11-23 04:57:39,538 DEBUG : BROWSER_OUTPUT: RSS: Main: 321728512 04:57:39 INFO - 2015-11-23 04:57:39,539 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-23 05:00:42,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 05:00:42 INFO - 2015-11-23 05:00:42,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 362045440 05:00:42 INFO - 2015-11-23 05:00:42,360 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-23 05:00:42,360 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:00:42 INFO - 2015-11-23 05:00:42,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:00:42 INFO - 2015-11-23 05:00:42,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:00:42 INFO - 2015-11-23 05:00:42,361 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:00:42 INFO - 2015-11-23 05:00:42,364 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3465.445528715405;3513.0865974846533;3552.5559305086863;3583.7849729016243;3602.9551430085276;5590.133529302954;5692.37383887773;6041.033434650451;6048.8487787805325;6054.091886217069;5890.145928840327;5936.851578710534;5943.227380440537;6065.059915713061;6070.54470914682;4528.43394575678;5090.949090509103;5348.732563371826;5348.893022139555;5475.178723191533;5420.430854760252;5499.7250137492965;5520.089185284423;5529.253550770655;5588.469095435948;5229.058769421503;5336.226247194174;5353.304070470814;5448.7548060337185;5452.4274951130155;5276.709780962045;5382.811601593965;5394;5397.055515284848;5410.431904649994;5343.679379237258;5397.46025397461;5399.78400863965;5407.810726624589;5422.864428389283;5835.35811060783;5878.088896221093;5885.058390657517;5907.6160049597065;5921.763129474816;5388.811391601275;6197.752089916398;6287.339829317902;6328.525360597928;6368.395002474757;5415.48552887475;6413.903791443132;6435.774747883848;6442.742290308382;6443.033544968245;6098.634081955097;6154.169187159721;6167.414095660905;6184.752609895644;6188.947878860605;6360.872782544323;6458.644774537445;6473;6481.4166724994975;6534.477241820643;6378.043293506012;6412.5190610704385;6436;6436.710348034349;6439.356064393523;6443;6448.677566121675;6451.580647257913;6469.741210351627;6473.967630161913;6259.624422534663;6289;6350.333215012357;6376.33048529907;6410.102585638015;5383.542398896059;6323.462505686976;6365.61806291624;6367.713452894631;6398.712057957403;5083.949160508421;5131.923021154686;5133.589312854962;5133.614978876524;5137.434882162959;4466.709663871838;4529.954700452953;4537.977310113428;4543.5910768031035;4619.099275641218;6068.150458935753;6074.668631805383;6088.847778805565;6092;6113.205283313141;6399.296077431479;6421.165248517663;6448.451881590024;6451.548391612636;6487.124238227779;5805.82582522525;5912.615679980788;5917.940820591739;5989.940100599026;6058.303295121117;4768.284757286435;5595.272614560081;5619.8033068843215;5623.297087864017;5648.9717551412805;6341.682915854281;6395.040743888361;6400;6411.871762564816;6413;6261.96869015652;6294.464970477561;6376.649284289409;6396;6450.580712253689;6369.936300636934;6373.330800265905;6386.87226255463;6393.6483493408305;6396.200474940632;6347.650879201688;6369.713362898588;6381.074744161978;6381.585196962183;6384.712687929147;6266.749330026748;6366.9681651591445;6368.522360822864;6447.967760161169;6449.161608990801;6225.097360882737;6292.653904035139;6348.682565871781;6366.363363663597;6382.042693595998;6346.809595712136;6353.7140828661895;6354.459870911024;6369.936300636934;6370.331115232834;5704;6047.78832740852;6096.146539484387;6190.7523699051535;6255.999040153553;6192.907106393318;6278.968605156945;6291.402316779899;6343.682815859281;6351.523635727246;6256.343083976299;6258.906116408349;6259.1550140730415;6277.2153480814895;6287 05:00:42 INFO - 2015-11-23 05:00:42,366 DEBUG : BROWSER_OUTPUT: |1;ext.html;574.4714862326662;593.7120496559171;596.2755252368372;607.1924340626965;607.835884311236;31534.68465315346;39070.60929390705;39594.406083908725;39599;39628.80185599075;42816;43250.13499730003;43298.78350608243;43513;43556;8515.489070655749;8759.16787905148;9539.666111686092;9763.463009534473;9775.071368220008;11659.533618655243;11748.530058797638;11752;11754.7649047019;11759.7648047039;11492.482838272297;11573.305601663886;11582.6525204244;11583.18917675763;11589.6523104307;8720.433171843873;8843.292536597057;8848.336374771918;11473.368964706939;11649.70875728105;11429.657110286706;11566.132540059445;11568.595099171573;11569.421528923604;11592;40198.59801401978;40565.98585035398;40614;40656;40780.1843963122;3168.6672899345467;3362.96637033629;3407.6251612322626;3437.4843773433936;3618.276344731038;29152.08479152089;29371.55942660862;29778.55332170019;30004.8499757502;30103;2730;2802.523570992936;2815.4650616382824;2840.1763488588285;2859.7569206617463;494821;495236.9999999964;496157;499110;503479;53766;54166.729166353914;54443.45556544384;63070.36929630645;63854.042189367196;70751.64624176949;71398;71406;71531.56936861234;71569.64215178891;16120.032798032156;16132.435364762412;16293.59266018359;16299;16324.67350653004;12431.067669924792;12466.376681165906;12484.687882803002;12485.001199903985;12496.25022498653;18606.069696515122;19292.838619589238;19590.70613940792;19608.70586941197;19615.607687846164;8058.758237252891;9305.441673499612;9318;9336;9351.485668288173;960.011188475871;994.3685759542742;995.9253056020683;1120.523777394604;1217.1837708830478;29419.411611767646;29647.55528667072;29875.85062074719;29886.40227195444;30060.84969575138;1076.9299995500267;1121.4673030310537;1225.8835410635975;1260.3887114749339;1274.75800446761;14965.925170374296;15003.474878379422;15046.306675235597;15248.466303679317;15453.922730386275;532394;539610;540508;540891.2955435198;541232;58098.419015809304;58424.707876461194;58547.41452585505;58573.60697947671;58579;1444.7543917534044;1447.1751101872042;1469.3828591991603;1482.762757958743;1488.4195163886093;27979;29204;29701.257468563457;29828.850855745583;29912.85043574768;51576;51868;51911.480885190664;51914.48085519097;52070;389545.10454895085;391927;392111;392143;392371;28221.294467638472;32480.675193247764;33315.00054998354;33359.666403336625;33404;42364.576354236066;43712.125757484035;44023.89940251391;44191.55808441874;44239.89400264891;34859.82570087133;36255.199168132975;37029.629703702616;37118.072048199014;37224;30322;36419.089522762144;36423.63576364202;36547.81726091352;37421.25157496889;28051.43897122087;35061.12347191238;35287.47068793919;35294.294114118085;35573.28853422969;30141.698583014768;31659.683403165673;32287.35425291528;32882.671173288916;32887.67112328846;24055.639165412882;24381.512369752152;24422;24918.377040573407;24989.500209995334 05:00:42 INFO - 2015-11-23 05:00:42,367 DEBUG : BROWSER_OUTPUT: |2;jquery.html;339.44670187594215;364.7300997262026;365.1838141753183;365.55037304115956;367.04751170711995;16030.679386412265;16508.66982660349;19495.317663881768;20605;21418.464538386546;11802.704932376695;12119.757604847899;12132.332721700324;20885.47786305343;21348.57302853946;5264.552513036397;5392.838214853541;5406.486383793534;5407.729613519328;5411.783528658849;3981.203759248162;4092.570280120589;4099.282625540533;4850.248211527201;5360.222767698681;5951.88096238075;5986.5210783137245;5994.940050599504;6000.909986350208;6007.6395416274945;5747.540196784247;6475.190601174853;6475.384838440341;6480.9675951620175;6483.513736469784;5525.4474552544825;5661.915071273934;5675.460831221028;5676.233708449389;5679.233303504016;12930.676733081655;13270.800937985938;13286.335683215897;13361.465541378333;23747.05011799526;2020.98989505053;2064.721262629541;2077.9272725454534;2170.9891450542646;2257.7967982881455;9823.36148150375;9860.753481162956;10210.978902109804;12378.195417297848;13904.930475347659;1709.2052195729045;1712.477694303237;1719.5185348102552;1741.1468380493593;1754.0528114817982;93646;98645.50677246568;99491;99791.0020899789;100508.49745751297;10702.625408110678;10954.452277386099;10974.396408197626;11027.61403350879;11111.444397784317;13139.60581182547;13157.342132893316;13177;13254.73490530184;13278.66803329905;8346.958265208636;8474.322054235647;8480.024797148284;8549.145085491526;8550.144985501525;8610.612522436506;8624.784380390414;8643.78390540229;8707.259882910024;8730.912690873138;4320.632746216606;4362.934555981663;4381.67137464685;4408.801603927831;4413.117376524708;1487.4570781664615;1539.4765779634754;1805.629845881591;1805.972910406345;1813.3925135079633;398.80259271660134;406.9369247766601;829.5686243153526;981.4454833019321;994.796066806303;11111.944440277746;11624.6512604622;11729.88270117305;11795.52817887275;11816.172867899337;428.3831282952538;450.1963994270212;452.3960512715496;455.6400443649546;460.05458782202896;5965.671888046112;5999.400059994053;6080.118382834465;6083.908741368795;6096.116063170815;700522;737310;767094;772054;812038;111140;112387;113756;117497.8250217487;123631;474.928760685893;478.33511419126745;478.79411852903587;478.8730986288636;480.00638677937036;10440;11124.555017799521;11273.605423810128;11278.210525263154;11346.319220846775;45229.76323788178;46249.30626040545;46654.53345466638;46762.766186168854;47024.529754702016;67798.96603101915;67909.6604516994;68135.97796033163;68993.79055884994;71103;8416.537090460084;9826.705198844045;10007.349522281029;10013.599456021677;10098.444585547866;11872.52509899629;11948.820767688665;12750.553730619384;19412.8058719411;19669.80330196737;11641;15659.765103523685;15975.360985560448;16061.919690401473;16214.270357834162;15256.313465894284;15441.305141268445;15454.072755634697;15868.2065896707;15956.68086638284;13092.476300947856;14965.625859353604;15651.37394504207;16089.436869709503;16349.427770027993;9878.110970012733;9930.404175749478;9953.253505986935;9990.050945160197;9992.20062394992;15173.848261517243;15378.615534611277;15571.76642350343;15724.29240684149;15795.052296862224 05:00:42 INFO - 2015-11-23 05:00:42,370 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1545.1115608525101;1552.9378824847006;1684.5451728033431;1693.449628870616;1958.373320537428;7541.547507149568;7962.1639727828615;7963.362930965523;8537.615807288672;8727.563621818916;8477.78805529862;8534.91465085349;8595.054544000172;8616.870746938801;8626.698065567707;2381.1070848431837;2401.771831675988;2403.4472071423584;2407.2417188585628;2407.6508906208587;2034.725312082872;2414.058517178302;2441.755824417553;2444.3766839455916;2444.5721998650165;2368.846025008369;2388.8327817052814;2390.8924098415528;2393.760623937601;2406.1458182345277;2334.4047267946567;2357.0571771291447;2373.762623737621;2391.5934291170456;2394.9281521554294;2383.380321116505;2400.627902675088;2421.32202983165;2424.3333083402204;2430.4652976345174;8541.487510749375;8566.186212309884;8567.443116197428;8577.228049475514;8584.484930904166;4653.418322709661;4789.664723469358;4809.975950120262;5090.160123579642;5260.158374660036;2948.572456993745;3529.576450825917;3574.5531808523933;3578.1949061461223;3593.838277277529;1046.6598355534406;1055.456439933435;1076.5101878645198;1630.812456567498;1659.0792110378734;11463.713407164803;11548.94225528867;11553.364564948924;11574.247673901169;11582.826257606142;4546.954530454653;4568.5102662314675;4621.491635920046;4634.768261586907;4664.883377915511;9199.218066464291;9211.078892110869;9219.21636660878;9245.029271926485;9247.352685312098;5180.119379705459;5219.060569097599;5219.42586315505;5225.399079105951;5228.2680424740565;4799.544043315879;4816.229403295456;4835.226363781849;4844.370231869834;4860.805567777249;3080.199148221434;3527.5414196154334;3597.4603809428795;3646.106703857572;3655.3420384330543;1135.057901941403;1144.0447226565743;1153.342594721001;1154.2439701995206;1155.5955415604471;1209.5585111434264;1375.1748950629542;1402.0606193850144;1423.6725553122633;1439.7048605035943;8063.395245356622;8066.354691624656;8066.475679080841;8097.311728503143;8111.391645626483;507.6192855358481;512.625783178282;516.1071346570454;517.4902720819989;521.259811068284;5964.940350596438;6048.939510604838;6126.417990290915;6187.133801267826;6197.318294987548;9745.074217949283;10316.742081448025;10428.739281517872;10434.843477347846;10449.216308776871;8821.779455513535;10204.285700001077;10325.108969488556;10556.736081598021;10585.100266477282;6961.79114626562;8158.918410815934;8232.34141268697;8236.588170591447;8242.29940455068;7870.567118808521;7883.093444253984;7895.6052197391045;7922.7227047053075;7933.801654958672;9084.772880678036;9221.17009469151;9283.978762336003;9315.534223288943;9352.953235234052;8259.587020649064;9395.342326037111;9560.904390956;9563.856542151734;9730.513474326113;6929.965350173217;7031.05080814104;7196.316349946746;7477.775666730006;7532.472726909064;8146.389020823343;8175.223353781381;8185.263326300424;8185.427020108774;8187.83624327522;7517.849643007218;7602.543847369176;7649.579273139808;7706.460547761827;7748.690052397841;7402.1857595665515;7428.294312040348;7429.962850185714;7562.054743157106;7599.734009309647;7612.391008719178;7640;7652.80867978305;7653.158152603098;7666.233376662289;6888.552244104118;6907.412869905913;6966.79099627012;6975.511714179958;6976.441884649317;7048.682809273492;7076.186238582629;7103.005579219017;7103.147622285359;7103.680334385069 05:00:42 INFO - 2015-11-23 05:00:42,371 DEBUG : BROWSER_OUTPUT: |4;prototype.html;289.83334582615004;324.60398314056846;334.5032626549573;336.2029949917689;337.6201773005369;6566.901496477557;6739.629320387383;6754.493412994027;6778.45772338213;6810.931890681091;5316;6655.633940133291;6689.063531105649;6692.564983276084;6746.561473504219;4851.757412129397;4901.8039278428905;4968.527989840977;4974.204127339608;4979.327790748239;4926.679765815228;4952.083864485064;4963.156263435207;4971.825986090487;4986.4514903360605;4667.649926255527;4751.762411879409;4787.4440806737775;4885.682430642015;4891.510848915098;4768.785404656799;4779.689320194194;4868.05073010763;4870.975645121752;4880.194767863299;4085.44846445729;4104.076582768883;4111.5477297497255;4122.2579935611575;4133.55325636025;6477.773277935296;6514.990176522647;6522.086907832907;6542.672866356663;6542.803715888531;5559.972200138974;5743.827685169452;5744.650007248293;5746.511546518551;5749.223854779593;7173.959775832527;7173.964130179368;7176.354128128493;7180.712771489134;7182.497225194238;4631.282151266559;4635.6986795858165;4643.767811609439;4657.301404789275;4661.510541393172;7392.260773922619;7482.925170748277;7599.202083781179;7610.961945190294;7629.732959346452;4664.227593514443;4704.835330763407;4705.317728929286;4711.104890070876;4718.88202794926;4543.136804007228;4766.6901651392545;4777.402824646919;4779.71321720691;4784.162771515041;4691.014886873795;5531.3915469298345;5539.19681646159;5566.582506312043;5696.487316141567;7218.819529511699;7248.492605517563;7253.927460725431;7254.1295044593935;7280.3083707047745;1639.8032236131742;1659.1621231278127;1661.8088919774382;1661.8338166183285;1662.6175979524778;1032.5766435761302;1060.109508013257;1065.4299949527121;1068.8877667844765;1074.0172741941037;6593.142891424084;6628.304028076983;6630.104935833697;6634.601923884486;6653.900191497131;7400.814979625552;7417.221191774786;7417.332440080419;7457.515261508093;7461.962690186514;5491;6422.903656445157;6564.4420224281475;6597.175353080865;6614.8346291343105;3926.332523471017;3945.4870866787132;3947.9013024674614;3949.3681011038097;3950.071733142709;7392.482526223221;7401.925980740231;7407.85184296311;7411.370033547101;7412.925870741331;5389.946100538945;7584.924150758532;7602.353799926957;7654.693812247559;7660.770176894702;7367.336939675455;7368.37368823656;7384.593847338556;7386.446016548673;7391.186969433358;7368.742094026683;7379.594122323324;7385.778426647209;7394.55632662042;7400.296971787671;5931.436513531207;7293.598852063187;7420.628968551443;7441.330280274801;7454.254574542502;7527.435442341955;7527.9247207529415;7530.021097257321;7534.397248220239;7537.9623101884135;4643.094596553639;4690.906181876275;4700.952990470051;4702.059588082328;4705.34125222476;5856.443637854397;7284.3664771185895;7331.486795924234;7345.706171753283;7453.552786832807;6571.145751052524;7055.717771289296;7091.716331346688;7098.083517450363;7125.821854453473;6173.629582225081;6825.907854743217;7074.080369551925;7199.568025918462;7206.063211782434;6798.082258894986;7037.929620703728;7041.929580704127;7048.471364647569;7062.540934839219;7217.314355136254;7227.9880816686755;7229;7253.165885923187;7273.309035641606;5610.9158362623775;7022.332878376546;7108.502404831612;7111.502194846311;7128.28717128283 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: |5;yui.html;705.4814711187277;798.0782196562968;811.6915572082607;825.4015838517076;866.33292364879;15034.624134396645;15350.616234594141;15392;15404.845951540481;15431.768523472158;12874.4206510707;14145.575632731008;14251.073680210806;14257.857421425782;14294.428222871098;948.2603569216005;967.3228739882076;968.593190859837;970.3983530211243;973.0561355485167;949.0699114867434;963.9878127965608;964.2623393104245;967.52591230297;968.1431932739541;995.2535598301274;1011.145581983223;1011.1657882247139;1012.0436187802529;1014.4826138669295;998.5007496251874;1001.3691374434133;1002.5338217728719;1002.9548670309854;1005.5927349423495;746.6229554075212;749.5540153608595;749.9550026998343;750.0961341583379;750.5196674128562;13319.134256273408;13512.86487135126;13513.459461621524;13547.390367433489;15508.767368489482;12245;12254.448549815279;12392.070594705434;12412.75174496505;12910.096293259476;10055.748606284827;10196.74508137295;10238.23213259001;10357.171426285879;11124.833127503094;3312.5031245313153;3530.276293359855;3567.233044895334;3695.0023493656563;3797.1076796952693;57658.084150523966;68741;78657.60671196607;78958;84400;9352.906470935204;9376.390534615228;9464.958854525996;9514.28642851789;9597.568109435093;21135.78864211338;21162.470938226666;21185.258515951868;21243.256486023223;21260.681089783666;7104;7279.563226206445;7309.816833106824;7425.665845036986;7502.699892004368;3808.9428658570146;3953.446517487554;3972.443857859902;3977.0057485628595;3989.7606143631474;3473.322702073122;3522.365974124631;3526.118470382404;3527.894163175109;3528.606200550768;621.2513920725515;632.0834789555163;633.7940169444948;652.667139758717;653.1900443450088;438.61840199026415;472.6289862457954;479.71456983095004;506.42014892947367;526.6813577785462;7979.122296547375;8303.211194936472;8354.331653467709;8426.789330266793;8554.61504232311;517.1441264706841;543.3669774712416;591.3377017740158;611.3733423241214;624.4255285137684;3885.475460812754;3997.700172487075;4017.5580686124504;4049.5140583129623;4055.229506393776;99852;100172;100587.99412005933;100889;101232.98767012382;61380.69309653423;80991.54546499999;85987;86646.56676716576;87314;75638;75913.62043189749;76034;76048.85926711104;76270.61864690752;8767.517786521803;8798.164174403422;8805.42764720291;8822.955885220534;9059.90940090617;51973;51986;52221.69445763886;52591;53132;66184;70082.64958675174;74235.8864617042;75818.62090689733;76809;10744.409057501913;10833.620823271147;10869.402182880018;10903;11777.116716246488;9986.300958932805;11994.160408771302;12205.450754715881;12442.191257568229;12743.49026038948;9667.564959576695;11179.10567154642;11214.49534770921;11547.884521155018;11859.229150105215;11133.407209959549;11216.08719866317;11327.603533876274;11334.036606888507;11793.823092653445;11321.264117832314;11359.54561817518;11416.143789216008;11505.884941150482;11657.591984280509;9449.385789923634;9721.805563888824;9816.460094694861;10087.848682269625;10129.544170512198;9635.277354198603;9997.300188986992;10016.39901605906;10024.958196261752;10094.041066098709 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1156 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283642360__endTimestamp 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-23 05:00:42,375 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5915.45 Median:6192.91 stddev:655.75 (10.6%) stddev-sans-first:628.96 05:00:42 INFO - 2015-11-23 05:00:42,376 DEBUG : BROWSER_OUTPUT: Values: 3465.4 3513.1 3552.6 3583.8 3603.0 5590.1 5692.4 6041.0 6048.8 6054.1 5890.1 5936.9 5943.2 6065.1 6070.5 4528.4 5090.9 5348.7 5348.9 5475.2 5420.4 5499.7 5520.1 5529.3 5588.5 5229.1 5336.2 5353.3 5448.8 5452.4 5276.7 5382.8 5394.0 5397.1 5410.4 5343.7 5397.5 5399.8 5407.8 5422.9 5835.4 5878.1 5885.1 5907.6 5921.8 5388.8 6197.8 6287.3 6328.5 6368.4 5415.5 6413.9 6435.8 6442.7 6443.0 6098.6 6154.2 6167.4 6184.8 6188.9 6360.9 6458.6 6473.0 6481.4 6534.5 6378.0 6412.5 6436.0 6436.7 6439.4 6443.0 6448.7 6451.6 6469.7 6474.0 6259.6 6289.0 6350.3 6376.3 6410.1 5383.5 6323.5 6365.6 6367.7 6398.7 5083.9 5131.9 5133.6 5133.6 5137.4 4466.7 4530.0 4538.0 4543.6 4619.1 6068.2 6074.7 6088.8 6092.0 6113.2 6399.3 6421.2 6448.5 6451.5 6487.1 5805.8 5912.6 5917.9 5989.9 6058.3 4768.3 5595.3 5619.8 5623.3 5649.0 6341.7 6395.0 6400.0 6411.9 6413.0 6262.0 6294.5 6376.6 6396.0 6450.6 6369.9 6373.3 6386.9 6393.6 6396.2 6347.7 6369.7 6381.1 6381.6 6384.7 6266.7 6367.0 6368.5 6448.0 6449.2 6225.1 6292.7 6348.7 6366.4 6382.0 6346.8 6353.7 6354.5 6369.9 6370.3 5704.0 6047.8 6096.1 6190.8 6256.0 6192.9 6279.0 6291.4 6343.7 6351.5 6256.3 6258.9 6259.2 6277.2 6287.0 05:00:42 INFO - 2015-11-23 05:00:42,376 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-23 05:00:42,376 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:62591.85 Median:19148.66 stddev:127585.98 (666.3%) stddev-sans-first:127858.92 05:00:42 INFO - 2015-11-23 05:00:42,377 DEBUG : BROWSER_OUTPUT: Values: 574.5 593.7 596.3 607.2 607.8 31534.7 39070.6 39594.4 39599.0 39628.8 42816.0 43250.1 43298.8 43513.0 43556.0 8515.5 8759.2 9539.7 9763.5 9775.1 11659.5 11748.5 11752.0 11754.8 11759.8 11492.5 11573.3 11582.7 11583.2 11589.7 8720.4 8843.3 8848.3 11473.4 11649.7 11429.7 11566.1 11568.6 11569.4 11592.0 40198.6 40566.0 40614.0 40656.0 40780.2 3168.7 3363.0 3407.6 3437.5 3618.3 29152.1 29371.6 29778.6 30004.8 30103.0 2730.0 2802.5 2815.5 2840.2 2859.8 494821.0 495237.0 496157.0 499110.0 503479.0 53766.0 54166.7 54443.5 63070.4 63854.0 70751.6 71398.0 71406.0 71531.6 71569.6 16120.0 16132.4 16293.6 16299.0 16324.7 12431.1 12466.4 12484.7 12485.0 12496.3 18606.1 19292.8 19590.7 19608.7 19615.6 8058.8 9305.4 9318.0 9336.0 9351.5 960.0 994.4 995.9 1120.5 1217.2 29419.4 29647.6 29875.9 29886.4 30060.8 1076.9 1121.5 1225.9 1260.4 1274.8 14965.9 15003.5 15046.3 15248.5 15453.9 532394.0 539610.0 540508.0 540891.3 541232.0 58098.4 58424.7 58547.4 58573.6 58579.0 1444.8 1447.2 1469.4 1482.8 1488.4 27979.0 29204.0 29701.3 29828.9 29912.9 51576.0 51868.0 51911.5 51914.5 52070.0 389545.1 391927.0 392111.0 392143.0 392371.0 28221.3 32480.7 33315.0 33359.7 33404.0 42364.6 43712.1 44023.9 44191.6 44239.9 34859.8 36255.2 37029.6 37118.1 37224.0 30322.0 36419.1 36423.6 36547.8 37421.3 28051.4 35061.1 35287.5 35294.3 35573.3 30141.7 31659.7 32287.4 32882.7 32887.7 24055.6 24381.5 24422.0 24918.4 24989.5 05:00:42 INFO - 2015-11-23 05:00:42,378 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-23 05:00:42,378 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37614.16 Median:366.30 stddev:124847.58 (34083.5%) stddev-sans-first:125166.44 05:00:42 INFO - 2015-11-23 05:00:42,378 DEBUG : BROWSER_OUTPUT: Values: 339.4 364.7 365.2 365.6 367.0 16030.7 16508.7 19495.3 20605.0 21418.5 11802.7 12119.8 12132.3 20885.5 21348.6 5264.6 5392.8 5406.5 5407.7 5411.8 3981.2 4092.6 4099.3 4850.2 5360.2 5951.9 5986.5 5994.9 6000.9 6007.6 5747.5 6475.2 6475.4 6481.0 6483.5 5525.4 5661.9 5675.5 5676.2 5679.2 12930.7 13270.8 13286.3 13361.5 23747.1 2021.0 2064.7 2077.9 2171.0 2257.8 9823.4 9860.8 10211.0 12378.2 13904.9 1709.2 1712.5 1719.5 1741.1 1754.1 93646.0 98645.5 99491.0 99791.0 100508.5 10702.6 10954.5 10974.4 11027.6 11111.4 13139.6 13157.3 13177.0 13254.7 13278.7 8347.0 8474.3 8480.0 8549.1 8550.1 8610.6 8624.8 8643.8 8707.3 8730.9 4320.6 4362.9 4381.7 4408.8 4413.1 1487.5 1539.5 1805.6 1806.0 1813.4 398.8 406.9 829.6 981.4 994.8 11111.9 11624.7 11729.9 11795.5 11816.2 428.4 450.2 452.4 455.6 460.1 5965.7 5999.4 6080.1 6083.9 6096.1 700522.0 737310.0 767094.0 772054.0 812038.0 111140.0 112387.0 113756.0 117497.8 123631.0 474.9 478.3 478.8 478.9 480.0 10440.0 11124.6 11273.6 11278.2 11346.3 45229.8 46249.3 46654.5 46762.8 47024.5 67799.0 67909.7 68136.0 68993.8 71103.0 8416.5 9826.7 10007.3 10013.6 10098.4 11872.5 11948.8 12750.6 19412.8 19669.8 11641.0 15659.8 15975.4 16061.9 16214.3 15256.3 15441.3 15454.1 15868.2 15956.7 13092.5 14965.6 15651.4 16089.4 16349.4 9878.1 9930.4 9953.3 9990.1 9992.2 15173.8 15378.6 15571.8 15724.3 15795.1 05:00:42 INFO - 2015-11-23 05:00:42,378 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-23 05:00:42,378 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5880.83 Median:5226.83 stddev:3096.92 (59.3%) stddev-sans-first:3088.46 05:00:42 INFO - 2015-11-23 05:00:42,379 DEBUG : BROWSER_OUTPUT: Values: 1545.1 1552.9 1684.5 1693.4 1958.4 7541.5 7962.2 7963.4 8537.6 8727.6 8477.8 8534.9 8595.1 8616.9 8626.7 2381.1 2401.8 2403.4 2407.2 2407.7 2034.7 2414.1 2441.8 2444.4 2444.6 2368.8 2388.8 2390.9 2393.8 2406.1 2334.4 2357.1 2373.8 2391.6 2394.9 2383.4 2400.6 2421.3 2424.3 2430.5 8541.5 8566.2 8567.4 8577.2 8584.5 4653.4 4789.7 4810.0 5090.2 5260.2 2948.6 3529.6 3574.6 3578.2 3593.8 1046.7 1055.5 1076.5 1630.8 1659.1 11463.7 11548.9 11553.4 11574.2 11582.8 4547.0 4568.5 4621.5 4634.8 4664.9 9199.2 9211.1 9219.2 9245.0 9247.4 5180.1 5219.1 5219.4 5225.4 5228.3 4799.5 4816.2 4835.2 4844.4 4860.8 3080.2 3527.5 3597.5 3646.1 3655.3 1135.1 1144.0 1153.3 1154.2 1155.6 1209.6 1375.2 1402.1 1423.7 1439.7 8063.4 8066.4 8066.5 8097.3 8111.4 507.6 512.6 516.1 517.5 521.3 5964.9 6048.9 6126.4 6187.1 6197.3 9745.1 10316.7 10428.7 10434.8 10449.2 8821.8 10204.3 10325.1 10556.7 10585.1 6961.8 8158.9 8232.3 8236.6 8242.3 7870.6 7883.1 7895.6 7922.7 7933.8 9084.8 9221.2 9284.0 9315.5 9353.0 8259.6 9395.3 9560.9 9563.9 9730.5 6930.0 7031.1 7196.3 7477.8 7532.5 8146.4 8175.2 8185.3 8185.4 8187.8 7517.8 7602.5 7649.6 7706.5 7748.7 7402.2 7428.3 7430.0 7562.1 7599.7 7612.4 7640.0 7652.8 7653.2 7666.2 6888.6 6907.4 6966.8 6975.5 6976.4 7048.7 7076.2 7103.0 7103.1 7103.7 05:00:42 INFO - 2015-11-23 05:00:42,379 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-23 05:00:42,380 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5791.74 Median:6582.14 stddev:1849.41 (28.1%) stddev-sans-first:1807.91 05:00:42 INFO - 2015-11-23 05:00:42,381 DEBUG : BROWSER_OUTPUT: Values: 289.8 324.6 334.5 336.2 337.6 6566.9 6739.6 6754.5 6778.5 6810.9 5316.0 6655.6 6689.1 6692.6 6746.6 4851.8 4901.8 4968.5 4974.2 4979.3 4926.7 4952.1 4963.2 4971.8 4986.5 4667.6 4751.8 4787.4 4885.7 4891.5 4768.8 4779.7 4868.1 4871.0 4880.2 4085.4 4104.1 4111.5 4122.3 4133.6 6477.8 6515.0 6522.1 6542.7 6542.8 5560.0 5743.8 5744.7 5746.5 5749.2 7174.0 7174.0 7176.4 7180.7 7182.5 4631.3 4635.7 4643.8 4657.3 4661.5 7392.3 7482.9 7599.2 7611.0 7629.7 4664.2 4704.8 4705.3 4711.1 4718.9 4543.1 4766.7 4777.4 4779.7 4784.2 4691.0 5531.4 5539.2 5566.6 5696.5 7218.8 7248.5 7253.9 7254.1 7280.3 1639.8 1659.2 1661.8 1661.8 1662.6 1032.6 1060.1 1065.4 1068.9 1074.0 6593.1 6628.3 6630.1 6634.6 6653.9 7400.8 7417.2 7417.3 7457.5 7462.0 5491.0 6422.9 6564.4 6597.2 6614.8 3926.3 3945.5 3947.9 3949.4 3950.1 7392.5 7401.9 7407.9 7411.4 7412.9 5389.9 7584.9 7602.4 7654.7 7660.8 7367.3 7368.4 7384.6 7386.4 7391.2 7368.7 7379.6 7385.8 7394.6 7400.3 5931.4 7293.6 7420.6 7441.3 7454.3 7527.4 7527.9 7530.0 7534.4 7538.0 4643.1 4690.9 4701.0 4702.1 4705.3 5856.4 7284.4 7331.5 7345.7 7453.6 6571.1 7055.7 7091.7 7098.1 7125.8 6173.6 6825.9 7074.1 7199.6 7206.1 6798.1 7037.9 7041.9 7048.5 7062.5 7217.3 7228.0 7229.0 7253.2 7273.3 5610.9 7022.3 7108.5 7111.5 7128.3 05:00:42 INFO - 2015-11-23 05:00:42,381 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-23 05:00:42,381 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18768.71 Median:455.62 stddev:26875.55 (5898.6%) stddev-sans-first:26916.72 05:00:42 INFO - 2015-11-23 05:00:42,382 DEBUG : BROWSER_OUTPUT: Values: 705.5 798.1 811.7 825.4 866.3 15034.6 15350.6 15392.0 15404.8 15431.8 12874.4 14145.6 14251.1 14257.9 14294.4 948.3 967.3 968.6 970.4 973.1 949.1 964.0 964.3 967.5 968.1 995.3 1011.1 1011.2 1012.0 1014.5 998.5 1001.4 1002.5 1003.0 1005.6 746.6 749.6 750.0 750.1 750.5 13319.1 13512.9 13513.5 13547.4 15508.8 12245.0 12254.4 12392.1 12412.8 12910.1 10055.7 10196.7 10238.2 10357.2 11124.8 3312.5 3530.3 3567.2 3695.0 3797.1 57658.1 68741.0 78657.6 78958.0 84400.0 9352.9 9376.4 9465.0 9514.3 9597.6 21135.8 21162.5 21185.3 21243.3 21260.7 7104.0 7279.6 7309.8 7425.7 7502.7 3808.9 3953.4 3972.4 3977.0 3989.8 3473.3 3522.4 3526.1 3527.9 3528.6 621.3 632.1 633.8 652.7 653.2 438.6 472.6 479.7 506.4 526.7 7979.1 8303.2 8354.3 8426.8 8554.6 517.1 543.4 591.3 611.4 624.4 3885.5 3997.7 4017.6 4049.5 4055.2 99852.0 100172.0 100588.0 100889.0 101233.0 61380.7 80991.5 85987.0 86646.6 87314.0 75638.0 75913.6 76034.0 76048.9 76270.6 8767.5 8798.2 8805.4 8823.0 9059.9 51973.0 51986.0 52221.7 52591.0 53132.0 66184.0 70082.6 74235.9 75818.6 76809.0 10744.4 10833.6 10869.4 10903.0 11777.1 9986.3 11994.2 12205.5 12442.2 12743.5 9667.6 11179.1 11214.5 11547.9 11859.2 11133.4 11216.1 11327.6 11334.0 11793.8 11321.3 11359.5 11416.1 11505.9 11657.6 9449.4 9721.8 9816.5 10087.8 10129.5 9635.3 9997.3 10016.4 10025.0 10094.0 05:00:42 INFO - 2015-11-23 05:00:42,383 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:00:42 INFO - 2015-11-23 05:00:42,383 DEBUG : BROWSER_OUTPUT: 05:00:42 INFO - 2015-11-23 05:00:42,778 INFO : Browser exited with error code: 0 05:00:42 INFO - 2015-11-23 05:00:42,802 INFO : Completed test dromaeo_css (00:18:33) 05:00:42 INFO - 2015-11-23 05:00:42,802 INFO : Starting test kraken 05:00:42 INFO - 2015-11-23 05:00:42,802 DEBUG : operating with platform_type : mac_ 05:00:42 INFO - 2015-11-23 05:00:42,803 INFO : Initialising browser for kraken test... 05:00:42 INFO - 2015-11-23 05:00:42,815 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpu3zymq/profile http://localhost:49266/getInfo.html 05:00:44 INFO - 2015-11-23 05:00:44,853 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:00:44 INFO - 2015-11-23 05:00:44,853 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:00:44 INFO - 2015-11-23 05:00:44,853 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:00:44 INFO - 2015-11-23 05:00:44,853 DEBUG : BROWSER_OUTPUT: __metrics 05:00:44 INFO - 2015-11-23 05:00:44,870 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:00:45 INFO - 2015-11-23 05:00:45,129 DEBUG : BROWSER_OUTPUT: console.error: 05:00:45 INFO - 2015-11-23 05:00:45,129 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 05:00:45 INFO - 2015-11-23 05:00:45,129 DEBUG : BROWSER_OUTPUT: Stack: 05:00:45 INFO - 2015-11-23 05:00:45,130 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 05:00:45 INFO - 2015-11-23 05:00:45,130 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 05:00:45 INFO - 2015-11-23 05:00:45,130 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 05:00:45 INFO - 2015-11-23 05:00:45,130 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 05:00:45 INFO - 2015-11-23 05:00:45,130 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 05:00:45 INFO - 2015-11-23 05:00:45,130 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 05:00:45 INFO - 2015-11-23 05:00:45,130 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 05:00:45 INFO - 2015-11-23 05:00:45,130 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 05:00:45 INFO - 2015-11-23 05:00:45,130 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 05:00:45 INFO - 2015-11-23 05:00:45,130 DEBUG : BROWSER_OUTPUT: 05:00:45 INFO - 2015-11-23 05:00:45,543 INFO : Browser initialized. 05:00:45 INFO - 2015-11-23 05:00:45,543 INFO : Running cycle 1/1 for kraken test... 05:00:45 INFO - 2015-11-23 05:00:45,544 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpu3zymq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:00:57 INFO - 2015-11-23 05:00:57,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 224497664 05:00:57 INFO - 2015-11-23 05:00:57,460 DEBUG : BROWSER_OUTPUT: 05:00:59 INFO - 2015-11-23 05:00:59,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 05:01:00 INFO - 2015-11-23 05:01:00,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 275243008 05:01:00 INFO - 2015-11-23 05:01:00,548 DEBUG : BROWSER_OUTPUT: 05:01:03 INFO - 2015-11-23 05:01:03,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 05:01:03 INFO - 2015-11-23 05:01:03,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 291557376 05:01:03 INFO - 2015-11-23 05:01:03,874 DEBUG : BROWSER_OUTPUT: 05:01:07 INFO - 2015-11-23 05:01:07,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 05:01:07 INFO - 2015-11-23 05:01:07,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 276705280 05:01:07 INFO - 2015-11-23 05:01:07,761 DEBUG : BROWSER_OUTPUT: 05:01:09 INFO - 2015-11-23 05:01:09,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 05:01:10 INFO - 2015-11-23 05:01:10,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 281051136 05:01:10 INFO - 2015-11-23 05:01:10,185 DEBUG : BROWSER_OUTPUT: 05:01:12 INFO - 2015-11-23 05:01:12,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:01:12 INFO - 2015-11-23 05:01:12,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 280772608 05:01:12 INFO - 2015-11-23 05:01:12,765 DEBUG : BROWSER_OUTPUT: 05:01:15 INFO - 2015-11-23 05:01:15,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 05:01:16 INFO - 2015-11-23 05:01:16,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 281174016 05:01:16 INFO - 2015-11-23 05:01:16,010 DEBUG : BROWSER_OUTPUT: 05:01:18 INFO - 2015-11-23 05:01:18,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 05:01:19 INFO - 2015-11-23 05:01:19,454 DEBUG : BROWSER_OUTPUT: RSS: Main: 280363008 05:01:19 INFO - 2015-11-23 05:01:19,455 DEBUG : BROWSER_OUTPUT: 05:01:22 INFO - 2015-11-23 05:01:22,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 05:01:22 INFO - 2015-11-23 05:01:22,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 280125440 05:01:22 INFO - 2015-11-23 05:01:22,700 DEBUG : BROWSER_OUTPUT: 05:01:24 INFO - 2015-11-23 05:01:24,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:01:24 INFO - 2015-11-23 05:01:24,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 313610240 05:01:24 INFO - 2015-11-23 05:01:24,791 DEBUG : BROWSER_OUTPUT: 05:01:26 INFO - 2015-11-23 05:01:26,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:01:27 INFO - 2015-11-23 05:01:27,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 314847232 05:01:27 INFO - 2015-11-23 05:01:27,176 DEBUG : BROWSER_OUTPUT: 05:01:29 INFO - 2015-11-23 05:01:29,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:01:29 INFO - 2015-11-23 05:01:29,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 323325952 05:01:29 INFO - 2015-11-23 05:01:29,783 DEBUG : BROWSER_OUTPUT: 05:01:32 INFO - 2015-11-23 05:01:32,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:01:32 INFO - 2015-11-23 05:01:32,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 325206016 05:01:32 INFO - 2015-11-23 05:01:32,906 DEBUG : BROWSER_OUTPUT: 05:01:35 INFO - 2015-11-23 05:01:35,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:01:35 INFO - 2015-11-23 05:01:35,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 323764224 05:01:35 INFO - 2015-11-23 05:01:35,913 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 05:01:37 INFO - 2015-11-23 05:01:37,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 384118784 05:01:37 INFO - 2015-11-23 05:01:37,818 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;109;102;109;108;108;100;108;111;110 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;140;179;183;127;142;142;145;186;119 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;185;184;182;183;184;185;185;195;261 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |3;audio-fft;62;70;75;73;60;56;57;69;72;54 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;83;120;74;75;75;111;75;74;113 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;86;84;87;85;86;86;86;86;84 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;94;93;96;94;113;150;93;93;93 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;85;87;85;87;87;86;87;86;86;85 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;56;57;54;55;54;54;64;52;53 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;63;64;66;69;68;69;68;69 05:01:37 INFO - 2015-11-23 05:01:37,819 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;81;83;82;83;82;81;83;83;84 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;110;115;110;132;121;107;127;126;121 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;136;136;135;137;124;134;133;133;123 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;64;67;64;65;66;65;65;65;67 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1043 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283697813__endTimestamp 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.20 Median:108.50 stddev:3.49 (3.2%) stddev-sans-first:3.70 05:01:37 INFO - 2015-11-23 05:01:37,820 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 102.0 109.0 108.0 108.0 100.0 108.0 111.0 110.0 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.40 Median:148.00 stddev:23.45 (15.8%) stddev-sans-first:24.88 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: Values: 151.0 140.0 179.0 183.0 127.0 142.0 142.0 145.0 186.0 119.0 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:192.40 Median:185.00 stddev:24.42 (13.2%) stddev-sans-first:25.49 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: Values: 180.0 185.0 184.0 182.0 183.0 184.0 185.0 185.0 195.0 261.0 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.80 Median:69.50 stddev:7.84 (11.3%) stddev-sans-first:8.25 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: Values: 62.0 70.0 75.0 73.0 60.0 56.0 57.0 69.0 72.0 54.0 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.30 Median:75.00 stddev:18.64 (24.8%) stddev-sans-first:19.67 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 120.0 74.0 75.0 75.0 111.0 75.0 74.0 113.0 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,821 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 84.0 87.0 85.0 86.0 86.0 86.0 86.0 84.0 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:101.20 Median:93.00 stddev:18.22 (19.6%) stddev-sans-first:19.08 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 93.0 96.0 94.0 113.0 150.0 93.0 93.0 93.0 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.50 stddev:0.88 (1.0%) stddev-sans-first:0.83 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 85.0 87.0 87.0 86.0 87.0 86.0 86.0 85.0 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:3.34 (6.0%) stddev-sans-first:3.54 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: Values: 56.0 56.0 57.0 54.0 55.0 54.0 54.0 64.0 52.0 53.0 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:68.00 stddev:2.46 (3.6%) stddev-sans-first:2.45 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 63.0 64.0 66.0 69.0 68.0 69.0 68.0 69.0 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,822 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: Values: 83.0 81.0 83.0 82.0 83.0 82.0 81.0 83.0 83.0 84.0 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.00 Median:123.50 stddev:9.10 (7.4%) stddev-sans-first:8.74 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: Values: 131.0 110.0 115.0 110.0 132.0 121.0 107.0 127.0 126.0 121.0 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.60 Median:135.00 stddev:4.97 (3.7%) stddev-sans-first:5.20 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: Values: 135.0 136.0 136.0 135.0 137.0 124.0 134.0 133.0 133.0 123.0 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: Values: 65.0 64.0 67.0 64.0 65.0 66.0 65.0 65.0 65.0 67.0 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:01:37 INFO - 2015-11-23 05:01:37,823 DEBUG : BROWSER_OUTPUT: 05:01:38 INFO - 2015-11-23 05:01:38,425 INFO : Browser exited with error code: 0 05:01:38 INFO - 2015-11-23 05:01:38,471 INFO : Completed test kraken (00:00:55) 05:01:38 INFO - 2015-11-23 05:01:38,471 INFO : Starting test v8_7 05:01:38 INFO - 2015-11-23 05:01:38,471 DEBUG : operating with platform_type : mac_ 05:01:38 INFO - 2015-11-23 05:01:38,471 INFO : Initialising browser for v8_7 test... 05:01:38 INFO - 2015-11-23 05:01:38,484 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpAfO9Ak/profile http://localhost:49266/getInfo.html 05:01:40 INFO - 2015-11-23 05:01:40,468 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:01:40 INFO - 2015-11-23 05:01:40,468 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:01:40 INFO - 2015-11-23 05:01:40,468 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:01:40 INFO - 2015-11-23 05:01:40,468 DEBUG : BROWSER_OUTPUT: __metrics 05:01:40 INFO - 2015-11-23 05:01:40,484 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:01:41 INFO - 2015-11-23 05:01:41,140 INFO : Browser initialized. 05:01:41 INFO - 2015-11-23 05:01:41,140 INFO : Running cycle 1/1 for v8_7 test... 05:01:41 INFO - 2015-11-23 05:01:41,141 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/tmpAfO9Ak/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:01:53 INFO - 2015-11-23 05:01:53,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 226455552 05:01:53 INFO - 2015-11-23 05:01:53,100 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/v8_7/run.html (next: http://localhost:49266/tests/v8_7/run.html) 05:02:14 INFO - 2015-11-23 05:02:14,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 724393984 05:02:14 INFO - 2015-11-23 05:02:14,782 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,782 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:02:14 INFO - 2015-11-23 05:02:14,782 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |0;Richards;146.5630954125751 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;159.9488163787588 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4721.698113207547 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1709.4017094017095 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |5;Earley;814.3322475570033 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |6;Boyer;13400 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |7;RegExp;28444.444444444445 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |8;Splay;606.060606060606 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4509.009009009009 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:02:14 INFO - 2015-11-23 05:02:14,783 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283734780__endTimestamp 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:146.56 Median:146.56 stddev:0.00 (0.0%) 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: Values: 146.6 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:159.95 Median:159.95 stddev:0.00 (0.0%) 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: Values: 159.9 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: Values: 279.7 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,784 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4721.70 Median:4721.70 stddev:0.00 (0.0%) 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: Values: 4721.7 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1709.40 Median:1709.40 stddev:0.00 (0.0%) 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: Values: 1709.4 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:814.33 Median:814.33 stddev:0.00 (0.0%) 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: Values: 814.3 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13400.00 Median:13400.00 stddev:0.00 (0.0%) 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: Values: 13400.0 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28444.44 Median:28444.44 stddev:0.00 (0.0%) 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: Values: 28444.4 05:02:14 INFO - 2015-11-23 05:02:14,785 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,786 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:606.06 Median:606.06 stddev:0.00 (0.0%) 05:02:14 INFO - 2015-11-23 05:02:14,786 DEBUG : BROWSER_OUTPUT: Values: 606.1 05:02:14 INFO - 2015-11-23 05:02:14,786 DEBUG : BROWSER_OUTPUT: 05:02:14 INFO - 2015-11-23 05:02:14,786 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4509.01 Median:4509.01 stddev:0.00 (0.0%) 05:02:14 INFO - 2015-11-23 05:02:14,786 DEBUG : BROWSER_OUTPUT: Values: 4509.0 05:02:14 INFO - 2015-11-23 05:02:14,786 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:02:14 INFO - 2015-11-23 05:02:14,786 DEBUG : BROWSER_OUTPUT: 05:02:15 INFO - 2015-11-23 05:02:15,431 INFO : Browser exited with error code: 0 05:02:15 INFO - 2015-11-23 05:02:15,449 INFO : Completed test v8_7 (00:00:36) 05:02:15 INFO - 2015-11-23 05:02:15,844 INFO : Completed test suite (00:20:06) 05:02:15 INFO - 2015-11-23 05:02:15,845 DEBUG : Working with test: dromaeo_css 05:02:15 INFO - 2015-11-23 05:02:15,845 DEBUG : Generating results file: dromaeo_css 05:02:15 INFO - 2015-11-23 05:02:15,845 DEBUG : Working with test: kraken 05:02:15 INFO - 2015-11-23 05:02:15,845 DEBUG : Generating results file: kraken 05:02:15 INFO - 2015-11-23 05:02:15,846 INFO : javascript benchmark 05:02:15 INFO - 2015-11-23 05:02:15,846 DEBUG : Working with test: v8_7 05:02:15 INFO - 2015-11-23 05:02:15,846 DEBUG : Generating results file: v8_7 05:02:15 INFO - 2015-11-23 05:02:15,846 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:02:16 INFO - 2015-11-23 05:02:16,240 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 05:02:16 INFO - 2015-11-23 05:02:16,240 DEBUG : process_Request line: dromaeo_css 7495.22 graph.html#tests=[[72,1,59]] 05:02:16 INFO - 2015-11-23 05:02:16,240 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:02:16 INFO - 2015-11-23 05:02:16,397 DEBUG : process_Request line: kraken 1399.20 graph.html#tests=[[232,1,59]] 05:02:16 INFO - 2015-11-23 05:02:16,397 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:02:16 INFO - 2015-11-23 05:02:16,523 DEBUG : process_Request line: v8_7 20621.15 graph.html#tests=[[230,1,59]] 05:02:16 INFO - 2015-11-23 05:02:16,524 INFO : javascript benchmark 05:02:16 INFO - 2015-11-23 05:02:16,526 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3465.445528715405, 3513.0865974846533, 3552.5559305086863, 3583.7849729016243, 3602.9551430085276, 5590.133529302954, 5692.37383887773, 6041.033434650451, 6048.8487787805325, 6054.091886217069, 5890.145928840327, 5936.851578710534, 5943.227380440537, 6065.059915713061, 6070.54470914682, 4528.43394575678, 5090.949090509103, 5348.732563371826, 5348.893022139555, 5475.178723191533, 5420.430854760252, 5499.7250137492965, 5520.089185284423, 5529.253550770655, 5588.469095435948, 5229.058769421503, 5336.226247194174, 5353.304070470814, 5448.7548060337185, 5452.4274951130155, 5276.709780962045, 5382.811601593965, 5394.0, 5397.055515284848, 5410.431904649994, 5343.679379237258, 5397.46025397461, 5399.78400863965, 5407.810726624589, 5422.864428389283, 5835.35811060783, 5878.088896221093, 5885.058390657517, 5907.6160049597065, 5921.763129474816, 5388.811391601275, 6197.752089916398, 6287.339829317902, 6328.525360597928, 6368.395002474757, 5415.48552887475, 6413.903791443132, 6435.774747883848, 6442.742290308382, 6443.033544968245, 6098.634081955097, 6154.169187159721, 6167.414095660905, 6184.752609895644, 6188.947878860605, 6360.872782544323, 6458.644774537445, 6473.0, 6481.4166724994975, 6534.477241820643, 6378.043293506012, 6412.5190610704385, 6436.0, 6436.710348034349, 6439.356064393523, 6443.0, 6448.677566121675, 6451.580647257913, 6469.741210351627, 6473.967630161913, 6259.624422534663, 6289.0, 6350.333215012357, 6376.33048529907, 6410.102585638015, 5383.542398896059, 6323.462505686976, 6365.61806291624, 6367.713452894631, 6398.712057957403, 5083.949160508421, 5131.923021154686, 5133.589312854962, 5133.614978876524, 5137.434882162959, 4466.709663871838, 4529.954700452953, 4537.977310113428, 4543.5910768031035, 4619.099275641218, 6068.150458935753, 6074.668631805383, 6088.847778805565, 6092.0, 6113.205283313141, 6399.296077431479, 6421.165248517663, 6448.451881590024, 6451.548391612636, 6487.124238227779, 5805.82582522525, 5912.615679980788, 5917.940820591739, 5989.940100599026, 6058.303295121117, 4768.284757286435, 5595.272614560081, 5619.8033068843215, 5623.297087864017, 5648.9717551412805, 6341.682915854281, 6395.040743888361, 6400.0, 6411.871762564816, 6413.0, 6261.96869015652, 6294.464970477561, 6376.649284289409, 6396.0, 6450.580712253689, 6369.936300636934, 6373.330800265905, 6386.87226255463, 6393.6483493408305, 6396.200474940632, 6347.650879201688, 6369.713362898588, 6381.074744161978, 6381.585196962183, 6384.712687929147, 6266.749330026748, 6366.9681651591445, 6368.522360822864, 6447.967760161169, 6449.161608990801, 6225.097360882737, 6292.653904035139, 6348.682565871781, 6366.363363663597, 6382.042693595998, 6346.809595712136, 6353.7140828661895, 6354.459870911024, 6369.936300636934, 6370.331115232834, 5704.0, 6047.78832740852, 6096.146539484387, 6190.7523699051535, 6255.999040153553, 6192.907106393318, 6278.968605156945, 6291.402316779899, 6343.682815859281, 6351.523635727246, 6256.343083976299, 6258.906116408349, 6259.1550140730415, 6277.2153480814895, 6287.0], "unit": "ms", "name": "dojo.html", "value": 5874.9997061369595}, {"lowerIsBetter": false, "replicates": [574.4714862326662, 593.7120496559171, 596.2755252368372, 607.1924340626965, 607.835884311236, 31534.68465315346, 39070.60929390705, 39594.406083908725, 39599.0, 39628.80185599075, 42816.0, 43250.13499730003, 43298.78350608243, 43513.0, 43556.0, 8515.489070655749, 8759.16787905148, 9539.666111686092, 9763.463009534473, 9775.071368220008, 11659.533618655243, 11748.530058797638, 11752.0, 11754.7649047019, 11759.7648047039, 11492.482838272297, 11573.305601663886, 11582.6525204244, 11583.18917675763, 11589.6523104307, 8720.433171843873, 8843.292536597057, 8848.336374771918, 11473.368964706939, 11649.70875728105, 11429.657110286706, 11566.132540059445, 11568.595099171573, 11569.421528923604, 11592.0, 40198.59801401978, 40565.98585035398, 40614.0, 40656.0, 40780.1843963122, 3168.6672899345467, 3362.96637033629, 3407.6251612322626, 3437.4843773433936, 3618.276344731038, 29152.08479152089, 29371.55942660862, 29778.55332170019, 30004.8499757502, 30103.0, 2730.0, 2802.523570992936, 2815.4650616382824, 2840.1763488588285, 2859.7569206617463, 494821.0, 495236.9999999964, 496157.0, 499110.0, 503479.0, 53766.0, 54166.729166353914, 54443.45556544384, 63070.36929630645, 63854.042189367196, 70751.64624176949, 71398.0, 71406.0, 71531.56936861234, 71569.64215178891, 16120.032798032156, 16132.435364762412, 16293.59266018359, 16299.0, 16324.67350653004, 12431.067669924792, 12466.376681165906, 12484.687882803002, 12485.001199903985, 12496.25022498653, 18606.069696515122, 19292.838619589238, 19590.70613940792, 19608.70586941197, 19615.607687846164, 8058.758237252891, 9305.441673499612, 9318.0, 9336.0, 9351.485668288173, 960.011188475871, 994.3685759542742, 995.9253056020683, 1120.523777394604, 1217.1837708830478, 29419.411611767646, 29647.55528667072, 29875.85062074719, 29886.40227195444, 30060.84969575138, 1076.9299995500267, 1121.4673030310537, 1225.8835410635975, 1260.3887114749339, 1274.75800446761, 14965.925170374296, 15003.474878379422, 15046.306675235597, 15248.466303679317, 15453.922730386275, 532394.0, 539610.0, 540508.0, 540891.2955435198, 541232.0, 58098.419015809304, 58424.707876461194, 58547.41452585505, 58573.60697947671, 58579.0, 1444.7543917534044, 1447.1751101872042, 1469.3828591991603, 1482.762757958743, 1488.4195163886093, 27979.0, 29204.0, 29701.257468563457, 29828.850855745583, 29912.85043574768, 51576.0, 51868.0, 51911.480885190664, 51914.48085519097, 52070.0, 389545.10454895085, 391927.0, 392111.0, 392143.0, 392371.0, 28221.294467638472, 32480.675193247764, 33315.00054998354, 33359.666403336625, 33404.0, 42364.576354236066, 43712.125757484035, 44023.89940251391, 44191.55808441874, 44239.89400264891, 34859.82570087133, 36255.199168132975, 37029.629703702616, 37118.072048199014, 37224.0, 30322.0, 36419.089522762144, 36423.63576364202, 36547.81726091352, 37421.25157496889, 28051.43897122087, 35061.12347191238, 35287.47068793919, 35294.294114118085, 35573.28853422969, 30141.698583014768, 31659.683403165673, 32287.35425291528, 32882.671173288916, 32887.67112328846, 24055.639165412882, 24381.512369752152, 24422.0, 24918.377040573407, 24989.500209995334], "unit": "ms", "name": "ext.html", "value": 20147.600498892818}, {"lowerIsBetter": false, "replicates": [339.44670187594215, 364.7300997262026, 365.1838141753183, 365.55037304115956, 367.04751170711995, 16030.679386412265, 16508.66982660349, 19495.317663881768, 20605.0, 21418.464538386546, 11802.704932376695, 12119.757604847899, 12132.332721700324, 20885.47786305343, 21348.57302853946, 5264.552513036397, 5392.838214853541, 5406.486383793534, 5407.729613519328, 5411.783528658849, 3981.203759248162, 4092.570280120589, 4099.282625540533, 4850.248211527201, 5360.222767698681, 5951.88096238075, 5986.5210783137245, 5994.940050599504, 6000.909986350208, 6007.6395416274945, 5747.540196784247, 6475.190601174853, 6475.384838440341, 6480.9675951620175, 6483.513736469784, 5525.4474552544825, 5661.915071273934, 5675.460831221028, 5676.233708449389, 5679.233303504016, 12930.676733081655, 13270.800937985938, 13286.335683215897, 13361.465541378333, 23747.05011799526, 2020.98989505053, 2064.721262629541, 2077.9272725454534, 2170.9891450542646, 2257.7967982881455, 9823.36148150375, 9860.753481162956, 10210.978902109804, 12378.195417297848, 13904.930475347659, 1709.2052195729045, 1712.477694303237, 1719.5185348102552, 1741.1468380493593, 1754.0528114817982, 93646.0, 98645.50677246568, 99491.0, 99791.0020899789, 100508.49745751297, 10702.625408110678, 10954.452277386099, 10974.396408197626, 11027.61403350879, 11111.444397784317, 13139.60581182547, 13157.342132893316, 13177.0, 13254.73490530184, 13278.66803329905, 8346.958265208636, 8474.322054235647, 8480.024797148284, 8549.145085491526, 8550.144985501525, 8610.612522436506, 8624.784380390414, 8643.78390540229, 8707.259882910024, 8730.912690873138, 4320.632746216606, 4362.934555981663, 4381.67137464685, 4408.801603927831, 4413.117376524708, 1487.4570781664615, 1539.4765779634754, 1805.629845881591, 1805.972910406345, 1813.3925135079633, 398.80259271660134, 406.9369247766601, 829.5686243153526, 981.4454833019321, 994.796066806303, 11111.944440277746, 11624.6512604622, 11729.88270117305, 11795.52817887275, 11816.172867899337, 428.3831282952538, 450.1963994270212, 452.3960512715496, 455.6400443649546, 460.05458782202896, 5965.671888046112, 5999.400059994053, 6080.118382834465, 6083.908741368795, 6096.116063170815, 700522.0, 737310.0, 767094.0, 772054.0, 812038.0, 111140.0, 112387.0, 113756.0, 117497.8250217487, 123631.0, 474.928760685893, 478.33511419126745, 478.79411852903587, 478.8730986288636, 480.00638677937036, 10440.0, 11124.555017799521, 11273.605423810128, 11278.210525263154, 11346.319220846775, 45229.76323788178, 46249.30626040545, 46654.53345466638, 46762.766186168854, 47024.529754702016, 67798.96603101915, 67909.6604516994, 68135.97796033163, 68993.79055884994, 71103.0, 8416.537090460084, 9826.705198844045, 10007.349522281029, 10013.599456021677, 10098.444585547866, 11872.52509899629, 11948.820767688665, 12750.553730619384, 19412.8058719411, 19669.80330196737, 11641.0, 15659.765103523685, 15975.360985560448, 16061.919690401473, 16214.270357834162, 15256.313465894284, 15441.305141268445, 15454.072755634697, 15868.2065896707, 15956.68086638284, 13092.476300947856, 14965.625859353604, 15651.37394504207, 16089.436869709503, 16349.427770027993, 9878.110970012733, 9930.404175749478, 9953.253505986935, 9990.050945160197, 9992.20062394992, 15173.848261517243, 15378.615534611277, 15571.76642350343, 15724.29240684149, 15795.052296862224], "unit": "ms", "name": "jquery.html", "value": 8725.121929524992}, {"lowerIsBetter": false, "replicates": [1545.1115608525101, 1552.9378824847006, 1684.5451728033431, 1693.449628870616, 1958.373320537428, 7541.547507149568, 7962.1639727828615, 7963.362930965523, 8537.615807288672, 8727.563621818916, 8477.78805529862, 8534.91465085349, 8595.054544000172, 8616.870746938801, 8626.698065567707, 2381.1070848431837, 2401.771831675988, 2403.4472071423584, 2407.2417188585628, 2407.6508906208587, 2034.725312082872, 2414.058517178302, 2441.755824417553, 2444.3766839455916, 2444.5721998650165, 2368.846025008369, 2388.8327817052814, 2390.8924098415528, 2393.760623937601, 2406.1458182345277, 2334.4047267946567, 2357.0571771291447, 2373.762623737621, 2391.5934291170456, 2394.9281521554294, 2383.380321116505, 2400.627902675088, 2421.32202983165, 2424.3333083402204, 2430.4652976345174, 8541.487510749375, 8566.186212309884, 8567.443116197428, 8577.228049475514, 8584.484930904166, 4653.418322709661, 4789.664723469358, 4809.975950120262, 5090.160123579642, 5260.158374660036, 2948.572456993745, 3529.576450825917, 3574.5531808523933, 3578.1949061461223, 3593.838277277529, 1046.6598355534406, 1055.456439933435, 1076.5101878645198, 1630.812456567498, 1659.0792110378734, 11463.713407164803, 11548.94225528867, 11553.364564948924, 11574.247673901169, 11582.826257606142, 4546.954530454653, 4568.5102662314675, 4621.491635920046, 4634.768261586907, 4664.883377915511, 9199.218066464291, 9211.078892110869, 9219.21636660878, 9245.029271926485, 9247.352685312098, 5180.119379705459, 5219.060569097599, 5219.42586315505, 5225.399079105951, 5228.2680424740565, 4799.544043315879, 4816.229403295456, 4835.226363781849, 4844.370231869834, 4860.805567777249, 3080.199148221434, 3527.5414196154334, 3597.4603809428795, 3646.106703857572, 3655.3420384330543, 1135.057901941403, 1144.0447226565743, 1153.342594721001, 1154.2439701995206, 1155.5955415604471, 1209.5585111434264, 1375.1748950629542, 1402.0606193850144, 1423.6725553122633, 1439.7048605035943, 8063.395245356622, 8066.354691624656, 8066.475679080841, 8097.311728503143, 8111.391645626483, 507.6192855358481, 512.625783178282, 516.1071346570454, 517.4902720819989, 521.259811068284, 5964.940350596438, 6048.939510604838, 6126.417990290915, 6187.133801267826, 6197.318294987548, 9745.074217949283, 10316.742081448025, 10428.739281517872, 10434.843477347846, 10449.216308776871, 8821.779455513535, 10204.285700001077, 10325.108969488556, 10556.736081598021, 10585.100266477282, 6961.79114626562, 8158.918410815934, 8232.34141268697, 8236.588170591447, 8242.29940455068, 7870.567118808521, 7883.093444253984, 7895.6052197391045, 7922.7227047053075, 7933.801654958672, 9084.772880678036, 9221.17009469151, 9283.978762336003, 9315.534223288943, 9352.953235234052, 8259.587020649064, 9395.342326037111, 9560.904390956, 9563.856542151734, 9730.513474326113, 6929.965350173217, 7031.05080814104, 7196.316349946746, 7477.775666730006, 7532.472726909064, 8146.389020823343, 8175.223353781381, 8185.263326300424, 8185.427020108774, 8187.83624327522, 7517.849643007218, 7602.543847369176, 7649.579273139808, 7706.460547761827, 7748.690052397841, 7402.1857595665515, 7428.294312040348, 7429.962850185714, 7562.054743157106, 7599.734009309647, 7612.391008719178, 7640.0, 7652.80867978305, 7653.158152603098, 7666.233376662289, 6888.552244104118, 6907.412869905913, 6966.79099627012, 6975.511714179958, 6976.441884649317, 7048.682809273492, 7076.186238582629, 7103.005579219017, 7103.147622285359, 7103.680334385069], "unit": "ms", "name": "mootools.html", "value": 4739.682727437287}, {"lowerIsBetter": false, "replicates": [289.83334582615004, 324.60398314056846, 334.5032626549573, 336.2029949917689, 337.6201773005369, 6566.901496477557, 6739.629320387383, 6754.493412994027, 6778.45772338213, 6810.931890681091, 5316.0, 6655.633940133291, 6689.063531105649, 6692.564983276084, 6746.561473504219, 4851.757412129397, 4901.8039278428905, 4968.527989840977, 4974.204127339608, 4979.327790748239, 4926.679765815228, 4952.083864485064, 4963.156263435207, 4971.825986090487, 4986.4514903360605, 4667.649926255527, 4751.762411879409, 4787.4440806737775, 4885.682430642015, 4891.510848915098, 4768.785404656799, 4779.689320194194, 4868.05073010763, 4870.975645121752, 4880.194767863299, 4085.44846445729, 4104.076582768883, 4111.5477297497255, 4122.2579935611575, 4133.55325636025, 6477.773277935296, 6514.990176522647, 6522.086907832907, 6542.672866356663, 6542.803715888531, 5559.972200138974, 5743.827685169452, 5744.650007248293, 5746.511546518551, 5749.223854779593, 7173.959775832527, 7173.964130179368, 7176.354128128493, 7180.712771489134, 7182.497225194238, 4631.282151266559, 4635.6986795858165, 4643.767811609439, 4657.301404789275, 4661.510541393172, 7392.260773922619, 7482.925170748277, 7599.202083781179, 7610.961945190294, 7629.732959346452, 4664.227593514443, 4704.835330763407, 4705.317728929286, 4711.104890070876, 4718.88202794926, 4543.136804007228, 4766.6901651392545, 4777.402824646919, 4779.71321720691, 4784.162771515041, 4691.014886873795, 5531.3915469298345, 5539.19681646159, 5566.582506312043, 5696.487316141567, 7218.819529511699, 7248.492605517563, 7253.927460725431, 7254.1295044593935, 7280.3083707047745, 1639.8032236131742, 1659.1621231278127, 1661.8088919774382, 1661.8338166183285, 1662.6175979524778, 1032.5766435761302, 1060.109508013257, 1065.4299949527121, 1068.8877667844765, 1074.0172741941037, 6593.142891424084, 6628.304028076983, 6630.104935833697, 6634.601923884486, 6653.900191497131, 7400.814979625552, 7417.221191774786, 7417.332440080419, 7457.515261508093, 7461.962690186514, 5491.0, 6422.903656445157, 6564.4420224281475, 6597.175353080865, 6614.8346291343105, 3926.332523471017, 3945.4870866787132, 3947.9013024674614, 3949.3681011038097, 3950.071733142709, 7392.482526223221, 7401.925980740231, 7407.85184296311, 7411.370033547101, 7412.925870741331, 5389.946100538945, 7584.924150758532, 7602.353799926957, 7654.693812247559, 7660.770176894702, 7367.336939675455, 7368.37368823656, 7384.593847338556, 7386.446016548673, 7391.186969433358, 7368.742094026683, 7379.594122323324, 7385.778426647209, 7394.55632662042, 7400.296971787671, 5931.436513531207, 7293.598852063187, 7420.628968551443, 7441.330280274801, 7454.254574542502, 7527.435442341955, 7527.9247207529415, 7530.021097257321, 7534.397248220239, 7537.9623101884135, 4643.094596553639, 4690.906181876275, 4700.952990470051, 4702.059588082328, 4705.34125222476, 5856.443637854397, 7284.3664771185895, 7331.486795924234, 7345.706171753283, 7453.552786832807, 6571.145751052524, 7055.717771289296, 7091.716331346688, 7098.083517450363, 7125.821854453473, 6173.629582225081, 6825.907854743217, 7074.080369551925, 7199.568025918462, 7206.063211782434, 6798.082258894986, 7037.929620703728, 7041.929580704127, 7048.471364647569, 7062.540934839219, 7217.314355136254, 7227.9880816686755, 7229.0, 7253.165885923187, 7273.309035641606, 5610.9158362623775, 7022.332878376546, 7108.502404831612, 7111.502194846311, 7128.28717128283], "unit": "ms", "name": "prototype.html", "value": 5172.419776284407}, {"lowerIsBetter": false, "replicates": [705.4814711187277, 798.0782196562968, 811.6915572082607, 825.4015838517076, 866.33292364879, 15034.624134396645, 15350.616234594141, 15392.0, 15404.845951540481, 15431.768523472158, 12874.4206510707, 14145.575632731008, 14251.073680210806, 14257.857421425782, 14294.428222871098, 948.2603569216005, 967.3228739882076, 968.593190859837, 970.3983530211243, 973.0561355485167, 949.0699114867434, 963.9878127965608, 964.2623393104245, 967.52591230297, 968.1431932739541, 995.2535598301274, 1011.145581983223, 1011.1657882247139, 1012.0436187802529, 1014.4826138669295, 998.5007496251874, 1001.3691374434133, 1002.5338217728719, 1002.9548670309854, 1005.5927349423495, 746.6229554075212, 749.5540153608595, 749.9550026998343, 750.0961341583379, 750.5196674128562, 13319.134256273408, 13512.86487135126, 13513.459461621524, 13547.390367433489, 15508.767368489482, 12245.0, 12254.448549815279, 12392.070594705434, 12412.75174496505, 12910.096293259476, 10055.748606284827, 10196.74508137295, 10238.23213259001, 10357.171426285879, 11124.833127503094, 3312.5031245313153, 3530.276293359855, 3567.233044895334, 3695.0023493656563, 3797.1076796952693, 57658.084150523966, 68741.0, 78657.60671196607, 78958.0, 84400.0, 9352.906470935204, 9376.390534615228, 9464.958854525996, 9514.28642851789, 9597.568109435093, 21135.78864211338, 21162.470938226666, 21185.258515951868, 21243.256486023223, 21260.681089783666, 7104.0, 7279.563226206445, 7309.816833106824, 7425.665845036986, 7502.699892004368, 3808.9428658570146, 3953.446517487554, 3972.443857859902, 3977.0057485628595, 3989.7606143631474, 3473.322702073122, 3522.365974124631, 3526.118470382404, 3527.894163175109, 3528.606200550768, 621.2513920725515, 632.0834789555163, 633.7940169444948, 652.667139758717, 653.1900443450088, 438.61840199026415, 472.6289862457954, 479.71456983095004, 506.42014892947367, 526.6813577785462, 7979.122296547375, 8303.211194936472, 8354.331653467709, 8426.789330266793, 8554.61504232311, 517.1441264706841, 543.3669774712416, 591.3377017740158, 611.3733423241214, 624.4255285137684, 3885.475460812754, 3997.700172487075, 4017.5580686124504, 4049.5140583129623, 4055.229506393776, 99852.0, 100172.0, 100587.99412005933, 100889.0, 101232.98767012382, 61380.69309653423, 80991.54546499999, 85987.0, 86646.56676716576, 87314.0, 75638.0, 75913.62043189749, 76034.0, 76048.85926711104, 76270.61864690752, 8767.517786521803, 8798.164174403422, 8805.42764720291, 8822.955885220534, 9059.90940090617, 51973.0, 51986.0, 52221.69445763886, 52591.0, 53132.0, 66184.0, 70082.64958675174, 74235.8864617042, 75818.62090689733, 76809.0, 10744.409057501913, 10833.620823271147, 10869.402182880018, 10903.0, 11777.116716246488, 9986.300958932805, 11994.160408771302, 12205.450754715881, 12442.191257568229, 12743.49026038948, 9667.564959576695, 11179.10567154642, 11214.49534770921, 11547.884521155018, 11859.229150105215, 11133.407209959549, 11216.08719866317, 11327.603533876274, 11334.036606888507, 11793.823092653445, 11321.264117832314, 11359.54561817518, 11416.143789216008, 11505.884941150482, 11657.591984280509, 9449.385789923634, 9721.805563888824, 9816.460094694861, 10087.848682269625, 10129.544170512198, 9635.277354198603, 9997.300188986992, 10016.39901605906, 10024.958196261752, 10094.041066098709], "unit": "ms", "name": "yui.html", "value": 7002.081836612523}], "name": "dromaeo_css", "value": 7495.225169141719}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [107.0, 109.0, 102.0, 109.0, 108.0, 108.0, 100.0, 108.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 107.2}, {"lowerIsBetter": true, "replicates": [151.0, 140.0, 179.0, 183.0, 127.0, 142.0, 142.0, 145.0, 186.0, 119.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.4}, {"lowerIsBetter": true, "replicates": [180.0, 185.0, 184.0, 182.0, 183.0, 184.0, 185.0, 185.0, 195.0, 261.0], "unit": "ms", "name": "audio-dft", "value": 192.4}, {"lowerIsBetter": true, "replicates": [62.0, 70.0, 75.0, 73.0, 60.0, 56.0, 57.0, 69.0, 72.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 64.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 120.0, 74.0, 75.0, 75.0, 111.0, 75.0, 74.0, 113.0], "unit": "ms", "name": "audio-oscillator", "value": 88.3}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 87.0, 85.0, 86.0, 86.0, 86.0, 86.0, 84.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 85.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 93.0, 96.0, 94.0, 113.0, 150.0, 93.0, 93.0, 93.0], "unit": "ms", "name": "imaging-darkroom", "value": 101.2}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 85.0, 87.0, 87.0, 86.0, 87.0, 86.0, 86.0, 85.0], "unit": "ms", "name": "imaging-desaturate", "value": 86.1}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 54.0, 55.0, 54.0, 54.0, 64.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 63.0, 64.0, 66.0, 69.0, 68.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.4}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 83.0, 82.0, 83.0, 82.0, 81.0, 83.0, 83.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [131.0, 110.0, 115.0, 110.0, 132.0, 121.0, 107.0, 127.0, 126.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.0}, {"lowerIsBetter": true, "replicates": [135.0, 136.0, 136.0, 135.0, 137.0, 124.0, 134.0, 133.0, 133.0, 123.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 132.6}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 67.0, 64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1399.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [146.5630954125751], "unit": "score", "name": "Richards", "value": 240.86554600000005}, {"lowerIsBetter": false, "replicates": [159.9488163787588], "unit": "score", "name": "DeltaBlue", "value": 413.36973600000005}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [4721.698113207547], "unit": "score", "name": "Decrypt", "value": 56.37399800199804}, {"lowerIsBetter": false, "replicates": [1709.4017094017095], "unit": "score", "name": "RayTrace", "value": 432.89356499999985}, {"lowerIsBetter": false, "replicates": [814.3322475570033], "unit": "score", "name": "Earley", "value": 818.4165640000001}, {"lowerIsBetter": false, "replicates": [13400.0], "unit": "score", "name": "Boyer", "value": 49.73604477611944}, {"lowerIsBetter": false, "replicates": [28444.444444444445], "unit": "score", "name": "RegExp", "value": 32.02681640624999}, {"lowerIsBetter": false, "replicates": [606.060606060606], "unit": "score", "name": "Splay", "value": 134.46015000000003}, {"lowerIsBetter": false, "replicates": [4509.009009009009], "unit": "score", "name": "NavierStokes", "value": 329.11888111888123}], "name": "v8_7", "value": 20621.15492513156}]} 05:02:16 INFO - RETURN: dromaeo_css: 7495.22 05:02:16 INFO - RETURN: kraken: 1399.20 05:02:16 INFO - RETURN: v8_7: 20621.15 05:02:16 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,59]]", "result": "20621.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1399.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7495.22"}}} 05:02:16 INFO - Return code: 0 05:02:16 INFO - # TBPL SUCCESS # 05:02:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:02:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:02:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:02:16 INFO - 2015-11-23 05:02:16.612 screenresolution[1683:10004] starting screenresolution argv=screenresolution get 05:02:16 INFO - 2015-11-23 05:02:16.614 screenresolution[1683:10004] Display 0: 1600x1200x32@50 05:02:16 INFO - 2015-11-23 05:02:16.620 screenresolution[1684:10007] starting screenresolution argv=screenresolution list 05:02:16 INFO - Available Modes on Display 0 05:02:16 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 05:02:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:02:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:02:16 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 05:02:16 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 05:02:16 INFO - Graphics/Displays: 05:02:16 INFO - Intel Iris: 05:02:16 INFO - Chipset Model: Intel Iris 05:02:16 INFO - Type: GPU 05:02:16 INFO - Bus: Built-In 05:02:16 INFO - VRAM (Dynamic, Max): 1536 MB 05:02:16 INFO - Vendor: Intel (0x8086) 05:02:16 INFO - Device ID: 0x0a2e 05:02:16 INFO - Revision ID: 0x0009 05:02:16 INFO - Displays: 05:02:16 INFO - Display: 05:02:16 INFO - Resolution: 1600 x 1200 @ 50 Hz 05:02:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:02:16 INFO - Display Serial Number: 1600x1200 50 05:02:16 INFO - Main Display: Yes 05:02:16 INFO - Mirror: Off 05:02:16 INFO - Online: Yes 05:02:16 INFO - Rotation: Supported 05:02:16 INFO - Return code: 0 05:02:16 INFO - Running post-action listener: _resource_record_post_action 05:02:16 INFO - Running post-run listener: _resource_record_post_run 05:02:17 INFO - Total resource usage - Wall time: 1238s; CPU: 52.0%; Read bytes: 39052800; Write bytes: 689767424; Read time: 423; Write time: 2257 05:02:17 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 336898560; Write bytes: 337930240; Read time: 26121; Write time: 650 05:02:17 INFO - run-tests - Wall time: 1209s; CPU: 52.0%; Read bytes: 37291520; Write bytes: 340634624; Read time: 405; Write time: 1572 05:02:17 INFO - Running post-run listener: _upload_blobber_files 05:02:17 INFO - Blob upload gear active. 05:02:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:02:17 INFO - Copying logs to upload dir... 05:02:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.720056 ========= master_lag: 2.51 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-23 05:02:20.452912) ========= ========= Started set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-23 05:02:20.454045) ========= 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.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009419 build_url: 'https://queue.taskcluster.net/v1/task/InJVvDMbT8uk5AZTcJiNsA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 2.30 ========= ========= Finished set props: build_url (results: 0, elapsed: 2 secs) (at 2015-11-23 05:02:22.758727) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:02:22.759039) ========= 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.gXSyEYHd5o/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.JaRQQcOQ0O/Listeners TMPDIR=/var/folders/93/f4rdtxvx5xg5dzcxcm29xd4c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005095 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 05:02:22.798126) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 05:02:22.798417) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 05:02:22.799445) ========= ========= Total master_lag: 4.95 =========