builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0028 starttime: 1448351859.08 results: success (0) buildid: 20151123230131 builduid: e1a21c9e4fc94800ad47e73ca81a94a6 revision: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.082670) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.083217) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.083500) ========= 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.2OP71man3n/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.TTKlymYBmx/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005187 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.103133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.103433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.117426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.117804) ========= 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.2OP71man3n/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.TTKlymYBmx/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005235 ========= master_lag: 0.26 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.381606) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.381948) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.382348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.382625) ========= 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.2OP71man3n/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.TTKlymYBmx/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-23 23:57:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.31M=0.001s 2015-11-23 23:57:39 (8.31 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115077 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.510725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.511026) ========= 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.2OP71man3n/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.TTKlymYBmx/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019299 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:39.623964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 23:57:39.624297) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4dca10306d58d2e87cbed46a72472b62c17b0ec9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4dca10306d58d2e87cbed46a72472b62c17b0ec9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2OP71man3n/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.TTKlymYBmx/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-23 23:57:39,696 truncating revision to first 12 chars 2015-11-23 23:57:39,696 Setting DEBUG logging. 2015-11-23 23:57:39,696 attempt 1/10 2015-11-23 23:57:39,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4dca10306d58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 23:57:41,247 unpacking tar archive at: fx-team-4dca10306d58/testing/mozharness/ program finished with exit code 0 elapsedTime=1.792252 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 23:57:41.431307) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:41.431634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:41.442315) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:41.442673) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 23:57:41.443108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-23 23:57:41.443388) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2OP71man3n/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.TTKlymYBmx/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 23:57:41 INFO - MultiFileLogger online at 20151123 23:57:41 in /builds/slave/test 23:57:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:57:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:57:41 INFO - {'append_to_log': False, 23:57:41 INFO - 'base_work_dir': '/builds/slave/test', 23:57:41 INFO - 'blob_upload_branch': 'Fx-Team', 23:57:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:57:41 INFO - 'branch': 'Fx-Team', 23:57:41 INFO - 'buildbot_json_path': 'buildprops.json', 23:57:41 INFO - 'config_files': ('talos/mac_config.py',), 23:57:41 INFO - 'default_actions': ('clobber', 23:57:41 INFO - 'read-buildbot-config', 23:57:41 INFO - 'download-and-extract', 23:57:41 INFO - 'populate-webroot', 23:57:41 INFO - 'create-virtualenv', 23:57:41 INFO - 'install', 23:57:41 INFO - 'run-tests'), 23:57:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:57:41 INFO - 'download_minidump_stackwalk': True, 23:57:41 INFO - 'download_symbols': 'ondemand', 23:57:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:57:41 INFO - 'tooltool.py': '/tools/tooltool.py', 23:57:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:57:41 INFO - '/tools/misc-python/virtualenv.py')}, 23:57:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:57:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:57:41 INFO - 'installer_path': 'installer.exe', 23:57:41 INFO - 'log_level': 'info', 23:57:41 INFO - 'log_name': 'talos', 23:57:41 INFO - 'log_to_console': True, 23:57:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:57:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:57:41 INFO - 'opt_config_files': (), 23:57:41 INFO - 'pip_index': False, 23:57:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:57:41 INFO - 'cmd': ('bash', 23:57:41 INFO - '-c', 23:57:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:57:41 INFO - 'enabled': True, 23:57:41 INFO - 'halt_on_failure': False, 23:57:41 INFO - 'name': 'check_screen_resolution'},), 23:57:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:57:41 INFO - 'cmd': ('bash', 23:57:41 INFO - '-c', 23:57:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:57:41 INFO - 'enabled': True, 23:57:41 INFO - 'halt_on_failure': False, 23:57:41 INFO - 'name': 'check_screen_resolution'},), 23:57:41 INFO - 'run_cmd_checks_enabled': True, 23:57:41 INFO - 'sps_profile': False, 23:57:41 INFO - 'sps_profile_interval': 0, 23:57:41 INFO - 'suite': 'dromaeojs-e10s', 23:57:41 INFO - 'system_bits': '64', 23:57:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:57:41 INFO - 'title': 't-yosemite-r7-0028', 23:57:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:57:41 INFO - 'use_talos_json': True, 23:57:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:57:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:57:41 INFO - 'work_dir': 'build'} 23:57:41 INFO - ##### 23:57:41 INFO - ##### Running clobber step. 23:57:41 INFO - ##### 23:57:41 INFO - Running pre-action listener: _resource_record_pre_action 23:57:41 INFO - Running main action method: clobber 23:57:41 INFO - rmtree: /builds/slave/test/build 23:57:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:57:42 INFO - Running post-action listener: _resource_record_post_action 23:57:42 INFO - ##### 23:57:42 INFO - ##### Running read-buildbot-config step. 23:57:42 INFO - ##### 23:57:42 INFO - Running pre-action listener: _resource_record_pre_action 23:57:42 INFO - Running main action method: read_buildbot_config 23:57:42 INFO - Using buildbot properties: 23:57:42 INFO - { 23:57:42 INFO - "properties": { 23:57:42 INFO - "buildnumber": 23, 23:57:42 INFO - "product": "firefox", 23:57:42 INFO - "script_repo_revision": "production", 23:57:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 23:57:42 INFO - "repository": "", 23:57:42 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 23:57:42 INFO - "buildid": "20151123230131", 23:57:42 INFO - "slavename": "t-yosemite-r7-0028", 23:57:42 INFO - "pgo_build": "False", 23:57:42 INFO - "basedir": "/builds/slave/test", 23:57:42 INFO - "project": "", 23:57:42 INFO - "platform": "yosemite_r7", 23:57:42 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 23:57:42 INFO - "slavebuilddir": "test", 23:57:42 INFO - "scheduler": "tests-fx-team-macosx64-talos", 23:57:42 INFO - "branch": "fx-team", 23:57:42 INFO - "repo_path": "integration/fx-team", 23:57:42 INFO - "stage_platform": "macosx64", 23:57:42 INFO - "builduid": "e1a21c9e4fc94800ad47e73ca81a94a6", 23:57:42 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 23:57:42 INFO - }, 23:57:42 INFO - "sourcestamp": { 23:57:42 INFO - "repository": "", 23:57:42 INFO - "hasPatch": false, 23:57:42 INFO - "project": "", 23:57:42 INFO - "branch": "fx-team-macosx64-talos", 23:57:42 INFO - "changes": [ 23:57:42 INFO - { 23:57:42 INFO - "category": null, 23:57:42 INFO - "files": [ 23:57:42 INFO - { 23:57:42 INFO - "url": null, 23:57:42 INFO - "name": "https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 23:57:42 INFO - } 23:57:42 INFO - ], 23:57:42 INFO - "repository": "", 23:57:42 INFO - "rev": "4dca10306d58d2e87cbed46a72472b62c17b0ec9", 23:57:42 INFO - "who": "maglione.k@gmail.com", 23:57:42 INFO - "when": 1448351439, 23:57:42 INFO - "number": 6699218, 23:57:42 INFO - "comments": "Bug 1208761: [webext] Support l10n.getMessage in content scripts. r=billm", 23:57:42 INFO - "project": "", 23:57:42 INFO - "at": "Mon 23 Nov 2015 23:50:39", 23:57:42 INFO - "branch": "fx-team-macosx64-talos", 23:57:42 INFO - "revlink": "", 23:57:42 INFO - "properties": [ 23:57:42 INFO - [ 23:57:42 INFO - "buildid", 23:57:42 INFO - "20151123230131", 23:57:42 INFO - "Change" 23:57:42 INFO - ], 23:57:42 INFO - [ 23:57:42 INFO - "builduid", 23:57:42 INFO - "e1a21c9e4fc94800ad47e73ca81a94a6", 23:57:42 INFO - "Change" 23:57:42 INFO - ], 23:57:42 INFO - [ 23:57:42 INFO - "pgo_build", 23:57:42 INFO - "False", 23:57:42 INFO - "Change" 23:57:42 INFO - ] 23:57:42 INFO - ], 23:57:42 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 23:57:42 INFO - } 23:57:42 INFO - ], 23:57:42 INFO - "revision": "4dca10306d58d2e87cbed46a72472b62c17b0ec9" 23:57:42 INFO - } 23:57:42 INFO - } 23:57:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 23:57:42 INFO - Running post-action listener: _resource_record_post_action 23:57:42 INFO - ##### 23:57:42 INFO - ##### Running download-and-extract step. 23:57:42 INFO - ##### 23:57:42 INFO - Running pre-action listener: _resource_record_pre_action 23:57:42 INFO - Running main action method: download_and_extract 23:57:42 INFO - mkdir: /builds/slave/test/build/tests 23:57:42 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')]} 23:57:42 INFO - https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:57:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/test_packages.json 23:57:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/test_packages.json 23:57:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:57:44 INFO - Downloaded 1149 bytes. 23:57:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:57:44 INFO - Using the following test package requirements: 23:57:44 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:57:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:44 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 23:57:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:44 INFO - u'jsshell-mac.zip'], 23:57:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:44 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 23:57:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:57:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:44 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 23:57:44 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:44 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 23:57:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:44 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 23:57:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:57:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:44 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 23:57:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:44 INFO - https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:57:45 INFO - Downloaded 17526945 bytes. 23:57:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 23:57:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:57:48 INFO - Return code: 0 23:57:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 23:57:48 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')]} 23:57:48 INFO - https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:57:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:57:49 INFO - Downloaded 17526945 bytes. 23:57:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 23:57:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:57:52 INFO - Return code: 0 23:57: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')]} 23:57:52 INFO - https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:57:53 INFO - Downloaded 11130997 bytes. 23:57:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 23:57:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:57:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 23:57:53 INFO - Return code: 0 23:57: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')]} 23:57:53 INFO - https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 23:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 23:57:56 INFO - Downloaded 109910917 bytes. 23:57:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:57:56 INFO - mkdir: /builds/slave/test/properties 23:57:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:57:56 INFO - Writing to file /builds/slave/test/properties/build_url 23:57:56 INFO - Contents: 23:57:56 INFO - build_url:https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:57:56 INFO - Running post-action listener: _resource_record_post_action 23:57:56 INFO - Running post-action listener: set_extra_try_arguments 23:57:56 INFO - ##### 23:57:56 INFO - ##### Running populate-webroot step. 23:57:56 INFO - ##### 23:57:56 INFO - Running pre-action listener: _resource_record_pre_action 23:57:56 INFO - Running main action method: populate_webroot 23:57:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:57:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:57:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 23:57:56 INFO - '../fennec_ids.txt'], 23:57:56 INFO - 'tests': ['tcheck2']}, 23:57:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:57:56 INFO - '--tppagecycles', 23:57:56 INFO - '7'], 23:57:56 INFO - 'tests': ['tsvgm']}}, 23:57:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:57:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:57:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:57:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:57:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:57:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:57:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:57:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:56 INFO - 'talos_options': ['--e10s'], 23:57:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:57:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:56 INFO - 'tests': ['damp', 'tps']}, 23:57:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:56 INFO - 'talos_options': ['--e10s'], 23:57:56 INFO - 'tests': ['damp', 'tps']}, 23:57:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:57:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:57:56 INFO - 'other': {'tests': ['a11yr', 23:57:56 INFO - 'ts_paint', 23:57:56 INFO - 'tpaint', 23:57:56 INFO - 'sessionrestore', 23:57:56 INFO - 'sessionrestore_no_auto_restore']}, 23:57:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:57:56 INFO - 'tests': ['a11yr', 23:57:56 INFO - 'ts_paint', 23:57:56 INFO - 'tpaint', 23:57:56 INFO - 'sessionrestore', 23:57:56 INFO - 'sessionrestore_no_auto_restore']}, 23:57:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:57:56 INFO - 'tests': ['a11yr', 23:57:56 INFO - 'ts_paint', 23:57:56 INFO - 'tpaint', 23:57:56 INFO - 'sessionrestore', 23:57:56 INFO - 'sessionrestore_no_auto_restore']}, 23:57:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:57:56 INFO - 'tests': ['a11yr', 23:57:56 INFO - 'ts_paint', 23:57:56 INFO - 'tpaint', 23:57:56 INFO - 'sessionrestore', 23:57:56 INFO - 'sessionrestore_no_auto_restore']}, 23:57:56 INFO - 'other_l64': {'tests': ['a11yr', 23:57:56 INFO - 'ts_paint', 23:57:56 INFO - 'tpaint', 23:57:56 INFO - 'sessionrestore', 23:57:56 INFO - 'sessionrestore_no_auto_restore']}, 23:57:56 INFO - 'other_nol64': {'tests': ['a11yr', 23:57:56 INFO - 'ts_paint', 23:57:56 INFO - 'tpaint', 23:57:56 INFO - 'sessionrestore', 23:57:56 INFO - 'sessionrestore_no_auto_restore']}, 23:57:56 INFO - 'svgr': {'tests': ['tsvgx', 23:57:56 INFO - 'tsvgr_opacity', 23:57:56 INFO - 'tart', 23:57:56 INFO - 'tscrollx', 23:57:56 INFO - 'cart']}, 23:57:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:57:56 INFO - 'tests': ['tsvgx', 23:57:56 INFO - 'tsvgr_opacity', 23:57:56 INFO - 'tart', 23:57:56 INFO - 'tscrollx', 23:57:56 INFO - 'cart']}, 23:57:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:56 INFO - 'tests': ['tp5o']}, 23:57:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:56 INFO - 'talos_options': ['--e10s'], 23:57:56 INFO - 'tests': ['tp5o']}, 23:57:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:56 INFO - 'talos_options': ['--xperf_path', 23:57:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:57:56 INFO - 'tests': ['tp5n']}, 23:57:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:57:56 INFO - 'talos_options': ['--e10s', 23:57:56 INFO - '--xperf_path', 23:57:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:57:56 INFO - 'tests': ['tp5n']}}, 23:57:56 INFO - 'talos.zip': {'path': '', 23:57:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:57:56 INFO - Running post-action listener: _resource_record_post_action 23:57:56 INFO - ##### 23:57:56 INFO - ##### Running create-virtualenv step. 23:57:56 INFO - ##### 23:57:56 INFO - Running pre-action listener: _resource_record_pre_action 23:57:56 INFO - Running main action method: create_virtualenv 23:57:56 INFO - Creating virtualenv /builds/slave/test/build/venv 23:57:56 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 23:57:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:57:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:57:56 INFO - Using real prefix '/tools/python27' 23:57:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:57:57 INFO - Installing distribute.............................................................................................................................................................................................done. 23:58:00 INFO - Installing pip.................done. 23:58:00 INFO - Return code: 0 23:58:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:58:00 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')]} 23:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:00 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')]} 23:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:00 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 0x10237a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102357228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66946f2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229e9f0>, '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 0x101ffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022918c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/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.TTKlymYBmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:58:00 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 23:58:00 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 23:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/Render', 23:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:00 INFO - 'HOME': '/Users/cltbld', 23:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:00 INFO - 'LOGNAME': 'cltbld', 23:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:00 INFO - 'MOZ_NO_REMOTE': '1', 23:58:00 INFO - 'NO_EM_RESTART': '1', 23:58:00 INFO - 'PAGER': '/bin/cat', 23:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:00 INFO - 'PWD': '/builds/slave/test', 23:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:00 INFO - 'SHELL': '/bin/bash', 23:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TTKlymYBmx/Listeners', 23:58:00 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 23:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:00 INFO - 'USER': 'cltbld', 23:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:00 INFO - 'XPC_FLAGS': '0x0', 23:58:00 INFO - 'XPC_SERVICE_NAME': '0', 23:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:00 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 23:58:00 INFO - Cleaning up... 23:58:00 INFO - Return code: 0 23:58:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:58:00 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')]} 23:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:00 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')]} 23:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:00 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 0x10237a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102357228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66946f2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229e9f0>, '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 0x101ffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022918c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/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.TTKlymYBmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:58:00 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 23:58:00 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 23:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/Render', 23:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:00 INFO - 'HOME': '/Users/cltbld', 23:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:00 INFO - 'LOGNAME': 'cltbld', 23:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:00 INFO - 'MOZ_NO_REMOTE': '1', 23:58:00 INFO - 'NO_EM_RESTART': '1', 23:58:00 INFO - 'PAGER': '/bin/cat', 23:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:00 INFO - 'PWD': '/builds/slave/test', 23:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:00 INFO - 'SHELL': '/bin/bash', 23:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TTKlymYBmx/Listeners', 23:58:00 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 23:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:00 INFO - 'USER': 'cltbld', 23:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:00 INFO - 'XPC_FLAGS': '0x0', 23:58:00 INFO - 'XPC_SERVICE_NAME': '0', 23:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:00 INFO - Downloading/unpacking psutil>=0.7.1 23:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:58:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:58:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:58:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:58:03 INFO - Installing collected packages: psutil 23:58:03 INFO - Running setup.py install for psutil 23:58:03 INFO - building 'psutil._psutil_osx' extension 23:58:03 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 23:58:03 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 23:58:03 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 23:58:03 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 23:58:03 INFO - building 'psutil._psutil_posix' extension 23:58:03 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 23:58:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:58:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:58:03 INFO - ^ 23:58:04 INFO - 1 warning generated. 23:58:04 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 23:58:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:58:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:58:04 INFO - Successfully installed psutil 23:58:04 INFO - Cleaning up... 23:58:04 INFO - Return code: 0 23:58:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:58: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')]} 23:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58: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')]} 23:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:04 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 0x10237a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102357228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66946f2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229e9f0>, '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 0x101ffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022918c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/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.TTKlymYBmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:58:04 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 23:58:04 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 23:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/Render', 23:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:04 INFO - 'HOME': '/Users/cltbld', 23:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:04 INFO - 'LOGNAME': 'cltbld', 23:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:04 INFO - 'MOZ_NO_REMOTE': '1', 23:58:04 INFO - 'NO_EM_RESTART': '1', 23:58:04 INFO - 'PAGER': '/bin/cat', 23:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:04 INFO - 'PWD': '/builds/slave/test', 23:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:04 INFO - 'SHELL': '/bin/bash', 23:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TTKlymYBmx/Listeners', 23:58:04 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 23:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:04 INFO - 'USER': 'cltbld', 23:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:04 INFO - 'XPC_FLAGS': '0x0', 23:58:04 INFO - 'XPC_SERVICE_NAME': '0', 23:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:58:04 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 23:58:04 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 23:58:04 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 23:58:04 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 23:58:04 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 23:58:04 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 23:58:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:58:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:58:06 INFO - Installing collected packages: mozsystemmonitor 23:58:06 INFO - Running setup.py install for mozsystemmonitor 23:58:06 INFO - Successfully installed mozsystemmonitor 23:58:06 INFO - Cleaning up... 23:58:06 INFO - Return code: 0 23:58:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:58:06 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')]} 23:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:06 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')]} 23:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:06 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 0x10237a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102357228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66946f2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229e9f0>, '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 0x101ffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022918c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/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.TTKlymYBmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:58:06 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 23:58:06 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 23:58:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/Render', 23:58:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:06 INFO - 'HOME': '/Users/cltbld', 23:58:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:06 INFO - 'LOGNAME': 'cltbld', 23:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:06 INFO - 'MOZ_NO_REMOTE': '1', 23:58:06 INFO - 'NO_EM_RESTART': '1', 23:58:06 INFO - 'PAGER': '/bin/cat', 23:58:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:06 INFO - 'PWD': '/builds/slave/test', 23:58:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:06 INFO - 'SHELL': '/bin/bash', 23:58:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TTKlymYBmx/Listeners', 23:58:06 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 23:58:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:06 INFO - 'USER': 'cltbld', 23:58:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:06 INFO - 'XPC_FLAGS': '0x0', 23:58:06 INFO - 'XPC_SERVICE_NAME': '0', 23:58:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:07 INFO - Downloading/unpacking blobuploader==1.2.4 23:58:07 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 23:58:07 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 23:58:07 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 23:58:07 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 23:58:07 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 23:58:07 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 23:58:09 INFO - Downloading blobuploader-1.2.4.tar.gz 23:58:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:58:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:58:09 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 23:58:09 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 23:58:09 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 23:58:09 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 23:58:09 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 23:58:09 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 23:58:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:58:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:58:10 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 23:58:10 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 23:58:10 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 23:58:10 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 23:58:10 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 23:58:10 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 23:58:10 INFO - Downloading docopt-0.6.1.tar.gz 23:58:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:58:10 INFO - Installing collected packages: blobuploader, requests, docopt 23:58:10 INFO - Running setup.py install for blobuploader 23:58:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:58:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:58:10 INFO - Running setup.py install for requests 23:58:11 INFO - Running setup.py install for docopt 23:58:11 INFO - Successfully installed blobuploader requests docopt 23:58:11 INFO - Cleaning up... 23:58:11 INFO - Return code: 0 23:58:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58:11 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')]} 23:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:11 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')]} 23:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:11 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 0x10237a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102357228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66946f2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229e9f0>, '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 0x101ffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022918c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/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.TTKlymYBmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:58:11 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 23:58:11 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 23:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/Render', 23:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:11 INFO - 'HOME': '/Users/cltbld', 23:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:11 INFO - 'LOGNAME': 'cltbld', 23:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:11 INFO - 'MOZ_NO_REMOTE': '1', 23:58:11 INFO - 'NO_EM_RESTART': '1', 23:58:11 INFO - 'PAGER': '/bin/cat', 23:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:11 INFO - 'PWD': '/builds/slave/test', 23:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:11 INFO - 'SHELL': '/bin/bash', 23:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TTKlymYBmx/Listeners', 23:58:11 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 23:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:11 INFO - 'USER': 'cltbld', 23:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:11 INFO - 'XPC_FLAGS': '0x0', 23:58:11 INFO - 'XPC_SERVICE_NAME': '0', 23:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:58:11 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-oJuavp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:58:11 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-dYRWUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:58:11 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-IQLfx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:58:11 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qdt9sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:58:12 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-rLQAg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:58:12 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-VTJ49r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:58:12 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-wkvibW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:58:12 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-jgvzk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:58:12 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-79vf_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:58:12 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ye3pXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:58:12 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-VBlrEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:58:12 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-X5Vccx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:58:12 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-4n35uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:58:13 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-tyRpS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:13 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-o36UVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:58:13 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-KxVcuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:58:13 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-bcwTUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:58:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:58:13 INFO - Running setup.py install for manifestparser 23:58:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:58:13 INFO - Running setup.py install for mozcrash 23:58:13 INFO - Running setup.py install for mozdebug 23:58:13 INFO - Running setup.py install for mozdevice 23:58:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:58:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:58:14 INFO - Running setup.py install for mozfile 23:58:14 INFO - Running setup.py install for mozhttpd 23:58:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:58:14 INFO - Running setup.py install for mozinfo 23:58:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:58:14 INFO - Running setup.py install for mozInstall 23:58:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:58:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:58:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:58:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:58:14 INFO - Running setup.py install for mozleak 23:58:14 INFO - Running setup.py install for mozlog 23:58:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:58:14 INFO - Running setup.py install for moznetwork 23:58:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:58:15 INFO - Running setup.py install for mozprocess 23:58:15 INFO - Running setup.py install for mozprofile 23:58:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:58:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:58:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:58:15 INFO - Running setup.py install for mozrunner 23:58:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:58:15 INFO - Running setup.py install for mozscreenshot 23:58:15 INFO - Running setup.py install for moztest 23:58:15 INFO - Running setup.py install for mozversion 23:58:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:58:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:58:15 INFO - Cleaning up... 23:58:16 INFO - Return code: 0 23:58:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10237a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102357228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66946f2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229e9f0>, '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 0x101ffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022918c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/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.TTKlymYBmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:58:16 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 23:58:16 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 23:58:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/Render', 23:58:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:16 INFO - 'HOME': '/Users/cltbld', 23:58:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:16 INFO - 'LOGNAME': 'cltbld', 23:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:16 INFO - 'MOZ_NO_REMOTE': '1', 23:58:16 INFO - 'NO_EM_RESTART': '1', 23:58:16 INFO - 'PAGER': '/bin/cat', 23:58:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:16 INFO - 'PWD': '/builds/slave/test', 23:58:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:16 INFO - 'SHELL': '/bin/bash', 23:58:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TTKlymYBmx/Listeners', 23:58:16 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 23:58:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:16 INFO - 'USER': 'cltbld', 23:58:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:16 INFO - 'XPC_FLAGS': '0x0', 23:58:16 INFO - 'XPC_SERVICE_NAME': '0', 23:58:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:58:16 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-0r5CiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:58:16 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)) 23:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:58:16 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-VlxU8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:58:16 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)) 23:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:58:16 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-P1pWqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:58:16 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)) 23:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:58:16 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Tsko_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:58:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:58:16 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-S2fxu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:58:16 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)) 23:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:58:16 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-elAj4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:58:16 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)) 23:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:58:16 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Z62QTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:58:17 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-UmEKTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:58:17 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)) 23:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:58:17 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qo0S13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:58:17 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)) 23:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:58:17 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-eIwgEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:58:17 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-jYmGDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:58:17 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)) 23:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:58:17 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-E6dW01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:58:17 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)) 23:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:58:17 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-lzioSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:58:17 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)) 23:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:58:17 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-haxMqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:58:17 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)) 23:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:17 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-6zsc6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:17 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)) 23:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:58:17 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-BwhK0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:58:17 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)) 23:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:58:17 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-2bDDUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:58:18 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)) 23:58:18 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)) 23:58:18 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)) 23:58:18 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)) 23:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:58:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:58:18 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 23:58:18 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 23:58:18 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 23:58:18 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 23:58:18 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 23:58:18 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 23:58:20 INFO - Downloading blessings-1.5.1.tar.gz 23:58:20 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 23:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:58:20 INFO - Installing collected packages: blessings 23:58:20 INFO - Running setup.py install for blessings 23:58:20 INFO - Successfully installed blessings 23:58:20 INFO - Cleaning up... 23:58:20 INFO - Return code: 0 23:58:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:58:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:58:20 INFO - Reading from file tmpfile_stdout 23:58:20 INFO - Current package versions: 23:58:20 INFO - blessings == 1.5.1 23:58:20 INFO - blobuploader == 1.2.4 23:58:20 INFO - docopt == 0.6.1 23:58:20 INFO - manifestparser == 1.1 23:58:20 INFO - mozInstall == 1.12 23:58:20 INFO - mozcrash == 0.16 23:58:20 INFO - mozdebug == 0.1 23:58:20 INFO - mozdevice == 0.47 23:58:20 INFO - mozfile == 1.2 23:58:20 INFO - mozhttpd == 0.7 23:58:20 INFO - mozinfo == 0.9 23:58:20 INFO - mozleak == 0.1 23:58:20 INFO - mozlog == 3.1 23:58:20 INFO - moznetwork == 0.27 23:58:20 INFO - mozprocess == 0.22 23:58:20 INFO - mozprofile == 0.27 23:58:20 INFO - mozrunner == 6.11 23:58:20 INFO - mozscreenshot == 0.1 23:58:20 INFO - mozsystemmonitor == 0.0 23:58:20 INFO - moztest == 0.7 23:58:20 INFO - mozversion == 1.4 23:58:20 INFO - psutil == 3.1.1 23:58:20 INFO - requests == 1.2.3 23:58:20 INFO - wsgiref == 0.1.2 23:58:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58: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')]} 23:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58: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')]} 23:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10237a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102357228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd66946f2f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10229e9f0>, '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 0x101ffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022918c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/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.TTKlymYBmx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 23:58:20 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 23:58:20 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 23:58:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/Render', 23:58:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:20 INFO - 'HOME': '/Users/cltbld', 23:58:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:20 INFO - 'LOGNAME': 'cltbld', 23:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:20 INFO - 'MOZ_NO_REMOTE': '1', 23:58:20 INFO - 'NO_EM_RESTART': '1', 23:58:20 INFO - 'PAGER': '/bin/cat', 23:58:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:20 INFO - 'PWD': '/builds/slave/test', 23:58:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:20 INFO - 'SHELL': '/bin/bash', 23:58:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TTKlymYBmx/Listeners', 23:58:20 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 23:58:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:20 INFO - 'USER': 'cltbld', 23:58:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:20 INFO - 'XPC_FLAGS': '0x0', 23:58:20 INFO - 'XPC_SERVICE_NAME': '0', 23:58:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:21 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)) 23:58:21 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)) 23:58:21 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)) 23:58:21 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)) 23:58:21 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)) 23:58:21 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)) 23:58:21 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)) 23:58:21 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)) 23:58:21 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)) 23:58:21 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)) 23:58:21 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)) 23:58:21 INFO - Cleaning up... 23:58:21 INFO - Return code: 0 23:58:21 INFO - Running post-action listener: _resource_record_post_action 23:58:21 INFO - Running post-action listener: _start_resource_monitoring 23:58:21 INFO - Starting resource monitoring. 23:58:21 INFO - ##### 23:58:21 INFO - ##### Running install step. 23:58:21 INFO - ##### 23:58:21 INFO - Running pre-action listener: _resource_record_pre_action 23:58:21 INFO - Running main action method: install 23:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:58:21 INFO - Reading from file tmpfile_stdout 23:58:21 INFO - Detecting whether we're running mozinstall >=1.0... 23:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:58:21 INFO - Reading from file tmpfile_stdout 23:58:21 INFO - Output received: 23:58:21 INFO - Usage: mozinstall [options] installer 23:58:21 INFO - Options: 23:58:21 INFO - -h, --help show this help message and exit 23:58:21 INFO - -d DEST, --destination=DEST 23:58:21 INFO - Directory to install application into. [default: 23:58:21 INFO - "/builds/slave/test"] 23:58:21 INFO - --app=APP Application being installed. [default: firefox] 23:58:21 INFO - mkdir: /builds/slave/test/build/application 23:58:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 23:58:52 INFO - Reading from file tmpfile_stdout 23:58:52 INFO - Output received: 23:58:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:58:52 INFO - Running post-action listener: _resource_record_post_action 23:58:52 INFO - ##### 23:58:52 INFO - ##### Running run-tests step. 23:58:52 INFO - ##### 23:58:52 INFO - Running pre-action listener: _resource_record_pre_action 23:58:52 INFO - Running main action method: run_tests 23:58:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:58:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:58:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:58:52 INFO - 2015-11-23 23:58:52.105 screenresolution[1928:10330] starting screenresolution argv=screenresolution get 23:58:52 INFO - 2015-11-23 23:58:52.108 screenresolution[1928:10330] Display 0: 1600x1200x32@60 23:58:52 INFO - 2015-11-23 23:58:52.113 screenresolution[1929:10333] starting screenresolution argv=screenresolution list 23:58:52 INFO - Available Modes on Display 0 23:58:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:58:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:58:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:58:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:58:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:58:52 INFO - Intel Iris: 23:58:52 INFO - Chipset Model: Intel Iris 23:58:52 INFO - Type: GPU 23:58:52 INFO - Bus: Built-In 23:58:52 INFO - VRAM (Dynamic, Max): 1536 MB 23:58:52 INFO - Vendor: Intel (0x8086) 23:58:52 INFO - Device ID: 0x0a2e 23:58:52 INFO - Revision ID: 0x0009 23:58:52 INFO - Displays: 23:58:52 INFO - Display: 23:58:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:58:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:58:52 INFO - Display Serial Number: 1600x1200 60 23:58:52 INFO - Main Display: Yes 23:58:52 INFO - Mirror: Off 23:58:52 INFO - Online: Yes 23:58:52 INFO - Rotation: Supported 23:58:52 INFO - Return code: 0 23:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:58:52 INFO - Python 2.7.3 23:58:52 INFO - Return code: 0 23:58:52 INFO - grabbing minidump binary from tooltool 23:58: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')]} 23:58: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 0x10229e9f0>, '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 0x101ffddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1022918c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:58: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 23:58: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 23:58:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:58:52 INFO - Return code: 0 23:58:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:58:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:58:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:58:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:58:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost'] in /builds/slave/test/build 23:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --webServer localhost 23:58:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2OP71man3n/Render', 23:58:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:52 INFO - 'HOME': '/Users/cltbld', 23:58:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:52 INFO - 'LOGNAME': 'cltbld', 23:58:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:58:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:52 INFO - 'MOZ_NO_REMOTE': '1', 23:58:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:58:52 INFO - 'NO_EM_RESTART': '1', 23:58:52 INFO - 'PAGER': '/bin/cat', 23:58:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:52 INFO - 'PWD': '/builds/slave/test', 23:58:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:58:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:52 INFO - 'SHELL': '/bin/bash', 23:58:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TTKlymYBmx/Listeners', 23:58:52 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 23:58:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:52 INFO - 'USER': 'cltbld', 23:58:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:52 INFO - 'XPC_FLAGS': '0x0', 23:58:52 INFO - 'XPC_SERVICE_NAME': '0', 23:58:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:58:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost'] with output_timeout 3600 23:58:52 INFO - mozversion INFO | application_buildid: 20151123230131 23:58:52 INFO - mozversion INFO | application_changeset: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 23:58:52 INFO - mozversion INFO | application_display_name: Nightly 23:58:52 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:58:52 INFO - mozversion INFO | application_name: Firefox 23:58:52 INFO - mozversion INFO | application_remotingname: firefox 23:58:52 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 23:58:52 INFO - mozversion INFO | application_vendor: Mozilla 23:58:52 INFO - mozversion INFO | application_version: 45.0a1 23:58:52 INFO - mozversion INFO | platform_buildid: 20151123230131 23:58:52 INFO - mozversion INFO | platform_changeset: 4dca10306d58d2e87cbed46a72472b62c17b0ec9 23:58:52 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 23:58:52 INFO - mozversion INFO | platform_version: 45.0a1 23:58:52 INFO - 2015-11-23 23:58:52,651 DEBUG : using testdate: 1448351932 23:58:52 INFO - 2015-11-23 23:58:52,651 DEBUG : actual date: 1448351932 23:58:52 INFO - 2015-11-23 23:58:52,996 INFO : starting webserver on 'localhost:49515' 23:58:52 INFO - 2015-11-23 23:58:52,997 INFO : Starting test suite t-yosemite-r7-0028.e 23:58:52 INFO - 2015-11-23 23:58:52,997 INFO : Starting test dromaeo_css 23:58:52 INFO - 2015-11-23 23:58:52,997 DEBUG : operating with platform_type : mac_ 23:58:52 INFO - 2015-11-23 23:58:52,999 INFO : Initialising browser for dromaeo_css test... 23:58:53 INFO - 2015-11-23 23:58:53,011 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpUesyRe/profile http://localhost:49515/getInfo.html 23:58:55 INFO - 2015-11-23 23:58:55,617 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:58:55 INFO - 2015-11-23 23:58:55,618 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:58:55 INFO - 2015-11-23 23:58:55,618 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:58:55 INFO - 2015-11-23 23:58:55,618 DEBUG : BROWSER_OUTPUT: __metrics 23:58:56 INFO - 2015-11-23 23:58:56,184 INFO : Browser initialized. 23:58:56 INFO - 2015-11-23 23:58:56,185 INFO : Running cycle 1/1 for dromaeo_css test... 23:58:56 INFO - 2015-11-23 23:58:56,185 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpUesyRe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:59:08 INFO - 2015-11-23 23:59:08,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 237461504 23:59:08 INFO - 2015-11-23 23:59:08,041 DEBUG : BROWSER_OUTPUT: 23:59:57 INFO - 2015-11-23 23:59:57,731 DEBUG : BROWSER_OUTPUT: 1448351997727 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] 00:02:08 INFO - 2015-11-24 00:02:08,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49515/tests/dromaeo/cssquery-ext.html) 00:02:09 INFO - 2015-11-24 00:02:09,816 DEBUG : BROWSER_OUTPUT: RSS: Main: 251793408 00:02:09 INFO - 2015-11-24 00:02:09,816 DEBUG : BROWSER_OUTPUT: 00:05:11 INFO - 2015-11-24 00:05:11,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-ext.html (next: http://localhost:49515/tests/dromaeo/cssquery-jquery.html) 00:05:12 INFO - 2015-11-24 00:05:12,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 263643136 00:05:12 INFO - 2015-11-24 00:05:12,480 DEBUG : BROWSER_OUTPUT: 00:08:14 INFO - 2015-11-24 00:08:14,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49515/tests/dromaeo/cssquery-mootools.html) 00:08:14 INFO - 2015-11-24 00:08:14,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 265072640 00:08:14 INFO - 2015-11-24 00:08:14,623 DEBUG : BROWSER_OUTPUT: 00:11:16 INFO - 2015-11-24 00:11:16,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49515/tests/dromaeo/cssquery-prototype.html) 00:11:16 INFO - 2015-11-24 00:11:16,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 267661312 00:11:16 INFO - 2015-11-24 00:11:16,811 DEBUG : BROWSER_OUTPUT: 00:14:19 INFO - 2015-11-24 00:14:19,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49515/tests/dromaeo/cssquery-yui.html) 00:14:19 INFO - 2015-11-24 00:14:19,858 DEBUG : BROWSER_OUTPUT: RSS: Main: 268382208 00:14:19 INFO - 2015-11-24 00:14:19,858 DEBUG : BROWSER_OUTPUT: 00:17:22 INFO - 2015-11-24 00:17:22,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/dromaeo/cssquery-yui.html (next: http://localhost:49515/tests/dromaeo/cssquery-dojo.html) 00:17:22 INFO - 2015-11-24 00:17:22,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 273457152 00:17:22 INFO - 2015-11-24 00:17:22,370 DEBUG : BROWSER_OUTPUT: 00:17:22 INFO - 2015-11-24 00:17:22,371 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:17:22 INFO - 2015-11-24 00:17:22,372 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:17:22 INFO - 2015-11-24 00:17:22,372 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:17:22 INFO - 2015-11-24 00:17:22,372 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:17:22 INFO - 2015-11-24 00:17:22,373 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2881.4381195666847;3524.295140971805;3550.1302180965636;3564.3227786720536;3575.2491976684887;5826.679532625709;5842.88314233715;5842.883142337156;5865.912011319833;5875.177475153482;4474.328850672401;5679.460451257134;5819.9418005819925;5851.76592936282;5888.970555147229;5207.088759467097;5272.868178295555;5275.155975043994;5369.087255166612;5389.245505629215;5390.434004429537;5424.484673955968;5432.6468779529205;5436.075867102582;5443.945560544384;5120.078385890538;5184.533391994739;5404.540614047811;5417.485338892799;5481.451854814526;5233.319668443116;5319.601029922771;5338.706371149585;5361.946380536184;5364.22218778275;3973.721839471238;5087.847364579032;5326.280952071459;5337.226102215157;5342.759575819097;5532.75102620383;5546.112621980464;5655.8586035349035;5852.326982397036;5853.795117170921;5344.973275133639;6273.780417685359;6338.176037115191;6380.553361264713;6410.294867564564;4551.8634440966825;6425.710843012076;6427.06807512908;6427.325130861239;6436.452901503378;5854.975379308604;5966.791162309299;5969.850753731104;5975.312839023568;5994.130851026577;6285.937140628626;6318.905216421757;6393.712282947278;6425.325340839238;6436.549441539048;6317.431431171217;6360.872782544416;6362.141110949962;6396.072569477493;6403.135576697179;5530.972345138249;5979.910301345483;6209.658468784261;6317.494600432046;6335.1447554579545;6225.128482012522;6355.745770169234;6360.236771587439;6369.71336289868;6397.072424498515;5190.636655434083;6078.632307730813;6335;6377.840553986188;6400.0719895614875;4291.957080429156;4745.098431298043;4904.2643603459055;4919.212925931905;5093.8726531836255;4442.888927776767;4556.567126123079;4582.587567118975;4614.469336026333;4624.9768751156025;5934.198883150806;5941.792037278675;5948.583599148018;6000.909986350208;6007.15899774032;6403.423691867754;6406.135171751847;6411.422971932455;6418.390252925965;6419;5738.311402631627;5835.912461313083;5858.443447872445;5963.612365196248;5993.640381577119;5565.666060036411;5566.944330556724;5567.498925096761;5573.721313934287;5576.052071147915;6277.2153480814895;6411.519136064814;6512.674366281667;6532.281449040602;6537.869242615121;6233.314335423009;6338.366163383625;6347.428731414195;6354.872902542016;6374.649394283173;6448.806535803933;6511.9348806511325;6527.967360163168;6532.510061745293;6549.574277671936;6116.305337585956;6229.719662615103;6364.840878978062;6373.904391434039;6391.265004524539;5021.598272138293;6266.373362663697;6305.653189074645;6406.359364063556;6408.967955160194;5391.7304134793885;6269.153664255449;6277.591956522811;6335.683215839282;6346.1432706585865;6094.177286066324;6104.732011601517;6161.291451483136;6252.249730032425;6320.4311611955145;6072.514198864169;6147.815565533041;6170.969145154246;6187.16473276102;6198.876022479615;6321.5574909757715;6329.050642403677;6340.207474065742;6347.3652634738;6352.745890164527;4717.3159891816185;5956.315023772148;6036.7887123952205;6066.636001839904;6162.568620196723 00:17:22 INFO - 2015-11-24 00:17:22,375 DEBUG : BROWSER_OUTPUT: |1;ext.html;576.9767364871575;582.6242073862359;587.248322147651;587.9147523609074;637.8773358888358;41912;42197.78901105494;42359.78820105899;42412.15175696484;42456.36315455263;40143.79928100356;45948.540514594846;46186;46241.07517849641;46481.070378592405;9839.606415743361;9985.75035624108;9994.700158995242;10004.949975250114;10040.548175332091;9850.802983940353;9880.555375008142;9921.15670168033;9959.452230127376;9970.65102721405;9884.357516761424;9960.95019524905;9968.750781230454;9988.101070903616;9998.350107243043;8781.64873405063;9830.55762490686;9883.752906177331;9909.355891867006;9950.402975821402;9770.658026969093;9908.504574771232;9936;9942.353747006493;9943;42550.78724606388;42569.36145957813;42877.57122428767;42946.355804662955;43030.35454468185;3146.4553728245423;3209.759268054905;3211.213252753067;3235.7249633781157;3246.2695893423793;29074;29618.70381296181;29775.404491910256;30699.69300307013;31331.903383381472;2771;2795.175423250146;2826.915192544227;2925.575791510219;2958.6745457999605;499747;500098;505675.99999999633;507190;509000;47546.762266188445;47983.04033919302;74333;74379.25620743832;74977.62511187409;47816.28275575869;47983.28025079626;48004.75997619989;48192.759036204596;48345.758271209124;15257.542273731584;15300.311485983157;15310.846891531164;15429.768553471707;15435.922820386051;12009.939950300193;12140.635780926586;12152.57465988686;12165.878341216474;12270.079744019235;12642.431090600945;14706.852931470763;15166.165860877758;15491.302891369915;15497.380104795908;5567.721613919369;6549.050387693757;6670.132882725312;6697;6704.128463299739;732.6263605561202;886.2289807867197;915.2174890468686;988.7033889833021;1045.2892033417197;26147.346316342242;30359.696403036127;30487.69512304893;31180.75276988895;31181.68818311788;1043.6190790361463;1070.6734445994045;1074.258761454594;1075.3278651696687;1137.2891942535914;12846.586875443694;15537.223138843012;15635.921820390826;15716.214189290718;15720.449784257497;509729;523756.38121809147;532343;539444;540489;60609;61854;62234.37765622376;62653.68673156696;62709.37290627127;1434.211183848879;1434.5050957419674;1457.4971634785982;1462.1081140504284;1597.0258142533046;23540.882295588413;30347.089587312417;30374.69625303807;30825.537616936213;31037.68962310348;54813.1778023338;55237;55371.89256214934;55404.72297638486;55488;498685;499923.50038249575;501383;501662;503702;34401;47503;48115;49340.753296234725;49413.75293123655;47823.5217647833;48352.758236208596;48596;49765.50234497753;49800.25299620581;41107;42509.08709108036;42513.36229956615;43236.783816080715;43394.69815905528;38842.22315553729;39781.60218397779;39801.00497487586;39898.20203595854;42004.57995420129;39036.80481597574;39175;40920.59079409287;42133;42638.57361426346;33047.834760826045;34624;34869;34971.12572185614;35032.47451288182;25859.353516162246;26601.201963941112;27199.72800271972;27632.86183569069;27702.584461232695 00:17:22 INFO - 2015-11-24 00:17:22,378 DEBUG : BROWSER_OUTPUT: |2;jquery.html;308.7730518069219;324.9886253981111;367.1518791591424;367.71318371670105;369.48087936449264;19617.50956226095;20253.696194557095;20559;21046;21096.789032109675;11969.64091077269;14327.355269012893;19478.51303717404;21222.363329100113;21246.362609121712;5134.358205224347;5230.450802665722;5254.185601231796;5259.395169555492;5260;5218.217267409881;5761.337446193699;6103.05402662588;6114.69426528674;6118.632882027093;3996.500437445319;4119.855805046824;6044.153818465418;6058.333583305833;6064.757409703607;5551.861203469925;5714.257146570961;5747.965366234076;5748.82753517393;5761.9135712964335;5503.3120859892515;5503.807366742185;5535.363433205192;5810.157527158538;5855.707214639251;13097.345132743325;23846.52306953851;25478.617820732703;25948.61077083845;26080.087196948014;1956.7945365736534;2009.2666176845346;2178.498945242603;2261.4685548895995;2392.964105538418;9779.951100244525;9840.966698496697;10028.849567256497;10147.847782283272;15302.464413745576;1759.8592112630959;1770.2034084661955;1779.2793918463044;1785.57146284892;1855.656703509855;88749.55625221833;89990.65014024795;102763;108300;110078.34882476769;10285.302925017288;10998.450077496092;11061.446927653586;11192.720181995352;11222.607208747819;10754.623588174376;13210.933945330213;13283.601491955256;13303;13309.134906231064;7847.450678452567;8088.555129467818;8209.958950205211;8239.588020598947;8275.751727448187;8093.595320233965;8201.876971845428;8246.134155913664;8288.958555207306;8405.95797021011;4266.189424009428;4301.806418711166;4332.090261045153;4348.412964249849;4374.4094547236355;1859.1355019915804;1882.774067111928;1882.905854707259;1889.4048374761906;1895.090356628826;400.4053979839935;408.25289719812673;905.5924833824805;1011.2870426349406;1030.4487099401783;10937.960893715084;11594.420278986017;11687.532498699957;11825.231359961575;11960.461779219955;429.9161663475592;444.88210624184615;446.2324801341687;448.59850433862164;450.10429245801276;6072.908906366408;6127.234095738033;6148.354422785633;6190.721417536131;6210.347913469111;722578;733869;736530;738146;749239;130975.34512327377;135070.3246483781;135106.32446837702;136236;136391;1166.7491489329834;1178.4696886401155;1180.9822852657217;1198.988010119905;1207.076586411396;18710.86703411468;18859.434216973514;19288.710669340253;19333.51666208356;19409.8059019408;47462.050758985315;50319.49680503295;54456;55071.347859564274;55125.44874551203;70355;72984;74243.6287818579;74487;74533.627331863;9671.806563868542;9896.604135834774;9937.25470589723;9980.60077596888;10013.39919604826;14355.282235888373;19915.402537923885;20067.899660501604;20191.19235230633;20618.175272988912;12976.935115324362;15995.840041599435;16263.918680406996;16318.26567804428;16387.67224655524;15640.530784076496;16006;16046.919765401099;16121.032738035756;16244.02535847853;16296.918515407348;16621.335146594483;16786.58033549171;16968.57578560546;17001.06494142834;9018.143276388733;9682.27382946296;9740.318177727491;9808.068233517804;9847.556859941464;11600.825987610024;15892.841071589599;16011.759823602888;16070.196490175678;16240.67518649644 00:17:22 INFO - 2015-11-24 00:17:22,380 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1566.4908904606;1582.0665807173766;1911.5507855653918;1949.4541528372042;1964.7936966618504;7579.8863017054655;7723.459357844939;8094.19058094191;8208.630611622477;8262.75211743648;8100.298937223175;8293.253607175353;8316.91683083169;8414.074451810297;8422.494650320985;2362.8818559072065;2386.677798497198;2398.556267090594;2399.712034555847;2402.9879850600723;2080.6878968154824;2399.5440866235444;2407.6990376202975;2432.8661923594195;2433.1605596069326;2356.528694261146;2377.2511658827416;2379.2981070584133;2389.7012873390827;2406.975930240693;2349.612313968193;2371.8695471749047;2371.9644205336936;2393.700787401575;2395.245497668229;2206.007296716484;2263.9434014149615;2367.183321753992;2398.136670798511;2422.3338581889943;8312.33501319899;8351.457155284948;8400.075991640915;8435.240828325419;8448.57757112142;4575.885602859922;5091.134507133796;5186;5186.0665080285535;5195.350581177353;3174.2699179188917;3407.216340241758;3414.9487757683655;3486.9128271793406;3490.162361033359;1018.1040684197933;1041.406398352939;1053.2048303530862;1070.175964507325;1076.7039064257312;10965.56137754489;10972.725681857937;10989.670309890636;10995.230333876632;10998.34009959405;4641.651876109306;4698.906021879543;4739.028499157665;4743.075100355398;4770.189067858472;9564.4739539326;9573.234141268682;9578.377405468622;9583.377080489747;9596.280278978966;5110.872228194251;5170.741462926839;5185.714785686823;5200.427952925175;5205.141151710001;4050.513938327361;4563.840265590688;4704.200285951397;4710.3405523226775;4718.363020992191;3220.533022711694;3285.3593549258144;3299.9175020624198;3840.0975770693863;3901.31726947783;1280.993595032019;1288.890444312244;1290.0840403313564;1290.7095903421844;1299.7920332746714;1357.6741582020245;1395.3651088754593;1395.818543589327;1408.6126315263384;1423.7437261293067;7771.92228077712;7888.802779930433;7920.247576480225;7939.007624046994;7960.641771120314;498.61357447978105;501.39081016565046;501.7190373390913;503.7733020140951;515.5720751776017;5987.670678112659;6124.724387402578;6152.200213972155;6153.384661533811;6181.84545386369;9457.858132128023;9919.752006199758;9923;10032.147267482345;10034.996500350053;9875.358101723365;9894.653687120915;9901.207903367856;10031.247656425798;10053.849192262122;7762;7799.18108598589;7799.3760499159935;7802.375809935192;7858.567778772108;7553.622318884144;7615.162332143571;7679.769606911802;7690.615469226628;7710;8917.598708058023;8935.821283574422;9034.2320902724;9046.411983221069;9111.407758495676;7623.847523049619;8436.325093992344;9033.774155645899;9288.767780805534;9308.813823723623;6027.819165425044;7084.397826184626;7099.609521476162;7165.7850264492145;7171.1753148386515;7774.416918731004;7849.254320839739;7901.604919754104;7939.483933544301;7951.84096318082;6291.245050593958;7398.889016664862;7403.7408690695565;7531.246875312425;7614.581198034161;7405.296496832792;7411.444141689287;7433;7510.061242344707;7514.924850751641;7381.926180738124;7517.0227870378685;7520.699172033057;7534.849303014019;7602.1257555381835;6748.0552722617895;6824.488163387865;6825.89761153593;6847.452203823583;6876.449884009167;6855.6572171390235;6968.233494315723;6968.895466568107;6981.616011119234;6984.511084224056 00:17:22 INFO - 2015-11-24 00:17:22,381 DEBUG : BROWSER_OUTPUT: |4;prototype.html;304.88719173905656;306.46980723348594;313.9623245210575;333.1554509318877;336.8332675325714;6782.152230971129;6814.659267036641;6931.930680693192;7146.213916469191;7165.211826699059;5108.489151084889;6715;6847.144106986627;6857.245702972669;6884.449244060475;3565.3760591896444;4284.63580595649;4918.926216106761;4966.478519755427;4980.103581355354;4031.395290706388;4966.602671786249;4972.602191824663;4978.352814134158;4986.227134794094;4799.712017278957;4896.216605343146;4916.680415772963;4926.704397736147;4956.876078098058;4928.531789479994;4928.704277743329;4930.556249937487;4944.728039957801;4949.158643030693;3530.5877648940373;4007.6793856491413;4096.344584866407;4119.299719047769;4180.749155050707;6454.419102280817;6597.901031484484;6616.073749675049;6620.503462240303;6626.271110177877;5849.766009359663;5889.823305300848;5893;5901.29184497863;5914.349421563625;7235.674394652201;7442.925570744277;7458.664360103754;7460.813479663052;7497.775066748006;4717.905641887143;4720.268358404453;4721.480637129913;4725.905481890377;4728.66899317048;7857;7933.325667318342;7953.244441778022;7959.323457506119;7975.880361794578;4626.514216007338;4800.5199480051715;4805.471398146201;4821.987382649612;4825.9034819303415;4853.39332583427;4856.077345304381;4858.6356023298395;4861.805527778849;4873.512648735169;5828.854278643068;5855.3851845556455;5891.175235467038;5903.203067585907;5910.7931222407005;6545.443637290884;7139.75054365484;7519.661615227328;7534.849303013909;7545.584992825337;1481.9555413337616;1636.3291050669168;1678.1860797513195;1703.080336618237;1707.2488105233658;1069.2194697870443;1083.0469187115289;1083.2633809009792;1084.3385534823751;1090.3239991205344;6942.236354001056;6950.443964482829;6955.304469553004;6964.79105626832;6993.930060699429;7781.8832717509285;7783.494072885358;7791.532508049535;7802.219778022266;7840.882386764203;6533.967330163318;6785;6879.346462086194;6939.618320992293;6980.581165130108;3374.274530975852;3988.4216788565495;4053.581246563679;4071.5521292657786;4136.896577585524;7960.164182760726;8096.959515202387;8111;8112.18878112184;8114.391420643476;8099.433039687283;8128.268455839003;8136.959315203386;8145.307648849795;8149.14433984435;7889.132195458495;8152.714654987047;8168;8169.795755106051;8174.713885013996;6043.486303664238;7835.294823465915;7836.882446763189;7843.529388236724;7862.488938218998;6929.480288978246;7493.325600695964;7591.810204744926;7679.69281228767;7702.152763195932;6613.768518101843;6917.965410172917;8165.550894700848;8176.509409435453;8200.712975045844;4783.736894470699;4823.300621409946;4827.396575428072;4832;4864.416270047617;6924.653767311514;7301.46669199474;7616.885746713693;7874.448788584744;7912.248336408032;7080.256573059754;7522.172561018174;7541;7551.565202611486;7594.354479869052;6538.738450461929;7352.77941661751;7531.133919599316;7543.170251272465;7554.773356799305;7253.8186545336785;7307.561546307238;7346.742863999734;7362.3741981932135;7372.926270737224;6019.518438524995;7494.925050749423;7518.398528117628;7519.774406767806;7550.244975502405;7167.319104685047;7317.853642927005;7336.119665640157;7399.59302238382;7422 00:17:22 INFO - 2015-11-24 00:17:22,385 DEBUG : BROWSER_OUTPUT: |5;yui.html;732.264074605022;792.9444938854283;796.4385108498508;816.701903805111;852.0407910817748;15084.094954302736;15269.083854968696;15425.537233883002;15445.45940892069;15450.690986180283;13934.303284835743;14155.36300866461;14284.500042498514;14310.642233944156;14314.92638052145;756.6027835386411;764.7514557768719;944.8252073366432;971.7619183300066;974.5906719177963;959.3332633819498;964.1322809471496;964.3346091197087;977.0522593084696;980.8773903262093;996.2727209137335;1003.8795344558663;1017.1862509991977;1024.6106479537802;1025.2361990317224;985.3398223190479;1007.7027276953316;1015.0914931136665;1017.7760892603652;1018.032868774667;733.4792297468804;736.1423941108602;748.9026426564511;757.3978686943893;760.0575286644577;14907.329170187259;14918.925405373013;14963.381408253512;14990.925045374812;15085.773713394308;11077.667669969915;12714.87285127146;12726.490940362375;12837.29394883281;13159.473621055145;10064.641273428068;10116.949415252877;10221.02900224485;10330.58677652893;10678.305910115818;3184.792988455743;3564.8395822188063;3564.8930532084078;3574.57105147384;3582.2119133790525;79781;81530.59234703847;83986.16013839844;84780.57609711912;85240.57379713123;9651.855222171673;9789.412635241766;9853.162481189036;9901;10155.796884062278;21832.563348733252;22227.222047228268;22609.321720348085;22651.20720774798;22756.772432275797;7338.156112047076;7411.629418529052;7455.888161677579;7579.54522728627;7579.962100189574;3981.3629819229363;4119.732217405859;4131.586841315904;4131.793410329472;4154.376843473443;3246.65910079443;3270.084376374619;3284.868605255811;3301.834908254578;3305.801651900894;529.931108955841;590.9556783241275;601.0173366545729;601.8495376155961;619.9969000154971;515.4304493534665;566.2355819643531;615.8491169663461;630.9495240380759;639.5195123289569;8424.789380265542;8424.915750842536;8496.1079086695;8702.869456958151;8708.912910870937;503.62983207342575;529.4387948774234;601.6720887116531;609.1928195141455;631.6999425272959;4186.727862688916;4396.758178300161;4427.265293986446;4449.354843547668;4546.454425468899;95009.52495237479;95305;95737.52131239438;95844.52077739706;99819;88472.6729099064;89092;89206;89440.6583901242;89576.552117239;68380;69686;70936.64531677308;74039.88940165902;78747.60626196832;7858.724944626911;8575.528345941033;8997.595108220015;9081.909180908371;9102.726918192464;52621;53130.67173320698;53410.73294633502;54375;54375.72812135914;70943.58112837818;74263;74700.62649686717;74956.62521687575;75466;8960.238379737795;10699.197560183173;10714.089302409071;10769.515371808131;11195.552177912792;11958.35972845014;12099.213551119148;12156.331401772988;12271.938640306742;12625.179363341353;11414.201005929837;11709.473073711533;11863.466144023367;12257.816132757838;12347.876521234673;11469.426528673699;11742.647720568397;11845.407729613657;11893.167478276437;12478;11253.831192532283;11487.712807179887;11568.537258509565;11635.709107272385;12156.574519891761;8301.46040507365;9444.386114902509;9646.324757266924;9727.416355018722;9833.136458839961;9309.86035209486;9333;9917.45454000037;10011.649592264235;10050.79390473148 00:17:22 INFO - 2015-11-24 00:17:22,385 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:17:22 INFO - 2015-11-24 00:17:22,385 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:17:22 INFO - 2015-11-24 00:17:22,385 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,325 00:17:22 INFO - 2015-11-24 00:17:22,385 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:17:22 INFO - 2015-11-24 00:17:22,385 DEBUG : BROWSER_OUTPUT: __startTimestamp1448353042370__endTimestamp 00:17:22 INFO - 2015-11-24 00:17:22,385 DEBUG : BROWSER_OUTPUT: 00:17:22 INFO - 2015-11-24 00:17:22,385 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:17:22 INFO - 2015-11-24 00:17:22,386 DEBUG : BROWSER_OUTPUT: Number of tests: 6 00:17:22 INFO - 2015-11-24 00:17:22,386 DEBUG : BROWSER_OUTPUT: 00:17:22 INFO - 2015-11-24 00:17:22,386 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5809.84 Median:6000.91 stddev:704.82 (11.7%) stddev-sans-first:668.50 00:17:22 INFO - 2015-11-24 00:17:22,386 DEBUG : BROWSER_OUTPUT: Values: 2881.4 3524.3 3550.1 3564.3 3575.2 5826.7 5842.9 5842.9 5865.9 5875.2 4474.3 5679.5 5819.9 5851.8 5889.0 5207.1 5272.9 5275.2 5369.1 5389.2 5390.4 5424.5 5432.6 5436.1 5443.9 5120.1 5184.5 5404.5 5417.5 5481.5 5233.3 5319.6 5338.7 5361.9 5364.2 3973.7 5087.8 5326.3 5337.2 5342.8 5532.8 5546.1 5655.9 5852.3 5853.8 5345.0 6273.8 6338.2 6380.6 6410.3 4551.9 6425.7 6427.1 6427.3 6436.5 5855.0 5966.8 5969.9 5975.3 5994.1 6285.9 6318.9 6393.7 6425.3 6436.5 6317.4 6360.9 6362.1 6396.1 6403.1 5531.0 5979.9 6209.7 6317.5 6335.1 6225.1 6355.7 6360.2 6369.7 6397.1 5190.6 6078.6 6335.0 6377.8 6400.1 4292.0 4745.1 4904.3 4919.2 5093.9 4442.9 4556.6 4582.6 4614.5 4625.0 5934.2 5941.8 5948.6 6000.9 6007.2 6403.4 6406.1 6411.4 6418.4 6419.0 5738.3 5835.9 5858.4 5963.6 5993.6 5565.7 5566.9 5567.5 5573.7 5576.1 6277.2 6411.5 6512.7 6532.3 6537.9 6233.3 6338.4 6347.4 6354.9 6374.6 6448.8 6511.9 6528.0 6532.5 6549.6 6116.3 6229.7 6364.8 6373.9 6391.3 5021.6 6266.4 6305.7 6406.4 6409.0 5391.7 6269.2 6277.6 6335.7 6346.1 6094.2 6104.7 6161.3 6252.2 6320.4 6072.5 6147.8 6171.0 6187.2 6198.9 6321.6 6329.1 6340.2 6347.4 6352.7 4717.3 5956.3 6036.8 6066.6 6162.6 00:17:22 INFO - 2015-11-24 00:17:22,386 DEBUG : BROWSER_OUTPUT: 00:17:22 INFO - 2015-11-24 00:17:22,386 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66272.70 Median:42911.96 stddev:135998.54 (316.9%) stddev-sans-first:136290.60 00:17:22 INFO - 2015-11-24 00:17:22,388 DEBUG : BROWSER_OUTPUT: Values: 577.0 582.6 587.2 587.9 637.9 41912.0 42197.8 42359.8 42412.2 42456.4 40143.8 45948.5 46186.0 46241.1 46481.1 9839.6 9985.8 9994.7 10004.9 10040.5 9850.8 9880.6 9921.2 9959.5 9970.7 9884.4 9961.0 9968.8 9988.1 9998.4 8781.6 9830.6 9883.8 9909.4 9950.4 9770.7 9908.5 9936.0 9942.4 9943.0 42550.8 42569.4 42877.6 42946.4 43030.4 3146.5 3209.8 3211.2 3235.7 3246.3 29074.0 29618.7 29775.4 30699.7 31331.9 2771.0 2795.2 2826.9 2925.6 2958.7 499747.0 500098.0 505676.0 507190.0 509000.0 47546.8 47983.0 74333.0 74379.3 74977.6 47816.3 47983.3 48004.8 48192.8 48345.8 15257.5 15300.3 15310.8 15429.8 15435.9 12009.9 12140.6 12152.6 12165.9 12270.1 12642.4 14706.9 15166.2 15491.3 15497.4 5567.7 6549.1 6670.1 6697.0 6704.1 732.6 886.2 915.2 988.7 1045.3 26147.3 30359.7 30487.7 31180.8 31181.7 1043.6 1070.7 1074.3 1075.3 1137.3 12846.6 15537.2 15635.9 15716.2 15720.4 509729.0 523756.4 532343.0 539444.0 540489.0 60609.0 61854.0 62234.4 62653.7 62709.4 1434.2 1434.5 1457.5 1462.1 1597.0 23540.9 30347.1 30374.7 30825.5 31037.7 54813.2 55237.0 55371.9 55404.7 55488.0 498685.0 499923.5 501383.0 501662.0 503702.0 34401.0 47503.0 48115.0 49340.8 49413.8 47823.5 48352.8 48596.0 49765.5 49800.3 41107.0 42509.1 42513.4 43236.8 43394.7 38842.2 39781.6 39801.0 39898.2 42004.6 39036.8 39175.0 40920.6 42133.0 42638.6 33047.8 34624.0 34869.0 34971.1 35032.5 25859.4 26601.2 27199.7 27632.9 27702.6 00:17:22 INFO - 2015-11-24 00:17:22,388 DEBUG : BROWSER_OUTPUT: 00:17:22 INFO - 2015-11-24 00:17:22,388 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38563.56 Median:13935.79 stddev:121542.53 (872.2%) stddev-sans-first:121849.54 00:17:22 INFO - 2015-11-24 00:17:22,388 DEBUG : BROWSER_OUTPUT: Values: 308.8 325.0 367.2 367.7 369.5 19617.5 20253.7 20559.0 21046.0 21096.8 11969.6 14327.4 19478.5 21222.4 21246.4 5134.4 5230.5 5254.2 5259.4 5260.0 5218.2 5761.3 6103.1 6114.7 6118.6 3996.5 4119.9 6044.2 6058.3 6064.8 5551.9 5714.3 5748.0 5748.8 5761.9 5503.3 5503.8 5535.4 5810.2 5855.7 13097.3 23846.5 25478.6 25948.6 26080.1 1956.8 2009.3 2178.5 2261.5 2393.0 9780.0 9841.0 10028.8 10147.8 15302.5 1759.9 1770.2 1779.3 1785.6 1855.7 88749.6 89990.7 102763.0 108300.0 110078.3 10285.3 10998.5 11061.4 11192.7 11222.6 10754.6 13210.9 13283.6 13303.0 13309.1 7847.5 8088.6 8210.0 8239.6 8275.8 8093.6 8201.9 8246.1 8289.0 8406.0 4266.2 4301.8 4332.1 4348.4 4374.4 1859.1 1882.8 1882.9 1889.4 1895.1 400.4 408.3 905.6 1011.3 1030.4 10938.0 11594.4 11687.5 11825.2 11960.5 429.9 444.9 446.2 448.6 450.1 6072.9 6127.2 6148.4 6190.7 6210.3 722578.0 733869.0 736530.0 738146.0 749239.0 130975.3 135070.3 135106.3 136236.0 136391.0 1166.7 1178.5 1181.0 1199.0 1207.1 18710.9 18859.4 19288.7 19333.5 19409.8 47462.1 50319.5 54456.0 55071.3 55125.4 70355.0 72984.0 74243.6 74487.0 74533.6 9671.8 9896.6 9937.3 9980.6 10013.4 14355.3 19915.4 20067.9 20191.2 20618.2 12976.9 15995.8 16263.9 16318.3 16387.7 15640.5 16006.0 16046.9 16121.0 16244.0 16296.9 16621.3 16786.6 16968.6 17001.1 9018.1 9682.3 9740.3 9808.1 9847.6 11600.8 15892.8 16011.8 16070.2 16240.7 00:17:22 INFO - 2015-11-24 00:17:22,388 DEBUG : BROWSER_OUTPUT: 00:17:22 INFO - 2015-11-24 00:17:22,389 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5759.00 Median:6076.27 stddev:2992.46 (49.2%) stddev-sans-first:2984.26 00:17:22 INFO - 2015-11-24 00:17:22,390 DEBUG : BROWSER_OUTPUT: Values: 1566.5 1582.1 1911.6 1949.5 1964.8 7579.9 7723.5 8094.2 8208.6 8262.8 8100.3 8293.3 8316.9 8414.1 8422.5 2362.9 2386.7 2398.6 2399.7 2403.0 2080.7 2399.5 2407.7 2432.9 2433.2 2356.5 2377.3 2379.3 2389.7 2407.0 2349.6 2371.9 2372.0 2393.7 2395.2 2206.0 2263.9 2367.2 2398.1 2422.3 8312.3 8351.5 8400.1 8435.2 8448.6 4575.9 5091.1 5186.0 5186.1 5195.4 3174.3 3407.2 3414.9 3486.9 3490.2 1018.1 1041.4 1053.2 1070.2 1076.7 10965.6 10972.7 10989.7 10995.2 10998.3 4641.7 4698.9 4739.0 4743.1 4770.2 9564.5 9573.2 9578.4 9583.4 9596.3 5110.9 5170.7 5185.7 5200.4 5205.1 4050.5 4563.8 4704.2 4710.3 4718.4 3220.5 3285.4 3299.9 3840.1 3901.3 1281.0 1288.9 1290.1 1290.7 1299.8 1357.7 1395.4 1395.8 1408.6 1423.7 7771.9 7888.8 7920.2 7939.0 7960.6 498.6 501.4 501.7 503.8 515.6 5987.7 6124.7 6152.2 6153.4 6181.8 9457.9 9919.8 9923.0 10032.1 10035.0 9875.4 9894.7 9901.2 10031.2 10053.8 7762.0 7799.2 7799.4 7802.4 7858.6 7553.6 7615.2 7679.8 7690.6 7710.0 8917.6 8935.8 9034.2 9046.4 9111.4 7623.8 8436.3 9033.8 9288.8 9308.8 6027.8 7084.4 7099.6 7165.8 7171.2 7774.4 7849.3 7901.6 7939.5 7951.8 6291.2 7398.9 7403.7 7531.2 7614.6 7405.3 7411.4 7433.0 7510.1 7514.9 7381.9 7517.0 7520.7 7534.8 7602.1 6748.1 6824.5 6825.9 6847.5 6876.4 6855.7 6968.2 6968.9 6981.6 6984.5 00:17:22 INFO - 2015-11-24 00:17:22,390 DEBUG : BROWSER_OUTPUT: 00:17:22 INFO - 2015-11-24 00:17:22,390 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6010.27 Median:6830.90 stddev:2004.66 (29.3%) stddev-sans-first:1964.01 00:17:22 INFO - 2015-11-24 00:17:22,391 DEBUG : BROWSER_OUTPUT: Values: 304.9 306.5 314.0 333.2 336.8 6782.2 6814.7 6931.9 7146.2 7165.2 5108.5 6715.0 6847.1 6857.2 6884.4 3565.4 4284.6 4918.9 4966.5 4980.1 4031.4 4966.6 4972.6 4978.4 4986.2 4799.7 4896.2 4916.7 4926.7 4956.9 4928.5 4928.7 4930.6 4944.7 4949.2 3530.6 4007.7 4096.3 4119.3 4180.7 6454.4 6597.9 6616.1 6620.5 6626.3 5849.8 5889.8 5893.0 5901.3 5914.3 7235.7 7442.9 7458.7 7460.8 7497.8 4717.9 4720.3 4721.5 4725.9 4728.7 7857.0 7933.3 7953.2 7959.3 7975.9 4626.5 4800.5 4805.5 4822.0 4825.9 4853.4 4856.1 4858.6 4861.8 4873.5 5828.9 5855.4 5891.2 5903.2 5910.8 6545.4 7139.8 7519.7 7534.8 7545.6 1482.0 1636.3 1678.2 1703.1 1707.2 1069.2 1083.0 1083.3 1084.3 1090.3 6942.2 6950.4 6955.3 6964.8 6993.9 7781.9 7783.5 7791.5 7802.2 7840.9 6534.0 6785.0 6879.3 6939.6 6980.6 3374.3 3988.4 4053.6 4071.6 4136.9 7960.2 8097.0 8111.0 8112.2 8114.4 8099.4 8128.3 8137.0 8145.3 8149.1 7889.1 8152.7 8168.0 8169.8 8174.7 6043.5 7835.3 7836.9 7843.5 7862.5 6929.5 7493.3 7591.8 7679.7 7702.2 6613.8 6918.0 8165.6 8176.5 8200.7 4783.7 4823.3 4827.4 4832.0 4864.4 6924.7 7301.5 7616.9 7874.4 7912.2 7080.3 7522.2 7541.0 7551.6 7594.4 6538.7 7352.8 7531.1 7543.2 7554.8 7253.8 7307.6 7346.7 7362.4 7372.9 6019.5 7494.9 7518.4 7519.8 7550.2 7167.3 7317.9 7336.1 7399.6 7422.0 00:17:22 INFO - 2015-11-24 00:17:22,391 DEBUG : BROWSER_OUTPUT: 00:17:22 INFO - 2015-11-24 00:17:22,391 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19238.50 Median:53270.70 stddev:27502.67 (51.6%) stddev-sans-first:27544.72 00:17:22 INFO - 2015-11-24 00:17:22,393 DEBUG : BROWSER_OUTPUT: Values: 732.3 792.9 796.4 816.7 852.0 15084.1 15269.1 15425.5 15445.5 15450.7 13934.3 14155.4 14284.5 14310.6 14314.9 756.6 764.8 944.8 971.8 974.6 959.3 964.1 964.3 977.1 980.9 996.3 1003.9 1017.2 1024.6 1025.2 985.3 1007.7 1015.1 1017.8 1018.0 733.5 736.1 748.9 757.4 760.1 14907.3 14918.9 14963.4 14990.9 15085.8 11077.7 12714.9 12726.5 12837.3 13159.5 10064.6 10116.9 10221.0 10330.6 10678.3 3184.8 3564.8 3564.9 3574.6 3582.2 79781.0 81530.6 83986.2 84780.6 85240.6 9651.9 9789.4 9853.2 9901.0 10155.8 21832.6 22227.2 22609.3 22651.2 22756.8 7338.2 7411.6 7455.9 7579.5 7580.0 3981.4 4119.7 4131.6 4131.8 4154.4 3246.7 3270.1 3284.9 3301.8 3305.8 529.9 591.0 601.0 601.8 620.0 515.4 566.2 615.8 630.9 639.5 8424.8 8424.9 8496.1 8702.9 8708.9 503.6 529.4 601.7 609.2 631.7 4186.7 4396.8 4427.3 4449.4 4546.5 95009.5 95305.0 95737.5 95844.5 99819.0 88472.7 89092.0 89206.0 89440.7 89576.6 68380.0 69686.0 70936.6 74039.9 78747.6 7858.7 8575.5 8997.6 9081.9 9102.7 52621.0 53130.7 53410.7 54375.0 54375.7 70943.6 74263.0 74700.6 74956.6 75466.0 8960.2 10699.2 10714.1 10769.5 11195.6 11958.4 12099.2 12156.3 12271.9 12625.2 11414.2 11709.5 11863.5 12257.8 12347.9 11469.4 11742.6 11845.4 11893.2 12478.0 11253.8 11487.7 11568.5 11635.7 12156.6 8301.5 9444.4 9646.3 9727.4 9833.1 9309.9 9333.0 9917.5 10011.6 10050.8 00:17:22 INFO - 2015-11-24 00:17:22,393 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:17:22 INFO - 2015-11-24 00:17:22,393 DEBUG : BROWSER_OUTPUT: 00:17:22 INFO - 2015-11-24 00:17:22,774 INFO : Browser exited with error code: 0 00:17:22 INFO - 2015-11-24 00:17:22,799 INFO : Completed test dromaeo_css (00:18:29) 00:17:22 INFO - 2015-11-24 00:17:22,799 INFO : Starting test kraken 00:17:22 INFO - 2015-11-24 00:17:22,800 DEBUG : operating with platform_type : mac_ 00:17:22 INFO - 2015-11-24 00:17:22,800 INFO : Initialising browser for kraken test... 00:17:22 INFO - 2015-11-24 00:17:22,812 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpIoiLjg/profile http://localhost:49515/getInfo.html 00:17:25 INFO - 2015-11-24 00:17:25,426 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:17:25 INFO - 2015-11-24 00:17:25,426 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:17:25 INFO - 2015-11-24 00:17:25,426 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 00:17:25 INFO - 2015-11-24 00:17:25,426 DEBUG : BROWSER_OUTPUT: __metrics 00:17:26 INFO - 2015-11-24 00:17:26,096 INFO : Browser initialized. 00:17:26 INFO - 2015-11-24 00:17:26,096 INFO : Running cycle 1/1 for kraken test... 00:17:26 INFO - 2015-11-24 00:17:26,096 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpIoiLjg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:17:37 INFO - 2015-11-24 00:17:37,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 236658688 00:17:37 INFO - 2015-11-24 00:17:37,972 DEBUG : BROWSER_OUTPUT: 00:17:40 INFO - 2015-11-24 00:17:40,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49515/tests/kraken/driver.html?testName=audio-beat-detection) 00:17:41 INFO - 2015-11-24 00:17:41,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 249905152 00:17:41 INFO - 2015-11-24 00:17:41,193 DEBUG : BROWSER_OUTPUT: 00:17:43 INFO - 2015-11-24 00:17:43,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49515/tests/kraken/driver.html?testName=audio-dft) 00:17:44 INFO - 2015-11-24 00:17:44,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 259260416 00:17:44 INFO - 2015-11-24 00:17:44,483 DEBUG : BROWSER_OUTPUT: 00:17:47 INFO - 2015-11-24 00:17:47,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49515/tests/kraken/driver.html?testName=audio-fft) 00:17:48 INFO - 2015-11-24 00:17:48,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 263163904 00:17:48 INFO - 2015-11-24 00:17:48,412 DEBUG : BROWSER_OUTPUT: 00:17:50 INFO - 2015-11-24 00:17:50,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49515/tests/kraken/driver.html?testName=audio-oscillator) 00:17:50 INFO - 2015-11-24 00:17:50,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 265093120 00:17:50 INFO - 2015-11-24 00:17:50,824 DEBUG : BROWSER_OUTPUT: 00:17:52 INFO - 2015-11-24 00:17:52,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:17:53 INFO - 2015-11-24 00:17:53,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 265179136 00:17:53 INFO - 2015-11-24 00:17:53,443 DEBUG : BROWSER_OUTPUT: 00:17:56 INFO - 2015-11-24 00:17:56,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49515/tests/kraken/driver.html?testName=imaging-darkroom) 00:17:56 INFO - 2015-11-24 00:17:56,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 265695232 00:17:56 INFO - 2015-11-24 00:17:56,909 DEBUG : BROWSER_OUTPUT: 00:17:59 INFO - 2015-11-24 00:17:59,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49515/tests/kraken/driver.html?testName=imaging-desaturate) 00:18:00 INFO - 2015-11-24 00:18:00,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 265662464 00:18:00 INFO - 2015-11-24 00:18:00,265 DEBUG : BROWSER_OUTPUT: 00:18:02 INFO - 2015-11-24 00:18:02,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49515/tests/kraken/driver.html?testName=json-parse-financial) 00:18:03 INFO - 2015-11-24 00:18:03,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 266170368 00:18:03 INFO - 2015-11-24 00:18:03,553 DEBUG : BROWSER_OUTPUT: 00:18:05 INFO - 2015-11-24 00:18:05,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:18:05 INFO - 2015-11-24 00:18:05,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 265777152 00:18:05 INFO - 2015-11-24 00:18:05,669 DEBUG : BROWSER_OUTPUT: 00:18:07 INFO - 2015-11-24 00:18:07,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:18:08 INFO - 2015-11-24 00:18:08,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 265252864 00:18:08 INFO - 2015-11-24 00:18:08,044 DEBUG : BROWSER_OUTPUT: 00:18:10 INFO - 2015-11-24 00:18:10,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:18:10 INFO - 2015-11-24 00:18:10,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 265555968 00:18:10 INFO - 2015-11-24 00:18:10,670 DEBUG : BROWSER_OUTPUT: 00:18:13 INFO - 2015-11-24 00:18:13,250 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:18:13 INFO - 2015-11-24 00:18:13,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 265158656 00:18:13 INFO - 2015-11-24 00:18:13,853 DEBUG : BROWSER_OUTPUT: 00:18:16 INFO - 2015-11-24 00:18:16,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:18:17 INFO - 2015-11-24 00:18:17,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 264081408 00:18:17 INFO - 2015-11-24 00:18:17,096 DEBUG : BROWSER_OUTPUT: 00:18:18 INFO - 2015-11-24 00:18:18,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49515/tests/kraken/driver.html?testName=ai-astar) 00:18:19 INFO - 2015-11-24 00:18:19,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 265691136 00:18:19 INFO - 2015-11-24 00:18:19,030 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,031 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:18:19 INFO - 2015-11-24 00:18:19,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:18:19 INFO - 2015-11-24 00:18:19,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:18:19 INFO - 2015-11-24 00:18:19,031 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:18:19 INFO - 2015-11-24 00:18:19,031 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;124;109;114;130;168;115;114;114 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;127;149;160;117;183;176;149;151;135 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |2;audio-dft;190;237;274;206;208;222;196;197;197;197 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |3;audio-fft;56;63;64;68;122;56;58;62;61;101 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;77;86;108;75;76;77;110;97;114;108 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;88;93;119;90;96;118;89;82;133;89 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;96;94;96;105;96;96;96;97;96;96 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;92;91;90;92;93;91;94;94;94;96 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;61;59;58;60;59;59;66;58;59 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;67;66;66;67;68;68;69;68;69 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;84;85;85;86;84;86;87;87;83 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;124;130;134;133;126;133;120;142;148 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;180;125;124;166;180;173;129;180;131 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;66;66;66;67;66;78;81;93;64 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:18:19 INFO - 2015-11-24 00:18:19,032 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:18:19 INFO - 2015-11-24 00:18:19,033 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,810 00:18:19 INFO - 2015-11-24 00:18:19,033 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:18:19 INFO - 2015-11-24 00:18:19,033 DEBUG : BROWSER_OUTPUT: __startTimestamp1448353099030__endTimestamp 00:18:19 INFO - 2015-11-24 00:18:19,033 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,034 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:18:19 INFO - 2015-11-24 00:18:19,034 DEBUG : BROWSER_OUTPUT: Number of tests: 14 00:18:19 INFO - 2015-11-24 00:18:19,034 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,035 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:120.90 Median:114.50 stddev:17.86 (15.6%) stddev-sans-first:18.77 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 124.0 109.0 114.0 130.0 168.0 115.0 114.0 114.0 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.50 Median:150.00 stddev:20.31 (13.5%) stddev-sans-first:21.53 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: Values: 148.0 127.0 149.0 160.0 117.0 183.0 176.0 149.0 151.0 135.0 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:212.40 Median:207.00 stddev:25.89 (12.5%) stddev-sans-first:26.17 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: Values: 190.0 237.0 274.0 206.0 208.0 222.0 196.0 197.0 197.0 197.0 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:71.10 Median:61.50 stddev:22.17 (36.0%) stddev-sans-first:22.83 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: Values: 56.0 63.0 64.0 68.0 122.0 56.0 58.0 62.0 61.0 101.0 00:18:19 INFO - 2015-11-24 00:18:19,036 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,037 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:92.80 Median:76.50 stddev:16.23 (21.2%) stddev-sans-first:16.17 00:18:19 INFO - 2015-11-24 00:18:19,037 DEBUG : BROWSER_OUTPUT: Values: 77.0 86.0 108.0 75.0 76.0 77.0 110.0 97.0 114.0 108.0 00:18:19 INFO - 2015-11-24 00:18:19,037 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,037 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:99.70 Median:89.00 stddev:17.15 (19.3%) stddev-sans-first:17.66 00:18:19 INFO - 2015-11-24 00:18:19,037 DEBUG : BROWSER_OUTPUT: Values: 88.0 93.0 119.0 90.0 96.0 118.0 89.0 82.0 133.0 89.0 00:18:19 INFO - 2015-11-24 00:18:19,037 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,037 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:96.80 Median:96.00 stddev:2.97 (3.1%) stddev-sans-first:3.14 00:18:19 INFO - 2015-11-24 00:18:19,037 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 96.0 105.0 96.0 96.0 96.0 97.0 96.0 96.0 00:18:19 INFO - 2015-11-24 00:18:19,037 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,037 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:92.70 Median:93.50 stddev:1.83 (2.0%) stddev-sans-first:1.92 00:18:19 INFO - 2015-11-24 00:18:19,038 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 90.0 92.0 93.0 91.0 94.0 94.0 94.0 96.0 00:18:19 INFO - 2015-11-24 00:18:19,038 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,038 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.00 stddev:2.50 (4.2%) stddev-sans-first:2.47 00:18:19 INFO - 2015-11-24 00:18:19,038 DEBUG : BROWSER_OUTPUT: Values: 57.0 61.0 59.0 58.0 60.0 59.0 59.0 66.0 58.0 59.0 00:18:19 INFO - 2015-11-24 00:18:19,038 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,038 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:68.00 stddev:1.34 (2.0%) stddev-sans-first:1.13 00:18:19 INFO - 2015-11-24 00:18:19,038 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 66.0 66.0 67.0 68.0 68.0 69.0 68.0 69.0 00:18:19 INFO - 2015-11-24 00:18:19,038 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,039 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.00 stddev:1.34 (1.6%) stddev-sans-first:1.39 00:18:19 INFO - 2015-11-24 00:18:19,039 DEBUG : BROWSER_OUTPUT: Values: 86.0 84.0 85.0 85.0 86.0 84.0 86.0 87.0 87.0 83.0 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:133.00 stddev:8.54 (6.4%) stddev-sans-first:8.73 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: Values: 125.0 124.0 130.0 134.0 133.0 126.0 133.0 120.0 142.0 148.0 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.70 Median:169.50 stddev:24.61 (14.5%) stddev-sans-first:26.05 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: Values: 149.0 180.0 125.0 124.0 166.0 180.0 173.0 129.0 180.0 131.0 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:67.50 stddev:9.45 (14.0%) stddev-sans-first:9.94 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: Values: 68.0 66.0 66.0 66.0 67.0 66.0 78.0 81.0 93.0 64.0 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:18:19 INFO - 2015-11-24 00:18:19,040 DEBUG : BROWSER_OUTPUT: 00:18:19 INFO - 2015-11-24 00:18:19,729 INFO : Browser exited with error code: 0 00:18:19 INFO - 2015-11-24 00:18:19,772 INFO : Completed test kraken (00:00:56) 00:18:19 INFO - 2015-11-24 00:18:19,772 INFO : Starting test v8_7 00:18:19 INFO - 2015-11-24 00:18:19,772 DEBUG : operating with platform_type : mac_ 00:18:19 INFO - 2015-11-24 00:18:19,773 INFO : Initialising browser for v8_7 test... 00:18:19 INFO - 2015-11-24 00:18:19,784 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpuFY2JT/profile http://localhost:49515/getInfo.html 00:18:22 INFO - 2015-11-24 00:18:22,453 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:18:22 INFO - 2015-11-24 00:18:22,454 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:18:22 INFO - 2015-11-24 00:18:22,454 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 00:18:22 INFO - 2015-11-24 00:18:22,454 DEBUG : BROWSER_OUTPUT: __metrics 00:18:23 INFO - 2015-11-24 00:18:23,070 INFO : Browser initialized. 00:18:23 INFO - 2015-11-24 00:18:23,070 INFO : Running cycle 1/1 for v8_7 test... 00:18:23 INFO - 2015-11-24 00:18:23,070 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpuFY2JT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:18:35 INFO - 2015-11-24 00:18:35,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 236449792 00:18:35 INFO - 2015-11-24 00:18:35,053 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49515/tests/v8_7/run.html (next: http://localhost:49515/tests/v8_7/run.html) 00:18:56 INFO - 2015-11-24 00:18:56,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 248360960 00:18:56 INFO - 2015-11-24 00:18:56,653 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,653 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:18:56 INFO - 2015-11-24 00:18:56,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:18:56 INFO - 2015-11-24 00:18:56,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:18:56 INFO - 2015-11-24 00:18:56,653 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:18:56 INFO - 2015-11-24 00:18:56,653 DEBUG : BROWSER_OUTPUT: |0;Richards;671.591672263264 00:18:56 INFO - 2015-11-24 00:18:56,654 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;157.87811809283232 00:18:56 INFO - 2015-11-24 00:18:56,654 DEBUG : BROWSER_OUTPUT: |2;Encrypt;331.2355084465055 00:18:56 INFO - 2015-11-24 00:18:56,655 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 00:18:56 INFO - 2015-11-24 00:18:56,655 DEBUG : BROWSER_OUTPUT: |4;RayTrace;944.2870632672333 00:18:56 INFO - 2015-11-24 00:18:56,655 DEBUG : BROWSER_OUTPUT: |5;Earley;739.0983000739099 00:18:56 INFO - 2015-11-24 00:18:56,655 DEBUG : BROWSER_OUTPUT: |6;Boyer;12700 00:18:56 INFO - 2015-11-24 00:18:56,655 DEBUG : BROWSER_OUTPUT: |7;RegExp;29705.882352941175 00:18:56 INFO - 2015-11-24 00:18:56,655 DEBUG : BROWSER_OUTPUT: |8;Splay;685.4009595613434 00:18:56 INFO - 2015-11-24 00:18:56,655 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4538.461538461538 00:18:56 INFO - 2015-11-24 00:18:56,655 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: __startTimestamp1448353136652__endTimestamp 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: Number of tests: 10 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:671.59 Median:671.59 stddev:0.00 (0.0%) 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: Values: 671.6 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:157.88 Median:157.88 stddev:0.00 (0.0%) 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: Values: 157.9 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:331.24 Median:331.24 stddev:0.00 (0.0%) 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: Values: 331.2 00:18:56 INFO - 2015-11-24 00:18:56,656 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: Values: 5122.4 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:944.29 Median:944.29 stddev:0.00 (0.0%) 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: Values: 944.3 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:739.10 Median:739.10 stddev:0.00 (0.0%) 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: Values: 739.1 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12700.00 Median:12700.00 stddev:0.00 (0.0%) 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: Values: 12700.0 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29705.88 Median:29705.88 stddev:0.00 (0.0%) 00:18:56 INFO - 2015-11-24 00:18:56,657 DEBUG : BROWSER_OUTPUT: Values: 29705.9 00:18:56 INFO - 2015-11-24 00:18:56,658 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,658 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:685.40 Median:685.40 stddev:0.00 (0.0%) 00:18:56 INFO - 2015-11-24 00:18:56,658 DEBUG : BROWSER_OUTPUT: Values: 685.4 00:18:56 INFO - 2015-11-24 00:18:56,658 DEBUG : BROWSER_OUTPUT: 00:18:56 INFO - 2015-11-24 00:18:56,658 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4538.46 Median:4538.46 stddev:0.00 (0.0%) 00:18:56 INFO - 2015-11-24 00:18:56,658 DEBUG : BROWSER_OUTPUT: Values: 4538.5 00:18:56 INFO - 2015-11-24 00:18:56,658 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:18:56 INFO - 2015-11-24 00:18:56,658 DEBUG : BROWSER_OUTPUT: 00:18:57 INFO - 2015-11-24 00:18:57,216 INFO : Browser exited with error code: 0 00:18:57 INFO - 2015-11-24 00:18:57,234 INFO : Completed test v8_7 (00:00:37) 00:18:57 INFO - 2015-11-24 00:18:57,286 INFO : Completed test suite (00:20:04) 00:18:57 INFO - 2015-11-24 00:18:57,286 DEBUG : Working with test: dromaeo_css 00:18:57 INFO - 2015-11-24 00:18:57,286 DEBUG : Generating results file: dromaeo_css 00:18:57 INFO - 2015-11-24 00:18:57,287 DEBUG : Working with test: kraken 00:18:57 INFO - 2015-11-24 00:18:57,287 DEBUG : Generating results file: kraken 00:18:57 INFO - 2015-11-24 00:18:57,287 INFO : javascript benchmark 00:18:57 INFO - 2015-11-24 00:18:57,287 DEBUG : Working with test: v8_7 00:18:57 INFO - 2015-11-24 00:18:57,288 DEBUG : Generating results file: v8_7 00:18:57 INFO - 2015-11-24 00:18:57,288 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:18:57 INFO - 2015-11-24 00:18:57,869 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 00:18:57 INFO - 2015-11-24 00:18:57,869 DEBUG : process_Request line: dromaeo_css 7602.09 graph.html#tests=[[72,64,61]] 00:18:57 INFO - 2015-11-24 00:18:57,869 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:18:58 INFO - 2015-11-24 00:18:58,003 DEBUG : process_Request line: kraken 1504.80 graph.html#tests=[[232,64,61]] 00:18:58 INFO - 2015-11-24 00:18:58,003 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:18:58 INFO - 2015-11-24 00:18:58,126 DEBUG : process_Request line: v8_7 18329.47 graph.html#tests=[[230,64,61]] 00:18:58 INFO - 2015-11-24 00:18:58,127 INFO : javascript benchmark 00:18:58 INFO - 2015-11-24 00:18:58,129 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2881.4381195666847, 3524.295140971805, 3550.1302180965636, 3564.3227786720536, 3575.2491976684887, 5826.679532625709, 5842.88314233715, 5842.883142337156, 5865.912011319833, 5875.177475153482, 4474.328850672401, 5679.460451257134, 5819.9418005819925, 5851.76592936282, 5888.970555147229, 5207.088759467097, 5272.868178295555, 5275.155975043994, 5369.087255166612, 5389.245505629215, 5390.434004429537, 5424.484673955968, 5432.6468779529205, 5436.075867102582, 5443.945560544384, 5120.078385890538, 5184.533391994739, 5404.540614047811, 5417.485338892799, 5481.451854814526, 5233.319668443116, 5319.601029922771, 5338.706371149585, 5361.946380536184, 5364.22218778275, 3973.721839471238, 5087.847364579032, 5326.280952071459, 5337.226102215157, 5342.759575819097, 5532.75102620383, 5546.112621980464, 5655.8586035349035, 5852.326982397036, 5853.795117170921, 5344.973275133639, 6273.780417685359, 6338.176037115191, 6380.553361264713, 6410.294867564564, 4551.8634440966825, 6425.710843012076, 6427.06807512908, 6427.325130861239, 6436.452901503378, 5854.975379308604, 5966.791162309299, 5969.850753731104, 5975.312839023568, 5994.130851026577, 6285.937140628626, 6318.905216421757, 6393.712282947278, 6425.325340839238, 6436.549441539048, 6317.431431171217, 6360.872782544416, 6362.141110949962, 6396.072569477493, 6403.135576697179, 5530.972345138249, 5979.910301345483, 6209.658468784261, 6317.494600432046, 6335.1447554579545, 6225.128482012522, 6355.745770169234, 6360.236771587439, 6369.71336289868, 6397.072424498515, 5190.636655434083, 6078.632307730813, 6335.0, 6377.840553986188, 6400.0719895614875, 4291.957080429156, 4745.098431298043, 4904.2643603459055, 4919.212925931905, 5093.8726531836255, 4442.888927776767, 4556.567126123079, 4582.587567118975, 4614.469336026333, 4624.9768751156025, 5934.198883150806, 5941.792037278675, 5948.583599148018, 6000.909986350208, 6007.15899774032, 6403.423691867754, 6406.135171751847, 6411.422971932455, 6418.390252925965, 6419.0, 5738.311402631627, 5835.912461313083, 5858.443447872445, 5963.612365196248, 5993.640381577119, 5565.666060036411, 5566.944330556724, 5567.498925096761, 5573.721313934287, 5576.052071147915, 6277.2153480814895, 6411.519136064814, 6512.674366281667, 6532.281449040602, 6537.869242615121, 6233.314335423009, 6338.366163383625, 6347.428731414195, 6354.872902542016, 6374.649394283173, 6448.806535803933, 6511.9348806511325, 6527.967360163168, 6532.510061745293, 6549.574277671936, 6116.305337585956, 6229.719662615103, 6364.840878978062, 6373.904391434039, 6391.265004524539, 5021.598272138293, 6266.373362663697, 6305.653189074645, 6406.359364063556, 6408.967955160194, 5391.7304134793885, 6269.153664255449, 6277.591956522811, 6335.683215839282, 6346.1432706585865, 6094.177286066324, 6104.732011601517, 6161.291451483136, 6252.249730032425, 6320.4311611955145, 6072.514198864169, 6147.815565533041, 6170.969145154246, 6187.16473276102, 6198.876022479615, 6321.5574909757715, 6329.050642403677, 6340.207474065742, 6347.3652634738, 6352.745890164527, 4717.3159891816185, 5956.315023772148, 6036.7887123952205, 6066.636001839904, 6162.568620196723], "unit": "ms", "name": "dojo.html", "value": 5767.385333841608}, {"lowerIsBetter": false, "replicates": [576.9767364871575, 582.6242073862359, 587.248322147651, 587.9147523609074, 637.8773358888358, 41912.0, 42197.78901105494, 42359.78820105899, 42412.15175696484, 42456.36315455263, 40143.79928100356, 45948.540514594846, 46186.0, 46241.07517849641, 46481.070378592405, 9839.606415743361, 9985.75035624108, 9994.700158995242, 10004.949975250114, 10040.548175332091, 9850.802983940353, 9880.555375008142, 9921.15670168033, 9959.452230127376, 9970.65102721405, 9884.357516761424, 9960.95019524905, 9968.750781230454, 9988.101070903616, 9998.350107243043, 8781.64873405063, 9830.55762490686, 9883.752906177331, 9909.355891867006, 9950.402975821402, 9770.658026969093, 9908.504574771232, 9936.0, 9942.353747006493, 9943.0, 42550.78724606388, 42569.36145957813, 42877.57122428767, 42946.355804662955, 43030.35454468185, 3146.4553728245423, 3209.759268054905, 3211.213252753067, 3235.7249633781157, 3246.2695893423793, 29074.0, 29618.70381296181, 29775.404491910256, 30699.69300307013, 31331.903383381472, 2771.0, 2795.175423250146, 2826.915192544227, 2925.575791510219, 2958.6745457999605, 499747.0, 500098.0, 505675.99999999633, 507190.0, 509000.0, 47546.762266188445, 47983.04033919302, 74333.0, 74379.25620743832, 74977.62511187409, 47816.28275575869, 47983.28025079626, 48004.75997619989, 48192.759036204596, 48345.758271209124, 15257.542273731584, 15300.311485983157, 15310.846891531164, 15429.768553471707, 15435.922820386051, 12009.939950300193, 12140.635780926586, 12152.57465988686, 12165.878341216474, 12270.079744019235, 12642.431090600945, 14706.852931470763, 15166.165860877758, 15491.302891369915, 15497.380104795908, 5567.721613919369, 6549.050387693757, 6670.132882725312, 6697.0, 6704.128463299739, 732.6263605561202, 886.2289807867197, 915.2174890468686, 988.7033889833021, 1045.2892033417197, 26147.346316342242, 30359.696403036127, 30487.69512304893, 31180.75276988895, 31181.68818311788, 1043.6190790361463, 1070.6734445994045, 1074.258761454594, 1075.3278651696687, 1137.2891942535914, 12846.586875443694, 15537.223138843012, 15635.921820390826, 15716.214189290718, 15720.449784257497, 509729.0, 523756.38121809147, 532343.0, 539444.0, 540489.0, 60609.0, 61854.0, 62234.37765622376, 62653.68673156696, 62709.37290627127, 1434.211183848879, 1434.5050957419674, 1457.4971634785982, 1462.1081140504284, 1597.0258142533046, 23540.882295588413, 30347.089587312417, 30374.69625303807, 30825.537616936213, 31037.68962310348, 54813.1778023338, 55237.0, 55371.89256214934, 55404.72297638486, 55488.0, 498685.0, 499923.50038249575, 501383.0, 501662.0, 503702.0, 34401.0, 47503.0, 48115.0, 49340.753296234725, 49413.75293123655, 47823.5217647833, 48352.758236208596, 48596.0, 49765.50234497753, 49800.25299620581, 41107.0, 42509.08709108036, 42513.36229956615, 43236.783816080715, 43394.69815905528, 38842.22315553729, 39781.60218397779, 39801.00497487586, 39898.20203595854, 42004.57995420129, 39036.80481597574, 39175.0, 40920.59079409287, 42133.0, 42638.57361426346, 33047.834760826045, 34624.0, 34869.0, 34971.12572185614, 35032.47451288182, 25859.353516162246, 26601.201963941112, 27199.72800271972, 27632.86183569069, 27702.584461232695], "unit": "ms", "name": "ext.html", "value": 20133.48725471455}, {"lowerIsBetter": false, "replicates": [308.7730518069219, 324.9886253981111, 367.1518791591424, 367.71318371670105, 369.48087936449264, 19617.50956226095, 20253.696194557095, 20559.0, 21046.0, 21096.789032109675, 11969.64091077269, 14327.355269012893, 19478.51303717404, 21222.363329100113, 21246.362609121712, 5134.358205224347, 5230.450802665722, 5254.185601231796, 5259.395169555492, 5260.0, 5218.217267409881, 5761.337446193699, 6103.05402662588, 6114.69426528674, 6118.632882027093, 3996.500437445319, 4119.855805046824, 6044.153818465418, 6058.333583305833, 6064.757409703607, 5551.861203469925, 5714.257146570961, 5747.965366234076, 5748.82753517393, 5761.9135712964335, 5503.3120859892515, 5503.807366742185, 5535.363433205192, 5810.157527158538, 5855.707214639251, 13097.345132743325, 23846.52306953851, 25478.617820732703, 25948.61077083845, 26080.087196948014, 1956.7945365736534, 2009.2666176845346, 2178.498945242603, 2261.4685548895995, 2392.964105538418, 9779.951100244525, 9840.966698496697, 10028.849567256497, 10147.847782283272, 15302.464413745576, 1759.8592112630959, 1770.2034084661955, 1779.2793918463044, 1785.57146284892, 1855.656703509855, 88749.55625221833, 89990.65014024795, 102763.0, 108300.0, 110078.34882476769, 10285.302925017288, 10998.450077496092, 11061.446927653586, 11192.720181995352, 11222.607208747819, 10754.623588174376, 13210.933945330213, 13283.601491955256, 13303.0, 13309.134906231064, 7847.450678452567, 8088.555129467818, 8209.958950205211, 8239.588020598947, 8275.751727448187, 8093.595320233965, 8201.876971845428, 8246.134155913664, 8288.958555207306, 8405.95797021011, 4266.189424009428, 4301.806418711166, 4332.090261045153, 4348.412964249849, 4374.4094547236355, 1859.1355019915804, 1882.774067111928, 1882.905854707259, 1889.4048374761906, 1895.090356628826, 400.4053979839935, 408.25289719812673, 905.5924833824805, 1011.2870426349406, 1030.4487099401783, 10937.960893715084, 11594.420278986017, 11687.532498699957, 11825.231359961575, 11960.461779219955, 429.9161663475592, 444.88210624184615, 446.2324801341687, 448.59850433862164, 450.10429245801276, 6072.908906366408, 6127.234095738033, 6148.354422785633, 6190.721417536131, 6210.347913469111, 722578.0, 733869.0, 736530.0, 738146.0, 749239.0, 130975.34512327377, 135070.3246483781, 135106.32446837702, 136236.0, 136391.0, 1166.7491489329834, 1178.4696886401155, 1180.9822852657217, 1198.988010119905, 1207.076586411396, 18710.86703411468, 18859.434216973514, 19288.710669340253, 19333.51666208356, 19409.8059019408, 47462.050758985315, 50319.49680503295, 54456.0, 55071.347859564274, 55125.44874551203, 70355.0, 72984.0, 74243.6287818579, 74487.0, 74533.627331863, 9671.806563868542, 9896.604135834774, 9937.25470589723, 9980.60077596888, 10013.39919604826, 14355.282235888373, 19915.402537923885, 20067.899660501604, 20191.19235230633, 20618.175272988912, 12976.935115324362, 15995.840041599435, 16263.918680406996, 16318.26567804428, 16387.67224655524, 15640.530784076496, 16006.0, 16046.919765401099, 16121.032738035756, 16244.02535847853, 16296.918515407348, 16621.335146594483, 16786.58033549171, 16968.57578560546, 17001.06494142834, 9018.143276388733, 9682.27382946296, 9740.318177727491, 9808.068233517804, 9847.556859941464, 11600.825987610024, 15892.841071589599, 16011.759823602888, 16070.196490175678, 16240.67518649644], "unit": "ms", "name": "jquery.html", "value": 9418.710745299759}, {"lowerIsBetter": false, "replicates": [1566.4908904606, 1582.0665807173766, 1911.5507855653918, 1949.4541528372042, 1964.7936966618504, 7579.8863017054655, 7723.459357844939, 8094.19058094191, 8208.630611622477, 8262.75211743648, 8100.298937223175, 8293.253607175353, 8316.91683083169, 8414.074451810297, 8422.494650320985, 2362.8818559072065, 2386.677798497198, 2398.556267090594, 2399.712034555847, 2402.9879850600723, 2080.6878968154824, 2399.5440866235444, 2407.6990376202975, 2432.8661923594195, 2433.1605596069326, 2356.528694261146, 2377.2511658827416, 2379.2981070584133, 2389.7012873390827, 2406.975930240693, 2349.612313968193, 2371.8695471749047, 2371.9644205336936, 2393.700787401575, 2395.245497668229, 2206.007296716484, 2263.9434014149615, 2367.183321753992, 2398.136670798511, 2422.3338581889943, 8312.33501319899, 8351.457155284948, 8400.075991640915, 8435.240828325419, 8448.57757112142, 4575.885602859922, 5091.134507133796, 5186.0, 5186.0665080285535, 5195.350581177353, 3174.2699179188917, 3407.216340241758, 3414.9487757683655, 3486.9128271793406, 3490.162361033359, 1018.1040684197933, 1041.406398352939, 1053.2048303530862, 1070.175964507325, 1076.7039064257312, 10965.56137754489, 10972.725681857937, 10989.670309890636, 10995.230333876632, 10998.34009959405, 4641.651876109306, 4698.906021879543, 4739.028499157665, 4743.075100355398, 4770.189067858472, 9564.4739539326, 9573.234141268682, 9578.377405468622, 9583.377080489747, 9596.280278978966, 5110.872228194251, 5170.741462926839, 5185.714785686823, 5200.427952925175, 5205.141151710001, 4050.513938327361, 4563.840265590688, 4704.200285951397, 4710.3405523226775, 4718.363020992191, 3220.533022711694, 3285.3593549258144, 3299.9175020624198, 3840.0975770693863, 3901.31726947783, 1280.993595032019, 1288.890444312244, 1290.0840403313564, 1290.7095903421844, 1299.7920332746714, 1357.6741582020245, 1395.3651088754593, 1395.818543589327, 1408.6126315263384, 1423.7437261293067, 7771.92228077712, 7888.802779930433, 7920.247576480225, 7939.007624046994, 7960.641771120314, 498.61357447978105, 501.39081016565046, 501.7190373390913, 503.7733020140951, 515.5720751776017, 5987.670678112659, 6124.724387402578, 6152.200213972155, 6153.384661533811, 6181.84545386369, 9457.858132128023, 9919.752006199758, 9923.0, 10032.147267482345, 10034.996500350053, 9875.358101723365, 9894.653687120915, 9901.207903367856, 10031.247656425798, 10053.849192262122, 7762.0, 7799.18108598589, 7799.3760499159935, 7802.375809935192, 7858.567778772108, 7553.622318884144, 7615.162332143571, 7679.769606911802, 7690.615469226628, 7710.0, 8917.598708058023, 8935.821283574422, 9034.2320902724, 9046.411983221069, 9111.407758495676, 7623.847523049619, 8436.325093992344, 9033.774155645899, 9288.767780805534, 9308.813823723623, 6027.819165425044, 7084.397826184626, 7099.609521476162, 7165.7850264492145, 7171.1753148386515, 7774.416918731004, 7849.254320839739, 7901.604919754104, 7939.483933544301, 7951.84096318082, 6291.245050593958, 7398.889016664862, 7403.7408690695565, 7531.246875312425, 7614.581198034161, 7405.296496832792, 7411.444141689287, 7433.0, 7510.061242344707, 7514.924850751641, 7381.926180738124, 7517.0227870378685, 7520.699172033057, 7534.849303014019, 7602.1257555381835, 6748.0552722617895, 6824.488163387865, 6825.89761153593, 6847.452203823583, 6876.449884009167, 6855.6572171390235, 6968.233494315723, 6968.895466568107, 6981.616011119234, 6984.511084224056], "unit": "ms", "name": "mootools.html", "value": 4661.488094705804}, {"lowerIsBetter": false, "replicates": [304.88719173905656, 306.46980723348594, 313.9623245210575, 333.1554509318877, 336.8332675325714, 6782.152230971129, 6814.659267036641, 6931.930680693192, 7146.213916469191, 7165.211826699059, 5108.489151084889, 6715.0, 6847.144106986627, 6857.245702972669, 6884.449244060475, 3565.3760591896444, 4284.63580595649, 4918.926216106761, 4966.478519755427, 4980.103581355354, 4031.395290706388, 4966.602671786249, 4972.602191824663, 4978.352814134158, 4986.227134794094, 4799.712017278957, 4896.216605343146, 4916.680415772963, 4926.704397736147, 4956.876078098058, 4928.531789479994, 4928.704277743329, 4930.556249937487, 4944.728039957801, 4949.158643030693, 3530.5877648940373, 4007.6793856491413, 4096.344584866407, 4119.299719047769, 4180.749155050707, 6454.419102280817, 6597.901031484484, 6616.073749675049, 6620.503462240303, 6626.271110177877, 5849.766009359663, 5889.823305300848, 5893.0, 5901.29184497863, 5914.349421563625, 7235.674394652201, 7442.925570744277, 7458.664360103754, 7460.813479663052, 7497.775066748006, 4717.905641887143, 4720.268358404453, 4721.480637129913, 4725.905481890377, 4728.66899317048, 7857.0, 7933.325667318342, 7953.244441778022, 7959.323457506119, 7975.880361794578, 4626.514216007338, 4800.5199480051715, 4805.471398146201, 4821.987382649612, 4825.9034819303415, 4853.39332583427, 4856.077345304381, 4858.6356023298395, 4861.805527778849, 4873.512648735169, 5828.854278643068, 5855.3851845556455, 5891.175235467038, 5903.203067585907, 5910.7931222407005, 6545.443637290884, 7139.75054365484, 7519.661615227328, 7534.849303013909, 7545.584992825337, 1481.9555413337616, 1636.3291050669168, 1678.1860797513195, 1703.080336618237, 1707.2488105233658, 1069.2194697870443, 1083.0469187115289, 1083.2633809009792, 1084.3385534823751, 1090.3239991205344, 6942.236354001056, 6950.443964482829, 6955.304469553004, 6964.79105626832, 6993.930060699429, 7781.8832717509285, 7783.494072885358, 7791.532508049535, 7802.219778022266, 7840.882386764203, 6533.967330163318, 6785.0, 6879.346462086194, 6939.618320992293, 6980.581165130108, 3374.274530975852, 3988.4216788565495, 4053.581246563679, 4071.5521292657786, 4136.896577585524, 7960.164182760726, 8096.959515202387, 8111.0, 8112.18878112184, 8114.391420643476, 8099.433039687283, 8128.268455839003, 8136.959315203386, 8145.307648849795, 8149.14433984435, 7889.132195458495, 8152.714654987047, 8168.0, 8169.795755106051, 8174.713885013996, 6043.486303664238, 7835.294823465915, 7836.882446763189, 7843.529388236724, 7862.488938218998, 6929.480288978246, 7493.325600695964, 7591.810204744926, 7679.69281228767, 7702.152763195932, 6613.768518101843, 6917.965410172917, 8165.550894700848, 8176.509409435453, 8200.712975045844, 4783.736894470699, 4823.300621409946, 4827.396575428072, 4832.0, 4864.416270047617, 6924.653767311514, 7301.46669199474, 7616.885746713693, 7874.448788584744, 7912.248336408032, 7080.256573059754, 7522.172561018174, 7541.0, 7551.565202611486, 7594.354479869052, 6538.738450461929, 7352.77941661751, 7531.133919599316, 7543.170251272465, 7554.773356799305, 7253.8186545336785, 7307.561546307238, 7346.742863999734, 7362.3741981932135, 7372.926270737224, 6019.518438524995, 7494.925050749423, 7518.398528117628, 7519.774406767806, 7550.244975502405, 7167.319104685047, 7317.853642927005, 7336.119665640157, 7399.59302238382, 7422.0], "unit": "ms", "name": "prototype.html", "value": 5330.447063372127}, {"lowerIsBetter": false, "replicates": [732.264074605022, 792.9444938854283, 796.4385108498508, 816.701903805111, 852.0407910817748, 15084.094954302736, 15269.083854968696, 15425.537233883002, 15445.45940892069, 15450.690986180283, 13934.303284835743, 14155.36300866461, 14284.500042498514, 14310.642233944156, 14314.92638052145, 756.6027835386411, 764.7514557768719, 944.8252073366432, 971.7619183300066, 974.5906719177963, 959.3332633819498, 964.1322809471496, 964.3346091197087, 977.0522593084696, 980.8773903262093, 996.2727209137335, 1003.8795344558663, 1017.1862509991977, 1024.6106479537802, 1025.2361990317224, 985.3398223190479, 1007.7027276953316, 1015.0914931136665, 1017.7760892603652, 1018.032868774667, 733.4792297468804, 736.1423941108602, 748.9026426564511, 757.3978686943893, 760.0575286644577, 14907.329170187259, 14918.925405373013, 14963.381408253512, 14990.925045374812, 15085.773713394308, 11077.667669969915, 12714.87285127146, 12726.490940362375, 12837.29394883281, 13159.473621055145, 10064.641273428068, 10116.949415252877, 10221.02900224485, 10330.58677652893, 10678.305910115818, 3184.792988455743, 3564.8395822188063, 3564.8930532084078, 3574.57105147384, 3582.2119133790525, 79781.0, 81530.59234703847, 83986.16013839844, 84780.57609711912, 85240.57379713123, 9651.855222171673, 9789.412635241766, 9853.162481189036, 9901.0, 10155.796884062278, 21832.563348733252, 22227.222047228268, 22609.321720348085, 22651.20720774798, 22756.772432275797, 7338.156112047076, 7411.629418529052, 7455.888161677579, 7579.54522728627, 7579.962100189574, 3981.3629819229363, 4119.732217405859, 4131.586841315904, 4131.793410329472, 4154.376843473443, 3246.65910079443, 3270.084376374619, 3284.868605255811, 3301.834908254578, 3305.801651900894, 529.931108955841, 590.9556783241275, 601.0173366545729, 601.8495376155961, 619.9969000154971, 515.4304493534665, 566.2355819643531, 615.8491169663461, 630.9495240380759, 639.5195123289569, 8424.789380265542, 8424.915750842536, 8496.1079086695, 8702.869456958151, 8708.912910870937, 503.62983207342575, 529.4387948774234, 601.6720887116531, 609.1928195141455, 631.6999425272959, 4186.727862688916, 4396.758178300161, 4427.265293986446, 4449.354843547668, 4546.454425468899, 95009.52495237479, 95305.0, 95737.52131239438, 95844.52077739706, 99819.0, 88472.6729099064, 89092.0, 89206.0, 89440.6583901242, 89576.552117239, 68380.0, 69686.0, 70936.64531677308, 74039.88940165902, 78747.60626196832, 7858.724944626911, 8575.528345941033, 8997.595108220015, 9081.909180908371, 9102.726918192464, 52621.0, 53130.67173320698, 53410.73294633502, 54375.0, 54375.72812135914, 70943.58112837818, 74263.0, 74700.62649686717, 74956.62521687575, 75466.0, 8960.238379737795, 10699.197560183173, 10714.089302409071, 10769.515371808131, 11195.552177912792, 11958.35972845014, 12099.213551119148, 12156.331401772988, 12271.938640306742, 12625.179363341353, 11414.201005929837, 11709.473073711533, 11863.466144023367, 12257.816132757838, 12347.876521234673, 11469.426528673699, 11742.647720568397, 11845.407729613657, 11893.167478276437, 12478.0, 11253.831192532283, 11487.712807179887, 11568.537258509565, 11635.709107272385, 12156.574519891761, 8301.46040507365, 9444.386114902509, 9646.324757266924, 9727.416355018722, 9833.136458839961, 9309.86035209486, 9333.0, 9917.45454000037, 10011.649592264235, 10050.79390473148], "unit": "ms", "name": "yui.html", "value": 7102.026479791302}], "name": "dromaeo_css", "value": 7602.083837392007}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 124.0, 109.0, 114.0, 130.0, 168.0, 115.0, 114.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 120.9}, {"lowerIsBetter": true, "replicates": [148.0, 127.0, 149.0, 160.0, 117.0, 183.0, 176.0, 149.0, 151.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [190.0, 237.0, 274.0, 206.0, 208.0, 222.0, 196.0, 197.0, 197.0, 197.0], "unit": "ms", "name": "audio-dft", "value": 212.4}, {"lowerIsBetter": true, "replicates": [56.0, 63.0, 64.0, 68.0, 122.0, 56.0, 58.0, 62.0, 61.0, 101.0], "unit": "ms", "name": "audio-fft", "value": 71.1}, {"lowerIsBetter": true, "replicates": [77.0, 86.0, 108.0, 75.0, 76.0, 77.0, 110.0, 97.0, 114.0, 108.0], "unit": "ms", "name": "audio-oscillator", "value": 92.8}, {"lowerIsBetter": true, "replicates": [88.0, 93.0, 119.0, 90.0, 96.0, 118.0, 89.0, 82.0, 133.0, 89.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 99.7}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 96.0, 105.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 96.8}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 90.0, 92.0, 93.0, 91.0, 94.0, 94.0, 94.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 92.7}, {"lowerIsBetter": true, "replicates": [57.0, 61.0, 59.0, 58.0, 60.0, 59.0, 59.0, 66.0, 58.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 66.0, 66.0, 67.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 85.0, 85.0, 86.0, 84.0, 86.0, 87.0, 87.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [125.0, 124.0, 130.0, 134.0, 133.0, 126.0, 133.0, 120.0, 142.0, 148.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 131.5}, {"lowerIsBetter": true, "replicates": [149.0, 180.0, 125.0, 124.0, 166.0, 180.0, 173.0, 129.0, 180.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.7}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 66.0, 67.0, 66.0, 78.0, 81.0, 93.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.5}], "name": "kraken", "value": 1504.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [671.591672263264], "unit": "score", "name": "Richards", "value": 52.56467800000001}, {"lowerIsBetter": false, "replicates": [157.87811809283232], "unit": "score", "name": "DeltaBlue", "value": 418.7914119999999}, {"lowerIsBetter": false, "replicates": [331.2355084465055], "unit": "score", "name": "Encrypt", "value": 803.600439}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [944.2870632672333], "unit": "score", "name": "RayTrace", "value": 783.6483509999999}, {"lowerIsBetter": false, "replicates": [739.0983000739099], "unit": "score", "name": "Earley", "value": 901.724439}, {"lowerIsBetter": false, "replicates": [12700.0], "unit": "score", "name": "Boyer", "value": 52.47740157480315}, {"lowerIsBetter": false, "replicates": [29705.882352941175], "unit": "score", "name": "RegExp", "value": 30.66682178217823}, {"lowerIsBetter": false, "replicates": [685.4009595613434], "unit": "score", "name": "Splay", "value": 118.89536899999999}, {"lowerIsBetter": false, "replicates": [4538.461538461538], "unit": "score", "name": "NavierStokes", "value": 326.98305084745743}], "name": "v8_7", "value": 18329.471611468194}]} 00:18:58 INFO - RETURN: dromaeo_css: 7602.09 00:18:58 INFO - RETURN: kraken: 1504.80 00:18:58 INFO - RETURN: v8_7: 18329.47 00:18:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "18329.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1504.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7602.09"}}} 00:18:58 INFO - Return code: 0 00:18:58 INFO - # TBPL SUCCESS # 00:18:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:18:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:18:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:18:58 INFO - 2015-11-24 00:18:58.235 screenresolution[1963:13552] starting screenresolution argv=screenresolution get 00:18:58 INFO - 2015-11-24 00:18:58.238 screenresolution[1963:13552] Display 0: 1600x1200x32@60 00:18:58 INFO - 2015-11-24 00:18:58.244 screenresolution[1964:13555] starting screenresolution argv=screenresolution list 00:18:58 INFO - Available Modes on Display 0 00:18:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:18:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:18:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:18:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:18:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:18:58 INFO - Intel Iris: 00:18:58 INFO - Chipset Model: Intel Iris 00:18:58 INFO - Type: GPU 00:18:58 INFO - Bus: Built-In 00:18:58 INFO - VRAM (Dynamic, Max): 1536 MB 00:18:58 INFO - Vendor: Intel (0x8086) 00:18:58 INFO - Device ID: 0x0a2e 00:18:58 INFO - Revision ID: 0x0009 00:18:58 INFO - Displays: 00:18:58 INFO - Display: 00:18:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:18:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:18:58 INFO - Display Serial Number: 1600x1200 60 00:18:58 INFO - Main Display: Yes 00:18:58 INFO - Mirror: Off 00:18:58 INFO - Online: Yes 00:18:58 INFO - Rotation: Supported 00:18:58 INFO - Return code: 0 00:18:58 INFO - Running post-action listener: _resource_record_post_action 00:18:58 INFO - Running post-run listener: _resource_record_post_run 00:18:59 INFO - Total resource usage - Wall time: 1236s; CPU: 54.0%; Read bytes: 3534848; Write bytes: 693661696; Read time: 59; Write time: 2278 00:18:59 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 335360512; Write bytes: 337434112; Read time: 25975; Write time: 693 00:18:59 INFO - run-tests - Wall time: 1206s; CPU: 54.0%; Read bytes: 3534848; Write bytes: 345799168; Read time: 59; Write time: 1551 00:18:59 INFO - Running post-run listener: _upload_blobber_files 00:18:59 INFO - Blob upload gear active. 00:18:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 00:18:59 INFO - Copying logs to upload dir... 00:18:59 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.120812 ========= master_lag: 1.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-24 00:19:00.957659) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:19:00.962009) ========= 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.2OP71man3n/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.TTKlymYBmx/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009385 build_url: 'https://queue.taskcluster.net/v1/task/5I7cAY2HQ4WuC3qktLedOw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 00:19:00.994312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:19:00.994646) ========= 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.2OP71man3n/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.TTKlymYBmx/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005143 ========= master_lag: 0.57 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 00:19:01.572892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 00:19:01.573185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 00:19:01.573503) ========= ========= Total master_lag: 2.38 =========