builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0031 starttime: 1447766335.45 results: success (0) buildid: 20151117031105 builduid: 6b125f933217436bbd304c483daa3de1 revision: 0e3b216c93f698f295e42910f442df42616fe003 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.452043) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.452673) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.453063) ========= 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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.006143 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.484855) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.485329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.506320) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.506708) ========= 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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.005588 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.560260) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.560688) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.561234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.561600) ========= 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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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-17 05:18:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-17 05:18:55 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157732 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.742855) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.743362) ========= 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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.021551 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.800001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:55.800529) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0e3b216c93f698f295e42910f442df42616fe003 --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 0e3b216c93f698f295e42910f442df42616fe003 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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-17 05:18:55,885 truncating revision to first 12 chars 2015-11-17 05:18:55,885 Setting DEBUG logging. 2015-11-17 05:18:55,885 attempt 1/10 2015-11-17 05:18:55,885 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0e3b216c93f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 05:18:56,460 unpacking tar archive at: mozilla-central-0e3b216c93f6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.844390 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:56.667317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:56.667755) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:56.685671) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:56.686046) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 05:18:56.686600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-11-17 05:18:56.686969) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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:18:56 INFO - MultiFileLogger online at 20151117 05:18:56 in /builds/slave/test 05:18:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:18:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:18:56 INFO - {'append_to_log': False, 05:18:56 INFO - 'base_work_dir': '/builds/slave/test', 05:18:56 INFO - 'blob_upload_branch': 'Firefox', 05:18:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:18:56 INFO - 'branch': 'Firefox', 05:18:56 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:56 INFO - 'config_files': ('talos/mac_config.py',), 05:18:56 INFO - 'default_actions': ('clobber', 05:18:56 INFO - 'read-buildbot-config', 05:18:56 INFO - 'download-and-extract', 05:18:56 INFO - 'populate-webroot', 05:18:56 INFO - 'create-virtualenv', 05:18:56 INFO - 'install', 05:18:56 INFO - 'run-tests'), 05:18:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:56 INFO - 'download_minidump_stackwalk': True, 05:18:56 INFO - 'download_symbols': 'ondemand', 05:18:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:56 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:56 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:56 INFO - 'installer_path': 'installer.exe', 05:18:56 INFO - 'log_level': 'info', 05:18:56 INFO - 'log_name': 'talos', 05:18:56 INFO - 'log_to_console': True, 05:18:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:18:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:18:56 INFO - 'opt_config_files': (), 05:18:56 INFO - 'pip_index': False, 05:18:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:18:56 INFO - 'cmd': ('bash', 05:18:56 INFO - '-c', 05:18:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:18:56 INFO - 'enabled': True, 05:18:56 INFO - 'halt_on_failure': False, 05:18:56 INFO - 'name': 'check_screen_resolution'},), 05:18:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:18:56 INFO - 'cmd': ('bash', 05:18:56 INFO - '-c', 05:18:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:18:56 INFO - 'enabled': True, 05:18:56 INFO - 'halt_on_failure': False, 05:18:56 INFO - 'name': 'check_screen_resolution'},), 05:18:56 INFO - 'run_cmd_checks_enabled': True, 05:18:56 INFO - 'sps_profile': False, 05:18:56 INFO - 'sps_profile_interval': 0, 05:18:56 INFO - 'suite': 'dromaeojs-e10s', 05:18:56 INFO - 'system_bits': '64', 05:18:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:56 INFO - 'title': 't-yosemite-r5-0031', 05:18:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:56 INFO - 'use_talos_json': True, 05:18:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:18:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:56 INFO - 'work_dir': 'build'} 05:18:56 INFO - ##### 05:18:56 INFO - ##### Running clobber step. 05:18:56 INFO - ##### 05:18:56 INFO - Running pre-action listener: _resource_record_pre_action 05:18:56 INFO - Running main action method: clobber 05:18:56 INFO - rmtree: /builds/slave/test/build 05:18:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:18:59 INFO - Running post-action listener: _resource_record_post_action 05:18:59 INFO - ##### 05:18:59 INFO - ##### Running read-buildbot-config step. 05:18:59 INFO - ##### 05:18:59 INFO - Running pre-action listener: _resource_record_pre_action 05:18:59 INFO - Running main action method: read_buildbot_config 05:18:59 INFO - Using buildbot properties: 05:18:59 INFO - { 05:18:59 INFO - "properties": { 05:18:59 INFO - "buildnumber": 18, 05:18:59 INFO - "product": "firefox", 05:18:59 INFO - "script_repo_revision": "production", 05:18:59 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 05:18:59 INFO - "repository": "", 05:18:59 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 05:18:59 INFO - "buildid": "20151117031105", 05:18:59 INFO - "slavename": "t-yosemite-r5-0031", 05:18:59 INFO - "pgo_build": "False", 05:18:59 INFO - "basedir": "/builds/slave/test", 05:18:59 INFO - "project": "", 05:18:59 INFO - "platform": "yosemite", 05:18:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:18:59 INFO - "slavebuilddir": "test", 05:18:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:18:59 INFO - "branch": "mozilla-central", 05:18:59 INFO - "repo_path": "mozilla-central", 05:18:59 INFO - "stage_platform": "macosx64", 05:18:59 INFO - "builduid": "6b125f933217436bbd304c483daa3de1", 05:18:59 INFO - "revision": "0e3b216c93f698f295e42910f442df42616fe003" 05:18:59 INFO - }, 05:18:59 INFO - "sourcestamp": { 05:18:59 INFO - "repository": "", 05:18:59 INFO - "hasPatch": false, 05:18:59 INFO - "project": "", 05:18:59 INFO - "branch": "mozilla-central-macosx64-talos", 05:18:59 INFO - "changes": [ 05:18:59 INFO - { 05:18:59 INFO - "category": null, 05:18:59 INFO - "files": [ 05:18:59 INFO - { 05:18:59 INFO - "url": null, 05:18:59 INFO - "name": "https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:18:59 INFO - } 05:18:59 INFO - ], 05:18:59 INFO - "repository": "", 05:18:59 INFO - "rev": "0e3b216c93f698f295e42910f442df42616fe003", 05:18:59 INFO - "who": "cbook@mozilla.com", 05:18:59 INFO - "when": 1447765290, 05:18:59 INFO - "number": 6671637, 05:18:59 INFO - "comments": "merge fx-team to mozilla-central a=merge", 05:18:59 INFO - "project": "", 05:18:59 INFO - "at": "Tue 17 Nov 2015 05:01:30", 05:18:59 INFO - "branch": "mozilla-central-macosx64-talos", 05:18:59 INFO - "revlink": "", 05:18:59 INFO - "properties": [ 05:18:59 INFO - [ 05:18:59 INFO - "buildid", 05:18:59 INFO - "20151117031105", 05:18:59 INFO - "Change" 05:18:59 INFO - ], 05:18:59 INFO - [ 05:18:59 INFO - "builduid", 05:18:59 INFO - "6b125f933217436bbd304c483daa3de1", 05:18:59 INFO - "Change" 05:18:59 INFO - ], 05:18:59 INFO - [ 05:18:59 INFO - "pgo_build", 05:18:59 INFO - "False", 05:18:59 INFO - "Change" 05:18:59 INFO - ] 05:18:59 INFO - ], 05:18:59 INFO - "revision": "0e3b216c93f698f295e42910f442df42616fe003" 05:18:59 INFO - } 05:18:59 INFO - ], 05:18:59 INFO - "revision": "0e3b216c93f698f295e42910f442df42616fe003" 05:18:59 INFO - } 05:18:59 INFO - } 05:18:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:18:59 INFO - Running post-action listener: _resource_record_post_action 05:18:59 INFO - ##### 05:18:59 INFO - ##### Running download-and-extract step. 05:18:59 INFO - ##### 05:18:59 INFO - Running pre-action listener: _resource_record_pre_action 05:18:59 INFO - Running main action method: download_and_extract 05:18:59 INFO - mkdir: /builds/slave/test/build/tests 05:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:59 INFO - https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:18:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/test_packages.json 05:18:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/test_packages.json 05:18:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:18:59 INFO - Downloaded 1149 bytes. 05:18:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:18:59 INFO - Using the following test package requirements: 05:18:59 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:18:59 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:59 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:18:59 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:59 INFO - u'jsshell-mac.zip'], 05:18:59 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:59 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:18:59 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:18:59 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:59 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:18:59 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:59 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:18:59 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:59 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:18:59 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:18:59 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:18:59 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:18:59 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:59 INFO - https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:18:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:18:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:18:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/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:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/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:19:00 INFO - Downloaded 17460727 bytes. 05:19:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:19:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:19:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:19:06 INFO - Return code: 0 05:19:06 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:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:06 INFO - https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:19:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:19:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:19:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/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:19:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/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:19:07 INFO - Downloaded 17460727 bytes. 05:19:07 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:19:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:19:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:19:13 INFO - Return code: 0 05:19: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:19:13 INFO - https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:19:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:19:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:19:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/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:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/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:19:14 INFO - Downloaded 11131693 bytes. 05:19:14 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:19:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:19:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:19:14 INFO - Return code: 0 05:19:14 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:19:14 INFO - https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:19:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:19:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:19:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:19:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/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:19:18 INFO - Downloaded 108783660 bytes. 05:19:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:19:18 INFO - mkdir: /builds/slave/test/properties 05:19:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:19:18 INFO - Writing to file /builds/slave/test/properties/build_url 05:19:18 INFO - Contents: 05:19:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:19:18 INFO - Running post-action listener: _resource_record_post_action 05:19:18 INFO - Running post-action listener: set_extra_try_arguments 05:19:18 INFO - ##### 05:19:18 INFO - ##### Running populate-webroot step. 05:19:18 INFO - ##### 05:19:18 INFO - Running pre-action listener: _resource_record_pre_action 05:19:18 INFO - Running main action method: populate_webroot 05:19:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:19:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:19:18 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:19:18 INFO - '../fennec_ids.txt'], 05:19:18 INFO - 'tests': ['tcheck2']}, 05:19:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:19:18 INFO - '--tppagecycles', 05:19:18 INFO - '7'], 05:19:18 INFO - 'tests': ['tsvgm']}}, 05:19:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:19:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:19:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:19:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:19:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:19:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:19:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:18 INFO - 'talos_options': ['--e10s'], 05:19:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:18 INFO - 'tests': ['damp', 'tps']}, 05:19:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:18 INFO - 'talos_options': ['--e10s'], 05:19:18 INFO - 'tests': ['damp', 'tps']}, 05:19:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:19:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:19:18 INFO - 'other': {'tests': ['a11yr', 05:19:18 INFO - 'ts_paint', 05:19:18 INFO - 'tpaint', 05:19:18 INFO - 'sessionrestore', 05:19:18 INFO - 'sessionrestore_no_auto_restore']}, 05:19:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:19:18 INFO - 'tests': ['a11yr', 05:19:18 INFO - 'ts_paint', 05:19:18 INFO - 'tpaint', 05:19:18 INFO - 'sessionrestore', 05:19:18 INFO - 'sessionrestore_no_auto_restore']}, 05:19:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:19:18 INFO - 'tests': ['a11yr', 05:19:18 INFO - 'ts_paint', 05:19:18 INFO - 'tpaint', 05:19:18 INFO - 'sessionrestore', 05:19:18 INFO - 'sessionrestore_no_auto_restore']}, 05:19:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:19:18 INFO - 'tests': ['a11yr', 05:19:18 INFO - 'ts_paint', 05:19:18 INFO - 'tpaint', 05:19:18 INFO - 'sessionrestore', 05:19:18 INFO - 'sessionrestore_no_auto_restore']}, 05:19:18 INFO - 'other_l64': {'tests': ['a11yr', 05:19:18 INFO - 'ts_paint', 05:19:18 INFO - 'tpaint', 05:19:18 INFO - 'sessionrestore', 05:19:18 INFO - 'sessionrestore_no_auto_restore']}, 05:19:18 INFO - 'other_nol64': {'tests': ['a11yr', 05:19:18 INFO - 'ts_paint', 05:19:18 INFO - 'tpaint', 05:19:18 INFO - 'sessionrestore', 05:19:18 INFO - 'sessionrestore_no_auto_restore']}, 05:19:18 INFO - 'svgr': {'tests': ['tsvgx', 05:19:18 INFO - 'tsvgr_opacity', 05:19:18 INFO - 'tart', 05:19:18 INFO - 'tscrollx', 05:19:18 INFO - 'cart']}, 05:19:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:19:18 INFO - 'tests': ['tsvgx', 05:19:18 INFO - 'tsvgr_opacity', 05:19:18 INFO - 'tart', 05:19:18 INFO - 'tscrollx', 05:19:18 INFO - 'cart']}, 05:19:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:18 INFO - 'tests': ['tp5o']}, 05:19:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:18 INFO - 'talos_options': ['--e10s'], 05:19:18 INFO - 'tests': ['tp5o']}, 05:19:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:18 INFO - 'talos_options': ['--xperf_path', 05:19:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:18 INFO - 'tests': ['tp5n']}, 05:19:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:18 INFO - 'talos_options': ['--e10s', 05:19:18 INFO - '--xperf_path', 05:19:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:18 INFO - 'tests': ['tp5n']}}, 05:19:18 INFO - 'talos.zip': {'path': '', 05:19:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:19:18 INFO - Running post-action listener: _resource_record_post_action 05:19:18 INFO - ##### 05:19:18 INFO - ##### Running create-virtualenv step. 05:19:18 INFO - ##### 05:19:18 INFO - Running pre-action listener: _resource_record_pre_action 05:19:18 INFO - Running main action method: create_virtualenv 05:19:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:19:18 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:19:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:19:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:19:18 INFO - Using real prefix '/tools/python27' 05:19:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:19:19 INFO - Installing distribute.............................................................................................................................................................................................done. 05:19:23 INFO - Installing pip.................done. 05:19:23 INFO - Return code: 0 05:19:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105271228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedc2d14df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051b79f0>, '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 0x104f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051ab8c8>, '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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81ZYy3ZuNQ/Render', 05:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:23 INFO - 'HOME': '/Users/cltbld', 05:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:23 INFO - 'LOGNAME': 'cltbld', 05:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:23 INFO - 'MOZ_NO_REMOTE': '1', 05:19:23 INFO - 'NO_EM_RESTART': '1', 05:19:23 INFO - 'PAGER': '/bin/cat', 05:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:23 INFO - 'PWD': '/builds/slave/test', 05:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:23 INFO - 'SHELL': '/bin/bash', 05:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L6Ja0bf10P/Listeners', 05:19:23 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 05:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:23 INFO - 'USER': 'cltbld', 05:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:23 INFO - 'XPC_FLAGS': '0x0', 05:19:23 INFO - 'XPC_SERVICE_NAME': '0', 05:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:23 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:19:23 INFO - Cleaning up... 05:19:23 INFO - Return code: 0 05:19:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105271228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedc2d14df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051b79f0>, '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 0x104f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051ab8c8>, '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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81ZYy3ZuNQ/Render', 05:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:23 INFO - 'HOME': '/Users/cltbld', 05:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:23 INFO - 'LOGNAME': 'cltbld', 05:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:23 INFO - 'MOZ_NO_REMOTE': '1', 05:19:23 INFO - 'NO_EM_RESTART': '1', 05:19:23 INFO - 'PAGER': '/bin/cat', 05:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:23 INFO - 'PWD': '/builds/slave/test', 05:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:23 INFO - 'SHELL': '/bin/bash', 05:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L6Ja0bf10P/Listeners', 05:19:23 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 05:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:23 INFO - 'USER': 'cltbld', 05:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:23 INFO - 'XPC_FLAGS': '0x0', 05:19:23 INFO - 'XPC_SERVICE_NAME': '0', 05:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:24 INFO - Downloading/unpacking psutil>=0.7.1 05:19: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:19: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:19: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:19: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:19: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:19: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:19:26 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:19:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:19:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:26 INFO - Installing collected packages: psutil 05:19:26 INFO - Running setup.py install for psutil 05:19:27 INFO - building 'psutil._psutil_osx' extension 05:19:27 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:19:27 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:19:27 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:19:27 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:19:27 INFO - building 'psutil._psutil_posix' extension 05:19:27 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:19:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:19:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:19:27 INFO - ^ 05:19:27 INFO - 1 warning generated. 05:19:27 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:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:19:28 INFO - Successfully installed psutil 05:19:28 INFO - Cleaning up... 05:19:28 INFO - Return code: 0 05:19:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:19:28 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:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:28 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:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:28 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 0x105294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105271228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedc2d14df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051b79f0>, '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 0x104f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051ab8c8>, '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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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:19:28 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:19:28 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:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81ZYy3ZuNQ/Render', 05:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:28 INFO - 'HOME': '/Users/cltbld', 05:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:28 INFO - 'LOGNAME': 'cltbld', 05:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:28 INFO - 'MOZ_NO_REMOTE': '1', 05:19:28 INFO - 'NO_EM_RESTART': '1', 05:19:28 INFO - 'PAGER': '/bin/cat', 05:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:28 INFO - 'PWD': '/builds/slave/test', 05:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:28 INFO - 'SHELL': '/bin/bash', 05:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L6Ja0bf10P/Listeners', 05:19:28 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 05:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:28 INFO - 'USER': 'cltbld', 05:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:28 INFO - 'XPC_FLAGS': '0x0', 05:19:28 INFO - 'XPC_SERVICE_NAME': '0', 05:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:19:28 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:19:28 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:19:28 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:19:28 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:19:28 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:19:28 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:19:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:19:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:19:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:19:31 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:19:31 INFO - Installing collected packages: mozsystemmonitor 05:19:31 INFO - Running setup.py install for mozsystemmonitor 05:19:31 INFO - Successfully installed mozsystemmonitor 05:19:31 INFO - Cleaning up... 05:19:31 INFO - Return code: 0 05:19:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:19:31 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:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:31 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:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:31 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 0x105294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105271228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedc2d14df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051b79f0>, '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 0x104f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051ab8c8>, '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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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:19:31 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:19:31 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:19:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81ZYy3ZuNQ/Render', 05:19:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:31 INFO - 'HOME': '/Users/cltbld', 05:19:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:31 INFO - 'LOGNAME': 'cltbld', 05:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:31 INFO - 'MOZ_NO_REMOTE': '1', 05:19:31 INFO - 'NO_EM_RESTART': '1', 05:19:31 INFO - 'PAGER': '/bin/cat', 05:19:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:31 INFO - 'PWD': '/builds/slave/test', 05:19:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:31 INFO - 'SHELL': '/bin/bash', 05:19:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L6Ja0bf10P/Listeners', 05:19:31 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 05:19:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:31 INFO - 'USER': 'cltbld', 05:19:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:31 INFO - 'XPC_FLAGS': '0x0', 05:19:31 INFO - 'XPC_SERVICE_NAME': '0', 05:19:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:31 INFO - Downloading/unpacking blobuploader==1.2.4 05:19:31 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:19:31 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:19:31 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:19:31 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:19:31 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:19:31 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:19:34 INFO - Downloading blobuploader-1.2.4.tar.gz 05:19:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:19:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:19:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:35 INFO - Downloading docopt-0.6.1.tar.gz 05:19:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:19:35 INFO - Installing collected packages: blobuploader, requests, docopt 05:19:35 INFO - Running setup.py install for blobuploader 05:19:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:19:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:19:35 INFO - Running setup.py install for requests 05:19:36 INFO - Running setup.py install for docopt 05:19:36 INFO - Successfully installed blobuploader requests docopt 05:19:36 INFO - Cleaning up... 05:19:36 INFO - Return code: 0 05:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:36 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:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:36 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:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:36 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 0x105294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105271228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedc2d14df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051b79f0>, '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 0x104f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051ab8c8>, '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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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:19:36 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:19:36 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:19:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81ZYy3ZuNQ/Render', 05:19:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:36 INFO - 'HOME': '/Users/cltbld', 05:19:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:36 INFO - 'LOGNAME': 'cltbld', 05:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:36 INFO - 'MOZ_NO_REMOTE': '1', 05:19:36 INFO - 'NO_EM_RESTART': '1', 05:19:36 INFO - 'PAGER': '/bin/cat', 05:19:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:36 INFO - 'PWD': '/builds/slave/test', 05:19:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:36 INFO - 'SHELL': '/bin/bash', 05:19:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L6Ja0bf10P/Listeners', 05:19:36 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 05:19:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:36 INFO - 'USER': 'cltbld', 05:19:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:36 INFO - 'XPC_FLAGS': '0x0', 05:19:36 INFO - 'XPC_SERVICE_NAME': '0', 05:19:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-zjrNCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-rNZEl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-2zq3SJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-3G2P39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-FFw3cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-xN1JYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-6O7fd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:37 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-7tEzXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-XkzGQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-iHgads-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-jXfSie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-wZc7ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-ILwon0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-LEt6jY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:38 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-ixWfc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:39 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-bT9a_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:39 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-zuWlIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:19:39 INFO - Running setup.py install for manifestparser 05:19:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:19:39 INFO - Running setup.py install for mozcrash 05:19:39 INFO - Running setup.py install for mozdebug 05:19:39 INFO - Running setup.py install for mozdevice 05:19:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:19:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:19:40 INFO - Running setup.py install for mozfile 05:19:40 INFO - Running setup.py install for mozhttpd 05:19:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:19:40 INFO - Running setup.py install for mozinfo 05:19:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:19:40 INFO - Running setup.py install for mozInstall 05:19:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:19:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:19:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:19:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:19:40 INFO - Running setup.py install for mozleak 05:19:40 INFO - Running setup.py install for mozlog 05:19:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:19:41 INFO - Running setup.py install for moznetwork 05:19:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:19:41 INFO - Running setup.py install for mozprocess 05:19:41 INFO - Running setup.py install for mozprofile 05:19:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:19:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:19:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:19:41 INFO - Running setup.py install for mozrunner 05:19:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:19:41 INFO - Running setup.py install for mozscreenshot 05:19:42 INFO - Running setup.py install for moztest 05:19:42 INFO - Running setup.py install for mozversion 05:19:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:19:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:19:42 INFO - Cleaning up... 05:19:42 INFO - Return code: 0 05:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19: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:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19: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:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:42 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 0x105294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105271228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedc2d14df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051b79f0>, '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 0x104f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051ab8c8>, '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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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:19:42 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:19:42 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:19:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81ZYy3ZuNQ/Render', 05:19:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:42 INFO - 'HOME': '/Users/cltbld', 05:19:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:42 INFO - 'LOGNAME': 'cltbld', 05:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:42 INFO - 'MOZ_NO_REMOTE': '1', 05:19:42 INFO - 'NO_EM_RESTART': '1', 05:19:42 INFO - 'PAGER': '/bin/cat', 05:19:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:42 INFO - 'PWD': '/builds/slave/test', 05:19:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:42 INFO - 'SHELL': '/bin/bash', 05:19:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L6Ja0bf10P/Listeners', 05:19:42 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 05:19:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:42 INFO - 'USER': 'cltbld', 05:19:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:42 INFO - 'XPC_FLAGS': '0x0', 05:19:42 INFO - 'XPC_SERVICE_NAME': '0', 05:19:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:19:42 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-CzpTKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:19:43 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:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:19:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-j_faR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:19:43 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:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:19:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-M8DIWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:19:43 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:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:19:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-qL1lvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:19:43 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:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:19:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-m2FNHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:19:43 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:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:19:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-eYfSaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:19:43 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:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:19:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-jU8Xbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:19:43 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:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:19:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-NvuWkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:19:43 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:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:19:43 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-yU4gvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:19:44 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:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:19:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-F7bLjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:19:44 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:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:19:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-j03INC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:19:44 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:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:19:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-Xhnx9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:19:44 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:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:19:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-qbWrqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:19:44 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:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:19:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-SZGVjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:19:44 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:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-9F53nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:19:44 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:19:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:19:44 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-e_qNTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:19:45 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:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:19:45 INFO - Running setup.py (path:/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/pip-m1U55l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:19:45 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:19:45 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:19:45 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:19:45 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:19:45 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:19:45 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:19:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:19:45 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:19:45 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:19:45 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:19:45 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:19:45 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:19:45 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:19:47 INFO - Downloading blessings-1.5.1.tar.gz 05:19:47 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:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:19:47 INFO - Installing collected packages: blessings 05:19:47 INFO - Running setup.py install for blessings 05:19:48 INFO - Successfully installed blessings 05:19:48 INFO - Cleaning up... 05:19:48 INFO - Return code: 0 05:19:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:19:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:48 INFO - Reading from file tmpfile_stdout 05:19:48 INFO - Current package versions: 05:19:48 INFO - blessings == 1.5.1 05:19:48 INFO - blobuploader == 1.2.4 05:19:48 INFO - docopt == 0.6.1 05:19:48 INFO - manifestparser == 1.1 05:19:48 INFO - mozInstall == 1.12 05:19:48 INFO - mozcrash == 0.16 05:19:48 INFO - mozdebug == 0.1 05:19:48 INFO - mozdevice == 0.47 05:19:48 INFO - mozfile == 1.2 05:19:48 INFO - mozhttpd == 0.7 05:19:48 INFO - mozinfo == 0.9 05:19:48 INFO - mozleak == 0.1 05:19:48 INFO - mozlog == 3.0 05:19:48 INFO - moznetwork == 0.27 05:19:48 INFO - mozprocess == 0.22 05:19:48 INFO - mozprofile == 0.27 05:19:48 INFO - mozrunner == 6.11 05:19:48 INFO - mozscreenshot == 0.1 05:19:48 INFO - mozsystemmonitor == 0.0 05:19:48 INFO - moztest == 0.7 05:19:48 INFO - mozversion == 1.4 05:19:48 INFO - psutil == 3.1.1 05:19:48 INFO - requests == 1.2.3 05:19:48 INFO - wsgiref == 0.1.2 05:19:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:48 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 0x105294490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105271228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedc2d14df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051b79f0>, '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 0x104f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051ab8c8>, '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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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:19:48 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:19:48 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:19:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81ZYy3ZuNQ/Render', 05:19:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:48 INFO - 'HOME': '/Users/cltbld', 05:19:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:48 INFO - 'LOGNAME': 'cltbld', 05:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:48 INFO - 'MOZ_NO_REMOTE': '1', 05:19:48 INFO - 'NO_EM_RESTART': '1', 05:19:48 INFO - 'PAGER': '/bin/cat', 05:19:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:48 INFO - 'PWD': '/builds/slave/test', 05:19:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:48 INFO - 'SHELL': '/bin/bash', 05:19:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L6Ja0bf10P/Listeners', 05:19:48 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 05:19:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:48 INFO - 'USER': 'cltbld', 05:19:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:48 INFO - 'XPC_FLAGS': '0x0', 05:19:48 INFO - 'XPC_SERVICE_NAME': '0', 05:19:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 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:19:48 INFO - Cleaning up... 05:19:48 INFO - Return code: 0 05:19:48 INFO - Running post-action listener: _resource_record_post_action 05:19:48 INFO - Running post-action listener: _start_resource_monitoring 05:19:48 INFO - Starting resource monitoring. 05:19:48 INFO - ##### 05:19:48 INFO - ##### Running install step. 05:19:48 INFO - ##### 05:19:48 INFO - Running pre-action listener: _resource_record_pre_action 05:19:48 INFO - Running main action method: install 05:19:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:49 INFO - Reading from file tmpfile_stdout 05:19:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:19:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:19:49 INFO - Reading from file tmpfile_stdout 05:19:49 INFO - Output received: 05:19:49 INFO - Usage: mozinstall [options] installer 05:19:49 INFO - Options: 05:19:49 INFO - -h, --help show this help message and exit 05:19:49 INFO - -d DEST, --destination=DEST 05:19:49 INFO - Directory to install application into. [default: 05:19:49 INFO - "/builds/slave/test"] 05:19:49 INFO - --app=APP Application being installed. [default: firefox] 05:19:49 INFO - mkdir: /builds/slave/test/build/application 05:19:49 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:19:49 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:20:30 INFO - Reading from file tmpfile_stdout 05:20:30 INFO - Output received: 05:20:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:20:30 INFO - Running post-action listener: _resource_record_post_action 05:20:30 INFO - ##### 05:20:30 INFO - ##### Running run-tests step. 05:20:30 INFO - ##### 05:20:30 INFO - Running pre-action listener: _resource_record_pre_action 05:20:30 INFO - Running main action method: run_tests 05:20:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:20:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:20:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:20:30 INFO - 2015-11-17 05:20:30.159 screenresolution[1909:11136] starting screenresolution argv=screenresolution get 05:20:30 INFO - 2015-11-17 05:20:30.162 screenresolution[1909:11136] Display 0: 1600x1200x32@60 05:20:30 INFO - 2015-11-17 05:20:30.169 screenresolution[1910:11138] starting screenresolution argv=screenresolution list 05:20:30 INFO - Available Modes on Display 0 05:20:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:20:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:20:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:20:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:20:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:20:30 INFO - Intel HD Graphics 3000: 05:20:30 INFO - Chipset Model: Intel HD Graphics 3000 05:20:30 INFO - Type: GPU 05:20:30 INFO - Bus: Built-In 05:20:30 INFO - VRAM (Total): 512 MB 05:20:30 INFO - VRAM (Dynamic, Max): 10 05:20:30 INFO - Vendor: Intel (0x8086) 05:20:30 INFO - Device ID: 0x0116 05:20:30 INFO - Revision ID: 0x0009 05:20:30 INFO - Displays: 05:20:30 INFO - Display: 05:20:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:20:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:20:30 INFO - Display Serial Number: 1600x1200 60 05:20:30 INFO - Main Display: Yes 05:20:30 INFO - Mirror: Off 05:20:30 INFO - Online: Yes 05:20:30 INFO - Rotation: Supported 05:20:30 INFO - Return code: 0 05:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:30 INFO - Python 2.7.3 05:20:30 INFO - Return code: 0 05:20:30 INFO - grabbing minidump binary from tooltool 05:20:30 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:20:30 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 0x1051b79f0>, '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 0x104f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051ab8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:30 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:20:30 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:20:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:30 INFO - Return code: 0 05:20:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:20:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:20:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:30 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0031', '--webServer', 'localhost'] in /builds/slave/test/build 05:20:30 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0031 --webServer localhost 05:20:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.81ZYy3ZuNQ/Render', 05:20:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:20:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:20:30 INFO - 'HOME': '/Users/cltbld', 05:20:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:20:30 INFO - 'LOGNAME': 'cltbld', 05:20:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:30 INFO - 'MOZ_NO_REMOTE': '1', 05:20:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:30 INFO - 'NO_EM_RESTART': '1', 05:20:30 INFO - 'PAGER': '/bin/cat', 05:20:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:30 INFO - 'PWD': '/builds/slave/test', 05:20:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:20:30 INFO - 'SHELL': '/bin/bash', 05:20:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L6Ja0bf10P/Listeners', 05:20:30 INFO - 'TMPDIR': '/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/', 05:20:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:20:30 INFO - 'USER': 'cltbld', 05:20:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:20:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:30 INFO - 'XPC_FLAGS': '0x0', 05:20:30 INFO - 'XPC_SERVICE_NAME': '0', 05:20:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:20:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0031', '--webServer', 'localhost'] with output_timeout 3600 05:20:30 INFO - mozversion INFO | application_buildid: 20151117031105 05:20:30 INFO - mozversion INFO | application_changeset: 0e3b216c93f698f295e42910f442df42616fe003 05:20:30 INFO - mozversion INFO | application_display_name: Nightly 05:20:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:30 INFO - mozversion INFO | application_name: Firefox 05:20:30 INFO - mozversion INFO | application_remotingname: firefox 05:20:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:20:30 INFO - mozversion INFO | application_vendor: Mozilla 05:20:30 INFO - mozversion INFO | application_version: 45.0a1 05:20:30 INFO - mozversion INFO | platform_buildid: 20151117031105 05:20:30 INFO - mozversion INFO | platform_changeset: 0e3b216c93f698f295e42910f442df42616fe003 05:20:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:20:30 INFO - mozversion INFO | platform_version: 45.0a1 05:20:30 INFO - 2015-11-17 05:20:30,818 DEBUG : using testdate: 1447766430 05:20:30 INFO - 2015-11-17 05:20:30,818 DEBUG : actual date: 1447766430 05:20:30 INFO - 2015-11-17 05:20:30,943 INFO : starting webserver on 'localhost:50497' 05:20:30 INFO - 2015-11-17 05:20:30,944 INFO : Starting test suite t-yosemite-r5-0031.e 05:20:30 INFO - 2015-11-17 05:20:30,944 INFO : Starting test dromaeo_css 05:20:30 INFO - 2015-11-17 05:20:30,944 DEBUG : operating with platform_type : mac_ 05:20:30 INFO - 2015-11-17 05:20:30,945 INFO : Initialising browser for dromaeo_css test... 05:20:30 INFO - 2015-11-17 05:20:30,968 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpdkOyKs/profile http://localhost:50497/getInfo.html 05:20:34 INFO - 2015-11-17 05:20:34,823 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:20:34 INFO - 2015-11-17 05:20:34,823 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:20:34 INFO - 2015-11-17 05:20:34,823 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:20:34 INFO - 2015-11-17 05:20:34,823 DEBUG : BROWSER_OUTPUT: __metrics 05:20:35 INFO - 2015-11-17 05:20:35,520 INFO : Browser initialized. 05:20:35 INFO - 2015-11-17 05:20:35,521 INFO : Running cycle 1/1 for dromaeo_css test... 05:20:35 INFO - 2015-11-17 05:20:35,521 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmpdkOyKs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:20:47 INFO - 2015-11-17 05:20:47,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 239943680 05:20:47 INFO - 2015-11-17 05:20:47,713 DEBUG : BROWSER_OUTPUT: 05:21:37 INFO - 2015-11-17 05:21:37,577 DEBUG : BROWSER_OUTPUT: 1447766497569 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:23:47 INFO - 2015-11-17 05:23:47,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50497/tests/dromaeo/cssquery-ext.html) 05:23:49 INFO - 2015-11-17 05:23:49,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 265277440 05:23:49 INFO - 2015-11-17 05:23:49,083 DEBUG : BROWSER_OUTPUT: 05:26:51 INFO - 2015-11-17 05:26:51,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-ext.html (next: http://localhost:50497/tests/dromaeo/cssquery-jquery.html) 05:26:51 INFO - 2015-11-17 05:26:51,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 272191488 05:26:51 INFO - 2015-11-17 05:26:51,830 DEBUG : BROWSER_OUTPUT: 05:29:53 INFO - 2015-11-17 05:29:53,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50497/tests/dromaeo/cssquery-mootools.html) 05:29:54 INFO - 2015-11-17 05:29:54,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 275116032 05:29:54 INFO - 2015-11-17 05:29:54,220 DEBUG : BROWSER_OUTPUT: 05:32:56 INFO - 2015-11-17 05:32:56,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50497/tests/dromaeo/cssquery-prototype.html) 05:32:56 INFO - 2015-11-17 05:32:56,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 278355968 05:32:56 INFO - 2015-11-17 05:32:56,592 DEBUG : BROWSER_OUTPUT: 05:35:59 INFO - 2015-11-17 05:35:59,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50497/tests/dromaeo/cssquery-yui.html) 05:35:59 INFO - 2015-11-17 05:35:59,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 283529216 05:35:59 INFO - 2015-11-17 05:35:59,780 DEBUG : BROWSER_OUTPUT: 05:39:01 INFO - 2015-11-17 05:39:01,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/dromaeo/cssquery-yui.html (next: http://localhost:50497/tests/dromaeo/cssquery-dojo.html) 05:39:02 INFO - 2015-11-17 05:39:02,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 289173504 05:39:02 INFO - 2015-11-17 05:39:02,247 DEBUG : BROWSER_OUTPUT: 05:39:02 INFO - 2015-11-17 05:39:02,247 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:39:02 INFO - 2015-11-17 05:39:02,247 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:39:02 INFO - 2015-11-17 05:39:02,247 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:39:02 INFO - 2015-11-17 05:39:02,247 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:39:02 INFO - 2015-11-17 05:39:02,247 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2717.320669832542;2721.6733991920973;2736.65791776028;2751.683556391016;2776.5973933779596;4377.606015458608;4504.50450450451;4506.6845320827515;4535.229011068118;4627.097715945392;4496.460424749034;4587.931181032279;4593.908121837561;4634.791434385453;4708.717476951377;4284.785760711968;4342.826286948518;4387.29803231483;4399.780010999437;4430.136123455927;4326.5673432656795;4374.9999999999845;4389.012472193763;4408.581184787457;4442;4193.370994350841;4209;4250.702450828428;4274.636655884254;4295.52749197588;4330.2638551446325;4341.544137865541;4354.455693038371;4379.540148284448;4388.1223755249075;4151.045259590281;4302.462192225972;4327.783610819478;4340.631046361063;4382.561743825624;4483.910321793546;4563.383943167663;4631.305304204363;4651.000034992459;4660.766961651938;4825.517448255181;4866;4908.116539022974;4916.410030796292;4926.014797040571;4904.4605093439695;4956.355673762388;4975.079610272075;5012.423571289275;5059.3169922060415;4645.86062418128;4693.225617773098;4704.317873908264;4712.811487540528;4719.9292010619865;4944.406671199407;5043.924341134886;5140.871478213;5142.640015198975;5191.844244672666;4780.354652121989;4817.181079216542;4875.609951203895;4897.926531102036;4916.0905232532095;5045.445001049881;5046.066477701637;5052.873678158002;5066.620003499752;5110.821121260738;4784.617230621542;4899.583535399531;4952.678075925053;4964.15609346412;5009.949900501021;4857.344258525054;4881.804727810848;4886.389201349832;4899.902001959941;4938.259261110862;3859.1316953685196;3860.613938606173;3890.3386424307937;3908.3746600544346;3922.843086276574;3420.931581368359;3435.261418794971;3501.2122272488486;3533.8409771559827;3573.017420209463;4660.533946605312;4689.366935463737;4746.406699162605;4763.928541071887;4812.951870481321;5024.949750502521;5032.47159048302;5033.647644664911;5050.873728156826;5062.316587260672;4566.223741963874;4645.953540464619;4699.083678682624;4724.71651700899;4768;4360.825566977285;4367.541408152162;4375.671824613167;4387.780610969438;4427.46870375557;5075.137226671474;5104.795808167706;5126.436092029874;5143.228515722672;5172.431032586337;4901.5588597026435;4930.482299358516;4972.477889821516;5027.497250274943;5031.798728050983;5069.7718602662235;5075.3402057732255;5076.18780995039;5097.7706003229205;5137.640365174402;4828.806847726051;4868.196747536616;4875.634327425386;4876.414830220397;4880.829170978998;4736.50266722003;4863;4886.682365646222;4913.877153071202;4979.651424400257;4850.490698476609;4884.267359896044;4895.828645997373;4904.607631389552;4931.778069986931;4704.92942605868;4875.414950205998;4879.682820616648;4881.51184881509;4931;4628.2363410038315;4661.394018777537;4682.531746825291;4739.905201896012;4773.307870358709;4776.713397196179;4868.41579010521;4875.853724388274;4907.435644900882;4934;4661.766911654471;4753.904921901473;4766.737829419415;4788.569028787426;4826.0830442215865 05:39:02 INFO - 2015-11-17 05:39:02,249 DEBUG : BROWSER_OUTPUT: |1;ext.html;474.459116607068;489.92651102334645;490.98527044188677;506.1244047797309;517.4695936664921;32232;32966.83516582414;33211.66788332116;33244.176919654215;33283.83358083206;36019;36767.63232367676;36836.63163368365;36907.44638830413;36914.8154259229;7972.481788683732;8097.190280971915;8104.837903241932;8137.796555086141;8149.225823546783;8002.119766825645;8108.270255677017;8123.918760812376;8140.1452847450755;8147.063087744897;8044.316233120192;8138.755837324889;8139.877901831477;8146.389020823462;8164.265216130547;7967;8061.556614386206;8064.153263907264;8084.6766129354755;8095.219051808593;7973.521588704696;8085.514869107814;8098.676052957874;8105.230003149692;8106.513609183467;34106.82946585276;34446.827765861264;34501.6549834501;34589.13527161841;34620.65379346199;2128.063651993118;2290.599145149609;2315.706683790552;2542.478791847667;2678.1965410377;24771.161930886472;25718.22845314625;26101.73898261012;26108.60837087445;26248.60627090595;2039.3474088291753;2040.8775473471492;2053.620080285152;2056.4961584411767;2060.258307009475;229019;230031;230085;230780;230908.9999999983;35052.82473587616;35851.64148358483;35866;35925.46111808325;53023.46976530185;34990.82504587511;35378.64621353753;35416.46875296873;35453.64546354555;35489.46765798515;12942.094053416358;13106.934465327613;13249.205047697169;13273.070885037954;13297.734045319234;10479;10571.524281407355;10629.5216715248;10637.308574942605;10729.195310351599;12117.69705757363;12123.939380303042;12125.151239413157;12147.93926030382;12187.329696866758;5343;5365.302510673588;5367.409584945653;5382.623216374816;5417.83746487606;793.8729803231455;799.9080105787909;819.6024927909959;937.779621788879;949.9408159901798;24361.756382436302;24401.145959891317;24676.876615616806;24694.876525617256;24702.505949880902;927.9304052196112;943.4999450291357;978.0610613810679;984.5520288268821;991.4844280973854;12769.68075798094;12829.743405131845;12878;14286.928565357315;14340.498082567268;241242;245961;247378;247432;248541;51998;53637.46362536403;53770.46229537654;53871.73064134654;53963;1219.2136072233536;1236.8948639365756;1247.0771628994478;1254.8117782332722;1255.5668294438403;26303.73696263013;27094.100317079556;27212.183634490997;27342.45315093647;27398;41737.58262417458;42029;42065.369019464124;42074.7896260529;42132.157356853306;232947;237141;237153;237242;239030;28998.565021525115;29312.706872931853;39688;41271.793641032804;41358.79320603498;37474.250514989006;37729.81135094307;37894;38101.23797523978;38676.22647546977;31517.36965260636;32368.676313236567;32398.514022290157;32509.674903250663;32577.597840755545;30895.691043089282;31469.8426507866;31523;31553.368932621677;31555.053348399586;31772.20569485689;32489.675103248665;32827.67172328246;32882.34235315328;32885.50671739878;27098.1870543884;28316.43367132687;28407.28981775472;28638.48600477318;28831.56752648754;21113.78886211118;21409.892950535148;21569.460763481038;21570.892145539172;21702.829717028802 05:39:02 INFO - 2015-11-17 05:39:02,253 DEBUG : BROWSER_OUTPUT: |2;jquery.html;286.17581365666877;288.8844462215114;291.59613934700434;293.8501364304205;297.48386549336897;8720.65117395305;9016;14786.630334241636;14930.328135233913;15342.156181410031;9247.815043699122;9668.903310966889;9901.257405694583;10191.643292484765;10233.181345492361;3700.1859590889962;3809.8857034288876;3816.751911125782;3818.6372294632106;3820.083180036799;2913.3153708878394;2988.5218365061596;3748.9437658435145;4006.298897692907;4138.730982486144;4033.9596604034023;4051.8379264829373;4057;4067.5932406759234;4081.1837632473475;3797.6012518685693;4102.733322334038;4104.466419365478;4107.342825147977;4113.856015039474;3360.092774950774;3366.495025746158;3373.122988023107;3379.983100084484;3387.4749413840896;11036.227464077438;11080.335179889233;11194.832077518844;11261.042811361043;11282.266652667633;1496.9850301496954;1557.2914323982561;1665.2839279110099;1742.1550547984218;1749.860011199101;6830;7952.244536768998;8138.593070346459;8167.591620419014;8235.13531079234;1262.2994238197796;1286.1318609938255;1301.3883474766844;1307.8626744191818;1358.6195865157772;47769.76115119402;50519;50555.49444505582;50717.239241411036;51261.74369128168;5573.359063707644;5605.635633683797;5638.069718496484;5653.660780353192;5658.179563963202;6379.266384365765;6386.074019267273;6405.071264666691;6411.6153030818305;6412.839679008062;4638.536146385402;4724.196886529298;4737.8341758039;4745.549172828576;4761.833335833229;5074.314967479343;5080.390353157571;5099.77051032697;5100.515451032146;5109.131447653907;2521.6217567364674;2551.4386834896295;2556.169244995384;2558.06630579837;2567.9229623111337;884.9424787388799;890.3633901760272;890.7951171230653;918.4626993209048;952.5284983932859;330.61813605285454;330.76350409457353;360.49170669356084;365.14920235850406;387.8351700527265;8508.489490630582;9030.774230644154;9270.72187834366;10125.189984801345;10197.388156710473;388.69875846219406;389.36339085595256;395.66566251517423;398.44218094667696;408.86916186820525;5320.361556613231;5461.972690136603;5531.529819965268;5555.527780138734;5558.666480011131;306376;307328;310792;311831;312097;52968.73515632397;55521.44478555163;56038.43961560414;56517.71741141268;57304.14043789347;427.92511310520536;445.243086752522;445.5477690144506;446.16121691220945;447.37144312241355;9372.765680858032;9384.624615015324;9421.434713917188;9434.198093161884;9533.523323833642;28401.28996775097;29207.561886571293;29784.255393614465;29960.25099372533;29961.550576741804;39751;40258.19483610253;40898;41591.37612935869;41894.790526047174;5128.1794912813775;5281.947180528299;5388.838334849961;5398.325209348832;5406.21609866575;10002.099811017044;10195.031472010147;10326.380417174994;10330.225233107396;10338.638147664795;7215.963920180576;8624.741257762276;8798.912010879809;8804.60379282921;8834.911650883409;8532.701355452778;8588.312934965314;8611.870821937551;8629;8782.209601135928;8749.6937607186;8775.507166565021;9054.502002389932;9067.229285510806;9075.047120052299;5221.765020574007;5270.262163297218;5273.683578985273;5289.338832645919;5299.2316114164005;8570.4000719949;8754.562271886507;8786.341024423065;8801.867971980297;8897.510636915033 05:39:02 INFO - 2015-11-17 05:39:02,253 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1441.8341890682575;1515.57563882113;1540.722669919414;1555.1602134847183;1583.8574528292452;6412.166418365618;6558.442532384753;6775.728970841166;7247.782566522999;7284.708611655534;6703.497237707179;6781.423578995791;6880.380765731084;6899.793006209809;6921.34247246512;1979.7921218272127;1998.7201791749167;2003.789602091774;2004.7293615361957;2011.4468521156653;1997.530580313625;2035.1045539962442;2042.0504465423576;2046.498607841081;2051.979480205201;1911.7514723085978;1913.378152100566;1928.864979451439;1948.4933917181493;1961.9411417657493;2001.3995801259564;2029.8883561404116;2032.7865574114653;2033.4509682385674;2033.5526184239443;1959.12818795636;1998.960020799576;1999.8300144487737;2006.297795771483;2014.5870096630301;7055.611941343224;7099.929000709978;7146.071010768619;7151.856962860766;7155.785326440215;4334.783260836945;4435.1573201092015;4442.044960333512;4443.111377724468;4444.400005999213;2548.210054882992;2591.9740802591923;2615.189291319697;2620.2270330252622;2629.9605505917425;752.6086435053742;759.9354054905284;761.9161892191854;787.4055088408215;788.7081779741475;9370.85943710845;9372.625094996192;9375.062493750638;9376.296777741696;9416.717498475056;3793.393057110849;3815.740805534167;3824;3842.7502212356108;3870.3807390817897;8020.83958320842;8066.435349525595;8096.595170241464;8096.878546821802;8113.8377232456205;4284.914301713949;4294.914101718011;4310.80601372939;4315.741055536678;4319.892002699895;3397.5413319202084;3461.7922924624604;3882.825272862728;3882.9223415531533;3886.7473614214987;3260.5598244236726;3327.93344133116;3344.4314466540745;3365.209175843675;3389.7627166098628;1077.9029887310023;1093.4095588382183;1094.9726256843483;1099.9230053896151;1102.030213412192;901.0268909577641;940.4686352210979;1145.2498613408231;1172.4489489939715;1179.628417048627;6652.534322597468;6717.1267735194115;6730.158730158731;6738;6739.528233023641;992.8014397120605;998.2064258914181;1003.1623594298842;1026.0509029148009;1037.911777498921;5253.290805741252;5258.8159414420315;5282.445343238905;5288.92066619001;5297.390800058042;8080.313173380211;8283.25450709439;8306.210909963544;8325.708600199085;8480.321574274043;8146.83706325882;8170.714025009096;8198.795030124294;8207.466514676527;8216.753497395088;6488.545801793924;6543.9345606544275;6630.767923122764;6680.498962577826;6685;6614.239362473185;6653.367930046637;6653.9667301663185;6661.566998145105;6665.100211471389;7289.489735718449;7452.105747310357;7467.887981680387;7478.326950574475;7525.247475252431;7250.383717384081;7311.780646580611;7470.663820127998;7593;7707.306342429209;5624.943750562606;5815.709214539341;6031.75872965094;6154.692265386623;6156.199694039746;6442.130312407765;6483.870322593616;6652.334766523309;6694.866102678016;6697.732090716511;6145.0782382642965;6161.106639537332;6242.875142497215;6324.30432652417;6362.300146983921;6010.819675409744;6132.325444201045;6179.938200617937;6205.906911396423;6284.08880712285;6295;6321.462675672619;6346.777862774781;6350.968245158745;6364.236291645032;5734.713264336683;5758.539316854558;5760.8271751847515;5768.884622307614;5770.942290577041;5818.0981947798155;5843.328017278068;5872.941270587239;5888.617239879394;5897.056470964625 05:39:02 INFO - 2015-11-17 05:39:02,257 DEBUG : BROWSER_OUTPUT: |4;prototype.html;271.9918402447927;276.2720232188185;282.39285536097384;283.37374402570333;284.056930989116;5259.8422047338545;5428.538574221186;5553.055980483317;5567.4432556744305;5584.134459158832;5421.620486565942;5532.114861622142;5562.360328562217;5568.053430916743;5572.080606699889;4203.684723645723;4218.810153543082;4219.324908014718;4235.068284977316;4246.532881383046;4200.57994200579;4200.97899510502;4217.8312867485265;4220.282551966157;4224.97887510562;4167.312393455076;4174.22776786294;4174.519930208019;4186.099988502471;4239.745615263078;4048.271311163989;4157.293260145767;4181.1010632714115;4192.0925978679625;4197.496300443966;3577.0342007657787;3591.982040089783;3602.189507360849;3604.6034936157266;3609.8014609196484;5185.974070129663;5343.011542864582;5436.130219164954;5442.755076021588;5473.75368108436;4572.588467037983;4701;4734;4744.074905393415;4765.928511072337;5767.538596912237;5776.682282474462;5779.33537643168;5782.45066718661;5787.218725472049;3924.489816323888;3925.8429662813455;3930.3514920038447;3931.272714547818;3931.842726290945;5918.874373422928;5994.310654274771;6087.847803804896;6097.908531372077;6103.908441373383;4011.0774521860135;4018.598140185958;4020.3165461871554;4022.8189731462153;4025.577314381948;4071.1247081877536;4085.8774236772942;4089.7750623715388;4090.8977275567754;4107.034846810997;4714.504976977368;4719.056188762262;4720.881977950578;4726.338312636233;4742.691725037862;5629.240052592848;5792.797252096157;5799.449052340021;5800.4489573490455;5816.912746308809;1416.221078406872;1437.0874494695734;1443.0547991065869;1448.5943935698022;1448.9275536223147;945.6028468043438;947.0860619502075;952.4190243951184;959.8704174936433;964.9710508684751;5584.553235741212;5587.106063029895;5593.692346920877;5599.216109744639;5613.831585052455;6033.909491357633;6034.487068599218;6048.848778780478;6061.060535616986;6078.665673388006;5537.916931246034;5546.862893106903;5554.527865131509;5576.7211639417865;5580.944190558123;3147.937041259162;3264.396086723964;3293.4730443129465;3294.0776582556923;3296.208909861616;6233.563650544509;6238.875222495615;6242.812715618538;6244.250689917239;6263.123162757218;6069.969650151809;6203.518592563011;6206.503479721611;6225.688715564203;6287.779927702509;6232.470240029648;6288.402601752826;6313.621182729051;6313.810585682529;6338.334474880164;6103.023516237381;6119.510439164767;6123.7550497981365;6124.908126378019;6130.570860039755;5717.971410142923;5960.672163031075;5976.731047102978;5983.551233657406;5991.310999235144;6259.2488901332135;6262.74949002053;6267.2479302484;6280.623162610258;6301.527385446201;3849.9615003849603;3889.9027524310986;3905.785181814914;3932.5477570079806;3937.5668676444993;6006.699665016819;6006.969965150146;6018.187544681412;6020.367861374492;6043.576949613484;5731.426857314235;5843.532517398683;5917.437843404869;5921.230240068763;5941.940580594139;5868.178455016387;5879.647221166743;5880.235569376125;5899.321578018583;5901.5868889177345;5729.2265544151005;5731.312242530923;5732.856678583069;5737.684427356536;5740.536163278337;5717.514011309086;5871.559633027455;5881.852953676193;5882.647041177543;5914.408559144051;5723.141528770718;5765.077587585966;5772.249607550992;5780.537556995514;5794.188813566188 05:39:02 INFO - 2015-11-17 05:39:02,258 DEBUG : BROWSER_OUTPUT: |5;yui.html;621.9937800621996;639.0892977507051;639.3063526074208;644.3105876711915;644.8968165093585;8712.346574006951;8964.686235981733;8989.101089891008;9692;9818.312718109735;9358.204552613037;9446.85829712555;9460.10129037742;9486.76283092923;9492.857607135882;598.8951933411657;728.5701436152669;735.6763024269331;741.1402772783572;744.0661969228638;597.6981624279732;735.6358602491747;746.7908985484073;751.0236692300016;751.5002523322012;748.9138749043848;766.3945483068369;766.4519868294169;767.6967597798894;770.0874463760434;743.3012967810241;757.7613051888637;759.1535437986632;759.7492827366983;759.8632246195682;562.3673367461606;562.6342877129857;566.9433056694339;570;570.8629928817096;8489.702860399857;8612.267957223643;8612.39713220075;8630.180132887366;8632.093630168805;7590.58251796151;7817.1791961843755;7988.640511177011;8172.141925097839;8289.875651865226;6984.930150698478;7130.108736407949;7235.529690570149;7281.708731650728;7660.621088204121;2415.3268891484304;2492.0779311654805;2511.5855883779154;2520.9117680881263;2562.359410147463;40155.59844401577;40283;40619.7969010156;40649;41175.38236926449;5323.547498462596;5489.725513724377;5507.449255074461;5534.557235421156;5633.915491267634;9569.234461243223;9598.18415434682;9602.039796020343;9610.615575376907;9618;4680.812767489262;4762.214234651313;4801.663883528119;4809.2305231162845;4833.564979151894;2994.595729576523;2998.9953365622323;3028.2126647071477;3044.3606842562867;3057.312104776452;2144.7855214478427;2152.1068756465893;2158.5035441848463;2164.945876353104;2168.20860385958;347.28632659883675;350.3938186936563;351.8223297234931;352.68082385441215;353.1084012867479;409.9405586189986;411.4856429463171;449.5212598582499;450.96843220974876;483.5841176588131;5988.101784732325;6010.158577799111;6092.51259899207;6105.145279660851;6352.7141278642575;402.5531659857556;442.1665161171151;446.3750748951429;475.70030880545727;492.44845772734766;2993.1918382037165;3205.182678416989;3231.1760501072545;3247.415465216284;3297.274599588087;44304.556954430685;45580.3162952556;52315.215271770954;52417.213741793144;52965.470345296824;40931.386029209585;41159.7942010288;41428.37857432141;41672.374914376305;41714.37428438576;39482.60517394847;40400.39399409011;41098.58901410948;41334.379984300256;41418.8935829814;6588.7364505421165;6844;6951.096357473496;7042.6126563039525;7062;29168.541572921695;29783.851080744458;31401.37197256088;32002;32408.83795581007;39366.60633393744;39658.80170599244;39967.20065598613;40063.19873602453;40351.1929761409;5950.19672344228;6054.48536874353;6055;6116.633002019715;6140.539459540463;8651.820269267178;8905.51019693923;8973.685920992733;9069.64332919357;9171.312151588523;8363.498190108612;8610.268127209007;8645.654173832976;8650.394472386872;8800.075992020746;8274.069816836954;8425.241728244242;8459.661613535636;8622.180892815173;8751.124887511198;8352;8419.284360829153;8427.536485493356;8666.739997800076;8898.975721921806;6509.414152726277;6961.860762784817;6967.686454109476;7074.409098368285;7602.581857997863;6687.899681504684;7017.578945263301;7148.499605027599;7297.963510182415;7504.774856754306 05:39:02 INFO - 2015-11-17 05:39:02,258 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:39:02 INFO - 2015-11-17 05:39:02,258 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:39:02 INFO - 2015-11-17 05:39:02,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,297 05:39:02 INFO - 2015-11-17 05:39:02,259 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:39:02 INFO - 2015-11-17 05:39:02,259 DEBUG : BROWSER_OUTPUT: __startTimestamp1447767542244__endTimestamp 05:39:02 INFO - 2015-11-17 05:39:02,259 DEBUG : BROWSER_OUTPUT: 05:39:02 INFO - 2015-11-17 05:39:02,259 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:39:02 INFO - 2015-11-17 05:39:02,259 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:39:02 INFO - 2015-11-17 05:39:02,259 DEBUG : BROWSER_OUTPUT: 05:39:02 INFO - 2015-11-17 05:39:02,260 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4628.43 Median:4768.00 stddev:491.15 (10.3%) stddev-sans-first:469.22 05:39:02 INFO - 2015-11-17 05:39:02,261 DEBUG : BROWSER_OUTPUT: Values: 2717.3 2721.7 2736.7 2751.7 2776.6 4377.6 4504.5 4506.7 4535.2 4627.1 4496.5 4587.9 4593.9 4634.8 4708.7 4284.8 4342.8 4387.3 4399.8 4430.1 4326.6 4375.0 4389.0 4408.6 4442.0 4193.4 4209.0 4250.7 4274.6 4295.5 4330.3 4341.5 4354.5 4379.5 4388.1 4151.0 4302.5 4327.8 4340.6 4382.6 4483.9 4563.4 4631.3 4651.0 4660.8 4825.5 4866.0 4908.1 4916.4 4926.0 4904.5 4956.4 4975.1 5012.4 5059.3 4645.9 4693.2 4704.3 4712.8 4719.9 4944.4 5043.9 5140.9 5142.6 5191.8 4780.4 4817.2 4875.6 4897.9 4916.1 5045.4 5046.1 5052.9 5066.6 5110.8 4784.6 4899.6 4952.7 4964.2 5009.9 4857.3 4881.8 4886.4 4899.9 4938.3 3859.1 3860.6 3890.3 3908.4 3922.8 3420.9 3435.3 3501.2 3533.8 3573.0 4660.5 4689.4 4746.4 4763.9 4813.0 5024.9 5032.5 5033.6 5050.9 5062.3 4566.2 4646.0 4699.1 4724.7 4768.0 4360.8 4367.5 4375.7 4387.8 4427.5 5075.1 5104.8 5126.4 5143.2 5172.4 4901.6 4930.5 4972.5 5027.5 5031.8 5069.8 5075.3 5076.2 5097.8 5137.6 4828.8 4868.2 4875.6 4876.4 4880.8 4736.5 4863.0 4886.7 4913.9 4979.7 4850.5 4884.3 4895.8 4904.6 4931.8 4704.9 4875.4 4879.7 4881.5 4931.0 4628.2 4661.4 4682.5 4739.9 4773.3 4776.7 4868.4 4875.9 4907.4 4934.0 4661.8 4753.9 4766.7 4788.6 4826.1 05:39:02 INFO - 2015-11-17 05:39:02,261 DEBUG : BROWSER_OUTPUT: 05:39:02 INFO - 2015-11-17 05:39:02,261 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38548.20 Median:32855.01 stddev:61924.21 (188.5%) stddev-sans-first:62031.94 05:39:02 INFO - 2015-11-17 05:39:02,262 DEBUG : BROWSER_OUTPUT: Values: 474.5 489.9 491.0 506.1 517.5 32232.0 32966.8 33211.7 33244.2 33283.8 36019.0 36767.6 36836.6 36907.4 36914.8 7972.5 8097.2 8104.8 8137.8 8149.2 8002.1 8108.3 8123.9 8140.1 8147.1 8044.3 8138.8 8139.9 8146.4 8164.3 7967.0 8061.6 8064.2 8084.7 8095.2 7973.5 8085.5 8098.7 8105.2 8106.5 34106.8 34446.8 34501.7 34589.1 34620.7 2128.1 2290.6 2315.7 2542.5 2678.2 24771.2 25718.2 26101.7 26108.6 26248.6 2039.3 2040.9 2053.6 2056.5 2060.3 229019.0 230031.0 230085.0 230780.0 230909.0 35052.8 35851.6 35866.0 35925.5 53023.5 34990.8 35378.6 35416.5 35453.6 35489.5 12942.1 13106.9 13249.2 13273.1 13297.7 10479.0 10571.5 10629.5 10637.3 10729.2 12117.7 12123.9 12125.2 12147.9 12187.3 5343.0 5365.3 5367.4 5382.6 5417.8 793.9 799.9 819.6 937.8 949.9 24361.8 24401.1 24676.9 24694.9 24702.5 927.9 943.5 978.1 984.6 991.5 12769.7 12829.7 12878.0 14286.9 14340.5 241242.0 245961.0 247378.0 247432.0 248541.0 51998.0 53637.5 53770.5 53871.7 53963.0 1219.2 1236.9 1247.1 1254.8 1255.6 26303.7 27094.1 27212.2 27342.5 27398.0 41737.6 42029.0 42065.4 42074.8 42132.2 232947.0 237141.0 237153.0 237242.0 239030.0 28998.6 29312.7 39688.0 41271.8 41358.8 37474.3 37729.8 37894.0 38101.2 38676.2 31517.4 32368.7 32398.5 32509.7 32577.6 30895.7 31469.8 31523.0 31553.4 31555.1 31772.2 32489.7 32827.7 32882.3 32885.5 27098.2 28316.4 28407.3 28638.5 28831.6 21113.8 21409.9 21569.5 21570.9 21702.8 05:39:02 INFO - 2015-11-17 05:39:02,263 DEBUG : BROWSER_OUTPUT: 05:39:02 INFO - 2015-11-17 05:39:02,263 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:18217.36 Median:446.77 stddev:51091.54 (11435.9%) stddev-sans-first:51217.13 05:39:02 INFO - 2015-11-17 05:39:02,264 DEBUG : BROWSER_OUTPUT: Values: 286.2 288.9 291.6 293.9 297.5 8720.7 9016.0 14786.6 14930.3 15342.2 9247.8 9668.9 9901.3 10191.6 10233.2 3700.2 3809.9 3816.8 3818.6 3820.1 2913.3 2988.5 3748.9 4006.3 4138.7 4034.0 4051.8 4057.0 4067.6 4081.2 3797.6 4102.7 4104.5 4107.3 4113.9 3360.1 3366.5 3373.1 3380.0 3387.5 11036.2 11080.3 11194.8 11261.0 11282.3 1497.0 1557.3 1665.3 1742.2 1749.9 6830.0 7952.2 8138.6 8167.6 8235.1 1262.3 1286.1 1301.4 1307.9 1358.6 47769.8 50519.0 50555.5 50717.2 51261.7 5573.4 5605.6 5638.1 5653.7 5658.2 6379.3 6386.1 6405.1 6411.6 6412.8 4638.5 4724.2 4737.8 4745.5 4761.8 5074.3 5080.4 5099.8 5100.5 5109.1 2521.6 2551.4 2556.2 2558.1 2567.9 884.9 890.4 890.8 918.5 952.5 330.6 330.8 360.5 365.1 387.8 8508.5 9030.8 9270.7 10125.2 10197.4 388.7 389.4 395.7 398.4 408.9 5320.4 5462.0 5531.5 5555.5 5558.7 306376.0 307328.0 310792.0 311831.0 312097.0 52968.7 55521.4 56038.4 56517.7 57304.1 427.9 445.2 445.5 446.2 447.4 9372.8 9384.6 9421.4 9434.2 9533.5 28401.3 29207.6 29784.3 29960.3 29961.6 39751.0 40258.2 40898.0 41591.4 41894.8 5128.2 5281.9 5388.8 5398.3 5406.2 10002.1 10195.0 10326.4 10330.2 10338.6 7216.0 8624.7 8798.9 8804.6 8834.9 8532.7 8588.3 8611.9 8629.0 8782.2 8749.7 8775.5 9054.5 9067.2 9075.0 5221.8 5270.3 5273.7 5289.3 5299.2 8570.4 8754.6 8786.3 8801.9 8897.5 05:39:02 INFO - 2015-11-17 05:39:02,264 DEBUG : BROWSER_OUTPUT: 05:39:02 INFO - 2015-11-17 05:39:02,265 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4874.72 Median:6138.70 stddev:2505.23 (40.8%) stddev-sans-first:2498.98 05:39:02 INFO - 2015-11-17 05:39:02,266 DEBUG : BROWSER_OUTPUT: Values: 1441.8 1515.6 1540.7 1555.2 1583.9 6412.2 6558.4 6775.7 7247.8 7284.7 6703.5 6781.4 6880.4 6899.8 6921.3 1979.8 1998.7 2003.8 2004.7 2011.4 1997.5 2035.1 2042.1 2046.5 2052.0 1911.8 1913.4 1928.9 1948.5 1961.9 2001.4 2029.9 2032.8 2033.5 2033.6 1959.1 1999.0 1999.8 2006.3 2014.6 7055.6 7099.9 7146.1 7151.9 7155.8 4334.8 4435.2 4442.0 4443.1 4444.4 2548.2 2592.0 2615.2 2620.2 2630.0 752.6 759.9 761.9 787.4 788.7 9370.9 9372.6 9375.1 9376.3 9416.7 3793.4 3815.7 3824.0 3842.8 3870.4 8020.8 8066.4 8096.6 8096.9 8113.8 4284.9 4294.9 4310.8 4315.7 4319.9 3397.5 3461.8 3882.8 3882.9 3886.7 3260.6 3327.9 3344.4 3365.2 3389.8 1077.9 1093.4 1095.0 1099.9 1102.0 901.0 940.5 1145.2 1172.4 1179.6 6652.5 6717.1 6730.2 6738.0 6739.5 992.8 998.2 1003.2 1026.1 1037.9 5253.3 5258.8 5282.4 5288.9 5297.4 8080.3 8283.3 8306.2 8325.7 8480.3 8146.8 8170.7 8198.8 8207.5 8216.8 6488.5 6543.9 6630.8 6680.5 6685.0 6614.2 6653.4 6654.0 6661.6 6665.1 7289.5 7452.1 7467.9 7478.3 7525.2 7250.4 7311.8 7470.7 7593.0 7707.3 5624.9 5815.7 6031.8 6154.7 6156.2 6442.1 6483.9 6652.3 6694.9 6697.7 6145.1 6161.1 6242.9 6324.3 6362.3 6010.8 6132.3 6179.9 6205.9 6284.1 6295.0 6321.5 6346.8 6351.0 6364.2 5734.7 5758.5 5760.8 5768.9 5770.9 5818.1 5843.3 5872.9 5888.6 5897.1 05:39:02 INFO - 2015-11-17 05:39:02,266 DEBUG : BROWSER_OUTPUT: 05:39:02 INFO - 2015-11-17 05:39:02,266 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4862.52 Median:5585.83 stddev:1496.57 (26.8%) stddev-sans-first:1460.57 05:39:02 INFO - 2015-11-17 05:39:02,268 DEBUG : BROWSER_OUTPUT: Values: 272.0 276.3 282.4 283.4 284.1 5259.8 5428.5 5553.1 5567.4 5584.1 5421.6 5532.1 5562.4 5568.1 5572.1 4203.7 4218.8 4219.3 4235.1 4246.5 4200.6 4201.0 4217.8 4220.3 4225.0 4167.3 4174.2 4174.5 4186.1 4239.7 4048.3 4157.3 4181.1 4192.1 4197.5 3577.0 3592.0 3602.2 3604.6 3609.8 5186.0 5343.0 5436.1 5442.8 5473.8 4572.6 4701.0 4734.0 4744.1 4765.9 5767.5 5776.7 5779.3 5782.5 5787.2 3924.5 3925.8 3930.4 3931.3 3931.8 5918.9 5994.3 6087.8 6097.9 6103.9 4011.1 4018.6 4020.3 4022.8 4025.6 4071.1 4085.9 4089.8 4090.9 4107.0 4714.5 4719.1 4720.9 4726.3 4742.7 5629.2 5792.8 5799.4 5800.4 5816.9 1416.2 1437.1 1443.1 1448.6 1448.9 945.6 947.1 952.4 959.9 965.0 5584.6 5587.1 5593.7 5599.2 5613.8 6033.9 6034.5 6048.8 6061.1 6078.7 5537.9 5546.9 5554.5 5576.7 5580.9 3147.9 3264.4 3293.5 3294.1 3296.2 6233.6 6238.9 6242.8 6244.3 6263.1 6070.0 6203.5 6206.5 6225.7 6287.8 6232.5 6288.4 6313.6 6313.8 6338.3 6103.0 6119.5 6123.8 6124.9 6130.6 5718.0 5960.7 5976.7 5983.6 5991.3 6259.2 6262.7 6267.2 6280.6 6301.5 3850.0 3889.9 3905.8 3932.5 3937.6 6006.7 6007.0 6018.2 6020.4 6043.6 5731.4 5843.5 5917.4 5921.2 5941.9 5868.2 5879.6 5880.2 5899.3 5901.6 5729.2 5731.3 5732.9 5737.7 5740.5 5717.5 5871.6 5881.9 5882.6 5914.4 5723.1 5765.1 5772.2 5780.5 5794.2 05:39:02 INFO - 2015-11-17 05:39:02,268 DEBUG : BROWSER_OUTPUT: 05:39:02 INFO - 2015-11-17 05:39:02,268 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10821.27 Median:3381.27 stddev:13869.64 (410.2%) stddev-sans-first:13887.40 05:39:02 INFO - 2015-11-17 05:39:02,268 DEBUG : BROWSER_OUTPUT: Values: 622.0 639.1 639.3 644.3 644.9 8712.3 8964.7 8989.1 9692.0 9818.3 9358.2 9446.9 9460.1 9486.8 9492.9 598.9 728.6 735.7 741.1 744.1 597.7 735.6 746.8 751.0 751.5 748.9 766.4 766.5 767.7 770.1 743.3 757.8 759.2 759.7 759.9 562.4 562.6 566.9 570.0 570.9 8489.7 8612.3 8612.4 8630.2 8632.1 7590.6 7817.2 7988.6 8172.1 8289.9 6984.9 7130.1 7235.5 7281.7 7660.6 2415.3 2492.1 2511.6 2520.9 2562.4 40155.6 40283.0 40619.8 40649.0 41175.4 5323.5 5489.7 5507.4 5534.6 5633.9 9569.2 9598.2 9602.0 9610.6 9618.0 4680.8 4762.2 4801.7 4809.2 4833.6 2994.6 2999.0 3028.2 3044.4 3057.3 2144.8 2152.1 2158.5 2164.9 2168.2 347.3 350.4 351.8 352.7 353.1 409.9 411.5 449.5 451.0 483.6 5988.1 6010.2 6092.5 6105.1 6352.7 402.6 442.2 446.4 475.7 492.4 2993.2 3205.2 3231.2 3247.4 3297.3 44304.6 45580.3 52315.2 52417.2 52965.5 40931.4 41159.8 41428.4 41672.4 41714.4 39482.6 40400.4 41098.6 41334.4 41418.9 6588.7 6844.0 6951.1 7042.6 7062.0 29168.5 29783.9 31401.4 32002.0 32408.8 39366.6 39658.8 39967.2 40063.2 40351.2 5950.2 6054.5 6055.0 6116.6 6140.5 8651.8 8905.5 8973.7 9069.6 9171.3 8363.5 8610.3 8645.7 8650.4 8800.1 8274.1 8425.2 8459.7 8622.2 8751.1 8352.0 8419.3 8427.5 8666.7 8899.0 6509.4 6961.9 6967.7 7074.4 7602.6 6687.9 7017.6 7148.5 7298.0 7504.8 05:39:02 INFO - 2015-11-17 05:39:02,268 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:39:02 INFO - 2015-11-17 05:39:02,268 DEBUG : BROWSER_OUTPUT: 05:39:02 INFO - 2015-11-17 05:39:02,945 INFO : Browser exited with error code: 0 05:39:02 INFO - 2015-11-17 05:39:02,977 INFO : Completed test dromaeo_css (00:18:32) 05:39:02 INFO - 2015-11-17 05:39:02,978 INFO : Starting test kraken 05:39:02 INFO - 2015-11-17 05:39:02,978 DEBUG : operating with platform_type : mac_ 05:39:02 INFO - 2015-11-17 05:39:02,978 INFO : Initialising browser for kraken test... 05:39:02 INFO - 2015-11-17 05:39:02,993 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmptNKlwm/profile http://localhost:50497/getInfo.html 05:39:06 INFO - 2015-11-17 05:39:06,133 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:39:06 INFO - 2015-11-17 05:39:06,133 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:39:06 INFO - 2015-11-17 05:39:06,134 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:39:06 INFO - 2015-11-17 05:39:06,134 DEBUG : BROWSER_OUTPUT: __metrics 05:39:06 INFO - 2015-11-17 05:39:06,876 INFO : Browser initialized. 05:39:06 INFO - 2015-11-17 05:39:06,876 INFO : Running cycle 1/1 for kraken test... 05:39:06 INFO - 2015-11-17 05:39:06,876 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmptNKlwm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:39:19 INFO - 2015-11-17 05:39:19,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 241614848 05:39:19 INFO - 2015-11-17 05:39:19,032 DEBUG : BROWSER_OUTPUT: 05:39:21 INFO - 2015-11-17 05:39:21,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50497/tests/kraken/driver.html?testName=audio-beat-detection) 05:39:22 INFO - 2015-11-17 05:39:22,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 259878912 05:39:22 INFO - 2015-11-17 05:39:22,534 DEBUG : BROWSER_OUTPUT: 05:39:25 INFO - 2015-11-17 05:39:25,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50497/tests/kraken/driver.html?testName=audio-dft) 05:39:26 INFO - 2015-11-17 05:39:26,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 267550720 05:39:26 INFO - 2015-11-17 05:39:26,104 DEBUG : BROWSER_OUTPUT: 05:39:29 INFO - 2015-11-17 05:39:29,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50497/tests/kraken/driver.html?testName=audio-fft) 05:39:29 INFO - 2015-11-17 05:39:29,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 268476416 05:39:29 INFO - 2015-11-17 05:39:29,899 DEBUG : BROWSER_OUTPUT: 05:39:32 INFO - 2015-11-17 05:39:32,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50497/tests/kraken/driver.html?testName=audio-oscillator) 05:39:32 INFO - 2015-11-17 05:39:32,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 268795904 05:39:32 INFO - 2015-11-17 05:39:32,644 DEBUG : BROWSER_OUTPUT: 05:39:34 INFO - 2015-11-17 05:39:34,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50497/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:39:35 INFO - 2015-11-17 05:39:35,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 268537856 05:39:35 INFO - 2015-11-17 05:39:35,579 DEBUG : BROWSER_OUTPUT: 05:39:38 INFO - 2015-11-17 05:39:38,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50497/tests/kraken/driver.html?testName=imaging-darkroom) 05:39:39 INFO - 2015-11-17 05:39:39,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 268972032 05:39:39 INFO - 2015-11-17 05:39:39,573 DEBUG : BROWSER_OUTPUT: 05:39:43 INFO - 2015-11-17 05:39:43,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50497/tests/kraken/driver.html?testName=imaging-desaturate) 05:39:43 INFO - 2015-11-17 05:39:43,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 267657216 05:39:43 INFO - 2015-11-17 05:39:43,692 DEBUG : BROWSER_OUTPUT: 05:39:46 INFO - 2015-11-17 05:39:46,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50497/tests/kraken/driver.html?testName=json-parse-financial) 05:39:47 INFO - 2015-11-17 05:39:47,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 268251136 05:39:47 INFO - 2015-11-17 05:39:47,514 DEBUG : BROWSER_OUTPUT: 05:39:49 INFO - 2015-11-17 05:39:49,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50497/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:39:49 INFO - 2015-11-17 05:39:49,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 268255232 05:39:49 INFO - 2015-11-17 05:39:49,833 DEBUG : BROWSER_OUTPUT: 05:39:51 INFO - 2015-11-17 05:39:51,841 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:39:52 INFO - 2015-11-17 05:39:52,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 267943936 05:39:52 INFO - 2015-11-17 05:39:52,471 DEBUG : BROWSER_OUTPUT: 05:39:54 INFO - 2015-11-17 05:39:54,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:39:55 INFO - 2015-11-17 05:39:55,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 268185600 05:39:55 INFO - 2015-11-17 05:39:55,430 DEBUG : BROWSER_OUTPUT: 05:39:58 INFO - 2015-11-17 05:39:58,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:39:58 INFO - 2015-11-17 05:39:58,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 268779520 05:39:58 INFO - 2015-11-17 05:39:58,941 DEBUG : BROWSER_OUTPUT: 05:40:01 INFO - 2015-11-17 05:40:01,874 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:02 INFO - 2015-11-17 05:40:02,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 268627968 05:40:02 INFO - 2015-11-17 05:40:02,466 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50497/tests/kraken/driver.html?testName=ai-astar) 05:40:04 INFO - 2015-11-17 05:40:04,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 268632064 05:40:04 INFO - 2015-11-17 05:40:04,600 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,600 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:40:04 INFO - 2015-11-17 05:40:04,600 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:40:04 INFO - 2015-11-17 05:40:04,600 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:40:04 INFO - 2015-11-17 05:40:04,600 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:40:04 INFO - 2015-11-17 05:40:04,601 DEBUG : BROWSER_OUTPUT: |0;ai-astar;127;120;134;128;128;138;128;134;134;128 05:40:04 INFO - 2015-11-17 05:40:04,601 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;177;162;185;189;151;179;183;154;188;150 05:40:04 INFO - 2015-11-17 05:40:04,601 DEBUG : BROWSER_OUTPUT: |2;audio-dft;190;195;212;201;194;192;194;195;197;195 05:40:04 INFO - 2015-11-17 05:40:04,601 DEBUG : BROWSER_OUTPUT: |3;audio-fft;83;89;99;145;81;83;83;83;112;81 05:40:04 INFO - 2015-11-17 05:40:04,601 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;102;105;147;105;108;104;145;104;104;149 05:40:04 INFO - 2015-11-17 05:40:04,601 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;143;139;136;135;136;143;141;136;143 05:40:04 INFO - 2015-11-17 05:40:04,602 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;157;153;149;149;157;150;149;151;157;152 05:40:04 INFO - 2015-11-17 05:40:04,602 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;114;128;128;125;118;130;125;123;122;127 05:40:04 INFO - 2015-11-17 05:40:04,602 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;74;74;74;74;74;76;76;79;77 05:40:04 INFO - 2015-11-17 05:40:04,602 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;81;84;82;84;86;86;84;83;83 05:40:04 INFO - 2015-11-17 05:40:04,602 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;105;102;108;106;105;103;102;101;114;106 05:40:04 INFO - 2015-11-17 05:40:04,602 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;147;156;166;163;155;159;165;154;155;147 05:40:04 INFO - 2015-11-17 05:40:04,603 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;182;181;171;187;189;174;183;181;183;182 05:40:04 INFO - 2015-11-17 05:40:04,603 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;84;84;84;87;87;86;84;85;88 05:40:04 INFO - 2015-11-17 05:40:04,603 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:40:04 INFO - 2015-11-17 05:40:04,603 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:40:04 INFO - 2015-11-17 05:40:04,603 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,730 05:40:04 INFO - 2015-11-17 05:40:04,603 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:40:04 INFO - 2015-11-17 05:40:04,604 DEBUG : BROWSER_OUTPUT: __startTimestamp1447767604594__endTimestamp 05:40:04 INFO - 2015-11-17 05:40:04,604 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,604 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:40:04 INFO - 2015-11-17 05:40:04,604 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:40:04 INFO - 2015-11-17 05:40:04,604 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,604 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:129.90 Median:131.00 stddev:5.13 (3.9%) stddev-sans-first:5.33 05:40:04 INFO - 2015-11-17 05:40:04,604 DEBUG : BROWSER_OUTPUT: Values: 127.0 120.0 134.0 128.0 128.0 138.0 128.0 134.0 134.0 128.0 05:40:04 INFO - 2015-11-17 05:40:04,605 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,605 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:171.80 Median:181.00 stddev:15.84 (8.8%) stddev-sans-first:16.69 05:40:04 INFO - 2015-11-17 05:40:04,605 DEBUG : BROWSER_OUTPUT: Values: 177.0 162.0 185.0 189.0 151.0 179.0 183.0 154.0 188.0 150.0 05:40:04 INFO - 2015-11-17 05:40:04,605 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,605 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:196.50 Median:195.00 stddev:6.17 (3.2%) stddev-sans-first:6.08 05:40:04 INFO - 2015-11-17 05:40:04,606 DEBUG : BROWSER_OUTPUT: Values: 190.0 195.0 212.0 201.0 194.0 192.0 194.0 195.0 197.0 195.0 05:40:04 INFO - 2015-11-17 05:40:04,606 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,606 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.90 Median:83.00 stddev:20.54 (24.7%) stddev-sans-first:21.40 05:40:04 INFO - 2015-11-17 05:40:04,606 DEBUG : BROWSER_OUTPUT: Values: 83.0 89.0 99.0 145.0 81.0 83.0 83.0 83.0 112.0 81.0 05:40:04 INFO - 2015-11-17 05:40:04,606 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,606 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:117.30 Median:106.50 stddev:20.57 (19.3%) stddev-sans-first:21.06 05:40:04 INFO - 2015-11-17 05:40:04,607 DEBUG : BROWSER_OUTPUT: Values: 102.0 105.0 147.0 105.0 108.0 104.0 145.0 104.0 104.0 149.0 05:40:04 INFO - 2015-11-17 05:40:04,607 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,607 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:139.40 Median:141.50 stddev:3.37 (2.4%) stddev-sans-first:3.44 05:40:04 INFO - 2015-11-17 05:40:04,607 DEBUG : BROWSER_OUTPUT: Values: 142.0 143.0 139.0 136.0 135.0 136.0 143.0 141.0 136.0 143.0 05:40:04 INFO - 2015-11-17 05:40:04,607 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,608 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:152.40 Median:152.50 stddev:3.44 (2.3%) stddev-sans-first:3.22 05:40:04 INFO - 2015-11-17 05:40:04,608 DEBUG : BROWSER_OUTPUT: Values: 157.0 153.0 149.0 149.0 157.0 150.0 149.0 151.0 157.0 152.0 05:40:04 INFO - 2015-11-17 05:40:04,608 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,608 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:124.00 Median:126.00 stddev:4.94 (3.9%) stddev-sans-first:3.69 05:40:04 INFO - 2015-11-17 05:40:04,608 DEBUG : BROWSER_OUTPUT: Values: 114.0 128.0 128.0 125.0 118.0 130.0 125.0 123.0 122.0 127.0 05:40:04 INFO - 2015-11-17 05:40:04,608 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,608 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.80 Median:75.00 stddev:2.39 (3.2%) stddev-sans-first:1.80 05:40:04 INFO - 2015-11-17 05:40:04,609 DEBUG : BROWSER_OUTPUT: Values: 70.0 74.0 74.0 74.0 74.0 74.0 76.0 76.0 79.0 77.0 05:40:04 INFO - 2015-11-17 05:40:04,609 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,609 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:83.00 Median:84.00 stddev:2.62 (3.1%) stddev-sans-first:1.66 05:40:04 INFO - 2015-11-17 05:40:04,609 DEBUG : BROWSER_OUTPUT: Values: 77.0 81.0 84.0 82.0 84.0 86.0 86.0 84.0 83.0 83.0 05:40:04 INFO - 2015-11-17 05:40:04,609 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,610 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:105.20 Median:105.50 stddev:3.79 (3.6%) stddev-sans-first:4.02 05:40:04 INFO - 2015-11-17 05:40:04,610 DEBUG : BROWSER_OUTPUT: Values: 105.0 102.0 108.0 106.0 105.0 103.0 102.0 101.0 114.0 106.0 05:40:04 INFO - 2015-11-17 05:40:04,610 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,610 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:156.70 Median:157.50 stddev:6.68 (4.2%) stddev-sans-first:6.10 05:40:04 INFO - 2015-11-17 05:40:04,611 DEBUG : BROWSER_OUTPUT: Values: 147.0 156.0 166.0 163.0 155.0 159.0 165.0 154.0 155.0 147.0 05:40:04 INFO - 2015-11-17 05:40:04,611 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,612 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.30 Median:182.50 stddev:5.36 (2.9%) stddev-sans-first:5.67 05:40:04 INFO - 2015-11-17 05:40:04,612 DEBUG : BROWSER_OUTPUT: Values: 182.0 181.0 171.0 187.0 189.0 174.0 183.0 181.0 183.0 182.0 05:40:04 INFO - 2015-11-17 05:40:04,612 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-11-17 05:40:04,612 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.80 Median:85.50 stddev:2.53 (3.0%) stddev-sans-first:1.59 05:40:04 INFO - 2015-11-17 05:40:04,612 DEBUG : BROWSER_OUTPUT: Values: 79.0 84.0 84.0 84.0 87.0 87.0 86.0 84.0 85.0 88.0 05:40:04 INFO - 2015-11-17 05:40:04,612 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:40:04 INFO - 2015-11-17 05:40:04,612 DEBUG : BROWSER_OUTPUT: 05:40:05 INFO - 2015-11-17 05:40:05,345 INFO : Browser exited with error code: 0 05:40:05 INFO - 2015-11-17 05:40:05,399 INFO : Completed test kraken (00:01:02) 05:40:05 INFO - 2015-11-17 05:40:05,399 INFO : Starting test v8_7 05:40:05 INFO - 2015-11-17 05:40:05,399 DEBUG : operating with platform_type : mac_ 05:40:05 INFO - 2015-11-17 05:40:05,399 INFO : Initialising browser for v8_7 test... 05:40:05 INFO - 2015-11-17 05:40:05,413 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmphvSeLe/profile http://localhost:50497/getInfo.html 05:40:08 INFO - 2015-11-17 05:40:08,522 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:40:08 INFO - 2015-11-17 05:40:08,523 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:40:08 INFO - 2015-11-17 05:40:08,523 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:40:08 INFO - 2015-11-17 05:40:08,523 DEBUG : BROWSER_OUTPUT: __metrics 05:40:09 INFO - 2015-11-17 05:40:09,205 INFO : Browser initialized. 05:40:09 INFO - 2015-11-17 05:40:09,205 INFO : Running cycle 1/1 for v8_7 test... 05:40:09 INFO - 2015-11-17 05:40:09,205 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/T/tmphvSeLe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:40:21 INFO - 2015-11-17 05:40:21,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 240308224 05:40:21 INFO - 2015-11-17 05:40:21,398 DEBUG : BROWSER_OUTPUT: 05:40:43 INFO - 2015-11-17 05:40:43,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50497/tests/v8_7/run.html (next: http://localhost:50497/tests/v8_7/run.html) 05:40:44 INFO - 2015-11-17 05:40:44,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 260648960 05:40:44 INFO - 2015-11-17 05:40:44,230 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,230 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:40:44 INFO - 2015-11-17 05:40:44,230 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:40:44 INFO - 2015-11-17 05:40:44,231 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:40:44 INFO - 2015-11-17 05:40:44,231 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:40:44 INFO - 2015-11-17 05:40:44,231 DEBUG : BROWSER_OUTPUT: |0;Richards;193.6108422071636 05:40:44 INFO - 2015-11-17 05:40:44,231 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;226.86025408348456 05:40:44 INFO - 2015-11-17 05:40:44,231 DEBUG : BROWSER_OUTPUT: |2;Encrypt;370.78235076010384 05:40:44 INFO - 2015-11-17 05:40:44,231 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6744.96644295302 05:40:44 INFO - 2015-11-17 05:40:44,231 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1298.313878080415 05:40:44 INFO - 2015-11-17 05:40:44,231 DEBUG : BROWSER_OUTPUT: |5;Earley;1057.0824524312895 05:40:44 INFO - 2015-11-17 05:40:44,232 DEBUG : BROWSER_OUTPUT: |6;Boyer;14637.68115942029 05:40:44 INFO - 2015-11-17 05:40:44,232 DEBUG : BROWSER_OUTPUT: |7;RegExp;33550 05:40:44 INFO - 2015-11-17 05:40:44,232 DEBUG : BROWSER_OUTPUT: |8;Splay;708.2152974504249 05:40:44 INFO - 2015-11-17 05:40:44,232 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6693.333333333333 05:40:44 INFO - 2015-11-17 05:40:44,232 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:40:44 INFO - 2015-11-17 05:40:44,232 DEBUG : BROWSER_OUTPUT: __startTimestamp1447767644221__endTimestamp 05:40:44 INFO - 2015-11-17 05:40:44,232 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,232 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:40:44 INFO - 2015-11-17 05:40:44,233 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:40:44 INFO - 2015-11-17 05:40:44,233 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,233 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:193.61 Median:193.61 stddev:0.00 (0.0%) 05:40:44 INFO - 2015-11-17 05:40:44,233 DEBUG : BROWSER_OUTPUT: Values: 193.6 05:40:44 INFO - 2015-11-17 05:40:44,233 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,233 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:226.86 Median:226.86 stddev:0.00 (0.0%) 05:40:44 INFO - 2015-11-17 05:40:44,233 DEBUG : BROWSER_OUTPUT: Values: 226.9 05:40:44 INFO - 2015-11-17 05:40:44,233 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,234 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:370.78 Median:370.78 stddev:0.00 (0.0%) 05:40:44 INFO - 2015-11-17 05:40:44,234 DEBUG : BROWSER_OUTPUT: Values: 370.8 05:40:44 INFO - 2015-11-17 05:40:44,234 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,234 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6744.97 Median:6744.97 stddev:0.00 (0.0%) 05:40:44 INFO - 2015-11-17 05:40:44,234 DEBUG : BROWSER_OUTPUT: Values: 6745.0 05:40:44 INFO - 2015-11-17 05:40:44,234 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,234 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1298.31 Median:1298.31 stddev:0.00 (0.0%) 05:40:44 INFO - 2015-11-17 05:40:44,234 DEBUG : BROWSER_OUTPUT: Values: 1298.3 05:40:44 INFO - 2015-11-17 05:40:44,235 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,235 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1057.08 Median:1057.08 stddev:0.00 (0.0%) 05:40:44 INFO - 2015-11-17 05:40:44,235 DEBUG : BROWSER_OUTPUT: Values: 1057.1 05:40:44 INFO - 2015-11-17 05:40:44,235 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,235 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14637.68 Median:14637.68 stddev:0.00 (0.0%) 05:40:44 INFO - 2015-11-17 05:40:44,235 DEBUG : BROWSER_OUTPUT: Values: 14637.7 05:40:44 INFO - 2015-11-17 05:40:44,235 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,236 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33550.00 Median:33550.00 stddev:0.00 (0.0%) 05:40:44 INFO - 2015-11-17 05:40:44,236 DEBUG : BROWSER_OUTPUT: Values: 33550.0 05:40:44 INFO - 2015-11-17 05:40:44,236 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,236 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:708.22 Median:708.22 stddev:0.00 (0.0%) 05:40:44 INFO - 2015-11-17 05:40:44,236 DEBUG : BROWSER_OUTPUT: Values: 708.2 05:40:44 INFO - 2015-11-17 05:40:44,236 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,236 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6693.33 Median:6693.33 stddev:0.00 (0.0%) 05:40:44 INFO - 2015-11-17 05:40:44,236 DEBUG : BROWSER_OUTPUT: Values: 6693.3 05:40:44 INFO - 2015-11-17 05:40:44,236 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:40:44 INFO - 2015-11-17 05:40:44,237 DEBUG : BROWSER_OUTPUT: 05:40:44 INFO - 2015-11-17 05:40:44,935 INFO : Browser exited with error code: 0 05:40:44 INFO - 2015-11-17 05:40:44,957 INFO : Completed test v8_7 (00:00:39) 05:40:45 INFO - 2015-11-17 05:40:45,225 INFO : Completed test suite (00:20:14) 05:40:45 INFO - 2015-11-17 05:40:45,226 DEBUG : Working with test: dromaeo_css 05:40:45 INFO - 2015-11-17 05:40:45,226 DEBUG : Generating results file: dromaeo_css 05:40:45 INFO - 2015-11-17 05:40:45,226 DEBUG : Working with test: kraken 05:40:45 INFO - 2015-11-17 05:40:45,227 DEBUG : Generating results file: kraken 05:40:45 INFO - 2015-11-17 05:40:45,227 INFO : javascript benchmark 05:40:45 INFO - 2015-11-17 05:40:45,227 DEBUG : Working with test: v8_7 05:40:45 INFO - 2015-11-17 05:40:45,227 DEBUG : Generating results file: v8_7 05:40:45 INFO - 2015-11-17 05:40:45,227 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:40:45 INFO - 2015-11-17 05:40:45,284 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 05:40:45 INFO - 2015-11-17 05:40:45,284 DEBUG : process_Request line: dromaeo_css 5645.23 graph.html#tests=[[72,1,57]] 05:40:45 INFO - 2015-11-17 05:40:45,284 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:40:45 INFO - 2015-11-17 05:40:45,358 DEBUG : process_Request line: kraken 1811.00 graph.html#tests=[[232,1,57]] 05:40:45 INFO - 2015-11-17 05:40:45,358 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:40:45 INFO - 2015-11-17 05:40:45,432 DEBUG : process_Request line: v8_7 16803.23 graph.html#tests=[[230,1,57]] 05:40:45 INFO - 2015-11-17 05:40:45,433 INFO : javascript benchmark 05:40:45 INFO - 2015-11-17 05:40:45,435 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [286.17581365666877, 288.8844462215114, 291.59613934700434, 293.8501364304205, 297.48386549336897, 8720.65117395305, 9016.0, 14786.630334241636, 14930.328135233913, 15342.156181410031, 9247.815043699122, 9668.903310966889, 9901.257405694583, 10191.643292484765, 10233.181345492361, 3700.1859590889962, 3809.8857034288876, 3816.751911125782, 3818.6372294632106, 3820.083180036799, 2913.3153708878394, 2988.5218365061596, 3748.9437658435145, 4006.298897692907, 4138.730982486144, 4033.9596604034023, 4051.8379264829373, 4057.0, 4067.5932406759234, 4081.1837632473475, 3797.6012518685693, 4102.733322334038, 4104.466419365478, 4107.342825147977, 4113.856015039474, 3360.092774950774, 3366.495025746158, 3373.122988023107, 3379.983100084484, 3387.4749413840896, 11036.227464077438, 11080.335179889233, 11194.832077518844, 11261.042811361043, 11282.266652667633, 1496.9850301496954, 1557.2914323982561, 1665.2839279110099, 1742.1550547984218, 1749.860011199101, 6830.0, 7952.244536768998, 8138.593070346459, 8167.591620419014, 8235.13531079234, 1262.2994238197796, 1286.1318609938255, 1301.3883474766844, 1307.8626744191818, 1358.6195865157772, 47769.76115119402, 50519.0, 50555.49444505582, 50717.239241411036, 51261.74369128168, 5573.359063707644, 5605.635633683797, 5638.069718496484, 5653.660780353192, 5658.179563963202, 6379.266384365765, 6386.074019267273, 6405.071264666691, 6411.6153030818305, 6412.839679008062, 4638.536146385402, 4724.196886529298, 4737.8341758039, 4745.549172828576, 4761.833335833229, 5074.314967479343, 5080.390353157571, 5099.77051032697, 5100.515451032146, 5109.131447653907, 2521.6217567364674, 2551.4386834896295, 2556.169244995384, 2558.06630579837, 2567.9229623111337, 884.9424787388799, 890.3633901760272, 890.7951171230653, 918.4626993209048, 952.5284983932859, 330.61813605285454, 330.76350409457353, 360.49170669356084, 365.14920235850406, 387.8351700527265, 8508.489490630582, 9030.774230644154, 9270.72187834366, 10125.189984801345, 10197.388156710473, 388.69875846219406, 389.36339085595256, 395.66566251517423, 398.44218094667696, 408.86916186820525, 5320.361556613231, 5461.972690136603, 5531.529819965268, 5555.527780138734, 5558.666480011131, 306376.0, 307328.0, 310792.0, 311831.0, 312097.0, 52968.73515632397, 55521.44478555163, 56038.43961560414, 56517.71741141268, 57304.14043789347, 427.92511310520536, 445.243086752522, 445.5477690144506, 446.16121691220945, 447.37144312241355, 9372.765680858032, 9384.624615015324, 9421.434713917188, 9434.198093161884, 9533.523323833642, 28401.28996775097, 29207.561886571293, 29784.255393614465, 29960.25099372533, 29961.550576741804, 39751.0, 40258.19483610253, 40898.0, 41591.37612935869, 41894.790526047174, 5128.1794912813775, 5281.947180528299, 5388.838334849961, 5398.325209348832, 5406.21609866575, 10002.099811017044, 10195.031472010147, 10326.380417174994, 10330.225233107396, 10338.638147664795, 7215.963920180576, 8624.741257762276, 8798.912010879809, 8804.60379282921, 8834.911650883409, 8532.701355452778, 8588.312934965314, 8611.870821937551, 8629.0, 8782.209601135928, 8749.6937607186, 8775.507166565021, 9054.502002389932, 9067.229285510806, 9075.047120052299, 5221.765020574007, 5270.262163297218, 5273.683578985273, 5289.338832645919, 5299.2316114164005, 8570.4000719949, 8754.562271886507, 8786.341024423065, 8801.867971980297, 8897.510636915033], "dojo.html": [2717.320669832542, 2721.6733991920973, 2736.65791776028, 2751.683556391016, 2776.5973933779596, 4377.606015458608, 4504.50450450451, 4506.6845320827515, 4535.229011068118, 4627.097715945392, 4496.460424749034, 4587.931181032279, 4593.908121837561, 4634.791434385453, 4708.717476951377, 4284.785760711968, 4342.826286948518, 4387.29803231483, 4399.780010999437, 4430.136123455927, 4326.5673432656795, 4374.9999999999845, 4389.012472193763, 4408.581184787457, 4442.0, 4193.370994350841, 4209.0, 4250.702450828428, 4274.636655884254, 4295.52749197588, 4330.2638551446325, 4341.544137865541, 4354.455693038371, 4379.540148284448, 4388.1223755249075, 4151.045259590281, 4302.462192225972, 4327.783610819478, 4340.631046361063, 4382.561743825624, 4483.910321793546, 4563.383943167663, 4631.305304204363, 4651.000034992459, 4660.766961651938, 4825.517448255181, 4866.0, 4908.116539022974, 4916.410030796292, 4926.014797040571, 4904.4605093439695, 4956.355673762388, 4975.079610272075, 5012.423571289275, 5059.3169922060415, 4645.86062418128, 4693.225617773098, 4704.317873908264, 4712.811487540528, 4719.9292010619865, 4944.406671199407, 5043.924341134886, 5140.871478213, 5142.640015198975, 5191.844244672666, 4780.354652121989, 4817.181079216542, 4875.609951203895, 4897.926531102036, 4916.0905232532095, 5045.445001049881, 5046.066477701637, 5052.873678158002, 5066.620003499752, 5110.821121260738, 4784.617230621542, 4899.583535399531, 4952.678075925053, 4964.15609346412, 5009.949900501021, 4857.344258525054, 4881.804727810848, 4886.389201349832, 4899.902001959941, 4938.259261110862, 3859.1316953685196, 3860.613938606173, 3890.3386424307937, 3908.3746600544346, 3922.843086276574, 3420.931581368359, 3435.261418794971, 3501.2122272488486, 3533.8409771559827, 3573.017420209463, 4660.533946605312, 4689.366935463737, 4746.406699162605, 4763.928541071887, 4812.951870481321, 5024.949750502521, 5032.47159048302, 5033.647644664911, 5050.873728156826, 5062.316587260672, 4566.223741963874, 4645.953540464619, 4699.083678682624, 4724.71651700899, 4768.0, 4360.825566977285, 4367.541408152162, 4375.671824613167, 4387.780610969438, 4427.46870375557, 5075.137226671474, 5104.795808167706, 5126.436092029874, 5143.228515722672, 5172.431032586337, 4901.5588597026435, 4930.482299358516, 4972.477889821516, 5027.497250274943, 5031.798728050983, 5069.7718602662235, 5075.3402057732255, 5076.18780995039, 5097.7706003229205, 5137.640365174402, 4828.806847726051, 4868.196747536616, 4875.634327425386, 4876.414830220397, 4880.829170978998, 4736.50266722003, 4863.0, 4886.682365646222, 4913.877153071202, 4979.651424400257, 4850.490698476609, 4884.267359896044, 4895.828645997373, 4904.607631389552, 4931.778069986931, 4704.92942605868, 4875.414950205998, 4879.682820616648, 4881.51184881509, 4931.0, 4628.2363410038315, 4661.394018777537, 4682.531746825291, 4739.905201896012, 4773.307870358709, 4776.713397196179, 4868.41579010521, 4875.853724388274, 4907.435644900882, 4934.0, 4661.766911654471, 4753.904921901473, 4766.737829419415, 4788.569028787426, 4826.0830442215865], "mootools.html": [1441.8341890682575, 1515.57563882113, 1540.722669919414, 1555.1602134847183, 1583.8574528292452, 6412.166418365618, 6558.442532384753, 6775.728970841166, 7247.782566522999, 7284.708611655534, 6703.497237707179, 6781.423578995791, 6880.380765731084, 6899.793006209809, 6921.34247246512, 1979.7921218272127, 1998.7201791749167, 2003.789602091774, 2004.7293615361957, 2011.4468521156653, 1997.530580313625, 2035.1045539962442, 2042.0504465423576, 2046.498607841081, 2051.979480205201, 1911.7514723085978, 1913.378152100566, 1928.864979451439, 1948.4933917181493, 1961.9411417657493, 2001.3995801259564, 2029.8883561404116, 2032.7865574114653, 2033.4509682385674, 2033.5526184239443, 1959.12818795636, 1998.960020799576, 1999.8300144487737, 2006.297795771483, 2014.5870096630301, 7055.611941343224, 7099.929000709978, 7146.071010768619, 7151.856962860766, 7155.785326440215, 4334.783260836945, 4435.1573201092015, 4442.044960333512, 4443.111377724468, 4444.400005999213, 2548.210054882992, 2591.9740802591923, 2615.189291319697, 2620.2270330252622, 2629.9605505917425, 752.6086435053742, 759.9354054905284, 761.9161892191854, 787.4055088408215, 788.7081779741475, 9370.85943710845, 9372.625094996192, 9375.062493750638, 9376.296777741696, 9416.717498475056, 3793.393057110849, 3815.740805534167, 3824.0, 3842.7502212356108, 3870.3807390817897, 8020.83958320842, 8066.435349525595, 8096.595170241464, 8096.878546821802, 8113.8377232456205, 4284.914301713949, 4294.914101718011, 4310.80601372939, 4315.741055536678, 4319.892002699895, 3397.5413319202084, 3461.7922924624604, 3882.825272862728, 3882.9223415531533, 3886.7473614214987, 3260.5598244236726, 3327.93344133116, 3344.4314466540745, 3365.209175843675, 3389.7627166098628, 1077.9029887310023, 1093.4095588382183, 1094.9726256843483, 1099.9230053896151, 1102.030213412192, 901.0268909577641, 940.4686352210979, 1145.2498613408231, 1172.4489489939715, 1179.628417048627, 6652.534322597468, 6717.1267735194115, 6730.158730158731, 6738.0, 6739.528233023641, 992.8014397120605, 998.2064258914181, 1003.1623594298842, 1026.0509029148009, 1037.911777498921, 5253.290805741252, 5258.8159414420315, 5282.445343238905, 5288.92066619001, 5297.390800058042, 8080.313173380211, 8283.25450709439, 8306.210909963544, 8325.708600199085, 8480.321574274043, 8146.83706325882, 8170.714025009096, 8198.795030124294, 8207.466514676527, 8216.753497395088, 6488.545801793924, 6543.9345606544275, 6630.767923122764, 6680.498962577826, 6685.0, 6614.239362473185, 6653.367930046637, 6653.9667301663185, 6661.566998145105, 6665.100211471389, 7289.489735718449, 7452.105747310357, 7467.887981680387, 7478.326950574475, 7525.247475252431, 7250.383717384081, 7311.780646580611, 7470.663820127998, 7593.0, 7707.306342429209, 5624.943750562606, 5815.709214539341, 6031.75872965094, 6154.692265386623, 6156.199694039746, 6442.130312407765, 6483.870322593616, 6652.334766523309, 6694.866102678016, 6697.732090716511, 6145.0782382642965, 6161.106639537332, 6242.875142497215, 6324.30432652417, 6362.300146983921, 6010.819675409744, 6132.325444201045, 6179.938200617937, 6205.906911396423, 6284.08880712285, 6295.0, 6321.462675672619, 6346.777862774781, 6350.968245158745, 6364.236291645032, 5734.713264336683, 5758.539316854558, 5760.8271751847515, 5768.884622307614, 5770.942290577041, 5818.0981947798155, 5843.328017278068, 5872.941270587239, 5888.617239879394, 5897.056470964625], "ext.html": [474.459116607068, 489.92651102334645, 490.98527044188677, 506.1244047797309, 517.4695936664921, 32232.0, 32966.83516582414, 33211.66788332116, 33244.176919654215, 33283.83358083206, 36019.0, 36767.63232367676, 36836.63163368365, 36907.44638830413, 36914.8154259229, 7972.481788683732, 8097.190280971915, 8104.837903241932, 8137.796555086141, 8149.225823546783, 8002.119766825645, 8108.270255677017, 8123.918760812376, 8140.1452847450755, 8147.063087744897, 8044.316233120192, 8138.755837324889, 8139.877901831477, 8146.389020823462, 8164.265216130547, 7967.0, 8061.556614386206, 8064.153263907264, 8084.6766129354755, 8095.219051808593, 7973.521588704696, 8085.514869107814, 8098.676052957874, 8105.230003149692, 8106.513609183467, 34106.82946585276, 34446.827765861264, 34501.6549834501, 34589.13527161841, 34620.65379346199, 2128.063651993118, 2290.599145149609, 2315.706683790552, 2542.478791847667, 2678.1965410377, 24771.161930886472, 25718.22845314625, 26101.73898261012, 26108.60837087445, 26248.60627090595, 2039.3474088291753, 2040.8775473471492, 2053.620080285152, 2056.4961584411767, 2060.258307009475, 229019.0, 230031.0, 230085.0, 230780.0, 230908.9999999983, 35052.82473587616, 35851.64148358483, 35866.0, 35925.46111808325, 53023.46976530185, 34990.82504587511, 35378.64621353753, 35416.46875296873, 35453.64546354555, 35489.46765798515, 12942.094053416358, 13106.934465327613, 13249.205047697169, 13273.070885037954, 13297.734045319234, 10479.0, 10571.524281407355, 10629.5216715248, 10637.308574942605, 10729.195310351599, 12117.69705757363, 12123.939380303042, 12125.151239413157, 12147.93926030382, 12187.329696866758, 5343.0, 5365.302510673588, 5367.409584945653, 5382.623216374816, 5417.83746487606, 793.8729803231455, 799.9080105787909, 819.6024927909959, 937.779621788879, 949.9408159901798, 24361.756382436302, 24401.145959891317, 24676.876615616806, 24694.876525617256, 24702.505949880902, 927.9304052196112, 943.4999450291357, 978.0610613810679, 984.5520288268821, 991.4844280973854, 12769.68075798094, 12829.743405131845, 12878.0, 14286.928565357315, 14340.498082567268, 241242.0, 245961.0, 247378.0, 247432.0, 248541.0, 51998.0, 53637.46362536403, 53770.46229537654, 53871.73064134654, 53963.0, 1219.2136072233536, 1236.8948639365756, 1247.0771628994478, 1254.8117782332722, 1255.5668294438403, 26303.73696263013, 27094.100317079556, 27212.183634490997, 27342.45315093647, 27398.0, 41737.58262417458, 42029.0, 42065.369019464124, 42074.7896260529, 42132.157356853306, 232947.0, 237141.0, 237153.0, 237242.0, 239030.0, 28998.565021525115, 29312.706872931853, 39688.0, 41271.793641032804, 41358.79320603498, 37474.250514989006, 37729.81135094307, 37894.0, 38101.23797523978, 38676.22647546977, 31517.36965260636, 32368.676313236567, 32398.514022290157, 32509.674903250663, 32577.597840755545, 30895.691043089282, 31469.8426507866, 31523.0, 31553.368932621677, 31555.053348399586, 31772.20569485689, 32489.675103248665, 32827.67172328246, 32882.34235315328, 32885.50671739878, 27098.1870543884, 28316.43367132687, 28407.28981775472, 28638.48600477318, 28831.56752648754, 21113.78886211118, 21409.892950535148, 21569.460763481038, 21570.892145539172, 21702.829717028802], "prototype.html": [271.9918402447927, 276.2720232188185, 282.39285536097384, 283.37374402570333, 284.056930989116, 5259.8422047338545, 5428.538574221186, 5553.055980483317, 5567.4432556744305, 5584.134459158832, 5421.620486565942, 5532.114861622142, 5562.360328562217, 5568.053430916743, 5572.080606699889, 4203.684723645723, 4218.810153543082, 4219.324908014718, 4235.068284977316, 4246.532881383046, 4200.57994200579, 4200.97899510502, 4217.8312867485265, 4220.282551966157, 4224.97887510562, 4167.312393455076, 4174.22776786294, 4174.519930208019, 4186.099988502471, 4239.745615263078, 4048.271311163989, 4157.293260145767, 4181.1010632714115, 4192.0925978679625, 4197.496300443966, 3577.0342007657787, 3591.982040089783, 3602.189507360849, 3604.6034936157266, 3609.8014609196484, 5185.974070129663, 5343.011542864582, 5436.130219164954, 5442.755076021588, 5473.75368108436, 4572.588467037983, 4701.0, 4734.0, 4744.074905393415, 4765.928511072337, 5767.538596912237, 5776.682282474462, 5779.33537643168, 5782.45066718661, 5787.218725472049, 3924.489816323888, 3925.8429662813455, 3930.3514920038447, 3931.272714547818, 3931.842726290945, 5918.874373422928, 5994.310654274771, 6087.847803804896, 6097.908531372077, 6103.908441373383, 4011.0774521860135, 4018.598140185958, 4020.3165461871554, 4022.8189731462153, 4025.577314381948, 4071.1247081877536, 4085.8774236772942, 4089.7750623715388, 4090.8977275567754, 4107.034846810997, 4714.504976977368, 4719.056188762262, 4720.881977950578, 4726.338312636233, 4742.691725037862, 5629.240052592848, 5792.797252096157, 5799.449052340021, 5800.4489573490455, 5816.912746308809, 1416.221078406872, 1437.0874494695734, 1443.0547991065869, 1448.5943935698022, 1448.9275536223147, 945.6028468043438, 947.0860619502075, 952.4190243951184, 959.8704174936433, 964.9710508684751, 5584.553235741212, 5587.106063029895, 5593.692346920877, 5599.216109744639, 5613.831585052455, 6033.909491357633, 6034.487068599218, 6048.848778780478, 6061.060535616986, 6078.665673388006, 5537.916931246034, 5546.862893106903, 5554.527865131509, 5576.7211639417865, 5580.944190558123, 3147.937041259162, 3264.396086723964, 3293.4730443129465, 3294.0776582556923, 3296.208909861616, 6233.563650544509, 6238.875222495615, 6242.812715618538, 6244.250689917239, 6263.123162757218, 6069.969650151809, 6203.518592563011, 6206.503479721611, 6225.688715564203, 6287.779927702509, 6232.470240029648, 6288.402601752826, 6313.621182729051, 6313.810585682529, 6338.334474880164, 6103.023516237381, 6119.510439164767, 6123.7550497981365, 6124.908126378019, 6130.570860039755, 5717.971410142923, 5960.672163031075, 5976.731047102978, 5983.551233657406, 5991.310999235144, 6259.2488901332135, 6262.74949002053, 6267.2479302484, 6280.623162610258, 6301.527385446201, 3849.9615003849603, 3889.9027524310986, 3905.785181814914, 3932.5477570079806, 3937.5668676444993, 6006.699665016819, 6006.969965150146, 6018.187544681412, 6020.367861374492, 6043.576949613484, 5731.426857314235, 5843.532517398683, 5917.437843404869, 5921.230240068763, 5941.940580594139, 5868.178455016387, 5879.647221166743, 5880.235569376125, 5899.321578018583, 5901.5868889177345, 5729.2265544151005, 5731.312242530923, 5732.856678583069, 5737.684427356536, 5740.536163278337, 5717.514011309086, 5871.559633027455, 5881.852953676193, 5882.647041177543, 5914.408559144051, 5723.141528770718, 5765.077587585966, 5772.249607550992, 5780.537556995514, 5794.188813566188], "yui.html": [621.9937800621996, 639.0892977507051, 639.3063526074208, 644.3105876711915, 644.8968165093585, 8712.346574006951, 8964.686235981733, 8989.101089891008, 9692.0, 9818.312718109735, 9358.204552613037, 9446.85829712555, 9460.10129037742, 9486.76283092923, 9492.857607135882, 598.8951933411657, 728.5701436152669, 735.6763024269331, 741.1402772783572, 744.0661969228638, 597.6981624279732, 735.6358602491747, 746.7908985484073, 751.0236692300016, 751.5002523322012, 748.9138749043848, 766.3945483068369, 766.4519868294169, 767.6967597798894, 770.0874463760434, 743.3012967810241, 757.7613051888637, 759.1535437986632, 759.7492827366983, 759.8632246195682, 562.3673367461606, 562.6342877129857, 566.9433056694339, 570.0, 570.8629928817096, 8489.702860399857, 8612.267957223643, 8612.39713220075, 8630.180132887366, 8632.093630168805, 7590.58251796151, 7817.1791961843755, 7988.640511177011, 8172.141925097839, 8289.875651865226, 6984.930150698478, 7130.108736407949, 7235.529690570149, 7281.708731650728, 7660.621088204121, 2415.3268891484304, 2492.0779311654805, 2511.5855883779154, 2520.9117680881263, 2562.359410147463, 40155.59844401577, 40283.0, 40619.7969010156, 40649.0, 41175.38236926449, 5323.547498462596, 5489.725513724377, 5507.449255074461, 5534.557235421156, 5633.915491267634, 9569.234461243223, 9598.18415434682, 9602.039796020343, 9610.615575376907, 9618.0, 4680.812767489262, 4762.214234651313, 4801.663883528119, 4809.2305231162845, 4833.564979151894, 2994.595729576523, 2998.9953365622323, 3028.2126647071477, 3044.3606842562867, 3057.312104776452, 2144.7855214478427, 2152.1068756465893, 2158.5035441848463, 2164.945876353104, 2168.20860385958, 347.28632659883675, 350.3938186936563, 351.8223297234931, 352.68082385441215, 353.1084012867479, 409.9405586189986, 411.4856429463171, 449.5212598582499, 450.96843220974876, 483.5841176588131, 5988.101784732325, 6010.158577799111, 6092.51259899207, 6105.145279660851, 6352.7141278642575, 402.5531659857556, 442.1665161171151, 446.3750748951429, 475.70030880545727, 492.44845772734766, 2993.1918382037165, 3205.182678416989, 3231.1760501072545, 3247.415465216284, 3297.274599588087, 44304.556954430685, 45580.3162952556, 52315.215271770954, 52417.213741793144, 52965.470345296824, 40931.386029209585, 41159.7942010288, 41428.37857432141, 41672.374914376305, 41714.37428438576, 39482.60517394847, 40400.39399409011, 41098.58901410948, 41334.379984300256, 41418.8935829814, 6588.7364505421165, 6844.0, 6951.096357473496, 7042.6126563039525, 7062.0, 29168.541572921695, 29783.851080744458, 31401.37197256088, 32002.0, 32408.83795581007, 39366.60633393744, 39658.80170599244, 39967.20065598613, 40063.19873602453, 40351.1929761409, 5950.19672344228, 6054.48536874353, 6055.0, 6116.633002019715, 6140.539459540463, 8651.820269267178, 8905.51019693923, 8973.685920992733, 9069.64332919357, 9171.312151588523, 8363.498190108612, 8610.268127209007, 8645.654173832976, 8650.394472386872, 8800.075992020746, 8274.069816836954, 8425.241728244242, 8459.661613535636, 8622.180892815173, 8751.124887511198, 8352.0, 8419.284360829153, 8427.536485493356, 8666.739997800076, 8898.975721921806, 6509.414152726277, 6961.860762784817, 6967.686454109476, 7074.409098368285, 7602.581857997863, 6687.899681504684, 7017.578945263301, 7148.499605027599, 7297.963510182415, 7504.774856754306]}, "summary": {"lowerIsBetter": false, "suite": 5645.232878682572, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5526.053897293077, "unit": "ms", "value": 5526.053897293077}, "dojo.html": {"lowerIsBetter": false, "filtered": 4597.478864801889, "unit": "ms", "value": 4597.478864801889}, "mootools.html": {"lowerIsBetter": false, "filtered": 4006.1837877722337, "unit": "ms", "value": 4006.1837877722337}, "ext.html": {"lowerIsBetter": false, "filtered": 15589.72302339773, "unit": "ms", "value": 15589.72302339773}, "prototype.html": {"lowerIsBetter": false, "filtered": 4363.382054327617, "unit": "ms", "value": 4363.382054327617}, "yui.html": {"lowerIsBetter": false, "filtered": 4674.376034010595, "unit": "ms", "value": 4674.376034010595}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0031.e"}, "testrun": {"date": 1447766430, "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": "20151117031105", "branch": "Firefox", "revision": "0e3b216c93f698f295e42910f442df42616fe003"}}, {"talos_counters": {}, "results": {"audio-dft": [190.0, 195.0, 212.0, 201.0, 194.0, 192.0, 194.0, 195.0, 197.0, 195.0], "ai-astar": [127.0, 120.0, 134.0, 128.0, 128.0, 138.0, 128.0, 134.0, 134.0, 128.0], "imaging-gaussian-blur": [142.0, 143.0, 139.0, 136.0, 135.0, 136.0, 143.0, 141.0, 136.0, 143.0], "audio-beat-detection": [177.0, 162.0, 185.0, 189.0, 151.0, 179.0, 183.0, 154.0, 188.0, 150.0], "json-stringify-tinderbox": [77.0, 81.0, 84.0, 82.0, 84.0, 86.0, 86.0, 84.0, 83.0, 83.0], "stanford-crypto-pbkdf2": [182.0, 181.0, 171.0, 187.0, 189.0, 174.0, 183.0, 181.0, 183.0, 182.0], "json-parse-financial": [70.0, 74.0, 74.0, 74.0, 74.0, 74.0, 76.0, 76.0, 79.0, 77.0], "stanford-crypto-sha256-iterative": [79.0, 84.0, 84.0, 84.0, 87.0, 87.0, 86.0, 84.0, 85.0, 88.0], "audio-fft": [83.0, 89.0, 99.0, 145.0, 81.0, 83.0, 83.0, 83.0, 112.0, 81.0], "imaging-darkroom": [157.0, 153.0, 149.0, 149.0, 157.0, 150.0, 149.0, 151.0, 157.0, 152.0], "stanford-crypto-ccm": [147.0, 156.0, 166.0, 163.0, 155.0, 159.0, 165.0, 154.0, 155.0, 147.0], "audio-oscillator": [102.0, 105.0, 147.0, 105.0, 108.0, 104.0, 145.0, 104.0, 104.0, 149.0], "stanford-crypto-aes": [105.0, 102.0, 108.0, 106.0, 105.0, 103.0, 102.0, 101.0, 114.0, 106.0], "imaging-desaturate": [114.0, 128.0, 128.0, 125.0, 118.0, 130.0, 125.0, 123.0, 122.0, 127.0]}, "summary": {"lowerIsBetter": true, "suite": 1810.9999999999998, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 93.9, "unit": "ms", "value": 93.9}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 181.3, "unit": "ms", "value": 181.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 171.8, "unit": "ms", "value": 171.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 156.7, "unit": "ms", "value": 156.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 152.4, "unit": "ms", "value": 152.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 74.8, "unit": "ms", "value": 74.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 117.3, "unit": "ms", "value": 117.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 129.9, "unit": "ms", "value": 129.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 196.5, "unit": "ms", "value": 196.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 84.8, "unit": "ms", "value": 84.8}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 83.0, "unit": "ms", "value": 83.0}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 139.4, "unit": "ms", "value": 139.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 105.2, "unit": "ms", "value": 105.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 124.0, "unit": "ms", "value": 124.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0031.e"}, "testrun": {"date": 1447766430, "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": "20151117031105", "branch": "Firefox", "revision": "0e3b216c93f698f295e42910f442df42616fe003"}}, {"talos_counters": {}, "results": {"DeltaBlue": [226.86025408348456], "Encrypt": [370.78235076010384], "NavierStokes": [6693.333333333333], "Decrypt": [6744.96644295302], "Splay": [708.2152974504249], "Richards": [193.6108422071636], "RegExp": [33550.0], "Earley": [1057.0824524312895], "Boyer": [14637.68115942029], "RayTrace": [1298.313878080415]}, "summary": {"lowerIsBetter": false, "suite": 16803.22832146226, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 291.4481440000001, "unit": "score", "value": 291.4481440000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 717.8901570000002, "unit": "score", "value": 717.8901570000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 221.71314741035866, "unit": "score", "value": 221.71314741035866}, "Decrypt": {"lowerIsBetter": false, "filtered": 39.46365074626863, "unit": "score", "value": 39.46365074626863}, "Splay": {"lowerIsBetter": false, "filtered": 115.06529199999996, "unit": "score", "value": 115.06529199999996}, "RegExp": {"lowerIsBetter": false, "filtered": 27.153055141579724, "unit": "score", "value": 27.153055141579724}, "Richards": {"lowerIsBetter": false, "filtered": 182.33482999999993, "unit": "score", "value": 182.33482999999993}, "Earley": {"lowerIsBetter": false, "filtered": 630.4739979999999, "unit": "score", "value": 630.4739979999999}, "Boyer": {"lowerIsBetter": false, "filtered": 45.53064059405943, "unit": "score", "value": 45.53064059405943}, "RayTrace": {"lowerIsBetter": false, "filtered": 569.9615574425573, "unit": "score", "value": 569.9615574425573}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0031.e"}, "testrun": {"date": 1447766430, "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": "20151117031105", "branch": "Firefox", "revision": "0e3b216c93f698f295e42910f442df42616fe003"}}] 05:40:45 INFO - RETURN: dromaeo_css: 5645.23 05:40:45 INFO - RETURN: kraken: 1811.00 05:40:45 INFO - RETURN: v8_7: 16803.23 05:40:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "16803.23"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1811.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "5645.23"}}} 05:40:45 INFO - Return code: 0 05:40:45 INFO - # TBPL SUCCESS # 05:40:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:40:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:40:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:40:45 INFO - 2015-11-17 05:40:45.564 screenresolution[1945:14179] starting screenresolution argv=screenresolution get 05:40:45 INFO - 2015-11-17 05:40:45.567 screenresolution[1945:14179] Display 0: 1600x1200x32@60 05:40:45 INFO - 2015-11-17 05:40:45.573 screenresolution[1946:14182] starting screenresolution argv=screenresolution list 05:40:45 INFO - Available Modes on Display 0 05:40:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:40:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:40:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:40:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:40:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:40:45 INFO - Intel HD Graphics 3000: 05:40:45 INFO - Chipset Model: Intel HD Graphics 3000 05:40:45 INFO - Type: GPU 05:40:45 INFO - Bus: Built-In 05:40:45 INFO - VRAM (Total): 512 MB 05:40:45 INFO - VRAM (Dynamic, Max): 10 05:40:45 INFO - Vendor: Intel (0x8086) 05:40:45 INFO - Device ID: 0x0116 05:40:45 INFO - Revision ID: 0x0009 05:40:45 INFO - Displays: 05:40:45 INFO - Display: 05:40:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:40:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:40:45 INFO - Display Serial Number: 1600x1200 60 05:40:45 INFO - Main Display: Yes 05:40:45 INFO - Mirror: Off 05:40:45 INFO - Online: Yes 05:40:45 INFO - Rotation: Supported 05:40:45 INFO - Return code: 0 05:40:45 INFO - Running post-action listener: _resource_record_post_action 05:40:45 INFO - Running post-run listener: _resource_record_post_run 05:40:46 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 4440064; Write bytes: 689965056; Read time: 1995; Write time: 56956 05:40:46 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 342612480; Write bytes: 344365056; Read time: 36287; Write time: 6061 05:40:46 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 4399104; Write bytes: 343945216; Read time: 1910; Write time: 50881 05:40:46 INFO - Running post-run listener: _upload_blobber_files 05:40:46 INFO - Blob upload gear active. 05:40:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:40:46 INFO - Copying logs to upload dir... 05:40:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1310.286756 ========= master_lag: 5.76 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-11-17 05:40:52.729572) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:40:52.732711) ========= 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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010799 build_url: 'https://queue.taskcluster.net/v1/task/Uzu9uDVbRsKIU5dd31ETTQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:40:52.785561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:40:52.785985) ========= 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.81ZYy3ZuNQ/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.L6Ja0bf10P/Listeners TMPDIR=/var/folders/z_/54y27cyd0xz7f8hhvbrvxdn400000w/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.005562 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:40:52.839221) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 05:40:52.839630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 05:40:52.841001) ========= ========= Total master_lag: 6.00 =========