builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0106 starttime: 1447114764.21 results: success (0) buildid: 20151109153630 builduid: b48da0ed8b4844bd9ab3aefb96b95e06 revision: 68a879c220d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.206712) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.207535) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.207894) ========= 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.4czGG0MSmO/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.ddqF1uQ4pC/Listeners TMPDIR=/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006515 basedir: '/builds/slave/test' ========= master_lag: 0.31 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.519620) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.519971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.550115) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.550447) ========= 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.4czGG0MSmO/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.ddqF1uQ4pC/Listeners TMPDIR=/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.027844 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.599068) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.599413) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.599811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.600120) ========= 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.4czGG0MSmO/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.ddqF1uQ4pC/Listeners TMPDIR=/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-09 16:19:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102, 63.245.215.102, ... Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.83M=0.001s 2015-11-09 16:19:24 (9.83 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.213957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.830371) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.830734) ========= 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.4czGG0MSmO/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.ddqF1uQ4pC/Listeners TMPDIR=/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.080700 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.926791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:24.927176) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 68a879c220d8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 68a879c220d8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4czGG0MSmO/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.ddqF1uQ4pC/Listeners TMPDIR=/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-09 16:19:25,012 Setting DEBUG logging. 2015-11-09 16:19:25,012 attempt 1/10 2015-11-09 16:19:25,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/68a879c220d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-09 16:19:25,317 unpacking tar archive at: fx-team-68a879c220d8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.586731 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:25.531166) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:25.531550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:25.545741) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:25.546140) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-09 16:19:25.546667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2015-11-09 16:19:25.546999) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4czGG0MSmO/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.ddqF1uQ4pC/Listeners TMPDIR=/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 16:19:25 INFO - MultiFileLogger online at 20151109 16:19:25 in /builds/slave/test 16:19:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:19:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:19:25 INFO - {'append_to_log': False, 16:19:25 INFO - 'base_work_dir': '/builds/slave/test', 16:19:25 INFO - 'blob_upload_branch': 'Fx-Team', 16:19:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:19:25 INFO - 'branch': 'Fx-Team', 16:19:25 INFO - 'buildbot_json_path': 'buildprops.json', 16:19:25 INFO - 'config_files': ('talos/mac_config.py',), 16:19:25 INFO - 'default_actions': ('clobber', 16:19:25 INFO - 'read-buildbot-config', 16:19:25 INFO - 'download-and-extract', 16:19:25 INFO - 'populate-webroot', 16:19:25 INFO - 'create-virtualenv', 16:19:25 INFO - 'install', 16:19:25 INFO - 'run-tests'), 16:19:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:19:25 INFO - 'download_minidump_stackwalk': True, 16:19:25 INFO - 'download_symbols': 'ondemand', 16:19:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:19:25 INFO - 'tooltool.py': '/tools/tooltool.py', 16:19:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:19:25 INFO - '/tools/misc-python/virtualenv.py')}, 16:19:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:19:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:19:25 INFO - 'installer_path': 'installer.exe', 16:19:25 INFO - 'log_level': 'info', 16:19:25 INFO - 'log_name': 'talos', 16:19:25 INFO - 'log_to_console': True, 16:19:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:19:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:19:25 INFO - 'opt_config_files': (), 16:19:25 INFO - 'pip_index': False, 16:19:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:19:25 INFO - 'cmd': ('bash', 16:19:25 INFO - '-c', 16:19:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:19:25 INFO - 'enabled': True, 16:19:25 INFO - 'halt_on_failure': False, 16:19:25 INFO - 'name': 'check_screen_resolution'},), 16:19:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:19:25 INFO - 'cmd': ('bash', 16:19:25 INFO - '-c', 16:19:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:19:25 INFO - 'enabled': True, 16:19:25 INFO - 'halt_on_failure': False, 16:19:25 INFO - 'name': 'check_screen_resolution'},), 16:19:25 INFO - 'run_cmd_checks_enabled': True, 16:19:25 INFO - 'sps_profile': False, 16:19:25 INFO - 'sps_profile_interval': 0, 16:19:25 INFO - 'suite': 'dromaeojs', 16:19:25 INFO - 'system_bits': '64', 16:19:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:19:25 INFO - 'title': 't-yosemite-r5-0106', 16:19:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:19:25 INFO - 'use_talos_json': True, 16:19:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:19:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:19:25 INFO - 'work_dir': 'build'} 16:19:25 INFO - ##### 16:19:25 INFO - ##### Running clobber step. 16:19:25 INFO - ##### 16:19:25 INFO - Running pre-action listener: _resource_record_pre_action 16:19:25 INFO - Running main action method: clobber 16:19:25 INFO - rmtree: /builds/slave/test/build 16:19:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:19:30 INFO - Running post-action listener: _resource_record_post_action 16:19:30 INFO - ##### 16:19:30 INFO - ##### Running read-buildbot-config step. 16:19:30 INFO - ##### 16:19:30 INFO - Running pre-action listener: _resource_record_pre_action 16:19:30 INFO - Running main action method: read_buildbot_config 16:19:30 INFO - Using buildbot properties: 16:19:30 INFO - { 16:19:30 INFO - "properties": { 16:19:30 INFO - "buildnumber": 1320, 16:19:30 INFO - "product": "firefox", 16:19:30 INFO - "script_repo_revision": "production", 16:19:30 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 16:19:30 INFO - "repository": "", 16:19:30 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 16:19:30 INFO - "buildid": "20151109153630", 16:19:30 INFO - "slavename": "t-yosemite-r5-0106", 16:19:30 INFO - "pgo_build": "False", 16:19:30 INFO - "basedir": "/builds/slave/test", 16:19:30 INFO - "project": "", 16:19:30 INFO - "platform": "yosemite", 16:19:30 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:19:30 INFO - "slavebuilddir": "test", 16:19:30 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:19:30 INFO - "branch": "fx-team", 16:19:30 INFO - "repo_path": "integration/fx-team", 16:19:30 INFO - "stage_platform": "macosx64", 16:19:30 INFO - "builduid": "b48da0ed8b4844bd9ab3aefb96b95e06", 16:19:30 INFO - "revision": "68a879c220d8" 16:19:30 INFO - }, 16:19:30 INFO - "sourcestamp": { 16:19:30 INFO - "repository": "", 16:19:30 INFO - "hasPatch": false, 16:19:30 INFO - "project": "", 16:19:30 INFO - "branch": "fx-team-macosx64-talos", 16:19:30 INFO - "changes": [ 16:19:30 INFO - { 16:19:30 INFO - "category": null, 16:19:30 INFO - "files": [ 16:19:30 INFO - { 16:19:30 INFO - "url": null, 16:19:30 INFO - "name": "https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:19:30 INFO - } 16:19:30 INFO - ], 16:19:30 INFO - "repository": "", 16:19:30 INFO - "rev": "68a879c220d8", 16:19:30 INFO - "who": "mozci-bot@mozilla.com", 16:19:30 INFO - "when": 1447114737, 16:19:30 INFO - "number": 6639668, 16:19:30 INFO - "comments": "", 16:19:30 INFO - "project": "", 16:19:30 INFO - "at": "Mon 09 Nov 2015 16:18:57", 16:19:30 INFO - "branch": "fx-team-macosx64-talos", 16:19:30 INFO - "revlink": "", 16:19:30 INFO - "properties": [ 16:19:30 INFO - [ 16:19:30 INFO - "buildid", 16:19:30 INFO - "20151109153630", 16:19:30 INFO - "Change" 16:19:30 INFO - ], 16:19:30 INFO - [ 16:19:30 INFO - "builduid", 16:19:30 INFO - "b48da0ed8b4844bd9ab3aefb96b95e06", 16:19:30 INFO - "Change" 16:19:30 INFO - ], 16:19:30 INFO - [ 16:19:30 INFO - "pgo_build", 16:19:30 INFO - "False", 16:19:30 INFO - "Change" 16:19:30 INFO - ] 16:19:30 INFO - ], 16:19:30 INFO - "revision": "68a879c220d8" 16:19:30 INFO - } 16:19:30 INFO - ], 16:19:30 INFO - "revision": "68a879c220d8" 16:19:30 INFO - } 16:19:30 INFO - } 16:19:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:19:30 INFO - Running post-action listener: _resource_record_post_action 16:19:30 INFO - ##### 16:19:30 INFO - ##### Running download-and-extract step. 16:19:30 INFO - ##### 16:19:30 INFO - Running pre-action listener: _resource_record_pre_action 16:19:30 INFO - Running main action method: download_and_extract 16:19:30 INFO - mkdir: /builds/slave/test/build/tests 16:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:30 INFO - https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:19:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/test_packages.json 16:19:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/test_packages.json 16:19:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:19:35 INFO - Downloaded 1149 bytes. 16:19:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:19:35 INFO - Using the following test package requirements: 16:19:35 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:19:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:19:35 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:19:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:19:35 INFO - u'jsshell-mac.zip'], 16:19:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:19:35 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:19:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:19:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:19:35 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:19:35 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:19:35 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:19:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:19:35 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:19:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:19:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:19:35 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:19:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:35 INFO - https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:19:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:19:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:19:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/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 16:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/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 16:19:45 INFO - Downloaded 17436481 bytes. 16:19:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:19:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:19:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:19:50 INFO - Return code: 0 16:19:50 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 16:19:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:19:50 INFO - https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:19:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:19:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:19:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/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 16:19:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/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 16:19:51 INFO - Downloaded 17436481 bytes. 16:19:51 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 16:19:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:19:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:19:57 INFO - Return code: 0 16:19:57 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')]} 16:19:57 INFO - https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:19:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:19:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:19:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/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 16:19:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/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 16:19:58 INFO - Downloaded 11131618 bytes. 16:19:58 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 16:19:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:19:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:19:58 INFO - Return code: 0 16:19:58 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')]} 16:19:58 INFO - https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:19:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:19:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:19:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:19:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/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 16:20:18 INFO - Downloaded 108647828 bytes. 16:20:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:20:18 INFO - mkdir: /builds/slave/test/properties 16:20:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:20:18 INFO - Writing to file /builds/slave/test/properties/build_url 16:20:18 INFO - Contents: 16:20:18 INFO - build_url:https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:20:18 INFO - Running post-action listener: _resource_record_post_action 16:20:18 INFO - Running post-action listener: set_extra_try_arguments 16:20:18 INFO - ##### 16:20:18 INFO - ##### Running populate-webroot step. 16:20:18 INFO - ##### 16:20:18 INFO - Running pre-action listener: _resource_record_pre_action 16:20:18 INFO - Running main action method: populate_webroot 16:20:18 INFO - Guessing talos json url... 16:20:18 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')]} 16:20:18 INFO - https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 16:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 16:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 16:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 16:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 16:20:19 INFO - Downloaded 103 bytes. 16:20:19 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 16:20:19 INFO - Contents: 16:20:19 INFO - 20151109153630 16:20:19 INFO - https://hg.mozilla.org/integration/fx-team/rev/68a879c220d8c777e165ab9df5c1a6a4a3c703f2 16:20:19 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')]} 16:20:19 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/68a879c220/testing/talos/talos.json 16:20:19 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/68a879c220/testing/talos/talos.json to /builds/slave/test/build/talos.json 16:20:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/68a879c220/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 16:20:19 INFO - Downloaded 4206 bytes. 16:20:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:20:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:20:19 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:20:19 INFO - '../fennec_ids.txt'], 16:20:19 INFO - 'tests': ['tcheck2']}, 16:20:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:20:19 INFO - '--tppagecycles', 16:20:19 INFO - '7'], 16:20:19 INFO - 'tests': ['tsvgm']}}, 16:20:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:20:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:20:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:20:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:20:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:20:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:20:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:20:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:19 INFO - 'talos_options': ['--e10s'], 16:20:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:20:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:19 INFO - 'tests': ['damp', 'tps']}, 16:20:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:19 INFO - 'talos_options': ['--e10s'], 16:20:19 INFO - 'tests': ['damp', 'tps']}, 16:20:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:20:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:20:19 INFO - 'other': {'tests': ['a11yr', 16:20:19 INFO - 'ts_paint', 16:20:19 INFO - 'tpaint', 16:20:19 INFO - 'sessionrestore', 16:20:19 INFO - 'sessionrestore_no_auto_restore']}, 16:20:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:20:19 INFO - 'tests': ['a11yr', 16:20:19 INFO - 'ts_paint', 16:20:19 INFO - 'tpaint', 16:20:19 INFO - 'sessionrestore', 16:20:19 INFO - 'sessionrestore_no_auto_restore']}, 16:20:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:20:19 INFO - 'tests': ['a11yr', 16:20:19 INFO - 'ts_paint', 16:20:19 INFO - 'tpaint', 16:20:19 INFO - 'sessionrestore', 16:20:19 INFO - 'sessionrestore_no_auto_restore']}, 16:20:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:20:19 INFO - 'tests': ['a11yr', 16:20:19 INFO - 'ts_paint', 16:20:19 INFO - 'tpaint', 16:20:19 INFO - 'sessionrestore', 16:20:19 INFO - 'sessionrestore_no_auto_restore']}, 16:20:19 INFO - 'other_l64': {'tests': ['a11yr', 16:20:19 INFO - 'ts_paint', 16:20:19 INFO - 'tpaint', 16:20:19 INFO - 'sessionrestore', 16:20:19 INFO - 'sessionrestore_no_auto_restore']}, 16:20:19 INFO - 'other_nol64': {'tests': ['a11yr', 16:20:19 INFO - 'ts_paint', 16:20:19 INFO - 'tpaint', 16:20:19 INFO - 'sessionrestore', 16:20:19 INFO - 'sessionrestore_no_auto_restore']}, 16:20:19 INFO - 'svgr': {'tests': ['tsvgx', 16:20:19 INFO - 'tsvgr_opacity', 16:20:19 INFO - 'tart', 16:20:19 INFO - 'tscrollx', 16:20:19 INFO - 'cart']}, 16:20:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:20:19 INFO - 'tests': ['tsvgx', 16:20:19 INFO - 'tsvgr_opacity', 16:20:19 INFO - 'tart', 16:20:19 INFO - 'tscrollx', 16:20:19 INFO - 'cart']}, 16:20:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:19 INFO - 'tests': ['tp5o']}, 16:20:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:19 INFO - 'talos_options': ['--e10s'], 16:20:19 INFO - 'tests': ['tp5o']}, 16:20:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:19 INFO - 'talos_options': ['--xperf_path', 16:20:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:20:19 INFO - 'tests': ['tp5n']}, 16:20:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:19 INFO - 'talos_options': ['--e10s', 16:20:19 INFO - '--xperf_path', 16:20:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:20:19 INFO - 'tests': ['tp5n']}}, 16:20:19 INFO - 'talos.zip': {'path': '', 16:20:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:20:19 INFO - Running post-action listener: _resource_record_post_action 16:20:19 INFO - ##### 16:20:19 INFO - ##### Running create-virtualenv step. 16:20:19 INFO - ##### 16:20:19 INFO - Running pre-action listener: _resource_record_pre_action 16:20:19 INFO - Running main action method: create_virtualenv 16:20:19 INFO - Creating virtualenv /builds/slave/test/build/venv 16:20:19 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 16:20:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:20:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:20:19 INFO - Using real prefix '/tools/python27' 16:20:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:20:20 INFO - Installing distribute.............................................................................................................................................................................................done. 16:20:24 INFO - Installing pip.................done. 16:20:24 INFO - Return code: 0 16:20:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:20:24 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')]} 16:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:24 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')]} 16:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:24 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 0x101c89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8614bdd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3e9f0>, '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 0x10199dcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c08990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/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.ddqF1uQ4pC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:20:24 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 16:20:24 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 16:20:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/Render', 16:20:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:24 INFO - 'HOME': '/Users/cltbld', 16:20:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:24 INFO - 'LOGNAME': 'cltbld', 16:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:24 INFO - 'MOZ_NO_REMOTE': '1', 16:20:24 INFO - 'NO_EM_RESTART': '1', 16:20:24 INFO - 'PAGER': '/bin/cat', 16:20:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:24 INFO - 'PWD': '/builds/slave/test', 16:20:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:24 INFO - 'SHELL': '/bin/bash', 16:20:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddqF1uQ4pC/Listeners', 16:20:24 INFO - 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', 16:20:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:24 INFO - 'USER': 'cltbld', 16:20:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:24 INFO - 'XPC_FLAGS': '0x0', 16:20:24 INFO - 'XPC_SERVICE_NAME': '0', 16:20:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:25 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 16:20:25 INFO - Cleaning up... 16:20:25 INFO - Return code: 0 16:20:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:20:25 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')]} 16:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:25 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')]} 16:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:25 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 0x101c89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8614bdd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3e9f0>, '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 0x10199dcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c08990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/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.ddqF1uQ4pC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:20:25 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 16:20:25 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 16:20:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/Render', 16:20:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:25 INFO - 'HOME': '/Users/cltbld', 16:20:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:25 INFO - 'LOGNAME': 'cltbld', 16:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:25 INFO - 'MOZ_NO_REMOTE': '1', 16:20:25 INFO - 'NO_EM_RESTART': '1', 16:20:25 INFO - 'PAGER': '/bin/cat', 16:20:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:25 INFO - 'PWD': '/builds/slave/test', 16:20:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:25 INFO - 'SHELL': '/bin/bash', 16:20:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddqF1uQ4pC/Listeners', 16:20:25 INFO - 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', 16:20:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:25 INFO - 'USER': 'cltbld', 16:20:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:25 INFO - 'XPC_FLAGS': '0x0', 16:20:25 INFO - 'XPC_SERVICE_NAME': '0', 16:20:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:25 INFO - Downloading/unpacking psutil>=0.7.1 16:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:28 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:20:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:20:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:20:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:20:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:20:28 INFO - Installing collected packages: psutil 16:20:28 INFO - Running setup.py install for psutil 16:20:28 INFO - building 'psutil._psutil_osx' extension 16:20:28 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 16:20:30 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 16:20:30 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 16:20:30 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 16:20:30 INFO - building 'psutil._psutil_posix' extension 16:20:30 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 16:20:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:20:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:20:30 INFO - ^ 16:20:30 INFO - 1 warning generated. 16:20:30 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 16:20:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:20:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:20:31 INFO - Successfully installed psutil 16:20:31 INFO - Cleaning up... 16:20:31 INFO - Return code: 0 16:20:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101c89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8614bdd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3e9f0>, '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 0x10199dcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c08990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/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.ddqF1uQ4pC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:20:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/Render', 16:20:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:31 INFO - 'HOME': '/Users/cltbld', 16:20:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:31 INFO - 'LOGNAME': 'cltbld', 16:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:31 INFO - 'MOZ_NO_REMOTE': '1', 16:20:31 INFO - 'NO_EM_RESTART': '1', 16:20:31 INFO - 'PAGER': '/bin/cat', 16:20:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:31 INFO - 'PWD': '/builds/slave/test', 16:20:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:31 INFO - 'SHELL': '/bin/bash', 16:20:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddqF1uQ4pC/Listeners', 16:20:31 INFO - 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', 16:20:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:31 INFO - 'USER': 'cltbld', 16:20:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:31 INFO - 'XPC_FLAGS': '0x0', 16:20:31 INFO - 'XPC_SERVICE_NAME': '0', 16:20:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:20:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:20:34 INFO - Installing collected packages: mozsystemmonitor 16:20:34 INFO - Running setup.py install for mozsystemmonitor 16:20:34 INFO - Successfully installed mozsystemmonitor 16:20:34 INFO - Cleaning up... 16:20:34 INFO - Return code: 0 16:20:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:34 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 0x101c89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8614bdd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3e9f0>, '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 0x10199dcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c08990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/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.ddqF1uQ4pC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:20:34 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 16:20:34 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 16:20:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/Render', 16:20:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:34 INFO - 'HOME': '/Users/cltbld', 16:20:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:34 INFO - 'LOGNAME': 'cltbld', 16:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:34 INFO - 'MOZ_NO_REMOTE': '1', 16:20:34 INFO - 'NO_EM_RESTART': '1', 16:20:34 INFO - 'PAGER': '/bin/cat', 16:20:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:34 INFO - 'PWD': '/builds/slave/test', 16:20:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:34 INFO - 'SHELL': '/bin/bash', 16:20:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddqF1uQ4pC/Listeners', 16:20:34 INFO - 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', 16:20:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:34 INFO - 'USER': 'cltbld', 16:20:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:34 INFO - 'XPC_FLAGS': '0x0', 16:20:34 INFO - 'XPC_SERVICE_NAME': '0', 16:20:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:34 INFO - Downloading/unpacking blobuploader==1.2.4 16:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:37 INFO - Downloading blobuploader-1.2.4.tar.gz 16:20:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:20:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:20:37 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 16:20:37 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 16:20:37 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 16:20:37 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 16:20:37 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 16:20:37 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 16:20:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:20:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:20:38 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 16:20:38 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 16:20:38 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 16:20:38 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 16:20:38 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 16:20:38 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 16:20:38 INFO - Downloading docopt-0.6.1.tar.gz 16:20:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:20:38 INFO - Installing collected packages: blobuploader, requests, docopt 16:20:38 INFO - Running setup.py install for blobuploader 16:20:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:20:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:20:38 INFO - Running setup.py install for requests 16:20:39 INFO - Running setup.py install for docopt 16:20:39 INFO - Successfully installed blobuploader requests docopt 16:20:39 INFO - Cleaning up... 16:20:39 INFO - Return code: 0 16:20:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20: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')]} 16:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20: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')]} 16:20:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:39 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 0x101c89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8614bdd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3e9f0>, '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 0x10199dcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c08990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/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.ddqF1uQ4pC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:20:39 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 16:20:39 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 16:20:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/Render', 16:20:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:39 INFO - 'HOME': '/Users/cltbld', 16:20:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:39 INFO - 'LOGNAME': 'cltbld', 16:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:39 INFO - 'MOZ_NO_REMOTE': '1', 16:20:39 INFO - 'NO_EM_RESTART': '1', 16:20:39 INFO - 'PAGER': '/bin/cat', 16:20:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:39 INFO - 'PWD': '/builds/slave/test', 16:20:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:39 INFO - 'SHELL': '/bin/bash', 16:20:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddqF1uQ4pC/Listeners', 16:20:39 INFO - 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', 16:20:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:39 INFO - 'USER': 'cltbld', 16:20:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:39 INFO - 'XPC_FLAGS': '0x0', 16:20:39 INFO - 'XPC_SERVICE_NAME': '0', 16:20:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:20:40 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-EnXVAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:20:40 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-fymHJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:20:40 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-EDU37c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:20:40 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-2Xj2Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:20:40 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-F80Cft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:20:40 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-6T3El4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:20:40 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-URWBte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:20:41 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-CUOXPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:20:41 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-vbKwMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:20:41 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-19Y2WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:20:41 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-t6fxRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:20:41 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-3f5HUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:20:41 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-Zml7wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:20:41 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-VkOLLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:41 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-ixqrPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:20:42 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-UW4a8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:20:42 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-qrunH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:20:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:20:42 INFO - Running setup.py install for manifestparser 16:20:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:20:42 INFO - Running setup.py install for mozcrash 16:20:42 INFO - Running setup.py install for mozdebug 16:20:42 INFO - Running setup.py install for mozdevice 16:20:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Running setup.py install for mozfile 16:20:43 INFO - Running setup.py install for mozhttpd 16:20:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Running setup.py install for mozinfo 16:20:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Running setup.py install for mozInstall 16:20:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:20:43 INFO - Running setup.py install for mozleak 16:20:43 INFO - Running setup.py install for mozlog 16:20:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Running setup.py install for moznetwork 16:20:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Running setup.py install for mozprocess 16:20:44 INFO - Running setup.py install for mozprofile 16:20:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Running setup.py install for mozrunner 16:20:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:20:44 INFO - Running setup.py install for mozscreenshot 16:20:45 INFO - Running setup.py install for moztest 16:20:45 INFO - Running setup.py install for mozversion 16:20:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:20:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:20:45 INFO - Cleaning up... 16:20:45 INFO - Return code: 0 16:20:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:45 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')]} 16:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:45 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')]} 16:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:45 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 0x101c89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8614bdd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3e9f0>, '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 0x10199dcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c08990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/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.ddqF1uQ4pC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:20:45 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 16:20:45 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 16:20:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/Render', 16:20:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:45 INFO - 'HOME': '/Users/cltbld', 16:20:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:45 INFO - 'LOGNAME': 'cltbld', 16:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:45 INFO - 'MOZ_NO_REMOTE': '1', 16:20:45 INFO - 'NO_EM_RESTART': '1', 16:20:45 INFO - 'PAGER': '/bin/cat', 16:20:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:45 INFO - 'PWD': '/builds/slave/test', 16:20:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:45 INFO - 'SHELL': '/bin/bash', 16:20:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddqF1uQ4pC/Listeners', 16:20:45 INFO - 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', 16:20:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:45 INFO - 'USER': 'cltbld', 16:20:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:45 INFO - 'XPC_FLAGS': '0x0', 16:20:45 INFO - 'XPC_SERVICE_NAME': '0', 16:20:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:20:45 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-_UjVhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:20:46 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)) 16:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:20:46 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-jfv5JT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:20:46 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)) 16:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:20:46 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-AFo4jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:20:46 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)) 16:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:20:46 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-gnzFkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:20:46 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)) 16:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:20:46 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-4RGou5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:20:46 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)) 16:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:20:46 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-b2Roqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:20:46 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)) 16:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:20:46 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-CAPlgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:20:46 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)) 16:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:20:46 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-Z7uRmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:20:46 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)) 16:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:20:46 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-TQc07p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:20:47 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)) 16:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:20:47 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-0bAC8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:20:47 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)) 16:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:20:47 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-gNy9zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:20:47 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)) 16:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:20:47 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-M2RQfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:20:47 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)) 16:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:20:47 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-Lekfv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:20:47 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)) 16:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:20:47 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-mwUiPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:20:47 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)) 16:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:47 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-CF74Xt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:47 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)) 16:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:20:47 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-IkscX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:20:48 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)) 16:20:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:20:48 INFO - Running setup.py (path:/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/pip-5gzHNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:20:48 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)) 16:20:48 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)) 16:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:20:48 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)) 16:20:48 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)) 16:20:48 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)) 16:20:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:20:48 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 16:20:48 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 16:20:48 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 16:20:48 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 16:20:48 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 16:20:48 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 16:20:50 INFO - Downloading blessings-1.5.1.tar.gz 16:20:50 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 16:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:20:50 INFO - Installing collected packages: blessings 16:20:50 INFO - Running setup.py install for blessings 16:20:51 INFO - Successfully installed blessings 16:20:51 INFO - Cleaning up... 16:20:51 INFO - Return code: 0 16:20:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:20:51 INFO - Reading from file tmpfile_stdout 16:20:51 INFO - Current package versions: 16:20:51 INFO - blessings == 1.5.1 16:20:51 INFO - blobuploader == 1.2.4 16:20:51 INFO - docopt == 0.6.1 16:20:51 INFO - manifestparser == 1.1 16:20:51 INFO - mozInstall == 1.12 16:20:51 INFO - mozcrash == 0.16 16:20:51 INFO - mozdebug == 0.1 16:20:51 INFO - mozdevice == 0.47 16:20:51 INFO - mozfile == 1.2 16:20:51 INFO - mozhttpd == 0.7 16:20:51 INFO - mozinfo == 0.9 16:20:51 INFO - mozleak == 0.1 16:20:51 INFO - mozlog == 3.0 16:20:51 INFO - moznetwork == 0.27 16:20:51 INFO - mozprocess == 0.22 16:20:51 INFO - mozprofile == 0.27 16:20:51 INFO - mozrunner == 6.11 16:20:51 INFO - mozscreenshot == 0.1 16:20:51 INFO - mozsystemmonitor == 0.0 16:20:51 INFO - moztest == 0.7 16:20:51 INFO - mozversion == 1.4 16:20:51 INFO - psutil == 3.1.1 16:20:51 INFO - requests == 1.2.3 16:20:51 INFO - wsgiref == 0.1.2 16:20:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:51 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 0x101c89a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cf6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8614bdd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101c3e9f0>, '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 0x10199dcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c08990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/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.ddqF1uQ4pC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:20:51 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 16:20:51 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 16:20:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/Render', 16:20:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:20:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:20:51 INFO - 'HOME': '/Users/cltbld', 16:20:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:20:51 INFO - 'LOGNAME': 'cltbld', 16:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:51 INFO - 'MOZ_NO_REMOTE': '1', 16:20:51 INFO - 'NO_EM_RESTART': '1', 16:20:51 INFO - 'PAGER': '/bin/cat', 16:20:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:51 INFO - 'PWD': '/builds/slave/test', 16:20:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:20:51 INFO - 'SHELL': '/bin/bash', 16:20:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddqF1uQ4pC/Listeners', 16:20:51 INFO - 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', 16:20:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:20:51 INFO - 'USER': 'cltbld', 16:20:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:20:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:51 INFO - 'XPC_FLAGS': '0x0', 16:20:51 INFO - 'XPC_SERVICE_NAME': '0', 16:20:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:51 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)) 16:20:51 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)) 16:20:51 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)) 16:20:51 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)) 16:20:51 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)) 16:20:51 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)) 16:20:51 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)) 16:20:51 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)) 16:20:51 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)) 16:20:51 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)) 16:20:51 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)) 16:20:51 INFO - Cleaning up... 16:20:51 INFO - Return code: 0 16:20:51 INFO - Running post-action listener: _resource_record_post_action 16:20:51 INFO - Running post-action listener: _start_resource_monitoring 16:20:51 INFO - Starting resource monitoring. 16:20:51 INFO - ##### 16:20:51 INFO - ##### Running install step. 16:20:51 INFO - ##### 16:20:51 INFO - Running pre-action listener: _resource_record_pre_action 16:20:51 INFO - Running main action method: install 16:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:20:52 INFO - Reading from file tmpfile_stdout 16:20:52 INFO - Detecting whether we're running mozinstall >=1.0... 16:20:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:20:52 INFO - Reading from file tmpfile_stdout 16:20:52 INFO - Output received: 16:20:52 INFO - Usage: mozinstall [options] installer 16:20:52 INFO - Options: 16:20:52 INFO - -h, --help show this help message and exit 16:20:52 INFO - -d DEST, --destination=DEST 16:20:52 INFO - Directory to install application into. [default: 16:20:52 INFO - "/builds/slave/test"] 16:20:52 INFO - --app=APP Application being installed. [default: firefox] 16:20:52 INFO - mkdir: /builds/slave/test/build/application 16:20:52 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'] 16:20:52 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 16:21:32 INFO - Reading from file tmpfile_stdout 16:21:32 INFO - Output received: 16:21:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:21:32 INFO - Running post-action listener: _resource_record_post_action 16:21:32 INFO - ##### 16:21:32 INFO - ##### Running run-tests step. 16:21:32 INFO - ##### 16:21:32 INFO - Running pre-action listener: _resource_record_pre_action 16:21:32 INFO - Running main action method: run_tests 16:21:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:21:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:21:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:21:32 INFO - 2015-11-09 16:21:32.564 screenresolution[1627:7738] starting screenresolution argv=screenresolution get 16:21:32 INFO - 2015-11-09 16:21:32.567 screenresolution[1627:7738] Display 0: 1600x1200x32@60 16:21:32 INFO - 2015-11-09 16:21:32.574 screenresolution[1628:7740] starting screenresolution argv=screenresolution list 16:21:32 INFO - Available Modes on Display 0 16:21:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:21:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:21:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:21:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:21:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:21:32 INFO - Intel HD Graphics 3000: 16:21:32 INFO - Chipset Model: Intel HD Graphics 3000 16:21:32 INFO - Type: GPU 16:21:32 INFO - Bus: Built-In 16:21:32 INFO - VRAM (Total): 512 MB 16:21:32 INFO - VRAM (Dynamic, Max): 10 16:21:32 INFO - Vendor: Intel (0x8086) 16:21:32 INFO - Device ID: 0x0116 16:21:32 INFO - Revision ID: 0x0009 16:21:32 INFO - Displays: 16:21:32 INFO - Display: 16:21:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:21:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:21:32 INFO - Display Serial Number: 1600x1200 60 16:21:32 INFO - Main Display: Yes 16:21:32 INFO - Mirror: Off 16:21:32 INFO - Online: Yes 16:21:32 INFO - Rotation: Supported 16:21:32 INFO - Return code: 0 16:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:21:32 INFO - Python 2.7.3 16:21:32 INFO - Return code: 0 16:21:32 INFO - grabbing minidump binary from tooltool 16:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:32 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 0x101c3e9f0>, '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 0x10199dcd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c08990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:21:32 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 16:21:32 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 16:21:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:21:32 INFO - Return code: 0 16:21:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:21:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:21:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:21:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:21:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0106', '--webServer', 'localhost'] in /builds/slave/test/build 16:21:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0106 --webServer localhost 16:21:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4czGG0MSmO/Render', 16:21:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:21:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:21:32 INFO - 'HOME': '/Users/cltbld', 16:21:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:21:32 INFO - 'LOGNAME': 'cltbld', 16:21:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:21:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:32 INFO - 'MOZ_NO_REMOTE': '1', 16:21:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:21:32 INFO - 'NO_EM_RESTART': '1', 16:21:32 INFO - 'PAGER': '/bin/cat', 16:21:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:32 INFO - 'PWD': '/builds/slave/test', 16:21:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:21:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:21:32 INFO - 'SHELL': '/bin/bash', 16:21:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ddqF1uQ4pC/Listeners', 16:21:32 INFO - 'TMPDIR': '/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/', 16:21:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:21:32 INFO - 'USER': 'cltbld', 16:21:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:21:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:32 INFO - 'XPC_FLAGS': '0x0', 16:21:32 INFO - 'XPC_SERVICE_NAME': '0', 16:21:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 16:21:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0106', '--webServer', 'localhost'] with output_timeout 3600 16:21:33 INFO - mozversion INFO | application_buildid: 20151109153630 16:21:33 INFO - mozversion INFO | application_changeset: 68a879c220d8c777e165ab9df5c1a6a4a3c703f2 16:21:33 INFO - mozversion INFO | application_display_name: Nightly 16:21:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:21:33 INFO - mozversion INFO | application_name: Firefox 16:21:33 INFO - mozversion INFO | application_remotingname: firefox 16:21:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:21:33 INFO - mozversion INFO | application_vendor: Mozilla 16:21:33 INFO - mozversion INFO | application_version: 45.0a1 16:21:33 INFO - mozversion INFO | platform_buildid: 20151109153630 16:21:33 INFO - mozversion INFO | platform_changeset: 68a879c220d8c777e165ab9df5c1a6a4a3c703f2 16:21:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:21:33 INFO - mozversion INFO | platform_version: 45.0a1 16:21:33 INFO - 2015-11-09 16:21:33,291 DEBUG : using testdate: 1447114893 16:21:33 INFO - 2015-11-09 16:21:33,291 DEBUG : actual date: 1447114893 16:21:33 INFO - 2015-11-09 16:21:33,346 INFO : starting webserver on 'localhost:49265' 16:21:33 INFO - 2015-11-09 16:21:33,347 INFO : Starting test suite t-yosemite-r5-0106 16:21:33 INFO - 2015-11-09 16:21:33,348 INFO : Starting test dromaeo_css 16:21:33 INFO - 2015-11-09 16:21:33,348 DEBUG : operating with platform_type : mac_ 16:21:33 INFO - 2015-11-09 16:21:33,349 INFO : Initialising browser for dromaeo_css test... 16:21:33 INFO - 2015-11-09 16:21:33,377 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/tmpZ_uact/profile http://localhost:49265/getInfo.html 16:21:37 INFO - 2015-11-09 16:21:37,214 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:21:37 INFO - 2015-11-09 16:21:37,214 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:21:37 INFO - 2015-11-09 16:21:37,214 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:21:37 INFO - 2015-11-09 16:21:37,214 DEBUG : BROWSER_OUTPUT: __metrics 16:21:37 INFO - 2015-11-09 16:21:37,242 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:21:37 INFO - 2015-11-09 16:21:37,586 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 16:21:38 INFO - 2015-11-09 16:21:38,110 INFO : Browser initialized. 16:21:38 INFO - 2015-11-09 16:21:38,111 INFO : Running cycle 1/1 for dromaeo_css test... 16:21:38 INFO - 2015-11-09 16:21:38,111 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/tmpZ_uact/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:21:50 INFO - 2015-11-09 16:21:50,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 228102144 16:21:50 INFO - 2015-11-09 16:21:50,376 DEBUG : BROWSER_OUTPUT: 16:22:42 INFO - 2015-11-09 16:22:42,261 DEBUG : BROWSER_OUTPUT: 1447114962255 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] 16:24:52 INFO - 2015-11-09 16:24:52,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49265/tests/dromaeo/cssquery-ext.html) 16:24:53 INFO - 2015-11-09 16:24:53,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 343494656 16:24:53 INFO - 2015-11-09 16:24:53,557 DEBUG : BROWSER_OUTPUT: 16:27:56 INFO - 2015-11-09 16:27:56,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-ext.html (next: http://localhost:49265/tests/dromaeo/cssquery-jquery.html) 16:27:57 INFO - 2015-11-09 16:27:57,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 366641152 16:27:57 INFO - 2015-11-09 16:27:57,054 DEBUG : BROWSER_OUTPUT: 16:30:59 INFO - 2015-11-09 16:30:59,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49265/tests/dromaeo/cssquery-mootools.html) 16:31:00 INFO - 2015-11-09 16:31:00,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 319733760 16:31:00 INFO - 2015-11-09 16:31:00,104 DEBUG : BROWSER_OUTPUT: 16:34:02 INFO - 2015-11-09 16:34:02,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49265/tests/dromaeo/cssquery-prototype.html) 16:34:02 INFO - 2015-11-09 16:34:02,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 317714432 16:34:02 INFO - 2015-11-09 16:34:02,758 DEBUG : BROWSER_OUTPUT: 16:37:05 INFO - 2015-11-09 16:37:05,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49265/tests/dromaeo/cssquery-yui.html) 16:37:06 INFO - 2015-11-09 16:37:06,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 321314816 16:37:06 INFO - 2015-11-09 16:37:06,413 DEBUG : BROWSER_OUTPUT: 16:40:09 INFO - 2015-11-09 16:40:09,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/dromaeo/cssquery-yui.html (next: http://localhost:49265/tests/dromaeo/cssquery-dojo.html) 16:40:09 INFO - 2015-11-09 16:40:09,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 362295296 16:40:09 INFO - 2015-11-09 16:40:09,587 DEBUG : BROWSER_OUTPUT: 16:40:09 INFO - 2015-11-09 16:40:09,587 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:40:09 INFO - 2015-11-09 16:40:09,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:40:09 INFO - 2015-11-09 16:40:09,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:40:09 INFO - 2015-11-09 16:40:09,587 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:40:09 INFO - 2015-11-09 16:40:09,588 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2758.5724212747027;2770.5290100682882;2784.22041828288;2803.313188268873;2834.5464725643897;4586.1744885920525;4601.838935637249;4694.413198350207;4700.388949436573;4716.198246298129;4672.929906051412;4684.110019096369;4706.599939005188;4720.999999999992;4842.564169224769;4391.429114215148;4395.714278571899;4497.190505708987;4507.774611269439;4613.584777370036;4545.659075569329;4547.204239258133;4594.218982772936;4613.261878099504;4640;4294.334378171373;4358.36803663467;4410.867673969786;4418.4256046714045;4494.70784399013;4461.776911154429;4486.955130448687;4491.146682130385;4496.100779844011;4543.750093744843;4462.866114016585;4464.151811155903;4464.531224221442;4484.977575112103;4546.363509108694;4602.401687780601;4618.468876079261;4641.3270075839155;4735.928961065587;4784.378030855966;5032;5044.344235249431;5053.292539044537;5060.721660308682;5106.821261255838;5099;5106.744662766847;5107.897842043139;5113.437521872591;5145.459726728677;4528.592426681615;4617.984043510422;4621.607163391116;4636.374089497942;4777.355057067321;5084.898302033938;5123;5135.897282054338;5139.460356662496;5143.97428012865;4962.082014827269;4966.205407134841;4976.0794253063295;4976.104301225741;5028.673136246132;4822.9758851205515;4922.655414120977;4935.111679897581;5056.6207534434325;5168.9741551292;4937.654364194544;4975.10448119342;4982.501749825061;4991.875203119951;5021.221710634857;4963.8262660806695;4971.055499455092;4991.3511243538105;4993.076280888047;5051.974740126276;3840.807959602065;3895.182011777502;3929.5088113985753;3944.290027794967;4005.6394924456354;3589.623089575557;3611.5846677631885;3612.7290453215587;3633.4549817527054;3654.616265292106;4483.14820184164;4733.834315798999;4739.668223224341;4750.501197374295;4789.209780386197;4928.383952005999;4986.601071914238;4989.900201996013;5008.198688209942;5033.874153146201;4711.387519622427;4737.407824021997;4742.075295317449;4744.264638980963;4749.572538471554;4324.070324880166;4477.619402350771;4478.417805685305;4488.551144885485;4555.043440877453;5050.72221027847;5071.492850714899;5076.18780995039;5127.46161653021;5189.351331083614;5054.4187418447345;5075.213341932006;5081.33942587476;5085.452271779973;5136.743162841918;5052.469490703424;5168.121419358793;5176.7152806594495;5185.455527169593;5196.064708352382;4954.5540901319055;4961.454240033666;4966.006798640215;4974.825881094144;5016.6237532184505;5030.748462576929;5043.4956504349275;5064.898702026013;5066.189409694432;5090.949090509048;4718.41019872516;4925.38432695913;4951.9752401237765;4963.879621941804;4989.176785830443;4838.879028024327;4839.177339852163;4851.902961940671;4880.048390563806;4937.1113199624415;4805.711657300573;4813.133635945564;4816.95183048165;4827.8551643450755;4838.491958344464;4792.305115758265;4916.82791102324;4931.038447502702;4941.407031156141;4953.975230123826;4744.857654270378;4780.426348838162;4788.832390866303;4800.135975524439;4877.9024419512125 16:40:09 INFO - 2015-11-09 16:40:09,588 DEBUG : BROWSER_OUTPUT: |1;ext.html;492.286185031704;495.417883986316;498.29242475684526;506.60231718101284;515.2914742229434;27358;28597.14208573741;34414.8279258604;34938.8253058735;34962.65037349626;38027.23945521088;38352.23295534088;38465.615343846555;38508.229835403276;38541.229175416476;7352.41180705545;8080.959595202015;8315.251627353537;8336.874946875801;8343.207395297437;7410.925890741104;9730.610775569005;9919.454430006346;9932.950335248313;9935.751606209866;9597.808043839119;9733.56198971048;9790.706278811647;9793.510324483783;9815.460149691764;7530.397568194531;7645.426593005547;9726.9513652432;9850.40897546146;9854.556544955494;9526.14264716172;9663.806723865553;9668.323217374787;9677.080677335642;9687.806243875082;35465.82267088674;35946.64053359459;35980.82009589962;35995.460068099;36364.81817590922;2534.822562420631;2626.5272250994813;2662.4541968896524;2683.1950414875655;3093.072078376478;24838.503229935483;24938.251852444457;24950.875245623836;25343.364274214357;25568.360790980187;2182.4216582605623;2199.197292988048;2203.019656252968;2204;2204.382772823612;237240;238174;238934;239707;241043;54326.728366357915;54664;54667.179992300145;54688;54766.45233547613;47478;48595.5140448598;49055.64165375151;62000;63637.36362636314;14716.33776480061;14733.189674568002;14838.441963593883;14840.406383744745;14849.851501484847;11066.39134847591;11190;11228.438578071064;11251.324920504632;11348.092152627934;17304.480865574053;17345.7398139028;17371.392001279895;17442.738358924627;17453;7177.138743350832;7320.341169294789;7364.594947277844;7409.962950185214;7448.318605302087;793.4089103617841;980.1032055668983;980.5881529757519;1008.0927165550917;1012.0688966151158;24417.145399910918;24866.37834054127;24942.625860612105;25083.62374564383;25122.37194070163;917.3486824354783;919.429953428865;939.9530023498935;1005.7234260578253;1041.7291504208808;13374;13672.17966921968;13766.724665506634;13774.65563360924;13812.654683632789;411350;417035;417704;417793;422693;50410.747946260766;50536.49463505392;50557;50600.24099638508;51242.23136652953;1162.540796385423;1238.9566365177175;1239.39269757818;1252.9122961392798;1255.0900597067052;26876;27153;27581.172564823086;27682;27877.86061069682;39251.607483924796;39981.40027899526;44381.33427998518;45069.32396013997;45098.54901450944;246759;248830;250917;253863;255645;24246.15138470145;24663.136790212255;28864;29186.854065729534;29523.557146642386;29709.702902970694;35944;36551.45172822357;36587.45118823273;37805.62194378131;28016.579751304154;29089.563656545593;29225.85387073136;29381.26546836346;29481.410371792874;28554;28752;29955.251118721335;30403.695963040085;31164.53253201249;31459;31579.526307104952;31676.683233168296;31704;34872;28303.433931320847;28879.85560072186;28913.132606021853;28951.276218094717;29201.415971680024;21508.67736983915;21852.344429667137;21876.23433179831;21908.12367505282;21977.890110549346 16:40:09 INFO - 2015-11-09 16:40:09,588 DEBUG : BROWSER_OUTPUT: |2;jquery.html;291.19049043658623;291.56702297088805;296.8664101154481;297.33842201102544;304.2409189073262;12161;12975.545855895021;14788.55634330969;14916.328765205564;15493.535193944186;13379.59861204163;14900.329485173166;15175.620609484768;15208.087514749122;15402.84597154028;4544.250198717207;4571.291449825282;4698.08387364464;4703.129920964615;4721.952780472186;3395.4906763985355;3535.3636345457808;3538.2215912499337;4638.049199914027;4688.390509233812;4942.950570494285;5060;5087.414947281054;5092.541671249587;5104.872378190538;4957.752112394366;5074.949250507521;5092.439831618519;5116.334876466073;5119.1809310510325;4357.803898824561;4422;4422.6682998774895;4429.3798868158165;4430.844920427802;18102.366417175337;18203.27186912522;18320.45038648843;18320.816791832043;18531.44405667832;1783.8037815840248;1826.75338829259;1841.1898764543557;1851.7037274036225;2117.2272120676;7768.124042458685;11435.428228588537;11754.529818807237;12147.757044859141;12238.694032649166;1367.7743172376545;1372.19726460021;1389.603962870577;1394.198335956829;1452.8038714773477;47584.76207618974;49969.25415068992;49998;50188.24717629238;50198.74900625474;5620.241267428926;5660.603757736919;5688.488036076773;5691.231683722644;5709.05800542914;6443.613383197023;6499.707513161919;6503.28463868974;6512.544121911421;6527.771527996592;4721.220998535272;4797.472278049481;4806.49531799163;4816.036792641416;4835.588974937099;5132.743362831843;5151.716655583904;5155.355580552431;5182.896342073137;5184.818531351385;2517;2524.886380112899;2537.8096642751866;2562.551553478134;2568.4477837264703;868.4919322196586;885.7431344909904;893.7542175901679;937.4656445825814;945.2060269373759;269.64003055920176;394.8144372145087;398.7726995612473;401.54424727934;404.4176386004145;9257.351985361094;10051.346662466916;10205.87735349111;10287.485625718684;10310.32982856112;374.65344556285874;387.2699960574338;393.2665578695712;400.62141276493435;402.5250204758413;5363.195520671852;5368.32895888014;5417.377001644862;5448.43972440342;5484.670919744828;510911;514472;517592;521693;547412;46929;63309;63853.68073159605;64927;65034.34965650283;426.5606425381862;430.78676055352173;431.4606741572971;431.90929904719735;432.16160648342117;9556.808863822545;9698.75753106178;9734.172595329477;9738.902610973799;9817;28122.156335309974;29071.56392654154;29217.41565168727;29414;30932.845335773178;37627;37942.2411551773;38354.232915342094;38396;38853.41719874261;5177.456367081553;5476.6166368355425;5485.61600687948;5488.807891723771;5500.257465242141;10097.747556311151;10205.285630005828;10323.63867264642;10451.843222351823;10482.37105773656;8457.87313190315;8947.507887066013;9044.864327034968;9073.047330030517;9076.455412675261;8554;8562.657493700432;8684.261837743863;8734.737957861274;8762.649494020168;8751.824963500821;8963.327750418614;9000;9010.639574417211;9092.545372731469;5408.37803652585;5410.296661433988;5410.3507579090765;5421.241026256248;5427.83716488506;8593.226609605166;8651.91348086511;8928.86606700887;9003.954980225057;9006.189442949904 16:40:09 INFO - 2015-11-09 16:40:09,592 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1099.2140619457086;1220.0178856020902;1276.3107921722267;1299.9740005199897;1503.8872084593659;6618.040384144296;6774.119364482616;6814.182298124219;7191.460640451974;7214.819629509252;6961.234264230943;7035.2612975637585;7041.014258003884;7047.541909775861;7077.64611769412;1893.905304734761;1923.3172223860538;1927.2772710233662;1929.4018854155186;1939.224310275894;1920.395075551204;1941.5825597496535;1942.9902850485798;1977.5056235941015;1982.108051376879;1954.8142926421967;1958.4516335426104;1959.549303660159;1962.3720409468976;1963.0283009910115;1872.4850666066804;1876.5402476393235;1880.5580688538182;1881.8118188181209;1888.1408958923726;1844.7232915062848;1855.944321670352;1867.5797945462161;1915.955804086762;1923.307609260665;6277.937220627781;7036.577805331696;7055.470839687044;7060.435165186773;7070.823229419254;3828.5788563258297;3931.4495970564144;4113.197926404352;4189.015581338383;4204.1801848639525;2563.4104156044027;2578.3425226567106;2616.3459135216194;2616.659834221539;2617.0316982716326;720.5172534401963;852.0925214646381;877.8727084572765;879.0046594231123;880.7357792662176;8309.210624990616;8352.373571982065;8388.958055209747;8429.70496032642;8471.534065626389;3798.164403831153;3810.5617853946596;3891.3968334908136;3893.8637147699696;3906.882793516199;8256.215659512336;8270.875936860952;8277.710280140167;8299.875501867476;8312.25189732927;4373.190959672471;4375.518692943773;4377.343398490252;4387.736735795863;4390.604845563915;3962.9603703963166;3964.8810535683397;3983.8605648802154;3991.3613821788376;3993.6405723484445;3113.517404802214;3128.6402063762503;3139;3153.6373317068833;3165.4014722564957;1000.4697510319543;1001.639409812467;1007.5667462990984;1012.2307046644603;1016.1362841584742;1117.9664610061711;1123.0510218865045;1150.7583407484356;1152.8904754048351;1161.285809227336;6643.900341494881;6666.033425153326;6693.029510720919;6720.260771315151;6726.058351830748;406.82913176465956;407.6107317511769;412.140686668294;412.9009037830899;413.04792453395214;5239.711815850089;5271.710055946883;5275.683458992473;5285.339332583427;5303.4696530346655;8196.918030819736;8278.461899976483;8445.113263107409;8476.618552165168;8491.830163396697;8394.496330220207;8407.2433480987;8417.28453081495;8442.451240669337;8443.66225350979;6244.7814326499265;6572.375624315682;6613.768518101843;6640.402363787282;6672.466202703772;6495.285518593046;6650.501212408992;6656.633885136364;6661.533692641468;6698.899516507354;7539.811504712426;7608.391328693802;7658.846823063396;7667.11828139771;7685.846283074419;7467.365273951775;7710.961445192738;7749.612519373896;7815.882761758692;7859.84280314402;6235.875282494416;6292.119103325446;6304.5586808922935;6316.684165791784;6332.810015699536;6347.523935704933;6652.467802575686;6672.432843208382;6677.232118306457;6777.728890844311;6013.428724271187;6209.5032397409;6213.099100630474;6352.841178970378;6359.236891572856;5857.619254748428;5946.910796338145;6134.4172303631085;6284;6288.654124023223;6272.905906411316;6318.210223722035;6381.234251889803;6387.808365749035;6453.322401147811;5708.4862362387585;5820.883582328414;5825.737841797214;5836.766529338949;5837.211976383134;5777.6822274775295;5815.04051831443;5819.854503637443;5826;5860.970695146668 16:40:09 INFO - 2015-11-09 16:40:09,592 DEBUG : BROWSER_OUTPUT: |4;prototype.html;268.87228566430946;275.36803037030006;277.64045560998517;282.66786525832157;287.5399361022366;5257.500537448946;5338.439463856293;5340.759665815038;5342.385625653051;5371.89256214876;5266.183741520071;5276.314079169702;5285.841424757264;5303.416624171338;5347.197920311955;4183.351580505011;4189.266878296301;4194.496660400756;4195.811188496525;4199.202151591203;3988.5413177484525;4075.3886916962547;4084.6732261419165;4171.395147703596;4210.031692710679;4055.1078762672164;4085.9182816343805;4113.9177216455655;4130.628243458088;4151.439555659993;4113.6297733203855;4127.772972486512;4131.97934010331;4135.66914646829;4137.97931010346;3394;3428.177237463016;3442.019024578008;3501.3347463981763;3579;5129.563987061104;5135.614828887811;5136.614753893473;5148.974255128738;5173.534381905609;4548.954510454886;4558.8632341029825;4569.314602809605;4570.702904311209;4583.220852455091;5492.725363731797;5501.642393244426;5506.476884695948;5520.779168833242;5526.309211348582;3644.9271014579826;3714.851405943759;3733.2906747718116;3736.551613806361;3818.045488627843;5581.609287349887;5683.744231509592;5738.885222295531;5752.108423194411;5756.798512052058;3782.0355809268463;3787;3788.4696142540065;3789.6020917803785;3790.7915064671706;3812.1803812180515;3821.5796262411113;3833.5399752029934;3836.808159592065;3857.189990102054;4402.459139301219;4522.3668686383935;4529.8641040768825;4534.342520334599;4536.092781443658;5585.078462053797;5597.272354593958;5598.832035038955;5612;5624;1349.9932500337632;1369.7808350664045;1371.5542448704211;1372.1698372484702;1374.202962281874;850.2560259772699;864.8443280209623;874.3486102853415;874.5845723281391;885.2784980241083;5285.762140703678;5301.204819277139;5303.098473259555;5307.124324486494;5310.867228319323;5795.333536643256;5796.536277097906;5808.651480911159;5811.88376232473;5829.591928565044;5290.1800220965815;5300.178472336794;5305.761240744176;5316.973415132899;5385.111456609616;3103.224193951512;3159.8262095584505;3195.5046967719577;3207.4547326954475;3212.3093534890113;5753.568482363839;5830.300363956352;5832.358440571534;5847;5958.940410595926;5882.735276912464;5921.526277897758;5941.55438342126;5942.70286485674;5980.342162362137;5873.236479257755;5892.1161825726485;5895.882082358415;5904.52763778888;5905.940940590539;5562.638428502134;5767.279090113736;5776.133579962871;5784.913226301524;5797.449242321973;5645.858853528531;5728.656280623176;5730.5129064030025;5742.942570574241;5764.106563482667;5932.347441781487;5938.73275702603;5941.821745347646;5945.791897283574;5980.401959803985;3728.7762734236035;3806.4670946067017;3819.751716138442;3819.942700859434;3825.12022234882;5634.971825140848;5835.94164058354;5838.12428135783;5844.795432159854;5865.706714664165;5627.8874422512135;5652.095664693629;5663.292088488939;5671.17767923657;5686.431356864446;5646;5662.716864156693;5666.093425051972;5667.688277144796;5669.971650141723;5524.723763811713;5540.91688624679;5550.0564903965615;5553.055980483408;5561.555075594024;5651.124075768263;5670.234518340137;5671.376148623731;5693.459121383462;5710.343310519177;5585.832425027255;5588.692621905834;5591.04952158126;5593.300837395325;5611.915821262603 16:40:09 INFO - 2015-11-09 16:40:09,595 DEBUG : BROWSER_OUTPUT: |5;yui.html;557.612459340758;574.0642752313728;622.4895585619794;642.5919541091408;663.6681659170414;11886.7622647547;12165.270083794956;12181.086418518624;12181.57364492243;12239.265644061352;11168.441577921112;11837.348945807977;12200.755984880298;12207.816882746743;12223.755524889497;594.8929192745326;728.3808762551828;746.8020974441778;748.4050180106829;748.5583505731618;586.2671660424469;596.7791916990719;736.7642354446552;747.3386053342804;747.8130467383154;749;760.3840888879997;762.8931949527071;763.1185980192859;764.4610549562545;617.0990354083;622.5704264057786;757.6704133701858;762.3596179209491;762.3634265388407;572.6249306704116;581.8719881626035;582.5194214772829;583.0030647592622;584.0684108846383;12140.392980350947;12230.877691223062;12245.02039836811;12253.142280040402;12305.384730763426;10057.547410366478;10079.44563049032;10232;10596.682099537025;10731.570737170503;7661.846763064707;8091.312238459738;8346.916530834675;8510;8656.653733850639;2885.422915416925;2945.366746149588;2966.777491688132;2979.6722360540325;3000.5499175123687;42771.57228427707;42817;43573;43678.344824827655;43987.34018989718;8159.95920020408;8168.059364253011;8195.754127376189;8276.255137037695;8296.377771667148;17192.22634981429;17204.65590688179;17219.741703874453;17225.483235502954;17328.046957417464;5944.851378715567;6007.369226231182;6052.546059045501;6079.513638908877;6337.7781777637565;3201.8879339223017;3202.615686117681;3215.5498230247786;3299.9175020624198;3314.4531152360073;2599.4541146359097;2654.349684327352;2658.667666541682;2659.8670066496597;2663;383.390409249295;386.03683808896983;400.661441082285;401.17358242021527;401.28170574671594;400.4713777813317;470.36970459583637;509.92860999460106;521.116707181324;544.9373322067934;6978.0400195022285;7017.543859649107;7061.682224299919;7160.176579693298;7294;435.8627032484757;444.45776153093175;471.4837253207732;554.0774610273929;557.3952261795997;3393.7794043387103;3412.9658703413143;3416.145963509123;3450.292689998544;3495.702865256431;50836;51671.48328516742;52249.47750522446;52415.73792131015;52419;44504.77747611306;44527.109457810664;44855;45092.3236151458;45164.77417612891;39070.60929390726;39949;40659.796701016894;40781.1843763129;40954;6802.591844489347;6978;7395.927590499455;7570.394368450621;7596.772096837104;30807.38385232238;30938.690613093582;31271.374572508877;31704.682953170173;32152.678473214968;36784.26431471302;37014.25971480609;41051;41085;41545;6540.967295163494;6592.208934927839;6640.273528882622;6659.53383263167;6763;9587.904120958701;9649.807003860024;9725.367851089657;9872.703818885446;10225.74435639115;8795.076516965626;8835.028146903964;8925;8957.955210223907;9558.044195580387;9012.549372531215;9040.41237319572;9203.263738900738;9210.631574736935;9907.256955728493;6540.5222763913325;8336.833263334578;8997.775055623662;9509.857352139585;9559.330846840932;7714.6914123434435;7933.484323519184;7936.404769642415;8006.739579075411;8439.70461033861;7468.365188958999;7841.176676448891;7863;7942.364610831235;8023.799405014921 16:40:09 INFO - 2015-11-09 16:40:09,596 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:40:09 INFO - 2015-11-09 16:40:09,596 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:40:09 INFO - 2015-11-09 16:40:09,596 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1070 16:40:09 INFO - 2015-11-09 16:40:09,596 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:40:09 INFO - 2015-11-09 16:40:09,596 DEBUG : BROWSER_OUTPUT: __startTimestamp1447116009581__endTimestamp 16:40:09 INFO - 2015-11-09 16:40:09,597 DEBUG : BROWSER_OUTPUT: 16:40:09 INFO - 2015-11-09 16:40:09,597 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:40:09 INFO - 2015-11-09 16:40:09,597 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:40:09 INFO - 2015-11-09 16:40:09,597 DEBUG : BROWSER_OUTPUT: 16:40:09 INFO - 2015-11-09 16:40:09,597 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4705.76 Median:4816.95 stddev:480.45 (10.0%) stddev-sans-first:457.00 16:40:09 INFO - 2015-11-09 16:40:09,597 DEBUG : BROWSER_OUTPUT: Values: 2758.6 2770.5 2784.2 2803.3 2834.5 4586.2 4601.8 4694.4 4700.4 4716.2 4672.9 4684.1 4706.6 4721.0 4842.6 4391.4 4395.7 4497.2 4507.8 4613.6 4545.7 4547.2 4594.2 4613.3 4640.0 4294.3 4358.4 4410.9 4418.4 4494.7 4461.8 4487.0 4491.1 4496.1 4543.8 4462.9 4464.2 4464.5 4485.0 4546.4 4602.4 4618.5 4641.3 4735.9 4784.4 5032.0 5044.3 5053.3 5060.7 5106.8 5099.0 5106.7 5107.9 5113.4 5145.5 4528.6 4618.0 4621.6 4636.4 4777.4 5084.9 5123.0 5135.9 5139.5 5144.0 4962.1 4966.2 4976.1 4976.1 5028.7 4823.0 4922.7 4935.1 5056.6 5169.0 4937.7 4975.1 4982.5 4991.9 5021.2 4963.8 4971.1 4991.4 4993.1 5052.0 3840.8 3895.2 3929.5 3944.3 4005.6 3589.6 3611.6 3612.7 3633.5 3654.6 4483.1 4733.8 4739.7 4750.5 4789.2 4928.4 4986.6 4989.9 5008.2 5033.9 4711.4 4737.4 4742.1 4744.3 4749.6 4324.1 4477.6 4478.4 4488.6 4555.0 5050.7 5071.5 5076.2 5127.5 5189.4 5054.4 5075.2 5081.3 5085.5 5136.7 5052.5 5168.1 5176.7 5185.5 5196.1 4954.6 4961.5 4966.0 4974.8 5016.6 5030.7 5043.5 5064.9 5066.2 5090.9 4718.4 4925.4 4952.0 4963.9 4989.2 4838.9 4839.2 4851.9 4880.0 4937.1 4805.7 4813.1 4817.0 4827.9 4838.5 4792.3 4916.8 4931.0 4941.4 4954.0 4744.9 4780.4 4788.8 4800.1 4877.9 16:40:09 INFO - 2015-11-09 16:40:09,598 DEBUG : BROWSER_OUTPUT: 16:40:09 INFO - 2015-11-09 16:40:09,598 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44908.30 Median:17128.80 stddev:82793.26 (483.4%) stddev-sans-first:82958.36 16:40:09 INFO - 2015-11-09 16:40:09,599 DEBUG : BROWSER_OUTPUT: Values: 492.3 495.4 498.3 506.6 515.3 27358.0 28597.1 34414.8 34938.8 34962.7 38027.2 38352.2 38465.6 38508.2 38541.2 7352.4 8081.0 8315.3 8336.9 8343.2 7410.9 9730.6 9919.5 9933.0 9935.8 9597.8 9733.6 9790.7 9793.5 9815.5 7530.4 7645.4 9727.0 9850.4 9854.6 9526.1 9663.8 9668.3 9677.1 9687.8 35465.8 35946.6 35980.8 35995.5 36364.8 2534.8 2626.5 2662.5 2683.2 3093.1 24838.5 24938.3 24950.9 25343.4 25568.4 2182.4 2199.2 2203.0 2204.0 2204.4 237240.0 238174.0 238934.0 239707.0 241043.0 54326.7 54664.0 54667.2 54688.0 54766.5 47478.0 48595.5 49055.6 62000.0 63637.4 14716.3 14733.2 14838.4 14840.4 14849.9 11066.4 11190.0 11228.4 11251.3 11348.1 17304.5 17345.7 17371.4 17442.7 17453.0 7177.1 7320.3 7364.6 7410.0 7448.3 793.4 980.1 980.6 1008.1 1012.1 24417.1 24866.4 24942.6 25083.6 25122.4 917.3 919.4 940.0 1005.7 1041.7 13374.0 13672.2 13766.7 13774.7 13812.7 411350.0 417035.0 417704.0 417793.0 422693.0 50410.7 50536.5 50557.0 50600.2 51242.2 1162.5 1239.0 1239.4 1252.9 1255.1 26876.0 27153.0 27581.2 27682.0 27877.9 39251.6 39981.4 44381.3 45069.3 45098.5 246759.0 248830.0 250917.0 253863.0 255645.0 24246.2 24663.1 28864.0 29186.9 29523.6 29709.7 35944.0 36551.5 36587.5 37805.6 28016.6 29089.6 29225.9 29381.3 29481.4 28554.0 28752.0 29955.3 30403.7 31164.5 31459.0 31579.5 31676.7 31704.0 34872.0 28303.4 28879.9 28913.1 28951.3 29201.4 21508.7 21852.3 21876.2 21908.1 21977.9 16:40:09 INFO - 2015-11-09 16:40:09,599 DEBUG : BROWSER_OUTPUT: 16:40:09 INFO - 2015-11-09 16:40:09,600 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24828.46 Median:26191.12 stddev:85425.93 (326.2%) stddev-sans-first:85645.70 16:40:09 INFO - 2015-11-09 16:40:09,601 DEBUG : BROWSER_OUTPUT: Values: 291.2 291.6 296.9 297.3 304.2 12161.0 12975.5 14788.6 14916.3 15493.5 13379.6 14900.3 15175.6 15208.1 15402.8 4544.3 4571.3 4698.1 4703.1 4722.0 3395.5 3535.4 3538.2 4638.0 4688.4 4943.0 5060.0 5087.4 5092.5 5104.9 4957.8 5074.9 5092.4 5116.3 5119.2 4357.8 4422.0 4422.7 4429.4 4430.8 18102.4 18203.3 18320.5 18320.8 18531.4 1783.8 1826.8 1841.2 1851.7 2117.2 7768.1 11435.4 11754.5 12147.8 12238.7 1367.8 1372.2 1389.6 1394.2 1452.8 47584.8 49969.3 49998.0 50188.2 50198.7 5620.2 5660.6 5688.5 5691.2 5709.1 6443.6 6499.7 6503.3 6512.5 6527.8 4721.2 4797.5 4806.5 4816.0 4835.6 5132.7 5151.7 5155.4 5182.9 5184.8 2517.0 2524.9 2537.8 2562.6 2568.4 868.5 885.7 893.8 937.5 945.2 269.6 394.8 398.8 401.5 404.4 9257.4 10051.3 10205.9 10287.5 10310.3 374.7 387.3 393.3 400.6 402.5 5363.2 5368.3 5417.4 5448.4 5484.7 510911.0 514472.0 517592.0 521693.0 547412.0 46929.0 63309.0 63853.7 64927.0 65034.3 426.6 430.8 431.5 431.9 432.2 9556.8 9698.8 9734.2 9738.9 9817.0 28122.2 29071.6 29217.4 29414.0 30932.8 37627.0 37942.2 38354.2 38396.0 38853.4 5177.5 5476.6 5485.6 5488.8 5500.3 10097.7 10205.3 10323.6 10451.8 10482.4 8457.9 8947.5 9044.9 9073.0 9076.5 8554.0 8562.7 8684.3 8734.7 8762.6 8751.8 8963.3 9000.0 9010.6 9092.5 5408.4 5410.3 5410.4 5421.2 5427.8 8593.2 8651.9 8928.9 9004.0 9006.2 16:40:09 INFO - 2015-11-09 16:40:09,601 DEBUG : BROWSER_OUTPUT: 16:40:09 INFO - 2015-11-09 16:40:09,601 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4843.31 Median:5903.94 stddev:2546.62 (43.1%) stddev-sans-first:2538.21 16:40:09 INFO - 2015-11-09 16:40:09,602 DEBUG : BROWSER_OUTPUT: Values: 1099.2 1220.0 1276.3 1300.0 1503.9 6618.0 6774.1 6814.2 7191.5 7214.8 6961.2 7035.3 7041.0 7047.5 7077.6 1893.9 1923.3 1927.3 1929.4 1939.2 1920.4 1941.6 1943.0 1977.5 1982.1 1954.8 1958.5 1959.5 1962.4 1963.0 1872.5 1876.5 1880.6 1881.8 1888.1 1844.7 1855.9 1867.6 1916.0 1923.3 6277.9 7036.6 7055.5 7060.4 7070.8 3828.6 3931.4 4113.2 4189.0 4204.2 2563.4 2578.3 2616.3 2616.7 2617.0 720.5 852.1 877.9 879.0 880.7 8309.2 8352.4 8389.0 8429.7 8471.5 3798.2 3810.6 3891.4 3893.9 3906.9 8256.2 8270.9 8277.7 8299.9 8312.3 4373.2 4375.5 4377.3 4387.7 4390.6 3963.0 3964.9 3983.9 3991.4 3993.6 3113.5 3128.6 3139.0 3153.6 3165.4 1000.5 1001.6 1007.6 1012.2 1016.1 1118.0 1123.1 1150.8 1152.9 1161.3 6643.9 6666.0 6693.0 6720.3 6726.1 406.8 407.6 412.1 412.9 413.0 5239.7 5271.7 5275.7 5285.3 5303.5 8196.9 8278.5 8445.1 8476.6 8491.8 8394.5 8407.2 8417.3 8442.5 8443.7 6244.8 6572.4 6613.8 6640.4 6672.5 6495.3 6650.5 6656.6 6661.5 6698.9 7539.8 7608.4 7658.8 7667.1 7685.8 7467.4 7711.0 7749.6 7815.9 7859.8 6235.9 6292.1 6304.6 6316.7 6332.8 6347.5 6652.5 6672.4 6677.2 6777.7 6013.4 6209.5 6213.1 6352.8 6359.2 5857.6 5946.9 6134.4 6284.0 6288.7 6272.9 6318.2 6381.2 6387.8 6453.3 5708.5 5820.9 5825.7 5836.8 5837.2 5777.7 5815.0 5819.9 5826.0 5861.0 16:40:09 INFO - 2015-11-09 16:40:09,602 DEBUG : BROWSER_OUTPUT: 16:40:09 INFO - 2015-11-09 16:40:09,603 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4665.53 Median:5341.57 stddev:1425.38 (26.7%) stddev-sans-first:1390.66 16:40:09 INFO - 2015-11-09 16:40:09,603 DEBUG : BROWSER_OUTPUT: Values: 268.9 275.4 277.6 282.7 287.5 5257.5 5338.4 5340.8 5342.4 5371.9 5266.2 5276.3 5285.8 5303.4 5347.2 4183.4 4189.3 4194.5 4195.8 4199.2 3988.5 4075.4 4084.7 4171.4 4210.0 4055.1 4085.9 4113.9 4130.6 4151.4 4113.6 4127.8 4132.0 4135.7 4138.0 3394.0 3428.2 3442.0 3501.3 3579.0 5129.6 5135.6 5136.6 5149.0 5173.5 4549.0 4558.9 4569.3 4570.7 4583.2 5492.7 5501.6 5506.5 5520.8 5526.3 3644.9 3714.9 3733.3 3736.6 3818.0 5581.6 5683.7 5738.9 5752.1 5756.8 3782.0 3787.0 3788.5 3789.6 3790.8 3812.2 3821.6 3833.5 3836.8 3857.2 4402.5 4522.4 4529.9 4534.3 4536.1 5585.1 5597.3 5598.8 5612.0 5624.0 1350.0 1369.8 1371.6 1372.2 1374.2 850.3 864.8 874.3 874.6 885.3 5285.8 5301.2 5303.1 5307.1 5310.9 5795.3 5796.5 5808.7 5811.9 5829.6 5290.2 5300.2 5305.8 5317.0 5385.1 3103.2 3159.8 3195.5 3207.5 3212.3 5753.6 5830.3 5832.4 5847.0 5958.9 5882.7 5921.5 5941.6 5942.7 5980.3 5873.2 5892.1 5895.9 5904.5 5905.9 5562.6 5767.3 5776.1 5784.9 5797.4 5645.9 5728.7 5730.5 5742.9 5764.1 5932.3 5938.7 5941.8 5945.8 5980.4 3728.8 3806.5 3819.8 3819.9 3825.1 5635.0 5835.9 5838.1 5844.8 5865.7 5627.9 5652.1 5663.3 5671.2 5686.4 5646.0 5662.7 5666.1 5667.7 5670.0 5524.7 5540.9 5550.1 5553.1 5561.6 5651.1 5670.2 5671.4 5693.5 5710.3 5585.8 5588.7 5591.0 5593.3 5611.9 16:40:09 INFO - 2015-11-09 16:40:09,603 DEBUG : BROWSER_OUTPUT: 16:40:09 INFO - 2015-11-09 16:40:09,603 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11914.95 Median:557.50 stddev:14296.62 (2564.4%) stddev-sans-first:14311.28 16:40:09 INFO - 2015-11-09 16:40:09,605 DEBUG : BROWSER_OUTPUT: Values: 557.6 574.1 622.5 642.6 663.7 11886.8 12165.3 12181.1 12181.6 12239.3 11168.4 11837.3 12200.8 12207.8 12223.8 594.9 728.4 746.8 748.4 748.6 586.3 596.8 736.8 747.3 747.8 749.0 760.4 762.9 763.1 764.5 617.1 622.6 757.7 762.4 762.4 572.6 581.9 582.5 583.0 584.1 12140.4 12230.9 12245.0 12253.1 12305.4 10057.5 10079.4 10232.0 10596.7 10731.6 7661.8 8091.3 8346.9 8510.0 8656.7 2885.4 2945.4 2966.8 2979.7 3000.5 42771.6 42817.0 43573.0 43678.3 43987.3 8160.0 8168.1 8195.8 8276.3 8296.4 17192.2 17204.7 17219.7 17225.5 17328.0 5944.9 6007.4 6052.5 6079.5 6337.8 3201.9 3202.6 3215.5 3299.9 3314.5 2599.5 2654.3 2658.7 2659.9 2663.0 383.4 386.0 400.7 401.2 401.3 400.5 470.4 509.9 521.1 544.9 6978.0 7017.5 7061.7 7160.2 7294.0 435.9 444.5 471.5 554.1 557.4 3393.8 3413.0 3416.1 3450.3 3495.7 50836.0 51671.5 52249.5 52415.7 52419.0 44504.8 44527.1 44855.0 45092.3 45164.8 39070.6 39949.0 40659.8 40781.2 40954.0 6802.6 6978.0 7395.9 7570.4 7596.8 30807.4 30938.7 31271.4 31704.7 32152.7 36784.3 37014.3 41051.0 41085.0 41545.0 6541.0 6592.2 6640.3 6659.5 6763.0 9587.9 9649.8 9725.4 9872.7 10225.7 8795.1 8835.0 8925.0 8958.0 9558.0 9012.5 9040.4 9203.3 9210.6 9907.3 6540.5 8336.8 8997.8 9509.9 9559.3 7714.7 7933.5 7936.4 8006.7 8439.7 7468.4 7841.2 7863.0 7942.4 8023.8 16:40:09 INFO - 2015-11-09 16:40:09,605 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:40:09 INFO - 2015-11-09 16:40:09,605 DEBUG : BROWSER_OUTPUT: 16:40:10 INFO - 2015-11-09 16:40:10,251 INFO : Browser exited with error code: 0 16:40:10 INFO - 2015-11-09 16:40:10,283 INFO : Completed test dromaeo_css (00:18:36) 16:40:10 INFO - 2015-11-09 16:40:10,283 INFO : Starting test kraken 16:40:10 INFO - 2015-11-09 16:40:10,283 DEBUG : operating with platform_type : mac_ 16:40:10 INFO - 2015-11-09 16:40:10,284 INFO : Initialising browser for kraken test... 16:40:10 INFO - 2015-11-09 16:40:10,299 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/tmpbcVTbk/profile http://localhost:49265/getInfo.html 16:40:12 INFO - 2015-11-09 16:40:12,923 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:40:12 INFO - 2015-11-09 16:40:12,923 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:40:12 INFO - 2015-11-09 16:40:12,923 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:40:12 INFO - 2015-11-09 16:40:12,924 DEBUG : BROWSER_OUTPUT: __metrics 16:40:12 INFO - 2015-11-09 16:40:12,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] 16:40:13 INFO - 2015-11-09 16:40:13,658 INFO : Browser initialized. 16:40:13 INFO - 2015-11-09 16:40:13,659 INFO : Running cycle 1/1 for kraken test... 16:40:13 INFO - 2015-11-09 16:40:13,659 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/tmpbcVTbk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:40:25 INFO - 2015-11-09 16:40:25,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 229785600 16:40:25 INFO - 2015-11-09 16:40:25,875 DEBUG : BROWSER_OUTPUT: 16:40:28 INFO - 2015-11-09 16:40:28,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection) 16:40:29 INFO - 2015-11-09 16:40:29,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 285134848 16:40:29 INFO - 2015-11-09 16:40:29,307 DEBUG : BROWSER_OUTPUT: 16:40:32 INFO - 2015-11-09 16:40:32,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-dft) 16:40:32 INFO - 2015-11-09 16:40:32,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 299331584 16:40:32 INFO - 2015-11-09 16:40:32,829 DEBUG : BROWSER_OUTPUT: 16:40:36 INFO - 2015-11-09 16:40:36,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-fft) 16:40:36 INFO - 2015-11-09 16:40:36,688 DEBUG : BROWSER_OUTPUT: RSS: Main: 281759744 16:40:36 INFO - 2015-11-09 16:40:36,688 DEBUG : BROWSER_OUTPUT: 16:40:38 INFO - 2015-11-09 16:40:38,907 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator) 16:40:39 INFO - 2015-11-09 16:40:39,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 281817088 16:40:39 INFO - 2015-11-09 16:40:39,510 DEBUG : BROWSER_OUTPUT: 16:40:41 INFO - 2015-11-09 16:40:41,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:40:42 INFO - 2015-11-09 16:40:42,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 284229632 16:40:42 INFO - 2015-11-09 16:40:42,511 DEBUG : BROWSER_OUTPUT: 16:40:45 INFO - 2015-11-09 16:40:45,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom) 16:40:46 INFO - 2015-11-09 16:40:46,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 285224960 16:40:46 INFO - 2015-11-09 16:40:46,487 DEBUG : BROWSER_OUTPUT: 16:40:49 INFO - 2015-11-09 16:40:49,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate) 16:40:50 INFO - 2015-11-09 16:40:50,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 280346624 16:40:50 INFO - 2015-11-09 16:40:50,573 DEBUG : BROWSER_OUTPUT: 16:40:53 INFO - 2015-11-09 16:40:53,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial) 16:40:54 INFO - 2015-11-09 16:40:54,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 281731072 16:40:54 INFO - 2015-11-09 16:40:54,368 DEBUG : BROWSER_OUTPUT: 16:40:56 INFO - 2015-11-09 16:40:56,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:40:56 INFO - 2015-11-09 16:40:56,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 318410752 16:40:56 INFO - 2015-11-09 16:40:56,636 DEBUG : BROWSER_OUTPUT: 16:40:58 INFO - 2015-11-09 16:40:58,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:40:59 INFO - 2015-11-09 16:40:59,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 318877696 16:40:59 INFO - 2015-11-09 16:40:59,235 DEBUG : BROWSER_OUTPUT: 16:41:01 INFO - 2015-11-09 16:41:01,535 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:41:02 INFO - 2015-11-09 16:41:02,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 326832128 16:41:02 INFO - 2015-11-09 16:41:02,120 DEBUG : BROWSER_OUTPUT: 16:41:04 INFO - 2015-11-09 16:41:04,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:41:05 INFO - 2015-11-09 16:41:05,585 DEBUG : BROWSER_OUTPUT: RSS: Main: 327938048 16:41:05 INFO - 2015-11-09 16:41:05,585 DEBUG : BROWSER_OUTPUT: 16:41:08 INFO - 2015-11-09 16:41:08,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:41:09 INFO - 2015-11-09 16:41:09,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 326963200 16:41:09 INFO - 2015-11-09 16:41:09,104 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49265/tests/kraken/driver.html?testName=ai-astar) 16:41:11 INFO - 2015-11-09 16:41:11,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 386220032 16:41:11 INFO - 2015-11-09 16:41:11,277 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,277 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:41:11 INFO - 2015-11-09 16:41:11,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:41:11 INFO - 2015-11-09 16:41:11,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:41:11 INFO - 2015-11-09 16:41:11,277 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:41:11 INFO - 2015-11-09 16:41:11,277 DEBUG : BROWSER_OUTPUT: |0;ai-astar;118;126;121;128;124;121;116;126;127;112 16:41:11 INFO - 2015-11-09 16:41:11,278 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;178;151;176;185;149;172;169;140;186;148 16:41:11 INFO - 2015-11-09 16:41:11,278 DEBUG : BROWSER_OUTPUT: |2;audio-dft;182;187;186;182;186;185;181;186;188;182 16:41:11 INFO - 2015-11-09 16:41:11,278 DEBUG : BROWSER_OUTPUT: |3;audio-fft;90;87;98;99;78;81;83;89;94;78 16:41:11 INFO - 2015-11-09 16:41:11,278 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;110;111;155;103;105;103;143;102;104;152 16:41:11 INFO - 2015-11-09 16:41:11,278 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;135;136;136;136;142;134;129;142;142;130 16:41:11 INFO - 2015-11-09 16:41:11,278 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;144;141;147;147;144;140;148;147 16:41:11 INFO - 2015-11-09 16:41:11,279 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;117;117;118;117;117;113;119;120;118;119 16:41:11 INFO - 2015-11-09 16:41:11,279 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;65;68;68;67;66;66;76;66;65 16:41:11 INFO - 2015-11-09 16:41:11,279 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;73;74;77;80;79;78;76;76;76;83 16:41:11 INFO - 2015-11-09 16:41:11,279 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;100;100;100;100;102;101;96;98;101;101 16:41:11 INFO - 2015-11-09 16:41:11,279 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;144;143;147;148;144;152;156;152;154;146 16:41:11 INFO - 2015-11-09 16:41:11,280 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;168;174;171;179;180;171;181;176;180;184 16:41:11 INFO - 2015-11-09 16:41:11,280 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;81;81;85;85;85;85;84;81;83;85 16:41:11 INFO - 2015-11-09 16:41:11,280 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:41:11 INFO - 2015-11-09 16:41:11,280 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:41:11 INFO - 2015-11-09 16:41:11,280 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,944 16:41:11 INFO - 2015-11-09 16:41:11,280 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:41:11 INFO - 2015-11-09 16:41:11,281 DEBUG : BROWSER_OUTPUT: __startTimestamp1447116071272__endTimestamp 16:41:11 INFO - 2015-11-09 16:41:11,281 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,281 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:41:11 INFO - 2015-11-09 16:41:11,281 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:41:11 INFO - 2015-11-09 16:41:11,281 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,282 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:121.90 Median:125.00 stddev:5.28 (4.2%) stddev-sans-first:5.41 16:41:11 INFO - 2015-11-09 16:41:11,282 DEBUG : BROWSER_OUTPUT: Values: 118.0 126.0 121.0 128.0 124.0 121.0 116.0 126.0 127.0 112.0 16:41:11 INFO - 2015-11-09 16:41:11,282 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,282 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:165.40 Median:174.00 stddev:16.87 (9.7%) stddev-sans-first:17.26 16:41:11 INFO - 2015-11-09 16:41:11,282 DEBUG : BROWSER_OUTPUT: Values: 178.0 151.0 176.0 185.0 149.0 172.0 169.0 140.0 186.0 148.0 16:41:11 INFO - 2015-11-09 16:41:11,282 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,282 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:184.50 Median:186.00 stddev:2.51 (1.3%) stddev-sans-first:2.49 16:41:11 INFO - 2015-11-09 16:41:11,283 DEBUG : BROWSER_OUTPUT: Values: 182.0 187.0 186.0 182.0 186.0 185.0 181.0 186.0 188.0 182.0 16:41:11 INFO - 2015-11-09 16:41:11,283 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,283 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.70 Median:89.50 stddev:7.72 (8.6%) stddev-sans-first:8.14 16:41:11 INFO - 2015-11-09 16:41:11,283 DEBUG : BROWSER_OUTPUT: Values: 90.0 87.0 98.0 99.0 78.0 81.0 83.0 89.0 94.0 78.0 16:41:11 INFO - 2015-11-09 16:41:11,283 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,283 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:118.80 Median:110.50 stddev:21.93 (19.8%) stddev-sans-first:23.03 16:41:11 INFO - 2015-11-09 16:41:11,283 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 155.0 103.0 105.0 103.0 143.0 102.0 104.0 152.0 16:41:11 INFO - 2015-11-09 16:41:11,284 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,284 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:136.20 Median:136.00 stddev:4.69 (3.4%) stddev-sans-first:4.95 16:41:11 INFO - 2015-11-09 16:41:11,284 DEBUG : BROWSER_OUTPUT: Values: 135.0 136.0 136.0 136.0 142.0 134.0 129.0 142.0 142.0 130.0 16:41:11 INFO - 2015-11-09 16:41:11,284 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,284 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:147.00 stddev:2.91 (2.0%) stddev-sans-first:2.92 16:41:11 INFO - 2015-11-09 16:41:11,285 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 144.0 141.0 147.0 147.0 144.0 140.0 148.0 147.0 16:41:11 INFO - 2015-11-09 16:41:11,285 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,285 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:117.50 Median:118.00 stddev:1.90 (1.6%) stddev-sans-first:2.01 16:41:11 INFO - 2015-11-09 16:41:11,285 DEBUG : BROWSER_OUTPUT: Values: 117.0 117.0 118.0 117.0 117.0 113.0 119.0 120.0 118.0 119.0 16:41:11 INFO - 2015-11-09 16:41:11,285 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,286 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:67.10 Median:66.50 stddev:3.38 (5.1%) stddev-sans-first:3.40 16:41:11 INFO - 2015-11-09 16:41:11,286 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 68.0 68.0 67.0 66.0 66.0 76.0 66.0 65.0 16:41:11 INFO - 2015-11-09 16:41:11,286 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,286 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:77.20 Median:77.50 stddev:2.94 (3.8%) stddev-sans-first:2.69 16:41:11 INFO - 2015-11-09 16:41:11,286 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 77.0 80.0 79.0 78.0 76.0 76.0 76.0 83.0 16:41:11 INFO - 2015-11-09 16:41:11,286 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,286 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:99.90 Median:101.00 stddev:1.73 (1.7%) stddev-sans-first:1.83 16:41:11 INFO - 2015-11-09 16:41:11,287 DEBUG : BROWSER_OUTPUT: Values: 100.0 100.0 100.0 100.0 102.0 101.0 96.0 98.0 101.0 101.0 16:41:11 INFO - 2015-11-09 16:41:11,287 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,288 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:150.00 stddev:4.60 (3.1%) stddev-sans-first:4.57 16:41:11 INFO - 2015-11-09 16:41:11,288 DEBUG : BROWSER_OUTPUT: Values: 144.0 143.0 147.0 148.0 144.0 152.0 156.0 152.0 154.0 146.0 16:41:11 INFO - 2015-11-09 16:41:11,288 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,288 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.40 Median:179.50 stddev:5.23 (2.9%) stddev-sans-first:4.58 16:41:11 INFO - 2015-11-09 16:41:11,289 DEBUG : BROWSER_OUTPUT: Values: 168.0 174.0 171.0 179.0 180.0 171.0 181.0 176.0 180.0 184.0 16:41:11 INFO - 2015-11-09 16:41:11,289 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,289 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.50 Median:85.00 stddev:1.84 (2.2%) stddev-sans-first:1.72 16:41:11 INFO - 2015-11-09 16:41:11,289 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 85.0 85.0 85.0 85.0 84.0 81.0 83.0 85.0 16:41:11 INFO - 2015-11-09 16:41:11,289 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:41:11 INFO - 2015-11-09 16:41:11,289 DEBUG : BROWSER_OUTPUT: 16:41:11 INFO - 2015-11-09 16:41:11,971 INFO : Browser exited with error code: 0 16:41:12 INFO - 2015-11-09 16:41:12,024 INFO : Completed test kraken (00:01:01) 16:41:12 INFO - 2015-11-09 16:41:12,025 INFO : Starting test v8_7 16:41:12 INFO - 2015-11-09 16:41:12,025 DEBUG : operating with platform_type : mac_ 16:41:12 INFO - 2015-11-09 16:41:12,025 INFO : Initialising browser for v8_7 test... 16:41:12 INFO - 2015-11-09 16:41:12,039 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/tmpisopbU/profile http://localhost:49265/getInfo.html 16:41:14 INFO - 2015-11-09 16:41:14,654 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:41:14 INFO - 2015-11-09 16:41:14,654 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:41:14 INFO - 2015-11-09 16:41:14,654 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:41:14 INFO - 2015-11-09 16:41:14,654 DEBUG : BROWSER_OUTPUT: __metrics 16:41:14 INFO - 2015-11-09 16:41:14,673 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:41:15 INFO - 2015-11-09 16:41:15,402 INFO : Browser initialized. 16:41:15 INFO - 2015-11-09 16:41:15,402 INFO : Running cycle 1/1 for v8_7 test... 16:41:15 INFO - 2015-11-09 16:41:15,402 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/tmpisopbU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:41:27 INFO - 2015-11-09 16:41:27,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 229466112 16:41:27 INFO - 2015-11-09 16:41:27,595 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49265/tests/v8_7/run.html (next: http://localhost:49265/tests/v8_7/run.html) 16:41:50 INFO - 2015-11-09 16:41:50,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 613314560 16:41:50 INFO - 2015-11-09 16:41:50,741 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,742 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:41:50 INFO - 2015-11-09 16:41:50,742 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:41:50 INFO - 2015-11-09 16:41:50,742 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:41:50 INFO - 2015-11-09 16:41:50,742 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:41:50 INFO - 2015-11-09 16:41:50,742 DEBUG : BROWSER_OUTPUT: |0;Richards;192.75250578257518 16:41:50 INFO - 2015-11-09 16:41:50,742 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;227.7385561375541 16:41:50 INFO - 2015-11-09 16:41:50,742 DEBUG : BROWSER_OUTPUT: |2;Encrypt;365.6307129798903 16:41:50 INFO - 2015-11-09 16:41:50,743 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6435.897435897436 16:41:50 INFO - 2015-11-09 16:41:50,743 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2192.9824561403507 16:41:50 INFO - 2015-11-09 16:41:50,743 DEBUG : BROWSER_OUTPUT: |5;Earley;905.7971014492754 16:41:50 INFO - 2015-11-09 16:41:50,743 DEBUG : BROWSER_OUTPUT: |6;Boyer;14838.235294117647 16:41:50 INFO - 2015-11-09 16:41:50,743 DEBUG : BROWSER_OUTPUT: |7;RegExp;33064.51612903226 16:41:50 INFO - 2015-11-09 16:41:50,743 DEBUG : BROWSER_OUTPUT: |8;Splay;753.0120481927711 16:41:50 INFO - 2015-11-09 16:41:50,743 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6578.9473684210525 16:41:50 INFO - 2015-11-09 16:41:50,743 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:41:50 INFO - 2015-11-09 16:41:50,743 DEBUG : BROWSER_OUTPUT: __startTimestamp1447116110735__endTimestamp 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:192.75 Median:192.75 stddev:0.00 (0.0%) 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: Values: 192.8 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:227.74 Median:227.74 stddev:0.00 (0.0%) 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: Values: 227.7 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:365.63 Median:365.63 stddev:0.00 (0.0%) 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: Values: 365.6 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,744 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6435.90 Median:6435.90 stddev:0.00 (0.0%) 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: Values: 6435.9 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2192.98 Median:2192.98 stddev:0.00 (0.0%) 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: Values: 2193.0 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:905.80 Median:905.80 stddev:0.00 (0.0%) 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: Values: 905.8 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14838.24 Median:14838.24 stddev:0.00 (0.0%) 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: Values: 14838.2 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33064.52 Median:33064.52 stddev:0.00 (0.0%) 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: Values: 33064.5 16:41:50 INFO - 2015-11-09 16:41:50,745 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,746 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:753.01 Median:753.01 stddev:0.00 (0.0%) 16:41:50 INFO - 2015-11-09 16:41:50,746 DEBUG : BROWSER_OUTPUT: Values: 753.0 16:41:50 INFO - 2015-11-09 16:41:50,746 DEBUG : BROWSER_OUTPUT: 16:41:50 INFO - 2015-11-09 16:41:50,746 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6578.95 Median:6578.95 stddev:0.00 (0.0%) 16:41:50 INFO - 2015-11-09 16:41:50,746 DEBUG : BROWSER_OUTPUT: Values: 6578.9 16:41:50 INFO - 2015-11-09 16:41:50,746 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:41:50 INFO - 2015-11-09 16:41:50,746 DEBUG : BROWSER_OUTPUT: 16:41:51 INFO - 2015-11-09 16:41:51,488 INFO : Browser exited with error code: 0 16:41:51 INFO - 2015-11-09 16:41:51,510 INFO : Completed test v8_7 (00:00:39) 16:41:51 INFO - 2015-11-09 16:41:51,967 INFO : Completed test suite (00:20:18) 16:41:51 INFO - 2015-11-09 16:41:51,967 DEBUG : Working with test: dromaeo_css 16:41:51 INFO - 2015-11-09 16:41:51,967 DEBUG : Generating results file: dromaeo_css 16:41:51 INFO - 2015-11-09 16:41:51,968 DEBUG : Working with test: kraken 16:41:51 INFO - 2015-11-09 16:41:51,968 DEBUG : Generating results file: kraken 16:41:51 INFO - 2015-11-09 16:41:51,968 INFO : javascript benchmark 16:41:51 INFO - 2015-11-09 16:41:51,969 DEBUG : Working with test: v8_7 16:41:51 INFO - 2015-11-09 16:41:51,969 DEBUG : Generating results file: v8_7 16:41:51 INFO - 2015-11-09 16:41:51,969 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:41:52 INFO - 2015-11-09 16:41:52,111 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 16:41:52 INFO - 2015-11-09 16:41:52,111 DEBUG : process_Request line: dromaeo_css 5861.57 graph.html#tests=[[72,64,55]] 16:41:52 INFO - 2015-11-09 16:41:52,111 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:41:52 INFO - 2015-11-09 16:41:52,139 DEBUG : process_Request line: kraken 1730.00 graph.html#tests=[[232,64,55]] 16:41:52 INFO - 2015-11-09 16:41:52,139 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:41:52 INFO - 2015-11-09 16:41:52,170 DEBUG : process_Request line: v8_7 16219.68 graph.html#tests=[[230,64,55]] 16:41:52 INFO - 2015-11-09 16:41:52,170 INFO : javascript benchmark 16:41:52 INFO - 2015-11-09 16:41:52,172 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [291.19049043658623, 291.56702297088805, 296.8664101154481, 297.33842201102544, 304.2409189073262, 12161.0, 12975.545855895021, 14788.55634330969, 14916.328765205564, 15493.535193944186, 13379.59861204163, 14900.329485173166, 15175.620609484768, 15208.087514749122, 15402.84597154028, 4544.250198717207, 4571.291449825282, 4698.08387364464, 4703.129920964615, 4721.952780472186, 3395.4906763985355, 3535.3636345457808, 3538.2215912499337, 4638.049199914027, 4688.390509233812, 4942.950570494285, 5060.0, 5087.414947281054, 5092.541671249587, 5104.872378190538, 4957.752112394366, 5074.949250507521, 5092.439831618519, 5116.334876466073, 5119.1809310510325, 4357.803898824561, 4422.0, 4422.6682998774895, 4429.3798868158165, 4430.844920427802, 18102.366417175337, 18203.27186912522, 18320.45038648843, 18320.816791832043, 18531.44405667832, 1783.8037815840248, 1826.75338829259, 1841.1898764543557, 1851.7037274036225, 2117.2272120676, 7768.124042458685, 11435.428228588537, 11754.529818807237, 12147.757044859141, 12238.694032649166, 1367.7743172376545, 1372.19726460021, 1389.603962870577, 1394.198335956829, 1452.8038714773477, 47584.76207618974, 49969.25415068992, 49998.0, 50188.24717629238, 50198.74900625474, 5620.241267428926, 5660.603757736919, 5688.488036076773, 5691.231683722644, 5709.05800542914, 6443.613383197023, 6499.707513161919, 6503.28463868974, 6512.544121911421, 6527.771527996592, 4721.220998535272, 4797.472278049481, 4806.49531799163, 4816.036792641416, 4835.588974937099, 5132.743362831843, 5151.716655583904, 5155.355580552431, 5182.896342073137, 5184.818531351385, 2517.0, 2524.886380112899, 2537.8096642751866, 2562.551553478134, 2568.4477837264703, 868.4919322196586, 885.7431344909904, 893.7542175901679, 937.4656445825814, 945.2060269373759, 269.64003055920176, 394.8144372145087, 398.7726995612473, 401.54424727934, 404.4176386004145, 9257.351985361094, 10051.346662466916, 10205.87735349111, 10287.485625718684, 10310.32982856112, 374.65344556285874, 387.2699960574338, 393.2665578695712, 400.62141276493435, 402.5250204758413, 5363.195520671852, 5368.32895888014, 5417.377001644862, 5448.43972440342, 5484.670919744828, 510911.0, 514472.0, 517592.0, 521693.0, 547412.0, 46929.0, 63309.0, 63853.68073159605, 64927.0, 65034.34965650283, 426.5606425381862, 430.78676055352173, 431.4606741572971, 431.90929904719735, 432.16160648342117, 9556.808863822545, 9698.75753106178, 9734.172595329477, 9738.902610973799, 9817.0, 28122.156335309974, 29071.56392654154, 29217.41565168727, 29414.0, 30932.845335773178, 37627.0, 37942.2411551773, 38354.232915342094, 38396.0, 38853.41719874261, 5177.456367081553, 5476.6166368355425, 5485.61600687948, 5488.807891723771, 5500.257465242141, 10097.747556311151, 10205.285630005828, 10323.63867264642, 10451.843222351823, 10482.37105773656, 8457.87313190315, 8947.507887066013, 9044.864327034968, 9073.047330030517, 9076.455412675261, 8554.0, 8562.657493700432, 8684.261837743863, 8734.737957861274, 8762.649494020168, 8751.824963500821, 8963.327750418614, 9000.0, 9010.639574417211, 9092.545372731469, 5408.37803652585, 5410.296661433988, 5410.3507579090765, 5421.241026256248, 5427.83716488506, 8593.226609605166, 8651.91348086511, 8928.86606700887, 9003.954980225057, 9006.189442949904], "dojo.html": [2758.5724212747027, 2770.5290100682882, 2784.22041828288, 2803.313188268873, 2834.5464725643897, 4586.1744885920525, 4601.838935637249, 4694.413198350207, 4700.388949436573, 4716.198246298129, 4672.929906051412, 4684.110019096369, 4706.599939005188, 4720.999999999992, 4842.564169224769, 4391.429114215148, 4395.714278571899, 4497.190505708987, 4507.774611269439, 4613.584777370036, 4545.659075569329, 4547.204239258133, 4594.218982772936, 4613.261878099504, 4640.0, 4294.334378171373, 4358.36803663467, 4410.867673969786, 4418.4256046714045, 4494.70784399013, 4461.776911154429, 4486.955130448687, 4491.146682130385, 4496.100779844011, 4543.750093744843, 4462.866114016585, 4464.151811155903, 4464.531224221442, 4484.977575112103, 4546.363509108694, 4602.401687780601, 4618.468876079261, 4641.3270075839155, 4735.928961065587, 4784.378030855966, 5032.0, 5044.344235249431, 5053.292539044537, 5060.721660308682, 5106.821261255838, 5099.0, 5106.744662766847, 5107.897842043139, 5113.437521872591, 5145.459726728677, 4528.592426681615, 4617.984043510422, 4621.607163391116, 4636.374089497942, 4777.355057067321, 5084.898302033938, 5123.0, 5135.897282054338, 5139.460356662496, 5143.97428012865, 4962.082014827269, 4966.205407134841, 4976.0794253063295, 4976.104301225741, 5028.673136246132, 4822.9758851205515, 4922.655414120977, 4935.111679897581, 5056.6207534434325, 5168.9741551292, 4937.654364194544, 4975.10448119342, 4982.501749825061, 4991.875203119951, 5021.221710634857, 4963.8262660806695, 4971.055499455092, 4991.3511243538105, 4993.076280888047, 5051.974740126276, 3840.807959602065, 3895.182011777502, 3929.5088113985753, 3944.290027794967, 4005.6394924456354, 3589.623089575557, 3611.5846677631885, 3612.7290453215587, 3633.4549817527054, 3654.616265292106, 4483.14820184164, 4733.834315798999, 4739.668223224341, 4750.501197374295, 4789.209780386197, 4928.383952005999, 4986.601071914238, 4989.900201996013, 5008.198688209942, 5033.874153146201, 4711.387519622427, 4737.407824021997, 4742.075295317449, 4744.264638980963, 4749.572538471554, 4324.070324880166, 4477.619402350771, 4478.417805685305, 4488.551144885485, 4555.043440877453, 5050.72221027847, 5071.492850714899, 5076.18780995039, 5127.46161653021, 5189.351331083614, 5054.4187418447345, 5075.213341932006, 5081.33942587476, 5085.452271779973, 5136.743162841918, 5052.469490703424, 5168.121419358793, 5176.7152806594495, 5185.455527169593, 5196.064708352382, 4954.5540901319055, 4961.454240033666, 4966.006798640215, 4974.825881094144, 5016.6237532184505, 5030.748462576929, 5043.4956504349275, 5064.898702026013, 5066.189409694432, 5090.949090509048, 4718.41019872516, 4925.38432695913, 4951.9752401237765, 4963.879621941804, 4989.176785830443, 4838.879028024327, 4839.177339852163, 4851.902961940671, 4880.048390563806, 4937.1113199624415, 4805.711657300573, 4813.133635945564, 4816.95183048165, 4827.8551643450755, 4838.491958344464, 4792.305115758265, 4916.82791102324, 4931.038447502702, 4941.407031156141, 4953.975230123826, 4744.857654270378, 4780.426348838162, 4788.832390866303, 4800.135975524439, 4877.9024419512125], "mootools.html": [1099.2140619457086, 1220.0178856020902, 1276.3107921722267, 1299.9740005199897, 1503.8872084593659, 6618.040384144296, 6774.119364482616, 6814.182298124219, 7191.460640451974, 7214.819629509252, 6961.234264230943, 7035.2612975637585, 7041.014258003884, 7047.541909775861, 7077.64611769412, 1893.905304734761, 1923.3172223860538, 1927.2772710233662, 1929.4018854155186, 1939.224310275894, 1920.395075551204, 1941.5825597496535, 1942.9902850485798, 1977.5056235941015, 1982.108051376879, 1954.8142926421967, 1958.4516335426104, 1959.549303660159, 1962.3720409468976, 1963.0283009910115, 1872.4850666066804, 1876.5402476393235, 1880.5580688538182, 1881.8118188181209, 1888.1408958923726, 1844.7232915062848, 1855.944321670352, 1867.5797945462161, 1915.955804086762, 1923.307609260665, 6277.937220627781, 7036.577805331696, 7055.470839687044, 7060.435165186773, 7070.823229419254, 3828.5788563258297, 3931.4495970564144, 4113.197926404352, 4189.015581338383, 4204.1801848639525, 2563.4104156044027, 2578.3425226567106, 2616.3459135216194, 2616.659834221539, 2617.0316982716326, 720.5172534401963, 852.0925214646381, 877.8727084572765, 879.0046594231123, 880.7357792662176, 8309.210624990616, 8352.373571982065, 8388.958055209747, 8429.70496032642, 8471.534065626389, 3798.164403831153, 3810.5617853946596, 3891.3968334908136, 3893.8637147699696, 3906.882793516199, 8256.215659512336, 8270.875936860952, 8277.710280140167, 8299.875501867476, 8312.25189732927, 4373.190959672471, 4375.518692943773, 4377.343398490252, 4387.736735795863, 4390.604845563915, 3962.9603703963166, 3964.8810535683397, 3983.8605648802154, 3991.3613821788376, 3993.6405723484445, 3113.517404802214, 3128.6402063762503, 3139.0, 3153.6373317068833, 3165.4014722564957, 1000.4697510319543, 1001.639409812467, 1007.5667462990984, 1012.2307046644603, 1016.1362841584742, 1117.9664610061711, 1123.0510218865045, 1150.7583407484356, 1152.8904754048351, 1161.285809227336, 6643.900341494881, 6666.033425153326, 6693.029510720919, 6720.260771315151, 6726.058351830748, 406.82913176465956, 407.6107317511769, 412.140686668294, 412.9009037830899, 413.04792453395214, 5239.711815850089, 5271.710055946883, 5275.683458992473, 5285.339332583427, 5303.4696530346655, 8196.918030819736, 8278.461899976483, 8445.113263107409, 8476.618552165168, 8491.830163396697, 8394.496330220207, 8407.2433480987, 8417.28453081495, 8442.451240669337, 8443.66225350979, 6244.7814326499265, 6572.375624315682, 6613.768518101843, 6640.402363787282, 6672.466202703772, 6495.285518593046, 6650.501212408992, 6656.633885136364, 6661.533692641468, 6698.899516507354, 7539.811504712426, 7608.391328693802, 7658.846823063396, 7667.11828139771, 7685.846283074419, 7467.365273951775, 7710.961445192738, 7749.612519373896, 7815.882761758692, 7859.84280314402, 6235.875282494416, 6292.119103325446, 6304.5586808922935, 6316.684165791784, 6332.810015699536, 6347.523935704933, 6652.467802575686, 6672.432843208382, 6677.232118306457, 6777.728890844311, 6013.428724271187, 6209.5032397409, 6213.099100630474, 6352.841178970378, 6359.236891572856, 5857.619254748428, 5946.910796338145, 6134.4172303631085, 6284.0, 6288.654124023223, 6272.905906411316, 6318.210223722035, 6381.234251889803, 6387.808365749035, 6453.322401147811, 5708.4862362387585, 5820.883582328414, 5825.737841797214, 5836.766529338949, 5837.211976383134, 5777.6822274775295, 5815.04051831443, 5819.854503637443, 5826.0, 5860.970695146668], "ext.html": [492.286185031704, 495.417883986316, 498.29242475684526, 506.60231718101284, 515.2914742229434, 27358.0, 28597.14208573741, 34414.8279258604, 34938.8253058735, 34962.65037349626, 38027.23945521088, 38352.23295534088, 38465.615343846555, 38508.229835403276, 38541.229175416476, 7352.41180705545, 8080.959595202015, 8315.251627353537, 8336.874946875801, 8343.207395297437, 7410.925890741104, 9730.610775569005, 9919.454430006346, 9932.950335248313, 9935.751606209866, 9597.808043839119, 9733.56198971048, 9790.706278811647, 9793.510324483783, 9815.460149691764, 7530.397568194531, 7645.426593005547, 9726.9513652432, 9850.40897546146, 9854.556544955494, 9526.14264716172, 9663.806723865553, 9668.323217374787, 9677.080677335642, 9687.806243875082, 35465.82267088674, 35946.64053359459, 35980.82009589962, 35995.460068099, 36364.81817590922, 2534.822562420631, 2626.5272250994813, 2662.4541968896524, 2683.1950414875655, 3093.072078376478, 24838.503229935483, 24938.251852444457, 24950.875245623836, 25343.364274214357, 25568.360790980187, 2182.4216582605623, 2199.197292988048, 2203.019656252968, 2204.0, 2204.382772823612, 237240.0, 238174.0, 238934.0, 239707.0, 241043.0, 54326.728366357915, 54664.0, 54667.179992300145, 54688.0, 54766.45233547613, 47478.0, 48595.5140448598, 49055.64165375151, 62000.0, 63637.36362636314, 14716.33776480061, 14733.189674568002, 14838.441963593883, 14840.406383744745, 14849.851501484847, 11066.39134847591, 11190.0, 11228.438578071064, 11251.324920504632, 11348.092152627934, 17304.480865574053, 17345.7398139028, 17371.392001279895, 17442.738358924627, 17453.0, 7177.138743350832, 7320.341169294789, 7364.594947277844, 7409.962950185214, 7448.318605302087, 793.4089103617841, 980.1032055668983, 980.5881529757519, 1008.0927165550917, 1012.0688966151158, 24417.145399910918, 24866.37834054127, 24942.625860612105, 25083.62374564383, 25122.37194070163, 917.3486824354783, 919.429953428865, 939.9530023498935, 1005.7234260578253, 1041.7291504208808, 13374.0, 13672.17966921968, 13766.724665506634, 13774.65563360924, 13812.654683632789, 411350.0, 417035.0, 417704.0, 417793.0, 422693.0, 50410.747946260766, 50536.49463505392, 50557.0, 50600.24099638508, 51242.23136652953, 1162.540796385423, 1238.9566365177175, 1239.39269757818, 1252.9122961392798, 1255.0900597067052, 26876.0, 27153.0, 27581.172564823086, 27682.0, 27877.86061069682, 39251.607483924796, 39981.40027899526, 44381.33427998518, 45069.32396013997, 45098.54901450944, 246759.0, 248830.0, 250917.0, 253863.0, 255645.0, 24246.15138470145, 24663.136790212255, 28864.0, 29186.854065729534, 29523.557146642386, 29709.702902970694, 35944.0, 36551.45172822357, 36587.45118823273, 37805.62194378131, 28016.579751304154, 29089.563656545593, 29225.85387073136, 29381.26546836346, 29481.410371792874, 28554.0, 28752.0, 29955.251118721335, 30403.695963040085, 31164.53253201249, 31459.0, 31579.526307104952, 31676.683233168296, 31704.0, 34872.0, 28303.433931320847, 28879.85560072186, 28913.132606021853, 28951.276218094717, 29201.415971680024, 21508.67736983915, 21852.344429667137, 21876.23433179831, 21908.12367505282, 21977.890110549346], "prototype.html": [268.87228566430946, 275.36803037030006, 277.64045560998517, 282.66786525832157, 287.5399361022366, 5257.500537448946, 5338.439463856293, 5340.759665815038, 5342.385625653051, 5371.89256214876, 5266.183741520071, 5276.314079169702, 5285.841424757264, 5303.416624171338, 5347.197920311955, 4183.351580505011, 4189.266878296301, 4194.496660400756, 4195.811188496525, 4199.202151591203, 3988.5413177484525, 4075.3886916962547, 4084.6732261419165, 4171.395147703596, 4210.031692710679, 4055.1078762672164, 4085.9182816343805, 4113.9177216455655, 4130.628243458088, 4151.439555659993, 4113.6297733203855, 4127.772972486512, 4131.97934010331, 4135.66914646829, 4137.97931010346, 3394.0, 3428.177237463016, 3442.019024578008, 3501.3347463981763, 3579.0, 5129.563987061104, 5135.614828887811, 5136.614753893473, 5148.974255128738, 5173.534381905609, 4548.954510454886, 4558.8632341029825, 4569.314602809605, 4570.702904311209, 4583.220852455091, 5492.725363731797, 5501.642393244426, 5506.476884695948, 5520.779168833242, 5526.309211348582, 3644.9271014579826, 3714.851405943759, 3733.2906747718116, 3736.551613806361, 3818.045488627843, 5581.609287349887, 5683.744231509592, 5738.885222295531, 5752.108423194411, 5756.798512052058, 3782.0355809268463, 3787.0, 3788.4696142540065, 3789.6020917803785, 3790.7915064671706, 3812.1803812180515, 3821.5796262411113, 3833.5399752029934, 3836.808159592065, 3857.189990102054, 4402.459139301219, 4522.3668686383935, 4529.8641040768825, 4534.342520334599, 4536.092781443658, 5585.078462053797, 5597.272354593958, 5598.832035038955, 5612.0, 5624.0, 1349.9932500337632, 1369.7808350664045, 1371.5542448704211, 1372.1698372484702, 1374.202962281874, 850.2560259772699, 864.8443280209623, 874.3486102853415, 874.5845723281391, 885.2784980241083, 5285.762140703678, 5301.204819277139, 5303.098473259555, 5307.124324486494, 5310.867228319323, 5795.333536643256, 5796.536277097906, 5808.651480911159, 5811.88376232473, 5829.591928565044, 5290.1800220965815, 5300.178472336794, 5305.761240744176, 5316.973415132899, 5385.111456609616, 3103.224193951512, 3159.8262095584505, 3195.5046967719577, 3207.4547326954475, 3212.3093534890113, 5753.568482363839, 5830.300363956352, 5832.358440571534, 5847.0, 5958.940410595926, 5882.735276912464, 5921.526277897758, 5941.55438342126, 5942.70286485674, 5980.342162362137, 5873.236479257755, 5892.1161825726485, 5895.882082358415, 5904.52763778888, 5905.940940590539, 5562.638428502134, 5767.279090113736, 5776.133579962871, 5784.913226301524, 5797.449242321973, 5645.858853528531, 5728.656280623176, 5730.5129064030025, 5742.942570574241, 5764.106563482667, 5932.347441781487, 5938.73275702603, 5941.821745347646, 5945.791897283574, 5980.401959803985, 3728.7762734236035, 3806.4670946067017, 3819.751716138442, 3819.942700859434, 3825.12022234882, 5634.971825140848, 5835.94164058354, 5838.12428135783, 5844.795432159854, 5865.706714664165, 5627.8874422512135, 5652.095664693629, 5663.292088488939, 5671.17767923657, 5686.431356864446, 5646.0, 5662.716864156693, 5666.093425051972, 5667.688277144796, 5669.971650141723, 5524.723763811713, 5540.91688624679, 5550.0564903965615, 5553.055980483408, 5561.555075594024, 5651.124075768263, 5670.234518340137, 5671.376148623731, 5693.459121383462, 5710.343310519177, 5585.832425027255, 5588.692621905834, 5591.04952158126, 5593.300837395325, 5611.915821262603], "yui.html": [557.612459340758, 574.0642752313728, 622.4895585619794, 642.5919541091408, 663.6681659170414, 11886.7622647547, 12165.270083794956, 12181.086418518624, 12181.57364492243, 12239.265644061352, 11168.441577921112, 11837.348945807977, 12200.755984880298, 12207.816882746743, 12223.755524889497, 594.8929192745326, 728.3808762551828, 746.8020974441778, 748.4050180106829, 748.5583505731618, 586.2671660424469, 596.7791916990719, 736.7642354446552, 747.3386053342804, 747.8130467383154, 749.0, 760.3840888879997, 762.8931949527071, 763.1185980192859, 764.4610549562545, 617.0990354083, 622.5704264057786, 757.6704133701858, 762.3596179209491, 762.3634265388407, 572.6249306704116, 581.8719881626035, 582.5194214772829, 583.0030647592622, 584.0684108846383, 12140.392980350947, 12230.877691223062, 12245.02039836811, 12253.142280040402, 12305.384730763426, 10057.547410366478, 10079.44563049032, 10232.0, 10596.682099537025, 10731.570737170503, 7661.846763064707, 8091.312238459738, 8346.916530834675, 8510.0, 8656.653733850639, 2885.422915416925, 2945.366746149588, 2966.777491688132, 2979.6722360540325, 3000.5499175123687, 42771.57228427707, 42817.0, 43573.0, 43678.344824827655, 43987.34018989718, 8159.95920020408, 8168.059364253011, 8195.754127376189, 8276.255137037695, 8296.377771667148, 17192.22634981429, 17204.65590688179, 17219.741703874453, 17225.483235502954, 17328.046957417464, 5944.851378715567, 6007.369226231182, 6052.546059045501, 6079.513638908877, 6337.7781777637565, 3201.8879339223017, 3202.615686117681, 3215.5498230247786, 3299.9175020624198, 3314.4531152360073, 2599.4541146359097, 2654.349684327352, 2658.667666541682, 2659.8670066496597, 2663.0, 383.390409249295, 386.03683808896983, 400.661441082285, 401.17358242021527, 401.28170574671594, 400.4713777813317, 470.36970459583637, 509.92860999460106, 521.116707181324, 544.9373322067934, 6978.0400195022285, 7017.543859649107, 7061.682224299919, 7160.176579693298, 7294.0, 435.8627032484757, 444.45776153093175, 471.4837253207732, 554.0774610273929, 557.3952261795997, 3393.7794043387103, 3412.9658703413143, 3416.145963509123, 3450.292689998544, 3495.702865256431, 50836.0, 51671.48328516742, 52249.47750522446, 52415.73792131015, 52419.0, 44504.77747611306, 44527.109457810664, 44855.0, 45092.3236151458, 45164.77417612891, 39070.60929390726, 39949.0, 40659.796701016894, 40781.1843763129, 40954.0, 6802.591844489347, 6978.0, 7395.927590499455, 7570.394368450621, 7596.772096837104, 30807.38385232238, 30938.690613093582, 31271.374572508877, 31704.682953170173, 32152.678473214968, 36784.26431471302, 37014.25971480609, 41051.0, 41085.0, 41545.0, 6540.967295163494, 6592.208934927839, 6640.273528882622, 6659.53383263167, 6763.0, 9587.904120958701, 9649.807003860024, 9725.367851089657, 9872.703818885446, 10225.74435639115, 8795.076516965626, 8835.028146903964, 8925.0, 8957.955210223907, 9558.044195580387, 9012.549372531215, 9040.41237319572, 9203.263738900738, 9210.631574736935, 9907.256955728493, 6540.5222763913325, 8336.833263334578, 8997.775055623662, 9509.857352139585, 9559.330846840932, 7714.6914123434435, 7933.484323519184, 7936.404769642415, 8006.739579075411, 8439.70461033861, 7468.365188958999, 7841.176676448891, 7863.0, 7942.364610831235, 8023.799405014921]}, "summary": {"lowerIsBetter": false, "suite": 5861.567064757173, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6072.0077199412, "unit": "ms", "value": 6072.0077199412}, "dojo.html": {"lowerIsBetter": false, "filtered": 4676.389663681743, "unit": "ms", "value": 4676.389663681743}, "mootools.html": {"lowerIsBetter": false, "filtered": 3874.639700821818, "unit": "ms", "value": 3874.639700821818}, "ext.html": {"lowerIsBetter": false, "filtered": 16802.77856423707, "unit": "ms", "value": 16802.77856423707}, "prototype.html": {"lowerIsBetter": false, "filtered": 4188.567974880158, "unit": "ms", "value": 4188.567974880158}, "yui.html": {"lowerIsBetter": false, "filtered": 5237.415843968237, "unit": "ms", "value": 5237.415843968237}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0106"}, "testrun": {"date": 1447114893, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151109153630", "branch": "Fx-Team", "revision": "68a879c220d8c777e165ab9df5c1a6a4a3c703f2"}}, {"talos_counters": {}, "results": {"audio-dft": [182.0, 187.0, 186.0, 182.0, 186.0, 185.0, 181.0, 186.0, 188.0, 182.0], "ai-astar": [118.0, 126.0, 121.0, 128.0, 124.0, 121.0, 116.0, 126.0, 127.0, 112.0], "imaging-gaussian-blur": [135.0, 136.0, 136.0, 136.0, 142.0, 134.0, 129.0, 142.0, 142.0, 130.0], "audio-beat-detection": [178.0, 151.0, 176.0, 185.0, 149.0, 172.0, 169.0, 140.0, 186.0, 148.0], "json-stringify-tinderbox": [73.0, 74.0, 77.0, 80.0, 79.0, 78.0, 76.0, 76.0, 76.0, 83.0], "stanford-crypto-pbkdf2": [168.0, 174.0, 171.0, 179.0, 180.0, 171.0, 181.0, 176.0, 180.0, 184.0], "json-parse-financial": [64.0, 65.0, 68.0, 68.0, 67.0, 66.0, 66.0, 76.0, 66.0, 65.0], "stanford-crypto-sha256-iterative": [81.0, 81.0, 85.0, 85.0, 85.0, 85.0, 84.0, 81.0, 83.0, 85.0], "audio-fft": [90.0, 87.0, 98.0, 99.0, 78.0, 81.0, 83.0, 89.0, 94.0, 78.0], "imaging-darkroom": [148.0, 147.0, 144.0, 141.0, 147.0, 147.0, 144.0, 140.0, 148.0, 147.0], "stanford-crypto-ccm": [144.0, 143.0, 147.0, 148.0, 144.0, 152.0, 156.0, 152.0, 154.0, 146.0], "audio-oscillator": [110.0, 111.0, 155.0, 103.0, 105.0, 103.0, 143.0, 102.0, 104.0, 152.0], "stanford-crypto-aes": [100.0, 100.0, 100.0, 100.0, 102.0, 101.0, 96.0, 98.0, 101.0, 101.0], "imaging-desaturate": [117.0, 117.0, 118.0, 117.0, 117.0, 113.0, 119.0, 120.0, 118.0, 119.0]}, "summary": {"lowerIsBetter": true, "suite": 1730.0, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 87.7, "unit": "ms", "value": 87.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 176.4, "unit": "ms", "value": 176.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 165.4, "unit": "ms", "value": 165.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 148.6, "unit": "ms", "value": 148.6}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.3, "unit": "ms", "value": 145.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 67.1, "unit": "ms", "value": 67.1}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 118.8, "unit": "ms", "value": 118.8}, "ai-astar": {"lowerIsBetter": true, "filtered": 121.9, "unit": "ms", "value": 121.9}, "audio-dft": {"lowerIsBetter": true, "filtered": 184.5, "unit": "ms", "value": 184.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 83.5, "unit": "ms", "value": 83.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 77.2, "unit": "ms", "value": 77.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 136.2, "unit": "ms", "value": 136.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 99.9, "unit": "ms", "value": 99.9}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 117.5, "unit": "ms", "value": 117.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0106"}, "testrun": {"date": 1447114893, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151109153630", "branch": "Fx-Team", "revision": "68a879c220d8c777e165ab9df5c1a6a4a3c703f2"}}, {"talos_counters": {}, "results": {"DeltaBlue": [227.7385561375541], "Encrypt": [365.6307129798903], "NavierStokes": [6578.9473684210525], "Decrypt": [6435.897435897436], "Splay": [753.0120481927711], "Richards": [192.75250578257518], "RegExp": [33064.51612903226], "Earley": [905.7971014492754], "Boyer": [14838.235294117647], "RayTrace": [2192.9824561403507]}, "summary": {"lowerIsBetter": false, "suite": 16219.676491363494, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 290.32413799999995, "unit": "score", "value": 290.32413799999995}, "Encrypt": {"lowerIsBetter": false, "filtered": 728.0050350000001, "unit": "score", "value": 728.0050350000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 225.56800000000015, "unit": "score", "value": 225.56800000000015}, "Decrypt": {"lowerIsBetter": false, "filtered": 41.35880079681276, "unit": "score", "value": 41.35880079681276}, "Splay": {"lowerIsBetter": false, "filtered": 108.22004799999995, "unit": "score", "value": 108.22004799999995}, "RegExp": {"lowerIsBetter": false, "filtered": 27.551741463414636, "unit": "score", "value": 27.551741463414636}, "Richards": {"lowerIsBetter": false, "filtered": 183.14677599999996, "unit": "score", "value": 183.14677599999996}, "Earley": {"lowerIsBetter": false, "filtered": 735.7751519999999, "unit": "score", "value": 735.7751519999999}, "Boyer": {"lowerIsBetter": false, "filtered": 44.915246778989115, "unit": "score", "value": 44.915246778989115}, "RayTrace": {"lowerIsBetter": false, "filtered": 337.43498400000004, "unit": "score", "value": 337.43498400000004}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0106"}, "testrun": {"date": 1447114893, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151109153630", "branch": "Fx-Team", "revision": "68a879c220d8c777e165ab9df5c1a6a4a3c703f2"}}] 16:41:52 INFO - RETURN: dromaeo_css: 5861.57 16:41:52 INFO - RETURN: kraken: 1730.00 16:41:52 INFO - RETURN: v8_7: 16219.68 16:41:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "16219.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1730.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5861.57"}}} 16:41:52 INFO - Return code: 0 16:41:52 INFO - # TBPL SUCCESS # 16:41:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:41:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:41:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:41:52 INFO - 2015-11-09 16:41:52.306 screenresolution[1656:9989] starting screenresolution argv=screenresolution get 16:41:52 INFO - 2015-11-09 16:41:52.309 screenresolution[1656:9989] Display 0: 1600x1200x32@60 16:41:52 INFO - 2015-11-09 16:41:52.316 screenresolution[1657:9992] starting screenresolution argv=screenresolution list 16:41:52 INFO - Available Modes on Display 0 16:41:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:41:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:41:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:41:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:41:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:41:52 INFO - Intel HD Graphics 3000: 16:41:52 INFO - Chipset Model: Intel HD Graphics 3000 16:41:52 INFO - Type: GPU 16:41:52 INFO - Bus: Built-In 16:41:52 INFO - VRAM (Total): 512 MB 16:41:52 INFO - VRAM (Dynamic, Max): 10 16:41:52 INFO - Vendor: Intel (0x8086) 16:41:52 INFO - Device ID: 0x0116 16:41:52 INFO - Revision ID: 0x0009 16:41:52 INFO - Displays: 16:41:52 INFO - Display: 16:41:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:41:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:41:52 INFO - Display Serial Number: 1600x1200 60 16:41:52 INFO - Main Display: Yes 16:41:52 INFO - Mirror: Off 16:41:52 INFO - Online: Yes 16:41:52 INFO - Rotation: Supported 16:41:52 INFO - Return code: 0 16:41:52 INFO - Running post-action listener: _resource_record_post_action 16:41:52 INFO - Running post-run listener: _resource_record_post_run 16:41:53 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 45859840; Write bytes: 693623808; Read time: 4814; Write time: 60207 16:41:53 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 336505344; Write bytes: 334866432; Read time: 35164; Write time: 6411 16:41:53 INFO - run-tests - Wall time: 1220s; CPU: 30.0%; Read bytes: 44975104; Write bytes: 348398592; Read time: 4616; Write time: 52909 16:41:53 INFO - Running post-run listener: _upload_blobber_files 16:41:53 INFO - Blob upload gear active. 16:41:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:41:53 INFO - Copying logs to upload dir... 16:41:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1348.161965 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 28 secs) (at 2015-11-09 16:41:53.744107) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-09 16:41:53.747723) ========= 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.4czGG0MSmO/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.ddqF1uQ4pC/Listeners TMPDIR=/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011026 build_url: 'https://queue.taskcluster.net/v1/task/o9aX4EPhT-OWp48Ja7gfXQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-09 16:41:53.776407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:41:53.776824) ========= 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.4czGG0MSmO/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.ddqF1uQ4pC/Listeners TMPDIR=/var/folders/gw/4ss7mzmj1zl31r78qsyc4xy800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005669 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-09 16:41:53.827790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-09 16:41:53.828175) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-09 16:41:53.828672) ========= ========= Total master_lag: 0.47 =========