builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0102 starttime: 1447298015.06 results: success (0) buildid: 20151111170847 builduid: c28b6e5896a44a388afc0046ccbe17ed revision: a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.059424) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.059913) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.060209) ========= 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.YkY973DMNI/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.ZnU5XZrF0R/Listeners TMPDIR=/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006642 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.118097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.118439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.145783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.146185) ========= 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.YkY973DMNI/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.ZnU5XZrF0R/Listeners TMPDIR=/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.036802 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.198407) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.198754) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.199144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.199426) ========= 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.YkY973DMNI/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.ZnU5XZrF0R/Listeners TMPDIR=/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-11 19:13:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.5M=0.001s 2015-11-11 19:13:35 (22.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.424625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.425121) ========= 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.YkY973DMNI/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.ZnU5XZrF0R/Listeners TMPDIR=/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.121517 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:35.562590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2015-11-11 19:13:35.563079) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YkY973DMNI/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.ZnU5XZrF0R/Listeners TMPDIR=/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-11 19:13:35,651 truncating revision to first 12 chars 2015-11-11 19:13:35,651 Setting DEBUG logging. 2015-11-11 19:13:35,652 attempt 1/10 2015-11-11 19:13:35,652 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8ed7dd831d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 19:13:38,804 unpacking tar archive at: mozilla-central-a8ed7dd831d1/testing/mozharness/ program finished with exit code 0 elapsedTime=5.405543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2015-11-11 19:13:40.984792) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:40.985124) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:40.998297) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:40.998691) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 19:13:40.999129) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-11 19:13:40.999435) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YkY973DMNI/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.ZnU5XZrF0R/Listeners TMPDIR=/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 19:13:41 INFO - MultiFileLogger online at 20151111 19:13:41 in /builds/slave/test 19:13:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:13:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:13:41 INFO - {'append_to_log': False, 19:13:41 INFO - 'base_work_dir': '/builds/slave/test', 19:13:41 INFO - 'blob_upload_branch': 'Firefox', 19:13:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:13:41 INFO - 'branch': 'Firefox', 19:13:41 INFO - 'buildbot_json_path': 'buildprops.json', 19:13:41 INFO - 'config_files': ('talos/mac_config.py',), 19:13:41 INFO - 'default_actions': ('clobber', 19:13:41 INFO - 'read-buildbot-config', 19:13:41 INFO - 'download-and-extract', 19:13:41 INFO - 'populate-webroot', 19:13:41 INFO - 'create-virtualenv', 19:13:41 INFO - 'install', 19:13:41 INFO - 'run-tests'), 19:13:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:13:41 INFO - 'download_minidump_stackwalk': True, 19:13:41 INFO - 'download_symbols': 'ondemand', 19:13:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:13:41 INFO - 'tooltool.py': '/tools/tooltool.py', 19:13:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:13:41 INFO - '/tools/misc-python/virtualenv.py')}, 19:13:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:13:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:13:41 INFO - 'installer_path': 'installer.exe', 19:13:41 INFO - 'log_level': 'info', 19:13:41 INFO - 'log_name': 'talos', 19:13:41 INFO - 'log_to_console': True, 19:13:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:13:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:13:41 INFO - 'opt_config_files': (), 19:13:41 INFO - 'pip_index': False, 19:13:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:13:41 INFO - 'cmd': ('bash', 19:13:41 INFO - '-c', 19:13:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:13:41 INFO - 'enabled': True, 19:13:41 INFO - 'halt_on_failure': False, 19:13:41 INFO - 'name': 'check_screen_resolution'},), 19:13:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:13:41 INFO - 'cmd': ('bash', 19:13:41 INFO - '-c', 19:13:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:13:41 INFO - 'enabled': True, 19:13:41 INFO - 'halt_on_failure': False, 19:13:41 INFO - 'name': 'check_screen_resolution'},), 19:13:41 INFO - 'run_cmd_checks_enabled': True, 19:13:41 INFO - 'sps_profile': False, 19:13:41 INFO - 'sps_profile_interval': 0, 19:13:41 INFO - 'suite': 'dromaeojs', 19:13:41 INFO - 'system_bits': '64', 19:13:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:13:41 INFO - 'title': 't-yosemite-r5-0102', 19:13:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:13:41 INFO - 'use_talos_json': True, 19:13:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:13:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:13:41 INFO - 'work_dir': 'build'} 19:13:41 INFO - ##### 19:13:41 INFO - ##### Running clobber step. 19:13:41 INFO - ##### 19:13:41 INFO - Running pre-action listener: _resource_record_pre_action 19:13:41 INFO - Running main action method: clobber 19:13:41 INFO - rmtree: /builds/slave/test/build 19:13:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:13:47 INFO - Running post-action listener: _resource_record_post_action 19:13:47 INFO - ##### 19:13:47 INFO - ##### Running read-buildbot-config step. 19:13:47 INFO - ##### 19:13:47 INFO - Running pre-action listener: _resource_record_pre_action 19:13:47 INFO - Running main action method: read_buildbot_config 19:13:47 INFO - Using buildbot properties: 19:13:47 INFO - { 19:13:47 INFO - "properties": { 19:13:47 INFO - "buildnumber": 596, 19:13:47 INFO - "product": "firefox", 19:13:47 INFO - "script_repo_revision": "production", 19:13:47 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 19:13:47 INFO - "repository": "", 19:13:47 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 19:13:47 INFO - "buildid": "20151111170847", 19:13:47 INFO - "slavename": "t-yosemite-r5-0102", 19:13:47 INFO - "pgo_build": "False", 19:13:47 INFO - "basedir": "/builds/slave/test", 19:13:47 INFO - "project": "", 19:13:47 INFO - "platform": "yosemite", 19:13:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:13:47 INFO - "slavebuilddir": "test", 19:13:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:13:47 INFO - "branch": "mozilla-central", 19:13:47 INFO - "repo_path": "mozilla-central", 19:13:47 INFO - "stage_platform": "macosx64", 19:13:47 INFO - "builduid": "c28b6e5896a44a388afc0046ccbe17ed", 19:13:47 INFO - "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a" 19:13:47 INFO - }, 19:13:47 INFO - "sourcestamp": { 19:13:47 INFO - "repository": "", 19:13:47 INFO - "hasPatch": false, 19:13:47 INFO - "project": "", 19:13:47 INFO - "branch": "mozilla-central-macosx64-talos", 19:13:47 INFO - "changes": [ 19:13:47 INFO - { 19:13:47 INFO - "category": null, 19:13:47 INFO - "files": [ 19:13:47 INFO - { 19:13:47 INFO - "url": null, 19:13:47 INFO - "name": "https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 19:13:47 INFO - } 19:13:47 INFO - ], 19:13:47 INFO - "repository": "", 19:13:47 INFO - "rev": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a", 19:13:47 INFO - "who": "kwierso@gmail.com", 19:13:47 INFO - "when": 1447297047, 19:13:47 INFO - "number": 6651754, 19:13:47 INFO - "comments": "Merge b2ginbound to central, a=merge", 19:13:47 INFO - "project": "", 19:13:47 INFO - "at": "Wed 11 Nov 2015 18:57:27", 19:13:47 INFO - "branch": "mozilla-central-macosx64-talos", 19:13:47 INFO - "revlink": "", 19:13:47 INFO - "properties": [ 19:13:47 INFO - [ 19:13:47 INFO - "buildid", 19:13:47 INFO - "20151111170847", 19:13:47 INFO - "Change" 19:13:47 INFO - ], 19:13:47 INFO - [ 19:13:47 INFO - "builduid", 19:13:47 INFO - "c28b6e5896a44a388afc0046ccbe17ed", 19:13:47 INFO - "Change" 19:13:47 INFO - ], 19:13:47 INFO - [ 19:13:47 INFO - "pgo_build", 19:13:47 INFO - "False", 19:13:47 INFO - "Change" 19:13:47 INFO - ] 19:13:47 INFO - ], 19:13:47 INFO - "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a" 19:13:47 INFO - } 19:13:47 INFO - ], 19:13:47 INFO - "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a" 19:13:47 INFO - } 19:13:47 INFO - } 19:13:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 19:13:47 INFO - Running post-action listener: _resource_record_post_action 19:13:47 INFO - ##### 19:13:47 INFO - ##### Running download-and-extract step. 19:13:47 INFO - ##### 19:13:47 INFO - Running pre-action listener: _resource_record_pre_action 19:13:47 INFO - Running main action method: download_and_extract 19:13:47 INFO - mkdir: /builds/slave/test/build/tests 19:13:47 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')]} 19:13:47 INFO - https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:13:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/test_packages.json 19:13:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/test_packages.json 19:13:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:13:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:13:47 INFO - Downloaded 1149 bytes. 19:13:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:13:48 INFO - Using the following test package requirements: 19:13:48 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:13:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:13:48 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 19:13:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:13:48 INFO - u'jsshell-mac.zip'], 19:13:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:13:48 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 19:13:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:13:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:13:48 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 19:13:48 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:13:48 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 19:13:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:13:48 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 19:13:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:13:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:13:48 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 19:13:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:13: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')]} 19:13:48 INFO - https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:13:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:13:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:13:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:13:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:13:49 INFO - Downloaded 17454528 bytes. 19:13: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 19:13:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:13:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:13:54 INFO - Return code: 0 19:13:54 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 19:13:54 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')]} 19:13:54 INFO - https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:13:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:13:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:13:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:13:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:13:55 INFO - Downloaded 17454528 bytes. 19:13:55 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 19:13:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:13:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:14:00 INFO - Return code: 0 19:14: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')]} 19:14:00 INFO - https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:14:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:14:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:14:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:14:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:14:01 INFO - Downloaded 11131693 bytes. 19:14:01 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 19:14:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:14:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 19:14:02 INFO - Return code: 0 19:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:02 INFO - https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:14:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:14:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:14:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 19:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:14:05 INFO - Downloaded 108701597 bytes. 19:14:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:14:05 INFO - mkdir: /builds/slave/test/properties 19:14:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:14:05 INFO - Writing to file /builds/slave/test/properties/build_url 19:14:05 INFO - Contents: 19:14:05 INFO - build_url:https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:14:05 INFO - Running post-action listener: _resource_record_post_action 19:14:05 INFO - Running post-action listener: set_extra_try_arguments 19:14:05 INFO - ##### 19:14:05 INFO - ##### Running populate-webroot step. 19:14:05 INFO - ##### 19:14:05 INFO - Running pre-action listener: _resource_record_pre_action 19:14:05 INFO - Running main action method: populate_webroot 19:14:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:14:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:14:05 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:14:05 INFO - '../fennec_ids.txt'], 19:14:05 INFO - 'tests': ['tcheck2']}, 19:14:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:14:05 INFO - '--tppagecycles', 19:14:05 INFO - '7'], 19:14:05 INFO - 'tests': ['tsvgm']}}, 19:14:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:14:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:14:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:14:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:14:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:14:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:14:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:14:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:05 INFO - 'talos_options': ['--e10s'], 19:14:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:14:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:05 INFO - 'tests': ['damp', 'tps']}, 19:14:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:05 INFO - 'talos_options': ['--e10s'], 19:14:05 INFO - 'tests': ['damp', 'tps']}, 19:14:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:14:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:14:05 INFO - 'other': {'tests': ['a11yr', 19:14:05 INFO - 'ts_paint', 19:14:05 INFO - 'tpaint', 19:14:05 INFO - 'sessionrestore', 19:14:05 INFO - 'sessionrestore_no_auto_restore']}, 19:14:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:14:05 INFO - 'tests': ['a11yr', 19:14:05 INFO - 'ts_paint', 19:14:05 INFO - 'tpaint', 19:14:05 INFO - 'sessionrestore', 19:14:05 INFO - 'sessionrestore_no_auto_restore']}, 19:14:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:14:05 INFO - 'tests': ['a11yr', 19:14:05 INFO - 'ts_paint', 19:14:05 INFO - 'tpaint', 19:14:05 INFO - 'sessionrestore', 19:14:05 INFO - 'sessionrestore_no_auto_restore']}, 19:14:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:14:05 INFO - 'tests': ['a11yr', 19:14:05 INFO - 'ts_paint', 19:14:05 INFO - 'tpaint', 19:14:05 INFO - 'sessionrestore', 19:14:05 INFO - 'sessionrestore_no_auto_restore']}, 19:14:05 INFO - 'other_l64': {'tests': ['a11yr', 19:14:05 INFO - 'ts_paint', 19:14:05 INFO - 'tpaint', 19:14:05 INFO - 'sessionrestore', 19:14:05 INFO - 'sessionrestore_no_auto_restore']}, 19:14:05 INFO - 'other_nol64': {'tests': ['a11yr', 19:14:05 INFO - 'ts_paint', 19:14:05 INFO - 'tpaint', 19:14:05 INFO - 'sessionrestore', 19:14:05 INFO - 'sessionrestore_no_auto_restore']}, 19:14:05 INFO - 'svgr': {'tests': ['tsvgx', 19:14:05 INFO - 'tsvgr_opacity', 19:14:05 INFO - 'tart', 19:14:05 INFO - 'tscrollx', 19:14:05 INFO - 'cart']}, 19:14:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:14:05 INFO - 'tests': ['tsvgx', 19:14:05 INFO - 'tsvgr_opacity', 19:14:05 INFO - 'tart', 19:14:05 INFO - 'tscrollx', 19:14:05 INFO - 'cart']}, 19:14:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:05 INFO - 'tests': ['tp5o']}, 19:14:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:05 INFO - 'talos_options': ['--e10s'], 19:14:05 INFO - 'tests': ['tp5o']}, 19:14:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:05 INFO - 'talos_options': ['--xperf_path', 19:14:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:14:05 INFO - 'tests': ['tp5n']}, 19:14:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:14:05 INFO - 'talos_options': ['--e10s', 19:14:05 INFO - '--xperf_path', 19:14:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:14:05 INFO - 'tests': ['tp5n']}}, 19:14:05 INFO - 'talos.zip': {'path': '', 19:14:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:14:05 INFO - Running post-action listener: _resource_record_post_action 19:14:05 INFO - ##### 19:14:05 INFO - ##### Running create-virtualenv step. 19:14:05 INFO - ##### 19:14:05 INFO - Running pre-action listener: _resource_record_pre_action 19:14:05 INFO - Running main action method: create_virtualenv 19:14:05 INFO - Creating virtualenv /builds/slave/test/build/venv 19:14:05 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 19:14:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:14:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:14:06 INFO - Using real prefix '/tools/python27' 19:14:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:14:07 INFO - Installing distribute.............................................................................................................................................................................................done. 19:14:10 INFO - Installing pip.................done. 19:14:10 INFO - Return code: 0 19:14:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:14:10 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')]} 19:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:10 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')]} 19:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:10 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 0x103342490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8563c9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032659f0>, '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 0x102fc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032598c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/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.ZnU5XZrF0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:14:10 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 19:14:10 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 19:14:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/Render', 19:14:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:10 INFO - 'HOME': '/Users/cltbld', 19:14:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:10 INFO - 'LOGNAME': 'cltbld', 19:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:10 INFO - 'MOZ_NO_REMOTE': '1', 19:14:10 INFO - 'NO_EM_RESTART': '1', 19:14:10 INFO - 'PAGER': '/bin/cat', 19:14:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:10 INFO - 'PWD': '/builds/slave/test', 19:14:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:10 INFO - 'SHELL': '/bin/bash', 19:14:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZnU5XZrF0R/Listeners', 19:14:10 INFO - 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', 19:14:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:10 INFO - 'USER': 'cltbld', 19:14:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:10 INFO - 'XPC_FLAGS': '0x0', 19:14:10 INFO - 'XPC_SERVICE_NAME': '0', 19:14:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:11 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 19:14:11 INFO - Cleaning up... 19:14:11 INFO - Return code: 0 19:14:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:14: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')]} 19:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14: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')]} 19:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:11 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 0x103342490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8563c9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032659f0>, '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 0x102fc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032598c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/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.ZnU5XZrF0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:14:11 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 19:14:11 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 19:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/Render', 19:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:11 INFO - 'HOME': '/Users/cltbld', 19:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:11 INFO - 'LOGNAME': 'cltbld', 19:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:11 INFO - 'MOZ_NO_REMOTE': '1', 19:14:11 INFO - 'NO_EM_RESTART': '1', 19:14:11 INFO - 'PAGER': '/bin/cat', 19:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:11 INFO - 'PWD': '/builds/slave/test', 19:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:11 INFO - 'SHELL': '/bin/bash', 19:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZnU5XZrF0R/Listeners', 19:14:11 INFO - 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', 19:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:11 INFO - 'USER': 'cltbld', 19:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:11 INFO - 'XPC_FLAGS': '0x0', 19:14:11 INFO - 'XPC_SERVICE_NAME': '0', 19:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:11 INFO - Downloading/unpacking psutil>=0.7.1 19:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:14 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:14:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:14:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:14 INFO - Installing collected packages: psutil 19:14:14 INFO - Running setup.py install for psutil 19:14:15 INFO - building 'psutil._psutil_osx' extension 19:14:15 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 19:14:16 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 19:14:16 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 19:14:16 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 19:14:17 INFO - building 'psutil._psutil_posix' extension 19:14:17 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 19:14:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:14:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:14:17 INFO - ^ 19:14:17 INFO - 1 warning generated. 19:14:17 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 19:14:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:14:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:14:17 INFO - Successfully installed psutil 19:14:17 INFO - Cleaning up... 19:14:17 INFO - Return code: 0 19:14:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:14:17 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')]} 19:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:17 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')]} 19:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:17 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 0x103342490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8563c9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032659f0>, '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 0x102fc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032598c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/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.ZnU5XZrF0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:14:17 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 19:14:17 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 19:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/Render', 19:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:17 INFO - 'HOME': '/Users/cltbld', 19:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:17 INFO - 'LOGNAME': 'cltbld', 19:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:17 INFO - 'MOZ_NO_REMOTE': '1', 19:14:17 INFO - 'NO_EM_RESTART': '1', 19:14:17 INFO - 'PAGER': '/bin/cat', 19:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:17 INFO - 'PWD': '/builds/slave/test', 19:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:17 INFO - 'SHELL': '/bin/bash', 19:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZnU5XZrF0R/Listeners', 19:14:17 INFO - 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', 19:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:17 INFO - 'USER': 'cltbld', 19:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:17 INFO - 'XPC_FLAGS': '0x0', 19:14:17 INFO - 'XPC_SERVICE_NAME': '0', 19:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14: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 19:14:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:14:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:14:20 INFO - Installing collected packages: mozsystemmonitor 19:14:20 INFO - Running setup.py install for mozsystemmonitor 19:14:21 INFO - Successfully installed mozsystemmonitor 19:14:21 INFO - Cleaning up... 19:14:21 INFO - Return code: 0 19:14:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:14:21 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')]} 19:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:21 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')]} 19:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:21 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 0x103342490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8563c9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032659f0>, '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 0x102fc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032598c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/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.ZnU5XZrF0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:14:21 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 19:14:21 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 19:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/Render', 19:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:21 INFO - 'HOME': '/Users/cltbld', 19:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:21 INFO - 'LOGNAME': 'cltbld', 19:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:21 INFO - 'MOZ_NO_REMOTE': '1', 19:14:21 INFO - 'NO_EM_RESTART': '1', 19:14:21 INFO - 'PAGER': '/bin/cat', 19:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:21 INFO - 'PWD': '/builds/slave/test', 19:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:21 INFO - 'SHELL': '/bin/bash', 19:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZnU5XZrF0R/Listeners', 19:14:21 INFO - 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', 19:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:21 INFO - 'USER': 'cltbld', 19:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:21 INFO - 'XPC_FLAGS': '0x0', 19:14:21 INFO - 'XPC_SERVICE_NAME': '0', 19:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:21 INFO - Downloading/unpacking blobuploader==1.2.4 19:14:21 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 19:14:21 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 19:14:21 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 19:14:21 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 19:14:21 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 19:14:21 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 19:14:24 INFO - Downloading blobuploader-1.2.4.tar.gz 19:14:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:14:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:14:24 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 19:14:24 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 19:14:24 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 19:14:24 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 19:14:24 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 19:14:24 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 19:14:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:14:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:25 INFO - Downloading docopt-0.6.1.tar.gz 19:14:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:14:25 INFO - Installing collected packages: blobuploader, requests, docopt 19:14:25 INFO - Running setup.py install for blobuploader 19:14:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:14:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:14:25 INFO - Running setup.py install for requests 19:14:26 INFO - Running setup.py install for docopt 19:14:26 INFO - Successfully installed blobuploader requests docopt 19:14:26 INFO - Cleaning up... 19:14:26 INFO - Return code: 0 19:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:26 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 0x103342490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8563c9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032659f0>, '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 0x102fc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032598c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/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.ZnU5XZrF0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:14:26 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 19:14:26 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 19:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/Render', 19:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:26 INFO - 'HOME': '/Users/cltbld', 19:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:26 INFO - 'LOGNAME': 'cltbld', 19:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:26 INFO - 'MOZ_NO_REMOTE': '1', 19:14:26 INFO - 'NO_EM_RESTART': '1', 19:14:26 INFO - 'PAGER': '/bin/cat', 19:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:26 INFO - 'PWD': '/builds/slave/test', 19:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:26 INFO - 'SHELL': '/bin/bash', 19:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZnU5XZrF0R/Listeners', 19:14:26 INFO - 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', 19:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:26 INFO - 'USER': 'cltbld', 19:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:26 INFO - 'XPC_FLAGS': '0x0', 19:14:26 INFO - 'XPC_SERVICE_NAME': '0', 19:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:14:27 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-rvKSTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:14:27 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-0Wp5oN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:14:27 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-Mv0DG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:14:27 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-jel01g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:14:27 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-xqnGo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:14:27 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-puQvs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:14:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:14:27 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-OG4yKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:14:28 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-hQe91m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:14:28 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-GJ0FWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:14:28 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-qJF1Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:14:28 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-AYg8mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:14:28 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-RLX95l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:14:28 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-w69MP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:14:28 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-_KLwVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:29 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-gF7U3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:14:29 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-LPcuQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:14:29 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-5eYPzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:14:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:14:29 INFO - Running setup.py install for manifestparser 19:14:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:14:29 INFO - Running setup.py install for mozcrash 19:14:29 INFO - Running setup.py install for mozdebug 19:14:30 INFO - Running setup.py install for mozdevice 19:14:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:14:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:14:30 INFO - Running setup.py install for mozfile 19:14:30 INFO - Running setup.py install for mozhttpd 19:14:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:14:30 INFO - Running setup.py install for mozinfo 19:14:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:14:30 INFO - Running setup.py install for mozInstall 19:14:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:14:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:14:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:14:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:14:31 INFO - Running setup.py install for mozleak 19:14:31 INFO - Running setup.py install for mozlog 19:14:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:14:31 INFO - Running setup.py install for moznetwork 19:14:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:14:31 INFO - Running setup.py install for mozprocess 19:14:31 INFO - Running setup.py install for mozprofile 19:14:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:14:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:14:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:14:32 INFO - Running setup.py install for mozrunner 19:14:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:14:32 INFO - Running setup.py install for mozscreenshot 19:14:32 INFO - Running setup.py install for moztest 19:14:32 INFO - Running setup.py install for mozversion 19:14:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:14:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:14:32 INFO - Cleaning up... 19:14:32 INFO - Return code: 0 19:14:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103342490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8563c9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032659f0>, '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 0x102fc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032598c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/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.ZnU5XZrF0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:14:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/Render', 19:14:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:32 INFO - 'HOME': '/Users/cltbld', 19:14:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:32 INFO - 'LOGNAME': 'cltbld', 19:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:32 INFO - 'MOZ_NO_REMOTE': '1', 19:14:32 INFO - 'NO_EM_RESTART': '1', 19:14:32 INFO - 'PAGER': '/bin/cat', 19:14:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:32 INFO - 'PWD': '/builds/slave/test', 19:14:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:32 INFO - 'SHELL': '/bin/bash', 19:14:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZnU5XZrF0R/Listeners', 19:14:32 INFO - 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', 19:14:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:32 INFO - 'USER': 'cltbld', 19:14:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:32 INFO - 'XPC_FLAGS': '0x0', 19:14:32 INFO - 'XPC_SERVICE_NAME': '0', 19:14:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:14:33 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-YeZSWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:14:33 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)) 19:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:14:33 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-ljaehw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:14:33 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)) 19:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:14:33 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-fRSQhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:14:33 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-ovdynL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:14:33 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-v8nIvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:14:33 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-y6yg5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:14:34 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)) 19:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:14:34 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-VxglMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:14:34 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)) 19:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:14:34 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-y06FU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:14:34 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)) 19:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:14:34 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-CTUy_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:14:34 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)) 19:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:14:34 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-Gpm_t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:14:34 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-hrmlwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:14:34 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)) 19:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:14:34 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-gz5bwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:14:34 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)) 19:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:14:34 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-EC05k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:14:35 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)) 19:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:14:35 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-YU6OFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:14:35 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)) 19:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:35 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-vO00tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:14:35 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)) 19:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:14:35 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-MAVqN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:14:35 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)) 19:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:14:35 INFO - Running setup.py (path:/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/pip-IZWtDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:14:35 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)) 19:14:35 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)) 19:14:35 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)) 19:14:35 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)) 19:14:35 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)) 19:14:35 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)) 19:14:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:14:38 INFO - Downloading blessings-1.5.1.tar.gz 19:14:38 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 19:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:14:38 INFO - Installing collected packages: blessings 19:14:38 INFO - Running setup.py install for blessings 19:14:38 INFO - Successfully installed blessings 19:14:38 INFO - Cleaning up... 19:14:38 INFO - Return code: 0 19:14:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:14:39 INFO - Reading from file tmpfile_stdout 19:14:39 INFO - Current package versions: 19:14:39 INFO - blessings == 1.5.1 19:14:39 INFO - blobuploader == 1.2.4 19:14:39 INFO - docopt == 0.6.1 19:14:39 INFO - manifestparser == 1.1 19:14:39 INFO - mozInstall == 1.12 19:14:39 INFO - mozcrash == 0.16 19:14:39 INFO - mozdebug == 0.1 19:14:39 INFO - mozdevice == 0.47 19:14:39 INFO - mozfile == 1.2 19:14:39 INFO - mozhttpd == 0.7 19:14:39 INFO - mozinfo == 0.9 19:14:39 INFO - mozleak == 0.1 19:14:39 INFO - mozlog == 3.0 19:14:39 INFO - moznetwork == 0.27 19:14:39 INFO - mozprocess == 0.22 19:14:39 INFO - mozprofile == 0.27 19:14:39 INFO - mozrunner == 6.11 19:14:39 INFO - mozscreenshot == 0.1 19:14:39 INFO - mozsystemmonitor == 0.0 19:14:39 INFO - moztest == 0.7 19:14:39 INFO - mozversion == 1.4 19:14:39 INFO - psutil == 3.1.1 19:14:39 INFO - requests == 1.2.3 19:14:39 INFO - wsgiref == 0.1.2 19:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:14:39 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')]} 19:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:39 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')]} 19:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:14:39 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 0x103342490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10331f228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8563c9ece0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1032659f0>, '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 0x102fc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032598c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/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.ZnU5XZrF0R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 19:14:39 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 19:14:39 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 19:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/Render', 19:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:14:39 INFO - 'HOME': '/Users/cltbld', 19:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:14:39 INFO - 'LOGNAME': 'cltbld', 19:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:14:39 INFO - 'MOZ_NO_REMOTE': '1', 19:14:39 INFO - 'NO_EM_RESTART': '1', 19:14:39 INFO - 'PAGER': '/bin/cat', 19:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:14:39 INFO - 'PWD': '/builds/slave/test', 19:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:14:39 INFO - 'SHELL': '/bin/bash', 19:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZnU5XZrF0R/Listeners', 19:14:39 INFO - 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', 19:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:14:39 INFO - 'USER': 'cltbld', 19:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:14:39 INFO - 'XPC_FLAGS': '0x0', 19:14:39 INFO - 'XPC_SERVICE_NAME': '0', 19:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:14:39 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)) 19:14:39 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)) 19:14:39 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)) 19:14:39 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)) 19:14:39 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)) 19:14:39 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)) 19:14:39 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)) 19:14:39 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)) 19:14:39 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)) 19:14:39 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)) 19:14:39 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)) 19:14:39 INFO - Cleaning up... 19:14:39 INFO - Return code: 0 19:14:39 INFO - Running post-action listener: _resource_record_post_action 19:14:39 INFO - Running post-action listener: _start_resource_monitoring 19:14:39 INFO - Starting resource monitoring. 19:14:39 INFO - ##### 19:14:39 INFO - ##### Running install step. 19:14:39 INFO - ##### 19:14:39 INFO - Running pre-action listener: _resource_record_pre_action 19:14:39 INFO - Running main action method: install 19:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:14:39 INFO - Reading from file tmpfile_stdout 19:14:39 INFO - Detecting whether we're running mozinstall >=1.0... 19:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:14:40 INFO - Reading from file tmpfile_stdout 19:14:40 INFO - Output received: 19:14:40 INFO - Usage: mozinstall [options] installer 19:14:40 INFO - Options: 19:14:40 INFO - -h, --help show this help message and exit 19:14:40 INFO - -d DEST, --destination=DEST 19:14:40 INFO - Directory to install application into. [default: 19:14:40 INFO - "/builds/slave/test"] 19:14:40 INFO - --app=APP Application being installed. [default: firefox] 19:14:40 INFO - mkdir: /builds/slave/test/build/application 19:14:40 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'] 19:14:40 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 19:15:22 INFO - Reading from file tmpfile_stdout 19:15:22 INFO - Output received: 19:15:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:15:22 INFO - Running post-action listener: _resource_record_post_action 19:15:22 INFO - ##### 19:15:22 INFO - ##### Running run-tests step. 19:15:22 INFO - ##### 19:15:22 INFO - Running pre-action listener: _resource_record_pre_action 19:15:22 INFO - Running main action method: run_tests 19:15:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:15:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:15:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:15:22 INFO - 2015-11-11 19:15:22.674 screenresolution[1632:7592] starting screenresolution argv=screenresolution get 19:15:22 INFO - 2015-11-11 19:15:22.678 screenresolution[1632:7592] Display 0: 1600x1200x32@60 19:15:22 INFO - 2015-11-11 19:15:22.685 screenresolution[1633:7594] starting screenresolution argv=screenresolution list 19:15:22 INFO - Available Modes on Display 0 19:15:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:15:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:15:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:15:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:15:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:15:22 INFO - Intel HD Graphics 3000: 19:15:22 INFO - Chipset Model: Intel HD Graphics 3000 19:15:22 INFO - Type: GPU 19:15:22 INFO - Bus: Built-In 19:15:22 INFO - VRAM (Total): 512 MB 19:15:22 INFO - VRAM (Dynamic, Max): 10 19:15:22 INFO - Vendor: Intel (0x8086) 19:15:22 INFO - Device ID: 0x0116 19:15:22 INFO - Revision ID: 0x0009 19:15:22 INFO - Displays: 19:15:22 INFO - Display: 19:15:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:15:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:15:22 INFO - Display Serial Number: 1600x1200 60 19:15:22 INFO - Main Display: Yes 19:15:22 INFO - Mirror: Off 19:15:22 INFO - Online: Yes 19:15:22 INFO - Rotation: Supported 19:15:22 INFO - Return code: 0 19:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:15:22 INFO - Python 2.7.3 19:15:22 INFO - Return code: 0 19:15:22 INFO - grabbing minidump binary from tooltool 19:15:22 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')]} 19:15:22 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 0x1032659f0>, '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 0x102fc5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1032598c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:15:22 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 19:15:22 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 19:15:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:15:23 INFO - Return code: 0 19:15:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:15:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:15:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:15:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:15:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0102', '--webServer', 'localhost'] in /builds/slave/test/build 19:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0102 --webServer localhost 19:15:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YkY973DMNI/Render', 19:15:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:15:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:15:23 INFO - 'HOME': '/Users/cltbld', 19:15:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:15:23 INFO - 'LOGNAME': 'cltbld', 19:15:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:15:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:15:23 INFO - 'MOZ_NO_REMOTE': '1', 19:15:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:15:23 INFO - 'NO_EM_RESTART': '1', 19:15:23 INFO - 'PAGER': '/bin/cat', 19:15:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:15:23 INFO - 'PWD': '/builds/slave/test', 19:15:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:15:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:15:23 INFO - 'SHELL': '/bin/bash', 19:15:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZnU5XZrF0R/Listeners', 19:15:23 INFO - 'TMPDIR': '/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/', 19:15:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:15:23 INFO - 'USER': 'cltbld', 19:15:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:15:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:15:23 INFO - 'XPC_FLAGS': '0x0', 19:15:23 INFO - 'XPC_SERVICE_NAME': '0', 19:15:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:15:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0102', '--webServer', 'localhost'] with output_timeout 3600 19:15:23 INFO - mozversion INFO | application_buildid: 20151111170847 19:15:23 INFO - mozversion INFO | application_changeset: a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a 19:15:23 INFO - mozversion INFO | application_display_name: Nightly 19:15:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:15:23 INFO - mozversion INFO | application_name: Firefox 19:15:23 INFO - mozversion INFO | application_remotingname: firefox 19:15:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 19:15:23 INFO - mozversion INFO | application_vendor: Mozilla 19:15:23 INFO - mozversion INFO | application_version: 45.0a1 19:15:23 INFO - mozversion INFO | platform_buildid: 20151111170847 19:15:23 INFO - mozversion INFO | platform_changeset: a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a 19:15:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 19:15:23 INFO - mozversion INFO | platform_version: 45.0a1 19:15:23 INFO - 2015-11-11 19:15:23,433 DEBUG : using testdate: 1447298123 19:15:23 INFO - 2015-11-11 19:15:23,433 DEBUG : actual date: 1447298123 19:15:23 INFO - 2015-11-11 19:15:23,537 INFO : starting webserver on 'localhost:49270' 19:15:23 INFO - 2015-11-11 19:15:23,538 INFO : Starting test suite t-yosemite-r5-0102 19:15:23 INFO - 2015-11-11 19:15:23,538 INFO : Starting test dromaeo_css 19:15:23 INFO - 2015-11-11 19:15:23,538 DEBUG : operating with platform_type : mac_ 19:15:23 INFO - 2015-11-11 19:15:23,539 INFO : Initialising browser for dromaeo_css test... 19:15:23 INFO - 2015-11-11 19:15:23,568 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/tmpenJkiD/profile http://localhost:49270/getInfo.html 19:15:27 INFO - 2015-11-11 19:15:27,416 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:15:27 INFO - 2015-11-11 19:15:27,416 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:15:27 INFO - 2015-11-11 19:15:27,416 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:15:27 INFO - 2015-11-11 19:15:27,416 DEBUG : BROWSER_OUTPUT: __metrics 19:15:27 INFO - 2015-11-11 19:15:27,437 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:15:28 INFO - 2015-11-11 19:15:28,203 INFO : Browser initialized. 19:15:28 INFO - 2015-11-11 19:15:28,203 INFO : Running cycle 1/1 for dromaeo_css test... 19:15:28 INFO - 2015-11-11 19:15:28,204 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/tmpenJkiD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:15:40 INFO - 2015-11-11 19:15:40,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 230076416 19:15:40 INFO - 2015-11-11 19:15:40,584 DEBUG : BROWSER_OUTPUT: 19:16:32 INFO - 2015-11-11 19:16:32,574 DEBUG : BROWSER_OUTPUT: 1447298192572 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] 19:18:43 INFO - 2015-11-11 19:18:43,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 19:18:44 INFO - 2015-11-11 19:18:44,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 343908352 19:18:44 INFO - 2015-11-11 19:18:44,277 DEBUG : BROWSER_OUTPUT: 19:21:47 INFO - 2015-11-11 19:21:47,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 19:21:47 INFO - 2015-11-11 19:21:47,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 365105152 19:21:47 INFO - 2015-11-11 19:21:47,863 DEBUG : BROWSER_OUTPUT: 19:24:50 INFO - 2015-11-11 19:24:50,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 19:24:50 INFO - 2015-11-11 19:24:50,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 328085504 19:24:50 INFO - 2015-11-11 19:24:50,692 DEBUG : BROWSER_OUTPUT: 19:27:52 INFO - 2015-11-11 19:27:52,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 19:27:53 INFO - 2015-11-11 19:27:53,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 319729664 19:27:53 INFO - 2015-11-11 19:27:53,415 DEBUG : BROWSER_OUTPUT: 19:30:56 INFO - 2015-11-11 19:30:56,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 19:30:57 INFO - 2015-11-11 19:30:57,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 319864832 19:30:57 INFO - 2015-11-11 19:30:57,228 DEBUG : BROWSER_OUTPUT: 19:34:00 INFO - 2015-11-11 19:34:00,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 19:34:00 INFO - 2015-11-11 19:34:00,490 DEBUG : BROWSER_OUTPUT: RSS: Main: 369598464 19:34:00 INFO - 2015-11-11 19:34:00,490 DEBUG : BROWSER_OUTPUT: 19:34:00 INFO - 2015-11-11 19:34:00,491 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:34:00 INFO - 2015-11-11 19:34:00,492 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:34:00 INFO - 2015-11-11 19:34:00,492 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:34:00 INFO - 2015-11-11 19:34:00,492 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:34:00 INFO - 2015-11-11 19:34:00,495 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2586.1724248240566;2612.5558655028644;2662.707102218757;2673.545497265465;2677.7054524002356;4379.167958087961;4454.866354009385;4466.977665111678;4569.291759777236;4679.578837904588;4414.955850441503;4505.324201369788;4557.794899229534;4696;4715.03341814928;4210.7473551586845;4277.379779931924;4335.414719012941;4356.433663623725;4386.078923426085;4379.386885835986;4392.648588112959;4402.471703395597;4411.4265145531035;4466.196084704752;4108.465899433055;4218.430511880888;4226.049138943744;4231.196072746168;4279.400883876276;4147.191297696951;4262.978685106555;4296.054867929081;4316.266234740102;4319.136172765459;4299.548547402509;4309.892252693677;4328.480582330109;4342.1532801103795;4357.281048626973;4327.545607711177;4445.9110817783785;4489.6408287336935;4512.097580483884;4605.470370907355;4743.691660042121;4878.804847806084;4903.558679718807;4927.433345165316;4941.629377796679;4939.481354457766;4955.752212389366;4963.032208719301;5056.191009438472;5066.03745288394;4410.558944105564;4579.542045795394;4597.080583883237;4629.907102187567;4646.814127434898;4929.06347793918;4957.975210123926;4980.402351717817;5049.065922804293;5071.644984851099;4795.256735206049;4841.12859685253;4867.488913664085;4868.756562171877;4923.310736496822;4619.514950930171;4640.930386044212;4680.274557443602;5009.524095210949;5029.798808047637;4728.219843725816;4828.251620998751;4877;4885.5847252983185;4909.607231421478;4857.368542089576;4857.708537487762;4875.902481950412;4883.413990321184;4936.136176169156;3509.78941263525;3714.1643130296006;3748.081719978623;3749.887503374903;3796.468494410785;3386.407378708716;3406.1654894550497;3450.4306789379975;3468.843902024415;3486.5816102067915;4440.35614835847;4445.110977804452;4459.375687403766;4471.1728330259;4488.438945131858;4749.928751068736;4779.044191161782;4793.664443488922;4803.231482962709;4858.3441235432765;4579.6794224403975;4599.701019433726;4635.837745678885;4639.9536004640195;4668.439787225555;4292.871213863589;4298.09739954613;4337.587929146726;4351.760653164107;4362.76004819738;4846.854594362175;4996.900061998813;5069.264956581349;5092.490750924952;5152.433232344439;4829.66192366531;4891.364122664173;4911.263310503453;4967.105920934267;4977.8257760978195;5023.723695196653;5034.119029169954;5072.340595722532;5097.311862898461;5109.6678715883345;4711.670183087288;4818.903621927471;4846.854594362175;4847.418309802705;4938.827141050046;4820.542048505386;4823.252395878644;4826.444958829639;4869.513048695244;4900.509949005071;4755.476897541337;4800.831970881002;4806.303086052572;4852.878678033077;4865.197242454955;4588.724676519286;4728.1252968201;4734.857954261378;4772.689775164603;4880.316755654282;4662.766861656835;4671.789769460314;4674.672772905864;4690;4715.834945776881;4653.348531205566;4724.126036683225;4753.595944344631;4850.369451971221;4901.264810278344;4505.43682039745;4628.514006029319;4665.790039448165;4773.474917759113;4787.736674482798 19:34:00 INFO - 2015-11-11 19:34:00,497 DEBUG : BROWSER_OUTPUT: |1;ext.html;462.87733750556106;466.3960171577809;466.941632295963;479.7697105389412;489.7502273840345;25863.74136258637;26643.33391665207;32880.17799555009;32993;33008.83495582519;35386.29227415456;35640;35886.743963961264;36152.638473615254;36448.08879778007;6767.932320676804;7516.248375162481;7671.309582137606;7730.7680769577;7794.3764498839955;6867.622280774555;7009.614471204081;9170.403923744936;9377.343585948985;9429.151376376125;8894.066123057082;9048.638054477813;9274.953625231898;9305.4881981491;9352.81294374112;6976.965115174392;7144.642767861586;9104.726858194232;9159.587818548149;9200.447973121567;6765.289644587346;9126.863097053549;9361.578728957213;9373.578188981444;9415.15263626277;32278.677213227802;32618.673813262038;32713;32776;33017;2562.9102981395563;2642.6036094585966;2871.4687782760257;2982.9552556711665;3017.6077109975563;22906.54186916269;22981.425464363358;24135.758642413526;24271.271861844172;24388.024479020816;1758.1912320332535;1787.4369573584408;1801.5676237702858;1817.5910420155492;1848.8705790594663;233704;234370;235249;236182;236618;47073.76463117731;47463.5253647466;48182.5181748178;50589.49410505922;50916.49083509117;58382.70808645929;59481.10778338328;59887;60539;60641.696791516646;13671.658208544866;14021.228832414112;14070.71858562823;14155.079919805179;14190.85809141916;10439.269251152346;10648.520816563274;10729.141668666489;10737;10791.83812242817;16211.918940405458;16258.918705406397;16337.673246535003;16509.83490165107;16518.504444866674;6503.772367967098;6769.593824370455;6834.077399551096;6838.47818373538;6868.690908909111;725.271102541942;840.8906842110487;844.4848642328175;856.1010938514535;879.3404452093745;23918.402039949142;24056.7594324058;24138.75861241365;25265.115720950045;25842;859.2438653984453;865.8268346330759;878.8022694893598;904.2991681446799;978.4520668425704;11857.881421185677;12066.879331206752;12305.876941230652;12325.137240393087;12489.375531223403;253000;256728;257513;258579;259978;38404.615953840665;38978.80510597429;42482.36276455856;45177.54822451733;45415.091698166514;1107.307932542145;1129.9322040677587;1144.5650652751901;1150.7871043856912;1155.6301983365242;22250.666240006736;22433;22624;22976.770232297462;23217.883910580338;36247;37163.81418092892;41965.58034419617;42779.786101069294;43137.56862431335;173353;173584.1320793388;173659.13170434066;173743;175743;26691.33271668224;27004.324891877073;27007.324816879736;27015.729842701323;27634.861825690743;34290;35363.028063517835;35374;35393;36159.45760813537;28734.425311494073;29100.500027473834;29722.256943575718;29802.70197298086;30380.088597342114;28582.285442864093;28921.132366029055;29066.41867162687;29089.563656545593;29564.55653165161;28889.56665649975;29495.410091798472;29644.703552964194;29663;30026.099217023526;24858.25425237246;25804.35489112787;26206;26267.21198364052;26802.061927832434;18743.412080308754;18782.436526904214;19236.80763192406;19389.806101939364;19715.901420492806 19:34:00 INFO - 2015-11-11 19:34:00,498 DEBUG : BROWSER_OUTPUT: |2;jquery.html;277.7500249775202;280.55812095948886;280.9241504793707;281.86470494162796;290.8603870142331;9322.541820361268;9755.463449510275;14254.857451425483;15010.624734381632;15026.474073407433;15035.473758418457;15191.46829860955;15408.07551546908;15594.376224951016;15855;4616.376789133457;4754.191787396134;4787.904241915159;4810.39870016248;4834.7824347904425;4643.907121857561;4689.9531004690025;4692.97653511732;4696.882577935562;4728.314394412825;3216.179874132093;3302.4550949093373;3463.1515278756738;4653.27874179501;4711.575958163765;4883.243097319903;4983.07813054586;5025.321581586494;5111.872203194913;5115.411727651331;4372.322290045048;4405.977970110161;4449.510553839075;4487.035287413222;4596.287575425815;18824.15291311894;19011;19154.329598464126;19339.516512087168;19594.21623135073;1348.7504811609883;1413.7949997250341;1446.7612843880747;1558.945436909714;1698.3376483171573;7737.187595302525;7803.3367163791145;8007.319377852889;8103.351731861437;8120.4315697901175;1248.6129299917054;1269.6127681057274;1291.1801006360934;1294.3398866578018;1324.3510679766941;46405;48579.51420485785;48598.27102593464;49125;49831;5424.349078110652;5425.37608175057;5470.316210473691;5474.343078830486;5519;6156.168917196122;6242.406971337716;6247.250329960434;6251;6257.530685198628;4518.683692141519;4524.23088075028;4560.087982403466;4578.496365399803;4616.238320677118;4682.086993036325;4827.179379505493;4877.268409738496;4884.780184891689;4913.434954980152;2408.337707130518;2444.511097780451;2471.4068623530584;2482.3918140055803;2488.1664642344654;836.5942517878824;840.5209030852355;850.1371108325055;887.9911200887908;907.8002839375326;338.8593733600528;342.1326936216679;345.1578149315662;355.786528083148;363.5655391806765;9509.381890177116;9603.471809050568;9859.950700246452;9892.356996795184;9969.900300996896;354.95208146900353;357.15176455917197;367.751767556898;389.95905429930013;396.53803319133465;4959.628027897922;5101.132807422747;5172.043172013115;5205.9219111713355;5279.39286982002;431168;434366;435625;446280;463984;56958.430415696144;58299.41700583025;58776;59177;59314.70342648259;404.3934098851722;404.6055096281102;405.5944055944056;407.3706124038368;407.55169313754635;8848.734537963872;8864.778380540538;8948.373613846969;8982.281417486716;9125.908740912771;27962.72037279601;28010.71989280081;28273.858630706716;28826.135215943556;29012;38914.80542597269;39092.804535977135;39217.6078239214;40260.59739402569;40508.392374115;5082.161443361804;5151.845444636667;5163.199704045879;5221.477852214748;5265.894682106413;9689.12797848197;9846.310758246855;9905.603775848886;9916.851247231152;9931.106200441995;6342.904856427065;8357.331413486785;8412.327013838756;8465.915340846514;8541.402101853058;7887.5267483948855;8036.87944680842;8125.4718443301;8222.424430289822;8248.54632995191;8199.59002049907;8211.630476628447;8373.07896131413;8638.956805215934;8658.956705216433;5039.798408063636;5052.898942021213;5062.544371006627;5065.189569668983;5214.42641309448;7614.885776713464;8271.95864020676;8418.957905210435;8452.957735211285;8567.657293708431 19:34:00 INFO - 2015-11-11 19:34:00,501 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1239.3988915376046;1387.1954266525415;1452.2593477326561;1473.66105795667;1494.0214159725383;6023.39766023398;6199;6293.056041593757;6358.68206589671;6362.840928976778;6387.968060159693;6476.773312934049;6539.64031978241;6564.146660934084;6579.1447111875505;1835.9724604130915;1838.5771272607308;1850.4541160357726;1869.1495369606796;1873.7189421586734;1739.9217035233444;1820.517562845847;1858.3402891973358;1883.4726276642562;1884.1709647755013;1808.2043900683723;1815.1468809659439;1826.8903865768095;1827.3421568235424;1832.0564909071838;1783.785945686513;1800.486861244552;1809.6923523001055;1837.4671345309844;1842.5577861313188;1818.354484158118;1831.688612935804;1843.8709290349682;1854.2119599170433;1865.7387965684816;5806.506446951972;6433.2601750798785;6445.258795238561;6484.740610375579;6601.6699165041555;3579.516765236686;3737.8131093445218;3877.4959255296912;3940.921181576381;3985.3822657488136;2355.281639100074;2361.6221404575185;2417.1177520204997;2422.709274887025;2455.5211733711935;709.7551344786092;714.4641518860855;718.0665135324058;744.6797876912925;746.3767753925479;8902.332325075646;8921.955390223073;8955.41789783662;8963.28293736493;9128.954355228248;3535.8055306958363;3625.7099432045375;3649.799261040615;3685;3710.18375957289;7748.302652761278;7753.728619498291;7754.457187996899;7790.182030886788;7802.336801371947;4098.754074755465;4120.62914337705;4126.298529250034;4149;4158;3712.9814350928614;3725.2921944830937;3757.5490941087246;3777.8299976500575;3782.8865134046023;2897.782666300036;3016.1403999859936;3016.7284944355115;3037.665856755755;3042.4067306874945;964.3008818606454;993.2451336983944;999.7450650084182;1002.6991902429243;1010.5957616953277;1072.0940805019745;1113.5768408004906;1115.8772535021142;1118.5861231344454;1119.1326721790676;6292.779752708725;6331.715072821734;6345.206849143857;6348.047792831112;6424.38968298011;363.1610978639299;377.24927394485326;378.4550247643385;381.5669215440495;385.22761862465575;4857.6599638025;4893.094777466109;4898.363212782316;4943.530364615356;4950.25746138075;7236.710531578783;7629.351505122127;8021.117677055519;8095.392845536609;8104.635291411901;7843.882341764878;7936.206379362017;7936.2857342839425;7977.122516523178;8022.9598852005365;6041.909371359433;6178.382161783876;6233.3143354231;6269.341719119518;6275.34108918557;6164.876702466016;6269.62382257066;6304.338044505261;6315.368463153648;6334.524910631813;6827.112475378368;7023.262557431601;7027.578345299298;7137.464690148156;7211.098612673416;7288.380487658608;7367.4106071515225;7369.189389167294;7490.812729681802;7493;5904.734286957011;5920.259967504062;5974.970125149346;6025.427584379477;6050.6369617823075;6474.255460622088;6475.320091390525;6486.254080780582;6487.448566871869;6514;5996.1005849122985;6030.246219222598;6066.484348830399;6168.814935551941;6215.254169499689;5926.4666180044005;5933.970330148321;5966.731497082555;6020.819375418744;6050.334463209131;6014.72933717975;6073.514118870568;6091.269047714125;6101.908471373022;6160.537959653134;5462.399136095106;5523.861903452445;5538.501534861882;5540.722963851711;5575.080111781673;5590.329160500766;5645.379008309001;5675.77296908119;5683.772649094155;5702.059160238514 19:34:00 INFO - 2015-11-11 19:34:00,503 DEBUG : BROWSER_OUTPUT: |4;prototype.html;261.0835965760182;265.9601059841024;266.4627075571784;270.16249626158896;273.8630684657671;5046.848594542161;5145.948540514593;5167.328247327847;5198.870028249291;5199.194124910645;4953.083679519292;4955.653104282693;5038.042771873342;5185.792568297273;5220.92168617471;3810.6379893910034;4008.859689910854;4020.3165461871554;4037.6164264394833;4074.205529921674;3889.3776995680696;3945.1123497213184;3951.38753493209;3988.6410223079915;4015.678745700337;3933.744306620075;3944.447777311179;3959.227950549644;3977.6817854571564;3986.8803935881824;3906.4726261954556;3931.9017024574327;3958.6635136013474;3990.7206495545324;4008.939865902014;3400.880969166067;3401.1837159081642;3419.1623052352334;3423.9315213695586;3439.8476510369055;4846.200376937801;4948.38145231846;5024.773885175176;5046.167382381903;5053.166227572447;4390.473143222802;4393.736375817429;4401.339799030139;4406.493253275882;4407.140607581523;5363.141897296414;5366.946330536723;5394.973025134849;5409.6213265071465;5416.404195538487;3544.1848374873925;3575.2670702506184;3591.6408359163875;3602.35157671619;3708.684761795251;5582.7766889324375;5588.077967135418;5592.105263157916;5592.944070559283;5631.80288689902;3735;3763.7553559018575;3769.962300376961;3793.18446533991;3808.809559522013;3811.5235595550557;3815.065308999313;3833;3836.865709700147;3868.458415821731;4232.343986682069;4450.198964186413;4469.217886869785;4482;4509.774511274423;5430.049741295336;5432.429594892558;5442.482964118402;5467.617266791286;5550.084236100998;1334.2728213123871;1382.322661895684;1394.7350003499303;1399.2164387942785;1410.1961881727316;871.1114663043786;886.1050339157497;902.5712786426395;914.3279689428265;924.713338864954;5107;5157.252198431206;5169.68981861082;5174.249733788655;5203.19350500673;5499.450054994549;5581.469760372758;5589.692566908859;5608.158776183605;5654.85862853432;5070.518300761421;5100.69395836251;5127.154019586801;5151.4333423323405;5198.584113270929;3038.741706954889;3050.8932187373334;3101.147184524274;3102;3113.392888386788;5603.495685388335;5787.88424231513;5798.6810725410505;5827.679477628772;5888.234529511136;5787.305523337142;5790.334111577138;5812.186293918855;5817.272840894888;5817.7091145442555;5796.594238403271;5832.650040997553;5853.209816674779;5869.647821130746;5931.58478906481;5443.863903402446;5554;5594.916076258778;5595.5803314752375;5684.488396044376;5161.587073034073;5437.429069947757;5453.918191227214;5477.67133971963;5496.395396506461;5598.048331783525;5628.296462942132;5706;5764.020116580107;5798.623089499169;3559.5906470756195;3609.9639003610678;3660.597334293279;3694.002619292722;3714.814259286971;5518.558515318685;5521.337439507285;5541.501264886179;5598.992181407386;5613.438656134354;5240.449752776056;5364.30264065669;5393.784248630011;5450.5367043801725;5510.118381059172;5466.699331536804;5483;5514.420985796433;5544.69504177258;5621.156826476062;5370.087085195448;5371.973140134274;5385.784568617368;5441.891162176655;5466.617336786387;5344.25180474726;5486.396496385474;5520.171974203901;5557.416471270459;5568.248286481273;5403.621746477709;5427.158790387496;5441.156620723794;5447.509724124848;5475.863103422287 19:34:00 INFO - 2015-11-11 19:34:00,506 DEBUG : BROWSER_OUTPUT: |5;yui.html;611.162707091285;625.8748250349928;629.7795771479981;643.1703102997134;645.7384759172535;11361.772764544705;13413.32933353332;13747.725045499084;13792.655183620414;13960.511382101617;11275.267107638017;11886.286822790638;12093.516259349637;12173.45219465124;12194.024478041758;562.9268195134626;566.6175331651119;571.4770984549133;710.1903829634208;734.4931996922106;689.5793565924782;700.7302188657353;711.235421921434;717.4726575966661;721.1418412089597;743.405275779377;751.6617522115042;753.6420200404818;754.7471597015007;757.7613051888637;587.33337661754;597.4801922327559;606.2755007765721;736.576468530597;742.4617152564401;552.0118987013242;553.1343447504643;555.9936514907989;558.7792821835393;559.6725915339531;11156.442177891155;11460.71348216293;11545.942270288679;11553.017993470565;11598;8186;8198.918010819874;8200.343972482187;8269.21442462965;8651.96678780486;7290.81772955675;7446.553206807609;7491.925080749232;7760.068791745027;7797.805054873616;2477.442575420534;2536.9238922832346;2553.565893798059;2564.2820010397118;2564.7050589182295;39892;40461;40543;40570.39144412836;40672;5852.326982397079;5952.345242023374;6118.510519158456;6180.6291622502795;6298.1812364392335;10110.8483372748;10188.796224075477;10252.333598316085;10406.063454289151;10486;5126.256692779526;5250.159974404077;5289.68261904287;5309.867253318698;5370.301860758076;3163.8892638757993;3193.3932552815354;3221.7583681224;3245.432049391347;3337.549430826807;2238.641817309223;2241.9215327463785;2242.8430009899153;2265.139247086097;2267.183813827021;333.7146739537709;340.94203985322554;344.14651663873235;345.9619441861393;346.7815276375867;380.4591404810506;410.2103450857088;485.8493866901272;491.3538696613941;529.8834256463572;5997.880042399128;6514.348565143542;6529.869402611921;6647;6764.154480689914;402.43658877571636;476.64966249806366;486.139533026541;499.21623051809036;519.3767479025184;3053.8916187419713;3082.7533797296164;3147.921301967469;3184.9203769905475;3204.8557814897918;49904.50095499071;50102.248466273035;51034.489655103716;51039.489605104216;51046.234306485436;42890.57109428866;43713.56286437095;43773.78113109478;43774.78112609417;43781.12437751291;39710.80144599258;39721.40417893792;39964.80017599952;40244.195116097515;40569.797151014645;6362.650054247061;6462;6463.612183269019;6487.416132548094;6663.333666633298;30854;31215.375692486476;31398.215044624067;31558;31982.840085799424;43173;43541;44656.33015504705;44691.10617787561;45081.774591126836;8802.33982451306;8889.911100888909;8917.42036767608;9256.166944974984;9316.114969077928;9339.85990210161;9365.812683746422;9371.484568348806;9477.431354118775;9686.418814871131;8939.910600893907;8947.463152210888;8951.239144672516;8994.505302208441;9092.181703646704;8898.110188981309;8917.063708310534;8963.775905602412;8988.505632190292;9032.45805251687;8779.648814047367;8819.559022049;8866.955665221632;8882.37823352385;9023.864642030243;7503.399728021855;7783.494072885244;7878.4091193161885;8158.184181581794;8167.224113709426;7593.848123037619;7705.30652241301;7898.949300115129;7930.603469826601;8013.759587212393 19:34:00 INFO - 2015-11-11 19:34:00,506 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:34:00 INFO - 2015-11-11 19:34:00,506 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:34:00 INFO - 2015-11-11 19:34:00,506 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,976 19:34:00 INFO - 2015-11-11 19:34:00,506 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:34:00 INFO - 2015-11-11 19:34:00,506 DEBUG : BROWSER_OUTPUT: __startTimestamp1447299240490__endTimestamp 19:34:00 INFO - 2015-11-11 19:34:00,507 DEBUG : BROWSER_OUTPUT: 19:34:00 INFO - 2015-11-11 19:34:00,507 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:34:00 INFO - 2015-11-11 19:34:00,507 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:34:00 INFO - 2015-11-11 19:34:00,507 DEBUG : BROWSER_OUTPUT: 19:34:00 INFO - 2015-11-11 19:34:00,507 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4554.72 Median:4679.58 stddev:495.75 (10.6%) stddev-sans-first:472.61 19:34:00 INFO - 2015-11-11 19:34:00,507 DEBUG : BROWSER_OUTPUT: Values: 2586.2 2612.6 2662.7 2673.5 2677.7 4379.2 4454.9 4467.0 4569.3 4679.6 4415.0 4505.3 4557.8 4696.0 4715.0 4210.7 4277.4 4335.4 4356.4 4386.1 4379.4 4392.6 4402.5 4411.4 4466.2 4108.5 4218.4 4226.0 4231.2 4279.4 4147.2 4263.0 4296.1 4316.3 4319.1 4299.5 4309.9 4328.5 4342.2 4357.3 4327.5 4445.9 4489.6 4512.1 4605.5 4743.7 4878.8 4903.6 4927.4 4941.6 4939.5 4955.8 4963.0 5056.2 5066.0 4410.6 4579.5 4597.1 4629.9 4646.8 4929.1 4958.0 4980.4 5049.1 5071.6 4795.3 4841.1 4867.5 4868.8 4923.3 4619.5 4640.9 4680.3 5009.5 5029.8 4728.2 4828.3 4877.0 4885.6 4909.6 4857.4 4857.7 4875.9 4883.4 4936.1 3509.8 3714.2 3748.1 3749.9 3796.5 3386.4 3406.2 3450.4 3468.8 3486.6 4440.4 4445.1 4459.4 4471.2 4488.4 4749.9 4779.0 4793.7 4803.2 4858.3 4579.7 4599.7 4635.8 4640.0 4668.4 4292.9 4298.1 4337.6 4351.8 4362.8 4846.9 4996.9 5069.3 5092.5 5152.4 4829.7 4891.4 4911.3 4967.1 4977.8 5023.7 5034.1 5072.3 5097.3 5109.7 4711.7 4818.9 4846.9 4847.4 4938.8 4820.5 4823.3 4826.4 4869.5 4900.5 4755.5 4800.8 4806.3 4852.9 4865.2 4588.7 4728.1 4734.9 4772.7 4880.3 4662.8 4671.8 4674.7 4690.0 4715.8 4653.3 4724.1 4753.6 4850.4 4901.3 4505.4 4628.5 4665.8 4773.5 4787.7 19:34:00 INFO - 2015-11-11 19:34:00,507 DEBUG : BROWSER_OUTPUT: 19:34:00 INFO - 2015-11-11 19:34:00,508 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37032.32 Median:29692.63 stddev:58731.63 (197.8%) stddev-sans-first:58832.20 19:34:00 INFO - 2015-11-11 19:34:00,509 DEBUG : BROWSER_OUTPUT: Values: 462.9 466.4 466.9 479.8 489.8 25863.7 26643.3 32880.2 32993.0 33008.8 35386.3 35640.0 35886.7 36152.6 36448.1 6767.9 7516.2 7671.3 7730.8 7794.4 6867.6 7009.6 9170.4 9377.3 9429.2 8894.1 9048.6 9275.0 9305.5 9352.8 6977.0 7144.6 9104.7 9159.6 9200.4 6765.3 9126.9 9361.6 9373.6 9415.2 32278.7 32618.7 32713.0 32776.0 33017.0 2562.9 2642.6 2871.5 2983.0 3017.6 22906.5 22981.4 24135.8 24271.3 24388.0 1758.2 1787.4 1801.6 1817.6 1848.9 233704.0 234370.0 235249.0 236182.0 236618.0 47073.8 47463.5 48182.5 50589.5 50916.5 58382.7 59481.1 59887.0 60539.0 60641.7 13671.7 14021.2 14070.7 14155.1 14190.9 10439.3 10648.5 10729.1 10737.0 10791.8 16211.9 16258.9 16337.7 16509.8 16518.5 6503.8 6769.6 6834.1 6838.5 6868.7 725.3 840.9 844.5 856.1 879.3 23918.4 24056.8 24138.8 25265.1 25842.0 859.2 865.8 878.8 904.3 978.5 11857.9 12066.9 12305.9 12325.1 12489.4 253000.0 256728.0 257513.0 258579.0 259978.0 38404.6 38978.8 42482.4 45177.5 45415.1 1107.3 1129.9 1144.6 1150.8 1155.6 22250.7 22433.0 22624.0 22976.8 23217.9 36247.0 37163.8 41965.6 42779.8 43137.6 173353.0 173584.1 173659.1 173743.0 175743.0 26691.3 27004.3 27007.3 27015.7 27634.9 34290.0 35363.0 35374.0 35393.0 36159.5 28734.4 29100.5 29722.3 29802.7 30380.1 28582.3 28921.1 29066.4 29089.6 29564.6 28889.6 29495.4 29644.7 29663.0 30026.1 24858.3 25804.4 26206.0 26267.2 26802.1 18743.4 18782.4 19236.8 19389.8 19715.9 19:34:00 INFO - 2015-11-11 19:34:00,509 DEBUG : BROWSER_OUTPUT: 19:34:00 INFO - 2015-11-11 19:34:00,509 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22243.03 Median:26707.15 stddev:72426.03 (271.2%) stddev-sans-first:72610.43 19:34:00 INFO - 2015-11-11 19:34:00,510 DEBUG : BROWSER_OUTPUT: Values: 277.8 280.6 280.9 281.9 290.9 9322.5 9755.5 14254.9 15010.6 15026.5 15035.5 15191.5 15408.1 15594.4 15855.0 4616.4 4754.2 4787.9 4810.4 4834.8 4643.9 4690.0 4693.0 4696.9 4728.3 3216.2 3302.5 3463.2 4653.3 4711.6 4883.2 4983.1 5025.3 5111.9 5115.4 4372.3 4406.0 4449.5 4487.0 4596.3 18824.2 19011.0 19154.3 19339.5 19594.2 1348.8 1413.8 1446.8 1558.9 1698.3 7737.2 7803.3 8007.3 8103.4 8120.4 1248.6 1269.6 1291.2 1294.3 1324.4 46405.0 48579.5 48598.3 49125.0 49831.0 5424.3 5425.4 5470.3 5474.3 5519.0 6156.2 6242.4 6247.3 6251.0 6257.5 4518.7 4524.2 4560.1 4578.5 4616.2 4682.1 4827.2 4877.3 4884.8 4913.4 2408.3 2444.5 2471.4 2482.4 2488.2 836.6 840.5 850.1 888.0 907.8 338.9 342.1 345.2 355.8 363.6 9509.4 9603.5 9860.0 9892.4 9969.9 355.0 357.2 367.8 390.0 396.5 4959.6 5101.1 5172.0 5205.9 5279.4 431168.0 434366.0 435625.0 446280.0 463984.0 56958.4 58299.4 58776.0 59177.0 59314.7 404.4 404.6 405.6 407.4 407.6 8848.7 8864.8 8948.4 8982.3 9125.9 27962.7 28010.7 28273.9 28826.1 29012.0 38914.8 39092.8 39217.6 40260.6 40508.4 5082.2 5151.8 5163.2 5221.5 5265.9 9689.1 9846.3 9905.6 9916.9 9931.1 6342.9 8357.3 8412.3 8465.9 8541.4 7887.5 8036.9 8125.5 8222.4 8248.5 8199.6 8211.6 8373.1 8639.0 8659.0 5039.8 5052.9 5062.5 5065.2 5214.4 7614.9 8272.0 8419.0 8453.0 8567.7 19:34:00 INFO - 2015-11-11 19:34:00,511 DEBUG : BROWSER_OUTPUT: 19:34:00 INFO - 2015-11-11 19:34:00,511 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4615.24 Median:5930.22 stddev:2438.77 (41.1%) stddev-sans-first:2432.41 19:34:00 INFO - 2015-11-11 19:34:00,512 DEBUG : BROWSER_OUTPUT: Values: 1239.4 1387.2 1452.3 1473.7 1494.0 6023.4 6199.0 6293.1 6358.7 6362.8 6388.0 6476.8 6539.6 6564.1 6579.1 1836.0 1838.6 1850.5 1869.1 1873.7 1739.9 1820.5 1858.3 1883.5 1884.2 1808.2 1815.1 1826.9 1827.3 1832.1 1783.8 1800.5 1809.7 1837.5 1842.6 1818.4 1831.7 1843.9 1854.2 1865.7 5806.5 6433.3 6445.3 6484.7 6601.7 3579.5 3737.8 3877.5 3940.9 3985.4 2355.3 2361.6 2417.1 2422.7 2455.5 709.8 714.5 718.1 744.7 746.4 8902.3 8922.0 8955.4 8963.3 9129.0 3535.8 3625.7 3649.8 3685.0 3710.2 7748.3 7753.7 7754.5 7790.2 7802.3 4098.8 4120.6 4126.3 4149.0 4158.0 3713.0 3725.3 3757.5 3777.8 3782.9 2897.8 3016.1 3016.7 3037.7 3042.4 964.3 993.2 999.7 1002.7 1010.6 1072.1 1113.6 1115.9 1118.6 1119.1 6292.8 6331.7 6345.2 6348.0 6424.4 363.2 377.2 378.5 381.6 385.2 4857.7 4893.1 4898.4 4943.5 4950.3 7236.7 7629.4 8021.1 8095.4 8104.6 7843.9 7936.2 7936.3 7977.1 8023.0 6041.9 6178.4 6233.3 6269.3 6275.3 6164.9 6269.6 6304.3 6315.4 6334.5 6827.1 7023.3 7027.6 7137.5 7211.1 7288.4 7367.4 7369.2 7490.8 7493.0 5904.7 5920.3 5975.0 6025.4 6050.6 6474.3 6475.3 6486.3 6487.4 6514.0 5996.1 6030.2 6066.5 6168.8 6215.3 5926.5 5934.0 5966.7 6020.8 6050.3 6014.7 6073.5 6091.3 6101.9 6160.5 5462.4 5523.9 5538.5 5540.7 5575.1 5590.3 5645.4 5675.8 5683.8 5702.1 19:34:00 INFO - 2015-11-11 19:34:00,512 DEBUG : BROWSER_OUTPUT: 19:34:00 INFO - 2015-11-11 19:34:00,513 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4530.08 Median:5192.19 stddev:1375.17 (26.5%) stddev-sans-first:1341.18 19:34:00 INFO - 2015-11-11 19:34:00,514 DEBUG : BROWSER_OUTPUT: Values: 261.1 266.0 266.5 270.2 273.9 5046.8 5145.9 5167.3 5198.9 5199.2 4953.1 4955.7 5038.0 5185.8 5220.9 3810.6 4008.9 4020.3 4037.6 4074.2 3889.4 3945.1 3951.4 3988.6 4015.7 3933.7 3944.4 3959.2 3977.7 3986.9 3906.5 3931.9 3958.7 3990.7 4008.9 3400.9 3401.2 3419.2 3423.9 3439.8 4846.2 4948.4 5024.8 5046.2 5053.2 4390.5 4393.7 4401.3 4406.5 4407.1 5363.1 5366.9 5395.0 5409.6 5416.4 3544.2 3575.3 3591.6 3602.4 3708.7 5582.8 5588.1 5592.1 5592.9 5631.8 3735.0 3763.8 3770.0 3793.2 3808.8 3811.5 3815.1 3833.0 3836.9 3868.5 4232.3 4450.2 4469.2 4482.0 4509.8 5430.0 5432.4 5442.5 5467.6 5550.1 1334.3 1382.3 1394.7 1399.2 1410.2 871.1 886.1 902.6 914.3 924.7 5107.0 5157.3 5169.7 5174.2 5203.2 5499.5 5581.5 5589.7 5608.2 5654.9 5070.5 5100.7 5127.2 5151.4 5198.6 3038.7 3050.9 3101.1 3102.0 3113.4 5603.5 5787.9 5798.7 5827.7 5888.2 5787.3 5790.3 5812.2 5817.3 5817.7 5796.6 5832.7 5853.2 5869.6 5931.6 5443.9 5554.0 5594.9 5595.6 5684.5 5161.6 5437.4 5453.9 5477.7 5496.4 5598.0 5628.3 5706.0 5764.0 5798.6 3559.6 3610.0 3660.6 3694.0 3714.8 5518.6 5521.3 5541.5 5599.0 5613.4 5240.4 5364.3 5393.8 5450.5 5510.1 5466.7 5483.0 5514.4 5544.7 5621.2 5370.1 5372.0 5385.8 5441.9 5466.6 5344.3 5486.4 5520.2 5557.4 5568.2 5403.6 5427.2 5441.2 5447.5 5475.9 19:34:00 INFO - 2015-11-11 19:34:00,514 DEBUG : BROWSER_OUTPUT: 19:34:00 INFO - 2015-11-11 19:34:00,514 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11523.01 Median:552.57 stddev:14245.28 (2578.0%) stddev-sans-first:14261.67 19:34:00 INFO - 2015-11-11 19:34:00,514 DEBUG : BROWSER_OUTPUT: Values: 611.2 625.9 629.8 643.2 645.7 11361.8 13413.3 13747.7 13792.7 13960.5 11275.3 11886.3 12093.5 12173.5 12194.0 562.9 566.6 571.5 710.2 734.5 689.6 700.7 711.2 717.5 721.1 743.4 751.7 753.6 754.7 757.8 587.3 597.5 606.3 736.6 742.5 552.0 553.1 556.0 558.8 559.7 11156.4 11460.7 11545.9 11553.0 11598.0 8186.0 8198.9 8200.3 8269.2 8652.0 7290.8 7446.6 7491.9 7760.1 7797.8 2477.4 2536.9 2553.6 2564.3 2564.7 39892.0 40461.0 40543.0 40570.4 40672.0 5852.3 5952.3 6118.5 6180.6 6298.2 10110.8 10188.8 10252.3 10406.1 10486.0 5126.3 5250.2 5289.7 5309.9 5370.3 3163.9 3193.4 3221.8 3245.4 3337.5 2238.6 2241.9 2242.8 2265.1 2267.2 333.7 340.9 344.1 346.0 346.8 380.5 410.2 485.8 491.4 529.9 5997.9 6514.3 6529.9 6647.0 6764.2 402.4 476.6 486.1 499.2 519.4 3053.9 3082.8 3147.9 3184.9 3204.9 49904.5 50102.2 51034.5 51039.5 51046.2 42890.6 43713.6 43773.8 43774.8 43781.1 39710.8 39721.4 39964.8 40244.2 40569.8 6362.7 6462.0 6463.6 6487.4 6663.3 30854.0 31215.4 31398.2 31558.0 31982.8 43173.0 43541.0 44656.3 44691.1 45081.8 8802.3 8889.9 8917.4 9256.2 9316.1 9339.9 9365.8 9371.5 9477.4 9686.4 8939.9 8947.5 8951.2 8994.5 9092.2 8898.1 8917.1 8963.8 8988.5 9032.5 8779.6 8819.6 8867.0 8882.4 9023.9 7503.4 7783.5 7878.4 8158.2 8167.2 7593.8 7705.3 7898.9 7930.6 8013.8 19:34:00 INFO - 2015-11-11 19:34:00,515 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:34:00 INFO - 2015-11-11 19:34:00,515 DEBUG : BROWSER_OUTPUT: 19:34:01 INFO - 2015-11-11 19:34:01,190 INFO : Browser exited with error code: 0 19:34:01 INFO - 2015-11-11 19:34:01,224 INFO : Completed test dromaeo_css (00:18:37) 19:34:01 INFO - 2015-11-11 19:34:01,224 INFO : Starting test kraken 19:34:01 INFO - 2015-11-11 19:34:01,224 DEBUG : operating with platform_type : mac_ 19:34:01 INFO - 2015-11-11 19:34:01,224 INFO : Initialising browser for kraken test... 19:34:01 INFO - 2015-11-11 19:34:01,240 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/tmph12JFg/profile http://localhost:49270/getInfo.html 19:34:03 INFO - 2015-11-11 19:34:03,980 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:34:03 INFO - 2015-11-11 19:34:03,980 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:34:03 INFO - 2015-11-11 19:34:03,980 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:34:03 INFO - 2015-11-11 19:34:03,980 DEBUG : BROWSER_OUTPUT: __metrics 19:34:03 INFO - 2015-11-11 19:34:03,997 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:34:04 INFO - 2015-11-11 19:34:04,756 INFO : Browser initialized. 19:34:04 INFO - 2015-11-11 19:34:04,756 INFO : Running cycle 1/1 for kraken test... 19:34:04 INFO - 2015-11-11 19:34:04,756 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/tmph12JFg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:34:17 INFO - 2015-11-11 19:34:17,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 229605376 19:34:17 INFO - 2015-11-11 19:34:17,066 DEBUG : BROWSER_OUTPUT: 19:34:20 INFO - 2015-11-11 19:34:20,010 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 19:34:20 INFO - 2015-11-11 19:34:20,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 285270016 19:34:20 INFO - 2015-11-11 19:34:20,598 DEBUG : BROWSER_OUTPUT: 19:34:23 INFO - 2015-11-11 19:34:23,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 19:34:24 INFO - 2015-11-11 19:34:24,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 299667456 19:34:24 INFO - 2015-11-11 19:34:24,333 DEBUG : BROWSER_OUTPUT: 19:34:27 INFO - 2015-11-11 19:34:27,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 19:34:28 INFO - 2015-11-11 19:34:28,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 284155904 19:34:28 INFO - 2015-11-11 19:34:28,317 DEBUG : BROWSER_OUTPUT: 19:34:30 INFO - 2015-11-11 19:34:30,650 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 19:34:31 INFO - 2015-11-11 19:34:31,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 285347840 19:34:31 INFO - 2015-11-11 19:34:31,246 DEBUG : BROWSER_OUTPUT: 19:34:33 INFO - 2015-11-11 19:34:33,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:34:34 INFO - 2015-11-11 19:34:34,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 285794304 19:34:34 INFO - 2015-11-11 19:34:34,320 DEBUG : BROWSER_OUTPUT: 19:34:37 INFO - 2015-11-11 19:34:37,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 19:34:38 INFO - 2015-11-11 19:34:38,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 283324416 19:34:38 INFO - 2015-11-11 19:34:38,453 DEBUG : BROWSER_OUTPUT: 19:34:42 INFO - 2015-11-11 19:34:42,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 19:34:42 INFO - 2015-11-11 19:34:42,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 281055232 19:34:42 INFO - 2015-11-11 19:34:42,699 DEBUG : BROWSER_OUTPUT: 19:34:46 INFO - 2015-11-11 19:34:46,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 19:34:46 INFO - 2015-11-11 19:34:46,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 283910144 19:34:46 INFO - 2015-11-11 19:34:46,624 DEBUG : BROWSER_OUTPUT: 19:34:48 INFO - 2015-11-11 19:34:48,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:34:48 INFO - 2015-11-11 19:34:48,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 320057344 19:34:48 INFO - 2015-11-11 19:34:48,953 DEBUG : BROWSER_OUTPUT: 19:34:50 INFO - 2015-11-11 19:34:50,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:34:51 INFO - 2015-11-11 19:34:51,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 319897600 19:34:51 INFO - 2015-11-11 19:34:51,619 DEBUG : BROWSER_OUTPUT: 19:34:54 INFO - 2015-11-11 19:34:54,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:34:54 INFO - 2015-11-11 19:34:54,596 DEBUG : BROWSER_OUTPUT: RSS: Main: 327741440 19:34:54 INFO - 2015-11-11 19:34:54,596 DEBUG : BROWSER_OUTPUT: 19:34:57 INFO - 2015-11-11 19:34:57,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:34:58 INFO - 2015-11-11 19:34:58,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 328351744 19:34:58 INFO - 2015-11-11 19:34:58,207 DEBUG : BROWSER_OUTPUT: 19:35:01 INFO - 2015-11-11 19:35:01,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:35:01 INFO - 2015-11-11 19:35:01,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 328425472 19:35:01 INFO - 2015-11-11 19:35:01,805 DEBUG : BROWSER_OUTPUT: 19:35:03 INFO - 2015-11-11 19:35:03,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 19:35:04 INFO - 2015-11-11 19:35:04,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 387776512 19:35:04 INFO - 2015-11-11 19:35:04,004 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,004 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:35:04 INFO - 2015-11-11 19:35:04,004 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:35:04 INFO - 2015-11-11 19:35:04,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:35:04 INFO - 2015-11-11 19:35:04,005 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:35:04 INFO - 2015-11-11 19:35:04,005 DEBUG : BROWSER_OUTPUT: |0;ai-astar;122;131;125;132;131;132;121;132;131;120 19:35:04 INFO - 2015-11-11 19:35:04,005 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;185;168;198;205;171;183;181;156;204;164 19:35:04 INFO - 2015-11-11 19:35:04,005 DEBUG : BROWSER_OUTPUT: |2;audio-dft;189;197;197;197;198;198;196;188;189;199 19:35:04 INFO - 2015-11-11 19:35:04,005 DEBUG : BROWSER_OUTPUT: |3;audio-fft;86;95;101;145;80;84;87;86;139;83 19:35:04 INFO - 2015-11-11 19:35:04,005 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;113;117;163;107;110;111;156;107;109;158 19:35:04 INFO - 2015-11-11 19:35:04,005 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;138;149;149;142;141;142;141;139;135;148 19:35:04 INFO - 2015-11-11 19:35:04,006 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;154;154;155;153;147;154;154;154;154;154 19:35:04 INFO - 2015-11-11 19:35:04,006 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;124;124;124;125;130;128;124;124;125;123 19:35:04 INFO - 2015-11-11 19:35:04,006 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;65;67;71;71;74;74;72;83;72;72 19:35:04 INFO - 2015-11-11 19:35:04,006 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;77;79;82;83;83;83;83;83;79 19:35:04 INFO - 2015-11-11 19:35:04,006 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;101;105;106;106;106;107;106;109;107 19:35:04 INFO - 2015-11-11 19:35:04,006 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;150;162;158;159;162;154;153;155;153;173 19:35:04 INFO - 2015-11-11 19:35:04,006 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;167;174;194;189;192;188;187;190;180;169 19:35:04 INFO - 2015-11-11 19:35:04,006 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;84;85;89;88;90;88;88;88;89 19:35:04 INFO - 2015-11-11 19:35:04,006 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:35:04 INFO - 2015-11-11 19:35:04,007 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:35:04 INFO - 2015-11-11 19:35:04,007 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,984 19:35:04 INFO - 2015-11-11 19:35:04,007 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:35:04 INFO - 2015-11-11 19:35:04,007 DEBUG : BROWSER_OUTPUT: __startTimestamp1447299304003__endTimestamp 19:35:04 INFO - 2015-11-11 19:35:04,007 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,008 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:35:04 INFO - 2015-11-11 19:35:04,008 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:35:04 INFO - 2015-11-11 19:35:04,008 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,008 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:127.70 Median:131.00 stddev:5.08 (3.9%) stddev-sans-first:4.95 19:35:04 INFO - 2015-11-11 19:35:04,010 DEBUG : BROWSER_OUTPUT: Values: 122.0 131.0 125.0 132.0 131.0 132.0 121.0 132.0 131.0 120.0 19:35:04 INFO - 2015-11-11 19:35:04,010 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,010 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:181.50 Median:184.00 stddev:16.98 (9.2%) stddev-sans-first:17.96 19:35:04 INFO - 2015-11-11 19:35:04,010 DEBUG : BROWSER_OUTPUT: Values: 185.0 168.0 198.0 205.0 171.0 183.0 181.0 156.0 204.0 164.0 19:35:04 INFO - 2015-11-11 19:35:04,011 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,011 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:194.80 Median:197.00 stddev:4.32 (2.2%) stddev-sans-first:4.03 19:35:04 INFO - 2015-11-11 19:35:04,011 DEBUG : BROWSER_OUTPUT: Values: 189.0 197.0 197.0 197.0 198.0 198.0 196.0 188.0 189.0 199.0 19:35:04 INFO - 2015-11-11 19:35:04,011 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,011 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:98.60 Median:85.00 stddev:23.71 (27.9%) stddev-sans-first:24.70 19:35:04 INFO - 2015-11-11 19:35:04,011 DEBUG : BROWSER_OUTPUT: Values: 86.0 95.0 101.0 145.0 80.0 84.0 87.0 86.0 139.0 83.0 19:35:04 INFO - 2015-11-11 19:35:04,011 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,012 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:125.10 Median:115.00 stddev:23.63 (20.6%) stddev-sans-first:24.66 19:35:04 INFO - 2015-11-11 19:35:04,012 DEBUG : BROWSER_OUTPUT: Values: 113.0 117.0 163.0 107.0 110.0 111.0 156.0 107.0 109.0 158.0 19:35:04 INFO - 2015-11-11 19:35:04,012 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,012 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:142.40 Median:142.00 stddev:4.81 (3.4%) stddev-sans-first:4.83 19:35:04 INFO - 2015-11-11 19:35:04,012 DEBUG : BROWSER_OUTPUT: Values: 138.0 149.0 149.0 142.0 141.0 142.0 141.0 139.0 135.0 148.0 19:35:04 INFO - 2015-11-11 19:35:04,013 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,013 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:153.30 Median:154.00 stddev:2.26 (1.5%) stddev-sans-first:2.39 19:35:04 INFO - 2015-11-11 19:35:04,013 DEBUG : BROWSER_OUTPUT: Values: 154.0 154.0 155.0 153.0 147.0 154.0 154.0 154.0 154.0 154.0 19:35:04 INFO - 2015-11-11 19:35:04,013 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,013 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:125.10 Median:124.50 stddev:2.18 (1.8%) stddev-sans-first:2.28 19:35:04 INFO - 2015-11-11 19:35:04,013 DEBUG : BROWSER_OUTPUT: Values: 124.0 124.0 124.0 125.0 130.0 128.0 124.0 124.0 125.0 123.0 19:35:04 INFO - 2015-11-11 19:35:04,013 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,014 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.10 Median:72.00 stddev:4.77 (6.6%) stddev-sans-first:4.31 19:35:04 INFO - 2015-11-11 19:35:04,014 DEBUG : BROWSER_OUTPUT: Values: 65.0 67.0 71.0 71.0 74.0 74.0 72.0 83.0 72.0 72.0 19:35:04 INFO - 2015-11-11 19:35:04,014 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,014 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:80.40 Median:83.00 stddev:3.69 (4.4%) stddev-sans-first:2.35 19:35:04 INFO - 2015-11-11 19:35:04,014 DEBUG : BROWSER_OUTPUT: Values: 72.0 77.0 79.0 82.0 83.0 83.0 83.0 83.0 83.0 79.0 19:35:04 INFO - 2015-11-11 19:35:04,014 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:104.80 Median:106.50 stddev:3.99 (3.8%) stddev-sans-first:2.15 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: Values: 95.0 101.0 105.0 106.0 106.0 106.0 107.0 106.0 109.0 107.0 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:157.90 Median:158.50 stddev:6.64 (4.2%) stddev-sans-first:6.40 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: Values: 150.0 162.0 158.0 159.0 162.0 154.0 153.0 155.0 153.0 173.0 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.00 Median:188.50 stddev:9.83 (5.2%) stddev-sans-first:8.56 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: Values: 167.0 174.0 194.0 189.0 192.0 188.0 187.0 190.0 180.0 169.0 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.90 Median:88.00 stddev:3.03 (3.4%) stddev-sans-first:1.94 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: Values: 80.0 84.0 85.0 89.0 88.0 90.0 88.0 88.0 88.0 89.0 19:35:04 INFO - 2015-11-11 19:35:04,016 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:35:04 INFO - 2015-11-11 19:35:04,017 DEBUG : BROWSER_OUTPUT: 19:35:04 INFO - 2015-11-11 19:35:04,743 INFO : Browser exited with error code: 0 19:35:04 INFO - 2015-11-11 19:35:04,802 INFO : Completed test kraken (00:01:03) 19:35:04 INFO - 2015-11-11 19:35:04,803 INFO : Starting test v8_7 19:35:04 INFO - 2015-11-11 19:35:04,803 DEBUG : operating with platform_type : mac_ 19:35:04 INFO - 2015-11-11 19:35:04,803 INFO : Initialising browser for v8_7 test... 19:35:04 INFO - 2015-11-11 19:35:04,819 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/tmpVjAmjc/profile http://localhost:49270/getInfo.html 19:35:07 INFO - 2015-11-11 19:35:07,514 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:35:07 INFO - 2015-11-11 19:35:07,514 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:35:07 INFO - 2015-11-11 19:35:07,515 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:35:07 INFO - 2015-11-11 19:35:07,515 DEBUG : BROWSER_OUTPUT: __metrics 19:35:07 INFO - 2015-11-11 19:35:07,532 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:35:07 INFO - 2015-11-11 19:35:07,834 DEBUG : BROWSER_OUTPUT: console.error: 19:35:07 INFO - 2015-11-11 19:35:07,834 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 19:35:07 INFO - 2015-11-11 19:35:07,834 DEBUG : BROWSER_OUTPUT: Stack: 19:35:07 INFO - 2015-11-11 19:35:07,834 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 19:35:07 INFO - 2015-11-11 19:35:07,835 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 19:35:07 INFO - 2015-11-11 19:35:07,835 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 19:35:07 INFO - 2015-11-11 19:35:07,835 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 19:35:07 INFO - 2015-11-11 19:35:07,835 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 19:35:07 INFO - 2015-11-11 19:35:07,835 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 19:35:07 INFO - 2015-11-11 19:35:07,835 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 19:35:07 INFO - 2015-11-11 19:35:07,835 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 19:35:07 INFO - 2015-11-11 19:35:07,835 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 19:35:07 INFO - 2015-11-11 19:35:07,835 DEBUG : BROWSER_OUTPUT: 19:35:08 INFO - 2015-11-11 19:35:08,334 INFO : Browser initialized. 19:35:08 INFO - 2015-11-11 19:35:08,334 INFO : Running cycle 1/1 for v8_7 test... 19:35:08 INFO - 2015-11-11 19:35:08,334 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/tmpVjAmjc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:35:20 INFO - 2015-11-11 19:35:20,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 229679104 19:35:20 INFO - 2015-11-11 19:35:20,668 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/v8_7/run.html (next: http://localhost:49270/tests/v8_7/run.html) 19:35:43 INFO - 2015-11-11 19:35:43,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 766255104 19:35:43 INFO - 2015-11-11 19:35:43,830 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,830 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:35:43 INFO - 2015-11-11 19:35:43,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:35:43 INFO - 2015-11-11 19:35:43,830 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:35:43 INFO - 2015-11-11 19:35:43,830 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:35:43 INFO - 2015-11-11 19:35:43,830 DEBUG : BROWSER_OUTPUT: |0;Richards;199.16351324437363 19:35:43 INFO - 2015-11-11 19:35:43,831 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;230.73373327180434 19:35:43 INFO - 2015-11-11 19:35:43,831 DEBUG : BROWSER_OUTPUT: |2;Encrypt;378.7878787878788 19:35:43 INFO - 2015-11-11 19:35:43,831 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7049.295774647887 19:35:43 INFO - 2015-11-11 19:35:43,831 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2280.1822323462416 19:35:43 INFO - 2015-11-11 19:35:43,831 DEBUG : BROWSER_OUTPUT: |5;Earley;956.9789674952199 19:35:43 INFO - 2015-11-11 19:35:43,831 DEBUG : BROWSER_OUTPUT: |6;Boyer;15492.307692307691 19:35:43 INFO - 2015-11-11 19:35:43,831 DEBUG : BROWSER_OUTPUT: |7;RegExp;35224.137931034486 19:35:43 INFO - 2015-11-11 19:35:43,832 DEBUG : BROWSER_OUTPUT: |8;Splay;824.4023083264633 19:35:43 INFO - 2015-11-11 19:35:43,832 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6856.164383561644 19:35:43 INFO - 2015-11-11 19:35:43,832 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:35:43 INFO - 2015-11-11 19:35:43,832 DEBUG : BROWSER_OUTPUT: __startTimestamp1447299343827__endTimestamp 19:35:43 INFO - 2015-11-11 19:35:43,832 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,832 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:35:43 INFO - 2015-11-11 19:35:43,832 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:35:43 INFO - 2015-11-11 19:35:43,832 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,833 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:199.16 Median:199.16 stddev:0.00 (0.0%) 19:35:43 INFO - 2015-11-11 19:35:43,833 DEBUG : BROWSER_OUTPUT: Values: 199.2 19:35:43 INFO - 2015-11-11 19:35:43,833 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,833 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:230.73 Median:230.73 stddev:0.00 (0.0%) 19:35:43 INFO - 2015-11-11 19:35:43,833 DEBUG : BROWSER_OUTPUT: Values: 230.7 19:35:43 INFO - 2015-11-11 19:35:43,833 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,833 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:378.79 Median:378.79 stddev:0.00 (0.0%) 19:35:43 INFO - 2015-11-11 19:35:43,833 DEBUG : BROWSER_OUTPUT: Values: 378.8 19:35:43 INFO - 2015-11-11 19:35:43,834 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,834 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7049.30 Median:7049.30 stddev:0.00 (0.0%) 19:35:43 INFO - 2015-11-11 19:35:43,834 DEBUG : BROWSER_OUTPUT: Values: 7049.3 19:35:43 INFO - 2015-11-11 19:35:43,834 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,834 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2280.18 Median:2280.18 stddev:0.00 (0.0%) 19:35:43 INFO - 2015-11-11 19:35:43,834 DEBUG : BROWSER_OUTPUT: Values: 2280.2 19:35:43 INFO - 2015-11-11 19:35:43,834 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,834 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:956.98 Median:956.98 stddev:0.00 (0.0%) 19:35:43 INFO - 2015-11-11 19:35:43,835 DEBUG : BROWSER_OUTPUT: Values: 957.0 19:35:43 INFO - 2015-11-11 19:35:43,835 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,835 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15492.31 Median:15492.31 stddev:0.00 (0.0%) 19:35:43 INFO - 2015-11-11 19:35:43,835 DEBUG : BROWSER_OUTPUT: Values: 15492.3 19:35:43 INFO - 2015-11-11 19:35:43,835 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,835 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35224.14 Median:35224.14 stddev:0.00 (0.0%) 19:35:43 INFO - 2015-11-11 19:35:43,835 DEBUG : BROWSER_OUTPUT: Values: 35224.1 19:35:43 INFO - 2015-11-11 19:35:43,835 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,836 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:824.40 Median:824.40 stddev:0.00 (0.0%) 19:35:43 INFO - 2015-11-11 19:35:43,836 DEBUG : BROWSER_OUTPUT: Values: 824.4 19:35:43 INFO - 2015-11-11 19:35:43,836 DEBUG : BROWSER_OUTPUT: 19:35:43 INFO - 2015-11-11 19:35:43,836 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6856.16 Median:6856.16 stddev:0.00 (0.0%) 19:35:43 INFO - 2015-11-11 19:35:43,836 DEBUG : BROWSER_OUTPUT: Values: 6856.2 19:35:43 INFO - 2015-11-11 19:35:43,836 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:35:43 INFO - 2015-11-11 19:35:43,836 DEBUG : BROWSER_OUTPUT: 19:35:44 INFO - 2015-11-11 19:35:44,619 INFO : Browser exited with error code: 0 19:35:44 INFO - 2015-11-11 19:35:44,644 INFO : Completed test v8_7 (00:00:39) 19:35:45 INFO - 2015-11-11 19:35:45,003 INFO : Completed test suite (00:20:21) 19:35:45 INFO - 2015-11-11 19:35:45,003 DEBUG : Working with test: dromaeo_css 19:35:45 INFO - 2015-11-11 19:35:45,004 DEBUG : Generating results file: dromaeo_css 19:35:45 INFO - 2015-11-11 19:35:45,005 DEBUG : Working with test: kraken 19:35:45 INFO - 2015-11-11 19:35:45,005 DEBUG : Generating results file: kraken 19:35:45 INFO - 2015-11-11 19:35:45,005 INFO : javascript benchmark 19:35:45 INFO - 2015-11-11 19:35:45,005 DEBUG : Working with test: v8_7 19:35:45 INFO - 2015-11-11 19:35:45,005 DEBUG : Generating results file: v8_7 19:35:45 INFO - 2015-11-11 19:35:45,006 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:35:45 INFO - 2015-11-11 19:35:45,136 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 19:35:45 INFO - 2015-11-11 19:35:45,136 DEBUG : process_Request line: dromaeo_css 5563.54 graph.html#tests=[[72,1,55]] 19:35:45 INFO - 2015-11-11 19:35:45,137 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:35:45 INFO - 2015-11-11 19:35:45,244 DEBUG : process_Request line: kraken 1833.60 graph.html#tests=[[232,1,55]] 19:35:45 INFO - 2015-11-11 19:35:45,244 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:35:45 INFO - 2015-11-11 19:35:45,348 DEBUG : process_Request line: v8_7 15427.83 graph.html#tests=[[230,1,55]] 19:35:45 INFO - 2015-11-11 19:35:45,349 INFO : javascript benchmark 19:35:45 INFO - 2015-11-11 19:35:45,351 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [277.7500249775202, 280.55812095948886, 280.9241504793707, 281.86470494162796, 290.8603870142331, 9322.541820361268, 9755.463449510275, 14254.857451425483, 15010.624734381632, 15026.474073407433, 15035.473758418457, 15191.46829860955, 15408.07551546908, 15594.376224951016, 15855.0, 4616.376789133457, 4754.191787396134, 4787.904241915159, 4810.39870016248, 4834.7824347904425, 4643.907121857561, 4689.9531004690025, 4692.97653511732, 4696.882577935562, 4728.314394412825, 3216.179874132093, 3302.4550949093373, 3463.1515278756738, 4653.27874179501, 4711.575958163765, 4883.243097319903, 4983.07813054586, 5025.321581586494, 5111.872203194913, 5115.411727651331, 4372.322290045048, 4405.977970110161, 4449.510553839075, 4487.035287413222, 4596.287575425815, 18824.15291311894, 19011.0, 19154.329598464126, 19339.516512087168, 19594.21623135073, 1348.7504811609883, 1413.7949997250341, 1446.7612843880747, 1558.945436909714, 1698.3376483171573, 7737.187595302525, 7803.3367163791145, 8007.319377852889, 8103.351731861437, 8120.4315697901175, 1248.6129299917054, 1269.6127681057274, 1291.1801006360934, 1294.3398866578018, 1324.3510679766941, 46405.0, 48579.51420485785, 48598.27102593464, 49125.0, 49831.0, 5424.349078110652, 5425.37608175057, 5470.316210473691, 5474.343078830486, 5519.0, 6156.168917196122, 6242.406971337716, 6247.250329960434, 6251.0, 6257.530685198628, 4518.683692141519, 4524.23088075028, 4560.087982403466, 4578.496365399803, 4616.238320677118, 4682.086993036325, 4827.179379505493, 4877.268409738496, 4884.780184891689, 4913.434954980152, 2408.337707130518, 2444.511097780451, 2471.4068623530584, 2482.3918140055803, 2488.1664642344654, 836.5942517878824, 840.5209030852355, 850.1371108325055, 887.9911200887908, 907.8002839375326, 338.8593733600528, 342.1326936216679, 345.1578149315662, 355.786528083148, 363.5655391806765, 9509.381890177116, 9603.471809050568, 9859.950700246452, 9892.356996795184, 9969.900300996896, 354.95208146900353, 357.15176455917197, 367.751767556898, 389.95905429930013, 396.53803319133465, 4959.628027897922, 5101.132807422747, 5172.043172013115, 5205.9219111713355, 5279.39286982002, 431168.0, 434366.0, 435625.0, 446280.0, 463984.0, 56958.430415696144, 58299.41700583025, 58776.0, 59177.0, 59314.70342648259, 404.3934098851722, 404.6055096281102, 405.5944055944056, 407.3706124038368, 407.55169313754635, 8848.734537963872, 8864.778380540538, 8948.373613846969, 8982.281417486716, 9125.908740912771, 27962.72037279601, 28010.71989280081, 28273.858630706716, 28826.135215943556, 29012.0, 38914.80542597269, 39092.804535977135, 39217.6078239214, 40260.59739402569, 40508.392374115, 5082.161443361804, 5151.845444636667, 5163.199704045879, 5221.477852214748, 5265.894682106413, 9689.12797848197, 9846.310758246855, 9905.603775848886, 9916.851247231152, 9931.106200441995, 6342.904856427065, 8357.331413486785, 8412.327013838756, 8465.915340846514, 8541.402101853058, 7887.5267483948855, 8036.87944680842, 8125.4718443301, 8222.424430289822, 8248.54632995191, 8199.59002049907, 8211.630476628447, 8373.07896131413, 8638.956805215934, 8658.956705216433, 5039.798408063636, 5052.898942021213, 5062.544371006627, 5065.189569668983, 5214.42641309448, 7614.885776713464, 8271.95864020676, 8418.957905210435, 8452.957735211285, 8567.657293708431], "dojo.html": [2586.1724248240566, 2612.5558655028644, 2662.707102218757, 2673.545497265465, 2677.7054524002356, 4379.167958087961, 4454.866354009385, 4466.977665111678, 4569.291759777236, 4679.578837904588, 4414.955850441503, 4505.324201369788, 4557.794899229534, 4696.0, 4715.03341814928, 4210.7473551586845, 4277.379779931924, 4335.414719012941, 4356.433663623725, 4386.078923426085, 4379.386885835986, 4392.648588112959, 4402.471703395597, 4411.4265145531035, 4466.196084704752, 4108.465899433055, 4218.430511880888, 4226.049138943744, 4231.196072746168, 4279.400883876276, 4147.191297696951, 4262.978685106555, 4296.054867929081, 4316.266234740102, 4319.136172765459, 4299.548547402509, 4309.892252693677, 4328.480582330109, 4342.1532801103795, 4357.281048626973, 4327.545607711177, 4445.9110817783785, 4489.6408287336935, 4512.097580483884, 4605.470370907355, 4743.691660042121, 4878.804847806084, 4903.558679718807, 4927.433345165316, 4941.629377796679, 4939.481354457766, 4955.752212389366, 4963.032208719301, 5056.191009438472, 5066.03745288394, 4410.558944105564, 4579.542045795394, 4597.080583883237, 4629.907102187567, 4646.814127434898, 4929.06347793918, 4957.975210123926, 4980.402351717817, 5049.065922804293, 5071.644984851099, 4795.256735206049, 4841.12859685253, 4867.488913664085, 4868.756562171877, 4923.310736496822, 4619.514950930171, 4640.930386044212, 4680.274557443602, 5009.524095210949, 5029.798808047637, 4728.219843725816, 4828.251620998751, 4877.0, 4885.5847252983185, 4909.607231421478, 4857.368542089576, 4857.708537487762, 4875.902481950412, 4883.413990321184, 4936.136176169156, 3509.78941263525, 3714.1643130296006, 3748.081719978623, 3749.887503374903, 3796.468494410785, 3386.407378708716, 3406.1654894550497, 3450.4306789379975, 3468.843902024415, 3486.5816102067915, 4440.35614835847, 4445.110977804452, 4459.375687403766, 4471.1728330259, 4488.438945131858, 4749.928751068736, 4779.044191161782, 4793.664443488922, 4803.231482962709, 4858.3441235432765, 4579.6794224403975, 4599.701019433726, 4635.837745678885, 4639.9536004640195, 4668.439787225555, 4292.871213863589, 4298.09739954613, 4337.587929146726, 4351.760653164107, 4362.76004819738, 4846.854594362175, 4996.900061998813, 5069.264956581349, 5092.490750924952, 5152.433232344439, 4829.66192366531, 4891.364122664173, 4911.263310503453, 4967.105920934267, 4977.8257760978195, 5023.723695196653, 5034.119029169954, 5072.340595722532, 5097.311862898461, 5109.6678715883345, 4711.670183087288, 4818.903621927471, 4846.854594362175, 4847.418309802705, 4938.827141050046, 4820.542048505386, 4823.252395878644, 4826.444958829639, 4869.513048695244, 4900.509949005071, 4755.476897541337, 4800.831970881002, 4806.303086052572, 4852.878678033077, 4865.197242454955, 4588.724676519286, 4728.1252968201, 4734.857954261378, 4772.689775164603, 4880.316755654282, 4662.766861656835, 4671.789769460314, 4674.672772905864, 4690.0, 4715.834945776881, 4653.348531205566, 4724.126036683225, 4753.595944344631, 4850.369451971221, 4901.264810278344, 4505.43682039745, 4628.514006029319, 4665.790039448165, 4773.474917759113, 4787.736674482798], "mootools.html": [1239.3988915376046, 1387.1954266525415, 1452.2593477326561, 1473.66105795667, 1494.0214159725383, 6023.39766023398, 6199.0, 6293.056041593757, 6358.68206589671, 6362.840928976778, 6387.968060159693, 6476.773312934049, 6539.64031978241, 6564.146660934084, 6579.1447111875505, 1835.9724604130915, 1838.5771272607308, 1850.4541160357726, 1869.1495369606796, 1873.7189421586734, 1739.9217035233444, 1820.517562845847, 1858.3402891973358, 1883.4726276642562, 1884.1709647755013, 1808.2043900683723, 1815.1468809659439, 1826.8903865768095, 1827.3421568235424, 1832.0564909071838, 1783.785945686513, 1800.486861244552, 1809.6923523001055, 1837.4671345309844, 1842.5577861313188, 1818.354484158118, 1831.688612935804, 1843.8709290349682, 1854.2119599170433, 1865.7387965684816, 5806.506446951972, 6433.2601750798785, 6445.258795238561, 6484.740610375579, 6601.6699165041555, 3579.516765236686, 3737.8131093445218, 3877.4959255296912, 3940.921181576381, 3985.3822657488136, 2355.281639100074, 2361.6221404575185, 2417.1177520204997, 2422.709274887025, 2455.5211733711935, 709.7551344786092, 714.4641518860855, 718.0665135324058, 744.6797876912925, 746.3767753925479, 8902.332325075646, 8921.955390223073, 8955.41789783662, 8963.28293736493, 9128.954355228248, 3535.8055306958363, 3625.7099432045375, 3649.799261040615, 3685.0, 3710.18375957289, 7748.302652761278, 7753.728619498291, 7754.457187996899, 7790.182030886788, 7802.336801371947, 4098.754074755465, 4120.62914337705, 4126.298529250034, 4149.0, 4158.0, 3712.9814350928614, 3725.2921944830937, 3757.5490941087246, 3777.8299976500575, 3782.8865134046023, 2897.782666300036, 3016.1403999859936, 3016.7284944355115, 3037.665856755755, 3042.4067306874945, 964.3008818606454, 993.2451336983944, 999.7450650084182, 1002.6991902429243, 1010.5957616953277, 1072.0940805019745, 1113.5768408004906, 1115.8772535021142, 1118.5861231344454, 1119.1326721790676, 6292.779752708725, 6331.715072821734, 6345.206849143857, 6348.047792831112, 6424.38968298011, 363.1610978639299, 377.24927394485326, 378.4550247643385, 381.5669215440495, 385.22761862465575, 4857.6599638025, 4893.094777466109, 4898.363212782316, 4943.530364615356, 4950.25746138075, 7236.710531578783, 7629.351505122127, 8021.117677055519, 8095.392845536609, 8104.635291411901, 7843.882341764878, 7936.206379362017, 7936.2857342839425, 7977.122516523178, 8022.9598852005365, 6041.909371359433, 6178.382161783876, 6233.3143354231, 6269.341719119518, 6275.34108918557, 6164.876702466016, 6269.62382257066, 6304.338044505261, 6315.368463153648, 6334.524910631813, 6827.112475378368, 7023.262557431601, 7027.578345299298, 7137.464690148156, 7211.098612673416, 7288.380487658608, 7367.4106071515225, 7369.189389167294, 7490.812729681802, 7493.0, 5904.734286957011, 5920.259967504062, 5974.970125149346, 6025.427584379477, 6050.6369617823075, 6474.255460622088, 6475.320091390525, 6486.254080780582, 6487.448566871869, 6514.0, 5996.1005849122985, 6030.246219222598, 6066.484348830399, 6168.814935551941, 6215.254169499689, 5926.4666180044005, 5933.970330148321, 5966.731497082555, 6020.819375418744, 6050.334463209131, 6014.72933717975, 6073.514118870568, 6091.269047714125, 6101.908471373022, 6160.537959653134, 5462.399136095106, 5523.861903452445, 5538.501534861882, 5540.722963851711, 5575.080111781673, 5590.329160500766, 5645.379008309001, 5675.77296908119, 5683.772649094155, 5702.059160238514], "ext.html": [462.87733750556106, 466.3960171577809, 466.941632295963, 479.7697105389412, 489.7502273840345, 25863.74136258637, 26643.33391665207, 32880.17799555009, 32993.0, 33008.83495582519, 35386.29227415456, 35640.0, 35886.743963961264, 36152.638473615254, 36448.08879778007, 6767.932320676804, 7516.248375162481, 7671.309582137606, 7730.7680769577, 7794.3764498839955, 6867.622280774555, 7009.614471204081, 9170.403923744936, 9377.343585948985, 9429.151376376125, 8894.066123057082, 9048.638054477813, 9274.953625231898, 9305.4881981491, 9352.81294374112, 6976.965115174392, 7144.642767861586, 9104.726858194232, 9159.587818548149, 9200.447973121567, 6765.289644587346, 9126.863097053549, 9361.578728957213, 9373.578188981444, 9415.15263626277, 32278.677213227802, 32618.673813262038, 32713.0, 32776.0, 33017.0, 2562.9102981395563, 2642.6036094585966, 2871.4687782760257, 2982.9552556711665, 3017.6077109975563, 22906.54186916269, 22981.425464363358, 24135.758642413526, 24271.271861844172, 24388.024479020816, 1758.1912320332535, 1787.4369573584408, 1801.5676237702858, 1817.5910420155492, 1848.8705790594663, 233704.0, 234370.0, 235249.0, 236182.0, 236618.0, 47073.76463117731, 47463.5253647466, 48182.5181748178, 50589.49410505922, 50916.49083509117, 58382.70808645929, 59481.10778338328, 59887.0, 60539.0, 60641.696791516646, 13671.658208544866, 14021.228832414112, 14070.71858562823, 14155.079919805179, 14190.85809141916, 10439.269251152346, 10648.520816563274, 10729.141668666489, 10737.0, 10791.83812242817, 16211.918940405458, 16258.918705406397, 16337.673246535003, 16509.83490165107, 16518.504444866674, 6503.772367967098, 6769.593824370455, 6834.077399551096, 6838.47818373538, 6868.690908909111, 725.271102541942, 840.8906842110487, 844.4848642328175, 856.1010938514535, 879.3404452093745, 23918.402039949142, 24056.7594324058, 24138.75861241365, 25265.115720950045, 25842.0, 859.2438653984453, 865.8268346330759, 878.8022694893598, 904.2991681446799, 978.4520668425704, 11857.881421185677, 12066.879331206752, 12305.876941230652, 12325.137240393087, 12489.375531223403, 253000.0, 256728.0, 257513.0, 258579.0, 259978.0, 38404.615953840665, 38978.80510597429, 42482.36276455856, 45177.54822451733, 45415.091698166514, 1107.307932542145, 1129.9322040677587, 1144.5650652751901, 1150.7871043856912, 1155.6301983365242, 22250.666240006736, 22433.0, 22624.0, 22976.770232297462, 23217.883910580338, 36247.0, 37163.81418092892, 41965.58034419617, 42779.786101069294, 43137.56862431335, 173353.0, 173584.1320793388, 173659.13170434066, 173743.0, 175743.0, 26691.33271668224, 27004.324891877073, 27007.324816879736, 27015.729842701323, 27634.861825690743, 34290.0, 35363.028063517835, 35374.0, 35393.0, 36159.45760813537, 28734.425311494073, 29100.500027473834, 29722.256943575718, 29802.70197298086, 30380.088597342114, 28582.285442864093, 28921.132366029055, 29066.41867162687, 29089.563656545593, 29564.55653165161, 28889.56665649975, 29495.410091798472, 29644.703552964194, 29663.0, 30026.099217023526, 24858.25425237246, 25804.35489112787, 26206.0, 26267.21198364052, 26802.061927832434, 18743.412080308754, 18782.436526904214, 19236.80763192406, 19389.806101939364, 19715.901420492806], "prototype.html": [261.0835965760182, 265.9601059841024, 266.4627075571784, 270.16249626158896, 273.8630684657671, 5046.848594542161, 5145.948540514593, 5167.328247327847, 5198.870028249291, 5199.194124910645, 4953.083679519292, 4955.653104282693, 5038.042771873342, 5185.792568297273, 5220.92168617471, 3810.6379893910034, 4008.859689910854, 4020.3165461871554, 4037.6164264394833, 4074.205529921674, 3889.3776995680696, 3945.1123497213184, 3951.38753493209, 3988.6410223079915, 4015.678745700337, 3933.744306620075, 3944.447777311179, 3959.227950549644, 3977.6817854571564, 3986.8803935881824, 3906.4726261954556, 3931.9017024574327, 3958.6635136013474, 3990.7206495545324, 4008.939865902014, 3400.880969166067, 3401.1837159081642, 3419.1623052352334, 3423.9315213695586, 3439.8476510369055, 4846.200376937801, 4948.38145231846, 5024.773885175176, 5046.167382381903, 5053.166227572447, 4390.473143222802, 4393.736375817429, 4401.339799030139, 4406.493253275882, 4407.140607581523, 5363.141897296414, 5366.946330536723, 5394.973025134849, 5409.6213265071465, 5416.404195538487, 3544.1848374873925, 3575.2670702506184, 3591.6408359163875, 3602.35157671619, 3708.684761795251, 5582.7766889324375, 5588.077967135418, 5592.105263157916, 5592.944070559283, 5631.80288689902, 3735.0, 3763.7553559018575, 3769.962300376961, 3793.18446533991, 3808.809559522013, 3811.5235595550557, 3815.065308999313, 3833.0, 3836.865709700147, 3868.458415821731, 4232.343986682069, 4450.198964186413, 4469.217886869785, 4482.0, 4509.774511274423, 5430.049741295336, 5432.429594892558, 5442.482964118402, 5467.617266791286, 5550.084236100998, 1334.2728213123871, 1382.322661895684, 1394.7350003499303, 1399.2164387942785, 1410.1961881727316, 871.1114663043786, 886.1050339157497, 902.5712786426395, 914.3279689428265, 924.713338864954, 5107.0, 5157.252198431206, 5169.68981861082, 5174.249733788655, 5203.19350500673, 5499.450054994549, 5581.469760372758, 5589.692566908859, 5608.158776183605, 5654.85862853432, 5070.518300761421, 5100.69395836251, 5127.154019586801, 5151.4333423323405, 5198.584113270929, 3038.741706954889, 3050.8932187373334, 3101.147184524274, 3102.0, 3113.392888386788, 5603.495685388335, 5787.88424231513, 5798.6810725410505, 5827.679477628772, 5888.234529511136, 5787.305523337142, 5790.334111577138, 5812.186293918855, 5817.272840894888, 5817.7091145442555, 5796.594238403271, 5832.650040997553, 5853.209816674779, 5869.647821130746, 5931.58478906481, 5443.863903402446, 5554.0, 5594.916076258778, 5595.5803314752375, 5684.488396044376, 5161.587073034073, 5437.429069947757, 5453.918191227214, 5477.67133971963, 5496.395396506461, 5598.048331783525, 5628.296462942132, 5706.0, 5764.020116580107, 5798.623089499169, 3559.5906470756195, 3609.9639003610678, 3660.597334293279, 3694.002619292722, 3714.814259286971, 5518.558515318685, 5521.337439507285, 5541.501264886179, 5598.992181407386, 5613.438656134354, 5240.449752776056, 5364.30264065669, 5393.784248630011, 5450.5367043801725, 5510.118381059172, 5466.699331536804, 5483.0, 5514.420985796433, 5544.69504177258, 5621.156826476062, 5370.087085195448, 5371.973140134274, 5385.784568617368, 5441.891162176655, 5466.617336786387, 5344.25180474726, 5486.396496385474, 5520.171974203901, 5557.416471270459, 5568.248286481273, 5403.621746477709, 5427.158790387496, 5441.156620723794, 5447.509724124848, 5475.863103422287], "yui.html": [611.162707091285, 625.8748250349928, 629.7795771479981, 643.1703102997134, 645.7384759172535, 11361.772764544705, 13413.32933353332, 13747.725045499084, 13792.655183620414, 13960.511382101617, 11275.267107638017, 11886.286822790638, 12093.516259349637, 12173.45219465124, 12194.024478041758, 562.9268195134626, 566.6175331651119, 571.4770984549133, 710.1903829634208, 734.4931996922106, 689.5793565924782, 700.7302188657353, 711.235421921434, 717.4726575966661, 721.1418412089597, 743.405275779377, 751.6617522115042, 753.6420200404818, 754.7471597015007, 757.7613051888637, 587.33337661754, 597.4801922327559, 606.2755007765721, 736.576468530597, 742.4617152564401, 552.0118987013242, 553.1343447504643, 555.9936514907989, 558.7792821835393, 559.6725915339531, 11156.442177891155, 11460.71348216293, 11545.942270288679, 11553.017993470565, 11598.0, 8186.0, 8198.918010819874, 8200.343972482187, 8269.21442462965, 8651.96678780486, 7290.81772955675, 7446.553206807609, 7491.925080749232, 7760.068791745027, 7797.805054873616, 2477.442575420534, 2536.9238922832346, 2553.565893798059, 2564.2820010397118, 2564.7050589182295, 39892.0, 40461.0, 40543.0, 40570.39144412836, 40672.0, 5852.326982397079, 5952.345242023374, 6118.510519158456, 6180.6291622502795, 6298.1812364392335, 10110.8483372748, 10188.796224075477, 10252.333598316085, 10406.063454289151, 10486.0, 5126.256692779526, 5250.159974404077, 5289.68261904287, 5309.867253318698, 5370.301860758076, 3163.8892638757993, 3193.3932552815354, 3221.7583681224, 3245.432049391347, 3337.549430826807, 2238.641817309223, 2241.9215327463785, 2242.8430009899153, 2265.139247086097, 2267.183813827021, 333.7146739537709, 340.94203985322554, 344.14651663873235, 345.9619441861393, 346.7815276375867, 380.4591404810506, 410.2103450857088, 485.8493866901272, 491.3538696613941, 529.8834256463572, 5997.880042399128, 6514.348565143542, 6529.869402611921, 6647.0, 6764.154480689914, 402.43658877571636, 476.64966249806366, 486.139533026541, 499.21623051809036, 519.3767479025184, 3053.8916187419713, 3082.7533797296164, 3147.921301967469, 3184.9203769905475, 3204.8557814897918, 49904.50095499071, 50102.248466273035, 51034.489655103716, 51039.489605104216, 51046.234306485436, 42890.57109428866, 43713.56286437095, 43773.78113109478, 43774.78112609417, 43781.12437751291, 39710.80144599258, 39721.40417893792, 39964.80017599952, 40244.195116097515, 40569.797151014645, 6362.650054247061, 6462.0, 6463.612183269019, 6487.416132548094, 6663.333666633298, 30854.0, 31215.375692486476, 31398.215044624067, 31558.0, 31982.840085799424, 43173.0, 43541.0, 44656.33015504705, 44691.10617787561, 45081.774591126836, 8802.33982451306, 8889.911100888909, 8917.42036767608, 9256.166944974984, 9316.114969077928, 9339.85990210161, 9365.812683746422, 9371.484568348806, 9477.431354118775, 9686.418814871131, 8939.910600893907, 8947.463152210888, 8951.239144672516, 8994.505302208441, 9092.181703646704, 8898.110188981309, 8917.063708310534, 8963.775905602412, 8988.505632190292, 9032.45805251687, 8779.648814047367, 8819.559022049, 8866.955665221632, 8882.37823352385, 9023.864642030243, 7503.399728021855, 7783.494072885244, 7878.4091193161885, 8158.184181581794, 8167.224113709426, 7593.848123037619, 7705.30652241301, 7898.949300115129, 7930.603469826601, 8013.759587212393]}, "summary": {"lowerIsBetter": false, "suite": 5563.543286426566, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5732.395569390557, "unit": "ms", "value": 5732.395569390557}, "dojo.html": {"lowerIsBetter": false, "filtered": 4522.641530267033, "unit": "ms", "value": 4522.641530267033}, "mootools.html": {"lowerIsBetter": false, "filtered": 3691.567499502163, "unit": "ms", "value": 3691.567499502163}, "ext.html": {"lowerIsBetter": false, "filtered": 15363.654813470654, "unit": "ms", "value": 15363.654813470654}, "prototype.html": {"lowerIsBetter": false, "filtered": 4075.6719308026068, "unit": "ms", "value": 4075.6719308026068}, "yui.html": {"lowerIsBetter": false, "filtered": 4948.029562171214, "unit": "ms", "value": 4948.029562171214}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0102"}, "testrun": {"date": 1447298123, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111170847", "branch": "Firefox", "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a"}}, {"talos_counters": {}, "results": {"audio-dft": [189.0, 197.0, 197.0, 197.0, 198.0, 198.0, 196.0, 188.0, 189.0, 199.0], "ai-astar": [122.0, 131.0, 125.0, 132.0, 131.0, 132.0, 121.0, 132.0, 131.0, 120.0], "imaging-gaussian-blur": [138.0, 149.0, 149.0, 142.0, 141.0, 142.0, 141.0, 139.0, 135.0, 148.0], "audio-beat-detection": [185.0, 168.0, 198.0, 205.0, 171.0, 183.0, 181.0, 156.0, 204.0, 164.0], "json-stringify-tinderbox": [72.0, 77.0, 79.0, 82.0, 83.0, 83.0, 83.0, 83.0, 83.0, 79.0], "stanford-crypto-pbkdf2": [167.0, 174.0, 194.0, 189.0, 192.0, 188.0, 187.0, 190.0, 180.0, 169.0], "json-parse-financial": [65.0, 67.0, 71.0, 71.0, 74.0, 74.0, 72.0, 83.0, 72.0, 72.0], "stanford-crypto-sha256-iterative": [80.0, 84.0, 85.0, 89.0, 88.0, 90.0, 88.0, 88.0, 88.0, 89.0], "audio-fft": [86.0, 95.0, 101.0, 145.0, 80.0, 84.0, 87.0, 86.0, 139.0, 83.0], "imaging-darkroom": [154.0, 154.0, 155.0, 153.0, 147.0, 154.0, 154.0, 154.0, 154.0, 154.0], "stanford-crypto-ccm": [150.0, 162.0, 158.0, 159.0, 162.0, 154.0, 153.0, 155.0, 153.0, 173.0], "audio-oscillator": [113.0, 117.0, 163.0, 107.0, 110.0, 111.0, 156.0, 107.0, 109.0, 158.0], "stanford-crypto-aes": [95.0, 101.0, 105.0, 106.0, 106.0, 106.0, 107.0, 106.0, 109.0, 107.0], "imaging-desaturate": [124.0, 124.0, 124.0, 125.0, 130.0, 128.0, 124.0, 124.0, 125.0, 123.0]}, "summary": {"lowerIsBetter": true, "suite": 1833.6000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 98.6, "unit": "ms", "value": 98.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 183.0, "unit": "ms", "value": 183.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 181.5, "unit": "ms", "value": 181.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 157.9, "unit": "ms", "value": 157.9}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 153.3, "unit": "ms", "value": 153.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 72.1, "unit": "ms", "value": 72.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 125.1, "unit": "ms", "value": 125.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 127.7, "unit": "ms", "value": 127.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 194.8, "unit": "ms", "value": 194.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 86.9, "unit": "ms", "value": 86.9}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 80.4, "unit": "ms", "value": 80.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 142.4, "unit": "ms", "value": 142.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 104.8, "unit": "ms", "value": 104.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 125.1, "unit": "ms", "value": 125.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0102"}, "testrun": {"date": 1447298123, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111170847", "branch": "Firefox", "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a"}}, {"talos_counters": {}, "results": {"DeltaBlue": [230.73373327180434], "Encrypt": [378.7878787878788], "NavierStokes": [6856.164383561644], "Decrypt": [7049.295774647887], "Splay": [824.4023083264633], "Richards": [199.16351324437363], "RegExp": [35224.137931034486], "Earley": [956.9789674952199], "Boyer": [15492.307692307691], "RayTrace": [2280.1822323462416]}, "summary": {"lowerIsBetter": false, "suite": 15427.830121278046, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 286.55541200000005, "unit": "score", "value": 286.55541200000005}, "Encrypt": {"lowerIsBetter": false, "filtered": 702.71784, "unit": "score", "value": 702.71784}, "NavierStokes": {"lowerIsBetter": false, "filtered": 216.44755244755225, "unit": "score", "value": 216.44755244755225}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.75994205794205, "unit": "score", "value": 37.75994205794205}, "Splay": {"lowerIsBetter": false, "filtered": 98.84858300000003, "unit": "score", "value": 98.84858300000003}, "RegExp": {"lowerIsBetter": false, "filtered": 25.86252080274106, "unit": "score", "value": 25.86252080274106}, "Richards": {"lowerIsBetter": false, "filtered": 177.25134200000002, "unit": "score", "value": 177.25134200000002}, "Earley": {"lowerIsBetter": false, "filtered": 696.4238741258741, "unit": "score", "value": 696.4238741258741}, "Boyer": {"lowerIsBetter": false, "filtered": 43.01896226415098, "unit": "score", "value": 43.01896226415098}, "RayTrace": {"lowerIsBetter": false, "filtered": 324.53064035964036, "unit": "score", "value": 324.53064035964036}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0102"}, "testrun": {"date": 1447298123, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111170847", "branch": "Firefox", "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a"}}] 19:35:45 INFO - RETURN: dromaeo_css: 5563.54 19:35:45 INFO - RETURN: kraken: 1833.60 19:35:45 INFO - RETURN: v8_7: 15427.83 19:35:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "15427.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1833.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "5563.54"}}} 19:35:45 INFO - Return code: 0 19:35:45 INFO - # TBPL SUCCESS # 19:35:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:35:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:35:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:35:45 INFO - 2015-11-11 19:35:45.479 screenresolution[1660:9803] starting screenresolution argv=screenresolution get 19:35:45 INFO - 2015-11-11 19:35:45.482 screenresolution[1660:9803] Display 0: 1600x1200x32@60 19:35:45 INFO - 2015-11-11 19:35:45.489 screenresolution[1661:9806] starting screenresolution argv=screenresolution list 19:35:45 INFO - Available Modes on Display 0 19:35:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:35:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:35:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:35:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:35:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:35:45 INFO - Intel HD Graphics 3000: 19:35:45 INFO - Chipset Model: Intel HD Graphics 3000 19:35:45 INFO - Type: GPU 19:35:45 INFO - Bus: Built-In 19:35:45 INFO - VRAM (Total): 512 MB 19:35:45 INFO - VRAM (Dynamic, Max): 10 19:35:45 INFO - Vendor: Intel (0x8086) 19:35:45 INFO - Device ID: 0x0116 19:35:45 INFO - Revision ID: 0x0009 19:35:45 INFO - Displays: 19:35:45 INFO - Display: 19:35:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:35:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:35:45 INFO - Display Serial Number: 1600x1200 60 19:35:45 INFO - Main Display: Yes 19:35:45 INFO - Mirror: Off 19:35:45 INFO - Online: Yes 19:35:45 INFO - Rotation: Supported 19:35:45 INFO - Return code: 0 19:35:45 INFO - Running post-action listener: _resource_record_post_action 19:35:45 INFO - Running post-run listener: _resource_record_post_run 19:35:46 INFO - Total resource usage - Wall time: 1266s; CPU: 30.0%; Read bytes: 39212032; Write bytes: 686832640; Read time: 4847; Write time: 50359 19:35:46 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 342626816; Write bytes: 346857472; Read time: 38452; Write time: 7855 19:35:46 INFO - run-tests - Wall time: 1223s; CPU: 30.0%; Read bytes: 37159936; Write bytes: 338459648; Read time: 4283; Write time: 42473 19:35:46 INFO - Running post-run listener: _upload_blobber_files 19:35:46 INFO - Blob upload gear active. 19:35:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:35:46 INFO - Copying logs to upload dir... 19:35:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1325.895585 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2015-11-11 19:35:46.927336) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 19:35:46.931053) ========= 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.YkY973DMNI/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.ZnU5XZrF0R/Listeners TMPDIR=/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010337 build_url: 'https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/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-11 19:35:46.957891) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:35:46.958247) ========= 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.YkY973DMNI/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.ZnU5XZrF0R/Listeners TMPDIR=/var/folders/q7/4psc8gk94sj4zwxqpjmgv89h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005540 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:35:47.007758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 19:35:47.008069) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 19:35:47.008478) ========= ========= Total master_lag: 0.21 =========