builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0050 starttime: 1448445708.08 results: success (0) buildid: 20151125002040 builduid: e1281c46c6db47c685649e5ab0265ce1 revision: 6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.085350) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.085837) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.086176) ========= 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.48nvdIChh8/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.BFOOaE69MP/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005389 basedir: '/builds/slave/test' ========= master_lag: 0.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.406398) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.406732) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.499470) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.499864) ========= 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.48nvdIChh8/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.BFOOaE69MP/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.042806 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.552438) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.552736) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.553169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.553879) ========= 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.48nvdIChh8/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.BFOOaE69MP/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-25 02:01:48-- 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, 63.245.215.25, ... 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% 1.26G=0s 2015-11-25 02:01:48 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208341 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.772608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.772915) ========= 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.48nvdIChh8/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.BFOOaE69MP/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.180675 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.963679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:48.964098) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.48nvdIChh8/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.BFOOaE69MP/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-25 02:01:49,048 truncating revision to first 12 chars 2015-11-25 02:01:49,048 Setting DEBUG logging. 2015-11-25 02:01:49,048 attempt 1/10 2015-11-25 02:01:49,048 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6ad162acd38b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 02:01:49,324 unpacking tar archive at: mozilla-aurora-6ad162acd38b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529696 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:49.506465) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:49.506814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:49.515037) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:49.515429) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 02:01:49.515913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2015-11-25 02:01:49.516250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.48nvdIChh8/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.BFOOaE69MP/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 02:01:49 INFO - MultiFileLogger online at 20151125 02:01:49 in /builds/slave/test 02:01:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:01:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:01:49 INFO - {'append_to_log': False, 02:01:49 INFO - 'base_work_dir': '/builds/slave/test', 02:01:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:01:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:01:49 INFO - 'branch': 'Mozilla-Aurora', 02:01:49 INFO - 'buildbot_json_path': 'buildprops.json', 02:01:49 INFO - 'config_files': ('talos/mac_config.py',), 02:01:49 INFO - 'default_actions': ('clobber', 02:01:49 INFO - 'read-buildbot-config', 02:01:49 INFO - 'download-and-extract', 02:01:49 INFO - 'populate-webroot', 02:01:49 INFO - 'create-virtualenv', 02:01:49 INFO - 'install', 02:01:49 INFO - 'run-tests'), 02:01:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:01:49 INFO - 'download_minidump_stackwalk': True, 02:01:49 INFO - 'download_symbols': 'ondemand', 02:01:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:01:49 INFO - 'tooltool.py': '/tools/tooltool.py', 02:01:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:01:49 INFO - '/tools/misc-python/virtualenv.py')}, 02:01:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:01:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:01:49 INFO - 'installer_path': 'installer.exe', 02:01:49 INFO - 'log_level': 'info', 02:01:49 INFO - 'log_name': 'talos', 02:01:49 INFO - 'log_to_console': True, 02:01:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:01:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:01:49 INFO - 'opt_config_files': (), 02:01:49 INFO - 'pip_index': False, 02:01:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:49 INFO - 'cmd': ('bash', 02:01:49 INFO - '-c', 02:01:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:49 INFO - 'enabled': True, 02:01:49 INFO - 'halt_on_failure': False, 02:01:49 INFO - 'name': 'check_screen_resolution'},), 02:01:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:49 INFO - 'cmd': ('bash', 02:01:49 INFO - '-c', 02:01:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:49 INFO - 'enabled': True, 02:01:49 INFO - 'halt_on_failure': False, 02:01:49 INFO - 'name': 'check_screen_resolution'},), 02:01:49 INFO - 'run_cmd_checks_enabled': True, 02:01:49 INFO - 'sps_profile': False, 02:01:49 INFO - 'sps_profile_interval': 0, 02:01:49 INFO - 'suite': 'dromaeojs', 02:01:49 INFO - 'system_bits': '64', 02:01:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:01:49 INFO - 'title': 't-yosemite-r5-0050', 02:01:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:01:49 INFO - 'use_talos_json': True, 02:01:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:01:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:01:49 INFO - 'work_dir': 'build'} 02:01:49 INFO - ##### 02:01:49 INFO - ##### Running clobber step. 02:01:49 INFO - ##### 02:01:49 INFO - Running pre-action listener: _resource_record_pre_action 02:01:49 INFO - Running main action method: clobber 02:01:49 INFO - rmtree: /builds/slave/test/build 02:01:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:01:53 INFO - Running post-action listener: _resource_record_post_action 02:01:53 INFO - ##### 02:01:53 INFO - ##### Running read-buildbot-config step. 02:01:53 INFO - ##### 02:01:53 INFO - Running pre-action listener: _resource_record_pre_action 02:01:53 INFO - Running main action method: read_buildbot_config 02:01:53 INFO - Using buildbot properties: 02:01:53 INFO - { 02:01:53 INFO - "properties": { 02:01:53 INFO - "buildnumber": 280, 02:01:53 INFO - "product": "firefox", 02:01:53 INFO - "script_repo_revision": "production", 02:01:53 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:01:53 INFO - "repository": "", 02:01:53 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:01:53 INFO - "buildid": "20151125002040", 02:01:53 INFO - "slavename": "t-yosemite-r5-0050", 02:01:53 INFO - "pgo_build": "False", 02:01:53 INFO - "basedir": "/builds/slave/test", 02:01:53 INFO - "project": "", 02:01:53 INFO - "platform": "yosemite", 02:01:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:01:53 INFO - "slavebuilddir": "test", 02:01:53 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:01:53 INFO - "branch": "mozilla-aurora", 02:01:53 INFO - "repo_path": "releases/mozilla-aurora", 02:01:53 INFO - "stage_platform": "macosx64", 02:01:53 INFO - "builduid": "e1281c46c6db47c685649e5ab0265ce1", 02:01:53 INFO - "revision": "6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d" 02:01:53 INFO - }, 02:01:53 INFO - "sourcestamp": { 02:01:53 INFO - "repository": "", 02:01:53 INFO - "hasPatch": false, 02:01:53 INFO - "project": "", 02:01:53 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:01:53 INFO - "changes": [ 02:01:53 INFO - { 02:01:53 INFO - "category": null, 02:01:53 INFO - "files": [ 02:01:53 INFO - { 02:01:53 INFO - "url": null, 02:01:53 INFO - "name": "https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:01:53 INFO - } 02:01:53 INFO - ], 02:01:53 INFO - "repository": "", 02:01:53 INFO - "rev": "6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d", 02:01:53 INFO - "who": "alessio.placitelli@gmail.com", 02:01:53 INFO - "when": 1448445636, 02:01:53 INFO - "number": 6704813, 02:01:53 INFO - "comments": "Bug 1222054 - Fix broken tests. r=gfritzsche, a=ritu", 02:01:53 INFO - "project": "", 02:01:53 INFO - "at": "Wed 25 Nov 2015 02:00:36", 02:01:53 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:01:53 INFO - "revlink": "", 02:01:53 INFO - "properties": [ 02:01:53 INFO - [ 02:01:53 INFO - "buildid", 02:01:53 INFO - "20151125002040", 02:01:53 INFO - "Change" 02:01:53 INFO - ], 02:01:53 INFO - [ 02:01:53 INFO - "builduid", 02:01:53 INFO - "e1281c46c6db47c685649e5ab0265ce1", 02:01:53 INFO - "Change" 02:01:53 INFO - ], 02:01:53 INFO - [ 02:01:53 INFO - "pgo_build", 02:01:53 INFO - "False", 02:01:53 INFO - "Change" 02:01:53 INFO - ] 02:01:53 INFO - ], 02:01:53 INFO - "revision": "6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d" 02:01:53 INFO - } 02:01:53 INFO - ], 02:01:53 INFO - "revision": "6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d" 02:01:53 INFO - } 02:01:53 INFO - } 02:01:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:01:53 INFO - Running post-action listener: _resource_record_post_action 02:01:53 INFO - ##### 02:01:53 INFO - ##### Running download-and-extract step. 02:01:53 INFO - ##### 02:01:53 INFO - Running pre-action listener: _resource_record_pre_action 02:01:53 INFO - Running main action method: download_and_extract 02:01:53 INFO - mkdir: /builds/slave/test/build/tests 02:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:53 INFO - https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:01:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/test_packages.json 02:01:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/test_packages.json 02:01:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:01:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:02:20 INFO - Downloaded 1149 bytes. 02:02:20 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:02:20 INFO - Using the following test package requirements: 02:02:20 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:02:20 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:02:20 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:02:20 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:02:20 INFO - u'jsshell-mac.zip'], 02:02:20 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:02:20 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:02:20 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:02:20 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:02:20 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:02:20 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:02:20 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:02:20 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:02:20 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:02:20 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:02:20 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:02:20 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:02:20 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:02: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')]} 02:02:20 INFO - https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:02:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:02:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:02:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:02:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:02:22 INFO - Downloaded 17448049 bytes. 02:02:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:02:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:02:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:02:27 INFO - Return code: 0 02:02:27 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:02: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')]} 02:02:27 INFO - https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:02:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:02:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:02:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:02:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:02:30 INFO - Downloaded 17448049 bytes. 02:02:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:02:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:02:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:02:35 INFO - Return code: 0 02:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:35 INFO - https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:02:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:02:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:02:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:02:36 INFO - Downloaded 11131307 bytes. 02:02:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 02:02:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:02:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:02:37 INFO - Return code: 0 02:02: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')]} 02:02:37 INFO - https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 02:02:43 INFO - Downloaded 107810530 bytes. 02:02:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:02:43 INFO - mkdir: /builds/slave/test/properties 02:02:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:02:43 INFO - Writing to file /builds/slave/test/properties/build_url 02:02:43 INFO - Contents: 02:02:43 INFO - build_url:https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:02:43 INFO - Running post-action listener: _resource_record_post_action 02:02:43 INFO - Running post-action listener: set_extra_try_arguments 02:02:43 INFO - ##### 02:02:43 INFO - ##### Running populate-webroot step. 02:02:43 INFO - ##### 02:02:43 INFO - Running pre-action listener: _resource_record_pre_action 02:02:43 INFO - Running main action method: populate_webroot 02:02:43 INFO - Guessing talos json url... 02:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:43 INFO - https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 02:02:43 INFO - Downloaded 107 bytes. 02:02:43 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:02:43 INFO - Contents: 02:02:43 INFO - 20151125002040 02:02:43 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d 02:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:43 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/6ad162acd3/testing/talos/talos.json 02:02:43 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/6ad162acd3/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/6ad162acd3/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:02:44 INFO - Downloaded 4264 bytes. 02:02:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:02:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:02:44 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:02:44 INFO - '../fennec_ids.txt'], 02:02:44 INFO - 'tests': ['tcheck2']}, 02:02:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:02:44 INFO - '--tppagecycles', 02:02:44 INFO - '7'], 02:02:44 INFO - 'tests': ['tsvgm']}}, 02:02:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:02:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:02:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:02:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:02:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:02:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:02:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:44 INFO - 'talos_options': ['--e10s'], 02:02:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:44 INFO - 'tests': ['damp', 'tps']}, 02:02:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:44 INFO - 'talos_options': ['--e10s'], 02:02:44 INFO - 'tests': ['damp', 'tps']}, 02:02:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:02:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:02:44 INFO - 'other': {'tests': ['a11yr', 02:02:44 INFO - 'ts_paint', 02:02:44 INFO - 'tpaint', 02:02:44 INFO - 'sessionrestore', 02:02:44 INFO - 'sessionrestore_no_auto_restore']}, 02:02:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:02:44 INFO - 'tests': ['a11yr', 02:02:44 INFO - 'ts_paint', 02:02:44 INFO - 'tpaint', 02:02:44 INFO - 'sessionrestore', 02:02:44 INFO - 'sessionrestore_no_auto_restore']}, 02:02:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:02:44 INFO - 'tests': ['a11yr', 02:02:44 INFO - 'ts_paint', 02:02:44 INFO - 'tpaint', 02:02:44 INFO - 'sessionrestore', 02:02:44 INFO - 'sessionrestore_no_auto_restore']}, 02:02:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:02:44 INFO - 'tests': ['a11yr', 02:02:44 INFO - 'ts_paint', 02:02:44 INFO - 'tpaint', 02:02:44 INFO - 'sessionrestore', 02:02:44 INFO - 'sessionrestore_no_auto_restore']}, 02:02:44 INFO - 'other_l64': {'tests': ['a11yr', 02:02:44 INFO - 'ts_paint', 02:02:44 INFO - 'tpaint', 02:02:44 INFO - 'sessionrestore', 02:02:44 INFO - 'sessionrestore_no_auto_restore']}, 02:02:44 INFO - 'other_nol64': {'tests': ['a11yr', 02:02:44 INFO - 'ts_paint', 02:02:44 INFO - 'tpaint', 02:02:44 INFO - 'sessionrestore', 02:02:44 INFO - 'sessionrestore_no_auto_restore']}, 02:02:44 INFO - 'svgr': {'tests': ['tsvgx', 02:02:44 INFO - 'tsvgr_opacity', 02:02:44 INFO - 'tart', 02:02:44 INFO - 'tscrollx', 02:02:44 INFO - 'cart']}, 02:02:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:02:44 INFO - 'tests': ['tsvgx', 02:02:44 INFO - 'tsvgr_opacity', 02:02:44 INFO - 'tart', 02:02:44 INFO - 'tscrollx', 02:02:44 INFO - 'cart']}, 02:02:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:44 INFO - 'tests': ['tp5o']}, 02:02:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:44 INFO - 'talos_options': ['--e10s'], 02:02:44 INFO - 'tests': ['tp5o']}, 02:02:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:44 INFO - 'talos_options': ['--xperf_path', 02:02:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:44 INFO - 'tests': ['tp5n']}, 02:02:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:44 INFO - 'talos_options': ['--e10s', 02:02:44 INFO - '--xperf_path', 02:02:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:02:44 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:02:44 INFO - 'tests': ['tp5n']}}, 02:02:44 INFO - 'talos.zip': {'path': '', 02:02:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:02:44 INFO - Running post-action listener: _resource_record_post_action 02:02:44 INFO - ##### 02:02:44 INFO - ##### Running create-virtualenv step. 02:02:44 INFO - ##### 02:02:44 INFO - Running pre-action listener: _resource_record_pre_action 02:02:44 INFO - Running main action method: create_virtualenv 02:02:44 INFO - Creating virtualenv /builds/slave/test/build/venv 02:02:44 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 02:02:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:02:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:02:44 INFO - Using real prefix '/tools/python27' 02:02:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:02:45 INFO - Installing distribute.............................................................................................................................................................................................done. 02:02:49 INFO - Installing pip.................done. 02:02:49 INFO - Return code: 0 02:02:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:49 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 0x10e630a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f875a5026c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5e59f0>, '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 0x10e344cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5af990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/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.BFOOaE69MP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:02:49 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 02:02:49 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 02:02:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/Render', 02:02:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:49 INFO - 'HOME': '/Users/cltbld', 02:02:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:49 INFO - 'LOGNAME': 'cltbld', 02:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:49 INFO - 'MOZ_NO_REMOTE': '1', 02:02:49 INFO - 'NO_EM_RESTART': '1', 02:02:49 INFO - 'PAGER': '/bin/cat', 02:02:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:49 INFO - 'PWD': '/builds/slave/test', 02:02:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:49 INFO - 'SHELL': '/bin/bash', 02:02:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BFOOaE69MP/Listeners', 02:02:49 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 02:02:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:49 INFO - 'USER': 'cltbld', 02:02:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:49 INFO - 'XPC_FLAGS': '0x0', 02:02:49 INFO - 'XPC_SERVICE_NAME': '0', 02:02:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:02:50 INFO - Cleaning up... 02:02:50 INFO - Return code: 0 02:02:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e630a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f875a5026c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5e59f0>, '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 0x10e344cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5af990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/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.BFOOaE69MP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:02:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/Render', 02:02:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:50 INFO - 'HOME': '/Users/cltbld', 02:02:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:50 INFO - 'LOGNAME': 'cltbld', 02:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:50 INFO - 'MOZ_NO_REMOTE': '1', 02:02:50 INFO - 'NO_EM_RESTART': '1', 02:02:50 INFO - 'PAGER': '/bin/cat', 02:02:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:50 INFO - 'PWD': '/builds/slave/test', 02:02:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:50 INFO - 'SHELL': '/bin/bash', 02:02:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BFOOaE69MP/Listeners', 02:02:50 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 02:02:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:50 INFO - 'USER': 'cltbld', 02:02:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:50 INFO - 'XPC_FLAGS': '0x0', 02:02:50 INFO - 'XPC_SERVICE_NAME': '0', 02:02:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:50 INFO - Downloading/unpacking psutil>=0.7.1 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:02:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:02:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:53 INFO - Installing collected packages: psutil 02:02:53 INFO - Running setup.py install for psutil 02:02:53 INFO - building 'psutil._psutil_osx' extension 02:02:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:02:55 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 02:02:55 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 02:02:55 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 02:02:55 INFO - building 'psutil._psutil_posix' extension 02:02:55 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 02:02:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:02:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:02:55 INFO - ^ 02:02:56 INFO - 1 warning generated. 02:02:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:02:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:56 INFO - Successfully installed psutil 02:02:56 INFO - Cleaning up... 02:02:56 INFO - Return code: 0 02:02:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e630a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f875a5026c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5e59f0>, '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 0x10e344cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5af990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/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.BFOOaE69MP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 02:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/Render', 02:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:56 INFO - 'HOME': '/Users/cltbld', 02:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:56 INFO - 'LOGNAME': 'cltbld', 02:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:56 INFO - 'MOZ_NO_REMOTE': '1', 02:02:56 INFO - 'NO_EM_RESTART': '1', 02:02:56 INFO - 'PAGER': '/bin/cat', 02:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:56 INFO - 'PWD': '/builds/slave/test', 02:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:56 INFO - 'SHELL': '/bin/bash', 02:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BFOOaE69MP/Listeners', 02:02:56 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 02:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:56 INFO - 'USER': 'cltbld', 02:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:56 INFO - 'XPC_FLAGS': '0x0', 02:02:56 INFO - 'XPC_SERVICE_NAME': '0', 02:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:02:56 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 02:02:56 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 02:02:56 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 02:02:56 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 02:02:56 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 02:02:56 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 02:02:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:02:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:02:59 INFO - Installing collected packages: mozsystemmonitor 02:02:59 INFO - Running setup.py install for mozsystemmonitor 02:02:59 INFO - Successfully installed mozsystemmonitor 02:02:59 INFO - Cleaning up... 02:02:59 INFO - Return code: 0 02:02:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e630a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f875a5026c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5e59f0>, '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 0x10e344cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5af990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/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.BFOOaE69MP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/Render', 02:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:59 INFO - 'HOME': '/Users/cltbld', 02:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:59 INFO - 'LOGNAME': 'cltbld', 02:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:59 INFO - 'MOZ_NO_REMOTE': '1', 02:02:59 INFO - 'NO_EM_RESTART': '1', 02:02:59 INFO - 'PAGER': '/bin/cat', 02:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:59 INFO - 'PWD': '/builds/slave/test', 02:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:59 INFO - 'SHELL': '/bin/bash', 02:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BFOOaE69MP/Listeners', 02:02:59 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 02:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:59 INFO - 'USER': 'cltbld', 02:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:59 INFO - 'XPC_FLAGS': '0x0', 02:02:59 INFO - 'XPC_SERVICE_NAME': '0', 02:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:59 INFO - Downloading/unpacking blobuploader==1.2.4 02:02:59 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 02:02:59 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 02:02:59 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 02:02:59 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 02:02:59 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 02:02:59 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 02:03:01 INFO - Downloading blobuploader-1.2.4.tar.gz 02:03:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:03:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:03:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:03 INFO - Downloading docopt-0.6.1.tar.gz 02:03:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:03:03 INFO - Installing collected packages: blobuploader, requests, docopt 02:03:03 INFO - Running setup.py install for blobuploader 02:03:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:03:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:03:03 INFO - Running setup.py install for requests 02:03:04 INFO - Running setup.py install for docopt 02:03:04 INFO - Successfully installed blobuploader requests docopt 02:03:04 INFO - Cleaning up... 02:03:04 INFO - Return code: 0 02:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e630a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f875a5026c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5e59f0>, '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 0x10e344cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5af990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/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.BFOOaE69MP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:03:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/Render', 02:03:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:03:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:03:04 INFO - 'HOME': '/Users/cltbld', 02:03:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:03:04 INFO - 'LOGNAME': 'cltbld', 02:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:04 INFO - 'MOZ_NO_REMOTE': '1', 02:03:04 INFO - 'NO_EM_RESTART': '1', 02:03:04 INFO - 'PAGER': '/bin/cat', 02:03:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:04 INFO - 'PWD': '/builds/slave/test', 02:03:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:03:04 INFO - 'SHELL': '/bin/bash', 02:03:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BFOOaE69MP/Listeners', 02:03:04 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 02:03:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:03:04 INFO - 'USER': 'cltbld', 02:03:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:03:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:04 INFO - 'XPC_FLAGS': '0x0', 02:03:04 INFO - 'XPC_SERVICE_NAME': '0', 02:03:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:03:04 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-iirW02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:03:04 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-7JTizA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:03:04 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-XfSZG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:03:04 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-mDqRKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:03:05 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-4rD0A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:03:05 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-KCJxdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:03:05 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-9hpAoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:03:05 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-nanvqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:03:05 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-uLHooF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:03:05 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-hbJbIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:03:05 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-Q5pWW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:03:05 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-FQsrR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:03:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:03:06 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-xvdanO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:03:06 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-YfEhCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:06 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-tcqISD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:03:06 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-yQ3M5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:03:06 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-YZFqbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:03:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:03:06 INFO - Running setup.py install for manifestparser 02:03:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:03:06 INFO - Running setup.py install for mozcrash 02:03:06 INFO - Running setup.py install for mozdebug 02:03:07 INFO - Running setup.py install for mozdevice 02:03:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Running setup.py install for mozfile 02:03:07 INFO - Running setup.py install for mozhttpd 02:03:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Running setup.py install for mozinfo 02:03:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Running setup.py install for mozInstall 02:03:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:03:07 INFO - Running setup.py install for mozleak 02:03:08 INFO - Running setup.py install for mozlog 02:03:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Running setup.py install for moznetwork 02:03:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Running setup.py install for mozprocess 02:03:08 INFO - Running setup.py install for mozprofile 02:03:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Running setup.py install for mozrunner 02:03:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:03:08 INFO - Running setup.py install for mozscreenshot 02:03:09 INFO - Running setup.py install for moztest 02:03:09 INFO - Running setup.py install for mozversion 02:03:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:03:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:03:09 INFO - Cleaning up... 02:03:09 INFO - Return code: 0 02:03:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03: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')]} 02:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03: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')]} 02:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e630a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f875a5026c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5e59f0>, '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 0x10e344cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5af990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/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.BFOOaE69MP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:03:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:03:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/Render', 02:03:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:03:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:03:09 INFO - 'HOME': '/Users/cltbld', 02:03:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:03:09 INFO - 'LOGNAME': 'cltbld', 02:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:09 INFO - 'MOZ_NO_REMOTE': '1', 02:03:09 INFO - 'NO_EM_RESTART': '1', 02:03:09 INFO - 'PAGER': '/bin/cat', 02:03:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:09 INFO - 'PWD': '/builds/slave/test', 02:03:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:03:09 INFO - 'SHELL': '/bin/bash', 02:03:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BFOOaE69MP/Listeners', 02:03:09 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 02:03:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:03:09 INFO - 'USER': 'cltbld', 02:03:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:03:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:09 INFO - 'XPC_FLAGS': '0x0', 02:03:09 INFO - 'XPC_SERVICE_NAME': '0', 02:03:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:03:10 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-cymksx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:03:10 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-1RPhtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:03:10 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-JYgeTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:03:10 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-k5nrFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 02:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:03:10 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-gWtx8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:03:10 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-sJzzQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:03:10 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-9z1N3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 02:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:03:10 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-91ESb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:03:11 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)) 02:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:03:11 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-i3MZ6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:03:11 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)) 02:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:03:11 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-ySrLBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:03:11 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-oDjVMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:03:11 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-YeAB7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:03:11 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-o7rET8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:03:11 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-W390CW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:11 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-7qNfVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:03:11 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-CZGAlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:03:11 INFO - Running setup.py (path:/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/pip-2O2jFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:03:12 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)) 02:03:12 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)) 02:03:12 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)) 02:03:12 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)) 02:03:12 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:03:12 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:03:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:03:12 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 02:03:12 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 02:03:12 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 02:03:12 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 02:03:12 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 02:03:12 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 02:03:14 INFO - Downloading blessings-1.5.1.tar.gz 02:03:14 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 02:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:03:14 INFO - Installing collected packages: blessings 02:03:14 INFO - Running setup.py install for blessings 02:03:14 INFO - Successfully installed blessings 02:03:14 INFO - Cleaning up... 02:03:14 INFO - Return code: 0 02:03:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:03:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:03:15 INFO - Reading from file tmpfile_stdout 02:03:15 INFO - Current package versions: 02:03:15 INFO - blessings == 1.5.1 02:03:15 INFO - blobuploader == 1.2.4 02:03:15 INFO - docopt == 0.6.1 02:03:15 INFO - manifestparser == 1.1 02:03:15 INFO - mozInstall == 1.12 02:03:15 INFO - mozcrash == 0.16 02:03:15 INFO - mozdebug == 0.1 02:03:15 INFO - mozdevice == 0.46 02:03:15 INFO - mozfile == 1.2 02:03:15 INFO - mozhttpd == 0.7 02:03:15 INFO - mozinfo == 0.8 02:03:15 INFO - mozleak == 0.1 02:03:15 INFO - mozlog == 3.0 02:03:15 INFO - moznetwork == 0.27 02:03:15 INFO - mozprocess == 0.22 02:03:15 INFO - mozprofile == 0.27 02:03:15 INFO - mozrunner == 6.11 02:03:15 INFO - mozscreenshot == 0.1 02:03:15 INFO - mozsystemmonitor == 0.0 02:03:15 INFO - moztest == 0.7 02:03:15 INFO - mozversion == 1.4 02:03:15 INFO - psutil == 3.1.1 02:03:15 INFO - requests == 1.2.3 02:03:15 INFO - wsgiref == 0.1.2 02:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:15 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')]} 02:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:15 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')]} 02:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:15 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 0x10e630a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f875a5026c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e5e59f0>, '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 0x10e344cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5af990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/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.BFOOaE69MP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:03:15 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 02:03:15 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 02:03:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/Render', 02:03:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:03:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:03:15 INFO - 'HOME': '/Users/cltbld', 02:03:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:03:15 INFO - 'LOGNAME': 'cltbld', 02:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:15 INFO - 'MOZ_NO_REMOTE': '1', 02:03:15 INFO - 'NO_EM_RESTART': '1', 02:03:15 INFO - 'PAGER': '/bin/cat', 02:03:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:15 INFO - 'PWD': '/builds/slave/test', 02:03:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:03:15 INFO - 'SHELL': '/bin/bash', 02:03:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BFOOaE69MP/Listeners', 02:03:15 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 02:03:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:03:15 INFO - 'USER': 'cltbld', 02:03:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:03:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:15 INFO - 'XPC_FLAGS': '0x0', 02:03:15 INFO - 'XPC_SERVICE_NAME': '0', 02:03:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:03:15 INFO - Cleaning up... 02:03:15 INFO - Return code: 0 02:03:15 INFO - Running post-action listener: _resource_record_post_action 02:03:15 INFO - Running post-action listener: _start_resource_monitoring 02:03:15 INFO - Starting resource monitoring. 02:03:15 INFO - ##### 02:03:15 INFO - ##### Running install step. 02:03:15 INFO - ##### 02:03:15 INFO - Running pre-action listener: _resource_record_pre_action 02:03:15 INFO - Running main action method: install 02:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:03:15 INFO - Reading from file tmpfile_stdout 02:03:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:03:15 INFO - Reading from file tmpfile_stdout 02:03:15 INFO - Output received: 02:03:15 INFO - Usage: mozinstall [options] installer 02:03:15 INFO - Options: 02:03:15 INFO - -h, --help show this help message and exit 02:03:15 INFO - -d DEST, --destination=DEST 02:03:15 INFO - Directory to install application into. [default: 02:03:15 INFO - "/builds/slave/test"] 02:03:15 INFO - --app=APP Application being installed. [default: firefox] 02:03:15 INFO - mkdir: /builds/slave/test/build/application 02:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:03:52 INFO - Reading from file tmpfile_stdout 02:03:52 INFO - Output received: 02:03:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:03:52 INFO - Running post-action listener: _resource_record_post_action 02:03:52 INFO - ##### 02:03:52 INFO - ##### Running run-tests step. 02:03:52 INFO - ##### 02:03:52 INFO - Running pre-action listener: _resource_record_pre_action 02:03:52 INFO - Running main action method: run_tests 02:03:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:03:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:03:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:03:52 INFO - 2015-11-25 02:03:52.585 screenresolution[1618:8043] starting screenresolution argv=screenresolution get 02:03:52 INFO - 2015-11-25 02:03:52.589 screenresolution[1618:8043] Display 0: 1600x1200x32@60 02:03:52 INFO - 2015-11-25 02:03:52.595 screenresolution[1619:8045] starting screenresolution argv=screenresolution list 02:03:52 INFO - Available Modes on Display 0 02:03:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:03:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:03:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:03:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:03:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:03:52 INFO - Intel HD Graphics 3000: 02:03:52 INFO - Chipset Model: Intel HD Graphics 3000 02:03:52 INFO - Type: GPU 02:03:52 INFO - Bus: Built-In 02:03:52 INFO - VRAM (Total): 512 MB 02:03:52 INFO - VRAM (Dynamic, Max): 10 02:03:52 INFO - Vendor: Intel (0x8086) 02:03:52 INFO - Device ID: 0x0116 02:03:52 INFO - Revision ID: 0x0009 02:03:52 INFO - Displays: 02:03:52 INFO - Display: 02:03:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:03:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:03:52 INFO - Display Serial Number: 1600x1200 60 02:03:52 INFO - Main Display: Yes 02:03:52 INFO - Mirror: Off 02:03:52 INFO - Online: Yes 02:03:52 INFO - Rotation: Supported 02:03:52 INFO - Return code: 0 02:03:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:03:52 INFO - Python 2.7.3 02:03:52 INFO - Return code: 0 02:03:52 INFO - grabbing minidump binary from tooltool 02:03:52 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')]} 02:03:52 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 0x10e5e59f0>, '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 0x10e344cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5af990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:03:52 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 02:03:52 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 02:03:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:03:52 INFO - Return code: 0 02:03:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:03:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:03:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:03:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:03:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:03:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0050', '--webServer', 'localhost'] in /builds/slave/test/build 02:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0050 --webServer localhost 02:03:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.48nvdIChh8/Render', 02:03:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:03:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:03:52 INFO - 'HOME': '/Users/cltbld', 02:03:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:03:52 INFO - 'LOGNAME': 'cltbld', 02:03:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:03:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:52 INFO - 'MOZ_NO_REMOTE': '1', 02:03:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:03:52 INFO - 'NO_EM_RESTART': '1', 02:03:52 INFO - 'PAGER': '/bin/cat', 02:03:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:52 INFO - 'PWD': '/builds/slave/test', 02:03:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:03:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:03:52 INFO - 'SHELL': '/bin/bash', 02:03:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BFOOaE69MP/Listeners', 02:03:52 INFO - 'TMPDIR': '/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/', 02:03:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:03:52 INFO - 'USER': 'cltbld', 02:03:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:03:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:52 INFO - 'XPC_FLAGS': '0x0', 02:03:52 INFO - 'XPC_SERVICE_NAME': '0', 02:03:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:03:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0050', '--webServer', 'localhost'] with output_timeout 3600 02:03:53 INFO - mozversion INFO | application_buildid: 20151125002040 02:03:53 INFO - mozversion INFO | application_changeset: 6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d 02:03:53 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:03:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:03:53 INFO - mozversion INFO | application_name: Firefox 02:03:53 INFO - mozversion INFO | application_remotingname: firefox-dev 02:03:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:03:53 INFO - mozversion INFO | application_vendor: Mozilla 02:03:53 INFO - mozversion INFO | application_version: 44.0a2 02:03:53 INFO - mozversion INFO | platform_buildid: 20151125002040 02:03:53 INFO - mozversion INFO | platform_changeset: 6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d 02:03:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:03:53 INFO - mozversion INFO | platform_version: 44.0a2 02:03:53 INFO - 2015-11-25 02:03:53,261 DEBUG : using testdate: 1448445833 02:03:53 INFO - 2015-11-25 02:03:53,261 DEBUG : actual date: 1448445833 02:03:53 INFO - 2015-11-25 02:03:53,272 INFO : starting webserver on 'localhost:49270' 02:03:53 INFO - 2015-11-25 02:03:53,273 INFO : Starting test suite t-yosemite-r5-0050 02:03:53 INFO - 2015-11-25 02:03:53,273 INFO : Starting test dromaeo_css 02:03:53 INFO - 2015-11-25 02:03:53,273 DEBUG : operating with platform_type : mac_ 02:03:53 INFO - 2015-11-25 02:03:53,274 INFO : Initialising browser for dromaeo_css test... 02:03:53 INFO - 2015-11-25 02:03:53,303 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmp_17aGS/profile http://localhost:49270/getInfo.html 02:03:56 INFO - 2015-11-25 02:03:56,208 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:03:56 INFO - 2015-11-25 02:03:56,208 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:03:56 INFO - 2015-11-25 02:03:56,208 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:03:56 INFO - 2015-11-25 02:03:56,208 DEBUG : BROWSER_OUTPUT: __metrics 02:03:56 INFO - 2015-11-25 02:03:56,228 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:03:56 INFO - 2015-11-25 02:03:56,912 INFO : Browser initialized. 02:03:56 INFO - 2015-11-25 02:03:56,912 INFO : Running cycle 1/1 for dromaeo_css test... 02:03:56 INFO - 2015-11-25 02:03:56,912 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmp_17aGS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:04:08 INFO - 2015-11-25 02:04:08,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 199819264 02:04:08 INFO - 2015-11-25 02:04:08,798 DEBUG : BROWSER_OUTPUT: 02:05:00 INFO - 2015-11-25 02:05:00,404 DEBUG : BROWSER_OUTPUT: 1448445900396 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] 02:07:10 INFO - 2015-11-25 02:07:10,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 02:07:12 INFO - 2015-11-25 02:07:12,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 325763072 02:07:12 INFO - 2015-11-25 02:07:12,162 DEBUG : BROWSER_OUTPUT: 02:10:14 INFO - 2015-11-25 02:10:14,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 02:10:15 INFO - 2015-11-25 02:10:15,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 342728704 02:10:15 INFO - 2015-11-25 02:10:15,315 DEBUG : BROWSER_OUTPUT: 02:13:17 INFO - 2015-11-25 02:13:17,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 02:13:17 INFO - 2015-11-25 02:13:17,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 311631872 02:13:17 INFO - 2015-11-25 02:13:17,903 DEBUG : BROWSER_OUTPUT: 02:16:19 INFO - 2015-11-25 02:16:19,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 02:16:20 INFO - 2015-11-25 02:16:20,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 300371968 02:16:20 INFO - 2015-11-25 02:16:20,386 DEBUG : BROWSER_OUTPUT: 02:19:23 INFO - 2015-11-25 02:19:23,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 02:19:24 INFO - 2015-11-25 02:19:24,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 300584960 02:19:24 INFO - 2015-11-25 02:19:24,127 DEBUG : BROWSER_OUTPUT: 02:22:26 INFO - 2015-11-25 02:22:26,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 02:22:27 INFO - 2015-11-25 02:22:27,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 343154688 02:22:27 INFO - 2015-11-25 02:22:27,020 DEBUG : BROWSER_OUTPUT: 02:22:27 INFO - 2015-11-25 02:22:27,020 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:22:27 INFO - 2015-11-25 02:22:27,020 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:22:27 INFO - 2015-11-25 02:22:27,020 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:22:27 INFO - 2015-11-25 02:22:27,021 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:22:27 INFO - 2015-11-25 02:22:27,025 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3170.9207269818257;3279.6720327967223;3280.7867488613224;3282.7537934654906;3297.5878015248095;4874.341963834886;5231.39838918524;5255.1329030709885;5364.490373414529;5411.458854114581;5236.764345604447;5270.446603106676;5326;5366.651167674098;5412.972935135329;4857.9757101214445;4953.6037117030555;4971.825986090496;5043;5150.716710580917;5091.898162036776;5119.923201151985;5147.974260128694;5155.871103222431;5167.224916262553;4992.07646585381;5100.285959965608;5113.488651134894;5114.744262786864;5122.231665250205;4960.975195124038;4996.800127994876;5025.120603894304;5091.592672586185;5174.09453345663;4946;4977.900441991176;4992.925106123411;5023.472535383768;5037.345145131146;5127;5141.511556402136;5269.314989051437;5275.525202731773;5321.414644389114;5563.443655634444;5578.246936663539;5579.8605034874045;5731.455511726379;5759.740811663485;5560;5581;5656.547476201894;5663.631863928831;5668.744906479218;5064.265681476165;5190.091733946544;5219.608529360313;5293.232481290268;5295.708736019517;5810.622309549865;5821.243238378984;5867.119932010232;5950.226470558886;5973.402659733992;5629.4652008059165;5630.8029218977135;5636.351819540805;5640.661560306395;5691.089425691869;5668.093105103164;5777.335606405233;5785.190073389729;5863.5309175265875;5866.6480011199465;5496.697681627549;5599.888002239933;5610.607257492018;5671.234383358276;5728.684922329312;5610.607257492018;5613.494785469327;5678.5741069419955;5690.004249256363;5706.885862282731;4311.698181127291;4355.978220108879;4391.890202744893;4395.912081758347;4413.6248418884115;3896.337622604164;3912.8630497932436;4035.1324465240114;4066.5933406659688;4093.3041382964966;5505.476979686923;5549.278593782782;5577.358603760538;5579.7489112990015;5593.07714227148;5444.8366549003595;5690.9146362804595;5867.061270196748;5958.165856780054;5995.130706047598;5341.732913354317;5365.517103460707;5435.402105768362;5451.236826844245;5466.508014278734;5109.948900510947;5113.769880355393;5116.8209112681625;5134.666246693953;5136.512031357015;5639.041362968387;5785.652860828363;5826;5898;5972.432618901197;5685.0335442973965;5765.336986246635;5773.076307790733;5779.537636988946;5794.536437084938;5700.714964251853;5783.161441590862;5789.710514474344;5801.419858014334;5817.0983497557945;5600.915986260128;5620.606557540933;5702.885942281214;5703.230063941315;5742.942570574241;5727.198192253005;5833.358330583717;5845.09401042839;5862.179294898632;5900.763969441346;5731.684757338219;5786.3056433228285;5786.739596718242;5793.710314484175;5794.159846822272;5444.700541470257;5595.804146854841;5701.486866182064;5739.569532285179;5764.7405866736935;5371.4897084776885;5381.811636592701;5387.407385187548;5494.917576236439;5506.311711036121;5595.412481689526;5601.103823388238;5620.269364982526;5642.943570564242;5701.059325211294;5229.398619158846;5405.378381486179;5486.369067557282;5491.093969494988;5492.313460817398 02:22:27 INFO - 2015-11-25 02:22:27,025 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.0907003444316;563.802669065827;569.4789267819945;571.4456976732567;581.3111462916444;31319.68680313196;32599.837000814994;41496.792516037414;41716.37425438621;41775.37336939948;45365;45439.77280113603;45638.543614563845;45947.310790338175;46158;9236.076392360761;9452.66915657952;9499.952500237488;9520.095590918852;9551.904480955205;9247.39891907024;9329.253659707207;9379.531023448835;9468.715938521855;9470.763230919214;9324.067593240656;9448.385854919408;9449.102335278138;9544.284178686592;9550.904490955105;9214.493202873839;9270.397424167408;9359.719208423792;9383.671571494964;9417.728606638084;8658.264047555902;9241.861372079424;9245.72262832116;9290.02454742249;9340.906590934072;41099.589004109876;41531.377029344585;41639.959001024916;42308.1538369234;42603;2874.4682233786816;2876.5685147227873;2982.5526171074293;3059.4187104450084;3576.9821150894077;28569.57145642817;28913.56629650557;29245.122646320644;29374.853125734448;29597.112086637437;2340.473393486469;2344.2146880794953;2386.5107652931106;2392.97607023931;2500.3874050857476;282812;289492;291504;291509.9999999979;291792;57076.42923570794;57590.7120464395;66194;66361.33638663648;70708.64645676738;66250.66874665595;67476.32523674799;67732;67756.32243677598;68275.3172468279;17753.911230443766;17801.109944502725;17811.821881781274;17848.46454606364;18012.459626211235;12633.684157896127;12638.620841374774;13545.119567228296;13573.59279221625;13811.792823107662;21560.78439215619;21691.783082168975;21770.673439898415;21842;21847.890760546412;8942.776430589287;9180.954095229481;9192.63229470827;9266.397684150643;9283.535823208813;881.5768431152954;939.248601119102;1026.3995562595817;1083.0523292119397;1091;29506.852465737535;30132.84933575318;30229.848850755607;30418.54372184419;30794.53808192879;1037.0770014686934;1070.1278458056659;1085.766560189563;1093.9671809845718;1202.8316035755001;13812;14928.772095567256;15318.157501337311;15318.617034574225;15709.607259818597;366791;370020;372829;373510;374285;50935.23597146046;51590.74204628953;57461.71269143711;59894.10158847621;60517.69741151266;1429.942802287897;1447.7755947828105;1449.239149446528;1463.8755705764916;1480.4152359818027;27961.021364252152;30408.391832163674;31416;32275.838620806746;33773.83113084419;48428.7578562119;49680.25479617881;59546.10680839878;60461.69769151126;60880.391196087476;327200;329269;332441;333165;335448;42978.570214297455;43071;43640.34539481847;44292;45390;46760;46944.530554694014;46965;47370.52629473661;48243;38517.229655406176;39361.40957885577;39436;41141.79429102955;42501.78749106234;37809;38148.42862552001;38148.85553433401;38369.80815095906;38908.221835563694;38396.23207535778;39249;39255.6074439252;39727.60272397355;39910.2017959645;33383.66616333806;34827.82586087155;36335.27329453449;36613.633863662086;36969.44545831761;25556.763441611314;25766.227013189633;26101.477970440104;26156.60765088563;26541.469170616092 02:22:27 INFO - 2015-11-25 02:22:27,029 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.25340517886525;349.15852794764623;356.05645040642287;357.31574035721593;366.5637890909817;14666.706665866703;15300.31148598313;17825.465236042925;18103.366382176628;18460.63078738426;10923.508442120105;11137.05335046522;15145.167015814126;18314.084295785226;18557.07214639266;4386.254336762742;4520.480144783359;4535.931961020588;4554.066416384633;4562.384078149441;3417.333619944112;3539.5044693742766;4464.749870036395;4528.094381123772;4864.708117512961;4853.902921941559;4867.732274724889;4882.072406242803;4895.951040489603;4919.409670839486;4869.269609558559;4889.535494128052;4892.584130348924;4934.654574179809;4976.527229913152;4145.751254924714;4211.557786432411;4223.556526564697;4229.534751177368;4243.236217480852;13335.266560339178;13892.305384730724;14017.229052402114;14030.508932187324;14119.223442710647;1854.8794328368747;1917.2043601905332;1949.9610007799765;2026.695995600657;2115.0693694774404;9716;9733.2213422926;10061.14480269178;10179.54192061359;10276.280660353777;1479.4082367053156;1541.7610270408104;1598.976015359759;1612.4114698135213;1645.5310236582636;56525;56739.43260567383;60484.69757651183;62397.37602623961;63403.68298158526;6552.770653027121;6593.044008618819;6607.867842643121;6618.30507796684;6719.630420326929;7784.883226751604;7841.333486653698;7885.369170466349;7917.524948503108;7919.089304729914;5447.618666693373;5521.641093328921;5562.749676264578;5584.771350302927;5611.270534830446;5695.117256825199;5748.511376532958;5761.510271626875;5765.942340576625;5815.098659707752;2937.706229377045;3040.3463255400197;3090.0575324525785;3100.5659207710937;3112.7042930921525;1026.2303272545591;1070.5075665194097;1091.7052395853075;1125.40916019089;1133.9794185233357;425.20486689889486;437.49032377280747;439.3475688602423;471.3518911496692;486.50133613046205;9729.854052189223;9869.654562090436;10540.894591054144;12046.457909394097;12201.45093470796;431.87475632066975;437.06468158141604;437.50343360285666;448.12839028090053;452.5632764382387;5884.176215329857;5935.881282374328;5978.103284507359;6028.095785632103;6111.938880611226;396236;405567;407900;409549;611550;77180.61409692916;78879;78928;79099;79516.60241698755;461.4854437302384;466.40999136093546;471.3777813286429;476.2974612446683;476.51395576511766;11193.832092518782;11215.158863085138;11249.49377278008;11323.094152467618;11621.477033533341;36547.26905461929;37232.627673724;37413.43879841859;37462.438063428526;37791;51397.74301128471;51590.22614660708;52168.73915630398;52454.21318680146;52853.471465284856;15691.293891775125;15877.603059923595;16296.185190740653;16348.427805027242;16375.508734737978;19166.71249931224;19235.711464327767;19501;19808.801911980696;19870.801291986896;13541.86458135406;13649.454021839016;14534.418623254951;15295.235238237821;15794.68410631758;14953.551393458214;15008.249587520362;15308.234588270765;15763.369465221263;15915.522534323989;12436.626901192978;15438.691226175639;15906.443274485337;16154.1115238663;16256.349746010028;15681.215939203223;15789.605259868595;15907.284172212047;16026.198690065683;16185.190740463166;15738.527844164693;15836.049837009816;16318.428854990017;16331.428400005943;16344.264508096927 02:22:27 INFO - 2015-11-25 02:22:27,030 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1337.8729020743026;1727.473120698187;1823.5167680564653;1860.3674750584798;1879.8402135818455;7358.595277259748;7659.655315510801;7965.243301886311;8038;8134.267915887576;7901.762947111596;7968.083670377909;7996.120426753053;8005.799855003628;8148.674053037887;2140.1439424230275;2143.3784202581232;2143.9249626263086;2163.2753027735725;2174.3803016140405;2256.3005468304796;2265.0713207584895;2355.858648481088;2358.021421110237;2359.3511784259294;2271.602469567819;2281.783230593091;2282.201229569654;2289.3132060381904;2293.392251053472;2273.4316420894775;2306.9307920762403;2325.5581439526436;2331.825113116506;2333.0784340185614;2205.7353117625826;2245.9101635934544;2251.223327951854;2257.4694946687514;2276.3739971507803;6915.204751453547;7183.4612404069385;8010.118886922434;8067.838643227161;8120.75637730869;4777.259524773631;4925.901481970376;4939.2838038484215;4981.601471882241;5009.824656137018;2927.5462303343015;2946.6758656547763;2950.9114726558237;2992.58103865459;2993.3564283679116;907.9909200908038;921.5852866210232;930.3255140023497;940.3276657190141;944.17856464876;10503.789924201474;10568.735781605445;10609;10637.361758294526;10660.360378377321;4246.936295955563;4332.935005974913;4349.543297953733;4360.280553708602;4361.062371590124;9253.629854805868;9281;9322.207612353026;9337.112974267433;9354.438733676001;4816.157172494799;4840.443349014838;4860.708357498562;4897.681650692693;4919.606431485473;4416.447944006999;4421.049474363027;4449.666275029385;4463.531329210451;4473.2842745160615;3637.0907273181706;3683.355412802802;3689;3737.7009839213342;3787.280416720814;1141.646089712192;1145.8796826333282;1149.230015889356;1155.162507182303;1157.774234024374;1238.3684320996356;1257.1765493601706;1262.50762202741;1270.989563297181;1291.2704322058007;7148.249433809479;7179.317964793337;7193.172785129673;7237.276272372826;7247.637618119073;500.4220125754759;508.6134537751262;508.95419412253074;511.2484647568069;514.9691018538899;5398;5455.8090466834265;5459;5513.173024046425;5839.766409343579;8851.424657397249;9144.222741066951;9411.341206115643;9587.472689002032;9688.9031109688;9320.813583728423;9389.248860091177;9395.765105872271;9506.239500839916;9715.854262186072;7525.548467091992;7577.9621101893035;7591.924080759121;7655.617219139132;7682.193369696213;7403.481756277009;7404.370628496638;7406.666699998621;7441.069866266716;7466.701331946879;8584.613692383733;8672.089430609694;8704.216620503932;8738.91261087381;8827.16141966512;8751.081136480832;8867.512286824287;8915.598798053974;8938;9083.318751093826;7173.928260717535;7207.099112610924;7217.566945983258;7220.061392019214;7305.159906610807;7326.157491888288;7333.633318333956;7445.553266804009;7457.888131678138;7469.7385591504035;7322.890156647548;7366.079240094989;7402.222766609429;7485.1017877855;7618.847623047397;7213.314735100157;7273.163586187445;7275.527090739085;7327.303906128909;7356.190819009797;6822.829429264308;6851.520393572402;6918.8616227676175;7016;7403.629818508945;6282.1519094921605;6381.425671689571;6409.359064093554;6427.421532062137;6442.291347951628;6382.138411314413;6503.219613646393;6503.861824180654;6508.869822603616;6514.250861151028 02:22:27 INFO - 2015-11-25 02:22:27,033 DEBUG : BROWSER_OUTPUT: |4;prototype.html;331.1605081119362;341.3071464926199;342.8954168978462;342.94684323929766;347.90258727556295;6014.248218972629;6175;6206.348333424993;6212.037134244194;6266.091416744569;6069.089636554519;6089.756409743605;6138.631682099066;6139.662318572477;6157.230346206724;4862.513748625127;4864.221724524077;4870.391201099863;4870.56164945154;4871.634627402941;4736.029114031632;4788.305695674125;4840.346553215324;4886.755662216875;4932.728699921503;4797.472278049412;4823.951760482403;4831.347768051303;4849.927251091219;4864.270359446076;4749.26386410107;4764.285357196431;4783.497732738082;4805.519448055202;4827.468978412372;3921.8431262749455;4121.567235440266;4153.501579810412;4212.578742125763;4222.662187025031;5857.736401861926;5876.441738034922;5915.231019967419;5949.286085669704;5969.044952807573;5216.530512253916;5224.843254702365;5233.633645644806;5235.869103272411;5239.659422137549;6059.303180134297;6189.102580125901;6291.653959032252;6307.4954003679595;6389.520785941073;4233.386159006957;4276.764777937212;4290.978545107255;4303.634191093761;4371.803268852877;6505.707243174069;6639.468842492589;6645.235797883257;6718.428933540655;6744.966275168642;4327.221100201994;4369.69412141147;4374.58441448062;4417.204903117469;4433.024734558392;4397.626201772821;4446.377507149002;4469.061497085583;4490.820367185276;4520.344550040226;4952.752362381866;5081.136206844845;5111;5187.429382767892;5193;6277.686115694197;6288.276848162428;6343.429091381798;6353.618782873043;6391.328910464427;1592.2834724373847;1604.7191741445433;1606.0765060090496;1608.8310727373691;1613.3788491430885;1024.359775140537;1051.2115913065202;1052.5316234275674;1062.3572738493256;1062.4209805655937;6208.81373558794;6237.064440333896;6278.529110316745;6282.937170628326;6298.401651843067;6562.015697645296;6651.33486651331;6657;6671.132752742113;6798.252192258947;6036.426539478743;6196.1015652731;6207.81376558704;6244.12582238487;6250.781222657185;3658.158623516606;3677.7609455385314;3732.682721968609;3736.7384283100464;3747.2130852521277;6686.09737685416;6758.493113016543;6779.593224406552;6787.762428314985;6790.32096790317;6784.898226526606;6845.418139458102;6858.142732158481;6859.965700171467;6860.245373008965;6746.325367463312;6766.526343156031;6799.456043516606;6800.829979250559;6805.149356330458;6477.384648458389;6508.349165083643;6612.570182938093;6672.699728512326;6744.527883048139;6406.13517175194;6494.318096599789;6527.706253218712;6564.868702625825;6566.671666416564;6631.038499417654;6652.733890644514;6661.400473957173;6717.261101278757;6745.325467453215;4368.868933931987;4475.731456112644;4505.752183629932;4593.26507758757;4602.677812553089;6531.052997315458;6560.212774467094;6566.540342176193;6574.178227721535;6605.9009114864275;6289.811305660837;6351;6351.841203969938;6395.616263024233;6430;6186.0102383618405;6324.177856878577;6330.113784070142;6354.555181137276;6488.610683358825;6359.427651511386;6368.235811702625;6390.073439351361;6392.520560957853;6405.295417503978;6453.225612926479;6472.126262954629;6527.543071985106;6558.573692709959;6571.408573228432;6134.11055396956;6301.6219026858535;6331.651759153291;6342.429181373698;6356.459700925473 02:22:27 INFO - 2015-11-25 02:22:27,034 DEBUG : BROWSER_OUTPUT: |5;yui.html;666.9533132680714;677.7255211639284;760.7945854619253;767.6238643064898;803.4616806739484;12199.695007624814;12389;12410.069244806631;12418.254904705724;12459.439325230363;13557.661058473543;13604.455821767118;13613.795793063113;13615.863841361583;13868;748.8277696129893;752.7591170825339;913.5112714697638;929.944203347798;942.0155937045804;935.4761333653177;938.1416004356006;938.4275591888942;942.6653537994016;947.2374738335672;783.8628240057996;949.738821823997;964.7395203295106;965.5365424596198;970.4662435660393;788.9644965976516;950.1021534649759;979.4710856137677;987.9753006174831;988.5205675247499;730.3645828129561;731.381982225019;733.0909672006727;734.9559026458429;744.1330849560255;14103.294835258195;14130.364133614012;14168;14341.641458963504;14407.351669174912;11706.707332316675;11907;11916.34460104694;11957.940210298893;12094.758104837854;9467;9561.856572151424;9797.755056123582;10401.635942741968;10768.730781730519;3405.7786243894066;3432.63957284484;3434.9484757728655;3556.626554211822;3726.4596633488263;50898;50986.74506627443;51883.74058129685;51926.22110668343;52237.99999999962;9155.176034156957;9508.572114254875;9522.190613797904;9566.426014439156;9608.855867161998;20292.492687682632;20336.69494957577;20343.694844577047;20366.083526241353;20409.69385459219;7151.427885769126;7159.57042577447;7196.208417074117;7574.394048476109;7788.493747906368;3897.6881849451975;3938.3895496198134;3962.881113566598;4005.178938317638;4026.295398305285;3018.215264031324;3095.9226019349244;3098.550710147016;3308.5037244413047;3455.8963231103107;554.5314209492972;562.4235158962015;567.9886402272014;568.7980766827799;569.7834822767405;426.86767102198417;510.0003992175304;528.4583302115362;528.8862894477705;614.7817524778728;7403.444741644291;7426.443016773764;7699.191584883619;7715.652795624211;7860.606969651494;519.9194124910645;538.1792766031755;546.9935319013035;547.9943407129965;603.6378173096107;3687.4284485904727;3907.4724912137067;4052.149048699806;4055.3511438169753;4210.894727631772;61658.38341616616;61960.69019654873;62002.37997619966;62205.37794621996;62950;52093;53717.73141134348;53940.730296348265;53978;54095.18857217145;49472;49797.253041204414;49799.0040199194;49938;50027.499725003014;7996.280334769898;8085.716999904975;8234.670613175645;8599.957000215209;8858.73423797287;33896.830515847265;34647.30705385929;35261.82369088138;36089.458658120675;36503;46695.76652116718;47262;47486;47531.76234118807;48838.26742598935;8022.91977080245;8089.02931648206;8098.190180981855;8162.918370816215;8367.28878045373;11016.449177541252;11246.437678116225;11478.368689721812;11660.12549058807;11786.76426471483;10535.209859260432;10785.730356741144;10835.458227088771;10946.179036572448;11020.614278500214;10406.323588966692;10500.789984200426;10880.945595271973;11060.502277397376;11256.83114753263;9445.96094429626;9730.513474326397;10134.391936483835;10224.948875255874;10664.360138391721;9270.258379329503;9333.953330233306;9383.108604682544;9387.577559009724;9482;8880.067592902653;9048.230900373279;9055.547222638974;9095.909040909506;9172.770680732769 02:22:27 INFO - 2015-11-25 02:22:27,034 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:22:27 INFO - 2015-11-25 02:22:27,034 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:22:27 INFO - 2015-11-25 02:22:27,035 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,897 02:22:27 INFO - 2015-11-25 02:22:27,035 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:22:27 INFO - 2015-11-25 02:22:27,035 DEBUG : BROWSER_OUTPUT: __startTimestamp1448446947019__endTimestamp 02:22:27 INFO - 2015-11-25 02:22:27,035 DEBUG : BROWSER_OUTPUT: 02:22:27 INFO - 2015-11-25 02:22:27,035 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:22:27 INFO - 2015-11-25 02:22:27,035 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:22:27 INFO - 2015-11-25 02:22:27,036 DEBUG : BROWSER_OUTPUT: 02:22:27 INFO - 2015-11-25 02:22:27,036 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5346.37 Median:5505.48 stddev:560.81 (10.2%) stddev-sans-first:535.94 02:22:27 INFO - 2015-11-25 02:22:27,036 DEBUG : BROWSER_OUTPUT: Values: 3170.9 3279.7 3280.8 3282.8 3297.6 4874.3 5231.4 5255.1 5364.5 5411.5 5236.8 5270.4 5326.0 5366.7 5413.0 4858.0 4953.6 4971.8 5043.0 5150.7 5091.9 5119.9 5148.0 5155.9 5167.2 4992.1 5100.3 5113.5 5114.7 5122.2 4961.0 4996.8 5025.1 5091.6 5174.1 4946.0 4977.9 4992.9 5023.5 5037.3 5127.0 5141.5 5269.3 5275.5 5321.4 5563.4 5578.2 5579.9 5731.5 5759.7 5560.0 5581.0 5656.5 5663.6 5668.7 5064.3 5190.1 5219.6 5293.2 5295.7 5810.6 5821.2 5867.1 5950.2 5973.4 5629.5 5630.8 5636.4 5640.7 5691.1 5668.1 5777.3 5785.2 5863.5 5866.6 5496.7 5599.9 5610.6 5671.2 5728.7 5610.6 5613.5 5678.6 5690.0 5706.9 4311.7 4356.0 4391.9 4395.9 4413.6 3896.3 3912.9 4035.1 4066.6 4093.3 5505.5 5549.3 5577.4 5579.7 5593.1 5444.8 5690.9 5867.1 5958.2 5995.1 5341.7 5365.5 5435.4 5451.2 5466.5 5109.9 5113.8 5116.8 5134.7 5136.5 5639.0 5785.7 5826.0 5898.0 5972.4 5685.0 5765.3 5773.1 5779.5 5794.5 5700.7 5783.2 5789.7 5801.4 5817.1 5600.9 5620.6 5702.9 5703.2 5742.9 5727.2 5833.4 5845.1 5862.2 5900.8 5731.7 5786.3 5786.7 5793.7 5794.2 5444.7 5595.8 5701.5 5739.6 5764.7 5371.5 5381.8 5387.4 5494.9 5506.3 5595.4 5601.1 5620.3 5642.9 5701.1 5229.4 5405.4 5486.4 5491.1 5492.3 02:22:27 INFO - 2015-11-25 02:22:27,036 DEBUG : BROWSER_OUTPUT: 02:22:27 INFO - 2015-11-25 02:22:27,036 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51532.66 Median:38712.73 stddev:87088.37 (225.0%) stddev-sans-first:87248.55 02:22:27 INFO - 2015-11-25 02:22:27,037 DEBUG : BROWSER_OUTPUT: Values: 551.1 563.8 569.5 571.4 581.3 31319.7 32599.8 41496.8 41716.4 41775.4 45365.0 45439.8 45638.5 45947.3 46158.0 9236.1 9452.7 9500.0 9520.1 9551.9 9247.4 9329.3 9379.5 9468.7 9470.8 9324.1 9448.4 9449.1 9544.3 9550.9 9214.5 9270.4 9359.7 9383.7 9417.7 8658.3 9241.9 9245.7 9290.0 9340.9 41099.6 41531.4 41640.0 42308.2 42603.0 2874.5 2876.6 2982.6 3059.4 3577.0 28569.6 28913.6 29245.1 29374.9 29597.1 2340.5 2344.2 2386.5 2393.0 2500.4 282812.0 289492.0 291504.0 291510.0 291792.0 57076.4 57590.7 66194.0 66361.3 70708.6 66250.7 67476.3 67732.0 67756.3 68275.3 17753.9 17801.1 17811.8 17848.5 18012.5 12633.7 12638.6 13545.1 13573.6 13811.8 21560.8 21691.8 21770.7 21842.0 21847.9 8942.8 9181.0 9192.6 9266.4 9283.5 881.6 939.2 1026.4 1083.1 1091.0 29506.9 30132.8 30229.8 30418.5 30794.5 1037.1 1070.1 1085.8 1094.0 1202.8 13812.0 14928.8 15318.2 15318.6 15709.6 366791.0 370020.0 372829.0 373510.0 374285.0 50935.2 51590.7 57461.7 59894.1 60517.7 1429.9 1447.8 1449.2 1463.9 1480.4 27961.0 30408.4 31416.0 32275.8 33773.8 48428.8 49680.3 59546.1 60461.7 60880.4 327200.0 329269.0 332441.0 333165.0 335448.0 42978.6 43071.0 43640.3 44292.0 45390.0 46760.0 46944.5 46965.0 47370.5 48243.0 38517.2 39361.4 39436.0 41141.8 42501.8 37809.0 38148.4 38148.9 38369.8 38908.2 38396.2 39249.0 39255.6 39727.6 39910.2 33383.7 34827.8 36335.3 36613.6 36969.4 25556.8 25766.2 26101.5 26156.6 26541.5 02:22:27 INFO - 2015-11-25 02:22:27,038 DEBUG : BROWSER_OUTPUT: 02:22:27 INFO - 2015-11-25 02:22:27,038 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25796.15 Median:37437.94 stddev:74572.37 (199.2%) stddev-sans-first:74757.08 02:22:27 INFO - 2015-11-25 02:22:27,039 DEBUG : BROWSER_OUTPUT: Values: 347.3 349.2 356.1 357.3 366.6 14666.7 15300.3 17825.5 18103.4 18460.6 10923.5 11137.1 15145.2 18314.1 18557.1 4386.3 4520.5 4535.9 4554.1 4562.4 3417.3 3539.5 4464.7 4528.1 4864.7 4853.9 4867.7 4882.1 4896.0 4919.4 4869.3 4889.5 4892.6 4934.7 4976.5 4145.8 4211.6 4223.6 4229.5 4243.2 13335.3 13892.3 14017.2 14030.5 14119.2 1854.9 1917.2 1950.0 2026.7 2115.1 9716.0 9733.2 10061.1 10179.5 10276.3 1479.4 1541.8 1599.0 1612.4 1645.5 56525.0 56739.4 60484.7 62397.4 63403.7 6552.8 6593.0 6607.9 6618.3 6719.6 7784.9 7841.3 7885.4 7917.5 7919.1 5447.6 5521.6 5562.7 5584.8 5611.3 5695.1 5748.5 5761.5 5765.9 5815.1 2937.7 3040.3 3090.1 3100.6 3112.7 1026.2 1070.5 1091.7 1125.4 1134.0 425.2 437.5 439.3 471.4 486.5 9729.9 9869.7 10540.9 12046.5 12201.5 431.9 437.1 437.5 448.1 452.6 5884.2 5935.9 5978.1 6028.1 6111.9 396236.0 405567.0 407900.0 409549.0 611550.0 77180.6 78879.0 78928.0 79099.0 79516.6 461.5 466.4 471.4 476.3 476.5 11193.8 11215.2 11249.5 11323.1 11621.5 36547.3 37232.6 37413.4 37462.4 37791.0 51397.7 51590.2 52168.7 52454.2 52853.5 15691.3 15877.6 16296.2 16348.4 16375.5 19166.7 19235.7 19501.0 19808.8 19870.8 13541.9 13649.5 14534.4 15295.2 15794.7 14953.6 15008.2 15308.2 15763.4 15915.5 12436.6 15438.7 15906.4 16154.1 16256.3 15681.2 15789.6 15907.3 16026.2 16185.2 15738.5 15836.0 16318.4 16331.4 16344.3 02:22:27 INFO - 2015-11-25 02:22:27,039 DEBUG : BROWSER_OUTPUT: 02:22:27 INFO - 2015-11-25 02:22:27,039 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5526.38 Median:6472.76 stddev:2897.78 (44.8%) stddev-sans-first:2888.80 02:22:27 INFO - 2015-11-25 02:22:27,041 DEBUG : BROWSER_OUTPUT: Values: 1337.9 1727.5 1823.5 1860.4 1879.8 7358.6 7659.7 7965.2 8038.0 8134.3 7901.8 7968.1 7996.1 8005.8 8148.7 2140.1 2143.4 2143.9 2163.3 2174.4 2256.3 2265.1 2355.9 2358.0 2359.4 2271.6 2281.8 2282.2 2289.3 2293.4 2273.4 2306.9 2325.6 2331.8 2333.1 2205.7 2245.9 2251.2 2257.5 2276.4 6915.2 7183.5 8010.1 8067.8 8120.8 4777.3 4925.9 4939.3 4981.6 5009.8 2927.5 2946.7 2950.9 2992.6 2993.4 908.0 921.6 930.3 940.3 944.2 10503.8 10568.7 10609.0 10637.4 10660.4 4246.9 4332.9 4349.5 4360.3 4361.1 9253.6 9281.0 9322.2 9337.1 9354.4 4816.2 4840.4 4860.7 4897.7 4919.6 4416.4 4421.0 4449.7 4463.5 4473.3 3637.1 3683.4 3689.0 3737.7 3787.3 1141.6 1145.9 1149.2 1155.2 1157.8 1238.4 1257.2 1262.5 1271.0 1291.3 7148.2 7179.3 7193.2 7237.3 7247.6 500.4 508.6 509.0 511.2 515.0 5398.0 5455.8 5459.0 5513.2 5839.8 8851.4 9144.2 9411.3 9587.5 9688.9 9320.8 9389.2 9395.8 9506.2 9715.9 7525.5 7578.0 7591.9 7655.6 7682.2 7403.5 7404.4 7406.7 7441.1 7466.7 8584.6 8672.1 8704.2 8738.9 8827.2 8751.1 8867.5 8915.6 8938.0 9083.3 7173.9 7207.1 7217.6 7220.1 7305.2 7326.2 7333.6 7445.6 7457.9 7469.7 7322.9 7366.1 7402.2 7485.1 7618.8 7213.3 7273.2 7275.5 7327.3 7356.2 6822.8 6851.5 6918.9 7016.0 7403.6 6282.2 6381.4 6409.4 6427.4 6442.3 6382.1 6503.2 6503.9 6508.9 6514.3 02:22:27 INFO - 2015-11-25 02:22:27,041 DEBUG : BROWSER_OUTPUT: 02:22:27 INFO - 2015-11-25 02:22:27,041 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5370.63 Median:6187.56 stddev:1608.83 (26.0%) stddev-sans-first:1568.25 02:22:27 INFO - 2015-11-25 02:22:27,043 DEBUG : BROWSER_OUTPUT: Values: 331.2 341.3 342.9 342.9 347.9 6014.2 6175.0 6206.3 6212.0 6266.1 6069.1 6089.8 6138.6 6139.7 6157.2 4862.5 4864.2 4870.4 4870.6 4871.6 4736.0 4788.3 4840.3 4886.8 4932.7 4797.5 4824.0 4831.3 4849.9 4864.3 4749.3 4764.3 4783.5 4805.5 4827.5 3921.8 4121.6 4153.5 4212.6 4222.7 5857.7 5876.4 5915.2 5949.3 5969.0 5216.5 5224.8 5233.6 5235.9 5239.7 6059.3 6189.1 6291.7 6307.5 6389.5 4233.4 4276.8 4291.0 4303.6 4371.8 6505.7 6639.5 6645.2 6718.4 6745.0 4327.2 4369.7 4374.6 4417.2 4433.0 4397.6 4446.4 4469.1 4490.8 4520.3 4952.8 5081.1 5111.0 5187.4 5193.0 6277.7 6288.3 6343.4 6353.6 6391.3 1592.3 1604.7 1606.1 1608.8 1613.4 1024.4 1051.2 1052.5 1062.4 1062.4 6208.8 6237.1 6278.5 6282.9 6298.4 6562.0 6651.3 6657.0 6671.1 6798.3 6036.4 6196.1 6207.8 6244.1 6250.8 3658.2 3677.8 3732.7 3736.7 3747.2 6686.1 6758.5 6779.6 6787.8 6790.3 6784.9 6845.4 6858.1 6860.0 6860.2 6746.3 6766.5 6799.5 6800.8 6805.1 6477.4 6508.3 6612.6 6672.7 6744.5 6406.1 6494.3 6527.7 6564.9 6566.7 6631.0 6652.7 6661.4 6717.3 6745.3 4368.9 4475.7 4505.8 4593.3 4602.7 6531.1 6560.2 6566.5 6574.2 6605.9 6289.8 6351.0 6351.8 6395.6 6430.0 6186.0 6324.2 6330.1 6354.6 6488.6 6359.4 6368.2 6390.1 6392.5 6405.3 6453.2 6472.1 6527.5 6558.6 6571.4 6134.1 6301.6 6331.7 6342.4 6356.5 02:22:27 INFO - 2015-11-25 02:22:27,043 DEBUG : BROWSER_OUTPUT: 02:22:27 INFO - 2015-11-25 02:22:27,043 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14067.28 Median:27123.31 stddev:17119.67 (63.1%) stddev-sans-first:17138.12 02:22:27 INFO - 2015-11-25 02:22:27,043 DEBUG : BROWSER_OUTPUT: Values: 667.0 677.7 760.8 767.6 803.5 12199.7 12389.0 12410.1 12418.3 12459.4 13557.7 13604.5 13613.8 13615.9 13868.0 748.8 752.8 913.5 929.9 942.0 935.5 938.1 938.4 942.7 947.2 783.9 949.7 964.7 965.5 970.5 789.0 950.1 979.5 988.0 988.5 730.4 731.4 733.1 735.0 744.1 14103.3 14130.4 14168.0 14341.6 14407.4 11706.7 11907.0 11916.3 11957.9 12094.8 9467.0 9561.9 9797.8 10401.6 10768.7 3405.8 3432.6 3434.9 3556.6 3726.5 50898.0 50986.7 51883.7 51926.2 52238.0 9155.2 9508.6 9522.2 9566.4 9608.9 20292.5 20336.7 20343.7 20366.1 20409.7 7151.4 7159.6 7196.2 7574.4 7788.5 3897.7 3938.4 3962.9 4005.2 4026.3 3018.2 3095.9 3098.6 3308.5 3455.9 554.5 562.4 568.0 568.8 569.8 426.9 510.0 528.5 528.9 614.8 7403.4 7426.4 7699.2 7715.7 7860.6 519.9 538.2 547.0 548.0 603.6 3687.4 3907.5 4052.1 4055.4 4210.9 61658.4 61960.7 62002.4 62205.4 62950.0 52093.0 53717.7 53940.7 53978.0 54095.2 49472.0 49797.3 49799.0 49938.0 50027.5 7996.3 8085.7 8234.7 8600.0 8858.7 33896.8 34647.3 35261.8 36089.5 36503.0 46695.8 47262.0 47486.0 47531.8 48838.3 8022.9 8089.0 8098.2 8162.9 8367.3 11016.4 11246.4 11478.4 11660.1 11786.8 10535.2 10785.7 10835.5 10946.2 11020.6 10406.3 10500.8 10880.9 11060.5 11256.8 9446.0 9730.5 10134.4 10224.9 10664.4 9270.3 9334.0 9383.1 9387.6 9482.0 8880.1 9048.2 9055.5 9095.9 9172.8 02:22:27 INFO - 2015-11-25 02:22:27,043 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:22:27 INFO - 2015-11-25 02:22:27,043 DEBUG : BROWSER_OUTPUT: 02:22:27 INFO - 2015-11-25 02:22:27,461 INFO : Browser exited with error code: 0 02:22:27 INFO - 2015-11-25 02:22:27,488 INFO : Completed test dromaeo_css (00:18:34) 02:22:27 INFO - 2015-11-25 02:22:27,489 INFO : Starting test kraken 02:22:27 INFO - 2015-11-25 02:22:27,489 DEBUG : operating with platform_type : mac_ 02:22:27 INFO - 2015-11-25 02:22:27,489 INFO : Initialising browser for kraken test... 02:22:27 INFO - 2015-11-25 02:22:27,502 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpfds7No/profile http://localhost:49270/getInfo.html 02:22:29 INFO - 2015-11-25 02:22:29,661 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:22:29 INFO - 2015-11-25 02:22:29,661 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:22:29 INFO - 2015-11-25 02:22:29,661 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:22:29 INFO - 2015-11-25 02:22:29,661 DEBUG : BROWSER_OUTPUT: __metrics 02:22:29 INFO - 2015-11-25 02:22:29,678 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:22:30 INFO - 2015-11-25 02:22:30,338 INFO : Browser initialized. 02:22:30 INFO - 2015-11-25 02:22:30,339 INFO : Running cycle 1/1 for kraken test... 02:22:30 INFO - 2015-11-25 02:22:30,339 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpfds7No/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:22:42 INFO - 2015-11-25 02:22:42,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 198914048 02:22:42 INFO - 2015-11-25 02:22:42,168 DEBUG : BROWSER_OUTPUT: 02:22:44 INFO - 2015-11-25 02:22:44,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 02:22:45 INFO - 2015-11-25 02:22:45,340 DEBUG : BROWSER_OUTPUT: RSS: Main: 265699328 02:22:45 INFO - 2015-11-25 02:22:45,340 DEBUG : BROWSER_OUTPUT: 02:22:47 INFO - 2015-11-25 02:22:47,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 02:22:48 INFO - 2015-11-25 02:22:48,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 277876736 02:22:48 INFO - 2015-11-25 02:22:48,539 DEBUG : BROWSER_OUTPUT: 02:22:51 INFO - 2015-11-25 02:22:51,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 02:22:51 INFO - 2015-11-25 02:22:51,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 268488704 02:22:51 INFO - 2015-11-25 02:22:51,958 DEBUG : BROWSER_OUTPUT: 02:22:53 INFO - 2015-11-25 02:22:53,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 02:22:54 INFO - 2015-11-25 02:22:54,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 268955648 02:22:54 INFO - 2015-11-25 02:22:54,576 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-25 02:22:56,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:22:57 INFO - 2015-11-25 02:22:57,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 269594624 02:22:57 INFO - 2015-11-25 02:22:57,335 DEBUG : BROWSER_OUTPUT: 02:23:00 INFO - 2015-11-25 02:23:00,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 02:23:00 INFO - 2015-11-25 02:23:00,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 268791808 02:23:00 INFO - 2015-11-25 02:23:00,946 DEBUG : BROWSER_OUTPUT: 02:23:04 INFO - 2015-11-25 02:23:04,064 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 02:23:04 INFO - 2015-11-25 02:23:04,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 270393344 02:23:04 INFO - 2015-11-25 02:23:04,647 DEBUG : BROWSER_OUTPUT: 02:23:07 INFO - 2015-11-25 02:23:07,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 02:23:08 INFO - 2015-11-25 02:23:08,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 269488128 02:23:08 INFO - 2015-11-25 02:23:08,084 DEBUG : BROWSER_OUTPUT: 02:23:09 INFO - 2015-11-25 02:23:09,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:23:10 INFO - 2015-11-25 02:23:10,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 301232128 02:23:10 INFO - 2015-11-25 02:23:10,262 DEBUG : BROWSER_OUTPUT: 02:23:12 INFO - 2015-11-25 02:23:12,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:23:12 INFO - 2015-11-25 02:23:12,685 DEBUG : BROWSER_OUTPUT: RSS: Main: 302043136 02:23:12 INFO - 2015-11-25 02:23:12,686 DEBUG : BROWSER_OUTPUT: 02:23:14 INFO - 2015-11-25 02:23:14,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:23:15 INFO - 2015-11-25 02:23:15,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 308101120 02:23:15 INFO - 2015-11-25 02:23:15,303 DEBUG : BROWSER_OUTPUT: 02:23:17 INFO - 2015-11-25 02:23:17,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:23:18 INFO - 2015-11-25 02:23:18,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 311496704 02:23:18 INFO - 2015-11-25 02:23:18,396 DEBUG : BROWSER_OUTPUT: 02:23:20 INFO - 2015-11-25 02:23:20,929 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:23:21 INFO - 2015-11-25 02:23:21,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 310046720 02:23:21 INFO - 2015-11-25 02:23:21,508 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 02:23:23 INFO - 2015-11-25 02:23:23,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 368836608 02:23:23 INFO - 2015-11-25 02:23:23,486 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,486 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:23:23 INFO - 2015-11-25 02:23:23,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:23:23 INFO - 2015-11-25 02:23:23,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:23:23 INFO - 2015-11-25 02:23:23,487 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:23:23 INFO - 2015-11-25 02:23:23,487 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;105;106;107;110;111;116;112;108;108 02:23:23 INFO - 2015-11-25 02:23:23,487 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;127;169;149;124;146;129;155;147;128 02:23:23 INFO - 2015-11-25 02:23:23,487 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;161;160;162;163;163;162;161 02:23:23 INFO - 2015-11-25 02:23:23,487 DEBUG : BROWSER_OUTPUT: |3;audio-fft;80;80;79;121;66;68;71;71;115;65 02:23:23 INFO - 2015-11-25 02:23:23,488 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;99;96;136;88;89;88;126;88;86;128 02:23:23 INFO - 2015-11-25 02:23:23,488 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;115;115;115;121;114;120;120;120;120 02:23:23 INFO - 2015-11-25 02:23:23,488 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;125;125;124;124;124;124;124;124;125 02:23:23 INFO - 2015-11-25 02:23:23,488 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;101;100;101;100;101;101;100;100;101 02:23:23 INFO - 2015-11-25 02:23:23,488 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;61;62;62;62;62;62;72;57;57 02:23:23 INFO - 2015-11-25 02:23:23,488 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;67;65;67;67;66;67;67;67;68 02:23:23 INFO - 2015-11-25 02:23:23,488 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;81;79;81;80;82;82;80;80;86 02:23:23 INFO - 2015-11-25 02:23:23,488 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;125;126;118;116;121;116;118;126;122 02:23:23 INFO - 2015-11-25 02:23:23,489 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;143;142;144;142;136;147;136;143;142 02:23:23 INFO - 2015-11-25 02:23:23,489 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;67;69;69;69;68;69;67;68 02:23:23 INFO - 2015-11-25 02:23:23,489 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:23:23 INFO - 2015-11-25 02:23:23,489 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:23:23 INFO - 2015-11-25 02:23:23,489 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,892 02:23:23 INFO - 2015-11-25 02:23:23,489 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:23:23 INFO - 2015-11-25 02:23:23,490 DEBUG : BROWSER_OUTPUT: __startTimestamp1448447003482__endTimestamp 02:23:23 INFO - 2015-11-25 02:23:23,490 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,490 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:23:23 INFO - 2015-11-25 02:23:23,490 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:23:23 INFO - 2015-11-25 02:23:23,490 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,491 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.23 (2.9%) stddev-sans-first:3.42 02:23:23 INFO - 2015-11-25 02:23:23,491 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 106.0 107.0 110.0 111.0 116.0 112.0 108.0 108.0 02:23:23 INFO - 2015-11-25 02:23:23,491 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,491 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.70 Median:148.00 stddev:14.97 (10.1%) stddev-sans-first:15.41 02:23:23 INFO - 2015-11-25 02:23:23,491 DEBUG : BROWSER_OUTPUT: Values: 153.0 127.0 169.0 149.0 124.0 146.0 129.0 155.0 147.0 128.0 02:23:23 INFO - 2015-11-25 02:23:23,491 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,492 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 02:23:23 INFO - 2015-11-25 02:23:23,492 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 161.0 160.0 162.0 163.0 163.0 162.0 161.0 02:23:23 INFO - 2015-11-25 02:23:23,492 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,492 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.60 Median:71.00 stddev:20.02 (28.2%) stddev-sans-first:21.23 02:23:23 INFO - 2015-11-25 02:23:23,492 DEBUG : BROWSER_OUTPUT: Values: 80.0 80.0 79.0 121.0 66.0 68.0 71.0 71.0 115.0 65.0 02:23:23 INFO - 2015-11-25 02:23:23,493 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,493 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.40 Median:88.00 stddev:19.62 (22.3%) stddev-sans-first:20.77 02:23:23 INFO - 2015-11-25 02:23:23,493 DEBUG : BROWSER_OUTPUT: Values: 99.0 96.0 136.0 88.0 89.0 88.0 126.0 88.0 86.0 128.0 02:23:23 INFO - 2015-11-25 02:23:23,493 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,494 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:120.00 stddev:2.83 (2.4%) stddev-sans-first:2.91 02:23:23 INFO - 2015-11-25 02:23:23,494 DEBUG : BROWSER_OUTPUT: Values: 120.0 115.0 115.0 115.0 121.0 114.0 120.0 120.0 120.0 120.0 02:23:23 INFO - 2015-11-25 02:23:23,495 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,495 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.40 Median:124.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:23:23 INFO - 2015-11-25 02:23:23,495 DEBUG : BROWSER_OUTPUT: Values: 125.0 125.0 125.0 124.0 124.0 124.0 124.0 124.0 124.0 125.0 02:23:23 INFO - 2015-11-25 02:23:23,495 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,495 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.60 Median:101.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:23:23 INFO - 2015-11-25 02:23:23,495 DEBUG : BROWSER_OUTPUT: Values: 101.0 101.0 100.0 101.0 100.0 101.0 101.0 100.0 100.0 101.0 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.40 Median:62.00 stddev:4.38 (7.1%) stddev-sans-first:4.34 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: Values: 57.0 61.0 62.0 62.0 62.0 62.0 62.0 72.0 57.0 57.0 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 65.0 67.0 67.0 66.0 67.0 67.0 67.0 68.0 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:81.50 stddev:1.95 (2.4%) stddev-sans-first:2.05 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: Values: 82.0 81.0 79.0 81.0 80.0 82.0 82.0 80.0 80.0 86.0 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:121.50 stddev:3.88 (3.2%) stddev-sans-first:4.11 02:23:23 INFO - 2015-11-25 02:23:23,496 DEBUG : BROWSER_OUTPUT: Values: 120.0 125.0 126.0 118.0 116.0 121.0 116.0 118.0 126.0 122.0 02:23:23 INFO - 2015-11-25 02:23:23,497 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,497 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:143.00 stddev:3.39 (2.4%) stddev-sans-first:3.57 02:23:23 INFO - 2015-11-25 02:23:23,497 DEBUG : BROWSER_OUTPUT: Values: 143.0 143.0 142.0 144.0 142.0 136.0 147.0 136.0 143.0 142.0 02:23:23 INFO - 2015-11-25 02:23:23,497 DEBUG : BROWSER_OUTPUT: 02:23:23 INFO - 2015-11-25 02:23:23,497 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:0.88 (1.3%) stddev-sans-first:0.93 02:23:23 INFO - 2015-11-25 02:23:23,497 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 69.0 69.0 69.0 68.0 69.0 67.0 68.0 02:23:23 INFO - 2015-11-25 02:23:23,497 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:23:23 INFO - 2015-11-25 02:23:23,497 DEBUG : BROWSER_OUTPUT: 02:23:24 INFO - 2015-11-25 02:23:24,132 INFO : Browser exited with error code: 0 02:23:24 INFO - 2015-11-25 02:23:24,180 INFO : Completed test kraken (00:00:56) 02:23:24 INFO - 2015-11-25 02:23:24,181 INFO : Starting test v8_7 02:23:24 INFO - 2015-11-25 02:23:24,181 DEBUG : operating with platform_type : mac_ 02:23:24 INFO - 2015-11-25 02:23:24,181 INFO : Initialising browser for v8_7 test... 02:23:24 INFO - 2015-11-25 02:23:24,194 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpVZ_eTk/profile http://localhost:49270/getInfo.html 02:23:26 INFO - 2015-11-25 02:23:26,323 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:23:26 INFO - 2015-11-25 02:23:26,323 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:23:26 INFO - 2015-11-25 02:23:26,323 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:23:26 INFO - 2015-11-25 02:23:26,323 DEBUG : BROWSER_OUTPUT: __metrics 02:23:26 INFO - 2015-11-25 02:23:26,341 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:23:26 INFO - 2015-11-25 02:23:26,972 INFO : Browser initialized. 02:23:26 INFO - 2015-11-25 02:23:26,972 INFO : Running cycle 1/1 for v8_7 test... 02:23:26 INFO - 2015-11-25 02:23:26,972 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/tmpVZ_eTk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:23:38 INFO - 2015-11-25 02:23:38,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 199098368 02:23:38 INFO - 2015-11-25 02:23:38,790 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/v8_7/run.html (next: http://localhost:49270/tests/v8_7/run.html) 02:24:00 INFO - 2015-11-25 02:24:00,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 518684672 02:24:00 INFO - 2015-11-25 02:24:00,462 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,462 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:24:00 INFO - 2015-11-25 02:24:00,462 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:24:00 INFO - 2015-11-25 02:24:00,462 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:24:00 INFO - 2015-11-25 02:24:00,462 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:24:00 INFO - 2015-11-25 02:24:00,462 DEBUG : BROWSER_OUTPUT: |0;Richards;165.97510373443984 02:24:00 INFO - 2015-11-25 02:24:00,462 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.22256039566292 02:24:00 INFO - 2015-11-25 02:24:00,462 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.7328990228013 02:24:00 INFO - 2015-11-25 02:24:00,463 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5731.428571428572 02:24:00 INFO - 2015-11-25 02:24:00,463 DEBUG : BROWSER_OUTPUT: |4;RayTrace;999.000999000999 02:24:00 INFO - 2015-11-25 02:24:00,463 DEBUG : BROWSER_OUTPUT: |5;Earley;668.4491978609626 02:24:00 INFO - 2015-11-25 02:24:00,463 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 02:24:00 INFO - 2015-11-25 02:24:00,463 DEBUG : BROWSER_OUTPUT: |7;RegExp;29114.285714285714 02:24:00 INFO - 2015-11-25 02:24:00,463 DEBUG : BROWSER_OUTPUT: |8;Splay;599.880023995201 02:24:00 INFO - 2015-11-25 02:24:00,463 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5803.468208092486 02:24:00 INFO - 2015-11-25 02:24:00,463 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:24:00 INFO - 2015-11-25 02:24:00,464 DEBUG : BROWSER_OUTPUT: __startTimestamp1448447040459__endTimestamp 02:24:00 INFO - 2015-11-25 02:24:00,464 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,464 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:24:00 INFO - 2015-11-25 02:24:00,464 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:24:00 INFO - 2015-11-25 02:24:00,464 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,464 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 02:24:00 INFO - 2015-11-25 02:24:00,464 DEBUG : BROWSER_OUTPUT: Values: 166.0 02:24:00 INFO - 2015-11-25 02:24:00,464 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.22 Median:190.22 stddev:0.00 (0.0%) 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: Values: 190.2 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.73 Median:325.73 stddev:0.00 (0.0%) 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: Values: 325.7 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5731.43 Median:5731.43 stddev:0.00 (0.0%) 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: Values: 5731.4 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:999.00 Median:999.00 stddev:0.00 (0.0%) 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: Values: 999.0 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:668.45 Median:668.45 stddev:0.00 (0.0%) 02:24:00 INFO - 2015-11-25 02:24:00,465 DEBUG : BROWSER_OUTPUT: Values: 668.4 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: Values: 12120.5 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29114.29 Median:29114.29 stddev:0.00 (0.0%) 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: Values: 29114.3 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:599.88 Median:599.88 stddev:0.00 (0.0%) 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: Values: 599.9 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5803.47 Median:5803.47 stddev:0.00 (0.0%) 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: Values: 5803.5 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:24:00 INFO - 2015-11-25 02:24:00,466 DEBUG : BROWSER_OUTPUT: 02:24:01 INFO - 2015-11-25 02:24:01,091 INFO : Browser exited with error code: 0 02:24:01 INFO - 2015-11-25 02:24:01,111 INFO : Completed test v8_7 (00:00:36) 02:24:01 INFO - 2015-11-25 02:24:01,113 INFO : Completed test suite (00:20:07) 02:24:01 INFO - 2015-11-25 02:24:01,113 DEBUG : Working with test: dromaeo_css 02:24:01 INFO - 2015-11-25 02:24:01,113 DEBUG : Generating results file: dromaeo_css 02:24:01 INFO - 2015-11-25 02:24:01,114 DEBUG : Working with test: kraken 02:24:01 INFO - 2015-11-25 02:24:01,114 DEBUG : Generating results file: kraken 02:24:01 INFO - 2015-11-25 02:24:01,114 INFO : javascript benchmark 02:24:01 INFO - 2015-11-25 02:24:01,114 DEBUG : Working with test: v8_7 02:24:01 INFO - 2015-11-25 02:24:01,114 DEBUG : Generating results file: v8_7 02:24:01 INFO - 2015-11-25 02:24:01,115 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:24:01 INFO - 2015-11-25 02:24:01,181 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 02:24:01 INFO - 2015-11-25 02:24:01,181 DEBUG : process_Request line: dromaeo_css 6869.46 graph.html#tests=[[72,52,55]] 02:24:01 INFO - 2015-11-25 02:24:01,182 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:24:01 INFO - 2015-11-25 02:24:01,217 DEBUG : process_Request line: kraken 1480.50 graph.html#tests=[[232,52,55]] 02:24:01 INFO - 2015-11-25 02:24:01,217 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:24:01 INFO - 2015-11-25 02:24:01,254 DEBUG : process_Request line: v8_7 20474.64 graph.html#tests=[[230,52,55]] 02:24:01 INFO - 2015-11-25 02:24:01,255 INFO : javascript benchmark 02:24:01 INFO - 2015-11-25 02:24:01,257 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [347.25340517886525, 349.15852794764623, 356.05645040642287, 357.31574035721593, 366.5637890909817, 14666.706665866703, 15300.31148598313, 17825.465236042925, 18103.366382176628, 18460.63078738426, 10923.508442120105, 11137.05335046522, 15145.167015814126, 18314.084295785226, 18557.07214639266, 4386.254336762742, 4520.480144783359, 4535.931961020588, 4554.066416384633, 4562.384078149441, 3417.333619944112, 3539.5044693742766, 4464.749870036395, 4528.094381123772, 4864.708117512961, 4853.902921941559, 4867.732274724889, 4882.072406242803, 4895.951040489603, 4919.409670839486, 4869.269609558559, 4889.535494128052, 4892.584130348924, 4934.654574179809, 4976.527229913152, 4145.751254924714, 4211.557786432411, 4223.556526564697, 4229.534751177368, 4243.236217480852, 13335.266560339178, 13892.305384730724, 14017.229052402114, 14030.508932187324, 14119.223442710647, 1854.8794328368747, 1917.2043601905332, 1949.9610007799765, 2026.695995600657, 2115.0693694774404, 9716.0, 9733.2213422926, 10061.14480269178, 10179.54192061359, 10276.280660353777, 1479.4082367053156, 1541.7610270408104, 1598.976015359759, 1612.4114698135213, 1645.5310236582636, 56525.0, 56739.43260567383, 60484.69757651183, 62397.37602623961, 63403.68298158526, 6552.770653027121, 6593.044008618819, 6607.867842643121, 6618.30507796684, 6719.630420326929, 7784.883226751604, 7841.333486653698, 7885.369170466349, 7917.524948503108, 7919.089304729914, 5447.618666693373, 5521.641093328921, 5562.749676264578, 5584.771350302927, 5611.270534830446, 5695.117256825199, 5748.511376532958, 5761.510271626875, 5765.942340576625, 5815.098659707752, 2937.706229377045, 3040.3463255400197, 3090.0575324525785, 3100.5659207710937, 3112.7042930921525, 1026.2303272545591, 1070.5075665194097, 1091.7052395853075, 1125.40916019089, 1133.9794185233357, 425.20486689889486, 437.49032377280747, 439.3475688602423, 471.3518911496692, 486.50133613046205, 9729.854052189223, 9869.654562090436, 10540.894591054144, 12046.457909394097, 12201.45093470796, 431.87475632066975, 437.06468158141604, 437.50343360285666, 448.12839028090053, 452.5632764382387, 5884.176215329857, 5935.881282374328, 5978.103284507359, 6028.095785632103, 6111.938880611226, 396236.0, 405567.0, 407900.0, 409549.0, 611550.0, 77180.61409692916, 78879.0, 78928.0, 79099.0, 79516.60241698755, 461.4854437302384, 466.40999136093546, 471.3777813286429, 476.2974612446683, 476.51395576511766, 11193.832092518782, 11215.158863085138, 11249.49377278008, 11323.094152467618, 11621.477033533341, 36547.26905461929, 37232.627673724, 37413.43879841859, 37462.438063428526, 37791.0, 51397.74301128471, 51590.22614660708, 52168.73915630398, 52454.21318680146, 52853.471465284856, 15691.293891775125, 15877.603059923595, 16296.185190740653, 16348.427805027242, 16375.508734737978, 19166.71249931224, 19235.711464327767, 19501.0, 19808.801911980696, 19870.801291986896, 13541.86458135406, 13649.454021839016, 14534.418623254951, 15295.235238237821, 15794.68410631758, 14953.551393458214, 15008.249587520362, 15308.234588270765, 15763.369465221263, 15915.522534323989, 12436.626901192978, 15438.691226175639, 15906.443274485337, 16154.1115238663, 16256.349746010028, 15681.215939203223, 15789.605259868595, 15907.284172212047, 16026.198690065683, 16185.190740463166, 15738.527844164693, 15836.049837009816, 16318.428854990017, 16331.428400005943, 16344.264508096927], "dojo.html": [3170.9207269818257, 3279.6720327967223, 3280.7867488613224, 3282.7537934654906, 3297.5878015248095, 4874.341963834886, 5231.39838918524, 5255.1329030709885, 5364.490373414529, 5411.458854114581, 5236.764345604447, 5270.446603106676, 5326.0, 5366.651167674098, 5412.972935135329, 4857.9757101214445, 4953.6037117030555, 4971.825986090496, 5043.0, 5150.716710580917, 5091.898162036776, 5119.923201151985, 5147.974260128694, 5155.871103222431, 5167.224916262553, 4992.07646585381, 5100.285959965608, 5113.488651134894, 5114.744262786864, 5122.231665250205, 4960.975195124038, 4996.800127994876, 5025.120603894304, 5091.592672586185, 5174.09453345663, 4946.0, 4977.900441991176, 4992.925106123411, 5023.472535383768, 5037.345145131146, 5127.0, 5141.511556402136, 5269.314989051437, 5275.525202731773, 5321.414644389114, 5563.443655634444, 5578.246936663539, 5579.8605034874045, 5731.455511726379, 5759.740811663485, 5560.0, 5581.0, 5656.547476201894, 5663.631863928831, 5668.744906479218, 5064.265681476165, 5190.091733946544, 5219.608529360313, 5293.232481290268, 5295.708736019517, 5810.622309549865, 5821.243238378984, 5867.119932010232, 5950.226470558886, 5973.402659733992, 5629.4652008059165, 5630.8029218977135, 5636.351819540805, 5640.661560306395, 5691.089425691869, 5668.093105103164, 5777.335606405233, 5785.190073389729, 5863.5309175265875, 5866.6480011199465, 5496.697681627549, 5599.888002239933, 5610.607257492018, 5671.234383358276, 5728.684922329312, 5610.607257492018, 5613.494785469327, 5678.5741069419955, 5690.004249256363, 5706.885862282731, 4311.698181127291, 4355.978220108879, 4391.890202744893, 4395.912081758347, 4413.6248418884115, 3896.337622604164, 3912.8630497932436, 4035.1324465240114, 4066.5933406659688, 4093.3041382964966, 5505.476979686923, 5549.278593782782, 5577.358603760538, 5579.7489112990015, 5593.07714227148, 5444.8366549003595, 5690.9146362804595, 5867.061270196748, 5958.165856780054, 5995.130706047598, 5341.732913354317, 5365.517103460707, 5435.402105768362, 5451.236826844245, 5466.508014278734, 5109.948900510947, 5113.769880355393, 5116.8209112681625, 5134.666246693953, 5136.512031357015, 5639.041362968387, 5785.652860828363, 5826.0, 5898.0, 5972.432618901197, 5685.0335442973965, 5765.336986246635, 5773.076307790733, 5779.537636988946, 5794.536437084938, 5700.714964251853, 5783.161441590862, 5789.710514474344, 5801.419858014334, 5817.0983497557945, 5600.915986260128, 5620.606557540933, 5702.885942281214, 5703.230063941315, 5742.942570574241, 5727.198192253005, 5833.358330583717, 5845.09401042839, 5862.179294898632, 5900.763969441346, 5731.684757338219, 5786.3056433228285, 5786.739596718242, 5793.710314484175, 5794.159846822272, 5444.700541470257, 5595.804146854841, 5701.486866182064, 5739.569532285179, 5764.7405866736935, 5371.4897084776885, 5381.811636592701, 5387.407385187548, 5494.917576236439, 5506.311711036121, 5595.412481689526, 5601.103823388238, 5620.269364982526, 5642.943570564242, 5701.059325211294, 5229.398619158846, 5405.378381486179, 5486.369067557282, 5491.093969494988, 5492.313460817398], "mootools.html": [1337.8729020743026, 1727.473120698187, 1823.5167680564653, 1860.3674750584798, 1879.8402135818455, 7358.595277259748, 7659.655315510801, 7965.243301886311, 8038.0, 8134.267915887576, 7901.762947111596, 7968.083670377909, 7996.120426753053, 8005.799855003628, 8148.674053037887, 2140.1439424230275, 2143.3784202581232, 2143.9249626263086, 2163.2753027735725, 2174.3803016140405, 2256.3005468304796, 2265.0713207584895, 2355.858648481088, 2358.021421110237, 2359.3511784259294, 2271.602469567819, 2281.783230593091, 2282.201229569654, 2289.3132060381904, 2293.392251053472, 2273.4316420894775, 2306.9307920762403, 2325.5581439526436, 2331.825113116506, 2333.0784340185614, 2205.7353117625826, 2245.9101635934544, 2251.223327951854, 2257.4694946687514, 2276.3739971507803, 6915.204751453547, 7183.4612404069385, 8010.118886922434, 8067.838643227161, 8120.75637730869, 4777.259524773631, 4925.901481970376, 4939.2838038484215, 4981.601471882241, 5009.824656137018, 2927.5462303343015, 2946.6758656547763, 2950.9114726558237, 2992.58103865459, 2993.3564283679116, 907.9909200908038, 921.5852866210232, 930.3255140023497, 940.3276657190141, 944.17856464876, 10503.789924201474, 10568.735781605445, 10609.0, 10637.361758294526, 10660.360378377321, 4246.936295955563, 4332.935005974913, 4349.543297953733, 4360.280553708602, 4361.062371590124, 9253.629854805868, 9281.0, 9322.207612353026, 9337.112974267433, 9354.438733676001, 4816.157172494799, 4840.443349014838, 4860.708357498562, 4897.681650692693, 4919.606431485473, 4416.447944006999, 4421.049474363027, 4449.666275029385, 4463.531329210451, 4473.2842745160615, 3637.0907273181706, 3683.355412802802, 3689.0, 3737.7009839213342, 3787.280416720814, 1141.646089712192, 1145.8796826333282, 1149.230015889356, 1155.162507182303, 1157.774234024374, 1238.3684320996356, 1257.1765493601706, 1262.50762202741, 1270.989563297181, 1291.2704322058007, 7148.249433809479, 7179.317964793337, 7193.172785129673, 7237.276272372826, 7247.637618119073, 500.4220125754759, 508.6134537751262, 508.95419412253074, 511.2484647568069, 514.9691018538899, 5398.0, 5455.8090466834265, 5459.0, 5513.173024046425, 5839.766409343579, 8851.424657397249, 9144.222741066951, 9411.341206115643, 9587.472689002032, 9688.9031109688, 9320.813583728423, 9389.248860091177, 9395.765105872271, 9506.239500839916, 9715.854262186072, 7525.548467091992, 7577.9621101893035, 7591.924080759121, 7655.617219139132, 7682.193369696213, 7403.481756277009, 7404.370628496638, 7406.666699998621, 7441.069866266716, 7466.701331946879, 8584.613692383733, 8672.089430609694, 8704.216620503932, 8738.91261087381, 8827.16141966512, 8751.081136480832, 8867.512286824287, 8915.598798053974, 8938.0, 9083.318751093826, 7173.928260717535, 7207.099112610924, 7217.566945983258, 7220.061392019214, 7305.159906610807, 7326.157491888288, 7333.633318333956, 7445.553266804009, 7457.888131678138, 7469.7385591504035, 7322.890156647548, 7366.079240094989, 7402.222766609429, 7485.1017877855, 7618.847623047397, 7213.314735100157, 7273.163586187445, 7275.527090739085, 7327.303906128909, 7356.190819009797, 6822.829429264308, 6851.520393572402, 6918.8616227676175, 7016.0, 7403.629818508945, 6282.1519094921605, 6381.425671689571, 6409.359064093554, 6427.421532062137, 6442.291347951628, 6382.138411314413, 6503.219613646393, 6503.861824180654, 6508.869822603616, 6514.250861151028], "ext.html": [551.0907003444316, 563.802669065827, 569.4789267819945, 571.4456976732567, 581.3111462916444, 31319.68680313196, 32599.837000814994, 41496.792516037414, 41716.37425438621, 41775.37336939948, 45365.0, 45439.77280113603, 45638.543614563845, 45947.310790338175, 46158.0, 9236.076392360761, 9452.66915657952, 9499.952500237488, 9520.095590918852, 9551.904480955205, 9247.39891907024, 9329.253659707207, 9379.531023448835, 9468.715938521855, 9470.763230919214, 9324.067593240656, 9448.385854919408, 9449.102335278138, 9544.284178686592, 9550.904490955105, 9214.493202873839, 9270.397424167408, 9359.719208423792, 9383.671571494964, 9417.728606638084, 8658.264047555902, 9241.861372079424, 9245.72262832116, 9290.02454742249, 9340.906590934072, 41099.589004109876, 41531.377029344585, 41639.959001024916, 42308.1538369234, 42603.0, 2874.4682233786816, 2876.5685147227873, 2982.5526171074293, 3059.4187104450084, 3576.9821150894077, 28569.57145642817, 28913.56629650557, 29245.122646320644, 29374.853125734448, 29597.112086637437, 2340.473393486469, 2344.2146880794953, 2386.5107652931106, 2392.97607023931, 2500.3874050857476, 282812.0, 289492.0, 291504.0, 291509.9999999979, 291792.0, 57076.42923570794, 57590.7120464395, 66194.0, 66361.33638663648, 70708.64645676738, 66250.66874665595, 67476.32523674799, 67732.0, 67756.32243677598, 68275.3172468279, 17753.911230443766, 17801.109944502725, 17811.821881781274, 17848.46454606364, 18012.459626211235, 12633.684157896127, 12638.620841374774, 13545.119567228296, 13573.59279221625, 13811.792823107662, 21560.78439215619, 21691.783082168975, 21770.673439898415, 21842.0, 21847.890760546412, 8942.776430589287, 9180.954095229481, 9192.63229470827, 9266.397684150643, 9283.535823208813, 881.5768431152954, 939.248601119102, 1026.3995562595817, 1083.0523292119397, 1091.0, 29506.852465737535, 30132.84933575318, 30229.848850755607, 30418.54372184419, 30794.53808192879, 1037.0770014686934, 1070.1278458056659, 1085.766560189563, 1093.9671809845718, 1202.8316035755001, 13812.0, 14928.772095567256, 15318.157501337311, 15318.617034574225, 15709.607259818597, 366791.0, 370020.0, 372829.0, 373510.0, 374285.0, 50935.23597146046, 51590.74204628953, 57461.71269143711, 59894.10158847621, 60517.69741151266, 1429.942802287897, 1447.7755947828105, 1449.239149446528, 1463.8755705764916, 1480.4152359818027, 27961.021364252152, 30408.391832163674, 31416.0, 32275.838620806746, 33773.83113084419, 48428.7578562119, 49680.25479617881, 59546.10680839878, 60461.69769151126, 60880.391196087476, 327200.0, 329269.0, 332441.0, 333165.0, 335448.0, 42978.570214297455, 43071.0, 43640.34539481847, 44292.0, 45390.0, 46760.0, 46944.530554694014, 46965.0, 47370.52629473661, 48243.0, 38517.229655406176, 39361.40957885577, 39436.0, 41141.79429102955, 42501.78749106234, 37809.0, 38148.42862552001, 38148.85553433401, 38369.80815095906, 38908.221835563694, 38396.23207535778, 39249.0, 39255.6074439252, 39727.60272397355, 39910.2017959645, 33383.66616333806, 34827.82586087155, 36335.27329453449, 36613.633863662086, 36969.44545831761, 25556.763441611314, 25766.227013189633, 26101.477970440104, 26156.60765088563, 26541.469170616092], "prototype.html": [331.1605081119362, 341.3071464926199, 342.8954168978462, 342.94684323929766, 347.90258727556295, 6014.248218972629, 6175.0, 6206.348333424993, 6212.037134244194, 6266.091416744569, 6069.089636554519, 6089.756409743605, 6138.631682099066, 6139.662318572477, 6157.230346206724, 4862.513748625127, 4864.221724524077, 4870.391201099863, 4870.56164945154, 4871.634627402941, 4736.029114031632, 4788.305695674125, 4840.346553215324, 4886.755662216875, 4932.728699921503, 4797.472278049412, 4823.951760482403, 4831.347768051303, 4849.927251091219, 4864.270359446076, 4749.26386410107, 4764.285357196431, 4783.497732738082, 4805.519448055202, 4827.468978412372, 3921.8431262749455, 4121.567235440266, 4153.501579810412, 4212.578742125763, 4222.662187025031, 5857.736401861926, 5876.441738034922, 5915.231019967419, 5949.286085669704, 5969.044952807573, 5216.530512253916, 5224.843254702365, 5233.633645644806, 5235.869103272411, 5239.659422137549, 6059.303180134297, 6189.102580125901, 6291.653959032252, 6307.4954003679595, 6389.520785941073, 4233.386159006957, 4276.764777937212, 4290.978545107255, 4303.634191093761, 4371.803268852877, 6505.707243174069, 6639.468842492589, 6645.235797883257, 6718.428933540655, 6744.966275168642, 4327.221100201994, 4369.69412141147, 4374.58441448062, 4417.204903117469, 4433.024734558392, 4397.626201772821, 4446.377507149002, 4469.061497085583, 4490.820367185276, 4520.344550040226, 4952.752362381866, 5081.136206844845, 5111.0, 5187.429382767892, 5193.0, 6277.686115694197, 6288.276848162428, 6343.429091381798, 6353.618782873043, 6391.328910464427, 1592.2834724373847, 1604.7191741445433, 1606.0765060090496, 1608.8310727373691, 1613.3788491430885, 1024.359775140537, 1051.2115913065202, 1052.5316234275674, 1062.3572738493256, 1062.4209805655937, 6208.81373558794, 6237.064440333896, 6278.529110316745, 6282.937170628326, 6298.401651843067, 6562.015697645296, 6651.33486651331, 6657.0, 6671.132752742113, 6798.252192258947, 6036.426539478743, 6196.1015652731, 6207.81376558704, 6244.12582238487, 6250.781222657185, 3658.158623516606, 3677.7609455385314, 3732.682721968609, 3736.7384283100464, 3747.2130852521277, 6686.09737685416, 6758.493113016543, 6779.593224406552, 6787.762428314985, 6790.32096790317, 6784.898226526606, 6845.418139458102, 6858.142732158481, 6859.965700171467, 6860.245373008965, 6746.325367463312, 6766.526343156031, 6799.456043516606, 6800.829979250559, 6805.149356330458, 6477.384648458389, 6508.349165083643, 6612.570182938093, 6672.699728512326, 6744.527883048139, 6406.13517175194, 6494.318096599789, 6527.706253218712, 6564.868702625825, 6566.671666416564, 6631.038499417654, 6652.733890644514, 6661.400473957173, 6717.261101278757, 6745.325467453215, 4368.868933931987, 4475.731456112644, 4505.752183629932, 4593.26507758757, 4602.677812553089, 6531.052997315458, 6560.212774467094, 6566.540342176193, 6574.178227721535, 6605.9009114864275, 6289.811305660837, 6351.0, 6351.841203969938, 6395.616263024233, 6430.0, 6186.0102383618405, 6324.177856878577, 6330.113784070142, 6354.555181137276, 6488.610683358825, 6359.427651511386, 6368.235811702625, 6390.073439351361, 6392.520560957853, 6405.295417503978, 6453.225612926479, 6472.126262954629, 6527.543071985106, 6558.573692709959, 6571.408573228432, 6134.11055396956, 6301.6219026858535, 6331.651759153291, 6342.429181373698, 6356.459700925473], "yui.html": [666.9533132680714, 677.7255211639284, 760.7945854619253, 767.6238643064898, 803.4616806739484, 12199.695007624814, 12389.0, 12410.069244806631, 12418.254904705724, 12459.439325230363, 13557.661058473543, 13604.455821767118, 13613.795793063113, 13615.863841361583, 13868.0, 748.8277696129893, 752.7591170825339, 913.5112714697638, 929.944203347798, 942.0155937045804, 935.4761333653177, 938.1416004356006, 938.4275591888942, 942.6653537994016, 947.2374738335672, 783.8628240057996, 949.738821823997, 964.7395203295106, 965.5365424596198, 970.4662435660393, 788.9644965976516, 950.1021534649759, 979.4710856137677, 987.9753006174831, 988.5205675247499, 730.3645828129561, 731.381982225019, 733.0909672006727, 734.9559026458429, 744.1330849560255, 14103.294835258195, 14130.364133614012, 14168.0, 14341.641458963504, 14407.351669174912, 11706.707332316675, 11907.0, 11916.34460104694, 11957.940210298893, 12094.758104837854, 9467.0, 9561.856572151424, 9797.755056123582, 10401.635942741968, 10768.730781730519, 3405.7786243894066, 3432.63957284484, 3434.9484757728655, 3556.626554211822, 3726.4596633488263, 50898.0, 50986.74506627443, 51883.74058129685, 51926.22110668343, 52237.99999999962, 9155.176034156957, 9508.572114254875, 9522.190613797904, 9566.426014439156, 9608.855867161998, 20292.492687682632, 20336.69494957577, 20343.694844577047, 20366.083526241353, 20409.69385459219, 7151.427885769126, 7159.57042577447, 7196.208417074117, 7574.394048476109, 7788.493747906368, 3897.6881849451975, 3938.3895496198134, 3962.881113566598, 4005.178938317638, 4026.295398305285, 3018.215264031324, 3095.9226019349244, 3098.550710147016, 3308.5037244413047, 3455.8963231103107, 554.5314209492972, 562.4235158962015, 567.9886402272014, 568.7980766827799, 569.7834822767405, 426.86767102198417, 510.0003992175304, 528.4583302115362, 528.8862894477705, 614.7817524778728, 7403.444741644291, 7426.443016773764, 7699.191584883619, 7715.652795624211, 7860.606969651494, 519.9194124910645, 538.1792766031755, 546.9935319013035, 547.9943407129965, 603.6378173096107, 3687.4284485904727, 3907.4724912137067, 4052.149048699806, 4055.3511438169753, 4210.894727631772, 61658.38341616616, 61960.69019654873, 62002.37997619966, 62205.37794621996, 62950.0, 52093.0, 53717.73141134348, 53940.730296348265, 53978.0, 54095.18857217145, 49472.0, 49797.253041204414, 49799.0040199194, 49938.0, 50027.499725003014, 7996.280334769898, 8085.716999904975, 8234.670613175645, 8599.957000215209, 8858.73423797287, 33896.830515847265, 34647.30705385929, 35261.82369088138, 36089.458658120675, 36503.0, 46695.76652116718, 47262.0, 47486.0, 47531.76234118807, 48838.26742598935, 8022.91977080245, 8089.02931648206, 8098.190180981855, 8162.918370816215, 8367.28878045373, 11016.449177541252, 11246.437678116225, 11478.368689721812, 11660.12549058807, 11786.76426471483, 10535.209859260432, 10785.730356741144, 10835.458227088771, 10946.179036572448, 11020.614278500214, 10406.323588966692, 10500.789984200426, 10880.945595271973, 11060.502277397376, 11256.83114753263, 9445.96094429626, 9730.513474326397, 10134.391936483835, 10224.948875255874, 10664.360138391721, 9270.258379329503, 9333.953330233306, 9383.108604682544, 9387.577559009724, 9482.0, 8880.067592902653, 9048.230900373279, 9055.547222638974, 9095.909040909506, 9172.770680732769]}, "summary": {"suite": 6869.459712032149, "subtests": {"jquery.html": {"filtered": 7499.213174656363, "value": 7499.213174656363}, "dojo.html": {"filtered": 5312.110457833228, "value": 5312.110457833228}, "mootools.html": {"filtered": 4450.309228268287, "value": 4450.309228268287}, "ext.html": {"filtered": 19668.076047644056, "value": 19668.076047644056}, "prototype.html": {"filtered": 4843.233178453813, "value": 4843.233178453813}, "yui.html": {"filtered": 6221.939329608143, "value": 6221.939329608143}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0050"}, "testrun": {"date": 1448445833, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151125002040", "branch": "Mozilla-Aurora", "revision": "6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 160.0, 161.0, 161.0, 160.0, 162.0, 163.0, 163.0, 162.0, 161.0], "ai-astar": [110.0, 105.0, 106.0, 107.0, 110.0, 111.0, 116.0, 112.0, 108.0, 108.0], "imaging-gaussian-blur": [120.0, 115.0, 115.0, 115.0, 121.0, 114.0, 120.0, 120.0, 120.0, 120.0], "audio-beat-detection": [153.0, 127.0, 169.0, 149.0, 124.0, 146.0, 129.0, 155.0, 147.0, 128.0], "json-stringify-tinderbox": [66.0, 67.0, 65.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 68.0], "stanford-crypto-pbkdf2": [143.0, 143.0, 142.0, 144.0, 142.0, 136.0, 147.0, 136.0, 143.0, 142.0], "json-parse-financial": [57.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 72.0, 57.0, 57.0], "stanford-crypto-sha256-iterative": [68.0, 67.0, 67.0, 69.0, 69.0, 69.0, 68.0, 69.0, 67.0, 68.0], "audio-fft": [80.0, 80.0, 79.0, 121.0, 66.0, 68.0, 71.0, 71.0, 115.0, 65.0], "imaging-darkroom": [125.0, 125.0, 125.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 125.0], "stanford-crypto-ccm": [120.0, 125.0, 126.0, 118.0, 116.0, 121.0, 116.0, 118.0, 126.0, 122.0], "audio-oscillator": [99.0, 96.0, 136.0, 88.0, 89.0, 88.0, 126.0, 88.0, 86.0, 128.0], "stanford-crypto-aes": [82.0, 81.0, 79.0, 81.0, 80.0, 82.0, 82.0, 80.0, 80.0, 86.0], "imaging-desaturate": [101.0, 101.0, 100.0, 101.0, 100.0, 101.0, 101.0, 100.0, 100.0, 101.0]}, "summary": {"suite": 1480.4999999999998, "subtests": {"audio-fft": {"filtered": 81.6, "value": 81.6}, "stanford-crypto-pbkdf2": {"filtered": 141.8, "value": 141.8}, "audio-beat-detection": {"filtered": 142.7, "value": 142.7}, "stanford-crypto-ccm": {"filtered": 120.8, "value": 120.8}, "imaging-darkroom": {"filtered": 124.4, "value": 124.4}, "json-parse-financial": {"filtered": 61.4, "value": 61.4}, "audio-oscillator": {"filtered": 102.4, "value": 102.4}, "ai-astar": {"filtered": 109.3, "value": 109.3}, "audio-dft": {"filtered": 161.4, "value": 161.4}, "stanford-crypto-sha256-iterative": {"filtered": 68.1, "value": 68.1}, "json-stringify-tinderbox": {"filtered": 66.7, "value": 66.7}, "imaging-gaussian-blur": {"filtered": 118.0, "value": 118.0}, "stanford-crypto-aes": {"filtered": 81.3, "value": 81.3}, "imaging-desaturate": {"filtered": 100.6, "value": 100.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0050"}, "testrun": {"date": 1448445833, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151125002040", "branch": "Mozilla-Aurora", "revision": "6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.22256039566292], "Encrypt": [325.7328990228013], "NavierStokes": [5803.468208092486], "Decrypt": [5731.428571428572], "Splay": [599.880023995201], "Richards": [165.97510373443984], "RegExp": [29114.285714285714], "Earley": [668.4491978609626], "Boyer": [12120.481927710844], "RayTrace": [999.000999000999]}, "summary": {"suite": 20474.641026704543, "subtests": {"DeltaBlue": {"filtered": 347.58232600000014, "value": 347.58232600000014}, "Encrypt": {"filtered": 817.1756700000001, "value": 817.1756700000001}, "NavierStokes": {"filtered": 255.70916334661337, "value": 255.70916334661337}, "Decrypt": {"filtered": 46.44234795613162, "value": 46.44234795613162}, "Splay": {"filtered": 135.84549700000002, "value": 135.84549700000002}, "RegExp": {"filtered": 31.289965652600593, "value": 31.289965652600593}, "Richards": {"filtered": 212.69455, "value": 212.69455}, "Earley": {"filtered": 997.028648, "value": 997.028648}, "Boyer": {"filtered": 54.9865099403579, "value": 54.9865099403579}, "RayTrace": {"filtered": 740.7289890000001, "value": 740.7289890000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0050"}, "testrun": {"date": 1448445833, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "44.0a2", "id": "20151125002040", "branch": "Mozilla-Aurora", "revision": "6ad162acd38b9838ffb411eac2cc7efe1d9c4f1d"}}] 02:24:01 INFO - RETURN: dromaeo_css: 6869.46 02:24:01 INFO - RETURN: kraken: 1480.50 02:24:01 INFO - RETURN: v8_7: 20474.64 02:24:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "20474.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1480.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6869.46"}}} 02:24:01 INFO - Return code: 0 02:24:01 INFO - # TBPL SUCCESS # 02:24:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:24:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:24:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:24:01 INFO - 2015-11-25 02:24:01.357 screenresolution[1647:10188] starting screenresolution argv=screenresolution get 02:24:01 INFO - 2015-11-25 02:24:01.360 screenresolution[1647:10188] Display 0: 1600x1200x32@60 02:24:01 INFO - 2015-11-25 02:24:01.366 screenresolution[1648:10191] starting screenresolution argv=screenresolution list 02:24:01 INFO - Available Modes on Display 0 02:24:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:24:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:24:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:24:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:24:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:24:01 INFO - Intel HD Graphics 3000: 02:24:01 INFO - Chipset Model: Intel HD Graphics 3000 02:24:01 INFO - Type: GPU 02:24:01 INFO - Bus: Built-In 02:24:01 INFO - VRAM (Total): 512 MB 02:24:01 INFO - VRAM (Dynamic, Max): 10 02:24:01 INFO - Vendor: Intel (0x8086) 02:24:01 INFO - Device ID: 0x0116 02:24:01 INFO - Revision ID: 0x0009 02:24:01 INFO - Displays: 02:24:01 INFO - Display: 02:24:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:24:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:24:01 INFO - Display Serial Number: 1600x1200 60 02:24:01 INFO - Main Display: Yes 02:24:01 INFO - Mirror: Off 02:24:01 INFO - Online: Yes 02:24:01 INFO - Rotation: Supported 02:24:01 INFO - Return code: 0 02:24:01 INFO - Running post-action listener: _resource_record_post_action 02:24:01 INFO - Running post-run listener: _resource_record_post_run 02:24:02 INFO - Total resource usage - Wall time: 1246s; CPU: 30.0%; Read bytes: 39171072; Write bytes: 686226432; Read time: 7006; Write time: 51301 02:24:02 INFO - install - Wall time: 37s; CPU: 30.0%; Read bytes: 332386816; Write bytes: 334487552; Read time: 33694; Write time: 5656 02:24:02 INFO - run-tests - Wall time: 1209s; CPU: 30.0%; Read bytes: 37954560; Write bytes: 341470208; Read time: 4454; Write time: 44750 02:24:02 INFO - Running post-run listener: _upload_blobber_files 02:24:02 INFO - Blob upload gear active. 02:24:02 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:24:02 INFO - Copying logs to upload dir... 02:24:02 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1333.232588 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2015-11-25 02:24:02.775911) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 02:24:02.779348) ========= 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.48nvdIChh8/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.BFOOaE69MP/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010144 build_url: 'https://queue.taskcluster.net/v1/task/aHYrW-32SmKEfCX9nM1p3w/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 02:24:02.801413) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 02:24:02.801695) ========= 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.48nvdIChh8/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.BFOOaE69MP/Listeners TMPDIR=/var/folders/w5/8gg9p2xn6p5cvvng_jjzx6x800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.004849 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 02:24:02.853623) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 02:24:02.854294) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 02:24:02.854734) ========= ========= Total master_lag: 0.44 =========