builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0045 starttime: 1448281895.02 results: success (0) buildid: 20151123030237 builduid: 933d95c3f7ec4a1382a9e13a65e28a4a revision: 8b1fc0961a076e35646d0472a81feefc0074558c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.017364) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.017806) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.018123) ========= 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.1IbOvbBlak/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.ZZLddhgKMH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005873 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.042127) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.042563) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.104600) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.104917) ========= 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.1IbOvbBlak/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.ZZLddhgKMH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005470 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.186496) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.186977) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.187705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.188117) ========= 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.1IbOvbBlak/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.ZZLddhgKMH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-23 04:31:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.3M=0s 2015-11-23 04:31:35 (34.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.681964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.890034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.890428) ========= 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.1IbOvbBlak/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.ZZLddhgKMH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019382 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:35.956128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 04:31:35.956558) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b1fc0961a076e35646d0472a81feefc0074558c --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 8b1fc0961a076e35646d0472a81feefc0074558c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1IbOvbBlak/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.ZZLddhgKMH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-23 04:31:36,037 truncating revision to first 12 chars 2015-11-23 04:31:36,038 Setting DEBUG logging. 2015-11-23 04:31:36,038 attempt 1/10 2015-11-23 04:31:36,038 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b1fc0961a07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 04:31:37,644 unpacking tar archive at: mozilla-central-8b1fc0961a07/testing/mozharness/ program finished with exit code 0 elapsedTime=1.850623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 04:31:37.829658) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:37.829969) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:37.842689) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:37.842989) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 04:31:37.843388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-23 04:31:37.843720) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1IbOvbBlak/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.ZZLddhgKMH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:31:38 INFO - MultiFileLogger online at 20151123 04:31:38 in /builds/slave/test 04:31:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:31:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:38 INFO - {'append_to_log': False, 04:31:38 INFO - 'base_work_dir': '/builds/slave/test', 04:31:38 INFO - 'blob_upload_branch': 'Firefox', 04:31:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:38 INFO - 'branch': 'Firefox', 04:31:38 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:38 INFO - 'config_files': ('talos/mac_config.py',), 04:31:38 INFO - 'default_actions': ('clobber', 04:31:38 INFO - 'read-buildbot-config', 04:31:38 INFO - 'download-and-extract', 04:31:38 INFO - 'populate-webroot', 04:31:38 INFO - 'create-virtualenv', 04:31:38 INFO - 'install', 04:31:38 INFO - 'run-tests'), 04:31:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:38 INFO - 'download_minidump_stackwalk': True, 04:31:38 INFO - 'download_symbols': 'ondemand', 04:31:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:38 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:38 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:38 INFO - 'installer_path': 'installer.exe', 04:31:38 INFO - 'log_level': 'info', 04:31:38 INFO - 'log_name': 'talos', 04:31:38 INFO - 'log_to_console': True, 04:31:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:31:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:31:38 INFO - 'opt_config_files': (), 04:31:38 INFO - 'pip_index': False, 04:31:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:38 INFO - 'cmd': ('bash', 04:31:38 INFO - '-c', 04:31:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:38 INFO - 'enabled': True, 04:31:38 INFO - 'halt_on_failure': False, 04:31:38 INFO - 'name': 'check_screen_resolution'},), 04:31:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:38 INFO - 'cmd': ('bash', 04:31:38 INFO - '-c', 04:31:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:38 INFO - 'enabled': True, 04:31:38 INFO - 'halt_on_failure': False, 04:31:38 INFO - 'name': 'check_screen_resolution'},), 04:31:38 INFO - 'run_cmd_checks_enabled': True, 04:31:38 INFO - 'sps_profile': False, 04:31:38 INFO - 'sps_profile_interval': 0, 04:31:38 INFO - 'suite': 'dromaeojs', 04:31:38 INFO - 'system_bits': '64', 04:31:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:38 INFO - 'title': 't-yosemite-r7-0045', 04:31:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:38 INFO - 'use_talos_json': True, 04:31:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:38 INFO - 'work_dir': 'build'} 04:31:38 INFO - ##### 04:31:38 INFO - ##### Running clobber step. 04:31:38 INFO - ##### 04:31:38 INFO - Running pre-action listener: _resource_record_pre_action 04:31:38 INFO - Running main action method: clobber 04:31:38 INFO - rmtree: /builds/slave/test/build 04:31:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:39 INFO - Running post-action listener: _resource_record_post_action 04:31:39 INFO - ##### 04:31:39 INFO - ##### Running read-buildbot-config step. 04:31:39 INFO - ##### 04:31:39 INFO - Running pre-action listener: _resource_record_pre_action 04:31:39 INFO - Running main action method: read_buildbot_config 04:31:39 INFO - Using buildbot properties: 04:31:39 INFO - { 04:31:39 INFO - "properties": { 04:31:39 INFO - "buildnumber": 4, 04:31:39 INFO - "product": "firefox", 04:31:39 INFO - "script_repo_revision": "production", 04:31:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:31:39 INFO - "repository": "", 04:31:39 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:31:39 INFO - "buildid": "20151123030237", 04:31:39 INFO - "slavename": "t-yosemite-r7-0045", 04:31:39 INFO - "stage_platform": "macosx64", 04:31:39 INFO - "basedir": "/builds/slave/test", 04:31:39 INFO - "nightly_build": "True", 04:31:39 INFO - "project": "", 04:31:39 INFO - "platform": "yosemite_r7", 04:31:39 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:31:39 INFO - "slavebuilddir": "test", 04:31:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:31:39 INFO - "branch": "mozilla-central", 04:31:39 INFO - "repo_path": "mozilla-central", 04:31:39 INFO - "pgo_build": "False", 04:31:39 INFO - "builduid": "933d95c3f7ec4a1382a9e13a65e28a4a", 04:31:39 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 04:31:39 INFO - }, 04:31:39 INFO - "sourcestamp": { 04:31:39 INFO - "repository": "", 04:31:39 INFO - "hasPatch": false, 04:31:39 INFO - "project": "", 04:31:39 INFO - "branch": "mozilla-central-macosx64-talos", 04:31:39 INFO - "changes": [ 04:31:39 INFO - { 04:31:39 INFO - "category": null, 04:31:39 INFO - "files": [ 04:31:39 INFO - { 04:31:39 INFO - "url": null, 04:31:39 INFO - "name": "https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 04:31:39 INFO - } 04:31:39 INFO - ], 04:31:39 INFO - "repository": "", 04:31:39 INFO - "rev": "8b1fc0961a076e35646d0472a81feefc0074558c", 04:31:39 INFO - "who": "sendchange", 04:31:39 INFO - "when": 1448281874, 04:31:39 INFO - "number": 6694663, 04:31:39 INFO - "comments": "", 04:31:39 INFO - "project": "", 04:31:39 INFO - "at": "Mon 23 Nov 2015 04:31:14", 04:31:39 INFO - "branch": "mozilla-central-macosx64-talos", 04:31:39 INFO - "revlink": "", 04:31:39 INFO - "properties": [ 04:31:39 INFO - [ 04:31:39 INFO - "buildid", 04:31:39 INFO - "20151123030237", 04:31:39 INFO - "Change" 04:31:39 INFO - ], 04:31:39 INFO - [ 04:31:39 INFO - "builduid", 04:31:39 INFO - "933d95c3f7ec4a1382a9e13a65e28a4a", 04:31:39 INFO - "Change" 04:31:39 INFO - ], 04:31:39 INFO - [ 04:31:39 INFO - "nightly_build", 04:31:39 INFO - "True", 04:31:39 INFO - "Change" 04:31:39 INFO - ], 04:31:39 INFO - [ 04:31:39 INFO - "pgo_build", 04:31:39 INFO - "False", 04:31:39 INFO - "Change" 04:31:39 INFO - ] 04:31:39 INFO - ], 04:31:39 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 04:31:39 INFO - } 04:31:39 INFO - ], 04:31:39 INFO - "revision": "8b1fc0961a076e35646d0472a81feefc0074558c" 04:31:39 INFO - } 04:31:39 INFO - } 04:31:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 04:31:39 INFO - Running post-action listener: _resource_record_post_action 04:31:39 INFO - ##### 04:31:39 INFO - ##### Running download-and-extract step. 04:31:39 INFO - ##### 04:31:39 INFO - Running pre-action listener: _resource_record_pre_action 04:31:39 INFO - Running main action method: download_and_extract 04:31:39 INFO - mkdir: /builds/slave/test/build/tests 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:39 INFO - https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:31:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/test_packages.json 04:31:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/test_packages.json 04:31:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:31:41 INFO - Downloaded 1149 bytes. 04:31:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:31:41 INFO - Using the following test package requirements: 04:31:41 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:31:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 04:31:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'jsshell-mac.zip'], 04:31:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 04:31:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:31:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 04:31:41 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 04:31:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 04:31:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:31:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 04:31:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:31:41 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')]} 04:31:41 INFO - https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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 04:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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 04:31:43 INFO - Downloaded 17525302 bytes. 04:31:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 04:31:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:31:46 INFO - Return code: 0 04:31:46 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 04:31:46 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')]} 04:31:46 INFO - https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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 04:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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 04:31:50 INFO - Downloaded 17525302 bytes. 04:31:50 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 04:31:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:31:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:31:53 INFO - Return code: 0 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:53 INFO - https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:31:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:31:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:31:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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 04:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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 04:31:54 INFO - Downloaded 11130997 bytes. 04:31:54 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 04:31:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:31:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:31:54 INFO - Return code: 0 04:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:54 INFO - https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:31:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:31:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:31:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 04:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TVrGEJlXS-2Vg68DsMgIRA/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 04:31:57 INFO - Downloaded 109732865 bytes. 04:31:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:31:57 INFO - mkdir: /builds/slave/test/properties 04:31:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:57 INFO - Contents: 04:31:57 INFO - build_url:https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:31:57 INFO - Running post-action listener: _resource_record_post_action 04:31:57 INFO - Running post-action listener: set_extra_try_arguments 04:31:57 INFO - ##### 04:31:57 INFO - ##### Running populate-webroot step. 04:31:57 INFO - ##### 04:31:57 INFO - Running pre-action listener: _resource_record_pre_action 04:31:57 INFO - Running main action method: populate_webroot 04:31:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:31:57 INFO - '../fennec_ids.txt'], 04:31:57 INFO - 'tests': ['tcheck2']}, 04:31:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:57 INFO - '--tppagecycles', 04:31:57 INFO - '7'], 04:31:57 INFO - 'tests': ['tsvgm']}}, 04:31:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:31:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:31:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:31:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'tests': ['damp', 'tps']}, 04:31:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['damp', 'tps']}, 04:31:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:31:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:57 INFO - 'other': {'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other_l64': {'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'other_nol64': {'tests': ['a11yr', 04:31:57 INFO - 'ts_paint', 04:31:57 INFO - 'tpaint', 04:31:57 INFO - 'sessionrestore', 04:31:57 INFO - 'sessionrestore_no_auto_restore']}, 04:31:57 INFO - 'svgr': {'tests': ['tsvgx', 04:31:57 INFO - 'tsvgr_opacity', 04:31:57 INFO - 'tart', 04:31:57 INFO - 'tscrollx', 04:31:57 INFO - 'cart']}, 04:31:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tsvgx', 04:31:57 INFO - 'tsvgr_opacity', 04:31:57 INFO - 'tart', 04:31:57 INFO - 'tscrollx', 04:31:57 INFO - 'cart']}, 04:31:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'tests': ['tp5o']}, 04:31:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s'], 04:31:57 INFO - 'tests': ['tp5o']}, 04:31:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--xperf_path', 04:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:57 INFO - 'tests': ['tp5n']}, 04:31:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:57 INFO - 'talos_options': ['--e10s', 04:31:57 INFO - '--xperf_path', 04:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:57 INFO - 'tests': ['tp5n']}}, 04:31:57 INFO - 'talos.zip': {'path': '', 04:31:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:57 INFO - Running post-action listener: _resource_record_post_action 04:31:57 INFO - ##### 04:31:57 INFO - ##### Running create-virtualenv step. 04:31:57 INFO - ##### 04:31:57 INFO - Running pre-action listener: _resource_record_pre_action 04:31:57 INFO - Running main action method: create_virtualenv 04:31:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:57 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 04:31:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:57 INFO - Using real prefix '/tools/python27' 04:31:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:01 INFO - Installing pip.................done. 04:32:01 INFO - Return code: 0 04:32:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104af8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ad5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d0c828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1c9f0>, '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 0x10477bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a0f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/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.ZZLddhgKMH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/Render', 04:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:01 INFO - 'HOME': '/Users/cltbld', 04:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:01 INFO - 'LOGNAME': 'cltbld', 04:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:01 INFO - 'MOZ_NO_REMOTE': '1', 04:32:01 INFO - 'NO_EM_RESTART': '1', 04:32:01 INFO - 'PAGER': '/bin/cat', 04:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:01 INFO - 'PWD': '/builds/slave/test', 04:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:01 INFO - 'SHELL': '/bin/bash', 04:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZZLddhgKMH/Listeners', 04:32:01 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 04:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:01 INFO - 'USER': 'cltbld', 04:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:01 INFO - 'XPC_FLAGS': '0x0', 04:32:01 INFO - 'XPC_SERVICE_NAME': '0', 04:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:32:01 INFO - Cleaning up... 04:32:01 INFO - Return code: 0 04:32:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104af8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ad5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d0c828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1c9f0>, '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 0x10477bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a0f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/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.ZZLddhgKMH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:32:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/Render', 04:32:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:01 INFO - 'HOME': '/Users/cltbld', 04:32:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:01 INFO - 'LOGNAME': 'cltbld', 04:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:01 INFO - 'MOZ_NO_REMOTE': '1', 04:32:01 INFO - 'NO_EM_RESTART': '1', 04:32:01 INFO - 'PAGER': '/bin/cat', 04:32:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:01 INFO - 'PWD': '/builds/slave/test', 04:32:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:01 INFO - 'SHELL': '/bin/bash', 04:32:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZZLddhgKMH/Listeners', 04:32:01 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 04:32:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:01 INFO - 'USER': 'cltbld', 04:32:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:01 INFO - 'XPC_FLAGS': '0x0', 04:32:01 INFO - 'XPC_SERVICE_NAME': '0', 04:32:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:01 INFO - Downloading/unpacking psutil>=0.7.1 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:04 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:32:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:04 INFO - Installing collected packages: psutil 04:32:04 INFO - Running setup.py install for psutil 04:32:05 INFO - building 'psutil._psutil_osx' extension 04:32:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:32:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:32:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:32:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:32:05 INFO - building 'psutil._psutil_posix' extension 04:32:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:32:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:05 INFO - ^ 04:32:05 INFO - 1 warning generated. 04:32:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:05 INFO - Successfully installed psutil 04:32:05 INFO - Cleaning up... 04:32:05 INFO - Return code: 0 04:32:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104af8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ad5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d0c828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1c9f0>, '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 0x10477bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a0f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/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.ZZLddhgKMH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:32:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/Render', 04:32:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:05 INFO - 'HOME': '/Users/cltbld', 04:32:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:05 INFO - 'LOGNAME': 'cltbld', 04:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:05 INFO - 'MOZ_NO_REMOTE': '1', 04:32:05 INFO - 'NO_EM_RESTART': '1', 04:32:05 INFO - 'PAGER': '/bin/cat', 04:32:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:05 INFO - 'PWD': '/builds/slave/test', 04:32:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:05 INFO - 'SHELL': '/bin/bash', 04:32:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZZLddhgKMH/Listeners', 04:32:05 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 04:32:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:05 INFO - 'USER': 'cltbld', 04:32:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:05 INFO - 'XPC_FLAGS': '0x0', 04:32:05 INFO - 'XPC_SERVICE_NAME': '0', 04:32:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:32:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:32:08 INFO - Installing collected packages: mozsystemmonitor 04:32:08 INFO - Running setup.py install for mozsystemmonitor 04:32:08 INFO - Successfully installed mozsystemmonitor 04:32:08 INFO - Cleaning up... 04:32:08 INFO - Return code: 0 04:32:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:08 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')]} 04:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:08 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')]} 04:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:08 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 0x104af8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ad5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d0c828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1c9f0>, '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 0x10477bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a0f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/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.ZZLddhgKMH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:08 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 04:32:08 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 04:32:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/Render', 04:32:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:08 INFO - 'HOME': '/Users/cltbld', 04:32:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:08 INFO - 'LOGNAME': 'cltbld', 04:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:08 INFO - 'MOZ_NO_REMOTE': '1', 04:32:08 INFO - 'NO_EM_RESTART': '1', 04:32:08 INFO - 'PAGER': '/bin/cat', 04:32:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:08 INFO - 'PWD': '/builds/slave/test', 04:32:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:08 INFO - 'SHELL': '/bin/bash', 04:32:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZZLddhgKMH/Listeners', 04:32:08 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 04:32:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:08 INFO - 'USER': 'cltbld', 04:32:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:08 INFO - 'XPC_FLAGS': '0x0', 04:32:08 INFO - 'XPC_SERVICE_NAME': '0', 04:32:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:08 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 04:32:08 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 04:32:08 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 04:32:08 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 04:32:08 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 04:32:08 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 04:32:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:11 INFO - Downloading docopt-0.6.1.tar.gz 04:32:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:11 INFO - Running setup.py install for blobuploader 04:32:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:12 INFO - Running setup.py install for requests 04:32:12 INFO - Running setup.py install for docopt 04:32:12 INFO - Successfully installed blobuploader requests docopt 04:32:12 INFO - Cleaning up... 04:32:12 INFO - Return code: 0 04:32:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:12 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')]} 04:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:12 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')]} 04:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:12 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 0x104af8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ad5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d0c828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1c9f0>, '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 0x10477bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a0f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/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.ZZLddhgKMH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:12 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 04:32:12 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 04:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/Render', 04:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:12 INFO - 'HOME': '/Users/cltbld', 04:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:12 INFO - 'LOGNAME': 'cltbld', 04:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:12 INFO - 'MOZ_NO_REMOTE': '1', 04:32:12 INFO - 'NO_EM_RESTART': '1', 04:32:12 INFO - 'PAGER': '/bin/cat', 04:32:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:12 INFO - 'PWD': '/builds/slave/test', 04:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:12 INFO - 'SHELL': '/bin/bash', 04:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZZLddhgKMH/Listeners', 04:32:12 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 04:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:12 INFO - 'USER': 'cltbld', 04:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:12 INFO - 'XPC_FLAGS': '0x0', 04:32:12 INFO - 'XPC_SERVICE_NAME': '0', 04:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-NZTzeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-T6oc97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-RBO6_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-600HSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-qNhj0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-k3k7Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Pr9vR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-SiExXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:13 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-1CNMAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-yiLAqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-XkZHK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-wd1sFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-RrkLsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-mGvWpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-lxsuqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-TaKscK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:14 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-ufQ9ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:14 INFO - Running setup.py install for manifestparser 04:32:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:15 INFO - Running setup.py install for mozcrash 04:32:15 INFO - Running setup.py install for mozdebug 04:32:15 INFO - Running setup.py install for mozdevice 04:32:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:15 INFO - Running setup.py install for mozfile 04:32:15 INFO - Running setup.py install for mozhttpd 04:32:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:15 INFO - Running setup.py install for mozinfo 04:32:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:15 INFO - Running setup.py install for mozInstall 04:32:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Running setup.py install for mozleak 04:32:16 INFO - Running setup.py install for mozlog 04:32:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Running setup.py install for moznetwork 04:32:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Running setup.py install for mozprocess 04:32:16 INFO - Running setup.py install for mozprofile 04:32:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:16 INFO - Running setup.py install for mozrunner 04:32:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Running setup.py install for mozscreenshot 04:32:17 INFO - Running setup.py install for moztest 04:32:17 INFO - Running setup.py install for mozversion 04:32:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:17 INFO - Cleaning up... 04:32:17 INFO - Return code: 0 04:32:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x104af8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ad5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d0c828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1c9f0>, '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 0x10477bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a0f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/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.ZZLddhgKMH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:17 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 04:32:17 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 04:32:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/Render', 04:32:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:17 INFO - 'HOME': '/Users/cltbld', 04:32:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:17 INFO - 'LOGNAME': 'cltbld', 04:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:17 INFO - 'MOZ_NO_REMOTE': '1', 04:32:17 INFO - 'NO_EM_RESTART': '1', 04:32:17 INFO - 'PAGER': '/bin/cat', 04:32:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:17 INFO - 'PWD': '/builds/slave/test', 04:32:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:17 INFO - 'SHELL': '/bin/bash', 04:32:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZZLddhgKMH/Listeners', 04:32:17 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 04:32:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:17 INFO - 'USER': 'cltbld', 04:32:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:17 INFO - 'XPC_FLAGS': '0x0', 04:32:17 INFO - 'XPC_SERVICE_NAME': '0', 04:32:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:17 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-pNsoQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:17 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)) 04:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:17 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-vLOxaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:17 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)) 04:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:17 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-kFFzmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:18 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)) 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-D7Qe0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:18 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)) 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-nTOARU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:18 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)) 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-1Ys3QH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:18 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)) 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-vApoQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:18 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)) 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-3ih5Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:18 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)) 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-eqbqWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:18 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)) 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Dsdv1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:18 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)) 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-rzpKC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:18 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)) 04:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:18 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-R41vll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-A_WPoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-rTwfOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-rKxoa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Z15epA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:19 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)) 04:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:19 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-NLJlFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:19 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)) 04:32:19 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)) 04:32:19 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)) 04:32:19 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)) 04:32:19 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)) 04:32:19 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)) 04:32:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:19 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 04:32:19 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 04:32:19 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 04:32:19 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 04:32:19 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 04:32:19 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 04:32:21 INFO - Downloading blessings-1.5.1.tar.gz 04:32:21 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 04:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:21 INFO - Installing collected packages: blessings 04:32:21 INFO - Running setup.py install for blessings 04:32:21 INFO - Successfully installed blessings 04:32:21 INFO - Cleaning up... 04:32:22 INFO - Return code: 0 04:32:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:22 INFO - Reading from file tmpfile_stdout 04:32:22 INFO - Current package versions: 04:32:22 INFO - blessings == 1.5.1 04:32:22 INFO - blobuploader == 1.2.4 04:32:22 INFO - docopt == 0.6.1 04:32:22 INFO - manifestparser == 1.1 04:32:22 INFO - mozInstall == 1.12 04:32:22 INFO - mozcrash == 0.16 04:32:22 INFO - mozdebug == 0.1 04:32:22 INFO - mozdevice == 0.47 04:32:22 INFO - mozfile == 1.2 04:32:22 INFO - mozhttpd == 0.7 04:32:22 INFO - mozinfo == 0.9 04:32:22 INFO - mozleak == 0.1 04:32:22 INFO - mozlog == 3.0 04:32:22 INFO - moznetwork == 0.27 04:32:22 INFO - mozprocess == 0.22 04:32:22 INFO - mozprofile == 0.27 04:32:22 INFO - mozrunner == 6.11 04:32:22 INFO - mozscreenshot == 0.1 04:32:22 INFO - mozsystemmonitor == 0.0 04:32:22 INFO - moztest == 0.7 04:32:22 INFO - mozversion == 1.4 04:32:22 INFO - psutil == 3.1.1 04:32:22 INFO - requests == 1.2.3 04:32:22 INFO - wsgiref == 0.1.2 04:32:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:22 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 0x104af8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104ad5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d0c828e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104a1c9f0>, '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 0x10477bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a0f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/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.ZZLddhgKMH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:22 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 04:32:22 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 04:32:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/Render', 04:32:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:22 INFO - 'HOME': '/Users/cltbld', 04:32:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:22 INFO - 'LOGNAME': 'cltbld', 04:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:22 INFO - 'MOZ_NO_REMOTE': '1', 04:32:22 INFO - 'NO_EM_RESTART': '1', 04:32:22 INFO - 'PAGER': '/bin/cat', 04:32:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:22 INFO - 'PWD': '/builds/slave/test', 04:32:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:22 INFO - 'SHELL': '/bin/bash', 04:32:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZZLddhgKMH/Listeners', 04:32:22 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 04:32:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:22 INFO - 'USER': 'cltbld', 04:32:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:22 INFO - 'XPC_FLAGS': '0x0', 04:32:22 INFO - 'XPC_SERVICE_NAME': '0', 04:32:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:22 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)) 04:32:22 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)) 04:32:22 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)) 04:32:22 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)) 04:32:22 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)) 04:32:22 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)) 04:32:22 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)) 04:32:22 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)) 04:32:22 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)) 04:32:22 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)) 04:32:22 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)) 04:32:22 INFO - Cleaning up... 04:32:22 INFO - Return code: 0 04:32:22 INFO - Running post-action listener: _resource_record_post_action 04:32:22 INFO - Running post-action listener: _start_resource_monitoring 04:32:22 INFO - Starting resource monitoring. 04:32:22 INFO - ##### 04:32:22 INFO - ##### Running install step. 04:32:22 INFO - ##### 04:32:22 INFO - Running pre-action listener: _resource_record_pre_action 04:32:22 INFO - Running main action method: install 04:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:22 INFO - Reading from file tmpfile_stdout 04:32:22 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:22 INFO - Reading from file tmpfile_stdout 04:32:22 INFO - Output received: 04:32:22 INFO - Usage: mozinstall [options] installer 04:32:22 INFO - Options: 04:32:22 INFO - -h, --help show this help message and exit 04:32:22 INFO - -d DEST, --destination=DEST 04:32:22 INFO - Directory to install application into. [default: 04:32:22 INFO - "/builds/slave/test"] 04:32:22 INFO - --app=APP Application being installed. [default: firefox] 04:32:22 INFO - mkdir: /builds/slave/test/build/application 04:32:22 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'] 04:32:22 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 04:32:53 INFO - Reading from file tmpfile_stdout 04:32:53 INFO - Output received: 04:32:53 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:32:53 INFO - Running post-action listener: _resource_record_post_action 04:32:53 INFO - ##### 04:32:53 INFO - ##### Running run-tests step. 04:32:53 INFO - ##### 04:32:53 INFO - Running pre-action listener: _resource_record_pre_action 04:32:53 INFO - Running main action method: run_tests 04:32:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:53 INFO - 2015-11-23 04:32:53.029 screenresolution[2242:16204] starting screenresolution argv=screenresolution get 04:32:53 INFO - 2015-11-23 04:32:53.032 screenresolution[2242:16204] Display 0: 1600x1200x32@60 04:32:53 INFO - 2015-11-23 04:32:53.038 screenresolution[2243:16206] starting screenresolution argv=screenresolution list 04:32:53 INFO - Available Modes on Display 0 04:32:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:53 INFO - Intel Iris: 04:32:53 INFO - Chipset Model: Intel Iris 04:32:53 INFO - Type: GPU 04:32:53 INFO - Bus: Built-In 04:32:53 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:53 INFO - Vendor: Intel (0x8086) 04:32:53 INFO - Device ID: 0x0a2e 04:32:53 INFO - Revision ID: 0x0009 04:32:53 INFO - Displays: 04:32:53 INFO - Display: 04:32:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:53 INFO - Display Serial Number: 1600x1200 60 04:32:53 INFO - Main Display: Yes 04:32:53 INFO - Mirror: Off 04:32:53 INFO - Online: Yes 04:32:53 INFO - Rotation: Supported 04:32:53 INFO - Return code: 0 04:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:53 INFO - Python 2.7.3 04:32:53 INFO - Return code: 0 04:32:53 INFO - grabbing minidump binary from tooltool 04:32:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:53 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 0x104a1c9f0>, '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 0x10477bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104a0f8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:53 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 04:32:53 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 04:32:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:53 INFO - Return code: 0 04:32:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:32:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:32:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--webServer', 'localhost'] in /builds/slave/test/build 04:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0045 --webServer localhost 04:32:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1IbOvbBlak/Render', 04:32:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:53 INFO - 'HOME': '/Users/cltbld', 04:32:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:53 INFO - 'LOGNAME': 'cltbld', 04:32:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:53 INFO - 'MOZ_NO_REMOTE': '1', 04:32:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:53 INFO - 'NO_EM_RESTART': '1', 04:32:53 INFO - 'PAGER': '/bin/cat', 04:32:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:53 INFO - 'PWD': '/builds/slave/test', 04:32:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:53 INFO - 'SHELL': '/bin/bash', 04:32:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZZLddhgKMH/Listeners', 04:32:53 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 04:32:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:53 INFO - 'USER': 'cltbld', 04:32:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:53 INFO - 'XPC_FLAGS': '0x0', 04:32:53 INFO - 'XPC_SERVICE_NAME': '0', 04:32:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--webServer', 'localhost'] with output_timeout 3600 04:32:53 INFO - mozversion INFO | application_buildid: 20151123030237 04:32:53 INFO - mozversion INFO | application_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 04:32:53 INFO - mozversion INFO | application_display_name: Nightly 04:32:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:53 INFO - mozversion INFO | application_name: Firefox 04:32:53 INFO - mozversion INFO | application_remotingname: firefox 04:32:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:32:53 INFO - mozversion INFO | application_vendor: Mozilla 04:32:53 INFO - mozversion INFO | application_version: 45.0a1 04:32:53 INFO - mozversion INFO | platform_buildid: 20151123030237 04:32:53 INFO - mozversion INFO | platform_changeset: 8b1fc0961a076e35646d0472a81feefc0074558c 04:32:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:32:53 INFO - mozversion INFO | platform_version: 45.0a1 04:32:53 INFO - 2015-11-23 04:32:53,576 DEBUG : using testdate: 1448281973 04:32:53 INFO - 2015-11-23 04:32:53,577 DEBUG : actual date: 1448281973 04:32:54 INFO - 2015-11-23 04:32:54,070 INFO : starting webserver on 'localhost:49898' 04:32:54 INFO - 2015-11-23 04:32:54,071 INFO : Starting test suite t-yosemite-r7-0045 04:32:54 INFO - 2015-11-23 04:32:54,071 INFO : Starting test dromaeo_css 04:32:54 INFO - 2015-11-23 04:32:54,071 DEBUG : operating with platform_type : mac_ 04:32:54 INFO - 2015-11-23 04:32:54,073 INFO : Initialising browser for dromaeo_css test... 04:32:54 INFO - 2015-11-23 04:32:54,085 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpjlRUHU/profile http://localhost:49898/getInfo.html 04:32:56 INFO - 2015-11-23 04:32:56,540 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:32:56 INFO - 2015-11-23 04:32:56,541 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:32:56 INFO - 2015-11-23 04:32:56,541 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:32:56 INFO - 2015-11-23 04:32:56,541 DEBUG : BROWSER_OUTPUT: __metrics 04:32:56 INFO - 2015-11-23 04:32:56,557 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:57 INFO - 2015-11-23 04:32:57,364 INFO : Browser initialized. 04:32:57 INFO - 2015-11-23 04:32:57,364 INFO : Running cycle 1/1 for dromaeo_css test... 04:32:57 INFO - 2015-11-23 04:32:57,364 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpjlRUHU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:33:09 INFO - 2015-11-23 04:33:09,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 226492416 04:33:09 INFO - 2015-11-23 04:33:09,149 DEBUG : BROWSER_OUTPUT: 04:34:00 INFO - 2015-11-23 04:34:00,074 DEBUG : BROWSER_OUTPUT: 1448282040072 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] 04:36:11 INFO - 2015-11-23 04:36:11,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49898/tests/dromaeo/cssquery-ext.html) 04:36:13 INFO - 2015-11-23 04:36:13,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 366800896 04:36:13 INFO - 2015-11-23 04:36:13,379 DEBUG : BROWSER_OUTPUT: 04:39:16 INFO - 2015-11-23 04:39:16,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/dromaeo/cssquery-ext.html (next: http://localhost:49898/tests/dromaeo/cssquery-jquery.html) 04:39:16 INFO - 2015-11-23 04:39:16,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 360669184 04:39:16 INFO - 2015-11-23 04:39:16,662 DEBUG : BROWSER_OUTPUT: 04:42:18 INFO - 2015-11-23 04:42:18,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49898/tests/dromaeo/cssquery-mootools.html) 04:42:19 INFO - 2015-11-23 04:42:19,351 DEBUG : BROWSER_OUTPUT: RSS: Main: 340148224 04:42:19 INFO - 2015-11-23 04:42:19,351 DEBUG : BROWSER_OUTPUT: 04:45:21 INFO - 2015-11-23 04:45:21,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49898/tests/dromaeo/cssquery-prototype.html) 04:45:21 INFO - 2015-11-23 04:45:21,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 323186688 04:45:21 INFO - 2015-11-23 04:45:21,970 DEBUG : BROWSER_OUTPUT: 04:48:24 INFO - 2015-11-23 04:48:24,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49898/tests/dromaeo/cssquery-yui.html) 04:48:25 INFO - 2015-11-23 04:48:25,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 327368704 04:48:25 INFO - 2015-11-23 04:48:25,561 DEBUG : BROWSER_OUTPUT: 04:51:28 INFO - 2015-11-23 04:51:28,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/dromaeo/cssquery-yui.html (next: http://localhost:49898/tests/dromaeo/cssquery-dojo.html) 04:51:28 INFO - 2015-11-23 04:51:28,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 368914432 04:51:28 INFO - 2015-11-23 04:51:28,635 DEBUG : BROWSER_OUTPUT: 04:51:28 INFO - 2015-11-23 04:51:28,635 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:51:28 INFO - 2015-11-23 04:51:28,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:51:28 INFO - 2015-11-23 04:51:28,635 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:51:28 INFO - 2015-11-23 04:51:28,635 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:51:28 INFO - 2015-11-23 04:51:28,636 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3456.118689734117;3488.930221395571;3495.947560786589;3529.3294274087907;3536.982315088424;5755.4244575542425;5883.941160588392;5993.250843644539;6021.909671354928;6063.302720187175;5879.735411906464;5936.257967754031;5954.077118046699;5959.284885813698;5972.223610930584;5354.973225133878;5391.32608423947;5422.593305502103;5468.453154684519;5519;5452.154915988028;5479.890402191953;5481.479259470344;5490.258815059976;5499.312585926759;5480.808171713991;5497.202905578689;5498.477644623755;5507.7246137693155;5513.696746678931;5475.5072043516075;5482.835514934558;5485.259489968883;5489.149181876815;5506.91739623904;5280.392754833205;5301.310829592128;5401.540869026137;5412.485813847678;5442.510174084312;5867.911981320283;6026.427489388501;6041.667708276043;6080.939190608082;6082.726277317532;5419.945800541984;6336.822357548057;6337.873242535124;6347.746090156388;6361.109444677749;6215.223097112861;6252.906206406908;6319.3680631936895;6322.209723784527;6329.715162817684;5585.442484727722;6127.234095738033;6134;6160.753569857246;6174.938250617482;5535.750891209825;6517.055027021055;6517.9348206517325;6520.771772988018;6542.967285163544;6117.979653188387;6216.378362163838;6336.968315158395;6363.363663633692;6364.840878978062;6384.585001974857;6395.232572091286;6396.232452105684;6396.328385519547;6398.744050238031;6301.96849015752;6352.872942541123;6358.713857876407;6373.936260637334;6390.712417941204;6170.259568851677;6186.536009799283;6271.310155882849;6293.874122517524;6342.39747224013;5124.692518448905;5142.5628821549835;5143.639945203875;5146.459621739738;5160.870978225575;4612.53874612536;4622.075584883037;4624.075184963021;4641;4650.674452788272;5914.940850591439;5972.954732921721;6061.121137435047;6074.392560743979;6098.236059785416;6500.804975850732;6505.056766768792;6522.380373864476;6523.510736694672;6524.9673751630935;6092.421219984094;6111.35830737775;6124.663143527148;6128.387161283836;6137.662428566472;5476.17857321405;5556.611037227436;5566.471185237396;5581.832545023656;5602.1036634138345;6269.341719119427;6293.024581189923;6299.464545513682;6372.267189273293;6376.39424254695;6461.676916154268;6468.611883287018;6469.353064693493;6476.158099447041;6493.123428337114;5364.275822763877;6328.810135695937;6393.6483493408305;6410.679466026773;6428.4857211423905;6141.7409431065635;6251.874962500816;6267.62394256346;6292.716827742855;6357.364263573606;6466.094746735367;6473.643949582818;6477.060826180272;6483.448906842971;6486.935130648633;5354.598405119554;6109.969450152721;6250.374962503895;6256.249250090018;6270.310265870842;6091.914134152887;6215.129881816459;6222.222222222223;6226.066090086523;6232.09634602971;4715.6227501799085;6112.65546444155;6113.263474096151;6124.44586445147;6143.877122457615;6156.107364432043;6309.400606942333;6316.273628532777;6319.652419116993;6339.429451349401;6210.223722034746;6269.749210031548;6282.434580887742;6287.276963149114;6294.527910406646 04:51:28 INFO - 2015-11-23 04:51:28,637 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.3820017081295;593.2910172344051;604.2748701558131;631.5547538985015;640.6924676155445;38795.612043879555;39496.457907340664;39523.40714889279;39594.60405395949;39771.2045759085;43810.56189438113;44196.779016104956;44204.77897610507;44289.89275268112;44315.33526997098;8817.779555511132;8907.866382004275;8920.152585504367;9764.658236961726;9988.700338989842;8820.941487021535;8879.866801997976;8992.370534062618;10600.416977066257;12154.453049612745;11888.227265227775;11983.64049078529;12007.579734709287;12014.939925300361;12045.337506437143;11826.822597661041;11908.047356211482;11939.462724177347;11944.581939632115;11996.64010079699;8941.329400294939;9099.954500227457;9122.81754364909;11828.467718952668;11978.64064078079;40916;41267.79366103181;41330.38004429936;41358.37962430566;41379.7931010343;3250.7886987345983;3291.6214635316765;3400.472926696366;3531.611522732497;3631.6005239423644;28283;28640.856795716096;29145.854270728723;29561.38255086995;29897.850510747525;2786.986065069682;2794.1338185162663;2858.1425572328426;2875.09434528123;2966.688497707731;465711;466684;470759.99999999657;471370;472285;55211.723941380034;56481.71759141178;56596.71701641465;65118;65544.34455655477;71034.64482677553;71794.28205717981;72094;72243;72385.55228895393;15319.846801532065;15640.92179539095;16472.176391180394;16629.584260393345;16672.083035432926;12715.491380344867;12781.041421893395;12782.680432989064;12792.36038198105;12810.871891280967;19617.509562260773;19984.90007549953;20010.599788004158;20025;20037.59924801525;8750;8899.466032038099;8917.286617070618;8926.241269492037;8927.508987005647;964.8359778837614;972.7713987212999;1023.5649848814224;1032.488917985587;1093.6008356949656;27772;27786.583201251997;27979.860100699774;28071.43857122846;28131.43737125287;1072.983905241422;1077.2405454154803;1125.7973564758258;1128.920975531705;1202.6452196602024;14369.13785172893;15059;15487.535373938574;15855.286512106983;16093.114878681785;645927;661723;662991.3700863026;665290;668175;62260.68869655623;62712.68643656844;62747;62904.68547657324;63011.684941575;1471.3967273417848;1483.3028476616405;1496.5211132437516;1496.7754836774352;1500.2573726005696;27370.768315425456;30963.213310802137;31153.532697010018;31389.686103138676;31854.36291274208;49273.26090108723;49955.75022124866;53256;53879.730601346746;53936.460635393145;662264;671449;673335;675402;677992.6100369466;34381.656183437844;34486.82756586201;34779;34789.30421391507;34809.82595087009;44832.775836120614;45661;45743.313850292936;46153.538464616264;46978.76510617425;37387.252254955296;38023.809880950415;38108.42837357497;38449.00162978795;39062;37199.25601488009;37874.242515150094;37914.43128353132;38112.809435952644;38203.8538843824;37325;37654;37819.81090094532;37892;37966.67116650904;31379;33180.50229246515;33784.831075844464;33790.15524611806;33836.154096147795;24880.25359239226;24922.50154996926;25064.248072557853;25393;25399.6190057153 04:51:28 INFO - 2015-11-23 04:51:28,641 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.82776267391654;359.92081742016757;365.8902329301212;367.80690137677715;372.87881438532486;15928.920355398206;18121.09394530275;20054.398368048962;20787.064582093804;21396.35810925673;11952.641420757369;12044.57843975461;12252.019838412927;12308.753824923497;12322.568710095149;3930.233604447134;5223.764930578123;5341.4925582069645;5372;5372.838814835562;4038.959610403888;4056.71602987791;5769.105788602752;5948.107783832416;5957.374475680056;5752.827415177551;5759.366469688331;5853.7365818538265;5898.233229680136;5911.497522710575;5660.971695141539;5661.009323368436;5764.193012978187;5765.423457654222;5791.884162316751;5408.513233808976;5545.195946587723;5548.472895074961;5560.193771903051;5579.330480342344;12938.223706577635;13089.083764136514;13104.934475327562;17915.910420447814;25950.961961521516;1994.9102290396968;2055.856090073695;2101.6322143624957;2115.471132216946;2127.8616889902105;9942.453165075918;9999.550020249106;10161.4919254037;10865.782684346268;13883.583492495241;1610.3800036985845;1648.1182567326543;1725.3702398624537;1736.6873962686711;1765.161548264564;94101;99276;99488;101402;103384;10879.83680244797;11155.72110697239;11221.71945701364;11228.775424491465;11329.660110196708;13148;13158.407871645799;13185.077044606785;13196.14225075367;13208.669783255304;7474.925250747532;8470.788230294169;8546.61540230691;8575.95712021436;8621.568921553897;7564.773056808304;8646.481211127353;8773.736787896374;8808.427452215585;8855.690050848318;4088.0801819590356;4359.629431498358;4380.561943805657;4399.6040356368085;4473.150101480708;1768.0629266488781;1793.650238203564;3000.294930691286;3393.728501719906;3474.5656792900886;781.7811012916393;900.9909900901038;937.2703985385001;951.7382719752123;963.9107808176716;14826.627739561618;17942.91028544875;20814.37556873296;20862.582748344947;20869.68695469569;956.8229877472689;1017.6641708236265;1020.1940467031111;1061.2836335473523;1062.946852657364;10853.294535855302;10994.34033957965;11033.724156896142;11433.428328583537;11879.643610691694;751636.209094777;755943;771024;771239;772488;61570.0764488533;95921;116575;118015.40992295156;120495.79504205022;472.3151430425896;485.7110019538369;488.77516342482147;489.9118158731391;491.00571343029935;10762.838557421488;10987.066099381642;11018.944905275423;11051.668449946514;11204.271722338022;52631.47368526266;53538.73230633822;53647;54870.451295486535;55106;74822.25177748154;75006;76586.6170669143;76938.46123077619;77696;9473.57368918414;9916.950415247878;10017.499125043865;10045.146162575971;10048.748781280527;19955.20179192816;19991.700124498435;20344.491387715425;20397.898010509853;20571.38285851427;3490.0402389343135;16194.919025404797;16269.769859836291;16278.941868778491;16422.17889105564;15528.922355388602;15632.4528641497;15685.529434116996;15927.442539511061;16397.67204655924;13183.40674669623;15997.040177589382;16749.497515074567;17416.825831742026;17492.47522574325;9939.453330066915;10019.048190421898;10213.642522511676;10235.897641023494;10267.897321026694;16279.186040697681;16295.26671299818;16498.917505412875;16825;16869 04:51:28 INFO - 2015-11-23 04:51:28,642 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1549.8837587180958;1553.8057742782146;1697;1896.459509039924;1917.8369838563722;7543.170251272362;7949.84100317994;7951.403644726647;8399.11809260028;8592.011918629343;8331.666733330674;8458.577071146448;8480.448770829891;8482.618282177302;8495.023072346667;2133.7012818205462;2368.7394386617502;2396.3529846941315;2398.6521954316613;2400.327908185711;2201.1195521791333;2203.8787866667326;2367.419982104378;2408.0488207158164;2409.1567951217107;2192.5286063496346;2241.316398498457;2312.5259321839067;2366.6213405855065;2370.3363058343693;2036.2465887621602;2115.428834214769;2177.3250292409243;2358.304300231427;2386.248331775485;2347.6361164019604;2392.533455976068;2394.4133687246735;2398.6881705378364;2400.9039638414442;8465.788355291106;8557.400981931267;8567.614457349435;8568.742937711879;8570.700025499078;5150.587952963791;5233.188855727369;5245;5245.055889939809;5273;3497.0557949353533;3557.1107223194203;3625.003124140856;3634.182308980485;3642.6721595056574;1052.6210564196883;1056.3767377247461;1062.2511129653653;1074.2963358999868;1081.2269227502295;11312.6040588579;11326.263792853439;11335.943320283428;11349.432528373549;11355.716107097305;4601;4698.835540756126;4702.95297047032;4727.385439892861;4765.69023013503;9695.272854535939;9696.175825054808;9696.757581060388;9707.805843883083;9718.659846905324;5256.448072952285;5284.709340986283;5295.735213239323;5295.920561191585;5310.946890531045;4799.592034677022;4841.298011788271;4842.176829938919;4842.878928026827;4853.417589889165;3621.5654121505063;3745.269672413853;3759.4360845872793;3763.8682646107254;3784.848606055727;1168.3865970365625;1178.7819253438142;1180.8760080191457;1182.4856187558269;1186.9643910682694;1113.4989254835357;1113.8941800528937;1164;1310.652677040585;1403.6771542545068;7843.176466470938;7860.174681658344;7945.841083178304;7947.165547617533;7968.880466793003;1078.6009176604707;1211.121936595961;1217.6468824040928;1218.4212499062874;1237.041292997916;5857.736401861926;5983.730732117066;6210.596311239755;6464.288928217892;6523.7064332105165;9624.37441566296;9769.316147869724;9939.353941993748;9956.701298961043;10100.191984641211;9940.403575785476;10038.196944244442;10045.995400460042;10149;10158.441285729208;7812.296893279632;7855.096663883613;7911.643976021093;7930.286274235346;7967.163447838009;7908.051033875971;7934.603269836601;7935.2064793520185;7943.523388596703;7978.401619878417;8918.420302680304;8928.955355223183;9121.270298376247;9185.173334399937;9248.583813728534;9390.107939745712;9536.380135291183;9562.043795620382;9562.808743825224;9579.473128977974;7942.166072562298;8052.476589021695;8064.83870322602;8069.919300806917;8070.394720395876;7904.802379940547;8115.1479094694205;8122.025356957203;8152.877706834283;8159.79600509992;7557;7571.432142589218;7630.542167469969;7710.1133369660965;7717.151113377637;7328.5969271690565;7459;7481.588512631857;7539.811504712206;7581;7590;7651.846963060596;7666.1950495199435;7698.499597526143;7712.113106992543;6946.6179360135675;6999.860002800017;7005.929940700732;7006.579605223703;7013.649317534205;6081.179040829431;7051.189113252041;7103.502754807114;7110.893336600058;7113.110861142357 04:51:28 INFO - 2015-11-23 04:51:28,645 DEBUG : BROWSER_OUTPUT: |4;prototype.html;326.3538194375137;335.8052329648804;338.90171850163455;344.67428280275135;346.6914446142932;5495.670259784416;6702.932970670292;6857.828554286145;6865.862682746342;6903.068085808414;5436.673799572029;6772.932270677292;6818.181818181825;6839.555428897118;6844.38400543951;4985;5115.590752739772;5117.360329958755;5118.360204974379;5141.922871156936;4996.600271978251;5056.570191533724;5135.435102138762;5142.228665700138;5143.254228136918;5045.899082018357;5124.128898087334;5127.077126117298;5131.025105230013;5155.278261043457;5086.321513900404;5088.23676448532;5091.516305950929;5096.770645320969;5103.26002729604;4329.285667864799;4351.0862718829085;4357.106793107437;4361.738295702236;4373.540778218273;6379.936200637981;6633.800985970429;6635.668216589152;6650.667466626649;6694.196696396415;6024.09638554216;6030.849228769272;6040.305364883006;6041.305249896231;6050.2134722486235;5973.37279585646;7051.224365319811;7211.134663840373;7393.223711510268;7396.3343299103335;3959.703022273341;4435.733855968652;4561.703489273186;4719.315699223594;4889.33993910821;7815.8436831263625;7840.764777056697;7841.568713720743;7846.803829904241;7848.293653571206;4829.1458535251595;4898.167311557044;4953.1332016896895;4965.553100220997;4967;5061.139606266944;5069.188929771292;5074.16276314404;5085.4914508548845;5089.949100509021;6014.909776353358;6016.819495415145;6024.789132380346;6032.788852390146;6039.667818270037;7454.142773581108;7466;7469.701211951569;7471.813204669927;7481.551106933602;1644.8355164483455;1701.013412220909;1704.1308932444542;1705.249690136336;1711.1786342555642;1067.5462928255615;1075.8224892892586;1086.4187659602233;1091.3560999010622;1093.6500319897557;6813.7955861324235;6843.623600702009;6847.589144651337;6857.828554286183;6879.965600172067;7639.618019099023;7645.847083058419;7652.04349456318;7652.1582625912215;7659.540427574363;6739.123913891162;6844.1444819397575;6865.176178858469;6875.243723190445;6927.168739751262;4081.755094694328;4100;4112.712110152261;4121.1345617420675;4128.710990230715;6661.667666466726;7322.340989310987;7419.962900185465;7768.805779855549;7787.922120778833;7639.618019099134;7827.25641064098;7981.600919953979;8017;8031.759047228593;6860.451163906875;7165.247648996885;7449.664765085692;7742.187070357531;7749.961250193713;7476.962615186889;7539.359154471931;7580.241975802375;7797.142314345304;7811.609419528887;7623.085229772463;7632.732854350071;7638.618069096412;7644.579548124907;7650.426218033781;7563.394928405824;7746.806329841799;7778.533288002738;7785.610719464117;7801.1808760079375;4784.593309568587;4834;4843.304843304956;4844.079624871404;4864.270359446112;7727.806804829925;7729.536227826348;7730.226977302224;7738.729144479917;7752.612369381395;7176.9904426760595;7418.035655364768;7432.92567074344;7435.92564074374;7445.553266804009;7380.114386273682;7380.409567234501;7394.667239974106;7411.518251313647;7418.740344087931;6960.582365058112;7176.390006849476;7189.928100718926;7198.0282661842075;7225.783226503213;7371.262873712586;7390.6674199660065;7396.14944281393;7407.62961851916;7409;7229.313215244543;7230.313120253568;7240.239774823568;7244.022057022235;7254.056972593529 04:51:28 INFO - 2015-11-23 04:51:28,646 DEBUG : BROWSER_OUTPUT: |5;yui.html;719.1801346465031;775.2673723331451;799.4483806173736;828.3000864269692;845.4546817302844;14924.77612835807;15273.389064437437;15276.236188190602;15288.388464461423;15300.999999999985;14023.649408764786;14099.154050756963;14110.64723381916;14111.082779619317;14115.717685646281;753.8040109571509;767.1178145133085;771.9189485104067;777.0946846923327;958.6836344006496;960.4957397366404;964.0022576633186;975.4878688688424;976.0922342221731;979.0356498848629;1016.69499150255;1029.6653587584028;1031.876174859018;1033.410955755216;1035.4460363705418;808.6967387229789;809.5062012172599;817.3012074676185;817.6606708216083;1012.9139023183002;751.143696186348;766.8006318357211;766.9041369828772;766.9693212271558;768.2356055724534;14714.190719510423;14878.776818347733;14892.776608350883;14899.478518251917;14944.551663450115;10514.474276286155;12320.75358492825;12728.490860365575;12955.48178072876;13174;9968.900310996869;10171.694849154463;10172.186225101974;10231.539580718885;10937.2890762101;3519.7712148710507;3523.2777280657406;3524.365614189445;3528.1356067763304;3529.400001999666;80595.99999999942;81711;81713.59143204306;82305.17694823035;82541;9647.083527064917;9711.514424278757;9764.9023509764;9896.505174741234;10273.640422585173;22514.437139071655;22609;22963.966621502073;23016.194433195094;23017.19439819598;7694.461387702919;7756.68973241064;7804.531728096219;7889.487183333065;8030.558319292495;4066.6543343816106;4119.8970025749595;4124.793760312033;4131.938020929689;4141.4616099907425;3102.705243001911;3668.5414323209598;3668.6881615062484;3669.7798132112157;3671.7246206534082;634.4480302137171;643.5012865029639;647.737666245162;670.2827974067798;671.7951024937344;483.5213138992372;509.9965272609982;519.7972790611665;552.8009916430082;632.3644737039338;8273.738033180683;8341.290990265896;8437.240648341678;8529.232369086812;8599.39804213699;537.3712756075402;584.2930054633856;601.8405122642504;629.9685015749194;644.44899610833;3685.299793039314;3929.7052721046034;3991.4611527444004;4084.101497670508;4133.1940271647345;97039;97336;99770.50114749525;100055.99384067747;100223.49888250513;76045.6197719019;77020;77473.61263193648;79020;81041;63986.40033999187;65786.67106664531;74112.62943685355;74600.25399746042;74710.87933680999;8103.83792324162;8116.188381161836;8232.382571307297;8318.45930014547;8336.87494687568;50297.49702502928;50363.49636503735;51002;51113.233301499764;52577.68555786136;60599.40169702424;70269.64865175642;70936;73588.63205683937;73685.7894263173;10997.12023038139;11168.832467512831;11201.43992800373;11448.599299024494;11730.296182229093;11871.109666775199;12565.18326308787;12607.49570017189;13040.891524220548;13090.14914030585;10888.945555272174;11422.371769552754;11507.539698412305;11524.078073754246;12221.022318214344;11476.02453791437;11687.18189726711;11814.645560633195;12060.457279422271;12486.875131248571;8177.836443270982;8708.73873783762;10384.065434110966;11529.423528823358;11719.296842189497;9326.347155699035;9436.386634868986;9598.284105634813;9650.517474126405;9690.37012594179;9449.385789923634;9649.662261821084;9754.219662427131;9857.852132217879;9908.554115064695 04:51:28 INFO - 2015-11-23 04:51:28,646 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:51:28 INFO - 2015-11-23 04:51:28,647 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:51:28 INFO - 2015-11-23 04:51:28,647 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1626 04:51:28 INFO - 2015-11-23 04:51:28,647 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:51:28 INFO - 2015-11-23 04:51:28,647 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283088632__endTimestamp 04:51:28 INFO - 2015-11-23 04:51:28,647 DEBUG : BROWSER_OUTPUT: 04:51:28 INFO - 2015-11-23 04:51:28,647 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:51:28 INFO - 2015-11-23 04:51:28,647 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:51:28 INFO - 2015-11-23 04:51:28,647 DEBUG : BROWSER_OUTPUT: 04:51:28 INFO - 2015-11-23 04:51:28,648 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5912.77 Median:6134.00 stddev:632.86 (10.3%) stddev-sans-first:604.74 04:51:28 INFO - 2015-11-23 04:51:28,649 DEBUG : BROWSER_OUTPUT: Values: 3456.1 3488.9 3495.9 3529.3 3537.0 5755.4 5883.9 5993.3 6021.9 6063.3 5879.7 5936.3 5954.1 5959.3 5972.2 5355.0 5391.3 5422.6 5468.5 5519.0 5452.2 5479.9 5481.5 5490.3 5499.3 5480.8 5497.2 5498.5 5507.7 5513.7 5475.5 5482.8 5485.3 5489.1 5506.9 5280.4 5301.3 5401.5 5412.5 5442.5 5867.9 6026.4 6041.7 6080.9 6082.7 5419.9 6336.8 6337.9 6347.7 6361.1 6215.2 6252.9 6319.4 6322.2 6329.7 5585.4 6127.2 6134.0 6160.8 6174.9 5535.8 6517.1 6517.9 6520.8 6543.0 6118.0 6216.4 6337.0 6363.4 6364.8 6384.6 6395.2 6396.2 6396.3 6398.7 6302.0 6352.9 6358.7 6373.9 6390.7 6170.3 6186.5 6271.3 6293.9 6342.4 5124.7 5142.6 5143.6 5146.5 5160.9 4612.5 4622.1 4624.1 4641.0 4650.7 5914.9 5973.0 6061.1 6074.4 6098.2 6500.8 6505.1 6522.4 6523.5 6525.0 6092.4 6111.4 6124.7 6128.4 6137.7 5476.2 5556.6 5566.5 5581.8 5602.1 6269.3 6293.0 6299.5 6372.3 6376.4 6461.7 6468.6 6469.4 6476.2 6493.1 5364.3 6328.8 6393.6 6410.7 6428.5 6141.7 6251.9 6267.6 6292.7 6357.4 6466.1 6473.6 6477.1 6483.4 6486.9 5354.6 6110.0 6250.4 6256.2 6270.3 6091.9 6215.1 6222.2 6226.1 6232.1 4715.6 6112.7 6113.3 6124.4 6143.9 6156.1 6309.4 6316.3 6319.7 6339.4 6210.2 6269.7 6282.4 6287.3 6294.5 04:51:28 INFO - 2015-11-23 04:51:28,649 DEBUG : BROWSER_OUTPUT: 04:51:28 INFO - 2015-11-23 04:51:28,649 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:73632.27 Median:37736.91 stddev:162718.50 (431.2%) stddev-sans-first:163082.49 04:51:28 INFO - 2015-11-23 04:51:28,649 DEBUG : BROWSER_OUTPUT: Values: 564.4 593.3 604.3 631.6 640.7 38795.6 39496.5 39523.4 39594.6 39771.2 43810.6 44196.8 44204.8 44289.9 44315.3 8817.8 8907.9 8920.2 9764.7 9988.7 8820.9 8879.9 8992.4 10600.4 12154.5 11888.2 11983.6 12007.6 12014.9 12045.3 11826.8 11908.0 11939.5 11944.6 11996.6 8941.3 9100.0 9122.8 11828.5 11978.6 40916.0 41267.8 41330.4 41358.4 41379.8 3250.8 3291.6 3400.5 3531.6 3631.6 28283.0 28640.9 29145.9 29561.4 29897.9 2787.0 2794.1 2858.1 2875.1 2966.7 465711.0 466684.0 470760.0 471370.0 472285.0 55211.7 56481.7 56596.7 65118.0 65544.3 71034.6 71794.3 72094.0 72243.0 72385.6 15319.8 15640.9 16472.2 16629.6 16672.1 12715.5 12781.0 12782.7 12792.4 12810.9 19617.5 19984.9 20010.6 20025.0 20037.6 8750.0 8899.5 8917.3 8926.2 8927.5 964.8 972.8 1023.6 1032.5 1093.6 27772.0 27786.6 27979.9 28071.4 28131.4 1073.0 1077.2 1125.8 1128.9 1202.6 14369.1 15059.0 15487.5 15855.3 16093.1 645927.0 661723.0 662991.4 665290.0 668175.0 62260.7 62712.7 62747.0 62904.7 63011.7 1471.4 1483.3 1496.5 1496.8 1500.3 27370.8 30963.2 31153.5 31389.7 31854.4 49273.3 49955.8 53256.0 53879.7 53936.5 662264.0 671449.0 673335.0 675402.0 677992.6 34381.7 34486.8 34779.0 34789.3 34809.8 44832.8 45661.0 45743.3 46153.5 46978.8 37387.3 38023.8 38108.4 38449.0 39062.0 37199.3 37874.2 37914.4 38112.8 38203.9 37325.0 37654.0 37819.8 37892.0 37966.7 31379.0 33180.5 33784.8 33790.2 33836.2 24880.3 24922.5 25064.2 25393.0 25399.6 04:51:28 INFO - 2015-11-23 04:51:28,649 DEBUG : BROWSER_OUTPUT: 04:51:28 INFO - 2015-11-23 04:51:28,650 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38379.30 Median:2108.55 stddev:125616.73 (5957.5%) stddev-sans-first:125936.67 04:51:28 INFO - 2015-11-23 04:51:28,651 DEBUG : BROWSER_OUTPUT: Values: 358.8 359.9 365.9 367.8 372.9 15928.9 18121.1 20054.4 20787.1 21396.4 11952.6 12044.6 12252.0 12308.8 12322.6 3930.2 5223.8 5341.5 5372.0 5372.8 4039.0 4056.7 5769.1 5948.1 5957.4 5752.8 5759.4 5853.7 5898.2 5911.5 5661.0 5661.0 5764.2 5765.4 5791.9 5408.5 5545.2 5548.5 5560.2 5579.3 12938.2 13089.1 13104.9 17915.9 25951.0 1994.9 2055.9 2101.6 2115.5 2127.9 9942.5 9999.6 10161.5 10865.8 13883.6 1610.4 1648.1 1725.4 1736.7 1765.2 94101.0 99276.0 99488.0 101402.0 103384.0 10879.8 11155.7 11221.7 11228.8 11329.7 13148.0 13158.4 13185.1 13196.1 13208.7 7474.9 8470.8 8546.6 8576.0 8621.6 7564.8 8646.5 8773.7 8808.4 8855.7 4088.1 4359.6 4380.6 4399.6 4473.2 1768.1 1793.7 3000.3 3393.7 3474.6 781.8 901.0 937.3 951.7 963.9 14826.6 17942.9 20814.4 20862.6 20869.7 956.8 1017.7 1020.2 1061.3 1062.9 10853.3 10994.3 11033.7 11433.4 11879.6 751636.2 755943.0 771024.0 771239.0 772488.0 61570.1 95921.0 116575.0 118015.4 120495.8 472.3 485.7 488.8 489.9 491.0 10762.8 10987.1 11018.9 11051.7 11204.3 52631.5 53538.7 53647.0 54870.5 55106.0 74822.3 75006.0 76586.6 76938.5 77696.0 9473.6 9917.0 10017.5 10045.1 10048.7 19955.2 19991.7 20344.5 20397.9 20571.4 3490.0 16194.9 16269.8 16278.9 16422.2 15528.9 15632.5 15685.5 15927.4 16397.7 13183.4 15997.0 16749.5 17416.8 17492.5 9939.5 10019.0 10213.6 10235.9 10267.9 16279.2 16295.3 16498.9 16825.0 16869.0 04:51:28 INFO - 2015-11-23 04:51:28,651 DEBUG : BROWSER_OUTPUT: 04:51:28 INFO - 2015-11-23 04:51:28,651 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5909.50 Median:5920.73 stddev:3067.04 (51.8%) stddev-sans-first:3058.14 04:51:28 INFO - 2015-11-23 04:51:28,652 DEBUG : BROWSER_OUTPUT: Values: 1549.9 1553.8 1697.0 1896.5 1917.8 7543.2 7949.8 7951.4 8399.1 8592.0 8331.7 8458.6 8480.4 8482.6 8495.0 2133.7 2368.7 2396.4 2398.7 2400.3 2201.1 2203.9 2367.4 2408.0 2409.2 2192.5 2241.3 2312.5 2366.6 2370.3 2036.2 2115.4 2177.3 2358.3 2386.2 2347.6 2392.5 2394.4 2398.7 2400.9 8465.8 8557.4 8567.6 8568.7 8570.7 5150.6 5233.2 5245.0 5245.1 5273.0 3497.1 3557.1 3625.0 3634.2 3642.7 1052.6 1056.4 1062.3 1074.3 1081.2 11312.6 11326.3 11335.9 11349.4 11355.7 4601.0 4698.8 4703.0 4727.4 4765.7 9695.3 9696.2 9696.8 9707.8 9718.7 5256.4 5284.7 5295.7 5295.9 5310.9 4799.6 4841.3 4842.2 4842.9 4853.4 3621.6 3745.3 3759.4 3763.9 3784.8 1168.4 1178.8 1180.9 1182.5 1187.0 1113.5 1113.9 1164.0 1310.7 1403.7 7843.2 7860.2 7945.8 7947.2 7968.9 1078.6 1211.1 1217.6 1218.4 1237.0 5857.7 5983.7 6210.6 6464.3 6523.7 9624.4 9769.3 9939.4 9956.7 10100.2 9940.4 10038.2 10046.0 10149.0 10158.4 7812.3 7855.1 7911.6 7930.3 7967.2 7908.1 7934.6 7935.2 7943.5 7978.4 8918.4 8929.0 9121.3 9185.2 9248.6 9390.1 9536.4 9562.0 9562.8 9579.5 7942.2 8052.5 8064.8 8069.9 8070.4 7904.8 8115.1 8122.0 8152.9 8159.8 7557.0 7571.4 7630.5 7710.1 7717.2 7328.6 7459.0 7481.6 7539.8 7581.0 7590.0 7651.8 7666.2 7698.5 7712.1 6946.6 6999.9 7005.9 7006.6 7013.6 6081.2 7051.2 7103.5 7110.9 7113.1 04:51:28 INFO - 2015-11-23 04:51:28,652 DEBUG : BROWSER_OUTPUT: 04:51:28 INFO - 2015-11-23 04:51:28,652 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6020.92 Median:6843.88 stddev:1909.07 (27.9%) stddev-sans-first:1865.96 04:51:28 INFO - 2015-11-23 04:51:28,654 DEBUG : BROWSER_OUTPUT: Values: 326.4 335.8 338.9 344.7 346.7 5495.7 6702.9 6857.8 6865.9 6903.1 5436.7 6772.9 6818.2 6839.6 6844.4 4985.0 5115.6 5117.4 5118.4 5141.9 4996.6 5056.6 5135.4 5142.2 5143.3 5045.9 5124.1 5127.1 5131.0 5155.3 5086.3 5088.2 5091.5 5096.8 5103.3 4329.3 4351.1 4357.1 4361.7 4373.5 6379.9 6633.8 6635.7 6650.7 6694.2 6024.1 6030.8 6040.3 6041.3 6050.2 5973.4 7051.2 7211.1 7393.2 7396.3 3959.7 4435.7 4561.7 4719.3 4889.3 7815.8 7840.8 7841.6 7846.8 7848.3 4829.1 4898.2 4953.1 4965.6 4967.0 5061.1 5069.2 5074.2 5085.5 5089.9 6014.9 6016.8 6024.8 6032.8 6039.7 7454.1 7466.0 7469.7 7471.8 7481.6 1644.8 1701.0 1704.1 1705.2 1711.2 1067.5 1075.8 1086.4 1091.4 1093.7 6813.8 6843.6 6847.6 6857.8 6880.0 7639.6 7645.8 7652.0 7652.2 7659.5 6739.1 6844.1 6865.2 6875.2 6927.2 4081.8 4100.0 4112.7 4121.1 4128.7 6661.7 7322.3 7420.0 7768.8 7787.9 7639.6 7827.3 7981.6 8017.0 8031.8 6860.5 7165.2 7449.7 7742.2 7750.0 7477.0 7539.4 7580.2 7797.1 7811.6 7623.1 7632.7 7638.6 7644.6 7650.4 7563.4 7746.8 7778.5 7785.6 7801.2 4784.6 4834.0 4843.3 4844.1 4864.3 7727.8 7729.5 7730.2 7738.7 7752.6 7177.0 7418.0 7432.9 7435.9 7445.6 7380.1 7380.4 7394.7 7411.5 7418.7 6960.6 7176.4 7189.9 7198.0 7225.8 7371.3 7390.7 7396.1 7407.6 7409.0 7229.3 7230.3 7240.2 7244.0 7254.1 04:51:28 INFO - 2015-11-23 04:51:28,654 DEBUG : BROWSER_OUTPUT: 04:51:28 INFO - 2015-11-23 04:51:28,654 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18699.69 Median:568.55 stddev:26503.89 (4661.7%) stddev-sans-first:26543.85 04:51:28 INFO - 2015-11-23 04:51:28,655 DEBUG : BROWSER_OUTPUT: Values: 719.2 775.3 799.4 828.3 845.5 14924.8 15273.4 15276.2 15288.4 15301.0 14023.6 14099.2 14110.6 14111.1 14115.7 753.8 767.1 771.9 777.1 958.7 960.5 964.0 975.5 976.1 979.0 1016.7 1029.7 1031.9 1033.4 1035.4 808.7 809.5 817.3 817.7 1012.9 751.1 766.8 766.9 767.0 768.2 14714.2 14878.8 14892.8 14899.5 14944.6 10514.5 12320.8 12728.5 12955.5 13174.0 9968.9 10171.7 10172.2 10231.5 10937.3 3519.8 3523.3 3524.4 3528.1 3529.4 80596.0 81711.0 81713.6 82305.2 82541.0 9647.1 9711.5 9764.9 9896.5 10273.6 22514.4 22609.0 22964.0 23016.2 23017.2 7694.5 7756.7 7804.5 7889.5 8030.6 4066.7 4119.9 4124.8 4131.9 4141.5 3102.7 3668.5 3668.7 3669.8 3671.7 634.4 643.5 647.7 670.3 671.8 483.5 510.0 519.8 552.8 632.4 8273.7 8341.3 8437.2 8529.2 8599.4 537.4 584.3 601.8 630.0 644.4 3685.3 3929.7 3991.5 4084.1 4133.2 97039.0 97336.0 99770.5 100056.0 100223.5 76045.6 77020.0 77473.6 79020.0 81041.0 63986.4 65786.7 74112.6 74600.3 74710.9 8103.8 8116.2 8232.4 8318.5 8336.9 50297.5 50363.5 51002.0 51113.2 52577.7 60599.4 70269.6 70936.0 73588.6 73685.8 10997.1 11168.8 11201.4 11448.6 11730.3 11871.1 12565.2 12607.5 13040.9 13090.1 10888.9 11422.4 11507.5 11524.1 12221.0 11476.0 11687.2 11814.6 12060.5 12486.9 8177.8 8708.7 10384.1 11529.4 11719.3 9326.3 9436.4 9598.3 9650.5 9690.4 9449.4 9649.7 9754.2 9857.9 9908.6 04:51:28 INFO - 2015-11-23 04:51:28,655 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:51:28 INFO - 2015-11-23 04:51:28,655 DEBUG : BROWSER_OUTPUT: 04:51:29 INFO - 2015-11-23 04:51:29,084 INFO : Browser exited with error code: 0 04:51:29 INFO - 2015-11-23 04:51:29,107 INFO : Completed test dromaeo_css (00:18:35) 04:51:29 INFO - 2015-11-23 04:51:29,108 INFO : Starting test kraken 04:51:29 INFO - 2015-11-23 04:51:29,108 DEBUG : operating with platform_type : mac_ 04:51:29 INFO - 2015-11-23 04:51:29,108 INFO : Initialising browser for kraken test... 04:51:29 INFO - 2015-11-23 04:51:29,121 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpyffpsC/profile http://localhost:49898/getInfo.html 04:51:31 INFO - 2015-11-23 04:51:31,062 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:51:31 INFO - 2015-11-23 04:51:31,062 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:51:31 INFO - 2015-11-23 04:51:31,062 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:51:31 INFO - 2015-11-23 04:51:31,062 DEBUG : BROWSER_OUTPUT: __metrics 04:51:31 INFO - 2015-11-23 04:51:31,078 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:31 INFO - 2015-11-23 04:51:31,710 INFO : Browser initialized. 04:51:31 INFO - 2015-11-23 04:51:31,711 INFO : Running cycle 1/1 for kraken test... 04:51:31 INFO - 2015-11-23 04:51:31,711 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpyffpsC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:51:43 INFO - 2015-11-23 04:51:43,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 226131968 04:51:43 INFO - 2015-11-23 04:51:43,515 DEBUG : BROWSER_OUTPUT: 04:51:46 INFO - 2015-11-23 04:51:46,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49898/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:46 INFO - 2015-11-23 04:51:46,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 275763200 04:51:46 INFO - 2015-11-23 04:51:46,618 DEBUG : BROWSER_OUTPUT: 04:51:49 INFO - 2015-11-23 04:51:49,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49898/tests/kraken/driver.html?testName=audio-dft) 04:51:49 INFO - 2015-11-23 04:51:49,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 289411072 04:51:49 INFO - 2015-11-23 04:51:49,873 DEBUG : BROWSER_OUTPUT: 04:51:53 INFO - 2015-11-23 04:51:53,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49898/tests/kraken/driver.html?testName=audio-fft) 04:51:53 INFO - 2015-11-23 04:51:53,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 275083264 04:51:53 INFO - 2015-11-23 04:51:53,664 DEBUG : BROWSER_OUTPUT: 04:51:55 INFO - 2015-11-23 04:51:55,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49898/tests/kraken/driver.html?testName=audio-oscillator) 04:51:56 INFO - 2015-11-23 04:51:56,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 276529152 04:51:56 INFO - 2015-11-23 04:51:56,119 DEBUG : BROWSER_OUTPUT: 04:51:58 INFO - 2015-11-23 04:51:58,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49898/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:58 INFO - 2015-11-23 04:51:58,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 279244800 04:51:58 INFO - 2015-11-23 04:51:58,684 DEBUG : BROWSER_OUTPUT: 04:52:01 INFO - 2015-11-23 04:52:01,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49898/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:02 INFO - 2015-11-23 04:52:02,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 280363008 04:52:02 INFO - 2015-11-23 04:52:02,058 DEBUG : BROWSER_OUTPUT: 04:52:04 INFO - 2015-11-23 04:52:04,965 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49898/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:05 INFO - 2015-11-23 04:52:05,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 278831104 04:52:05 INFO - 2015-11-23 04:52:05,552 DEBUG : BROWSER_OUTPUT: 04:52:08 INFO - 2015-11-23 04:52:08,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49898/tests/kraken/driver.html?testName=json-parse-financial) 04:52:08 INFO - 2015-11-23 04:52:08,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 278212608 04:52:08 INFO - 2015-11-23 04:52:08,975 DEBUG : BROWSER_OUTPUT: 04:52:10 INFO - 2015-11-23 04:52:10,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49898/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:11 INFO - 2015-11-23 04:52:11,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 311689216 04:52:11 INFO - 2015-11-23 04:52:11,058 DEBUG : BROWSER_OUTPUT: 04:52:12 INFO - 2015-11-23 04:52:12,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49898/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:13 INFO - 2015-11-23 04:52:13,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 312926208 04:52:13 INFO - 2015-11-23 04:52:13,457 DEBUG : BROWSER_OUTPUT: 04:52:15 INFO - 2015-11-23 04:52:15,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49898/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:16 INFO - 2015-11-23 04:52:16,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 321175552 04:52:16 INFO - 2015-11-23 04:52:16,116 DEBUG : BROWSER_OUTPUT: 04:52:18 INFO - 2015-11-23 04:52:18,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:19 INFO - 2015-11-23 04:52:19,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 322379776 04:52:19 INFO - 2015-11-23 04:52:19,247 DEBUG : BROWSER_OUTPUT: 04:52:21 INFO - 2015-11-23 04:52:21,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:22 INFO - 2015-11-23 04:52:22,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 323391488 04:52:22 INFO - 2015-11-23 04:52:22,241 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49898/tests/kraken/driver.html?testName=ai-astar) 04:52:24 INFO - 2015-11-23 04:52:24,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 381231104 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;104;110;110;110;110;110;104;109 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;120;142;152;118;142;141;181;133;136 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;183;183;186;182;185;186;185;184;182 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: |3;audio-fft;66;63;71;72;57;57;57;71;73;54 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;87;115;73;76;74;105;75;74;106 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;85;87;85;85;85;85;86;88;131 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;93;120;147;98;93;99;99;92;92 04:52:24 INFO - 2015-11-23 04:52:24,263 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;133;134;85;86;85;87;86;85;84 04:52:24 INFO - 2015-11-23 04:52:24,264 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;52;53;55;54;53;54;63;52;51 04:52:24 INFO - 2015-11-23 04:52:24,264 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;65;64;66;68;69;66;69;68 04:52:24 INFO - 2015-11-23 04:52:24,264 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;78;83;78;83;83;81;94;80;82;82 04:52:24 INFO - 2015-11-23 04:52:24,264 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;124;130;119;125;117;123;123;117;119 04:52:24 INFO - 2015-11-23 04:52:24,264 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;124;135;131;135;126;135;134;137;133 04:52:24 INFO - 2015-11-23 04:52:24,264 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;65;64;66;65;67;81;92;88 04:52:24 INFO - 2015-11-23 04:52:24,264 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:52:24 INFO - 2015-11-23 04:52:24,264 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:52:24 INFO - 2015-11-23 04:52:24,264 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1050 04:52:24 INFO - 2015-11-23 04:52:24,264 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283144255__endTimestamp 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:2.50 (2.3%) stddev-sans-first:2.60 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 104.0 110.0 110.0 110.0 110.0 110.0 104.0 109.0 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.30 Median:142.00 stddev:17.73 (12.5%) stddev-sans-first:18.64 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: Values: 148.0 120.0 142.0 152.0 118.0 142.0 141.0 181.0 133.0 136.0 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:1.52 (0.8%) stddev-sans-first:1.58 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: Values: 183.0 183.0 183.0 186.0 182.0 185.0 186.0 185.0 184.0 182.0 04:52:24 INFO - 2015-11-23 04:52:24,265 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.10 Median:68.50 stddev:7.42 (10.8%) stddev-sans-first:7.83 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: Values: 66.0 63.0 71.0 72.0 57.0 57.0 57.0 71.0 73.0 54.0 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:86.80 Median:74.50 stddev:15.93 (21.4%) stddev-sans-first:16.84 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: Values: 83.0 87.0 115.0 73.0 76.0 74.0 105.0 75.0 74.0 106.0 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:85.00 stddev:14.37 (16.9%) stddev-sans-first:15.12 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 87.0 85.0 85.0 85.0 85.0 86.0 88.0 131.0 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:102.60 Median:93.00 stddev:17.71 (19.0%) stddev-sans-first:18.44 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 120.0 147.0 98.0 93.0 99.0 99.0 92.0 92.0 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:85.50 stddev:20.00 (23.4%) stddev-sans-first:21.22 04:52:24 INFO - 2015-11-23 04:52:24,266 DEBUG : BROWSER_OUTPUT: Values: 96.0 133.0 134.0 85.0 86.0 85.0 87.0 86.0 85.0 84.0 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:3.36 (6.2%) stddev-sans-first:3.55 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: Values: 55.0 52.0 53.0 55.0 54.0 53.0 54.0 63.0 52.0 51.0 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:67.00 stddev:2.20 (3.3%) stddev-sans-first:2.01 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 65.0 64.0 66.0 68.0 69.0 66.0 69.0 68.0 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:4.50 (5.5%) stddev-sans-first:4.48 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: Values: 78.0 83.0 78.0 83.0 83.0 81.0 94.0 80.0 82.0 82.0 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:123.00 stddev:4.04 (3.3%) stddev-sans-first:4.28 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: Values: 122.0 124.0 130.0 119.0 125.0 117.0 123.0 123.0 117.0 119.0 04:52:24 INFO - 2015-11-23 04:52:24,267 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,268 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.50 Median:135.00 stddev:4.28 (3.2%) stddev-sans-first:4.44 04:52:24 INFO - 2015-11-23 04:52:24,268 DEBUG : BROWSER_OUTPUT: Values: 135.0 124.0 135.0 131.0 135.0 126.0 135.0 134.0 137.0 133.0 04:52:24 INFO - 2015-11-23 04:52:24,268 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,268 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:66.50 stddev:10.84 (16.3%) stddev-sans-first:11.22 04:52:24 INFO - 2015-11-23 04:52:24,268 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 64.0 66.0 65.0 67.0 81.0 92.0 88.0 04:52:24 INFO - 2015-11-23 04:52:24,268 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:52:24 INFO - 2015-11-23 04:52:24,268 DEBUG : BROWSER_OUTPUT: 04:52:24 INFO - 2015-11-23 04:52:24,859 INFO : Browser exited with error code: 0 04:52:24 INFO - 2015-11-23 04:52:24,905 INFO : Completed test kraken (00:00:55) 04:52:24 INFO - 2015-11-23 04:52:24,905 INFO : Starting test v8_7 04:52:24 INFO - 2015-11-23 04:52:24,905 DEBUG : operating with platform_type : mac_ 04:52:24 INFO - 2015-11-23 04:52:24,905 INFO : Initialising browser for v8_7 test... 04:52:24 INFO - 2015-11-23 04:52:24,918 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpyffB9x/profile http://localhost:49898/getInfo.html 04:52:26 INFO - 2015-11-23 04:52:26,927 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:52:26 INFO - 2015-11-23 04:52:26,927 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:52:26 INFO - 2015-11-23 04:52:26,927 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:52:26 INFO - 2015-11-23 04:52:26,927 DEBUG : BROWSER_OUTPUT: __metrics 04:52:26 INFO - 2015-11-23 04:52:26,943 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:52:27 INFO - 2015-11-23 04:52:27,695 INFO : Browser initialized. 04:52:27 INFO - 2015-11-23 04:52:27,696 INFO : Running cycle 1/1 for v8_7 test... 04:52:27 INFO - 2015-11-23 04:52:27,696 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpyffB9x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:52:39 INFO - 2015-11-23 04:52:39,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 224022528 04:52:39 INFO - 2015-11-23 04:52:39,637 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49898/tests/v8_7/run.html (next: http://localhost:49898/tests/v8_7/run.html) 04:53:01 INFO - 2015-11-23 04:53:01,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 581677056 04:53:01 INFO - 2015-11-23 04:53:01,346 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,346 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:53:01 INFO - 2015-11-23 04:53:01,346 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:53:01 INFO - 2015-11-23 04:53:01,346 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:53:01 INFO - 2015-11-23 04:53:01,346 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:53:01 INFO - 2015-11-23 04:53:01,346 DEBUG : BROWSER_OUTPUT: |0;Richards;147.27540500736376 04:53:01 INFO - 2015-11-23 04:53:01,346 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.86468112657818 04:53:01 INFO - 2015-11-23 04:53:01,346 DEBUG : BROWSER_OUTPUT: |2;Encrypt;298.86431560071725 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4643.518518518518 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1892.249527410208 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: |5;Earley;793.1854199683042 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: |6;Boyer;12469.135802469136 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: |7;RegExp;27189.18918918919 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: |8;Splay;1304.6875 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4522.522522522522 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: __startTimestamp1448283181340__endTimestamp 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,347 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.28 Median:147.28 stddev:0.00 (0.0%) 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: Values: 147.3 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.86 Median:161.86 stddev:0.00 (0.0%) 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: Values: 161.9 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:298.86 Median:298.86 stddev:0.00 (0.0%) 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: Values: 298.9 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4643.52 Median:4643.52 stddev:0.00 (0.0%) 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: Values: 4643.5 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1892.25 Median:1892.25 stddev:0.00 (0.0%) 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: Values: 1892.2 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,348 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.19 Median:793.19 stddev:0.00 (0.0%) 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: Values: 793.2 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12469.14 Median:12469.14 stddev:0.00 (0.0%) 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: Values: 12469.1 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27189.19 Median:27189.19 stddev:0.00 (0.0%) 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: Values: 27189.2 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:1304.69 Median:1304.69 stddev:0.00 (0.0%) 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: Values: 1304.7 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4522.52 Median:4522.52 stddev:0.00 (0.0%) 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: Values: 4522.5 04:53:01 INFO - 2015-11-23 04:53:01,349 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:53:01 INFO - 2015-11-23 04:53:01,350 DEBUG : BROWSER_OUTPUT: 04:53:02 INFO - 2015-11-23 04:53:02,084 INFO : Browser exited with error code: 0 04:53:02 INFO - 2015-11-23 04:53:02,102 INFO : Completed test v8_7 (00:00:37) 04:53:02 INFO - 2015-11-23 04:53:02,380 INFO : Completed test suite (00:20:08) 04:53:02 INFO - 2015-11-23 04:53:02,380 DEBUG : Working with test: dromaeo_css 04:53:02 INFO - 2015-11-23 04:53:02,380 DEBUG : Generating results file: dromaeo_css 04:53:02 INFO - 2015-11-23 04:53:02,381 DEBUG : Working with test: kraken 04:53:02 INFO - 2015-11-23 04:53:02,381 DEBUG : Generating results file: kraken 04:53:02 INFO - 2015-11-23 04:53:02,381 INFO : javascript benchmark 04:53:02 INFO - 2015-11-23 04:53:02,381 DEBUG : Working with test: v8_7 04:53:02 INFO - 2015-11-23 04:53:02,381 DEBUG : Generating results file: v8_7 04:53:02 INFO - 2015-11-23 04:53:02,382 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:53:02 INFO - 2015-11-23 04:53:02,440 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 04:53:02 INFO - 2015-11-23 04:53:02,440 DEBUG : process_Request line: dromaeo_css 7708.74 graph.html#tests=[[72,1,59]] 04:53:02 INFO - 2015-11-23 04:53:02,440 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:53:02 INFO - 2015-11-23 04:53:02,469 DEBUG : process_Request line: kraken 1402.70 graph.html#tests=[[232,1,59]] 04:53:02 INFO - 2015-11-23 04:53:02,469 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:53:02 INFO - 2015-11-23 04:53:02,508 DEBUG : process_Request line: v8_7 19050.34 graph.html#tests=[[230,1,59]] 04:53:02 INFO - 2015-11-23 04:53:02,509 INFO : javascript benchmark 04:53:02 INFO - 2015-11-23 04:53:02,511 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3456.118689734117, 3488.930221395571, 3495.947560786589, 3529.3294274087907, 3536.982315088424, 5755.4244575542425, 5883.941160588392, 5993.250843644539, 6021.909671354928, 6063.302720187175, 5879.735411906464, 5936.257967754031, 5954.077118046699, 5959.284885813698, 5972.223610930584, 5354.973225133878, 5391.32608423947, 5422.593305502103, 5468.453154684519, 5519.0, 5452.154915988028, 5479.890402191953, 5481.479259470344, 5490.258815059976, 5499.312585926759, 5480.808171713991, 5497.202905578689, 5498.477644623755, 5507.7246137693155, 5513.696746678931, 5475.5072043516075, 5482.835514934558, 5485.259489968883, 5489.149181876815, 5506.91739623904, 5280.392754833205, 5301.310829592128, 5401.540869026137, 5412.485813847678, 5442.510174084312, 5867.911981320283, 6026.427489388501, 6041.667708276043, 6080.939190608082, 6082.726277317532, 5419.945800541984, 6336.822357548057, 6337.873242535124, 6347.746090156388, 6361.109444677749, 6215.223097112861, 6252.906206406908, 6319.3680631936895, 6322.209723784527, 6329.715162817684, 5585.442484727722, 6127.234095738033, 6134.0, 6160.753569857246, 6174.938250617482, 5535.750891209825, 6517.055027021055, 6517.9348206517325, 6520.771772988018, 6542.967285163544, 6117.979653188387, 6216.378362163838, 6336.968315158395, 6363.363663633692, 6364.840878978062, 6384.585001974857, 6395.232572091286, 6396.232452105684, 6396.328385519547, 6398.744050238031, 6301.96849015752, 6352.872942541123, 6358.713857876407, 6373.936260637334, 6390.712417941204, 6170.259568851677, 6186.536009799283, 6271.310155882849, 6293.874122517524, 6342.39747224013, 5124.692518448905, 5142.5628821549835, 5143.639945203875, 5146.459621739738, 5160.870978225575, 4612.53874612536, 4622.075584883037, 4624.075184963021, 4641.0, 4650.674452788272, 5914.940850591439, 5972.954732921721, 6061.121137435047, 6074.392560743979, 6098.236059785416, 6500.804975850732, 6505.056766768792, 6522.380373864476, 6523.510736694672, 6524.9673751630935, 6092.421219984094, 6111.35830737775, 6124.663143527148, 6128.387161283836, 6137.662428566472, 5476.17857321405, 5556.611037227436, 5566.471185237396, 5581.832545023656, 5602.1036634138345, 6269.341719119427, 6293.024581189923, 6299.464545513682, 6372.267189273293, 6376.39424254695, 6461.676916154268, 6468.611883287018, 6469.353064693493, 6476.158099447041, 6493.123428337114, 5364.275822763877, 6328.810135695937, 6393.6483493408305, 6410.679466026773, 6428.4857211423905, 6141.7409431065635, 6251.874962500816, 6267.62394256346, 6292.716827742855, 6357.364263573606, 6466.094746735367, 6473.643949582818, 6477.060826180272, 6483.448906842971, 6486.935130648633, 5354.598405119554, 6109.969450152721, 6250.374962503895, 6256.249250090018, 6270.310265870842, 6091.914134152887, 6215.129881816459, 6222.222222222223, 6226.066090086523, 6232.09634602971, 4715.6227501799085, 6112.65546444155, 6113.263474096151, 6124.44586445147, 6143.877122457615, 6156.107364432043, 6309.400606942333, 6316.273628532777, 6319.652419116993, 6339.429451349401, 6210.223722034746, 6269.749210031548, 6282.434580887742, 6287.276963149114, 6294.527910406646], "unit": "ms", "name": "dojo.html", "value": 5875.252752808401}, {"lowerIsBetter": false, "replicates": [564.3820017081295, 593.2910172344051, 604.2748701558131, 631.5547538985015, 640.6924676155445, 38795.612043879555, 39496.457907340664, 39523.40714889279, 39594.60405395949, 39771.2045759085, 43810.56189438113, 44196.779016104956, 44204.77897610507, 44289.89275268112, 44315.33526997098, 8817.779555511132, 8907.866382004275, 8920.152585504367, 9764.658236961726, 9988.700338989842, 8820.941487021535, 8879.866801997976, 8992.370534062618, 10600.416977066257, 12154.453049612745, 11888.227265227775, 11983.64049078529, 12007.579734709287, 12014.939925300361, 12045.337506437143, 11826.822597661041, 11908.047356211482, 11939.462724177347, 11944.581939632115, 11996.64010079699, 8941.329400294939, 9099.954500227457, 9122.81754364909, 11828.467718952668, 11978.64064078079, 40916.0, 41267.79366103181, 41330.38004429936, 41358.37962430566, 41379.7931010343, 3250.7886987345983, 3291.6214635316765, 3400.472926696366, 3531.611522732497, 3631.6005239423644, 28283.0, 28640.856795716096, 29145.854270728723, 29561.38255086995, 29897.850510747525, 2786.986065069682, 2794.1338185162663, 2858.1425572328426, 2875.09434528123, 2966.688497707731, 465711.0, 466684.0, 470759.99999999657, 471370.0, 472285.0, 55211.723941380034, 56481.71759141178, 56596.71701641465, 65118.0, 65544.34455655477, 71034.64482677553, 71794.28205717981, 72094.0, 72243.0, 72385.55228895393, 15319.846801532065, 15640.92179539095, 16472.176391180394, 16629.584260393345, 16672.083035432926, 12715.491380344867, 12781.041421893395, 12782.680432989064, 12792.36038198105, 12810.871891280967, 19617.509562260773, 19984.90007549953, 20010.599788004158, 20025.0, 20037.59924801525, 8750.0, 8899.466032038099, 8917.286617070618, 8926.241269492037, 8927.508987005647, 964.8359778837614, 972.7713987212999, 1023.5649848814224, 1032.488917985587, 1093.6008356949656, 27772.0, 27786.583201251997, 27979.860100699774, 28071.43857122846, 28131.43737125287, 1072.983905241422, 1077.2405454154803, 1125.7973564758258, 1128.920975531705, 1202.6452196602024, 14369.13785172893, 15059.0, 15487.535373938574, 15855.286512106983, 16093.114878681785, 645927.0, 661723.0, 662991.3700863026, 665290.0, 668175.0, 62260.68869655623, 62712.68643656844, 62747.0, 62904.68547657324, 63011.684941575, 1471.3967273417848, 1483.3028476616405, 1496.5211132437516, 1496.7754836774352, 1500.2573726005696, 27370.768315425456, 30963.213310802137, 31153.532697010018, 31389.686103138676, 31854.36291274208, 49273.26090108723, 49955.75022124866, 53256.0, 53879.730601346746, 53936.460635393145, 662264.0, 671449.0, 673335.0, 675402.0, 677992.6100369466, 34381.656183437844, 34486.82756586201, 34779.0, 34789.30421391507, 34809.82595087009, 44832.775836120614, 45661.0, 45743.313850292936, 46153.538464616264, 46978.76510617425, 37387.252254955296, 38023.809880950415, 38108.42837357497, 38449.00162978795, 39062.0, 37199.25601488009, 37874.242515150094, 37914.43128353132, 38112.809435952644, 38203.8538843824, 37325.0, 37654.0, 37819.81090094532, 37892.0, 37966.67116650904, 31379.0, 33180.50229246515, 33784.831075844464, 33790.15524611806, 33836.154096147795, 24880.25359239226, 24922.50154996926, 25064.248072557853, 25393.0, 25399.6190057153], "unit": "ms", "name": "ext.html", "value": 20811.221373600867}, {"lowerIsBetter": false, "replicates": [358.82776267391654, 359.92081742016757, 365.8902329301212, 367.80690137677715, 372.87881438532486, 15928.920355398206, 18121.09394530275, 20054.398368048962, 20787.064582093804, 21396.35810925673, 11952.641420757369, 12044.57843975461, 12252.019838412927, 12308.753824923497, 12322.568710095149, 3930.233604447134, 5223.764930578123, 5341.4925582069645, 5372.0, 5372.838814835562, 4038.959610403888, 4056.71602987791, 5769.105788602752, 5948.107783832416, 5957.374475680056, 5752.827415177551, 5759.366469688331, 5853.7365818538265, 5898.233229680136, 5911.497522710575, 5660.971695141539, 5661.009323368436, 5764.193012978187, 5765.423457654222, 5791.884162316751, 5408.513233808976, 5545.195946587723, 5548.472895074961, 5560.193771903051, 5579.330480342344, 12938.223706577635, 13089.083764136514, 13104.934475327562, 17915.910420447814, 25950.961961521516, 1994.9102290396968, 2055.856090073695, 2101.6322143624957, 2115.471132216946, 2127.8616889902105, 9942.453165075918, 9999.550020249106, 10161.4919254037, 10865.782684346268, 13883.583492495241, 1610.3800036985845, 1648.1182567326543, 1725.3702398624537, 1736.6873962686711, 1765.161548264564, 94101.0, 99276.0, 99488.0, 101402.0, 103384.0, 10879.83680244797, 11155.72110697239, 11221.71945701364, 11228.775424491465, 11329.660110196708, 13148.0, 13158.407871645799, 13185.077044606785, 13196.14225075367, 13208.669783255304, 7474.925250747532, 8470.788230294169, 8546.61540230691, 8575.95712021436, 8621.568921553897, 7564.773056808304, 8646.481211127353, 8773.736787896374, 8808.427452215585, 8855.690050848318, 4088.0801819590356, 4359.629431498358, 4380.561943805657, 4399.6040356368085, 4473.150101480708, 1768.0629266488781, 1793.650238203564, 3000.294930691286, 3393.728501719906, 3474.5656792900886, 781.7811012916393, 900.9909900901038, 937.2703985385001, 951.7382719752123, 963.9107808176716, 14826.627739561618, 17942.91028544875, 20814.37556873296, 20862.582748344947, 20869.68695469569, 956.8229877472689, 1017.6641708236265, 1020.1940467031111, 1061.2836335473523, 1062.946852657364, 10853.294535855302, 10994.34033957965, 11033.724156896142, 11433.428328583537, 11879.643610691694, 751636.209094777, 755943.0, 771024.0, 771239.0, 772488.0, 61570.0764488533, 95921.0, 116575.0, 118015.40992295156, 120495.79504205022, 472.3151430425896, 485.7110019538369, 488.77516342482147, 489.9118158731391, 491.00571343029935, 10762.838557421488, 10987.066099381642, 11018.944905275423, 11051.668449946514, 11204.271722338022, 52631.47368526266, 53538.73230633822, 53647.0, 54870.451295486535, 55106.0, 74822.25177748154, 75006.0, 76586.6170669143, 76938.46123077619, 77696.0, 9473.57368918414, 9916.950415247878, 10017.499125043865, 10045.146162575971, 10048.748781280527, 19955.20179192816, 19991.700124498435, 20344.491387715425, 20397.898010509853, 20571.38285851427, 3490.0402389343135, 16194.919025404797, 16269.769859836291, 16278.941868778491, 16422.17889105564, 15528.922355388602, 15632.4528641497, 15685.529434116996, 15927.442539511061, 16397.67204655924, 13183.40674669623, 15997.040177589382, 16749.497515074567, 17416.825831742026, 17492.47522574325, 9939.453330066915, 10019.048190421898, 10213.642522511676, 10235.897641023494, 10267.897321026694, 16279.186040697681, 16295.26671299818, 16498.917505412875, 16825.0, 16869.0], "unit": "ms", "name": "jquery.html", "value": 9451.116523507299}, {"lowerIsBetter": false, "replicates": [1549.8837587180958, 1553.8057742782146, 1697.0, 1896.459509039924, 1917.8369838563722, 7543.170251272362, 7949.84100317994, 7951.403644726647, 8399.11809260028, 8592.011918629343, 8331.666733330674, 8458.577071146448, 8480.448770829891, 8482.618282177302, 8495.023072346667, 2133.7012818205462, 2368.7394386617502, 2396.3529846941315, 2398.6521954316613, 2400.327908185711, 2201.1195521791333, 2203.8787866667326, 2367.419982104378, 2408.0488207158164, 2409.1567951217107, 2192.5286063496346, 2241.316398498457, 2312.5259321839067, 2366.6213405855065, 2370.3363058343693, 2036.2465887621602, 2115.428834214769, 2177.3250292409243, 2358.304300231427, 2386.248331775485, 2347.6361164019604, 2392.533455976068, 2394.4133687246735, 2398.6881705378364, 2400.9039638414442, 8465.788355291106, 8557.400981931267, 8567.614457349435, 8568.742937711879, 8570.700025499078, 5150.587952963791, 5233.188855727369, 5245.0, 5245.055889939809, 5273.0, 3497.0557949353533, 3557.1107223194203, 3625.003124140856, 3634.182308980485, 3642.6721595056574, 1052.6210564196883, 1056.3767377247461, 1062.2511129653653, 1074.2963358999868, 1081.2269227502295, 11312.6040588579, 11326.263792853439, 11335.943320283428, 11349.432528373549, 11355.716107097305, 4601.0, 4698.835540756126, 4702.95297047032, 4727.385439892861, 4765.69023013503, 9695.272854535939, 9696.175825054808, 9696.757581060388, 9707.805843883083, 9718.659846905324, 5256.448072952285, 5284.709340986283, 5295.735213239323, 5295.920561191585, 5310.946890531045, 4799.592034677022, 4841.298011788271, 4842.176829938919, 4842.878928026827, 4853.417589889165, 3621.5654121505063, 3745.269672413853, 3759.4360845872793, 3763.8682646107254, 3784.848606055727, 1168.3865970365625, 1178.7819253438142, 1180.8760080191457, 1182.4856187558269, 1186.9643910682694, 1113.4989254835357, 1113.8941800528937, 1164.0, 1310.652677040585, 1403.6771542545068, 7843.176466470938, 7860.174681658344, 7945.841083178304, 7947.165547617533, 7968.880466793003, 1078.6009176604707, 1211.121936595961, 1217.6468824040928, 1218.4212499062874, 1237.041292997916, 5857.736401861926, 5983.730732117066, 6210.596311239755, 6464.288928217892, 6523.7064332105165, 9624.37441566296, 9769.316147869724, 9939.353941993748, 9956.701298961043, 10100.191984641211, 9940.403575785476, 10038.196944244442, 10045.995400460042, 10149.0, 10158.441285729208, 7812.296893279632, 7855.096663883613, 7911.643976021093, 7930.286274235346, 7967.163447838009, 7908.051033875971, 7934.603269836601, 7935.2064793520185, 7943.523388596703, 7978.401619878417, 8918.420302680304, 8928.955355223183, 9121.270298376247, 9185.173334399937, 9248.583813728534, 9390.107939745712, 9536.380135291183, 9562.043795620382, 9562.808743825224, 9579.473128977974, 7942.166072562298, 8052.476589021695, 8064.83870322602, 8069.919300806917, 8070.394720395876, 7904.802379940547, 8115.1479094694205, 8122.025356957203, 8152.877706834283, 8159.79600509992, 7557.0, 7571.432142589218, 7630.542167469969, 7710.1133369660965, 7717.151113377637, 7328.5969271690565, 7459.0, 7481.588512631857, 7539.811504712206, 7581.0, 7590.0, 7651.846963060596, 7666.1950495199435, 7698.499597526143, 7712.113106992543, 6946.6179360135675, 6999.860002800017, 7005.929940700732, 7006.579605223703, 7013.649317534205, 6081.179040829431, 7051.189113252041, 7103.502754807114, 7110.893336600058, 7113.110861142357], "unit": "ms", "name": "mootools.html", "value": 4827.019688460253}, {"lowerIsBetter": false, "replicates": [326.3538194375137, 335.8052329648804, 338.90171850163455, 344.67428280275135, 346.6914446142932, 5495.670259784416, 6702.932970670292, 6857.828554286145, 6865.862682746342, 6903.068085808414, 5436.673799572029, 6772.932270677292, 6818.181818181825, 6839.555428897118, 6844.38400543951, 4985.0, 5115.590752739772, 5117.360329958755, 5118.360204974379, 5141.922871156936, 4996.600271978251, 5056.570191533724, 5135.435102138762, 5142.228665700138, 5143.254228136918, 5045.899082018357, 5124.128898087334, 5127.077126117298, 5131.025105230013, 5155.278261043457, 5086.321513900404, 5088.23676448532, 5091.516305950929, 5096.770645320969, 5103.26002729604, 4329.285667864799, 4351.0862718829085, 4357.106793107437, 4361.738295702236, 4373.540778218273, 6379.936200637981, 6633.800985970429, 6635.668216589152, 6650.667466626649, 6694.196696396415, 6024.09638554216, 6030.849228769272, 6040.305364883006, 6041.305249896231, 6050.2134722486235, 5973.37279585646, 7051.224365319811, 7211.134663840373, 7393.223711510268, 7396.3343299103335, 3959.703022273341, 4435.733855968652, 4561.703489273186, 4719.315699223594, 4889.33993910821, 7815.8436831263625, 7840.764777056697, 7841.568713720743, 7846.803829904241, 7848.293653571206, 4829.1458535251595, 4898.167311557044, 4953.1332016896895, 4965.553100220997, 4967.0, 5061.139606266944, 5069.188929771292, 5074.16276314404, 5085.4914508548845, 5089.949100509021, 6014.909776353358, 6016.819495415145, 6024.789132380346, 6032.788852390146, 6039.667818270037, 7454.142773581108, 7466.0, 7469.701211951569, 7471.813204669927, 7481.551106933602, 1644.8355164483455, 1701.013412220909, 1704.1308932444542, 1705.249690136336, 1711.1786342555642, 1067.5462928255615, 1075.8224892892586, 1086.4187659602233, 1091.3560999010622, 1093.6500319897557, 6813.7955861324235, 6843.623600702009, 6847.589144651337, 6857.828554286183, 6879.965600172067, 7639.618019099023, 7645.847083058419, 7652.04349456318, 7652.1582625912215, 7659.540427574363, 6739.123913891162, 6844.1444819397575, 6865.176178858469, 6875.243723190445, 6927.168739751262, 4081.755094694328, 4100.0, 4112.712110152261, 4121.1345617420675, 4128.710990230715, 6661.667666466726, 7322.340989310987, 7419.962900185465, 7768.805779855549, 7787.922120778833, 7639.618019099134, 7827.25641064098, 7981.600919953979, 8017.0, 8031.759047228593, 6860.451163906875, 7165.247648996885, 7449.664765085692, 7742.187070357531, 7749.961250193713, 7476.962615186889, 7539.359154471931, 7580.241975802375, 7797.142314345304, 7811.609419528887, 7623.085229772463, 7632.732854350071, 7638.618069096412, 7644.579548124907, 7650.426218033781, 7563.394928405824, 7746.806329841799, 7778.533288002738, 7785.610719464117, 7801.1808760079375, 4784.593309568587, 4834.0, 4843.304843304956, 4844.079624871404, 4864.270359446112, 7727.806804829925, 7729.536227826348, 7730.226977302224, 7738.729144479917, 7752.612369381395, 7176.9904426760595, 7418.035655364768, 7432.92567074344, 7435.92564074374, 7445.553266804009, 7380.114386273682, 7380.409567234501, 7394.667239974106, 7411.518251313647, 7418.740344087931, 6960.582365058112, 7176.390006849476, 7189.928100718926, 7198.0282661842075, 7225.783226503213, 7371.262873712586, 7390.6674199660065, 7396.14944281393, 7407.62961851916, 7409.0, 7229.313215244543, 7230.313120253568, 7240.239774823568, 7244.022057022235, 7254.056972593529], "unit": "ms", "name": "prototype.html", "value": 5374.905829622862}, {"lowerIsBetter": false, "replicates": [719.1801346465031, 775.2673723331451, 799.4483806173736, 828.3000864269692, 845.4546817302844, 14924.77612835807, 15273.389064437437, 15276.236188190602, 15288.388464461423, 15300.999999999985, 14023.649408764786, 14099.154050756963, 14110.64723381916, 14111.082779619317, 14115.717685646281, 753.8040109571509, 767.1178145133085, 771.9189485104067, 777.0946846923327, 958.6836344006496, 960.4957397366404, 964.0022576633186, 975.4878688688424, 976.0922342221731, 979.0356498848629, 1016.69499150255, 1029.6653587584028, 1031.876174859018, 1033.410955755216, 1035.4460363705418, 808.6967387229789, 809.5062012172599, 817.3012074676185, 817.6606708216083, 1012.9139023183002, 751.143696186348, 766.8006318357211, 766.9041369828772, 766.9693212271558, 768.2356055724534, 14714.190719510423, 14878.776818347733, 14892.776608350883, 14899.478518251917, 14944.551663450115, 10514.474276286155, 12320.75358492825, 12728.490860365575, 12955.48178072876, 13174.0, 9968.900310996869, 10171.694849154463, 10172.186225101974, 10231.539580718885, 10937.2890762101, 3519.7712148710507, 3523.2777280657406, 3524.365614189445, 3528.1356067763304, 3529.400001999666, 80595.99999999942, 81711.0, 81713.59143204306, 82305.17694823035, 82541.0, 9647.083527064917, 9711.514424278757, 9764.9023509764, 9896.505174741234, 10273.640422585173, 22514.437139071655, 22609.0, 22963.966621502073, 23016.194433195094, 23017.19439819598, 7694.461387702919, 7756.68973241064, 7804.531728096219, 7889.487183333065, 8030.558319292495, 4066.6543343816106, 4119.8970025749595, 4124.793760312033, 4131.938020929689, 4141.4616099907425, 3102.705243001911, 3668.5414323209598, 3668.6881615062484, 3669.7798132112157, 3671.7246206534082, 634.4480302137171, 643.5012865029639, 647.737666245162, 670.2827974067798, 671.7951024937344, 483.5213138992372, 509.9965272609982, 519.7972790611665, 552.8009916430082, 632.3644737039338, 8273.738033180683, 8341.290990265896, 8437.240648341678, 8529.232369086812, 8599.39804213699, 537.3712756075402, 584.2930054633856, 601.8405122642504, 629.9685015749194, 644.44899610833, 3685.299793039314, 3929.7052721046034, 3991.4611527444004, 4084.101497670508, 4133.1940271647345, 97039.0, 97336.0, 99770.50114749525, 100055.99384067747, 100223.49888250513, 76045.6197719019, 77020.0, 77473.61263193648, 79020.0, 81041.0, 63986.40033999187, 65786.67106664531, 74112.62943685355, 74600.25399746042, 74710.87933680999, 8103.83792324162, 8116.188381161836, 8232.382571307297, 8318.45930014547, 8336.87494687568, 50297.49702502928, 50363.49636503735, 51002.0, 51113.233301499764, 52577.68555786136, 60599.40169702424, 70269.64865175642, 70936.0, 73588.63205683937, 73685.7894263173, 10997.12023038139, 11168.832467512831, 11201.43992800373, 11448.599299024494, 11730.296182229093, 11871.109666775199, 12565.18326308787, 12607.49570017189, 13040.891524220548, 13090.14914030585, 10888.945555272174, 11422.371769552754, 11507.539698412305, 11524.078073754246, 12221.022318214344, 11476.02453791437, 11687.18189726711, 11814.645560633195, 12060.457279422271, 12486.875131248571, 8177.836443270982, 8708.73873783762, 10384.065434110966, 11529.423528823358, 11719.296842189497, 9326.347155699035, 9436.386634868986, 9598.284105634813, 9650.517474126405, 9690.37012594179, 9449.385789923634, 9649.662261821084, 9754.219662427131, 9857.852132217879, 9908.554115064695], "unit": "ms", "name": "yui.html", "value": 6998.550026623135}], "name": "dromaeo_css", "value": 7708.7411363023775}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 110.0, 110.0, 110.0, 110.0, 110.0, 104.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [148.0, 120.0, 142.0, 152.0, 118.0, 142.0, 141.0, 181.0, 133.0, 136.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.3}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 183.0, 186.0, 182.0, 185.0, 186.0, 185.0, 184.0, 182.0], "unit": "ms", "name": "audio-dft", "value": 183.9}, {"lowerIsBetter": true, "replicates": [66.0, 63.0, 71.0, 72.0, 57.0, 57.0, 57.0, 71.0, 73.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 64.1}, {"lowerIsBetter": true, "replicates": [83.0, 87.0, 115.0, 73.0, 76.0, 74.0, 105.0, 75.0, 74.0, 106.0], "unit": "ms", "name": "audio-oscillator", "value": 86.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 87.0, 85.0, 85.0, 85.0, 85.0, 86.0, 88.0, 131.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 90.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 120.0, 147.0, 98.0, 93.0, 99.0, 99.0, 92.0, 92.0], "unit": "ms", "name": "imaging-darkroom", "value": 102.6}, {"lowerIsBetter": true, "replicates": [96.0, 133.0, 134.0, 85.0, 86.0, 85.0, 87.0, 86.0, 85.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [55.0, 52.0, 53.0, 55.0, 54.0, 53.0, 54.0, 63.0, 52.0, 51.0], "unit": "ms", "name": "json-parse-financial", "value": 54.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 64.0, 66.0, 68.0, 69.0, 66.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.2}, {"lowerIsBetter": true, "replicates": [78.0, 83.0, 78.0, 83.0, 83.0, 81.0, 94.0, 80.0, 82.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 130.0, 119.0, 125.0, 117.0, 123.0, 123.0, 117.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [135.0, 124.0, 135.0, 131.0, 135.0, 126.0, 135.0, 134.0, 137.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 132.5}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 67.0, 81.0, 92.0, 88.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.8}], "name": "kraken", "value": 1402.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.27540500736376], "unit": "score", "name": "Richards", "value": 239.70057999999992}, {"lowerIsBetter": false, "replicates": [161.86468112657818], "unit": "score", "name": "DeltaBlue", "value": 408.47700399999985}, {"lowerIsBetter": false, "replicates": [298.86431560071725], "unit": "score", "name": "Encrypt", "value": 890.6416259999997}, {"lowerIsBetter": false, "replicates": [4643.518518518518], "unit": "score", "name": "Decrypt", "value": 57.323126620139575}, {"lowerIsBetter": false, "replicates": [1892.249527410208], "unit": "score", "name": "RayTrace", "value": 391.0631178821179}, {"lowerIsBetter": false, "replicates": [793.1854199683042], "unit": "score", "name": "Earley", "value": 840.23606993007}, {"lowerIsBetter": false, "replicates": [12469.135802469136], "unit": "score", "name": "Boyer", "value": 53.449012871287174}, {"lowerIsBetter": false, "replicates": [27189.18918918919], "unit": "score", "name": "RegExp", "value": 33.505412524850904}, {"lowerIsBetter": false, "replicates": [1304.6875], "unit": "score", "name": "Splay", "value": 62.46016766467066}, {"lowerIsBetter": false, "replicates": [4522.522522522522], "unit": "score", "name": "NavierStokes", "value": 328.13545816733085}], "name": "v8_7", "value": 19050.33953317741}]} 04:53:02 INFO - RETURN: dromaeo_css: 7708.74 04:53:02 INFO - RETURN: kraken: 1402.70 04:53:02 INFO - RETURN: v8_7: 19050.34 04:53:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,59]]", "result": "19050.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1402.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7708.74"}}} 04:53:02 INFO - Return code: 0 04:53:02 INFO - # TBPL SUCCESS # 04:53:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:02 INFO - 2015-11-23 04:53:02.594 screenresolution[2270:18600] starting screenresolution argv=screenresolution get 04:53:02 INFO - 2015-11-23 04:53:02.596 screenresolution[2270:18600] Display 0: 1600x1200x32@60 04:53:02 INFO - 2015-11-23 04:53:02.602 screenresolution[2271:18603] starting screenresolution argv=screenresolution list 04:53:02 INFO - Available Modes on Display 0 04:53:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:02 INFO - Intel Iris: 04:53:02 INFO - Chipset Model: Intel Iris 04:53:02 INFO - Type: GPU 04:53:02 INFO - Bus: Built-In 04:53:02 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:02 INFO - Vendor: Intel (0x8086) 04:53:02 INFO - Device ID: 0x0a2e 04:53:02 INFO - Revision ID: 0x0009 04:53:02 INFO - Displays: 04:53:02 INFO - Display: 04:53:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:02 INFO - Display Serial Number: 1600x1200 60 04:53:02 INFO - Main Display: Yes 04:53:02 INFO - Mirror: Off 04:53:02 INFO - Online: Yes 04:53:02 INFO - Rotation: Supported 04:53:02 INFO - Return code: 0 04:53:02 INFO - Running post-action listener: _resource_record_post_action 04:53:02 INFO - Running post-run listener: _resource_record_post_run 04:53:03 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 2355200; Write bytes: 689466368; Read time: 36; Write time: 2084 04:53:03 INFO - install - Wall time: 30s; CPU: 54.0%; Read bytes: 340181504; Write bytes: 336020992; Read time: 26263; Write time: 601 04:53:03 INFO - run-tests - Wall time: 1210s; CPU: 53.0%; Read bytes: 2355200; Write bytes: 341972480; Read time: 36; Write time: 1446 04:53:03 INFO - Running post-run listener: _upload_blobber_files 04:53:03 INFO - Blob upload gear active. 04:53:03 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:53:03 INFO - Copying logs to upload dir... 04:53:03 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1286.084589 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-23 04:53:03.969039) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-23 04:53:03.974110) ========= 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.1IbOvbBlak/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.ZZLddhgKMH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009613 build_url: 'https://queue.taskcluster.net/v1/task/TVrGEJlXS-2Vg68DsMgIRA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 1.27 ========= ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-23 04:53:05.255513) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:53:05.258925) ========= 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.1IbOvbBlak/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.ZZLddhgKMH/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005302 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 04:53:05.281285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 04:53:05.281596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 04:53:05.281933) ========= ========= Total master_lag: 1.51 =========