builder: mozilla-central_yosemite_test-dromaeojs slave: t-yosemite-r5-0059 starttime: 1447506752.58 results: success (0) buildid: 20151114030404 builduid: 568447c2ffd94f3882ec6291393c705d revision: 202b199b9fcf37a687bef882f2513e191f079622 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.583269) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.583812) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.584273) ========= 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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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.007249 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.615913) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.616291) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.635687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.636357) ========= 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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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.006503 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.690135) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.690971) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.691887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:32.692273) ========= 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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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-14 05:12:32-- 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% 1.26G=0s 2015-11-14 05:12:33 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.418220 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:33.133556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:33.134457) ========= 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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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.021903 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:33.189815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:33.190672) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 202b199b9fcf37a687bef882f2513e191f079622 --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 202b199b9fcf37a687bef882f2513e191f079622 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KCbK0K4zyt/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.rTTVJxLTRY/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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-14 05:12:33,274 truncating revision to first 12 chars 2015-11-14 05:12:33,274 Setting DEBUG logging. 2015-11-14 05:12:33,274 attempt 1/10 2015-11-14 05:12:33,274 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/202b199b9fcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 05:12:33,629 unpacking tar archive at: mozilla-central-202b199b9fcf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:33.855460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:33.855889) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:33.872048) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:33.872801) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 05:12:33.873857) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2015-11-14 05:12:33.874655) ========= /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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 05:12:34 INFO - MultiFileLogger online at 20151114 05:12:34 in /builds/slave/test 05:12:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:12:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:12:34 INFO - {'append_to_log': False, 05:12:34 INFO - 'base_work_dir': '/builds/slave/test', 05:12:34 INFO - 'blob_upload_branch': 'Firefox', 05:12:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:12:34 INFO - 'branch': 'Firefox', 05:12:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:12:34 INFO - 'config_files': ('talos/mac_config.py',), 05:12:34 INFO - 'default_actions': ('clobber', 05:12:34 INFO - 'read-buildbot-config', 05:12:34 INFO - 'download-and-extract', 05:12:34 INFO - 'populate-webroot', 05:12:34 INFO - 'create-virtualenv', 05:12:34 INFO - 'install', 05:12:34 INFO - 'run-tests'), 05:12:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:12:34 INFO - 'download_minidump_stackwalk': True, 05:12:34 INFO - 'download_symbols': 'ondemand', 05:12:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:12:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:12:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:12:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:12:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:12:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:12:34 INFO - 'installer_path': 'installer.exe', 05:12:34 INFO - 'log_level': 'info', 05:12:34 INFO - 'log_name': 'talos', 05:12:34 INFO - 'log_to_console': True, 05:12:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:12:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:12:34 INFO - 'opt_config_files': (), 05:12:34 INFO - 'pip_index': False, 05:12:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:12:34 INFO - 'cmd': ('bash', 05:12:34 INFO - '-c', 05:12:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:12:34 INFO - 'enabled': True, 05:12:34 INFO - 'halt_on_failure': False, 05:12:34 INFO - 'name': 'check_screen_resolution'},), 05:12:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:12:34 INFO - 'cmd': ('bash', 05:12:34 INFO - '-c', 05:12:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:12:34 INFO - 'enabled': True, 05:12:34 INFO - 'halt_on_failure': False, 05:12:34 INFO - 'name': 'check_screen_resolution'},), 05:12:34 INFO - 'run_cmd_checks_enabled': True, 05:12:34 INFO - 'sps_profile': False, 05:12:34 INFO - 'sps_profile_interval': 0, 05:12:34 INFO - 'suite': 'dromaeojs', 05:12:34 INFO - 'system_bits': '64', 05:12:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:12:34 INFO - 'title': 't-yosemite-r5-0059', 05:12:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:12:34 INFO - 'use_talos_json': True, 05:12:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:12:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:12:34 INFO - 'work_dir': 'build'} 05:12:34 INFO - ##### 05:12:34 INFO - ##### Running clobber step. 05:12:34 INFO - ##### 05:12:34 INFO - Running pre-action listener: _resource_record_pre_action 05:12:34 INFO - Running main action method: clobber 05:12:34 INFO - rmtree: /builds/slave/test/build 05:12:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:12:34 INFO - Running post-action listener: _resource_record_post_action 05:12:34 INFO - ##### 05:12:34 INFO - ##### Running read-buildbot-config step. 05:12:34 INFO - ##### 05:12:34 INFO - Running pre-action listener: _resource_record_pre_action 05:12:34 INFO - Running main action method: read_buildbot_config 05:12:34 INFO - Using buildbot properties: 05:12:34 INFO - { 05:12:34 INFO - "properties": { 05:12:34 INFO - "buildnumber": 481, 05:12:34 INFO - "product": "firefox", 05:12:34 INFO - "script_repo_revision": "production", 05:12:34 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs", 05:12:34 INFO - "repository": "", 05:12:34 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs", 05:12:34 INFO - "buildid": "20151114030404", 05:12:34 INFO - "slavename": "t-yosemite-r5-0059", 05:12:34 INFO - "stage_platform": "macosx64", 05:12:34 INFO - "basedir": "/builds/slave/test", 05:12:34 INFO - "nightly_build": "True", 05:12:34 INFO - "project": "", 05:12:34 INFO - "platform": "yosemite", 05:12:34 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:12:34 INFO - "slavebuilddir": "test", 05:12:34 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:12:34 INFO - "branch": "mozilla-central", 05:12:34 INFO - "repo_path": "mozilla-central", 05:12:34 INFO - "pgo_build": "False", 05:12:34 INFO - "builduid": "568447c2ffd94f3882ec6291393c705d", 05:12:34 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 05:12:34 INFO - }, 05:12:34 INFO - "sourcestamp": { 05:12:34 INFO - "repository": "", 05:12:34 INFO - "hasPatch": false, 05:12:34 INFO - "project": "", 05:12:34 INFO - "branch": "mozilla-central-macosx64-talos", 05:12:34 INFO - "changes": [ 05:12:34 INFO - { 05:12:34 INFO - "category": null, 05:12:34 INFO - "files": [ 05:12:34 INFO - { 05:12:34 INFO - "url": null, 05:12:34 INFO - "name": "https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:12:34 INFO - } 05:12:34 INFO - ], 05:12:34 INFO - "repository": "", 05:12:34 INFO - "rev": "202b199b9fcf37a687bef882f2513e191f079622", 05:12:34 INFO - "who": "sendchange", 05:12:34 INFO - "when": 1447506467, 05:12:34 INFO - "number": 6662077, 05:12:34 INFO - "comments": "", 05:12:34 INFO - "project": "", 05:12:34 INFO - "at": "Sat 14 Nov 2015 05:07:47", 05:12:34 INFO - "branch": "mozilla-central-macosx64-talos", 05:12:34 INFO - "revlink": "", 05:12:34 INFO - "properties": [ 05:12:34 INFO - [ 05:12:34 INFO - "buildid", 05:12:34 INFO - "20151114030404", 05:12:34 INFO - "Change" 05:12:34 INFO - ], 05:12:34 INFO - [ 05:12:34 INFO - "builduid", 05:12:34 INFO - "568447c2ffd94f3882ec6291393c705d", 05:12:34 INFO - "Change" 05:12:34 INFO - ], 05:12:34 INFO - [ 05:12:34 INFO - "nightly_build", 05:12:34 INFO - "True", 05:12:34 INFO - "Change" 05:12:34 INFO - ], 05:12:34 INFO - [ 05:12:34 INFO - "pgo_build", 05:12:34 INFO - "False", 05:12:34 INFO - "Change" 05:12:34 INFO - ] 05:12:34 INFO - ], 05:12:34 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 05:12:34 INFO - } 05:12:34 INFO - ], 05:12:34 INFO - "revision": "202b199b9fcf37a687bef882f2513e191f079622" 05:12:34 INFO - } 05:12:34 INFO - } 05:12:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:12:34 INFO - Running post-action listener: _resource_record_post_action 05:12:34 INFO - ##### 05:12:34 INFO - ##### Running download-and-extract step. 05:12:34 INFO - ##### 05:12:34 INFO - Running pre-action listener: _resource_record_pre_action 05:12:34 INFO - Running main action method: download_and_extract 05:12:34 INFO - mkdir: /builds/slave/test/build/tests 05:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:34 INFO - https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:12:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/test_packages.json 05:12:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/test_packages.json 05:12:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:12:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:12:35 INFO - Downloaded 1149 bytes. 05:12:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:12:35 INFO - Using the following test package requirements: 05:12:35 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:12:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:35 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:12:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:35 INFO - u'jsshell-mac.zip'], 05:12:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:35 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:12:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:12:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:35 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:12:35 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:35 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:12:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:35 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:12:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:12:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:12:35 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:12:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:35 INFO - https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:12:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:12:36 INFO - Downloaded 17460030 bytes. 05:12:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:12:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:12:42 INFO - Return code: 0 05:12:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:42 INFO - https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:12:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:12:43 INFO - Downloaded 17460030 bytes. 05:12:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:12:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:12:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:12:50 INFO - Return code: 0 05:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:50 INFO - https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:12:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:12:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:12:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:12:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:12:51 INFO - Downloaded 11131693 bytes. 05:12:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:12:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:12:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:12:51 INFO - Return code: 0 05:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:51 INFO - https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:12:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:12:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:12:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:12:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:12:55 INFO - Downloaded 108813146 bytes. 05:12:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:12:55 INFO - mkdir: /builds/slave/test/properties 05:12:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:12:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:12:55 INFO - Contents: 05:12:55 INFO - build_url:https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:12:55 INFO - Running post-action listener: _resource_record_post_action 05:12:55 INFO - Running post-action listener: set_extra_try_arguments 05:12:55 INFO - ##### 05:12:55 INFO - ##### Running populate-webroot step. 05:12:55 INFO - ##### 05:12:55 INFO - Running pre-action listener: _resource_record_pre_action 05:12:55 INFO - Running main action method: populate_webroot 05:12:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:12:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:12:55 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:12:55 INFO - '../fennec_ids.txt'], 05:12:55 INFO - 'tests': ['tcheck2']}, 05:12:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:12:55 INFO - '--tppagecycles', 05:12:55 INFO - '7'], 05:12:55 INFO - 'tests': ['tsvgm']}}, 05:12:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:12:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:12:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:12:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:12:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:12:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:12:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:55 INFO - 'talos_options': ['--e10s'], 05:12:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:12:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:55 INFO - 'tests': ['damp', 'tps']}, 05:12:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:55 INFO - 'talos_options': ['--e10s'], 05:12:55 INFO - 'tests': ['damp', 'tps']}, 05:12:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:12:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:12:55 INFO - 'other': {'tests': ['a11yr', 05:12:55 INFO - 'ts_paint', 05:12:55 INFO - 'tpaint', 05:12:55 INFO - 'sessionrestore', 05:12:55 INFO - 'sessionrestore_no_auto_restore']}, 05:12:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:12:55 INFO - 'tests': ['a11yr', 05:12:55 INFO - 'ts_paint', 05:12:55 INFO - 'tpaint', 05:12:55 INFO - 'sessionrestore', 05:12:55 INFO - 'sessionrestore_no_auto_restore']}, 05:12:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:12:55 INFO - 'tests': ['a11yr', 05:12:55 INFO - 'ts_paint', 05:12:55 INFO - 'tpaint', 05:12:55 INFO - 'sessionrestore', 05:12:55 INFO - 'sessionrestore_no_auto_restore']}, 05:12:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:12:55 INFO - 'tests': ['a11yr', 05:12:55 INFO - 'ts_paint', 05:12:55 INFO - 'tpaint', 05:12:55 INFO - 'sessionrestore', 05:12:55 INFO - 'sessionrestore_no_auto_restore']}, 05:12:55 INFO - 'other_l64': {'tests': ['a11yr', 05:12:55 INFO - 'ts_paint', 05:12:55 INFO - 'tpaint', 05:12:55 INFO - 'sessionrestore', 05:12:55 INFO - 'sessionrestore_no_auto_restore']}, 05:12:55 INFO - 'other_nol64': {'tests': ['a11yr', 05:12:55 INFO - 'ts_paint', 05:12:55 INFO - 'tpaint', 05:12:55 INFO - 'sessionrestore', 05:12:55 INFO - 'sessionrestore_no_auto_restore']}, 05:12:55 INFO - 'svgr': {'tests': ['tsvgx', 05:12:55 INFO - 'tsvgr_opacity', 05:12:55 INFO - 'tart', 05:12:55 INFO - 'tscrollx', 05:12:55 INFO - 'cart']}, 05:12:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:12:55 INFO - 'tests': ['tsvgx', 05:12:55 INFO - 'tsvgr_opacity', 05:12:55 INFO - 'tart', 05:12:55 INFO - 'tscrollx', 05:12:55 INFO - 'cart']}, 05:12:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:55 INFO - 'tests': ['tp5o']}, 05:12:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:55 INFO - 'talos_options': ['--e10s'], 05:12:55 INFO - 'tests': ['tp5o']}, 05:12:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:55 INFO - 'talos_options': ['--xperf_path', 05:12:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:55 INFO - 'tests': ['tp5n']}, 05:12:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:12:55 INFO - 'talos_options': ['--e10s', 05:12:55 INFO - '--xperf_path', 05:12:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:12:55 INFO - 'tests': ['tp5n']}}, 05:12:55 INFO - 'talos.zip': {'path': '', 05:12:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:12:55 INFO - Running post-action listener: _resource_record_post_action 05:12:55 INFO - ##### 05:12:55 INFO - ##### Running create-virtualenv step. 05:12:55 INFO - ##### 05:12:55 INFO - Running pre-action listener: _resource_record_pre_action 05:12:55 INFO - Running main action method: create_virtualenv 05:12:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:12:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:12:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:12:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:12:55 INFO - Using real prefix '/tools/python27' 05:12:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:12:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:13:00 INFO - Installing pip.................done. 05:13:00 INFO - Return code: 0 05:13:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1051e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9950e56890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051059f0>, '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 0x104e65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f98c8>, '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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:13:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCbK0K4zyt/Render', 05:13:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:00 INFO - 'HOME': '/Users/cltbld', 05:13:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:00 INFO - 'LOGNAME': 'cltbld', 05:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:00 INFO - 'MOZ_NO_REMOTE': '1', 05:13:00 INFO - 'NO_EM_RESTART': '1', 05:13:00 INFO - 'PAGER': '/bin/cat', 05:13:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:00 INFO - 'PWD': '/builds/slave/test', 05:13:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:00 INFO - 'SHELL': '/bin/bash', 05:13:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTTVJxLTRY/Listeners', 05:13:00 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 05:13:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:00 INFO - 'USER': 'cltbld', 05:13:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:00 INFO - 'XPC_FLAGS': '0x0', 05:13:00 INFO - 'XPC_SERVICE_NAME': '0', 05:13:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:13:01 INFO - Cleaning up... 05:13:01 INFO - Return code: 0 05:13:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:01 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 0x1051e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9950e56890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051059f0>, '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 0x104e65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f98c8>, '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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:13:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCbK0K4zyt/Render', 05:13:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:01 INFO - 'HOME': '/Users/cltbld', 05:13:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:01 INFO - 'LOGNAME': 'cltbld', 05:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:01 INFO - 'MOZ_NO_REMOTE': '1', 05:13:01 INFO - 'NO_EM_RESTART': '1', 05:13:01 INFO - 'PAGER': '/bin/cat', 05:13:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:01 INFO - 'PWD': '/builds/slave/test', 05:13:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:01 INFO - 'SHELL': '/bin/bash', 05:13:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTTVJxLTRY/Listeners', 05:13:01 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 05:13:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:01 INFO - 'USER': 'cltbld', 05:13:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:01 INFO - 'XPC_FLAGS': '0x0', 05:13:01 INFO - 'XPC_SERVICE_NAME': '0', 05:13:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:01 INFO - Downloading/unpacking psutil>=0.7.1 05:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:13:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:13:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:04 INFO - Installing collected packages: psutil 05:13:04 INFO - Running setup.py install for psutil 05:13:04 INFO - building 'psutil._psutil_osx' extension 05:13:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:13:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:13:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:13:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:13:05 INFO - building 'psutil._psutil_posix' extension 05:13:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:13:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:13:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:13:05 INFO - ^ 05:13:05 INFO - 1 warning generated. 05:13:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:13:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:13:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:13:05 INFO - Successfully installed psutil 05:13:05 INFO - Cleaning up... 05:13:05 INFO - Return code: 0 05:13:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:05 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 0x1051e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9950e56890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051059f0>, '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 0x104e65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f98c8>, '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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:13:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:13:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCbK0K4zyt/Render', 05:13:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:05 INFO - 'HOME': '/Users/cltbld', 05:13:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:05 INFO - 'LOGNAME': 'cltbld', 05:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:05 INFO - 'MOZ_NO_REMOTE': '1', 05:13:05 INFO - 'NO_EM_RESTART': '1', 05:13:05 INFO - 'PAGER': '/bin/cat', 05:13:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:05 INFO - 'PWD': '/builds/slave/test', 05:13:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:05 INFO - 'SHELL': '/bin/bash', 05:13:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTTVJxLTRY/Listeners', 05:13:05 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 05:13:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:05 INFO - 'USER': 'cltbld', 05:13:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:05 INFO - 'XPC_FLAGS': '0x0', 05:13:05 INFO - 'XPC_SERVICE_NAME': '0', 05:13:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:13:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:13:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:13:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:13:09 INFO - Installing collected packages: mozsystemmonitor 05:13:09 INFO - Running setup.py install for mozsystemmonitor 05:13:09 INFO - Successfully installed mozsystemmonitor 05:13:09 INFO - Cleaning up... 05:13:09 INFO - Return code: 0 05:13:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1051e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9950e56890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051059f0>, '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 0x104e65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f98c8>, '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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:13:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:13:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCbK0K4zyt/Render', 05:13:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:09 INFO - 'HOME': '/Users/cltbld', 05:13:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:09 INFO - 'LOGNAME': 'cltbld', 05:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:09 INFO - 'MOZ_NO_REMOTE': '1', 05:13:09 INFO - 'NO_EM_RESTART': '1', 05:13:09 INFO - 'PAGER': '/bin/cat', 05:13:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:09 INFO - 'PWD': '/builds/slave/test', 05:13:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:09 INFO - 'SHELL': '/bin/bash', 05:13:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTTVJxLTRY/Listeners', 05:13:09 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 05:13:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:09 INFO - 'USER': 'cltbld', 05:13:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:09 INFO - 'XPC_FLAGS': '0x0', 05:13:09 INFO - 'XPC_SERVICE_NAME': '0', 05:13:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:12 INFO - Downloading blobuploader-1.2.4.tar.gz 05:13:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:13:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:13:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:13:13 INFO - Downloading docopt-0.6.1.tar.gz 05:13:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:13:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:13:14 INFO - Running setup.py install for blobuploader 05:13:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:13:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:13:14 INFO - Running setup.py install for requests 05:13:14 INFO - Running setup.py install for docopt 05:13:15 INFO - Successfully installed blobuploader requests docopt 05:13:15 INFO - Cleaning up... 05:13:15 INFO - Return code: 0 05:13:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:15 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 0x1051e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9950e56890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051059f0>, '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 0x104e65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f98c8>, '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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:13:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCbK0K4zyt/Render', 05:13:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:15 INFO - 'HOME': '/Users/cltbld', 05:13:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:15 INFO - 'LOGNAME': 'cltbld', 05:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:15 INFO - 'MOZ_NO_REMOTE': '1', 05:13:15 INFO - 'NO_EM_RESTART': '1', 05:13:15 INFO - 'PAGER': '/bin/cat', 05:13:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:15 INFO - 'PWD': '/builds/slave/test', 05:13:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:15 INFO - 'SHELL': '/bin/bash', 05:13:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTTVJxLTRY/Listeners', 05:13:15 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 05:13:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:15 INFO - 'USER': 'cltbld', 05:13:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:15 INFO - 'XPC_FLAGS': '0x0', 05:13:15 INFO - 'XPC_SERVICE_NAME': '0', 05:13:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:15 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-AvPXrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:15 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-XrEUF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:15 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-As4fXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:16 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Bq_vhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:16 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Ubuvcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:16 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-RlkKJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:16 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-UdUJwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:16 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-DbzySE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:16 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-_Qxn1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:16 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-7HsIOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:17 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-GzJHPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:17 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-eIsVpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:17 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-FTpQK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:17 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-MZohqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:17 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-rMS47q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:17 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-UElsrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:17 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-uJpFOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:13:17 INFO - Running setup.py install for manifestparser 05:13:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:13:18 INFO - Running setup.py install for mozcrash 05:13:18 INFO - Running setup.py install for mozdebug 05:13:18 INFO - Running setup.py install for mozdevice 05:13:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:13:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:13:18 INFO - Running setup.py install for mozfile 05:13:19 INFO - Running setup.py install for mozhttpd 05:13:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:13:19 INFO - Running setup.py install for mozinfo 05:13:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:13:19 INFO - Running setup.py install for mozInstall 05:13:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:13:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:13:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:13:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:13:19 INFO - Running setup.py install for mozleak 05:13:19 INFO - Running setup.py install for mozlog 05:13:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:13:20 INFO - Running setup.py install for moznetwork 05:13:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:13:20 INFO - Running setup.py install for mozprocess 05:13:20 INFO - Running setup.py install for mozprofile 05:13:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:13:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:13:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:13:20 INFO - Running setup.py install for mozrunner 05:13:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:13:20 INFO - Running setup.py install for mozscreenshot 05:13:21 INFO - Running setup.py install for moztest 05:13:21 INFO - Running setup.py install for mozversion 05:13:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:13:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:13:21 INFO - Cleaning up... 05:13:21 INFO - Return code: 0 05:13:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13: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')]} 05:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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')]} 05:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13: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', '-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 0x1051e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9950e56890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051059f0>, '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 0x104e65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f98c8>, '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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:13:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCbK0K4zyt/Render', 05:13:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:21 INFO - 'HOME': '/Users/cltbld', 05:13:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:21 INFO - 'LOGNAME': 'cltbld', 05:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:21 INFO - 'MOZ_NO_REMOTE': '1', 05:13:21 INFO - 'NO_EM_RESTART': '1', 05:13:21 INFO - 'PAGER': '/bin/cat', 05:13:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:21 INFO - 'PWD': '/builds/slave/test', 05:13:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:21 INFO - 'SHELL': '/bin/bash', 05:13:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTTVJxLTRY/Listeners', 05:13:21 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 05:13:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:21 INFO - 'USER': 'cltbld', 05:13:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:21 INFO - 'XPC_FLAGS': '0x0', 05:13:21 INFO - 'XPC_SERVICE_NAME': '0', 05:13:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:13:21 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-UazXB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:13:22 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-LSRUnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:13:22 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-_L0Qlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:13:22 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Hh4tk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:13:22 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-j4biUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:13:22 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-gIutl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:13:22 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-77V5RC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:13:22 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Y0w275-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:13:23 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-kejFLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:13:23 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-VTKnJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:13:23 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-0ccyiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:13:23 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-47ou0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:13:23 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-nR3wsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:13:23 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-o4irQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:23 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-YZGyk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:13:24 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-Hvp2Ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:13:24 INFO - Running setup.py (path:/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/pip-JD53EH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:13:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13: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 05:13:27 INFO - Downloading blessings-1.5.1.tar.gz 05:13:27 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:13:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:13:27 INFO - Installing collected packages: blessings 05:13:27 INFO - Running setup.py install for blessings 05:13:27 INFO - Successfully installed blessings 05:13:27 INFO - Cleaning up... 05:13:27 INFO - Return code: 0 05:13:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:27 INFO - Reading from file tmpfile_stdout 05:13:27 INFO - Current package versions: 05:13:27 INFO - blessings == 1.5.1 05:13:27 INFO - blobuploader == 1.2.4 05:13:27 INFO - docopt == 0.6.1 05:13:27 INFO - manifestparser == 1.1 05:13:27 INFO - mozInstall == 1.12 05:13:27 INFO - mozcrash == 0.16 05:13:27 INFO - mozdebug == 0.1 05:13:27 INFO - mozdevice == 0.47 05:13:27 INFO - mozfile == 1.2 05:13:27 INFO - mozhttpd == 0.7 05:13:27 INFO - mozinfo == 0.9 05:13:27 INFO - mozleak == 0.1 05:13:27 INFO - mozlog == 3.0 05:13:27 INFO - moznetwork == 0.27 05:13:27 INFO - mozprocess == 0.22 05:13:27 INFO - mozprofile == 0.27 05:13:27 INFO - mozrunner == 6.11 05:13:27 INFO - mozscreenshot == 0.1 05:13:27 INFO - mozsystemmonitor == 0.0 05:13:27 INFO - moztest == 0.7 05:13:27 INFO - mozversion == 1.4 05:13:27 INFO - psutil == 3.1.1 05:13:27 INFO - requests == 1.2.3 05:13:27 INFO - wsgiref == 0.1.2 05:13:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:13:27 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 0x1051e2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051bf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9950e56890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051059f0>, '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 0x104e65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f98c8>, '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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:13:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCbK0K4zyt/Render', 05:13:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:13:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:13:27 INFO - 'HOME': '/Users/cltbld', 05:13:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:13:27 INFO - 'LOGNAME': 'cltbld', 05:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:13:27 INFO - 'MOZ_NO_REMOTE': '1', 05:13:27 INFO - 'NO_EM_RESTART': '1', 05:13:27 INFO - 'PAGER': '/bin/cat', 05:13:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:13:27 INFO - 'PWD': '/builds/slave/test', 05:13:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:13:27 INFO - 'SHELL': '/bin/bash', 05:13:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTTVJxLTRY/Listeners', 05:13:27 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 05:13:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:13:27 INFO - 'USER': 'cltbld', 05:13:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:13:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:13:27 INFO - 'XPC_FLAGS': '0x0', 05:13:27 INFO - 'XPC_SERVICE_NAME': '0', 05:13:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:13:28 INFO - Cleaning up... 05:13:28 INFO - Return code: 0 05:13:28 INFO - Running post-action listener: _resource_record_post_action 05:13:28 INFO - Running post-action listener: _start_resource_monitoring 05:13:28 INFO - Starting resource monitoring. 05:13:28 INFO - ##### 05:13:28 INFO - ##### Running install step. 05:13:28 INFO - ##### 05:13:28 INFO - Running pre-action listener: _resource_record_pre_action 05:13:28 INFO - Running main action method: install 05:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:13:28 INFO - Reading from file tmpfile_stdout 05:13:28 INFO - Detecting whether we're running mozinstall >=1.0... 05:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:13:28 INFO - Reading from file tmpfile_stdout 05:13:28 INFO - Output received: 05:13:28 INFO - Usage: mozinstall [options] installer 05:13:28 INFO - Options: 05:13:28 INFO - -h, --help show this help message and exit 05:13:28 INFO - -d DEST, --destination=DEST 05:13:28 INFO - Directory to install application into. [default: 05:13:28 INFO - "/builds/slave/test"] 05:13:28 INFO - --app=APP Application being installed. [default: firefox] 05:13:28 INFO - mkdir: /builds/slave/test/build/application 05:13:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:14:12 INFO - Reading from file tmpfile_stdout 05:14:12 INFO - Output received: 05:14:12 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:14:12 INFO - Running post-action listener: _resource_record_post_action 05:14:12 INFO - ##### 05:14:12 INFO - ##### Running run-tests step. 05:14:12 INFO - ##### 05:14:12 INFO - Running pre-action listener: _resource_record_pre_action 05:14:12 INFO - Running main action method: run_tests 05:14:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:14:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:14:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:14:12 INFO - 2015-11-14 05:14:12.701 screenresolution[5901:104131] starting screenresolution argv=screenresolution get 05:14:12 INFO - 2015-11-14 05:14:12.705 screenresolution[5901:104131] Display 0: 1600x1200x32@60 05:14:12 INFO - 2015-11-14 05:14:12.712 screenresolution[5902:104133] starting screenresolution argv=screenresolution list 05:14:12 INFO - Available Modes on Display 0 05:14:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:14:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:14:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:14:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:14:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:14:13 INFO - Intel HD Graphics 3000: 05:14:13 INFO - Chipset Model: Intel HD Graphics 3000 05:14:13 INFO - Type: GPU 05:14:13 INFO - Bus: Built-In 05:14:13 INFO - VRAM (Total): 512 MB 05:14:13 INFO - VRAM (Dynamic, Max): 10 05:14:13 INFO - Vendor: Intel (0x8086) 05:14:13 INFO - Device ID: 0x0116 05:14:13 INFO - Revision ID: 0x0009 05:14:13 INFO - Displays: 05:14:13 INFO - Display: 05:14:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:14:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:14:13 INFO - Display Serial Number: 1600x1200 60 05:14:13 INFO - Main Display: Yes 05:14:13 INFO - Mirror: Off 05:14:13 INFO - Online: Yes 05:14:13 INFO - Rotation: Supported 05:14:13 INFO - Return code: 0 05:14:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:14:13 INFO - Python 2.7.3 05:14:13 INFO - Return code: 0 05:14:13 INFO - grabbing minidump binary from tooltool 05:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:14:13 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 0x1051059f0>, '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 0x104e65db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f98c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:14:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:14:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:14:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:14:13 INFO - Return code: 0 05:14:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:14:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:14:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:14:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:14:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:14:13 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0059', '--webServer', 'localhost'] in /builds/slave/test/build 05:14:13 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0059 --webServer localhost 05:14:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KCbK0K4zyt/Render', 05:14:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:13 INFO - 'HOME': '/Users/cltbld', 05:14:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:13 INFO - 'LOGNAME': 'cltbld', 05:14:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:14:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:13 INFO - 'MOZ_NO_REMOTE': '1', 05:14:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:14:13 INFO - 'NO_EM_RESTART': '1', 05:14:13 INFO - 'PAGER': '/bin/cat', 05:14:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:13 INFO - 'PWD': '/builds/slave/test', 05:14:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:14:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:13 INFO - 'SHELL': '/bin/bash', 05:14:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rTTVJxLTRY/Listeners', 05:14:13 INFO - 'TMPDIR': '/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/', 05:14:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:13 INFO - 'USER': 'cltbld', 05:14:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:13 INFO - 'XPC_FLAGS': '0x0', 05:14:13 INFO - 'XPC_SERVICE_NAME': '0', 05:14:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:14:13 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0059', '--webServer', 'localhost'] with output_timeout 3600 05:14:13 INFO - mozversion INFO | application_buildid: 20151114030404 05:14:13 INFO - mozversion INFO | application_changeset: 202b199b9fcf37a687bef882f2513e191f079622 05:14:13 INFO - mozversion INFO | application_display_name: Nightly 05:14:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:14:13 INFO - mozversion INFO | application_name: Firefox 05:14:13 INFO - mozversion INFO | application_remotingname: firefox 05:14:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:14:13 INFO - mozversion INFO | application_vendor: Mozilla 05:14:13 INFO - mozversion INFO | application_version: 45.0a1 05:14:13 INFO - mozversion INFO | platform_buildid: 20151114030404 05:14:13 INFO - mozversion INFO | platform_changeset: 202b199b9fcf37a687bef882f2513e191f079622 05:14:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:14:13 INFO - mozversion INFO | platform_version: 45.0a1 05:14:13 INFO - 2015-11-14 05:14:13,454 DEBUG : using testdate: 1447506853 05:14:13 INFO - 2015-11-14 05:14:13,454 DEBUG : actual date: 1447506853 05:14:13 INFO - 2015-11-14 05:14:13,470 INFO : starting webserver on 'localhost:53253' 05:14:13 INFO - 2015-11-14 05:14:13,471 INFO : Starting test suite t-yosemite-r5-0059 05:14:13 INFO - 2015-11-14 05:14:13,471 INFO : Starting test dromaeo_css 05:14:13 INFO - 2015-11-14 05:14:13,471 DEBUG : operating with platform_type : mac_ 05:14:13 INFO - 2015-11-14 05:14:13,472 INFO : Initialising browser for dromaeo_css test... 05:14:13 INFO - 2015-11-14 05:14:13,531 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpya2Uiz/profile http://localhost:53253/getInfo.html 05:14:18 INFO - 2015-11-14 05:14:18,489 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:14:18 INFO - 2015-11-14 05:14:18,490 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:14:18 INFO - 2015-11-14 05:14:18,490 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:14:18 INFO - 2015-11-14 05:14:18,490 DEBUG : BROWSER_OUTPUT: __metrics 05:14:18 INFO - 2015-11-14 05:14:18,507 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:19 INFO - 2015-11-14 05:14:19,373 INFO : Browser initialized. 05:14:19 INFO - 2015-11-14 05:14:19,374 INFO : Running cycle 1/1 for dromaeo_css test... 05:14:19 INFO - 2015-11-14 05:14:19,374 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpya2Uiz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:14:31 INFO - 2015-11-14 05:14:31,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 230981632 05:14:31 INFO - 2015-11-14 05:14:31,756 DEBUG : BROWSER_OUTPUT: 05:15:22 INFO - 2015-11-14 05:15:22,713 DEBUG : BROWSER_OUTPUT: 1447506922710 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:17:33 INFO - 2015-11-14 05:17:33,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53253/tests/dromaeo/cssquery-ext.html) 05:17:34 INFO - 2015-11-14 05:17:34,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 315641856 05:17:34 INFO - 2015-11-14 05:17:34,897 DEBUG : BROWSER_OUTPUT: 05:20:37 INFO - 2015-11-14 05:20:37,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-ext.html (next: http://localhost:53253/tests/dromaeo/cssquery-jquery.html) 05:20:38 INFO - 2015-11-14 05:20:38,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 361381888 05:20:38 INFO - 2015-11-14 05:20:38,431 DEBUG : BROWSER_OUTPUT: 05:23:40 INFO - 2015-11-14 05:23:40,819 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53253/tests/dromaeo/cssquery-mootools.html) 05:23:41 INFO - 2015-11-14 05:23:41,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 320020480 05:23:41 INFO - 2015-11-14 05:23:41,408 DEBUG : BROWSER_OUTPUT: 05:26:43 INFO - 2015-11-14 05:26:43,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53253/tests/dromaeo/cssquery-prototype.html) 05:26:44 INFO - 2015-11-14 05:26:44,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 317403136 05:26:44 INFO - 2015-11-14 05:26:44,302 DEBUG : BROWSER_OUTPUT: 05:29:47 INFO - 2015-11-14 05:29:47,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53253/tests/dromaeo/cssquery-yui.html) 05:29:48 INFO - 2015-11-14 05:29:48,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 321466368 05:29:48 INFO - 2015-11-14 05:29:48,278 DEBUG : BROWSER_OUTPUT: 05:32:51 INFO - 2015-11-14 05:32:51,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-yui.html (next: http://localhost:53253/tests/dromaeo/cssquery-dojo.html) 05:32:51 INFO - 2015-11-14 05:32:51,369 DEBUG : BROWSER_OUTPUT: RSS: Main: 365019136 05:32:51 INFO - 2015-11-14 05:32:51,369 DEBUG : BROWSER_OUTPUT: 05:32:51 INFO - 2015-11-14 05:32:51,369 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:32:51 INFO - 2015-11-14 05:32:51,371 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:32:51 INFO - 2015-11-14 05:32:51,371 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:32:51 INFO - 2015-11-14 05:32:51,371 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:32:51 INFO - 2015-11-14 05:32:51,373 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2495.712993005804;2518.4333524956887;2538.4161642822137;2552.8085393595484;2571.922842314731;4157.812898419571;4245.49054113506;4263.232618128735;4328.502222244443;4331.870043898684;4166.916661666764;4191.916161676764;4241.151769646068;4343.066240758237;4373.4314539109955;3964.2467931093;3982;3991.5808840071663;3994;4024.798760062;3995.1610161866042;4058.4521089652962;4092.9386059209137;4103.9384409233735;4104.897377565555;3737.4206997915094;3739.5699494558066;3784.735068545203;3922.0783115967724;3923.5684074751753;3991.0621004064024;4005.2790497710403;4015.558288588253;4047.919041619151;4092.1815636872743;3926.862559810393;3930.744501607386;3981.402789581557;4005.018770401241;4061.451704019949;4030.45588845505;4118;4145.316022856225;4257.254980378452;4261.978690106561;4484.596386325214;4528.592426681615;4538.478075021382;4594.816207351702;4638.8608341749805;4615.746133962664;4627.259638457865;4636.837710680144;4653.930191047137;4681.204195286809;4055.7566546007038;4175.185838761473;4247.214265360918;4267.445232119804;4324.697271190987;4614.492405835355;4703.17694403478;4757.14371413149;4774.594159496412;4787.832425865078;4526.049529598756;4529.660275479352;4554.066416384633;4577.06170235101;4625.398698169217;4332.090261045216;4464.531224221475;4497.280435130363;4517.887052823706;4630.536946305342;4465.754383508874;4533.795979180944;4562.817487300471;4658.487566367697;4672.649551283599;4534.319852022223;4543.5910768031035;4551.40831691878;4571.679982401267;4580.725156490621;3452.413089774694;3507.859685612598;3512.1921957949303;3530.4174811156386;3558.87543935961;3223.9677603224136;3251.3172233830687;3263.0047835409955;3278.622958359819;3306.8181250031;4081.9795901020307;4224.577542245751;4253.76604286761;4270.636995855325;4291.763952982616;4617.607503362185;4677.298405239241;4680.625549955996;4720.669553131248;4774.427068751772;4211.7472951623;4386.627136693417;4402.163588918095;4446.599806017474;4447.510773814878;3975.920481590352;4011.7793521356607;4025.6175663311938;4035.4955630546183;4117.238310912431;4731.7634118293945;4731.787069581946;4737.620990320697;4766.213574760195;4782.37829082224;4517.051419201873;4617.422822147231;4646.86059418218;4655.604273636779;4670.392848929618;4618.053299073749;4647.535246475325;4676.485586585405;4733.431988161443;4738.4787673356595;4531.13908357411;4557.498675145665;4571.977140114411;4607.723536587815;4673.556012178838;4343.4136391586735;4439.378487011885;4667.276572131325;4669.533046695304;4695.577398034194;4249.575042495726;4339.717918335298;4357.651387888898;4484;4528.47922488918;4470.329450582439;4514.638828893746;4516.932246016247;4545.886352841206;4547.158775626387;4183.435236243068;4397.516273209881;4415.359772832857;4444.400005999149;4470.821167153277;4342.500612429485;4440.511543730252;4454.910901781881;4458.799354029142;4530.3883975664185;4449.866504004885;4468.486124095641;4483.820647174207;4518.299663552155;4530.501644819134 05:32:51 INFO - 2015-11-14 05:32:51,377 DEBUG : BROWSER_OUTPUT: |1;ext.html;442.86492619750976;447.3178402935523;456.8309725401602;458.97705114744264;480.6347176146128;24270;24987.25038248851;25464.434979102916;31133.84433077837;31341.529877051864;33697.831510842414;33935.83032084842;34060.318793624174;34437.48343774845;34649.30701385977;7300.817479563027;7510.887336689927;7527.397808175333;7620.08558972924;7634.923650763504;6819.727210911557;6828.829279268009;6837.555558888681;7248.927510724904;8731.301495880314;8856.291496680282;8893.866592001094;8917.375783695144;8918.509481978488;9002.909970900273;8783.47299162046;8825.51459669718;8827.16141966512;8918.777030574223;8970.327225458117;6580.14458120446;6768.458523318122;6911.516193866431;8544.61549230286;9026.833559945566;31305;31540.211494712585;31552;31879.84060079708;31986.840065799523;2218.179273668753;2273.897674604647;2514.8365356251784;2529.4308780524234;2785.3593673455016;22150.55698886013;22277.220297289678;22334.979971970777;22459;22656.207032753773;1871.3543827379533;1948.1136083082163;1959.7452331196853;1969.045013168612;1971.6549603819274;214575;215787;216077;216398;217656.911715442;44768;44953.55046449559;44997;45797.77101114473;45966.540334596895;45284;45322.32016519755;45658;49107.263391049164;53935;11291.604793832177;11407;11508.59719909799;11554;11610.651680449431;8218.096009438957;8276.213759692819;8309.95845020783;8341.165883411732;8355.456895301786;15210.859185561127;15242.161681107646;15399.61500962485;15426.074435533905;15467.922660386626;6143.447089761943;6422.454091402283;6431.13179720741;6527.477801775846;6552;726.5241266970143;730.652939853576;771.6951804037486;779.2791667707348;835.2858306148278;22470.887645561666;22938.541229175324;23033.30900072967;23170.7682923172;23187.76812231856;820.8112134209165;825.2902503846688;865.7662431143556;889.7375274293969;924.523870206844;11190.160737944687;11256.831147532794;11279.830802537968;11289.604863829727;11363.829542556869;264660;271012;271292;271467;273238;42233.36649950253;42921.57078429238;42923;42975.785121074194;43070;1079.83262594298;1090.8472813806075;1094.102835674739;1096.6545538155456;1104.7017305327677;21770.564588708454;21945.231916882833;22044.33866983993;22111.66832497546;22257.109715611194;34333.313333733684;34373;39555.2088958225;39755.40978360949;40544.79727601343;167721;168861;171707;171903;174640;21808.781912180675;21851.453713657287;22687.432814179116;22756.43108922224;22929.65605515952;26857.597136043365;30745;31565.053048408583;31709.5243571342;32567.837160814044;26387.60418593684;27241.591376128978;27305.180844574694;27551.173464796088;27689.723102768716;26792.330191744582;26849.865750671903;27237.59143612887;27410.314742131606;27800.304992375353;27227;27293.72706272991;27302.453950920473;27760.58359124655;27804.72195278021;22883.199088031837;23374.64938025897;24342.51314973726;24693.629595556442;25367.238982830546;18352.357667481574;18370.35703750362;18442.170102345695;18450.723239151153;18809.90595047016 05:32:51 INFO - 2015-11-14 05:32:51,378 DEBUG : BROWSER_OUTPUT: |2;jquery.html;254.51895916717396;261.87560908568435;263.915547024952;266.33814969800056;267.36634177000514;11018.338899666025;11170.664880053611;13790.517331893374;14374.568762937115;14550.19973901435;11828.172027958046;13956;14242.145471271731;14461.78307325391;14874;4162.105147393309;4319.395284660134;4420.756858372788;4424.181526417623;4444.866654000385;3107.2697915989725;3113.875444982198;4288.456155783915;4357.975875669215;4626.236670949306;4620.676552641316;4657.464391594959;4675.696079754805;4707.12918110149;4740.312654665072;4437.822487100512;4635.443746750378;4670.416197975253;4688.859334219979;4689.343491911135;4093.2427500912127;4208.263553878059;4225.260579398624;4261.744295342259;4291.206126866539;17389.652206955918;17412.825871741374;17575.73636395455;17598.208080636403;17603.73594396085;1216.2155409760744;1371.306436550859;1436.4972259709123;1462.8390877003521;1495.723291191133;7744.41916856238;7760.534367937942;7768.961155194244;7919.604019799044;7939.682412703485;1199.4302706214567;1199.7660456211042;1207.076586411396;1240.3054289597853;1245.850497940253;47050.76474617605;47396.76301618505;47752.28371574429;48180.759096204645;49371.25943110856;5117.744112794346;5133.922991155136;5237.816676416307;5240.34495688039;5328.307320048447;5904.586678932434;5969.015112506388;5982.641041537521;5991.340952495222;5997.220361353084;4140.585941405896;4157.5010998679745;4204.978975105105;4224.155168966219;4249.065205654751;4368.60682538573;4400.581944715247;4420.955790442119;4483.775811209492;4526.977365113154;2281.0989659084566;2352.2002519143575;2359.657849611797;2363.4564050268536;2383.21353953195;812.2333923716012;819.8770184472257;828.0891019878086;840.0423517190408;885.6103314541581;315.20568168215965;324.847321758773;331.61367007436064;345.5059265250665;352.01611495869105;9202.585883635253;9213.401128926598;9356.625734970525;9428.245740340757;9583.281253905985;317.7600911311945;350.4078107997476;380.07831009801123;380.77153707775113;381.6221940279159;4559.498455169929;4985.850424487271;5032.647714660012;5122.026814905156;5129.358830146231;394874.64066991623;421677;425838;441208;448425;56815;60217.698911506035;60696.696516518015;62006.37993620096;62248.68875655683;365.44817325837647;368.7695190505934;369.6654527652479;369.994450083249;377.0761633996664;8572.099929507312;8685.696000639948;8801.51591662439;8997.865032024656;9015.909840901508;28211.57682634803;28267;28617.14148575546;28993;29357.85321073381;39494;39602;39930.60069399269;40429.79785101055;41136.58863411328;4801.18379875429;4849.224124140121;4901;4906.533879281463;4967.230079337708;8897.777555561162;8914;9380.155785979294;9491.810163796823;9584.28117891147;8156.755297341089;8169.428140030141;8201.548914809742;8204.343652507665;8253.546054967035;7729.768106956801;7801.726939557088;7841.137474877645;7848.293653571206;8057.597120144086;6779.593224406552;7916.920830791619;8168.183181681784;8287.875681864898;8409.663613455394;4439.445069366329;4499.302608095751;4691.413573303337;4853.4418541868135;4900;7383.15093764224;7782.883256751266;7886.408519361185;8022.9197708022175;8122.472039317426 05:32:51 INFO - 2015-11-14 05:32:51,381 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1210.7639010392977;1291.8514370847352;1359.6804750883541;1373.1349249972518;1462.861028202321;5574.581906357024;6027.367126451725;6098.4511393974535;6414.422701956823;6451.354864513546;6283.371662833714;6283.528735344845;6333.55665103443;6366.490680745529;6407.967960160193;1548.2026756220555;1568.6000069982138;1727.6285598596298;1728.9481315560554;1738.9391371302006;1558.127448628766;1721.8536424403878;1724.6809340272089;1739.4868513788463;1745.2757105801077;1679.4877562343481;1706.1895599590218;1713.2119225156443;1733.0295034780563;1749.580100775811;1734.5576877896183;1738.956526086858;1748.038578781665;1754.9473515794546;1782.0109839039328;1721.0964243771994;1762.1805860275033;1765.8763886527947;1773.0602780526342;1785.4286628278956;6103.633781973052;6185.41238582334;6217.222847144107;6321.462675672573;6327.46216571592;3703.777773333609;3729.291434627412;3765.6799172070405;3782.602826703184;3822.197338558906;2217.5897458970144;2234.5642599693065;2255.819534437241;2292;2299.7470278269375;605.0865084617552;653.8038588423454;681.6966449929783;693.6011793218919;734.4711807498593;8347;8422.915770842274;8447.028591711909;8485.618147183392;8521;3398.1844357354057;3419.076849250688;3438.5186073949667;3468.6011108722314;3473.4442489201606;7366.447516436288;7408.333250007525;7425.108986921604;7513.39892808574;7518.097828260535;3810.333191691443;3825.885223443301;3851.422286656968;3863.6715879150024;3878.166194268246;3417.1115509967585;3457.9654203457644;3531.770434921722;3534.293141371736;3554.2536067425613;2898.434805212963;2986.89545865898;2992.1621945855195;3047.801892876956;3068.601081859344;958.836997710391;966.5843687214565;970.088117169858;981.3277904635205;995.1690338567232;1052.9052385285208;1053.3363980692268;1066.3655125200494;1068.2468859454066;1068.4444089073638;6003.0695242237525;6066.514678825683;6086.1175129606845;6093.817185484442;6094.329623741385;335.1637664028265;335.95296658467834;336.18978262387526;339.5365326329542;341.7471071407141;4669.789859456333;4678.812847486062;4683.648726345469;4763.476017638057;4787.4494433140635;6871.793846184622;6872.072270243553;7125.893111603226;7156.355927966508;7164.355208031302;6884.965575172092;6928.688209030605;6933.306669333027;6937.028815965768;7028.50800443964;5167.534921856975;5310.8141215057285;5399.109146990702;5517.806876759294;5684.573656975744;5551.666899986014;5778.075507918713;5823.621464604787;5939.643621382731;5959.67221802805;5895.94104058954;6058.000429929189;6538.084668146368;6589.143411356493;6821.965890170517;6453.354664533509;6792.422644075111;6893.241743408322;7005.05431766705;7070.7525236616475;5343.305370301991;5409.377921539073;5431.049566325798;5510.311211098613;5547.278853748987;5815.76736930518;5874.853128671817;5883.764649414146;5931.911021334769;5985.221921150222;5423.213634022965;5494.505494505353;5501;5505.504504594605;5518.944810552004;5332.360116786011;5386.165144402624;5448.83653490396;5473.233747275305;5546.500814926676;4909.3372394727685;5207.244949482228;5260.789568417221;5291.417944026231;5325.813596524258;4883.072216278895;4912.975435122801;4968.080905032581;4984.925226121539;5011;4816;4932.30947667334;4942.728149951788;4971.502849715;4975.353204083446 05:32:51 INFO - 2015-11-14 05:32:51,383 DEBUG : BROWSER_OUTPUT: |4;prototype.html;244.57077828411136;246.9802415806736;250.65534889526901;251.52963957399666;252.854608600055;5058.367704036996;5083.7966481340745;5110.795568177273;5117.206832940891;5160.483951604838;4883.218685010399;4984.750762461871;4987.426445958716;5070.822521211759;5071;3774.0942173878207;3817.1983883384523;3827.502424684801;3829.5978922213253;3836.8848934532007;3759.097816524028;3821.5414150302004;3829.9425508617255;3834.980825095871;3837.0407398150464;3594.19130695594;3612.1330880588603;3676.540432445944;3707.3512135376336;3711.350513660112;3732.992092135108;3764.887053388403;3772.8868133956025;3793.127580656451;3797.3544497435228;3034.605501284841;3146.874125034996;3205.3268813549184;3226.2418331692033;3260.3479304139028;4778.163821331288;4813.315339631101;4851.320815085891;4864.683795553277;4912.164931961575;4206.053637931472;4230.576942305775;4272.316429371285;4329.567043295677;4333.285007973712;5239.083160446945;5245.580353571705;5275.709835959021;5366.517013468768;5377.46225377463;3476.9652303476896;3478.391281525748;3555.8933232003083;3557.5375201223674;3560.0743806610467;5220.686758794484;5507.697076660782;5595.720213989284;5606.775728970877;5610.775568977236;3428.8285585720614;3438.8108654024268;3445.966210136949;3458.2564748579175;3503.493497795921;3488.110531814371;3494.178867966026;3543.1496440854526;3556.324298383299;3563.1092226943265;4140.585941405835;4171;4193.134055345342;4218.810153543037;4222.704410691222;5185.844424667266;5290.497402746733;5294.841154765363;5314.601404894648;5346.091164502044;1268.289757735671;1271.192792576702;1274.6367285323638;1276.1131013945405;1281.7180220351509;827.4249396669377;829.1542626520915;829.5934991853948;830.9293710034594;835.0647275051859;5062.139436295838;5090.898182036412;5103.8468845934685;5175.741212939338;5177.741112944338;5464.098423760114;5474.288342515448;5500.119980803132;5555.916661250085;5585.860353491195;5060.291559181717;5068.391792984866;5071.290019397287;5151.433342332415;5171.715555644476;2911.097559756482;2944.6319210098736;2972.346083861547;2976.4939960206816;2979.553067039961;5476.315460567429;5591.10542313228;5610.691411972381;5643.463870932255;5697.316322041299;5487.341519017744;5537.529310008614;5538.086215774352;5559.972200138974;5610.5231055360755;5596.552275818006;5614.69119198448;5642.85892852682;5725.141228815628;5819.70901454934;5504.091824849015;5513.862153446196;5519.172124181245;5594.580406469612;5638.407967163553;5226.111561034557;5423.864403389947;5455.318085239345;5493.203485494501;5509.47659972302;5641.830745077655;5669.7165141741925;5765.7117144141785;5768.625039372428;5770.451807078321;3528.276703275771;3532.682058614737;3547.166415892315;3611.5124458197806;3629.546306711661;5486.670799752028;5489.286392769074;5563.388027316911;5571.997040532743;5595.104783234663;5138.665986710852;5315.176147697113;5337;5385.973070134624;5391.137418013099;5354.625176237626;5364.678119312854;5423.267858839164;5434.538064264581;5471.151971444432;5205.6356055075785;5212.635115541876;5301.416844147064;5332.68003919766;5336.119540275811;5198.766055527586;5328.09422398201;5339.946600533945;5426.186072089218;5446.237526746179;5187.533122019036;5197.688138711689;5269.077911365573;5292.232626269247;5296 05:32:51 INFO - 2015-11-14 05:32:51,386 DEBUG : BROWSER_OUTPUT: |5;yui.html;476.5496605707606;555.3141869790808;599.4964230046766;603.399617380706;616.4883146987999;10441;10938.671839844817;10941.945290273547;10950.507227174776;10969.616063437792;9323.021082786312;9692.806143877118;10105.898941010588;10316.123129533999;10361.481925903712;694.9409300209488;704.5983789240136;713.0267185292091;717.5838013951895;721.2715157690718;707.5895980331395;716.1907045039098;716.795713221732;723.2947875821085;730;702.0872865275147;730.6127752291294;736.4329466310937;745.8172747676799;747.6710247491113;732.827785470414;734.7391675955013;736.3299397548259;737.71229220604;744.2966396755069;542.2977244468423;547.8657728856416;547.9287692599936;548.0710196217414;550.5017958747341;8464.365172612017;8703.651853925836;8737.432066915693;8741.956290218572;8774.736757897273;7834.529928204269;8061.9193808061755;8103.513789172668;8517.74446766598;8592.14078592142;6976.616286104262;7013.89479157813;7153.177384600734;7210.2789721028;7349.265073492661;2605.1403036997744;2655.3361659585103;2685.422634133651;2705.8105932584726;2793.064323451646;36679.63320366789;36911.44632830509;37582.24835503302;38956;39464.80267598672;7149.213586505481;7258.818529536698;7549.698012079565;7561.848763024709;7652.387808975269;15120.621984450478;15310.387584496719;15347.309371078329;15410.460633877761;15545.222738863238;5395.568354531628;5402.08164612009;5486.862828429321;5634.3802181759975;5791.131330300489;2958.763298936123;3038.9696103039128;3056.831874246893;3125.093722820402;3134.9373012540077;2340.906363745465;2382.237683941157;2392.8564286142887;2404.0624156578947;2420.1771397724856;345.50075141420405;352.8729657323361;354.7109106078589;355.4987467670572;360.27944111776446;350.9087637214292;351.78716876289985;359.21690714243204;371.79551246814145;378.9166383395648;6074.240719910012;6324.71538780756;6651.102101216371;6860.485463590251;7039.683214255371;405.96549293309806;449.4067830463822;450.31102413307036;457.85536159600997;501.5511117549772;3049.7560195184333;3073.416050950312;3088.320569474712;3157.67419586557;3186.2830863056092;46610.76694616505;47111;47435;47794.52205477901;47970.28044579334;41595.584044159776;42501.57498425038;43017;43123;43233.13533729371;33896.66103338984;35395.82302088473;36671.633283667354;36769.63230367769;36803.447948280795;6354.301026887131;6526.706298216497;6707.396334329934;6723.731050757915;6948.861022779617;28975.13074607765;29050.854745726137;29084.418311634072;29609.25976850596;30105.849470752506;32940.67059329472;34072.14819629529;35420.82289588536;36343.63656363403;37576.2484750298;6189.164462797465;6239.4696450800375;6276.717547710456;6310.6213627182515;6460.741570337133;8771.824563508566;8937;8970.254901181013;9105.226055785068;9204.355695101278;8414.284785793276;8423.957880210559;8537.060923298308;8553.82892342162;8553.914460855312;8531.402801803813;8557.743267701979;8563.529005904486;8580.65677372898;8592.226699597066;8420.452670576393;8441.66233350659;8460.069392366959;8466.788330291793;8499.235068843835;6862.965685171542;6894.207166175754;6965.686544105629;7140.964295178491;7419.295166959346;7063.71745130189;7070.116235470567;7119.822004449723;7165.605891676008;7333.266673332838 05:32:51 INFO - 2015-11-14 05:32:51,386 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:32:51 INFO - 2015-11-14 05:32:51,387 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:32:51 INFO - 2015-11-14 05:32:51,387 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1050 05:32:51 INFO - 2015-11-14 05:32:51,387 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:32:51 INFO - 2015-11-14 05:32:51,387 DEBUG : BROWSER_OUTPUT: __startTimestamp1447507971369__endTimestamp 05:32:51 INFO - 2015-11-14 05:32:51,387 DEBUG : BROWSER_OUTPUT: 05:32:51 INFO - 2015-11-14 05:32:51,387 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:32:51 INFO - 2015-11-14 05:32:51,388 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:32:51 INFO - 2015-11-14 05:32:51,388 DEBUG : BROWSER_OUTPUT: 05:32:51 INFO - 2015-11-14 05:32:51,388 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4272.48 Median:4439.38 stddev:464.55 (10.5%) stddev-sans-first:444.57 05:32:51 INFO - 2015-11-14 05:32:51,388 DEBUG : BROWSER_OUTPUT: Values: 2495.7 2518.4 2538.4 2552.8 2571.9 4157.8 4245.5 4263.2 4328.5 4331.9 4166.9 4191.9 4241.2 4343.1 4373.4 3964.2 3982.0 3991.6 3994.0 4024.8 3995.2 4058.5 4092.9 4103.9 4104.9 3737.4 3739.6 3784.7 3922.1 3923.6 3991.1 4005.3 4015.6 4047.9 4092.2 3926.9 3930.7 3981.4 4005.0 4061.5 4030.5 4118.0 4145.3 4257.3 4262.0 4484.6 4528.6 4538.5 4594.8 4638.9 4615.7 4627.3 4636.8 4653.9 4681.2 4055.8 4175.2 4247.2 4267.4 4324.7 4614.5 4703.2 4757.1 4774.6 4787.8 4526.0 4529.7 4554.1 4577.1 4625.4 4332.1 4464.5 4497.3 4517.9 4630.5 4465.8 4533.8 4562.8 4658.5 4672.6 4534.3 4543.6 4551.4 4571.7 4580.7 3452.4 3507.9 3512.2 3530.4 3558.9 3224.0 3251.3 3263.0 3278.6 3306.8 4082.0 4224.6 4253.8 4270.6 4291.8 4617.6 4677.3 4680.6 4720.7 4774.4 4211.7 4386.6 4402.2 4446.6 4447.5 3975.9 4011.8 4025.6 4035.5 4117.2 4731.8 4731.8 4737.6 4766.2 4782.4 4517.1 4617.4 4646.9 4655.6 4670.4 4618.1 4647.5 4676.5 4733.4 4738.5 4531.1 4557.5 4572.0 4607.7 4673.6 4343.4 4439.4 4667.3 4669.5 4695.6 4249.6 4339.7 4357.7 4484.0 4528.5 4470.3 4514.6 4516.9 4545.9 4547.2 4183.4 4397.5 4415.4 4444.4 4470.8 4342.5 4440.5 4454.9 4458.8 4530.4 4449.9 4468.5 4483.8 4518.3 4530.5 05:32:51 INFO - 2015-11-14 05:32:51,388 DEBUG : BROWSER_OUTPUT: 05:32:51 INFO - 2015-11-14 05:32:51,389 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:35275.48 Median:27780.44 stddev:58339.33 (210.0%) stddev-sans-first:58444.37 05:32:51 INFO - 2015-11-14 05:32:51,390 DEBUG : BROWSER_OUTPUT: Values: 442.9 447.3 456.8 459.0 480.6 24270.0 24987.3 25464.4 31133.8 31341.5 33697.8 33935.8 34060.3 34437.5 34649.3 7300.8 7510.9 7527.4 7620.1 7634.9 6819.7 6828.8 6837.6 7248.9 8731.3 8856.3 8893.9 8917.4 8918.5 9002.9 8783.5 8825.5 8827.2 8918.8 8970.3 6580.1 6768.5 6911.5 8544.6 9026.8 31305.0 31540.2 31552.0 31879.8 31986.8 2218.2 2273.9 2514.8 2529.4 2785.4 22150.6 22277.2 22335.0 22459.0 22656.2 1871.4 1948.1 1959.7 1969.0 1971.7 214575.0 215787.0 216077.0 216398.0 217656.9 44768.0 44953.6 44997.0 45797.8 45966.5 45284.0 45322.3 45658.0 49107.3 53935.0 11291.6 11407.0 11508.6 11554.0 11610.7 8218.1 8276.2 8310.0 8341.2 8355.5 15210.9 15242.2 15399.6 15426.1 15467.9 6143.4 6422.5 6431.1 6527.5 6552.0 726.5 730.7 771.7 779.3 835.3 22470.9 22938.5 23033.3 23170.8 23187.8 820.8 825.3 865.8 889.7 924.5 11190.2 11256.8 11279.8 11289.6 11363.8 264660.0 271012.0 271292.0 271467.0 273238.0 42233.4 42921.6 42923.0 42975.8 43070.0 1079.8 1090.8 1094.1 1096.7 1104.7 21770.6 21945.2 22044.3 22111.7 22257.1 34333.3 34373.0 39555.2 39755.4 40544.8 167721.0 168861.0 171707.0 171903.0 174640.0 21808.8 21851.5 22687.4 22756.4 22929.7 26857.6 30745.0 31565.1 31709.5 32567.8 26387.6 27241.6 27305.2 27551.2 27689.7 26792.3 26849.9 27237.6 27410.3 27800.3 27227.0 27293.7 27302.5 27760.6 27804.7 22883.2 23374.6 24342.5 24693.6 25367.2 18352.4 18370.4 18442.2 18450.7 18809.9 05:32:51 INFO - 2015-11-14 05:32:51,390 DEBUG : BROWSER_OUTPUT: 05:32:51 INFO - 2015-11-14 05:32:51,390 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21617.55 Median:4513.14 stddev:69963.98 (1550.2%) stddev-sans-first:70141.86 05:32:51 INFO - 2015-11-14 05:32:51,391 DEBUG : BROWSER_OUTPUT: Values: 254.5 261.9 263.9 266.3 267.4 11018.3 11170.7 13790.5 14374.6 14550.2 11828.2 13956.0 14242.1 14461.8 14874.0 4162.1 4319.4 4420.8 4424.2 4444.9 3107.3 3113.9 4288.5 4358.0 4626.2 4620.7 4657.5 4675.7 4707.1 4740.3 4437.8 4635.4 4670.4 4688.9 4689.3 4093.2 4208.3 4225.3 4261.7 4291.2 17389.7 17412.8 17575.7 17598.2 17603.7 1216.2 1371.3 1436.5 1462.8 1495.7 7744.4 7760.5 7769.0 7919.6 7939.7 1199.4 1199.8 1207.1 1240.3 1245.9 47050.8 47396.8 47752.3 48180.8 49371.3 5117.7 5133.9 5237.8 5240.3 5328.3 5904.6 5969.0 5982.6 5991.3 5997.2 4140.6 4157.5 4205.0 4224.2 4249.1 4368.6 4400.6 4421.0 4483.8 4527.0 2281.1 2352.2 2359.7 2363.5 2383.2 812.2 819.9 828.1 840.0 885.6 315.2 324.8 331.6 345.5 352.0 9202.6 9213.4 9356.6 9428.2 9583.3 317.8 350.4 380.1 380.8 381.6 4559.5 4985.9 5032.6 5122.0 5129.4 394874.6 421677.0 425838.0 441208.0 448425.0 56815.0 60217.7 60696.7 62006.4 62248.7 365.4 368.8 369.7 370.0 377.1 8572.1 8685.7 8801.5 8997.9 9015.9 28211.6 28267.0 28617.1 28993.0 29357.9 39494.0 39602.0 39930.6 40429.8 41136.6 4801.2 4849.2 4901.0 4906.5 4967.2 8897.8 8914.0 9380.2 9491.8 9584.3 8156.8 8169.4 8201.5 8204.3 8253.5 7729.8 7801.7 7841.1 7848.3 8057.6 6779.6 7916.9 8168.2 8287.9 8409.7 4439.4 4499.3 4691.4 4853.4 4900.0 7383.2 7782.9 7886.4 8022.9 8122.5 05:32:51 INFO - 2015-11-14 05:32:51,392 DEBUG : BROWSER_OUTPUT: 05:32:51 INFO - 2015-11-14 05:32:51,393 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4275.52 Median:5318.31 stddev:2237.29 (42.1%) stddev-sans-first:2231.71 05:32:51 INFO - 2015-11-14 05:32:51,393 DEBUG : BROWSER_OUTPUT: Values: 1210.8 1291.9 1359.7 1373.1 1462.9 5574.6 6027.4 6098.5 6414.4 6451.4 6283.4 6283.5 6333.6 6366.5 6408.0 1548.2 1568.6 1727.6 1728.9 1738.9 1558.1 1721.9 1724.7 1739.5 1745.3 1679.5 1706.2 1713.2 1733.0 1749.6 1734.6 1739.0 1748.0 1754.9 1782.0 1721.1 1762.2 1765.9 1773.1 1785.4 6103.6 6185.4 6217.2 6321.5 6327.5 3703.8 3729.3 3765.7 3782.6 3822.2 2217.6 2234.6 2255.8 2292.0 2299.7 605.1 653.8 681.7 693.6 734.5 8347.0 8422.9 8447.0 8485.6 8521.0 3398.2 3419.1 3438.5 3468.6 3473.4 7366.4 7408.3 7425.1 7513.4 7518.1 3810.3 3825.9 3851.4 3863.7 3878.2 3417.1 3458.0 3531.8 3534.3 3554.3 2898.4 2986.9 2992.2 3047.8 3068.6 958.8 966.6 970.1 981.3 995.2 1052.9 1053.3 1066.4 1068.2 1068.4 6003.1 6066.5 6086.1 6093.8 6094.3 335.2 336.0 336.2 339.5 341.7 4669.8 4678.8 4683.6 4763.5 4787.4 6871.8 6872.1 7125.9 7156.4 7164.4 6885.0 6928.7 6933.3 6937.0 7028.5 5167.5 5310.8 5399.1 5517.8 5684.6 5551.7 5778.1 5823.6 5939.6 5959.7 5895.9 6058.0 6538.1 6589.1 6822.0 6453.4 6792.4 6893.2 7005.1 7070.8 5343.3 5409.4 5431.0 5510.3 5547.3 5815.8 5874.9 5883.8 5931.9 5985.2 5423.2 5494.5 5501.0 5505.5 5518.9 5332.4 5386.2 5448.8 5473.2 5546.5 4909.3 5207.2 5260.8 5291.4 5325.8 4883.1 4913.0 4968.1 4984.9 5011.0 4816.0 4932.3 4942.7 4971.5 4975.4 05:32:51 INFO - 2015-11-14 05:32:51,393 DEBUG : BROWSER_OUTPUT: 05:32:51 INFO - 2015-11-14 05:32:51,394 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4404.18 Median:5145.05 stddev:1382.72 (26.9%) stddev-sans-first:1350.89 05:32:51 INFO - 2015-11-14 05:32:51,395 DEBUG : BROWSER_OUTPUT: Values: 244.6 247.0 250.7 251.5 252.9 5058.4 5083.8 5110.8 5117.2 5160.5 4883.2 4984.8 4987.4 5070.8 5071.0 3774.1 3817.2 3827.5 3829.6 3836.9 3759.1 3821.5 3829.9 3835.0 3837.0 3594.2 3612.1 3676.5 3707.4 3711.4 3733.0 3764.9 3772.9 3793.1 3797.4 3034.6 3146.9 3205.3 3226.2 3260.3 4778.2 4813.3 4851.3 4864.7 4912.2 4206.1 4230.6 4272.3 4329.6 4333.3 5239.1 5245.6 5275.7 5366.5 5377.5 3477.0 3478.4 3555.9 3557.5 3560.1 5220.7 5507.7 5595.7 5606.8 5610.8 3428.8 3438.8 3446.0 3458.3 3503.5 3488.1 3494.2 3543.1 3556.3 3563.1 4140.6 4171.0 4193.1 4218.8 4222.7 5185.8 5290.5 5294.8 5314.6 5346.1 1268.3 1271.2 1274.6 1276.1 1281.7 827.4 829.2 829.6 830.9 835.1 5062.1 5090.9 5103.8 5175.7 5177.7 5464.1 5474.3 5500.1 5555.9 5585.9 5060.3 5068.4 5071.3 5151.4 5171.7 2911.1 2944.6 2972.3 2976.5 2979.6 5476.3 5591.1 5610.7 5643.5 5697.3 5487.3 5537.5 5538.1 5560.0 5610.5 5596.6 5614.7 5642.9 5725.1 5819.7 5504.1 5513.9 5519.2 5594.6 5638.4 5226.1 5423.9 5455.3 5493.2 5509.5 5641.8 5669.7 5765.7 5768.6 5770.5 3528.3 3532.7 3547.2 3611.5 3629.5 5486.7 5489.3 5563.4 5572.0 5595.1 5138.7 5315.2 5337.0 5386.0 5391.1 5354.6 5364.7 5423.3 5434.5 5471.2 5205.6 5212.6 5301.4 5332.7 5336.1 5198.8 5328.1 5339.9 5426.2 5446.2 5187.5 5197.7 5269.1 5292.2 5296.0 05:32:51 INFO - 2015-11-14 05:32:51,395 DEBUG : BROWSER_OUTPUT: 05:32:51 INFO - 2015-11-14 05:32:51,395 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10733.82 Median:601.45 stddev:13004.44 (2162.2%) stddev-sans-first:13018.11 05:32:51 INFO - 2015-11-14 05:32:51,396 DEBUG : BROWSER_OUTPUT: Values: 476.5 555.3 599.5 603.4 616.5 10441.0 10938.7 10941.9 10950.5 10969.6 9323.0 9692.8 10105.9 10316.1 10361.5 694.9 704.6 713.0 717.6 721.3 707.6 716.2 716.8 723.3 730.0 702.1 730.6 736.4 745.8 747.7 732.8 734.7 736.3 737.7 744.3 542.3 547.9 547.9 548.1 550.5 8464.4 8703.7 8737.4 8742.0 8774.7 7834.5 8061.9 8103.5 8517.7 8592.1 6976.6 7013.9 7153.2 7210.3 7349.3 2605.1 2655.3 2685.4 2705.8 2793.1 36679.6 36911.4 37582.2 38956.0 39464.8 7149.2 7258.8 7549.7 7561.8 7652.4 15120.6 15310.4 15347.3 15410.5 15545.2 5395.6 5402.1 5486.9 5634.4 5791.1 2958.8 3039.0 3056.8 3125.1 3134.9 2340.9 2382.2 2392.9 2404.1 2420.2 345.5 352.9 354.7 355.5 360.3 350.9 351.8 359.2 371.8 378.9 6074.2 6324.7 6651.1 6860.5 7039.7 406.0 449.4 450.3 457.9 501.6 3049.8 3073.4 3088.3 3157.7 3186.3 46610.8 47111.0 47435.0 47794.5 47970.3 41595.6 42501.6 43017.0 43123.0 43233.1 33896.7 35395.8 36671.6 36769.6 36803.4 6354.3 6526.7 6707.4 6723.7 6948.9 28975.1 29050.9 29084.4 29609.3 30105.8 32940.7 34072.1 35420.8 36343.6 37576.2 6189.2 6239.5 6276.7 6310.6 6460.7 8771.8 8937.0 8970.3 9105.2 9204.4 8414.3 8424.0 8537.1 8553.8 8553.9 8531.4 8557.7 8563.5 8580.7 8592.2 8420.5 8441.7 8460.1 8466.8 8499.2 6863.0 6894.2 6965.7 7141.0 7419.3 7063.7 7070.1 7119.8 7165.6 7333.3 05:32:51 INFO - 2015-11-14 05:32:51,396 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:32:51 INFO - 2015-11-14 05:32:51,397 DEBUG : BROWSER_OUTPUT: 05:32:52 INFO - 2015-11-14 05:32:52,127 INFO : Browser exited with error code: 0 05:32:52 INFO - 2015-11-14 05:32:52,161 INFO : Completed test dromaeo_css (00:18:38) 05:32:52 INFO - 2015-11-14 05:32:52,161 INFO : Starting test kraken 05:32:52 INFO - 2015-11-14 05:32:52,161 DEBUG : operating with platform_type : mac_ 05:32:52 INFO - 2015-11-14 05:32:52,161 INFO : Initialising browser for kraken test... 05:32:52 INFO - 2015-11-14 05:32:52,181 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpuE_Co7/profile http://localhost:53253/getInfo.html 05:32:54 INFO - 2015-11-14 05:32:54,922 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:32:54 INFO - 2015-11-14 05:32:54,922 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:32:54 INFO - 2015-11-14 05:32:54,923 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:32:54 INFO - 2015-11-14 05:32:54,923 DEBUG : BROWSER_OUTPUT: __metrics 05:32:54 INFO - 2015-11-14 05:32:54,941 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:55 INFO - 2015-11-14 05:32:55,755 INFO : Browser initialized. 05:32:55 INFO - 2015-11-14 05:32:55,756 INFO : Running cycle 1/1 for kraken test... 05:32:55 INFO - 2015-11-14 05:32:55,756 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpuE_Co7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:33:07 INFO - 2015-11-14 05:33:07,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 231043072 05:33:07 INFO - 2015-11-14 05:33:07,985 DEBUG : BROWSER_OUTPUT: 05:33:11 INFO - 2015-11-14 05:33:11,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53253/tests/kraken/driver.html?testName=audio-beat-detection) 05:33:11 INFO - 2015-11-14 05:33:11,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 288403456 05:33:11 INFO - 2015-11-14 05:33:11,640 DEBUG : BROWSER_OUTPUT: 05:33:14 INFO - 2015-11-14 05:33:14,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53253/tests/kraken/driver.html?testName=audio-dft) 05:33:15 INFO - 2015-11-14 05:33:15,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 300802048 05:33:15 INFO - 2015-11-14 05:33:15,442 DEBUG : BROWSER_OUTPUT: 05:33:18 INFO - 2015-11-14 05:33:18,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53253/tests/kraken/driver.html?testName=audio-fft) 05:33:19 INFO - 2015-11-14 05:33:19,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 282722304 05:33:19 INFO - 2015-11-14 05:33:19,551 DEBUG : BROWSER_OUTPUT: 05:33:21 INFO - 2015-11-14 05:33:21,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53253/tests/kraken/driver.html?testName=audio-oscillator) 05:33:22 INFO - 2015-11-14 05:33:22,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 284327936 05:33:22 INFO - 2015-11-14 05:33:22,515 DEBUG : BROWSER_OUTPUT: 05:33:25 INFO - 2015-11-14 05:33:25,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:33:25 INFO - 2015-11-14 05:33:25,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 284123136 05:33:25 INFO - 2015-11-14 05:33:25,674 DEBUG : BROWSER_OUTPUT: 05:33:29 INFO - 2015-11-14 05:33:29,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53253/tests/kraken/driver.html?testName=imaging-darkroom) 05:33:29 INFO - 2015-11-14 05:33:29,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 282214400 05:33:29 INFO - 2015-11-14 05:33:29,939 DEBUG : BROWSER_OUTPUT: 05:33:33 INFO - 2015-11-14 05:33:33,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53253/tests/kraken/driver.html?testName=imaging-desaturate) 05:33:34 INFO - 2015-11-14 05:33:34,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 282103808 05:33:34 INFO - 2015-11-14 05:33:34,330 DEBUG : BROWSER_OUTPUT: 05:33:37 INFO - 2015-11-14 05:33:37,687 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53253/tests/kraken/driver.html?testName=json-parse-financial) 05:33:38 INFO - 2015-11-14 05:33:38,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 283271168 05:33:38 INFO - 2015-11-14 05:33:38,280 DEBUG : BROWSER_OUTPUT: 05:33:40 INFO - 2015-11-14 05:33:40,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:33:40 INFO - 2015-11-14 05:33:40,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 318853120 05:33:40 INFO - 2015-11-14 05:33:40,648 DEBUG : BROWSER_OUTPUT: 05:33:42 INFO - 2015-11-14 05:33:42,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:33:43 INFO - 2015-11-14 05:33:43,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 318832640 05:33:43 INFO - 2015-11-14 05:33:43,382 DEBUG : BROWSER_OUTPUT: 05:33:45 INFO - 2015-11-14 05:33:45,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:33:46 INFO - 2015-11-14 05:33:46,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 328007680 05:33:46 INFO - 2015-11-14 05:33:46,453 DEBUG : BROWSER_OUTPUT: 05:33:49 INFO - 2015-11-14 05:33:49,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:33:50 INFO - 2015-11-14 05:33:50,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 329940992 05:33:50 INFO - 2015-11-14 05:33:50,181 DEBUG : BROWSER_OUTPUT: 05:33:53 INFO - 2015-11-14 05:33:53,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:33:53 INFO - 2015-11-14 05:33:53,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 330067968 05:33:53 INFO - 2015-11-14 05:33:53,971 DEBUG : BROWSER_OUTPUT: 05:33:55 INFO - 2015-11-14 05:33:55,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53253/tests/kraken/driver.html?testName=ai-astar) 05:33:56 INFO - 2015-11-14 05:33:56,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 390578176 05:33:56 INFO - 2015-11-14 05:33:56,259 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,259 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:33:56 INFO - 2015-11-14 05:33:56,260 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:33:56 INFO - 2015-11-14 05:33:56,260 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:33:56 INFO - 2015-11-14 05:33:56,260 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:33:56 INFO - 2015-11-14 05:33:56,260 DEBUG : BROWSER_OUTPUT: |0;ai-astar;132;133;133;140;138;134;133;133;132;141 05:33:56 INFO - 2015-11-14 05:33:56,260 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;201;164;195;211;163;192;193;162;215;166 05:33:56 INFO - 2015-11-14 05:33:56,261 DEBUG : BROWSER_OUTPUT: |2;audio-dft;196;208;206;200;198;199;208;207;205;197 05:33:56 INFO - 2015-11-14 05:33:56,261 DEBUG : BROWSER_OUTPUT: |3;audio-fft;87;100;103;158;85;89;90;91;148;87 05:33:56 INFO - 2015-11-14 05:33:56,261 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;122;124;174;115;116;118;163;110;109;159 05:33:56 INFO - 2015-11-14 05:33:56,261 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;156;148;146;148;156;155;152;141;148;155 05:33:56 INFO - 2015-11-14 05:33:56,261 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;160;162;162;155;162;163;163;162;159;155 05:33:56 INFO - 2015-11-14 05:33:56,262 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;120;120;120;121;120;130;130;130;120;119 05:33:56 INFO - 2015-11-14 05:33:56,262 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;69;72;71;72;74;75;85;75;74 05:33:56 INFO - 2015-11-14 05:33:56,262 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;80;80;83;86;88;86;86;86;86 05:33:56 INFO - 2015-11-14 05:33:56,262 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;104;106;113;110;109;109;112;111;113;111 05:33:56 INFO - 2015-11-14 05:33:56,262 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;156;160;170;161;170;167;169;157;170;175 05:33:56 INFO - 2015-11-14 05:33:56,262 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;182;198;203;203;190;194;203;201;205;190 05:33:56 INFO - 2015-11-14 05:33:56,262 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;83;88;93;92;93;91;91;88;89;90 05:33:56 INFO - 2015-11-14 05:33:56,263 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:33:56 INFO - 2015-11-14 05:33:56,264 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:33:56 INFO - 2015-11-14 05:33:56,264 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1025 05:33:56 INFO - 2015-11-14 05:33:56,264 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:33:56 INFO - 2015-11-14 05:33:56,265 DEBUG : BROWSER_OUTPUT: __startTimestamp1447508036258__endTimestamp 05:33:56 INFO - 2015-11-14 05:33:56,265 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,265 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:33:56 INFO - 2015-11-14 05:33:56,265 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:33:56 INFO - 2015-11-14 05:33:56,265 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,265 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:134.90 Median:133.50 stddev:3.41 (2.6%) stddev-sans-first:3.46 05:33:56 INFO - 2015-11-14 05:33:56,266 DEBUG : BROWSER_OUTPUT: Values: 132.0 133.0 133.0 140.0 138.0 134.0 133.0 133.0 132.0 141.0 05:33:56 INFO - 2015-11-14 05:33:56,266 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,266 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:186.20 Median:194.00 stddev:20.67 (10.7%) stddev-sans-first:21.22 05:33:56 INFO - 2015-11-14 05:33:56,266 DEBUG : BROWSER_OUTPUT: Values: 201.0 164.0 195.0 211.0 163.0 192.0 193.0 162.0 215.0 166.0 05:33:56 INFO - 2015-11-14 05:33:56,266 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,267 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:202.40 Median:205.50 stddev:4.84 (2.4%) stddev-sans-first:4.54 05:33:56 INFO - 2015-11-14 05:33:56,267 DEBUG : BROWSER_OUTPUT: Values: 196.0 208.0 206.0 200.0 198.0 199.0 208.0 207.0 205.0 197.0 05:33:56 INFO - 2015-11-14 05:33:56,267 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,267 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:103.80 Median:87.00 stddev:26.66 (30.6%) stddev-sans-first:27.58 05:33:56 INFO - 2015-11-14 05:33:56,268 DEBUG : BROWSER_OUTPUT: Values: 87.0 100.0 103.0 158.0 85.0 89.0 90.0 91.0 148.0 87.0 05:33:56 INFO - 2015-11-14 05:33:56,268 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,268 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:131.00 Median:123.00 stddev:24.41 (19.8%) stddev-sans-first:25.67 05:33:56 INFO - 2015-11-14 05:33:56,268 DEBUG : BROWSER_OUTPUT: Values: 122.0 124.0 174.0 115.0 116.0 118.0 163.0 110.0 109.0 159.0 05:33:56 INFO - 2015-11-14 05:33:56,268 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,268 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:150.50 Median:153.50 stddev:5.08 (3.3%) stddev-sans-first:4.99 05:33:56 INFO - 2015-11-14 05:33:56,269 DEBUG : BROWSER_OUTPUT: Values: 156.0 148.0 146.0 148.0 156.0 155.0 152.0 141.0 148.0 155.0 05:33:56 INFO - 2015-11-14 05:33:56,269 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,269 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:160.30 Median:162.00 stddev:3.06 (1.9%) stddev-sans-first:3.24 05:33:56 INFO - 2015-11-14 05:33:56,269 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 162.0 155.0 162.0 163.0 163.0 162.0 159.0 155.0 05:33:56 INFO - 2015-11-14 05:33:56,270 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,270 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:123.00 Median:120.50 stddev:4.85 (4.0%) stddev-sans-first:5.02 05:33:56 INFO - 2015-11-14 05:33:56,270 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 120.0 121.0 120.0 130.0 130.0 130.0 120.0 119.0 05:33:56 INFO - 2015-11-14 05:33:56,270 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,271 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.40 Median:74.00 stddev:4.84 (6.5%) stddev-sans-first:4.54 05:33:56 INFO - 2015-11-14 05:33:56,271 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 72.0 71.0 72.0 74.0 75.0 85.0 75.0 74.0 05:33:56 INFO - 2015-11-14 05:33:56,271 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,272 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:83.80 Median:86.00 stddev:3.61 (4.2%) stddev-sans-first:2.88 05:33:56 INFO - 2015-11-14 05:33:56,272 DEBUG : BROWSER_OUTPUT: Values: 77.0 80.0 80.0 83.0 86.0 88.0 86.0 86.0 86.0 86.0 05:33:56 INFO - 2015-11-14 05:33:56,272 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,272 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:109.80 Median:111.00 stddev:2.94 (2.6%) stddev-sans-first:2.24 05:33:56 INFO - 2015-11-14 05:33:56,272 DEBUG : BROWSER_OUTPUT: Values: 104.0 106.0 113.0 110.0 109.0 109.0 112.0 111.0 113.0 111.0 05:33:56 INFO - 2015-11-14 05:33:56,272 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,272 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:165.50 Median:169.50 stddev:6.49 (3.8%) stddev-sans-first:5.90 05:33:56 INFO - 2015-11-14 05:33:56,272 DEBUG : BROWSER_OUTPUT: Values: 156.0 160.0 170.0 161.0 170.0 167.0 169.0 157.0 170.0 175.0 05:33:56 INFO - 2015-11-14 05:33:56,273 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,273 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.90 Median:202.00 stddev:7.61 (3.8%) stddev-sans-first:5.85 05:33:56 INFO - 2015-11-14 05:33:56,273 DEBUG : BROWSER_OUTPUT: Values: 182.0 198.0 203.0 203.0 190.0 194.0 203.0 201.0 205.0 190.0 05:33:56 INFO - 2015-11-14 05:33:56,273 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,273 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:89.80 Median:91.00 stddev:3.01 (3.3%) stddev-sans-first:1.94 05:33:56 INFO - 2015-11-14 05:33:56,273 DEBUG : BROWSER_OUTPUT: Values: 83.0 88.0 93.0 92.0 93.0 91.0 91.0 88.0 89.0 90.0 05:33:56 INFO - 2015-11-14 05:33:56,273 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:33:56 INFO - 2015-11-14 05:33:56,273 DEBUG : BROWSER_OUTPUT: 05:33:56 INFO - 2015-11-14 05:33:56,982 INFO : Browser exited with error code: 0 05:33:57 INFO - 2015-11-14 05:33:57,043 INFO : Completed test kraken (00:01:04) 05:33:57 INFO - 2015-11-14 05:33:57,043 INFO : Starting test v8_7 05:33:57 INFO - 2015-11-14 05:33:57,044 DEBUG : operating with platform_type : mac_ 05:33:57 INFO - 2015-11-14 05:33:57,044 INFO : Initialising browser for v8_7 test... 05:33:57 INFO - 2015-11-14 05:33:57,064 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpnde3Ug/profile http://localhost:53253/getInfo.html 05:33:59 INFO - 2015-11-14 05:33:59,723 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:33:59 INFO - 2015-11-14 05:33:59,724 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:33:59 INFO - 2015-11-14 05:33:59,724 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:33:59 INFO - 2015-11-14 05:33:59,724 DEBUG : BROWSER_OUTPUT: __metrics 05:33:59 INFO - 2015-11-14 05:33:59,732 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:34:00 INFO - 2015-11-14 05:34:00,533 INFO : Browser initialized. 05:34:00 INFO - 2015-11-14 05:34:00,533 INFO : Running cycle 1/1 for v8_7 test... 05:34:00 INFO - 2015-11-14 05:34:00,533 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/T/tmpnde3Ug/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:34:12 INFO - 2015-11-14 05:34:12,765 DEBUG : BROWSER_OUTPUT: RSS: Main: 229183488 05:34:12 INFO - 2015-11-14 05:34:12,765 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,615 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53253/tests/v8_7/run.html (next: http://localhost:53253/tests/v8_7/run.html) 05:34:35 INFO - 2015-11-14 05:34:35,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 308400128 05:34:35 INFO - 2015-11-14 05:34:35,864 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,864 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:34:35 INFO - 2015-11-14 05:34:35,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:34:35 INFO - 2015-11-14 05:34:35,864 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:34:35 INFO - 2015-11-14 05:34:35,864 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:34:35 INFO - 2015-11-14 05:34:35,865 DEBUG : BROWSER_OUTPUT: |0;Richards;207.68431983385256 05:34:35 INFO - 2015-11-14 05:34:35,865 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;246.06299212598427 05:34:35 INFO - 2015-11-14 05:34:35,865 DEBUG : BROWSER_OUTPUT: |2;Encrypt;392.92730844793715 05:34:35 INFO - 2015-11-14 05:34:35,865 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7063.380281690141 05:34:35 INFO - 2015-11-14 05:34:35,865 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2590.6735751295337 05:34:35 INFO - 2015-11-14 05:34:35,865 DEBUG : BROWSER_OUTPUT: |5;Earley;1016.260162601626 05:34:35 INFO - 2015-11-14 05:34:35,866 DEBUG : BROWSER_OUTPUT: |6;Boyer;16655.737704918032 05:34:35 INFO - 2015-11-14 05:34:35,866 DEBUG : BROWSER_OUTPUT: |7;RegExp;36781.818181818184 05:34:35 INFO - 2015-11-14 05:34:35,866 DEBUG : BROWSER_OUTPUT: |8;Splay;801.924619085806 05:34:35 INFO - 2015-11-14 05:34:35,866 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7084.507042253521 05:34:35 INFO - 2015-11-14 05:34:35,867 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:34:35 INFO - 2015-11-14 05:34:35,867 DEBUG : BROWSER_OUTPUT: __startTimestamp1447508075863__endTimestamp 05:34:35 INFO - 2015-11-14 05:34:35,867 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,867 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:34:35 INFO - 2015-11-14 05:34:35,867 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:34:35 INFO - 2015-11-14 05:34:35,867 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,868 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:207.68 Median:207.68 stddev:0.00 (0.0%) 05:34:35 INFO - 2015-11-14 05:34:35,868 DEBUG : BROWSER_OUTPUT: Values: 207.7 05:34:35 INFO - 2015-11-14 05:34:35,868 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,868 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:246.06 Median:246.06 stddev:0.00 (0.0%) 05:34:35 INFO - 2015-11-14 05:34:35,868 DEBUG : BROWSER_OUTPUT: Values: 246.1 05:34:35 INFO - 2015-11-14 05:34:35,869 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,869 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:392.93 Median:392.93 stddev:0.00 (0.0%) 05:34:35 INFO - 2015-11-14 05:34:35,869 DEBUG : BROWSER_OUTPUT: Values: 392.9 05:34:35 INFO - 2015-11-14 05:34:35,870 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,870 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7063.38 Median:7063.38 stddev:0.00 (0.0%) 05:34:35 INFO - 2015-11-14 05:34:35,870 DEBUG : BROWSER_OUTPUT: Values: 7063.4 05:34:35 INFO - 2015-11-14 05:34:35,871 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,871 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2590.67 Median:2590.67 stddev:0.00 (0.0%) 05:34:35 INFO - 2015-11-14 05:34:35,871 DEBUG : BROWSER_OUTPUT: Values: 2590.7 05:34:35 INFO - 2015-11-14 05:34:35,871 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,871 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1016.26 Median:1016.26 stddev:0.00 (0.0%) 05:34:35 INFO - 2015-11-14 05:34:35,871 DEBUG : BROWSER_OUTPUT: Values: 1016.3 05:34:35 INFO - 2015-11-14 05:34:35,872 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,872 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16655.74 Median:16655.74 stddev:0.00 (0.0%) 05:34:35 INFO - 2015-11-14 05:34:35,872 DEBUG : BROWSER_OUTPUT: Values: 16655.7 05:34:35 INFO - 2015-11-14 05:34:35,872 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,872 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:36781.82 Median:36781.82 stddev:0.00 (0.0%) 05:34:35 INFO - 2015-11-14 05:34:35,872 DEBUG : BROWSER_OUTPUT: Values: 36781.8 05:34:35 INFO - 2015-11-14 05:34:35,872 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,873 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 05:34:35 INFO - 2015-11-14 05:34:35,873 DEBUG : BROWSER_OUTPUT: Values: 801.9 05:34:35 INFO - 2015-11-14 05:34:35,873 DEBUG : BROWSER_OUTPUT: 05:34:35 INFO - 2015-11-14 05:34:35,873 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7084.51 Median:7084.51 stddev:0.00 (0.0%) 05:34:35 INFO - 2015-11-14 05:34:35,873 DEBUG : BROWSER_OUTPUT: Values: 7084.5 05:34:35 INFO - 2015-11-14 05:34:35,873 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:34:35 INFO - 2015-11-14 05:34:35,873 DEBUG : BROWSER_OUTPUT: 05:34:36 INFO - 2015-11-14 05:34:36,593 INFO : Browser exited with error code: 0 05:34:36 INFO - 2015-11-14 05:34:36,618 INFO : Completed test v8_7 (00:00:39) 05:34:36 INFO - 2015-11-14 05:34:36,661 INFO : Completed test suite (00:20:23) 05:34:36 INFO - 2015-11-14 05:34:36,661 DEBUG : Working with test: dromaeo_css 05:34:36 INFO - 2015-11-14 05:34:36,661 DEBUG : Generating results file: dromaeo_css 05:34:36 INFO - 2015-11-14 05:34:36,662 DEBUG : Working with test: kraken 05:34:36 INFO - 2015-11-14 05:34:36,662 DEBUG : Generating results file: kraken 05:34:36 INFO - 2015-11-14 05:34:36,662 INFO : javascript benchmark 05:34:36 INFO - 2015-11-14 05:34:36,662 DEBUG : Working with test: v8_7 05:34:36 INFO - 2015-11-14 05:34:36,662 DEBUG : Generating results file: v8_7 05:34:36 INFO - 2015-11-14 05:34:36,662 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:36 INFO - 2015-11-14 05:34:36,709 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,55]] 05:34:36 INFO - 2015-11-14 05:34:36,709 DEBUG : process_Request line: dromaeo_css 5272.34 graph.html#tests=[[72,1,55]] 05:34:36 INFO - 2015-11-14 05:34:36,709 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:36 INFO - 2015-11-14 05:34:36,737 DEBUG : process_Request line: kraken 1911.30 graph.html#tests=[[232,1,55]] 05:34:36 INFO - 2015-11-14 05:34:36,737 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:34:36 INFO - 2015-11-14 05:34:36,773 DEBUG : process_Request line: v8_7 14745.88 graph.html#tests=[[230,1,55]] 05:34:36 INFO - 2015-11-14 05:34:36,774 INFO : javascript benchmark 05:34:36 INFO - 2015-11-14 05:34:36,776 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [254.51895916717396, 261.87560908568435, 263.915547024952, 266.33814969800056, 267.36634177000514, 11018.338899666025, 11170.664880053611, 13790.517331893374, 14374.568762937115, 14550.19973901435, 11828.172027958046, 13956.0, 14242.145471271731, 14461.78307325391, 14874.0, 4162.105147393309, 4319.395284660134, 4420.756858372788, 4424.181526417623, 4444.866654000385, 3107.2697915989725, 3113.875444982198, 4288.456155783915, 4357.975875669215, 4626.236670949306, 4620.676552641316, 4657.464391594959, 4675.696079754805, 4707.12918110149, 4740.312654665072, 4437.822487100512, 4635.443746750378, 4670.416197975253, 4688.859334219979, 4689.343491911135, 4093.2427500912127, 4208.263553878059, 4225.260579398624, 4261.744295342259, 4291.206126866539, 17389.652206955918, 17412.825871741374, 17575.73636395455, 17598.208080636403, 17603.73594396085, 1216.2155409760744, 1371.306436550859, 1436.4972259709123, 1462.8390877003521, 1495.723291191133, 7744.41916856238, 7760.534367937942, 7768.961155194244, 7919.604019799044, 7939.682412703485, 1199.4302706214567, 1199.7660456211042, 1207.076586411396, 1240.3054289597853, 1245.850497940253, 47050.76474617605, 47396.76301618505, 47752.28371574429, 48180.759096204645, 49371.25943110856, 5117.744112794346, 5133.922991155136, 5237.816676416307, 5240.34495688039, 5328.307320048447, 5904.586678932434, 5969.015112506388, 5982.641041537521, 5991.340952495222, 5997.220361353084, 4140.585941405896, 4157.5010998679745, 4204.978975105105, 4224.155168966219, 4249.065205654751, 4368.60682538573, 4400.581944715247, 4420.955790442119, 4483.775811209492, 4526.977365113154, 2281.0989659084566, 2352.2002519143575, 2359.657849611797, 2363.4564050268536, 2383.21353953195, 812.2333923716012, 819.8770184472257, 828.0891019878086, 840.0423517190408, 885.6103314541581, 315.20568168215965, 324.847321758773, 331.61367007436064, 345.5059265250665, 352.01611495869105, 9202.585883635253, 9213.401128926598, 9356.625734970525, 9428.245740340757, 9583.281253905985, 317.7600911311945, 350.4078107997476, 380.07831009801123, 380.77153707775113, 381.6221940279159, 4559.498455169929, 4985.850424487271, 5032.647714660012, 5122.026814905156, 5129.358830146231, 394874.64066991623, 421677.0, 425838.0, 441208.0, 448425.0, 56815.0, 60217.698911506035, 60696.696516518015, 62006.37993620096, 62248.68875655683, 365.44817325837647, 368.7695190505934, 369.6654527652479, 369.994450083249, 377.0761633996664, 8572.099929507312, 8685.696000639948, 8801.51591662439, 8997.865032024656, 9015.909840901508, 28211.57682634803, 28267.0, 28617.14148575546, 28993.0, 29357.85321073381, 39494.0, 39602.0, 39930.60069399269, 40429.79785101055, 41136.58863411328, 4801.18379875429, 4849.224124140121, 4901.0, 4906.533879281463, 4967.230079337708, 8897.777555561162, 8914.0, 9380.155785979294, 9491.810163796823, 9584.28117891147, 8156.755297341089, 8169.428140030141, 8201.548914809742, 8204.343652507665, 8253.546054967035, 7729.768106956801, 7801.726939557088, 7841.137474877645, 7848.293653571206, 8057.597120144086, 6779.593224406552, 7916.920830791619, 8168.183181681784, 8287.875681864898, 8409.663613455394, 4439.445069366329, 4499.302608095751, 4691.413573303337, 4853.4418541868135, 4900.0, 7383.15093764224, 7782.883256751266, 7886.408519361185, 8022.9197708022175, 8122.472039317426], "dojo.html": [2495.712993005804, 2518.4333524956887, 2538.4161642822137, 2552.8085393595484, 2571.922842314731, 4157.812898419571, 4245.49054113506, 4263.232618128735, 4328.502222244443, 4331.870043898684, 4166.916661666764, 4191.916161676764, 4241.151769646068, 4343.066240758237, 4373.4314539109955, 3964.2467931093, 3982.0, 3991.5808840071663, 3994.0, 4024.798760062, 3995.1610161866042, 4058.4521089652962, 4092.9386059209137, 4103.9384409233735, 4104.897377565555, 3737.4206997915094, 3739.5699494558066, 3784.735068545203, 3922.0783115967724, 3923.5684074751753, 3991.0621004064024, 4005.2790497710403, 4015.558288588253, 4047.919041619151, 4092.1815636872743, 3926.862559810393, 3930.744501607386, 3981.402789581557, 4005.018770401241, 4061.451704019949, 4030.45588845505, 4118.0, 4145.316022856225, 4257.254980378452, 4261.978690106561, 4484.596386325214, 4528.592426681615, 4538.478075021382, 4594.816207351702, 4638.8608341749805, 4615.746133962664, 4627.259638457865, 4636.837710680144, 4653.930191047137, 4681.204195286809, 4055.7566546007038, 4175.185838761473, 4247.214265360918, 4267.445232119804, 4324.697271190987, 4614.492405835355, 4703.17694403478, 4757.14371413149, 4774.594159496412, 4787.832425865078, 4526.049529598756, 4529.660275479352, 4554.066416384633, 4577.06170235101, 4625.398698169217, 4332.090261045216, 4464.531224221475, 4497.280435130363, 4517.887052823706, 4630.536946305342, 4465.754383508874, 4533.795979180944, 4562.817487300471, 4658.487566367697, 4672.649551283599, 4534.319852022223, 4543.5910768031035, 4551.40831691878, 4571.679982401267, 4580.725156490621, 3452.413089774694, 3507.859685612598, 3512.1921957949303, 3530.4174811156386, 3558.87543935961, 3223.9677603224136, 3251.3172233830687, 3263.0047835409955, 3278.622958359819, 3306.8181250031, 4081.9795901020307, 4224.577542245751, 4253.76604286761, 4270.636995855325, 4291.763952982616, 4617.607503362185, 4677.298405239241, 4680.625549955996, 4720.669553131248, 4774.427068751772, 4211.7472951623, 4386.627136693417, 4402.163588918095, 4446.599806017474, 4447.510773814878, 3975.920481590352, 4011.7793521356607, 4025.6175663311938, 4035.4955630546183, 4117.238310912431, 4731.7634118293945, 4731.787069581946, 4737.620990320697, 4766.213574760195, 4782.37829082224, 4517.051419201873, 4617.422822147231, 4646.86059418218, 4655.604273636779, 4670.392848929618, 4618.053299073749, 4647.535246475325, 4676.485586585405, 4733.431988161443, 4738.4787673356595, 4531.13908357411, 4557.498675145665, 4571.977140114411, 4607.723536587815, 4673.556012178838, 4343.4136391586735, 4439.378487011885, 4667.276572131325, 4669.533046695304, 4695.577398034194, 4249.575042495726, 4339.717918335298, 4357.651387888898, 4484.0, 4528.47922488918, 4470.329450582439, 4514.638828893746, 4516.932246016247, 4545.886352841206, 4547.158775626387, 4183.435236243068, 4397.516273209881, 4415.359772832857, 4444.400005999149, 4470.821167153277, 4342.500612429485, 4440.511543730252, 4454.910901781881, 4458.799354029142, 4530.3883975664185, 4449.866504004885, 4468.486124095641, 4483.820647174207, 4518.299663552155, 4530.501644819134], "mootools.html": [1210.7639010392977, 1291.8514370847352, 1359.6804750883541, 1373.1349249972518, 1462.861028202321, 5574.581906357024, 6027.367126451725, 6098.4511393974535, 6414.422701956823, 6451.354864513546, 6283.371662833714, 6283.528735344845, 6333.55665103443, 6366.490680745529, 6407.967960160193, 1548.2026756220555, 1568.6000069982138, 1727.6285598596298, 1728.9481315560554, 1738.9391371302006, 1558.127448628766, 1721.8536424403878, 1724.6809340272089, 1739.4868513788463, 1745.2757105801077, 1679.4877562343481, 1706.1895599590218, 1713.2119225156443, 1733.0295034780563, 1749.580100775811, 1734.5576877896183, 1738.956526086858, 1748.038578781665, 1754.9473515794546, 1782.0109839039328, 1721.0964243771994, 1762.1805860275033, 1765.8763886527947, 1773.0602780526342, 1785.4286628278956, 6103.633781973052, 6185.41238582334, 6217.222847144107, 6321.462675672573, 6327.46216571592, 3703.777773333609, 3729.291434627412, 3765.6799172070405, 3782.602826703184, 3822.197338558906, 2217.5897458970144, 2234.5642599693065, 2255.819534437241, 2292.0, 2299.7470278269375, 605.0865084617552, 653.8038588423454, 681.6966449929783, 693.6011793218919, 734.4711807498593, 8347.0, 8422.915770842274, 8447.028591711909, 8485.618147183392, 8521.0, 3398.1844357354057, 3419.076849250688, 3438.5186073949667, 3468.6011108722314, 3473.4442489201606, 7366.447516436288, 7408.333250007525, 7425.108986921604, 7513.39892808574, 7518.097828260535, 3810.333191691443, 3825.885223443301, 3851.422286656968, 3863.6715879150024, 3878.166194268246, 3417.1115509967585, 3457.9654203457644, 3531.770434921722, 3534.293141371736, 3554.2536067425613, 2898.434805212963, 2986.89545865898, 2992.1621945855195, 3047.801892876956, 3068.601081859344, 958.836997710391, 966.5843687214565, 970.088117169858, 981.3277904635205, 995.1690338567232, 1052.9052385285208, 1053.3363980692268, 1066.3655125200494, 1068.2468859454066, 1068.4444089073638, 6003.0695242237525, 6066.514678825683, 6086.1175129606845, 6093.817185484442, 6094.329623741385, 335.1637664028265, 335.95296658467834, 336.18978262387526, 339.5365326329542, 341.7471071407141, 4669.789859456333, 4678.812847486062, 4683.648726345469, 4763.476017638057, 4787.4494433140635, 6871.793846184622, 6872.072270243553, 7125.893111603226, 7156.355927966508, 7164.355208031302, 6884.965575172092, 6928.688209030605, 6933.306669333027, 6937.028815965768, 7028.50800443964, 5167.534921856975, 5310.8141215057285, 5399.109146990702, 5517.806876759294, 5684.573656975744, 5551.666899986014, 5778.075507918713, 5823.621464604787, 5939.643621382731, 5959.67221802805, 5895.94104058954, 6058.000429929189, 6538.084668146368, 6589.143411356493, 6821.965890170517, 6453.354664533509, 6792.422644075111, 6893.241743408322, 7005.05431766705, 7070.7525236616475, 5343.305370301991, 5409.377921539073, 5431.049566325798, 5510.311211098613, 5547.278853748987, 5815.76736930518, 5874.853128671817, 5883.764649414146, 5931.911021334769, 5985.221921150222, 5423.213634022965, 5494.505494505353, 5501.0, 5505.504504594605, 5518.944810552004, 5332.360116786011, 5386.165144402624, 5448.83653490396, 5473.233747275305, 5546.500814926676, 4909.3372394727685, 5207.244949482228, 5260.789568417221, 5291.417944026231, 5325.813596524258, 4883.072216278895, 4912.975435122801, 4968.080905032581, 4984.925226121539, 5011.0, 4816.0, 4932.30947667334, 4942.728149951788, 4971.502849715, 4975.353204083446], "ext.html": [442.86492619750976, 447.3178402935523, 456.8309725401602, 458.97705114744264, 480.6347176146128, 24270.0, 24987.25038248851, 25464.434979102916, 31133.84433077837, 31341.529877051864, 33697.831510842414, 33935.83032084842, 34060.318793624174, 34437.48343774845, 34649.30701385977, 7300.817479563027, 7510.887336689927, 7527.397808175333, 7620.08558972924, 7634.923650763504, 6819.727210911557, 6828.829279268009, 6837.555558888681, 7248.927510724904, 8731.301495880314, 8856.291496680282, 8893.866592001094, 8917.375783695144, 8918.509481978488, 9002.909970900273, 8783.47299162046, 8825.51459669718, 8827.16141966512, 8918.777030574223, 8970.327225458117, 6580.14458120446, 6768.458523318122, 6911.516193866431, 8544.61549230286, 9026.833559945566, 31305.0, 31540.211494712585, 31552.0, 31879.84060079708, 31986.840065799523, 2218.179273668753, 2273.897674604647, 2514.8365356251784, 2529.4308780524234, 2785.3593673455016, 22150.55698886013, 22277.220297289678, 22334.979971970777, 22459.0, 22656.207032753773, 1871.3543827379533, 1948.1136083082163, 1959.7452331196853, 1969.045013168612, 1971.6549603819274, 214575.0, 215787.0, 216077.0, 216398.0, 217656.911715442, 44768.0, 44953.55046449559, 44997.0, 45797.77101114473, 45966.540334596895, 45284.0, 45322.32016519755, 45658.0, 49107.263391049164, 53935.0, 11291.604793832177, 11407.0, 11508.59719909799, 11554.0, 11610.651680449431, 8218.096009438957, 8276.213759692819, 8309.95845020783, 8341.165883411732, 8355.456895301786, 15210.859185561127, 15242.161681107646, 15399.61500962485, 15426.074435533905, 15467.922660386626, 6143.447089761943, 6422.454091402283, 6431.13179720741, 6527.477801775846, 6552.0, 726.5241266970143, 730.652939853576, 771.6951804037486, 779.2791667707348, 835.2858306148278, 22470.887645561666, 22938.541229175324, 23033.30900072967, 23170.7682923172, 23187.76812231856, 820.8112134209165, 825.2902503846688, 865.7662431143556, 889.7375274293969, 924.523870206844, 11190.160737944687, 11256.831147532794, 11279.830802537968, 11289.604863829727, 11363.829542556869, 264660.0, 271012.0, 271292.0, 271467.0, 273238.0, 42233.36649950253, 42921.57078429238, 42923.0, 42975.785121074194, 43070.0, 1079.83262594298, 1090.8472813806075, 1094.102835674739, 1096.6545538155456, 1104.7017305327677, 21770.564588708454, 21945.231916882833, 22044.33866983993, 22111.66832497546, 22257.109715611194, 34333.313333733684, 34373.0, 39555.2088958225, 39755.40978360949, 40544.79727601343, 167721.0, 168861.0, 171707.0, 171903.0, 174640.0, 21808.781912180675, 21851.453713657287, 22687.432814179116, 22756.43108922224, 22929.65605515952, 26857.597136043365, 30745.0, 31565.053048408583, 31709.5243571342, 32567.837160814044, 26387.60418593684, 27241.591376128978, 27305.180844574694, 27551.173464796088, 27689.723102768716, 26792.330191744582, 26849.865750671903, 27237.59143612887, 27410.314742131606, 27800.304992375353, 27227.0, 27293.72706272991, 27302.453950920473, 27760.58359124655, 27804.72195278021, 22883.199088031837, 23374.64938025897, 24342.51314973726, 24693.629595556442, 25367.238982830546, 18352.357667481574, 18370.35703750362, 18442.170102345695, 18450.723239151153, 18809.90595047016], "prototype.html": [244.57077828411136, 246.9802415806736, 250.65534889526901, 251.52963957399666, 252.854608600055, 5058.367704036996, 5083.7966481340745, 5110.795568177273, 5117.206832940891, 5160.483951604838, 4883.218685010399, 4984.750762461871, 4987.426445958716, 5070.822521211759, 5071.0, 3774.0942173878207, 3817.1983883384523, 3827.502424684801, 3829.5978922213253, 3836.8848934532007, 3759.097816524028, 3821.5414150302004, 3829.9425508617255, 3834.980825095871, 3837.0407398150464, 3594.19130695594, 3612.1330880588603, 3676.540432445944, 3707.3512135376336, 3711.350513660112, 3732.992092135108, 3764.887053388403, 3772.8868133956025, 3793.127580656451, 3797.3544497435228, 3034.605501284841, 3146.874125034996, 3205.3268813549184, 3226.2418331692033, 3260.3479304139028, 4778.163821331288, 4813.315339631101, 4851.320815085891, 4864.683795553277, 4912.164931961575, 4206.053637931472, 4230.576942305775, 4272.316429371285, 4329.567043295677, 4333.285007973712, 5239.083160446945, 5245.580353571705, 5275.709835959021, 5366.517013468768, 5377.46225377463, 3476.9652303476896, 3478.391281525748, 3555.8933232003083, 3557.5375201223674, 3560.0743806610467, 5220.686758794484, 5507.697076660782, 5595.720213989284, 5606.775728970877, 5610.775568977236, 3428.8285585720614, 3438.8108654024268, 3445.966210136949, 3458.2564748579175, 3503.493497795921, 3488.110531814371, 3494.178867966026, 3543.1496440854526, 3556.324298383299, 3563.1092226943265, 4140.585941405835, 4171.0, 4193.134055345342, 4218.810153543037, 4222.704410691222, 5185.844424667266, 5290.497402746733, 5294.841154765363, 5314.601404894648, 5346.091164502044, 1268.289757735671, 1271.192792576702, 1274.6367285323638, 1276.1131013945405, 1281.7180220351509, 827.4249396669377, 829.1542626520915, 829.5934991853948, 830.9293710034594, 835.0647275051859, 5062.139436295838, 5090.898182036412, 5103.8468845934685, 5175.741212939338, 5177.741112944338, 5464.098423760114, 5474.288342515448, 5500.119980803132, 5555.916661250085, 5585.860353491195, 5060.291559181717, 5068.391792984866, 5071.290019397287, 5151.433342332415, 5171.715555644476, 2911.097559756482, 2944.6319210098736, 2972.346083861547, 2976.4939960206816, 2979.553067039961, 5476.315460567429, 5591.10542313228, 5610.691411972381, 5643.463870932255, 5697.316322041299, 5487.341519017744, 5537.529310008614, 5538.086215774352, 5559.972200138974, 5610.5231055360755, 5596.552275818006, 5614.69119198448, 5642.85892852682, 5725.141228815628, 5819.70901454934, 5504.091824849015, 5513.862153446196, 5519.172124181245, 5594.580406469612, 5638.407967163553, 5226.111561034557, 5423.864403389947, 5455.318085239345, 5493.203485494501, 5509.47659972302, 5641.830745077655, 5669.7165141741925, 5765.7117144141785, 5768.625039372428, 5770.451807078321, 3528.276703275771, 3532.682058614737, 3547.166415892315, 3611.5124458197806, 3629.546306711661, 5486.670799752028, 5489.286392769074, 5563.388027316911, 5571.997040532743, 5595.104783234663, 5138.665986710852, 5315.176147697113, 5337.0, 5385.973070134624, 5391.137418013099, 5354.625176237626, 5364.678119312854, 5423.267858839164, 5434.538064264581, 5471.151971444432, 5205.6356055075785, 5212.635115541876, 5301.416844147064, 5332.68003919766, 5336.119540275811, 5198.766055527586, 5328.09422398201, 5339.946600533945, 5426.186072089218, 5446.237526746179, 5187.533122019036, 5197.688138711689, 5269.077911365573, 5292.232626269247, 5296.0], "yui.html": [476.5496605707606, 555.3141869790808, 599.4964230046766, 603.399617380706, 616.4883146987999, 10441.0, 10938.671839844817, 10941.945290273547, 10950.507227174776, 10969.616063437792, 9323.021082786312, 9692.806143877118, 10105.898941010588, 10316.123129533999, 10361.481925903712, 694.9409300209488, 704.5983789240136, 713.0267185292091, 717.5838013951895, 721.2715157690718, 707.5895980331395, 716.1907045039098, 716.795713221732, 723.2947875821085, 730.0, 702.0872865275147, 730.6127752291294, 736.4329466310937, 745.8172747676799, 747.6710247491113, 732.827785470414, 734.7391675955013, 736.3299397548259, 737.71229220604, 744.2966396755069, 542.2977244468423, 547.8657728856416, 547.9287692599936, 548.0710196217414, 550.5017958747341, 8464.365172612017, 8703.651853925836, 8737.432066915693, 8741.956290218572, 8774.736757897273, 7834.529928204269, 8061.9193808061755, 8103.513789172668, 8517.74446766598, 8592.14078592142, 6976.616286104262, 7013.89479157813, 7153.177384600734, 7210.2789721028, 7349.265073492661, 2605.1403036997744, 2655.3361659585103, 2685.422634133651, 2705.8105932584726, 2793.064323451646, 36679.63320366789, 36911.44632830509, 37582.24835503302, 38956.0, 39464.80267598672, 7149.213586505481, 7258.818529536698, 7549.698012079565, 7561.848763024709, 7652.387808975269, 15120.621984450478, 15310.387584496719, 15347.309371078329, 15410.460633877761, 15545.222738863238, 5395.568354531628, 5402.08164612009, 5486.862828429321, 5634.3802181759975, 5791.131330300489, 2958.763298936123, 3038.9696103039128, 3056.831874246893, 3125.093722820402, 3134.9373012540077, 2340.906363745465, 2382.237683941157, 2392.8564286142887, 2404.0624156578947, 2420.1771397724856, 345.50075141420405, 352.8729657323361, 354.7109106078589, 355.4987467670572, 360.27944111776446, 350.9087637214292, 351.78716876289985, 359.21690714243204, 371.79551246814145, 378.9166383395648, 6074.240719910012, 6324.71538780756, 6651.102101216371, 6860.485463590251, 7039.683214255371, 405.96549293309806, 449.4067830463822, 450.31102413307036, 457.85536159600997, 501.5511117549772, 3049.7560195184333, 3073.416050950312, 3088.320569474712, 3157.67419586557, 3186.2830863056092, 46610.76694616505, 47111.0, 47435.0, 47794.52205477901, 47970.28044579334, 41595.584044159776, 42501.57498425038, 43017.0, 43123.0, 43233.13533729371, 33896.66103338984, 35395.82302088473, 36671.633283667354, 36769.63230367769, 36803.447948280795, 6354.301026887131, 6526.706298216497, 6707.396334329934, 6723.731050757915, 6948.861022779617, 28975.13074607765, 29050.854745726137, 29084.418311634072, 29609.25976850596, 30105.849470752506, 32940.67059329472, 34072.14819629529, 35420.82289588536, 36343.63656363403, 37576.2484750298, 6189.164462797465, 6239.4696450800375, 6276.717547710456, 6310.6213627182515, 6460.741570337133, 8771.824563508566, 8937.0, 8970.254901181013, 9105.226055785068, 9204.355695101278, 8414.284785793276, 8423.957880210559, 8537.060923298308, 8553.82892342162, 8553.914460855312, 8531.402801803813, 8557.743267701979, 8563.529005904486, 8580.65677372898, 8592.226699597066, 8420.452670576393, 8441.66233350659, 8460.069392366959, 8466.788330291793, 8499.235068843835, 6862.965685171542, 6894.207166175754, 6965.686544105629, 7140.964295178491, 7419.295166959346, 7063.71745130189, 7070.116235470567, 7119.822004449723, 7165.605891676008, 7333.266673332838]}, "summary": {"lowerIsBetter": false, "suite": 5272.339056881257, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5494.5252582551575, "unit": "ms", "value": 5494.5252582551575}, "dojo.html": {"lowerIsBetter": false, "filtered": 4243.023473237969, "unit": "ms", "value": 4243.023473237969}, "mootools.html": {"lowerIsBetter": false, "filtered": 3435.8625012029784, "unit": "ms", "value": 3435.8625012029784}, "ext.html": {"lowerIsBetter": false, "filtered": 14316.6091628402, "unit": "ms", "value": 14316.6091628402}, "prototype.html": {"lowerIsBetter": false, "filtered": 3939.033296692529, "unit": "ms", "value": 3939.033296692529}, "yui.html": {"lowerIsBetter": false, "filtered": 4754.483034743135, "unit": "ms", "value": 4754.483034743135}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0059"}, "testrun": {"date": 1447506853, "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": "20151114030404", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}, {"talos_counters": {}, "results": {"audio-dft": [196.0, 208.0, 206.0, 200.0, 198.0, 199.0, 208.0, 207.0, 205.0, 197.0], "ai-astar": [132.0, 133.0, 133.0, 140.0, 138.0, 134.0, 133.0, 133.0, 132.0, 141.0], "imaging-gaussian-blur": [156.0, 148.0, 146.0, 148.0, 156.0, 155.0, 152.0, 141.0, 148.0, 155.0], "audio-beat-detection": [201.0, 164.0, 195.0, 211.0, 163.0, 192.0, 193.0, 162.0, 215.0, 166.0], "json-stringify-tinderbox": [77.0, 80.0, 80.0, 83.0, 86.0, 88.0, 86.0, 86.0, 86.0, 86.0], "stanford-crypto-pbkdf2": [182.0, 198.0, 203.0, 203.0, 190.0, 194.0, 203.0, 201.0, 205.0, 190.0], "json-parse-financial": [67.0, 69.0, 72.0, 71.0, 72.0, 74.0, 75.0, 85.0, 75.0, 74.0], "stanford-crypto-sha256-iterative": [83.0, 88.0, 93.0, 92.0, 93.0, 91.0, 91.0, 88.0, 89.0, 90.0], "audio-fft": [87.0, 100.0, 103.0, 158.0, 85.0, 89.0, 90.0, 91.0, 148.0, 87.0], "imaging-darkroom": [160.0, 162.0, 162.0, 155.0, 162.0, 163.0, 163.0, 162.0, 159.0, 155.0], "stanford-crypto-ccm": [156.0, 160.0, 170.0, 161.0, 170.0, 167.0, 169.0, 157.0, 170.0, 175.0], "audio-oscillator": [122.0, 124.0, 174.0, 115.0, 116.0, 118.0, 163.0, 110.0, 109.0, 159.0], "stanford-crypto-aes": [104.0, 106.0, 113.0, 110.0, 109.0, 109.0, 112.0, 111.0, 113.0, 111.0], "imaging-desaturate": [120.0, 120.0, 120.0, 121.0, 120.0, 130.0, 130.0, 130.0, 120.0, 119.0]}, "summary": {"lowerIsBetter": true, "suite": 1911.3, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 103.8, "unit": "ms", "value": 103.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 196.9, "unit": "ms", "value": 196.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 186.2, "unit": "ms", "value": 186.2}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 165.5, "unit": "ms", "value": 165.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 160.3, "unit": "ms", "value": 160.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 73.4, "unit": "ms", "value": 73.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 131.0, "unit": "ms", "value": 131.0}, "ai-astar": {"lowerIsBetter": true, "filtered": 134.9, "unit": "ms", "value": 134.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 202.4, "unit": "ms", "value": 202.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 89.8, "unit": "ms", "value": 89.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 83.8, "unit": "ms", "value": 83.8}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 150.5, "unit": "ms", "value": 150.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 109.8, "unit": "ms", "value": 109.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 123.0, "unit": "ms", "value": 123.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0059"}, "testrun": {"date": 1447506853, "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": "20151114030404", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}, {"talos_counters": {}, "results": {"DeltaBlue": [246.06299212598427], "Encrypt": [392.92730844793715], "NavierStokes": [7084.507042253521], "Decrypt": [7063.380281690141], "Splay": [801.924619085806], "Richards": [207.68431983385256], "RegExp": [36781.818181818184], "Earley": [1016.260162601626], "Boyer": [16655.737704918032], "RayTrace": [2590.6735751295337]}, "summary": {"lowerIsBetter": false, "suite": 14745.879513906048, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 268.70355199999995, "unit": "score", "value": 268.70355199999995}, "Encrypt": {"lowerIsBetter": false, "filtered": 677.4306449999999, "unit": "score", "value": 677.4306449999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 209.47117296222666, "unit": "score", "value": 209.47117296222666}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.684648055832476, "unit": "score", "value": 37.684648055832476}, "Splay": {"lowerIsBetter": false, "filtered": 101.619277, "unit": "score", "value": 101.619277}, "RegExp": {"lowerIsBetter": false, "filtered": 24.767263964409313, "unit": "score", "value": 24.767263964409313}, "Richards": {"lowerIsBetter": false, "filtered": 169.97913000000003, "unit": "score", "value": 169.97913000000003}, "Earley": {"lowerIsBetter": false, "filtered": 655.799592, "unit": "score", "value": 655.799592}, "Boyer": {"lowerIsBetter": false, "filtered": 40.01401870078742, "unit": "score", "value": 40.01401870078742}, "RayTrace": {"lowerIsBetter": false, "filtered": 285.63575399999996, "unit": "score", "value": 285.63575399999996}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0059"}, "testrun": {"date": 1447506853, "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": "20151114030404", "branch": "Firefox", "revision": "202b199b9fcf37a687bef882f2513e191f079622"}}] 05:34:36 INFO - RETURN: dromaeo_css: 5272.34 05:34:36 INFO - RETURN: kraken: 1911.30 05:34:36 INFO - RETURN: v8_7: 14745.88 05:34:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,55]]", "result": "14745.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,55]]", "result": "1911.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,55]]", "result": "5272.34"}}} 05:34:36 INFO - Return code: 0 05:34:36 INFO - # TBPL SUCCESS # 05:34:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:34:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:34:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:34:36 INFO - 2015-11-14 05:34:36.915 screenresolution[5930:106245] starting screenresolution argv=screenresolution get 05:34:36 INFO - 2015-11-14 05:34:36.919 screenresolution[5930:106245] Display 0: 1600x1200x32@60 05:34:36 INFO - 2015-11-14 05:34:36.926 screenresolution[5931:106249] starting screenresolution argv=screenresolution list 05:34:36 INFO - Available Modes on Display 0 05:34:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:34:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:34:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:34:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:34:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:34:37 INFO - Intel HD Graphics 3000: 05:34:37 INFO - Chipset Model: Intel HD Graphics 3000 05:34:37 INFO - Type: GPU 05:34:37 INFO - Bus: Built-In 05:34:37 INFO - VRAM (Total): 512 MB 05:34:37 INFO - VRAM (Dynamic, Max): 10 05:34:37 INFO - Vendor: Intel (0x8086) 05:34:37 INFO - Device ID: 0x0116 05:34:37 INFO - Revision ID: 0x0009 05:34:37 INFO - Displays: 05:34:37 INFO - Display: 05:34:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:34:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:34:37 INFO - Display Serial Number: 1600x1200 60 05:34:37 INFO - Main Display: Yes 05:34:37 INFO - Mirror: Off 05:34:37 INFO - Online: Yes 05:34:37 INFO - Rotation: Supported 05:34:37 INFO - Return code: 0 05:34:37 INFO - Running post-action listener: _resource_record_post_action 05:34:37 INFO - Running post-run listener: _resource_record_post_run 05:34:38 INFO - Total resource usage - Wall time: 1268s; CPU: 30.0%; Read bytes: 8836096; Write bytes: 684518400; Read time: 3143; Write time: 59828 05:34:38 INFO - install - Wall time: 44s; CPU: 30.0%; Read bytes: 340818432; Write bytes: 335820800; Read time: 39162; Write time: 4980 05:34:38 INFO - run-tests - Wall time: 1225s; CPU: 30.0%; Read bytes: 7844864; Write bytes: 338334720; Read time: 3022; Write time: 53990 05:34:38 INFO - Running post-run listener: _upload_blobber_files 05:34:38 INFO - Blob upload gear active. 05:34:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:34:38 INFO - Copying logs to upload dir... 05:34:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1324.479541 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2015-11-14 05:34:38.402539) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 05:34:38.405721) ========= 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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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/aPTj2c3WQSOjwP_30wV6RQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010637 build_url: 'https://queue.taskcluster.net/v1/task/aPTj2c3WQSOjwP_30wV6RQ/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-14 05:34:38.437338) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:34:38.437721) ========= 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.KCbK0K4zyt/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.rTTVJxLTRY/Listeners TMPDIR=/var/folders/08/1phn45pd11bdbfk1kgcr6t8r00000w/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.005815 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 05:34:38.491557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 05:34:38.492245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 05:34:38.492754) ========= ========= Total master_lag: 0.27 =========