builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0022 starttime: 1446717697.91 results: success (0) buildid: 20151105004045 builduid: bc6f3e05669f4163a1387029420c5c96 revision: ef5a44ab4ef0344d35f2e465566d37e4906af6ff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:37.905534) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:37.905999) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:37.906296) ========= 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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.006189 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:37.960382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:37.960705) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:37.981441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:37.981830) ========= 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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.030019 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:38.032084) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:38.032585) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:38.033175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:38.033661) ========= 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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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-05 02:01:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 965M=0s 2015-11-05 02:01:38 (965 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.219211 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:38.269169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:38.269484) ========= 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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.109103 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:38.393083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:38.393427) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ef5a44ab4ef0344d35f2e465566d37e4906af6ff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ef5a44ab4ef0344d35f2e465566d37e4906af6ff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TPwsb6pnVa/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.mzXNtFYJmk/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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-05 02:01:38,474 truncating revision to first 12 chars 2015-11-05 02:01:38,474 Setting DEBUG logging. 2015-11-05 02:01:38,474 attempt 1/10 2015-11-05 02:01:38,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ef5a44ab4ef0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-05 02:01:38,765 unpacking tar archive at: mozilla-aurora-ef5a44ab4ef0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:39.109149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:39.109674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:39.122269) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:39.122545) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-05 02:01:39.122944) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-05 02:01:39.123237) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TPwsb6pnVa/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.mzXNtFYJmk/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 02:01:39 INFO - MultiFileLogger online at 20151105 02:01:39 in /builds/slave/test 02:01:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:01:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:01:39 INFO - {'append_to_log': False, 02:01:39 INFO - 'base_work_dir': '/builds/slave/test', 02:01:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:01:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:01:39 INFO - 'branch': 'Mozilla-Aurora', 02:01:39 INFO - 'buildbot_json_path': 'buildprops.json', 02:01:39 INFO - 'config_files': ('talos/mac_config.py',), 02:01:39 INFO - 'default_actions': ('clobber', 02:01:39 INFO - 'read-buildbot-config', 02:01:39 INFO - 'download-and-extract', 02:01:39 INFO - 'populate-webroot', 02:01:39 INFO - 'create-virtualenv', 02:01:39 INFO - 'install', 02:01:39 INFO - 'run-tests'), 02:01:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:01:39 INFO - 'download_minidump_stackwalk': True, 02:01:39 INFO - 'download_symbols': 'ondemand', 02:01:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:01:39 INFO - 'tooltool.py': '/tools/tooltool.py', 02:01:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:01:39 INFO - '/tools/misc-python/virtualenv.py')}, 02:01:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:01:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:01:39 INFO - 'installer_path': 'installer.exe', 02:01:39 INFO - 'log_level': 'info', 02:01:39 INFO - 'log_name': 'talos', 02:01:39 INFO - 'log_to_console': True, 02:01:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:01:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:01:39 INFO - 'opt_config_files': (), 02:01:39 INFO - 'pip_index': False, 02:01:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:39 INFO - 'cmd': ('bash', 02:01:39 INFO - '-c', 02:01:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:39 INFO - 'enabled': True, 02:01:39 INFO - 'halt_on_failure': False, 02:01:39 INFO - 'name': 'check_screen_resolution'},), 02:01:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:39 INFO - 'cmd': ('bash', 02:01:39 INFO - '-c', 02:01:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:39 INFO - 'enabled': True, 02:01:39 INFO - 'halt_on_failure': False, 02:01:39 INFO - 'name': 'check_screen_resolution'},), 02:01:39 INFO - 'run_cmd_checks_enabled': True, 02:01:39 INFO - 'sps_profile': False, 02:01:39 INFO - 'sps_profile_interval': 0, 02:01:39 INFO - 'suite': 'dromaeojs', 02:01:39 INFO - 'system_bits': '64', 02:01:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:01:39 INFO - 'title': 't-yosemite-r5-0022', 02:01:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:01:39 INFO - 'use_talos_json': True, 02:01:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:01:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:01:39 INFO - 'work_dir': 'build'} 02:01:39 INFO - ##### 02:01:39 INFO - ##### Running clobber step. 02:01:39 INFO - ##### 02:01:39 INFO - Running pre-action listener: _resource_record_pre_action 02:01:39 INFO - Running main action method: clobber 02:01:39 INFO - rmtree: /builds/slave/test/build 02:01:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:01:43 INFO - Running post-action listener: _resource_record_post_action 02:01:43 INFO - ##### 02:01:43 INFO - ##### Running read-buildbot-config step. 02:01:43 INFO - ##### 02:01:43 INFO - Running pre-action listener: _resource_record_pre_action 02:01:43 INFO - Running main action method: read_buildbot_config 02:01:43 INFO - Using buildbot properties: 02:01:43 INFO - { 02:01:43 INFO - "properties": { 02:01:43 INFO - "buildnumber": 401, 02:01:43 INFO - "product": "firefox", 02:01:43 INFO - "script_repo_revision": "production", 02:01:43 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 02:01:43 INFO - "repository": "", 02:01:43 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 02:01:43 INFO - "buildid": "20151105004045", 02:01:43 INFO - "slavename": "t-yosemite-r5-0022", 02:01:43 INFO - "stage_platform": "macosx64", 02:01:43 INFO - "basedir": "/builds/slave/test", 02:01:43 INFO - "nightly_build": "True", 02:01:43 INFO - "project": "", 02:01:43 INFO - "platform": "yosemite", 02:01:43 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:01:43 INFO - "slavebuilddir": "test", 02:01:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:01:43 INFO - "branch": "mozilla-aurora", 02:01:43 INFO - "repo_path": "releases/mozilla-aurora", 02:01:43 INFO - "pgo_build": "False", 02:01:43 INFO - "builduid": "bc6f3e05669f4163a1387029420c5c96", 02:01:43 INFO - "revision": "ef5a44ab4ef0344d35f2e465566d37e4906af6ff" 02:01:43 INFO - }, 02:01:43 INFO - "sourcestamp": { 02:01:43 INFO - "repository": "", 02:01:43 INFO - "hasPatch": false, 02:01:43 INFO - "project": "", 02:01:43 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:01:43 INFO - "changes": [ 02:01:43 INFO - { 02:01:43 INFO - "category": null, 02:01:43 INFO - "files": [ 02:01:43 INFO - { 02:01:43 INFO - "url": null, 02:01:43 INFO - "name": "https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 02:01:43 INFO - } 02:01:43 INFO - ], 02:01:43 INFO - "repository": "", 02:01:43 INFO - "rev": "ef5a44ab4ef0344d35f2e465566d37e4906af6ff", 02:01:43 INFO - "who": "sendchange", 02:01:43 INFO - "when": 1446717656, 02:01:43 INFO - "number": 6624128, 02:01:43 INFO - "comments": "", 02:01:43 INFO - "project": "", 02:01:43 INFO - "at": "Thu 05 Nov 2015 02:00:56", 02:01:43 INFO - "branch": "mozilla-aurora-macosx64-talos", 02:01:43 INFO - "revlink": "", 02:01:43 INFO - "properties": [ 02:01:43 INFO - [ 02:01:43 INFO - "buildid", 02:01:43 INFO - "20151105004045", 02:01:43 INFO - "Change" 02:01:43 INFO - ], 02:01:43 INFO - [ 02:01:43 INFO - "builduid", 02:01:43 INFO - "bc6f3e05669f4163a1387029420c5c96", 02:01:43 INFO - "Change" 02:01:43 INFO - ], 02:01:43 INFO - [ 02:01:43 INFO - "nightly_build", 02:01:43 INFO - "True", 02:01:43 INFO - "Change" 02:01:43 INFO - ], 02:01:43 INFO - [ 02:01:43 INFO - "pgo_build", 02:01:43 INFO - "False", 02:01:43 INFO - "Change" 02:01:43 INFO - ] 02:01:43 INFO - ], 02:01:43 INFO - "revision": "ef5a44ab4ef0344d35f2e465566d37e4906af6ff" 02:01:43 INFO - } 02:01:43 INFO - ], 02:01:43 INFO - "revision": "ef5a44ab4ef0344d35f2e465566d37e4906af6ff" 02:01:43 INFO - } 02:01:43 INFO - } 02:01:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 02:01:43 INFO - Running post-action listener: _resource_record_post_action 02:01:43 INFO - ##### 02:01:43 INFO - ##### Running download-and-extract step. 02:01:43 INFO - ##### 02:01:43 INFO - Running pre-action listener: _resource_record_pre_action 02:01:43 INFO - Running main action method: download_and_extract 02:01:43 INFO - mkdir: /builds/slave/test/build/tests 02:01:43 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')]} 02:01:43 INFO - https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:01:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/test_packages.json 02:01:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/test_packages.json 02:01:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 02:01:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 02:01:44 INFO - Downloaded 1149 bytes. 02:01:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 02:01:44 INFO - Using the following test package requirements: 02:01:44 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:01:44 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:01:44 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 02:01:44 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:01:44 INFO - u'jsshell-mac.zip'], 02:01:44 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:01:44 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 02:01:44 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:01:44 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:01:44 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 02:01:44 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:01:44 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 02:01:44 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:01:44 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 02:01:44 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 02:01:44 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 02:01:44 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 02:01:44 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:01:44 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')]} 02:01:44 INFO - https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:01:48 INFO - Downloaded 17445703 bytes. 02:01:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:01:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:01:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:01:52 INFO - Return code: 0 02:01:52 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip', u'firefox-44.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:01:52 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')]} 02:01:52 INFO - https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:01:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:01:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:01:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:01:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:01:54 INFO - Downloaded 17445703 bytes. 02:01:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 02:01:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 02:01:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 02:02:00 INFO - Return code: 0 02:02:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:00 INFO - https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:02:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:02:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:02:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:02:01 INFO - Downloaded 11131307 bytes. 02:02:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 02:02:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 02:02:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 02:02:02 INFO - Return code: 0 02:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:02 INFO - https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 02:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg'}, attempt #1 02:02:07 INFO - Downloaded 107840959 bytes. 02:02:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:02:07 INFO - mkdir: /builds/slave/test/properties 02:02:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:02:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:02:07 INFO - Contents: 02:02:07 INFO - build_url:https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 02:02:07 INFO - Running post-action listener: _resource_record_post_action 02:02:07 INFO - Running post-action listener: set_extra_try_arguments 02:02:07 INFO - ##### 02:02:07 INFO - ##### Running populate-webroot step. 02:02:07 INFO - ##### 02:02:07 INFO - Running pre-action listener: _resource_record_pre_action 02:02:07 INFO - Running main action method: populate_webroot 02:02:07 INFO - Guessing talos json url... 02:02:07 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')]} 02:02:07 INFO - https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 02:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 02:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-44.0a2.en-US.mac.txt'}, attempt #1 02:02:07 INFO - Downloaded 107 bytes. 02:02:07 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 02:02:07 INFO - Contents: 02:02:07 INFO - 20151105004045 02:02:07 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/ef5a44ab4ef0344d35f2e465566d37e4906af6ff 02:02:07 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')]} 02:02:07 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/ef5a44ab4e/testing/talos/talos.json 02:02:07 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/ef5a44ab4e/testing/talos/talos.json to /builds/slave/test/build/talos.json 02:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/ef5a44ab4e/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 02:02:08 INFO - Downloaded 4264 bytes. 02:02:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:02:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:02:08 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 02:02:08 INFO - '../fennec_ids.txt'], 02:02:08 INFO - 'tests': ['tcheck2']}, 02:02:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:02:08 INFO - '--tppagecycles', 02:02:08 INFO - '7'], 02:02:08 INFO - 'tests': ['tsvgm']}}, 02:02:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:02:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:02:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:02:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:02:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:02:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:02:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:08 INFO - 'talos_options': ['--e10s'], 02:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:02:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:08 INFO - 'tests': ['damp', 'tps']}, 02:02:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:08 INFO - 'talos_options': ['--e10s'], 02:02:08 INFO - 'tests': ['damp', 'tps']}, 02:02:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:02:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:02:08 INFO - 'other': {'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore']}, 02:02:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:02:08 INFO - 'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore']}, 02:02:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:02:08 INFO - 'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore']}, 02:02:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:02:08 INFO - 'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore']}, 02:02:08 INFO - 'other_l64': {'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore']}, 02:02:08 INFO - 'other_nol64': {'tests': ['a11yr', 02:02:08 INFO - 'ts_paint', 02:02:08 INFO - 'tpaint', 02:02:08 INFO - 'sessionrestore', 02:02:08 INFO - 'sessionrestore_no_auto_restore']}, 02:02:08 INFO - 'svgr': {'tests': ['tsvgx', 02:02:08 INFO - 'tsvgr_opacity', 02:02:08 INFO - 'tart', 02:02:08 INFO - 'tscrollx', 02:02:08 INFO - 'cart']}, 02:02:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:02:08 INFO - 'tests': ['tsvgx', 02:02:08 INFO - 'tsvgr_opacity', 02:02:08 INFO - 'tart', 02:02:08 INFO - 'tscrollx', 02:02:08 INFO - 'cart']}, 02:02:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:08 INFO - 'tests': ['tp5o']}, 02:02:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:08 INFO - 'talos_options': ['--e10s'], 02:02:08 INFO - 'tests': ['tp5o']}, 02:02:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:08 INFO - 'talos_options': ['--xperf_path', 02:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:02:08 INFO - 'tests': ['tp5n']}, 02:02:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:02:08 INFO - 'talos_options': ['--e10s', 02:02:08 INFO - '--xperf_path', 02:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 02:02:08 INFO - 'C:/slave/talos-data/talos/xperf.config'], 02:02:08 INFO - 'tests': ['tp5n']}}, 02:02:08 INFO - 'talos.zip': {'path': '', 02:02:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:02:08 INFO - Running post-action listener: _resource_record_post_action 02:02:08 INFO - ##### 02:02:08 INFO - ##### Running create-virtualenv step. 02:02:08 INFO - ##### 02:02:08 INFO - Running pre-action listener: _resource_record_pre_action 02:02:08 INFO - Running main action method: create_virtualenv 02:02:08 INFO - Creating virtualenv /builds/slave/test/build/venv 02:02:08 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 02:02:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:02:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:02:08 INFO - Using real prefix '/tools/python27' 02:02:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:02:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:02:13 INFO - Installing pip.................done. 02:02:13 INFO - Return code: 0 02:02:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:13 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 0x110316a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110383228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b3574b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102cb9f0>, '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 0x11002acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110295990>, '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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 02:02:13 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 02:02:13 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 02:02:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPwsb6pnVa/Render', 02:02:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:13 INFO - 'HOME': '/Users/cltbld', 02:02:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:13 INFO - 'LOGNAME': 'cltbld', 02:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:13 INFO - 'MOZ_NO_REMOTE': '1', 02:02:13 INFO - 'NO_EM_RESTART': '1', 02:02:13 INFO - 'PAGER': '/bin/cat', 02:02:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:13 INFO - 'PWD': '/builds/slave/test', 02:02:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:13 INFO - 'SHELL': '/bin/bash', 02:02:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mzXNtFYJmk/Listeners', 02:02:13 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 02:02:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:13 INFO - 'USER': 'cltbld', 02:02:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:13 INFO - 'XPC_FLAGS': '0x0', 02:02:13 INFO - 'XPC_SERVICE_NAME': '0', 02:02:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:14 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 02:02:14 INFO - Cleaning up... 02:02:14 INFO - Return code: 0 02:02:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:14 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 0x110316a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110383228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b3574b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102cb9f0>, '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 0x11002acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110295990>, '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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 02:02:14 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 02:02:14 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 02:02:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPwsb6pnVa/Render', 02:02:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:14 INFO - 'HOME': '/Users/cltbld', 02:02:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:14 INFO - 'LOGNAME': 'cltbld', 02:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:14 INFO - 'MOZ_NO_REMOTE': '1', 02:02:14 INFO - 'NO_EM_RESTART': '1', 02:02:14 INFO - 'PAGER': '/bin/cat', 02:02:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:14 INFO - 'PWD': '/builds/slave/test', 02:02:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:14 INFO - 'SHELL': '/bin/bash', 02:02:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mzXNtFYJmk/Listeners', 02:02:14 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 02:02:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:14 INFO - 'USER': 'cltbld', 02:02:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:14 INFO - 'XPC_FLAGS': '0x0', 02:02:14 INFO - 'XPC_SERVICE_NAME': '0', 02:02:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:14 INFO - Downloading/unpacking psutil>=0.7.1 02:02:14 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 02:02:14 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 02:02:14 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 02:02:14 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 02:02:14 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 02:02:14 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 02:02:17 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 02:02:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:02:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:17 INFO - Installing collected packages: psutil 02:02:17 INFO - Running setup.py install for psutil 02:02:17 INFO - building 'psutil._psutil_osx' extension 02:02:17 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 02:02:19 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 02:02:19 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 02:02:19 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 02:02:19 INFO - building 'psutil._psutil_posix' extension 02:02:19 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 02:02:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:02:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:02:20 INFO - ^ 02:02:20 INFO - 1 warning generated. 02:02:20 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 02:02:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:02:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:02:20 INFO - Successfully installed psutil 02:02:20 INFO - Cleaning up... 02:02:20 INFO - Return code: 0 02:02:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:02:20 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')]} 02:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:20 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')]} 02:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:20 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 0x110316a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110383228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b3574b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102cb9f0>, '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 0x11002acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110295990>, '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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 02:02:20 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 02:02:20 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 02:02:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPwsb6pnVa/Render', 02:02:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:20 INFO - 'HOME': '/Users/cltbld', 02:02:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:20 INFO - 'LOGNAME': 'cltbld', 02:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:20 INFO - 'MOZ_NO_REMOTE': '1', 02:02:20 INFO - 'NO_EM_RESTART': '1', 02:02:20 INFO - 'PAGER': '/bin/cat', 02:02:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:20 INFO - 'PWD': '/builds/slave/test', 02:02:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:20 INFO - 'SHELL': '/bin/bash', 02:02:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mzXNtFYJmk/Listeners', 02:02:20 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 02:02:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:20 INFO - 'USER': 'cltbld', 02:02:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:20 INFO - 'XPC_FLAGS': '0x0', 02:02:20 INFO - 'XPC_SERVICE_NAME': '0', 02:02:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:02:20 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 02:02:20 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 02:02:20 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 02:02:20 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 02:02:20 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 02:02:20 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 02:02:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:02:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:02:23 INFO - Installing collected packages: mozsystemmonitor 02:02:23 INFO - Running setup.py install for mozsystemmonitor 02:02:23 INFO - Successfully installed mozsystemmonitor 02:02:23 INFO - Cleaning up... 02:02:23 INFO - Return code: 0 02:02:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110316a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110383228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b3574b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102cb9f0>, '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 0x11002acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110295990>, '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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 02:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:02:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPwsb6pnVa/Render', 02:02:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:23 INFO - 'HOME': '/Users/cltbld', 02:02:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:23 INFO - 'LOGNAME': 'cltbld', 02:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:23 INFO - 'MOZ_NO_REMOTE': '1', 02:02:23 INFO - 'NO_EM_RESTART': '1', 02:02:23 INFO - 'PAGER': '/bin/cat', 02:02:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:23 INFO - 'PWD': '/builds/slave/test', 02:02:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:23 INFO - 'SHELL': '/bin/bash', 02:02:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mzXNtFYJmk/Listeners', 02:02:23 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 02:02:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:23 INFO - 'USER': 'cltbld', 02:02:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:23 INFO - 'XPC_FLAGS': '0x0', 02:02:23 INFO - 'XPC_SERVICE_NAME': '0', 02:02:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:23 INFO - Downloading/unpacking blobuploader==1.2.4 02:02:23 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 02:02:23 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 02:02:23 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 02:02:23 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 02:02:23 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 02:02:23 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 02:02:26 INFO - Downloading blobuploader-1.2.4.tar.gz 02:02:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:02:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:02:26 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 02:02:26 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 02:02:26 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 02:02:26 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 02:02:26 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 02:02:26 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 02:02:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:02:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:02:27 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 02:02:27 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 02:02:27 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 02:02:27 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 02:02:27 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 02:02:27 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 02:02:27 INFO - Downloading docopt-0.6.1.tar.gz 02:02:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:02:27 INFO - Installing collected packages: blobuploader, requests, docopt 02:02:27 INFO - Running setup.py install for blobuploader 02:02:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:02:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:02:27 INFO - Running setup.py install for requests 02:02:28 INFO - Running setup.py install for docopt 02:02:28 INFO - Successfully installed blobuploader requests docopt 02:02:28 INFO - Cleaning up... 02:02:28 INFO - Return code: 0 02:02:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:28 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 0x110316a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110383228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b3574b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102cb9f0>, '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 0x11002acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110295990>, '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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 02:02:28 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 02:02:28 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 02:02:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPwsb6pnVa/Render', 02:02:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:28 INFO - 'HOME': '/Users/cltbld', 02:02:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:28 INFO - 'LOGNAME': 'cltbld', 02:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:28 INFO - 'MOZ_NO_REMOTE': '1', 02:02:28 INFO - 'NO_EM_RESTART': '1', 02:02:28 INFO - 'PAGER': '/bin/cat', 02:02:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:28 INFO - 'PWD': '/builds/slave/test', 02:02:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:28 INFO - 'SHELL': '/bin/bash', 02:02:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mzXNtFYJmk/Listeners', 02:02:28 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 02:02:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:28 INFO - 'USER': 'cltbld', 02:02:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:28 INFO - 'XPC_FLAGS': '0x0', 02:02:28 INFO - 'XPC_SERVICE_NAME': '0', 02:02:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:29 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-u8h3ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:29 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-_UxZUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:29 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-No4Twf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:29 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-PbCYmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:29 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-UN5FUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:29 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-uiIvOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:29 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-aAgffV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:30 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-xnJGrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:30 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-GMJKqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:30 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-svy86L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:30 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-O1YNdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:30 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-bnCuq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:30 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-zFgKgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:30 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-LKCsuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:30 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-nsO8mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:31 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-xHw7s6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:31 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-lAyaGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:02:31 INFO - Running setup.py install for manifestparser 02:02:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:02:31 INFO - Running setup.py install for mozcrash 02:02:31 INFO - Running setup.py install for mozdebug 02:02:31 INFO - Running setup.py install for mozdevice 02:02:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:02:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:02:32 INFO - Running setup.py install for mozfile 02:02:32 INFO - Running setup.py install for mozhttpd 02:02:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:02:32 INFO - Running setup.py install for mozinfo 02:02:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:02:32 INFO - Running setup.py install for mozInstall 02:02:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:02:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:02:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:02:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:02:32 INFO - Running setup.py install for mozleak 02:02:32 INFO - Running setup.py install for mozlog 02:02:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Running setup.py install for moznetwork 02:02:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Running setup.py install for mozprocess 02:02:33 INFO - Running setup.py install for mozprofile 02:02:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Running setup.py install for mozrunner 02:02:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:02:33 INFO - Running setup.py install for mozscreenshot 02:02:34 INFO - Running setup.py install for moztest 02:02:34 INFO - Running setup.py install for mozversion 02:02:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:02:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:02:34 INFO - Cleaning up... 02:02:34 INFO - Return code: 0 02:02:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02: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')]} 02:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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')]} 02:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02: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', '-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 0x110316a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110383228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b3574b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102cb9f0>, '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 0x11002acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110295990>, '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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 02:02:34 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 02:02:34 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 02:02:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPwsb6pnVa/Render', 02:02:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:34 INFO - 'HOME': '/Users/cltbld', 02:02:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:34 INFO - 'LOGNAME': 'cltbld', 02:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:34 INFO - 'MOZ_NO_REMOTE': '1', 02:02:34 INFO - 'NO_EM_RESTART': '1', 02:02:34 INFO - 'PAGER': '/bin/cat', 02:02:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:34 INFO - 'PWD': '/builds/slave/test', 02:02:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:34 INFO - 'SHELL': '/bin/bash', 02:02:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mzXNtFYJmk/Listeners', 02:02:34 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 02:02:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:34 INFO - 'USER': 'cltbld', 02:02:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:34 INFO - 'XPC_FLAGS': '0x0', 02:02:34 INFO - 'XPC_SERVICE_NAME': '0', 02:02:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:02:34 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-wuDNER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:02:34 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)) 02:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:02:34 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-4B4YLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:02:35 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-OGomch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:02:35 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-b2nyqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:02:35 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-LLYLtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:02:35 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-u8omjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:02:35 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-NRq6D4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:02:35 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-0JYIWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:02:35 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-io5nHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:02:35 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)) 02:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:02:35 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-PI8lmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:02:36 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)) 02:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:02:36 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-icchnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:02:36 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)) 02:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:02:36 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-dGLl7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:02:36 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)) 02:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:02:36 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-FSC5S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:02:36 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)) 02:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:02:36 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-UKpUpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:02:36 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)) 02:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:36 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-OK8QF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:02:36 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)) 02:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:02:36 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-NV4B8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:02:36 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)) 02:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:02:36 INFO - Running setup.py (path:/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/pip-Z1okrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:02:37 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)) 02:02:37 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)) 02:02:37 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)) 02:02:37 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)) 02:02:37 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:02:37 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.46->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:02:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02: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 02:02:39 INFO - Downloading blessings-1.5.1.tar.gz 02:02:39 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 02:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:39 INFO - Installing collected packages: blessings 02:02:39 INFO - Running setup.py install for blessings 02:02:39 INFO - Successfully installed blessings 02:02:39 INFO - Cleaning up... 02:02:39 INFO - Return code: 0 02:02:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:40 INFO - Reading from file tmpfile_stdout 02:02:40 INFO - Current package versions: 02:02:40 INFO - blessings == 1.5.1 02:02:40 INFO - blobuploader == 1.2.4 02:02:40 INFO - docopt == 0.6.1 02:02:40 INFO - manifestparser == 1.1 02:02:40 INFO - mozInstall == 1.12 02:02:40 INFO - mozcrash == 0.16 02:02:40 INFO - mozdebug == 0.1 02:02:40 INFO - mozdevice == 0.46 02:02:40 INFO - mozfile == 1.2 02:02:40 INFO - mozhttpd == 0.7 02:02:40 INFO - mozinfo == 0.8 02:02:40 INFO - mozleak == 0.1 02:02:40 INFO - mozlog == 3.0 02:02:40 INFO - moznetwork == 0.27 02:02:40 INFO - mozprocess == 0.22 02:02:40 INFO - mozprofile == 0.27 02:02:40 INFO - mozrunner == 6.11 02:02:40 INFO - mozscreenshot == 0.1 02:02:40 INFO - mozsystemmonitor == 0.0 02:02:40 INFO - moztest == 0.7 02:02:40 INFO - mozversion == 1.4 02:02:40 INFO - psutil == 3.1.1 02:02:40 INFO - requests == 1.2.3 02:02:40 INFO - wsgiref == 0.1.2 02:02:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:40 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')]} 02:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:40 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')]} 02:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:40 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 0x110316a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110383228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff9b3574b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102cb9f0>, '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 0x11002acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110295990>, '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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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 02:02:40 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 02:02:40 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 02:02:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPwsb6pnVa/Render', 02:02:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:40 INFO - 'HOME': '/Users/cltbld', 02:02:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:40 INFO - 'LOGNAME': 'cltbld', 02:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:40 INFO - 'MOZ_NO_REMOTE': '1', 02:02:40 INFO - 'NO_EM_RESTART': '1', 02:02:40 INFO - 'PAGER': '/bin/cat', 02:02:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:40 INFO - 'PWD': '/builds/slave/test', 02:02:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:40 INFO - 'SHELL': '/bin/bash', 02:02:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mzXNtFYJmk/Listeners', 02:02:40 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 02:02:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:40 INFO - 'USER': 'cltbld', 02:02:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:40 INFO - 'XPC_FLAGS': '0x0', 02:02:40 INFO - 'XPC_SERVICE_NAME': '0', 02:02:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:40 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)) 02:02:40 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)) 02:02:40 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)) 02:02:40 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)) 02:02:40 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)) 02:02:40 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)) 02:02:40 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)) 02:02:40 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)) 02:02:40 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)) 02:02:40 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)) 02:02:40 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)) 02:02:40 INFO - Cleaning up... 02:02:40 INFO - Return code: 0 02:02:40 INFO - Running post-action listener: _resource_record_post_action 02:02:40 INFO - Running post-action listener: _start_resource_monitoring 02:02:40 INFO - Starting resource monitoring. 02:02:40 INFO - ##### 02:02:40 INFO - ##### Running install step. 02:02:40 INFO - ##### 02:02:40 INFO - Running pre-action listener: _resource_record_pre_action 02:02:40 INFO - Running main action method: install 02:02:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:40 INFO - Reading from file tmpfile_stdout 02:02:40 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:41 INFO - Reading from file tmpfile_stdout 02:02:41 INFO - Output received: 02:02:41 INFO - Usage: mozinstall [options] installer 02:02:41 INFO - Options: 02:02:41 INFO - -h, --help show this help message and exit 02:02:41 INFO - -d DEST, --destination=DEST 02:02:41 INFO - Directory to install application into. [default: 02:02:41 INFO - "/builds/slave/test"] 02:02:41 INFO - --app=APP Application being installed. [default: firefox] 02:02:41 INFO - mkdir: /builds/slave/test/build/application 02:02:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:03:20 INFO - Reading from file tmpfile_stdout 02:03:20 INFO - Output received: 02:03:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:03:20 INFO - Running post-action listener: _resource_record_post_action 02:03:20 INFO - ##### 02:03:20 INFO - ##### Running run-tests step. 02:03:20 INFO - ##### 02:03:20 INFO - Running pre-action listener: _resource_record_pre_action 02:03:20 INFO - Running main action method: run_tests 02:03:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:03:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:03:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:03:20 INFO - 2015-11-05 02:03:20.710 screenresolution[1627:7512] starting screenresolution argv=screenresolution get 02:03:20 INFO - 2015-11-05 02:03:20.713 screenresolution[1627:7512] Display 0: 1600x1200x32@60 02:03:20 INFO - 2015-11-05 02:03:20.719 screenresolution[1628:7514] starting screenresolution argv=screenresolution list 02:03:20 INFO - Available Modes on Display 0 02:03:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:03:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:03:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:03:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:03:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:03:20 INFO - Intel HD Graphics 3000: 02:03:20 INFO - Chipset Model: Intel HD Graphics 3000 02:03:20 INFO - Type: GPU 02:03:20 INFO - Bus: Built-In 02:03:20 INFO - VRAM (Total): 512 MB 02:03:20 INFO - VRAM (Dynamic, Max): 10 02:03:20 INFO - Vendor: Intel (0x8086) 02:03:20 INFO - Device ID: 0x0116 02:03:20 INFO - Revision ID: 0x0009 02:03:20 INFO - Displays: 02:03:20 INFO - Display: 02:03:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:03:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:03:20 INFO - Display Serial Number: 1600x1200 60 02:03:20 INFO - Main Display: Yes 02:03:20 INFO - Mirror: Off 02:03:20 INFO - Online: Yes 02:03:20 INFO - Rotation: Supported 02:03:20 INFO - Return code: 0 02:03:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:03:20 INFO - Python 2.7.3 02:03:20 INFO - Return code: 0 02:03:20 INFO - grabbing minidump binary from tooltool 02:03:20 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')]} 02:03:20 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 0x1102cb9f0>, '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 0x11002acd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110295990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:03:20 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 02:03:20 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 02:03:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:03:21 INFO - Return code: 0 02:03:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:03:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:03:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:03:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:03:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:03:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0022', '--webServer', 'localhost'] in /builds/slave/test/build 02:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0022 --webServer localhost 02:03:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TPwsb6pnVa/Render', 02:03:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:03:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:03:21 INFO - 'HOME': '/Users/cltbld', 02:03:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:03:21 INFO - 'LOGNAME': 'cltbld', 02:03:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:03:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:21 INFO - 'MOZ_NO_REMOTE': '1', 02:03:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:03:21 INFO - 'NO_EM_RESTART': '1', 02:03:21 INFO - 'PAGER': '/bin/cat', 02:03:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:21 INFO - 'PWD': '/builds/slave/test', 02:03:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:03:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:03:21 INFO - 'SHELL': '/bin/bash', 02:03:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mzXNtFYJmk/Listeners', 02:03:21 INFO - 'TMPDIR': '/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/', 02:03:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:03:21 INFO - 'USER': 'cltbld', 02:03:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:03:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:21 INFO - 'XPC_FLAGS': '0x0', 02:03:21 INFO - 'XPC_SERVICE_NAME': '0', 02:03:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 02:03:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0022', '--webServer', 'localhost'] with output_timeout 3600 02:03:21 INFO - mozversion INFO | application_buildid: 20151105004045 02:03:21 INFO - mozversion INFO | application_changeset: ef5a44ab4ef0344d35f2e465566d37e4906af6ff 02:03:21 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:03:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:03:21 INFO - mozversion INFO | application_name: Firefox 02:03:21 INFO - mozversion INFO | application_remotingname: firefox-dev 02:03:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:03:21 INFO - mozversion INFO | application_vendor: Mozilla 02:03:21 INFO - mozversion INFO | application_version: 44.0a2 02:03:21 INFO - mozversion INFO | platform_buildid: 20151105004045 02:03:21 INFO - mozversion INFO | platform_changeset: ef5a44ab4ef0344d35f2e465566d37e4906af6ff 02:03:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:03:21 INFO - mozversion INFO | platform_version: 44.0a2 02:03:21 INFO - 2015-11-05 02:03:21,438 DEBUG : using testdate: 1446717801 02:03:21 INFO - 2015-11-05 02:03:21,438 DEBUG : actual date: 1446717801 02:03:21 INFO - 2015-11-05 02:03:21,448 INFO : starting webserver on 'localhost:49277' 02:03:21 INFO - 2015-11-05 02:03:21,449 INFO : Starting test suite t-yosemite-r5-0022 02:03:21 INFO - 2015-11-05 02:03:21,449 INFO : Starting test dromaeo_css 02:03:21 INFO - 2015-11-05 02:03:21,449 DEBUG : operating with platform_type : mac_ 02:03:21 INFO - 2015-11-05 02:03:21,450 INFO : Initialising browser for dromaeo_css test... 02:03:21 INFO - 2015-11-05 02:03:21,481 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpzyKnR_/profile http://localhost:49277/getInfo.html 02:03:24 INFO - 2015-11-05 02:03:24,665 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:03:24 INFO - 2015-11-05 02:03:24,666 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:03:24 INFO - 2015-11-05 02:03:24,666 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:03:24 INFO - 2015-11-05 02:03:24,666 DEBUG : BROWSER_OUTPUT: __metrics 02:03:24 INFO - 2015-11-05 02:03:24,684 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:03:25 INFO - 2015-11-05 02:03:25,430 INFO : Browser initialized. 02:03:25 INFO - 2015-11-05 02:03:25,431 INFO : Running cycle 1/1 for dromaeo_css test... 02:03:25 INFO - 2015-11-05 02:03:25,431 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpzyKnR_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:03:37 INFO - 2015-11-05 02:03:37,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 200130560 02:03:37 INFO - 2015-11-05 02:03:37,448 DEBUG : BROWSER_OUTPUT: 02:04:29 INFO - 2015-11-05 02:04:29,023 DEBUG : BROWSER_OUTPUT: 1446717869017 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] 02:06:40 INFO - 2015-11-05 02:06:40,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 02:06:41 INFO - 2015-11-05 02:06:41,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 323543040 02:06:41 INFO - 2015-11-05 02:06:41,226 DEBUG : BROWSER_OUTPUT: 02:09:43 INFO - 2015-11-05 02:09:43,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 02:09:44 INFO - 2015-11-05 02:09:44,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 343166976 02:09:44 INFO - 2015-11-05 02:09:44,525 DEBUG : BROWSER_OUTPUT: 02:12:46 INFO - 2015-11-05 02:12:46,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 02:12:47 INFO - 2015-11-05 02:12:47,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 312184832 02:12:47 INFO - 2015-11-05 02:12:47,196 DEBUG : BROWSER_OUTPUT: 02:15:49 INFO - 2015-11-05 02:15:49,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 02:15:49 INFO - 2015-11-05 02:15:49,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 300408832 02:15:49 INFO - 2015-11-05 02:15:49,809 DEBUG : BROWSER_OUTPUT: 02:18:52 INFO - 2015-11-05 02:18:52,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 02:18:53 INFO - 2015-11-05 02:18:53,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 298033152 02:18:53 INFO - 2015-11-05 02:18:53,584 DEBUG : BROWSER_OUTPUT: 02:21:56 INFO - 2015-11-05 02:21:56,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 02:21:56 INFO - 2015-11-05 02:21:56,539 DEBUG : BROWSER_OUTPUT: RSS: Main: 347062272 02:21:56 INFO - 2015-11-05 02:21:56,539 DEBUG : BROWSER_OUTPUT: 02:21:56 INFO - 2015-11-05 02:21:56,539 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:21:56 INFO - 2015-11-05 02:21:56,539 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:21:56 INFO - 2015-11-05 02:21:56,540 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:21:56 INFO - 2015-11-05 02:21:56,540 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:21:56 INFO - 2015-11-05 02:21:56,540 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2880.884764609416;2944.676085630581;2950.631171103612;2953.719396657317;2981.865816038278;4867.269909513575;4905.411350637928;4909.3126962225315;4926.433460152083;4999.025190087934;4903.8528844134735;4936.876578085541;4946.455889852123;4967.10592093423;5027.1202539555525;4506;4605.815767369301;4625.560571745679;4637.397138372015;4708.952910470885;4615.976920115395;4635.049814787961;4637.281221410687;4643.326717625942;4744.4069491313585;4594.678372513926;4645.837395691152;4650.674452788307;4659.88350291242;4709.081729062834;4621.30680397943;4685.1332503486965;4690.859274221779;4759.5002524734755;4799.592034677056;4651.767411629405;4702.78837452312;4728.3143944127905;4731.7634118293945;4756.6432517561325;4780.282957556359;4859;4892.339534162878;4975.825846095369;4976.45259021511;5080.568151707109;5149.433562308143;5170.560502357304;5196.168613021899;5233.895322093536;5301.787928482856;5360.544353729938;5398.649087809319;5400.83797486076;5415.864603384907;4772.427308722976;4877.439094504107;4899.118158731462;5038.395392552917;5045.873853153664;5274.947250527523;5435.755391007414;5453.754581043862;5458.61789674719;5474.863128421742;5177.068127736969;5211.140161873249;5214.921776173361;5215.295935048795;5282.049231138355;5106.208537676666;5234.26720259164;5235.607329450307;5297.54970827484;5344.599155063386;5030.547250747451;5144.279800827887;5153.433122356538;5177.792888284502;5265.289185959923;5281.471852814765;5292.867678308073;5300.1519756838725;5327.7336133193185;5355.357357117093;3904;4027.275090483741;4077.44954431148;4150.813213405404;4154.127633197002;3660.743747937619;3710.07248187953;3714.238581090924;3742.2702572998546;3746.662800347982;5047.116754567936;5047.671901326402;5049.26785616091;5077.517635824591;5132.255822905658;5193.324867767166;5323.574114070942;5380.381256155514;5409.188621706697;5413.702246376409;4925.236588328815;5005.62457815658;5023.799048038038;5052.216906379517;5077.847664570068;4729.597984171384;4771.021940502189;4785.1625965455905;4802.615790736802;4808.447028591687;5207.609429292894;5337.546308563816;5353.518183363516;5494.890102198014;5532.5297349724915;5276.683398996072;5346.091164501966;5359.142537194186;5371.838844834661;5379.569634429158;5420.918686219631;5451.56387488992;5455.727213639223;5460.863478413072;5549.056660367666;5029.0947629427055;5108.872278192926;5110.029094472187;5329.733513324396;5335.706536140549;5207.895842083061;5220.243064755513;5295.152775555893;5296.867578310573;5301.708406037705;5035.219540971156;5213.504717051874;5224.268602395591;5247.422783493889;5269.736513174403;4947.282644016669;5057.468965758542;5120.129577971679;5235.554977826928;5244.76398562058;4963.404391473046;4975.0796102721115;4976.178930476575;5037.118504261813;5093.312402825719;5215.191645294985;5246.31797866275;5247.580193584427;5281.841544753664;5312.442193569774;4895.04546613407;4998.87502812418;5063.721495317793;5128.051310507568;5163.406208285945 02:21:56 INFO - 2015-11-05 02:21:56,541 DEBUG : BROWSER_OUTPUT: |1;ext.html;516.7545415927435;517.0744367582029;530.1702835063128;535.2078923193674;543.0903237077894;29904;31012.22469438265;36130.45804312937;36793.63206367935;37235.62764372356;38980.80509597448;39075.41386879199;39500;39610.80194599023;39657.80171099148;7764.262395072487;8403.327733781314;8476.618552165168;8603.010653774802;8611.224989750921;7759.030121234846;10117.089461948422;10219.38683678978;10332.586696532167;10342.172626189888;9947.701568952943;10073.39559626421;10087.899121008806;10182.389056656624;10190.64332748354;7882.842343153105;8197.590120493951;9965.601375944954;10065.899341006607;10070.798584028315;9651.565679544437;9932.602695892156;9938.453385063818;9957.65148219816;10035.69892903214;36744.63255367439;36853;36888.26223475515;36901.26197476035;37089.07277318062;2720.238714825993;2757.7518023377793;3017.411604737077;3116.703913128249;3197.2326641605846;24662.383440413952;24913.128040518495;25021.249362519153;25526.361840953938;26401.867990660117;2135.540858715368;2168.913243470259;2192.2984644913636;2245.3376254005107;2257.6274914639066;257249;258013;258108.9999999981;258426;258646;45985.7700711501;48005;52605.47394526083;54413.45586544084;54938.450615494134;50986;51186;51349.22976155361;51649;51650.48349516457;15489.380424782883;15687.1372074537;15907.602309942344;15924.522264332089;15943.123128228059;12075.3358565278;12106.152569320064;12153.5138594457;12243.632691019284;12244.693882653006;17456.12719364052;17695.823041769676;17713.557161071076;17739.379121730937;17924.283028678707;7571.129320128146;7822.217778222132;7838.568878711726;7877.818327250843;7892.4080693947035;808.7614153824636;852.6930305090162;966.5215718219526;998.8152191844532;1024.2676486312323;26181.476370472483;26347.868260658575;26361.80964507404;26490.86754566215;26578.867105664736;837.2004735477605;1023.7952409518126;1024.364893765855;1050.1598721023151;1122.399516258814;12692.619221423372;13520.12119212248;13818;14251.358688859027;14657.706845863024;313193;318317;318659;318828;320719;51755.741221293654;51757.7412112937;52124;52356.47643523592;52423.47576524262;1276.0748457368334;1293.5407930184838;1295.1710905020607;1295.9935200323937;1310.6461255460972;26060.218193454228;26649.200523984313;26874.462510750065;27250.318742031606;27277.318067048483;43731.56268437275;43836;43939.34090988574;44179.77910110429;44250.778746106065;277473;283035;289196;367610;376822;27211.455770884077;27330.453390932467;27866.582001270403;28041.298967525974;28210.15369538835;33896.66103338935;37231.06922326964;37879.2424151521;37949.620503794606;38718.80640596891;30784;32054.519182212753;32339.676603234606;32656.183595410304;33044.50433243455;32211.963387779175;32455.350892981536;32523.674763252064;32672.673273266962;32689.34621307513;32718.83640581782;33262.66737332596;33291.83354083214;33371.16572085717;33426;24704.382390439663;25208.495830082928;28229.294267643472;28951;29653.555196671634;21911.21714565179;22136.335909922727;22188.445288867908;22195.33413997583;22321.665175022063 02:21:56 INFO - 2015-11-05 02:21:56,545 DEBUG : BROWSER_OUTPUT: |2;jquery.html;309.7398185524159;314.1235951694772;319.1271871431635;321.1249345533422;331.3488994126541;14038.29808509573;14442.061266017728;16209.75685364719;16439.506814795546;16555.337786488526;13930.903277537342;14070.577882663536;15938.601534961632;16517.66964660706;17163.141842907837;4842.29786680931;5013.799448022093;5049.166887463564;5062.544371006608;5080.339555857733;3114.517249826269;4980.576650984671;4982.953579748258;4984.3021976923255;5011.123053465629;3153.4166179256795;3206.374756922401;4275.593818587229;4382.276924307485;4413.249747542925;4347.347897815337;4378.036831896978;4410.338449232609;4418.469783625986;4437.800298986554;3663.5970043295215;3695.2055308108884;3785.848566057382;3792.4500947362753;3826.2921359548573;12270.938645306716;12337.568185113567;12515.311657858814;12527.812082818766;12656.430460629294;1697.7538256952796;1782.7058535341653;1784.1971112999202;1859.7133607035778;1878.6336664350458;9027.593758280893;9107.36248462608;9110.362274640778;9271.211946984515;9297.209737172348;1389.8957578181678;1438.6834896322791;1450.419832067171;1457.1330058615108;1459.6569806095558;55610;56608.43391566073;56633;56944.430555694744;57160.142597861064;5982.192404025488;6014.398560143951;6167;6194.690265486708;6212.0371342441995;7237.384822290059;7245.130584329809;7246.166690830517;7251.3836323912;7255.419566434673;5193.610479214074;5325.360956685223;5330.307060082165;5353.518183363438;5381.67709937405;5688.374278829326;5726.341470730836;5753.453421924911;5760.8271751847515;5767.452092051249;2798.2444739920516;2812.662480502353;2823.294176455886;2837.730415610514;2846.672632647231;928.6007016982762;971.7522031881825;985.9408435493893;1019.1999280564721;1042.0309112525272;374.3841380928412;404.7126540156463;410.72686663368523;418.53751604477225;422.88793469730547;10606.575736970435;10735.409552474688;11017.779644407066;11118.444077796077;11131.077168812888;389.7934094929692;427.8010725012884;441.0891509033835;442.10032583692674;464.8768076459741;5720.399358067426;5833.970830145907;5946.167536544887;5962.135490353874;5983.700814959235;539075;547473;559547;563472;572529;69496.30503695;72725;72918.63540682262;73657.31713414307;74837.62581187059;425.46816479400746;438.18716281297736;438.6030642268688;439.31466911618617;443.66724956282786;10232.59069637206;10253.231007674305;10293.9485302576;10358.533865975898;10427.426491543038;33532;34231.82884085563;34255.14362140966;34605.30789384148;34717.47923781095;46892.7655361721;47392.28911566261;47412.2888156671;47760.28359574539;47878.760606196745;5801.680907550125;5849.093390524476;5886.676232807236;5903.321118071305;5906.468417842415;10626.36241825493;10658.228860496172;10930.579024726734;11191.944040279746;11203.495842686936;9368.906310936803;9374.296927730311;9642.662506812228;9658.227341812497;9680.225581953286;8948.776280593038;9221.400608960395;9248.075192480697;9350.345475816628;9384.249260059316;7708.537487750753;9253.120953509406;9750.951245243728;9754.951225243829;9958.452285124387;5862.3844496328975;5874.911876321944;5915.142304365757;5915.674637894785;5917.319508256605;9491.098345657152;9523.384770909612;9527.285453591147;9624.278179136452;9703.126718595078 02:21:56 INFO - 2015-11-05 02:21:56,546 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1188.4295538141698;1549.341529849814;1641.7701521786953;1651.1001504180224;1686.3760408648802;6502.284748677642;6766.526343155975;6919.861602767942;7008;7123.0740003799565;7039.824004399892;7136.678849451774;7194.316539928712;7208.207097219301;7225.988361629376;1784.7858257009177;1838.8896666200071;2043.7240972468712;2078.2102800935622;2089.2478707665227;2001.3095482058739;2021.4137900009052;2040.2757021257462;2040.8673436226672;2046.0690385874466;1945.2802463088606;1948.9707654385195;1960.0493760526133;1993.8703984241051;1996.5607566335384;2003.6693945498976;2029.573789504206;2041.2243347527992;2066.8036536529007;2067.7105205271273;2012.3962811156593;2012.7383440152832;2036.0430597619243;2037.4193354893785;2041.1121162294448;7076.186238582577;7150.427965762727;7189.245129261404;7194.4963852530345;7256.092988376453;4216.62050415461;4318.5465526119615;4322.589354011364;4329.025969156946;4342.630876375511;2504.686914135733;2585.75435333643;2607.9478410431875;2608.29576014475;2636.670416197975;678.6131904814258;683.6000939450428;734.720806093681;771.4484143837184;776.9184235655288;9417.38786978851;9435.90564094357;9438;9447.669331573363;9541.33210675253;3983.2830090583393;4009.1981603679383;4034.334334834778;4050.2911990401562;4121.196366708523;8411.327093832479;8413.368997325102;8427.873581896276;8435;8502.404831661725;4437.955620443819;4439.556044395599;4441.733495990251;4464.598186163261;4490.775461226991;4031.9395209071886;4045.9797701011894;4054.4729185205733;4075.1849630074103;4090.3250963590676;3349.8157601331673;3402.387570237381;3438.0717206354143;3444.9655503445147;3459.8270086496077;1074.0655629602295;1092.4974511724536;1101.0621306500616;1106.2919731371928;1106.319613437746;950.7290422229631;971.1114330387617;971.3977334052792;1146.954121835134;1184.135581025856;6710.698018589175;6791.524593278522;6852.45180385568;6861.519693621499;6862.622555759481;421.48157765948054;424.5987541772995;427.1755511862074;432.9458817647794;433.47982421094815;5371.650842695212;5378.273933019071;5460.372057213392;5463.016657001778;5468.64453810509;7667.003289572432;8061.798455038554;8281.792955176048;8300.04549476818;8377.748667539983;7822.061352637606;7963.362930965509;8029.518228906284;8033.558154301452;8095.39284553649;6678.9332106679285;6788.355106264897;6803.421709154777;6822.4200942919415;6862.176538815274;6642.634655093823;6796;6806.727730890709;6838.829029274308;6921.653917304014;7581.166071731995;7637.961810190914;7689.50018248812;7729.652165652672;7758.456908016385;7747;7835.529868207926;7857.332126769289;7989.480683755537;8013.959930200312;5997.4002599741425;6148.661823599745;6158.907616385847;6163.322034576104;6176.722047507783;6638.966805165944;6706.798796036127;6731.4951378647775;6842.794716158523;6862.382385585322;6430.710618022106;6460.644664543307;6470.708818103102;6537.5750576212395;6579.440747536513;6171.783987560414;6221.440070393686;6288;6396.840078998062;6427.132337134427;6344.199610182805;6394.23269207698;6406.295307516077;6472.546921715435;6485.124508191334;5871.031279838779;5911.201987731602;5915.733791979285;5991.910121348096;6002.069679199731;5968.970155149196;5980.401959803985;6036.336003039574;6060.939390606038;6092.025275955826 02:21:56 INFO - 2015-11-05 02:21:56,549 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.3039711083288;304.1392858211261;305.62255614316325;306.9002574163396;311.89551500247416;5526.253955715977;5546.91679624806;5573.749181286852;5596.27248457701;5620.775168993246;5456.154296084103;5461.453854614537;5510.504054635082;5535.142052981794;5564.944350556493;4202.6007529284825;4375.540568240321;4407.6033157015945;4418.315161150027;4424;4189.727667701605;4232.619064284214;4284.935725964113;4304.182205380983;4333.674974376934;4197.916041679165;4211.894702632428;4212.53662097169;4238.215930052935;4267.615914567688;4196.811143498535;4203.4115223868685;4241.448611680493;4241.87274381769;4245.639120674747;3691.8523259069607;3747.1381582235967;3761.2101458693705;3767.830447629863;3790.166163444038;5326.067938110854;5336.439673834269;5371.677699338053;5385.434529374437;5435.320584926884;4758.666893317469;4761.857144285677;4774.594159496447;4831.685940413862;4833.154198015369;5600.411956744565;5702.800401985952;5730.255066841326;5770;5784.652920824764;3881.6894648428056;3910.1006768443417;3910.921781564353;3913.745606535566;3945.408188771707;5966.463018328372;6061.424164704346;6091.878162436771;6116.235470566179;6148.661823599745;3975.5030621172355;3981.7610943343493;3993.4808474898077;3994.141259629194;3997;3800.7149463790324;3838.7504812187117;3924.2543916656314;3983.063979964706;4017.5379831319187;4626.097910907408;4627.329037289574;4699.483056863743;4711.740854253049;4713.528647135327;5745.511631511368;5753.626014309057;5756.02147634903;5821.27234095738;5869.266341707286;1435.2823588205897;1460.58373363593;1463.158683756844;1465.0989641370693;1466.1349803615917;921.8386782313069;927.9489628070386;950.3062764182048;960.4093482508347;963.949295268147;5660.349059858169;5670.631408958405;5671.914921276184;5678.971605141948;5708.885822283531;6098.0243161094895;6109.633421994695;6148.9692551537855;6180.845478863064;6215.751369945242;5589.776408943678;5602.915956260659;5642.153676948491;5643.887122257532;5696.3449203341315;3275.5905511811025;3324.335132973415;3341.1480072581335;3349.5143204235737;3392.7625066245128;6064.818055458343;6093.055576385667;6147.477464415485;6166.290876549165;6196.039613859859;6165.630062196283;6181.072839074175;6183.196184495987;6201.410865967726;6230.688465576703;5878.088896221093;6125.785597504066;6135.662538560422;6196.349383314687;6238.937610623836;6072.1498990140535;6130.63216207029;6143.293521245114;6149.600275982047;6170.074488826533;5956.434138756985;5957.4042595740075;6025.66858822769;6033.698315084141;6069.969650151721;5981.431763982415;6130.601510901777;6235.314115447207;6239.78160764371;6244.188255526752;3851.595582463801;3900.64894159527;3907.374820028782;3936.626020528045;3939.842406303716;5858.502027327725;5967.37342579023;6095.8780824382375;6169.043798211284;6171.413715697002;5779.364269930388;5780.797672081457;5862.267216597926;5905.881882362414;5937.287525496968;5817.2146760188525;5833.095870140135;5905.675187864708;5909.143174239625;5910.143029260647;5520.66875987442;5698.458646428583;5741.339745929272;5745.683987380734;5767.192593037062;5796.9420305798085;5830.591858570029;5887.352391236875;5914.290285165635;6001.339852616296;5720.513756330759;5762.1068734346245;5826.650400975955;5854.736536855767;5862.736176871966 02:21:56 INFO - 2015-11-05 02:21:56,549 DEBUG : BROWSER_OUTPUT: |5;yui.html;674.4974993629745;684.5481338385713;691.1050190003945;693.6531734132933;708.5890183693458;11795.627732667082;12691.17507362022;12758.80861787074;12788;12923.289219092947;11891.4054297285;11999.940000300008;12011.639650810468;12015.33915634642;12020.27878327301;689.2487188964028;689.3416786968434;816.1919699497499;831.7463173732009;834.5034704350932;822.4900561651784;835.0105125426359;836.7573403712946;838.6016642094986;839.2237180607943;854.2397266432848;861.2765277167179;861.2894362151219;862.8964524257067;867.9088695686956;710.0343532795395;712.6223101756077;861.814709837388;862.211076864668;866.0213958227226;635.7139287320724;643.5881036136876;643.8519140597642;648.5460177875506;653.2716021635889;12867.356632168448;12869.485220591165;12895.22628642275;13011.21932684042;13016.869831301661;10704.30422022566;10823.783524329549;10896.18278629106;11034.117270618332;11064.18244268707;8593.699220527315;8719.171678690514;8779.73660790171;8836;8953.865692014626;2928.061831153397;2961.481740695391;3032.4844776387845;3072.554479600468;3123.344097739455;46959.765201174116;47146;47393.52606473926;47462.288065679044;47477.76261118707;8196;8230.62962166704;8303.875441868377;8405.831883362422;8460.957695211484;17871.910640446713;17878.642427151382;18029.368972085915;18041.188146533437;18057.458276251735;6446.645434501147;6487.091807147003;6601.108850305243;6653.63405012729;6675.499337549703;3361.9495707564406;3414.5048967899515;3441.776284541547;3456.861725531001;3574.8748793792092;2644.523985682557;2690.1122629532206;2702.121810411624;2709.580015097663;2723.9727602724115;407.23643169058016;415.2110989120695;422.80550946564307;423.65048834711484;428.22491290763816;470.6846412903363;478.93294938708607;499.4805402381555;519.6258693740501;538.2572050570188;7144.3570078693165;7285.089363829521;7366.889496657554;7630.351420129351;7719.729809456642;383.7601499063086;423.3184572837729;479.68101212693864;549.6976662835425;564.5596434780878;3311.8012919224925;3326.9001929941655;3352.2792599591203;3443.1220038889924;3451.4650229214008;52481.47518524766;53186.734066330195;53699.73150134303;53807.73096134494;58547;49903;50522.49477505252;50547.494525055015;51387;51723.482765171866;45970.77014614906;46325.536744632795;46573.06853862971;47622.761886189655;47645.5235447648;7415.406767458699;7429.888551671621;7431.071116110486;7538.623068846646;7602.771916842504;34406.483902740976;34485.827570861984;34533.82733086318;35272.294554109285;35289.117772055906;45982.080358393316;46062;46505.30242046304;46547;46555.301670475645;6963.338482844122;7016.614086225307;7144.285571442814;7273.9636301818155;7363.815904602214;10194.337368071052;10374.22193335518;10426.635067772591;10523.421211833116;10539.42033188182;9560.904390956279;9575.952120239353;9652.565634546321;9805.362651427635;9993.600255989679;9315.34792564514;9663.613455461984;9720.75698107553;9825.950870245602;10180.032896874785;9317.301202409712;9772.071653192936;9789.85315220258;9902.554385052834;10303.072723454925;8141.185881411811;8572.957135214285;8682;8824.647014119364;9052.502112383881;7962.761117166494;8173.959130204311;8473.95763021181;8694.739157825275;8724.738257852274 02:21:56 INFO - 2015-11-05 02:21:56,551 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:21:56 INFO - 2015-11-05 02:21:56,551 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:21:56 INFO - 2015-11-05 02:21:56,551 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,930 02:21:56 INFO - 2015-11-05 02:21:56,551 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:21:56 INFO - 2015-11-05 02:21:56,552 DEBUG : BROWSER_OUTPUT: __startTimestamp1446718916536__endTimestamp 02:21:56 INFO - 2015-11-05 02:21:56,552 DEBUG : BROWSER_OUTPUT: 02:21:56 INFO - 2015-11-05 02:21:56,552 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:21:56 INFO - 2015-11-05 02:21:56,552 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:21:56 INFO - 2015-11-05 02:21:56,552 DEBUG : BROWSER_OUTPUT: 02:21:56 INFO - 2015-11-05 02:21:56,552 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4944.17 Median:5057.47 stddev:519.22 (10.3%) stddev-sans-first:494.95 02:21:56 INFO - 2015-11-05 02:21:56,553 DEBUG : BROWSER_OUTPUT: Values: 2880.9 2944.7 2950.6 2953.7 2981.9 4867.3 4905.4 4909.3 4926.4 4999.0 4903.9 4936.9 4946.5 4967.1 5027.1 4506.0 4605.8 4625.6 4637.4 4709.0 4616.0 4635.0 4637.3 4643.3 4744.4 4594.7 4645.8 4650.7 4659.9 4709.1 4621.3 4685.1 4690.9 4759.5 4799.6 4651.8 4702.8 4728.3 4731.8 4756.6 4780.3 4859.0 4892.3 4975.8 4976.5 5080.6 5149.4 5170.6 5196.2 5233.9 5301.8 5360.5 5398.6 5400.8 5415.9 4772.4 4877.4 4899.1 5038.4 5045.9 5274.9 5435.8 5453.8 5458.6 5474.9 5177.1 5211.1 5214.9 5215.3 5282.0 5106.2 5234.3 5235.6 5297.5 5344.6 5030.5 5144.3 5153.4 5177.8 5265.3 5281.5 5292.9 5300.2 5327.7 5355.4 3904.0 4027.3 4077.4 4150.8 4154.1 3660.7 3710.1 3714.2 3742.3 3746.7 5047.1 5047.7 5049.3 5077.5 5132.3 5193.3 5323.6 5380.4 5409.2 5413.7 4925.2 5005.6 5023.8 5052.2 5077.8 4729.6 4771.0 4785.2 4802.6 4808.4 5207.6 5337.5 5353.5 5494.9 5532.5 5276.7 5346.1 5359.1 5371.8 5379.6 5420.9 5451.6 5455.7 5460.9 5549.1 5029.1 5108.9 5110.0 5329.7 5335.7 5207.9 5220.2 5295.2 5296.9 5301.7 5035.2 5213.5 5224.3 5247.4 5269.7 4947.3 5057.5 5120.1 5235.6 5244.8 4963.4 4975.1 4976.2 5037.1 5093.3 5215.2 5246.3 5247.6 5281.8 5312.4 4895.0 4998.9 5063.7 5128.1 5163.4 02:21:56 INFO - 2015-11-05 02:21:56,553 DEBUG : BROWSER_OUTPUT: 02:21:56 INFO - 2015-11-05 02:21:56,553 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44952.32 Median:158154.85 stddev:78857.33 (49.9%) stddev-sans-first:79007.96 02:21:56 INFO - 2015-11-05 02:21:56,555 DEBUG : BROWSER_OUTPUT: Values: 516.8 517.1 530.2 535.2 543.1 29904.0 31012.2 36130.5 36793.6 37235.6 38980.8 39075.4 39500.0 39610.8 39657.8 7764.3 8403.3 8476.6 8603.0 8611.2 7759.0 10117.1 10219.4 10332.6 10342.2 9947.7 10073.4 10087.9 10182.4 10190.6 7882.8 8197.6 9965.6 10065.9 10070.8 9651.6 9932.6 9938.5 9957.7 10035.7 36744.6 36853.0 36888.3 36901.3 37089.1 2720.2 2757.8 3017.4 3116.7 3197.2 24662.4 24913.1 25021.2 25526.4 26401.9 2135.5 2168.9 2192.3 2245.3 2257.6 257249.0 258013.0 258109.0 258426.0 258646.0 45985.8 48005.0 52605.5 54413.5 54938.5 50986.0 51186.0 51349.2 51649.0 51650.5 15489.4 15687.1 15907.6 15924.5 15943.1 12075.3 12106.2 12153.5 12243.6 12244.7 17456.1 17695.8 17713.6 17739.4 17924.3 7571.1 7822.2 7838.6 7877.8 7892.4 808.8 852.7 966.5 998.8 1024.3 26181.5 26347.9 26361.8 26490.9 26578.9 837.2 1023.8 1024.4 1050.2 1122.4 12692.6 13520.1 13818.0 14251.4 14657.7 313193.0 318317.0 318659.0 318828.0 320719.0 51755.7 51757.7 52124.0 52356.5 52423.5 1276.1 1293.5 1295.2 1296.0 1310.6 26060.2 26649.2 26874.5 27250.3 27277.3 43731.6 43836.0 43939.3 44179.8 44250.8 277473.0 283035.0 289196.0 367610.0 376822.0 27211.5 27330.5 27866.6 28041.3 28210.2 33896.7 37231.1 37879.2 37949.6 38718.8 30784.0 32054.5 32339.7 32656.2 33044.5 32212.0 32455.4 32523.7 32672.7 32689.3 32718.8 33262.7 33291.8 33371.2 33426.0 24704.4 25208.5 28229.3 28951.0 29653.6 21911.2 22136.3 22188.4 22195.3 22321.7 02:21:56 INFO - 2015-11-05 02:21:56,555 DEBUG : BROWSER_OUTPUT: 02:21:56 INFO - 2015-11-05 02:21:56,555 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26731.48 Median:47586.29 stddev:91194.89 (191.6%) stddev-sans-first:91429.13 02:21:56 INFO - 2015-11-05 02:21:56,557 DEBUG : BROWSER_OUTPUT: Values: 309.7 314.1 319.1 321.1 331.3 14038.3 14442.1 16209.8 16439.5 16555.3 13930.9 14070.6 15938.6 16517.7 17163.1 4842.3 5013.8 5049.2 5062.5 5080.3 3114.5 4980.6 4983.0 4984.3 5011.1 3153.4 3206.4 4275.6 4382.3 4413.2 4347.3 4378.0 4410.3 4418.5 4437.8 3663.6 3695.2 3785.8 3792.5 3826.3 12270.9 12337.6 12515.3 12527.8 12656.4 1697.8 1782.7 1784.2 1859.7 1878.6 9027.6 9107.4 9110.4 9271.2 9297.2 1389.9 1438.7 1450.4 1457.1 1459.7 55610.0 56608.4 56633.0 56944.4 57160.1 5982.2 6014.4 6167.0 6194.7 6212.0 7237.4 7245.1 7246.2 7251.4 7255.4 5193.6 5325.4 5330.3 5353.5 5381.7 5688.4 5726.3 5753.5 5760.8 5767.5 2798.2 2812.7 2823.3 2837.7 2846.7 928.6 971.8 985.9 1019.2 1042.0 374.4 404.7 410.7 418.5 422.9 10606.6 10735.4 11017.8 11118.4 11131.1 389.8 427.8 441.1 442.1 464.9 5720.4 5834.0 5946.2 5962.1 5983.7 539075.0 547473.0 559547.0 563472.0 572529.0 69496.3 72725.0 72918.6 73657.3 74837.6 425.5 438.2 438.6 439.3 443.7 10232.6 10253.2 10293.9 10358.5 10427.4 33532.0 34231.8 34255.1 34605.3 34717.5 46892.8 47392.3 47412.3 47760.3 47878.8 5801.7 5849.1 5886.7 5903.3 5906.5 10626.4 10658.2 10930.6 11191.9 11203.5 9368.9 9374.3 9642.7 9658.2 9680.2 8948.8 9221.4 9248.1 9350.3 9384.2 7708.5 9253.1 9751.0 9755.0 9958.5 5862.4 5874.9 5915.1 5915.7 5917.3 9491.1 9523.4 9527.3 9624.3 9703.1 02:21:56 INFO - 2015-11-05 02:21:56,557 DEBUG : BROWSER_OUTPUT: 02:21:56 INFO - 2015-11-05 02:21:56,557 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4956.58 Median:6167.55 stddev:2583.19 (41.9%) stddev-sans-first:2574.91 02:21:56 INFO - 2015-11-05 02:21:56,557 DEBUG : BROWSER_OUTPUT: Values: 1188.4 1549.3 1641.8 1651.1 1686.4 6502.3 6766.5 6919.9 7008.0 7123.1 7039.8 7136.7 7194.3 7208.2 7226.0 1784.8 1838.9 2043.7 2078.2 2089.2 2001.3 2021.4 2040.3 2040.9 2046.1 1945.3 1949.0 1960.0 1993.9 1996.6 2003.7 2029.6 2041.2 2066.8 2067.7 2012.4 2012.7 2036.0 2037.4 2041.1 7076.2 7150.4 7189.2 7194.5 7256.1 4216.6 4318.5 4322.6 4329.0 4342.6 2504.7 2585.8 2607.9 2608.3 2636.7 678.6 683.6 734.7 771.4 776.9 9417.4 9435.9 9438.0 9447.7 9541.3 3983.3 4009.2 4034.3 4050.3 4121.2 8411.3 8413.4 8427.9 8435.0 8502.4 4438.0 4439.6 4441.7 4464.6 4490.8 4031.9 4046.0 4054.5 4075.2 4090.3 3349.8 3402.4 3438.1 3445.0 3459.8 1074.1 1092.5 1101.1 1106.3 1106.3 950.7 971.1 971.4 1147.0 1184.1 6710.7 6791.5 6852.5 6861.5 6862.6 421.5 424.6 427.2 432.9 433.5 5371.7 5378.3 5460.4 5463.0 5468.6 7667.0 8061.8 8281.8 8300.0 8377.7 7822.1 7963.4 8029.5 8033.6 8095.4 6678.9 6788.4 6803.4 6822.4 6862.2 6642.6 6796.0 6806.7 6838.8 6921.7 7581.2 7638.0 7689.5 7729.7 7758.5 7747.0 7835.5 7857.3 7989.5 8014.0 5997.4 6148.7 6158.9 6163.3 6176.7 6639.0 6706.8 6731.5 6842.8 6862.4 6430.7 6460.6 6470.7 6537.6 6579.4 6171.8 6221.4 6288.0 6396.8 6427.1 6344.2 6394.2 6406.3 6472.5 6485.1 5871.0 5911.2 5915.7 5991.9 6002.1 5969.0 5980.4 6036.3 6060.9 6092.0 02:21:56 INFO - 2015-11-05 02:21:56,557 DEBUG : BROWSER_OUTPUT: 02:21:56 INFO - 2015-11-05 02:21:56,557 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4874.53 Median:5652.12 stddev:1486.51 (26.3%) stddev-sans-first:1450.39 02:21:56 INFO - 2015-11-05 02:21:56,559 DEBUG : BROWSER_OUTPUT: Values: 294.3 304.1 305.6 306.9 311.9 5526.3 5546.9 5573.7 5596.3 5620.8 5456.2 5461.5 5510.5 5535.1 5564.9 4202.6 4375.5 4407.6 4418.3 4424.0 4189.7 4232.6 4284.9 4304.2 4333.7 4197.9 4211.9 4212.5 4238.2 4267.6 4196.8 4203.4 4241.4 4241.9 4245.6 3691.9 3747.1 3761.2 3767.8 3790.2 5326.1 5336.4 5371.7 5385.4 5435.3 4758.7 4761.9 4774.6 4831.7 4833.2 5600.4 5702.8 5730.3 5770.0 5784.7 3881.7 3910.1 3910.9 3913.7 3945.4 5966.5 6061.4 6091.9 6116.2 6148.7 3975.5 3981.8 3993.5 3994.1 3997.0 3800.7 3838.8 3924.3 3983.1 4017.5 4626.1 4627.3 4699.5 4711.7 4713.5 5745.5 5753.6 5756.0 5821.3 5869.3 1435.3 1460.6 1463.2 1465.1 1466.1 921.8 927.9 950.3 960.4 963.9 5660.3 5670.6 5671.9 5679.0 5708.9 6098.0 6109.6 6149.0 6180.8 6215.8 5589.8 5602.9 5642.2 5643.9 5696.3 3275.6 3324.3 3341.1 3349.5 3392.8 6064.8 6093.1 6147.5 6166.3 6196.0 6165.6 6181.1 6183.2 6201.4 6230.7 5878.1 6125.8 6135.7 6196.3 6238.9 6072.1 6130.6 6143.3 6149.6 6170.1 5956.4 5957.4 6025.7 6033.7 6070.0 5981.4 6130.6 6235.3 6239.8 6244.2 3851.6 3900.6 3907.4 3936.6 3939.8 5858.5 5967.4 6095.9 6169.0 6171.4 5779.4 5780.8 5862.3 5905.9 5937.3 5817.2 5833.1 5905.7 5909.1 5910.1 5520.7 5698.5 5741.3 5745.7 5767.2 5796.9 5830.6 5887.4 5914.3 6001.3 5720.5 5762.1 5826.7 5854.7 5862.7 02:21:56 INFO - 2015-11-05 02:21:56,559 DEBUG : BROWSER_OUTPUT: 02:21:56 INFO - 2015-11-05 02:21:56,559 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12995.27 Median:53443.23 stddev:15939.71 (29.8%) stddev-sans-first:15957.57 02:21:56 INFO - 2015-11-05 02:21:56,561 DEBUG : BROWSER_OUTPUT: Values: 674.5 684.5 691.1 693.7 708.6 11795.6 12691.2 12758.8 12788.0 12923.3 11891.4 11999.9 12011.6 12015.3 12020.3 689.2 689.3 816.2 831.7 834.5 822.5 835.0 836.8 838.6 839.2 854.2 861.3 861.3 862.9 867.9 710.0 712.6 861.8 862.2 866.0 635.7 643.6 643.9 648.5 653.3 12867.4 12869.5 12895.2 13011.2 13016.9 10704.3 10823.8 10896.2 11034.1 11064.2 8593.7 8719.2 8779.7 8836.0 8953.9 2928.1 2961.5 3032.5 3072.6 3123.3 46959.8 47146.0 47393.5 47462.3 47477.8 8196.0 8230.6 8303.9 8405.8 8461.0 17871.9 17878.6 18029.4 18041.2 18057.5 6446.6 6487.1 6601.1 6653.6 6675.5 3361.9 3414.5 3441.8 3456.9 3574.9 2644.5 2690.1 2702.1 2709.6 2724.0 407.2 415.2 422.8 423.7 428.2 470.7 478.9 499.5 519.6 538.3 7144.4 7285.1 7366.9 7630.4 7719.7 383.8 423.3 479.7 549.7 564.6 3311.8 3326.9 3352.3 3443.1 3451.5 52481.5 53186.7 53699.7 53807.7 58547.0 49903.0 50522.5 50547.5 51387.0 51723.5 45970.8 46325.5 46573.1 47622.8 47645.5 7415.4 7429.9 7431.1 7538.6 7602.8 34406.5 34485.8 34533.8 35272.3 35289.1 45982.1 46062.0 46505.3 46547.0 46555.3 6963.3 7016.6 7144.3 7274.0 7363.8 10194.3 10374.2 10426.6 10523.4 10539.4 9560.9 9576.0 9652.6 9805.4 9993.6 9315.3 9663.6 9720.8 9826.0 10180.0 9317.3 9772.1 9789.9 9902.6 10303.1 8141.2 8573.0 8682.0 8824.6 9052.5 7962.8 8174.0 8474.0 8694.7 8724.7 02:21:56 INFO - 2015-11-05 02:21:56,561 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:21:56 INFO - 2015-11-05 02:21:56,561 DEBUG : BROWSER_OUTPUT: 02:21:57 INFO - 2015-11-05 02:21:57,239 INFO : Browser exited with error code: 0 02:21:57 INFO - 2015-11-05 02:21:57,270 INFO : Completed test dromaeo_css (00:18:35) 02:21:57 INFO - 2015-11-05 02:21:57,270 INFO : Starting test kraken 02:21:57 INFO - 2015-11-05 02:21:57,271 DEBUG : operating with platform_type : mac_ 02:21:57 INFO - 2015-11-05 02:21:57,271 INFO : Initialising browser for kraken test... 02:21:57 INFO - 2015-11-05 02:21:57,286 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpS2Zc6r/profile http://localhost:49277/getInfo.html 02:21:59 INFO - 2015-11-05 02:21:59,751 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:21:59 INFO - 2015-11-05 02:21:59,751 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:21:59 INFO - 2015-11-05 02:21:59,752 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:21:59 INFO - 2015-11-05 02:21:59,752 DEBUG : BROWSER_OUTPUT: __metrics 02:21:59 INFO - 2015-11-05 02:21:59,767 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:22:00 INFO - 2015-11-05 02:22:00,531 INFO : Browser initialized. 02:22:00 INFO - 2015-11-05 02:22:00,532 INFO : Running cycle 1/1 for kraken test... 02:22:00 INFO - 2015-11-05 02:22:00,532 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmpS2Zc6r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:22:12 INFO - 2015-11-05 02:22:12,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 199925760 02:22:12 INFO - 2015-11-05 02:22:12,482 DEBUG : BROWSER_OUTPUT: 02:22:15 INFO - 2015-11-05 02:22:15,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 02:22:15 INFO - 2015-11-05 02:22:15,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 263766016 02:22:15 INFO - 2015-11-05 02:22:15,834 DEBUG : BROWSER_OUTPUT: 02:22:18 INFO - 2015-11-05 02:22:18,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 02:22:19 INFO - 2015-11-05 02:22:19,350 DEBUG : BROWSER_OUTPUT: RSS: Main: 278056960 02:22:19 INFO - 2015-11-05 02:22:19,351 DEBUG : BROWSER_OUTPUT: 02:22:22 INFO - 2015-11-05 02:22:22,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 02:22:23 INFO - 2015-11-05 02:22:23,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 263278592 02:22:23 INFO - 2015-11-05 02:22:23,029 DEBUG : BROWSER_OUTPUT: 02:22:25 INFO - 2015-11-05 02:22:25,220 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 02:22:25 INFO - 2015-11-05 02:22:25,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 264409088 02:22:25 INFO - 2015-11-05 02:22:25,795 DEBUG : BROWSER_OUTPUT: 02:22:28 INFO - 2015-11-05 02:22:28,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:22:28 INFO - 2015-11-05 02:22:28,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 263712768 02:22:28 INFO - 2015-11-05 02:22:28,727 DEBUG : BROWSER_OUTPUT: 02:22:32 INFO - 2015-11-05 02:22:32,100 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 02:22:32 INFO - 2015-11-05 02:22:32,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 263221248 02:22:32 INFO - 2015-11-05 02:22:32,688 DEBUG : BROWSER_OUTPUT: 02:22:36 INFO - 2015-11-05 02:22:36,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 02:22:36 INFO - 2015-11-05 02:22:36,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 264568832 02:22:36 INFO - 2015-11-05 02:22:36,717 DEBUG : BROWSER_OUTPUT: 02:22:39 INFO - 2015-11-05 02:22:39,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 02:22:40 INFO - 2015-11-05 02:22:40,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 265076736 02:22:40 INFO - 2015-11-05 02:22:40,462 DEBUG : BROWSER_OUTPUT: 02:22:42 INFO - 2015-11-05 02:22:42,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:42 INFO - 2015-11-05 02:22:42,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 297979904 02:22:42 INFO - 2015-11-05 02:22:42,740 DEBUG : BROWSER_OUTPUT: 02:22:44 INFO - 2015-11-05 02:22:44,709 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:45 INFO - 2015-11-05 02:22:45,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 300507136 02:22:45 INFO - 2015-11-05 02:22:45,326 DEBUG : BROWSER_OUTPUT: 02:22:47 INFO - 2015-11-05 02:22:47,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:22:48 INFO - 2015-11-05 02:22:48,171 DEBUG : BROWSER_OUTPUT: RSS: Main: 306675712 02:22:48 INFO - 2015-11-05 02:22:48,171 DEBUG : BROWSER_OUTPUT: 02:22:50 INFO - 2015-11-05 02:22:50,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:22:51 INFO - 2015-11-05 02:22:51,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 308539392 02:22:51 INFO - 2015-11-05 02:22:51,542 DEBUG : BROWSER_OUTPUT: 02:22:54 INFO - 2015-11-05 02:22:54,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:22:54 INFO - 2015-11-05 02:22:54,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 307957760 02:22:54 INFO - 2015-11-05 02:22:54,864 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 02:22:56 INFO - 2015-11-05 02:22:56,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 367759360 02:22:56 INFO - 2015-11-05 02:22:56,962 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,962 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:22:56 INFO - 2015-11-05 02:22:56,962 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:22:56 INFO - 2015-11-05 02:22:56,962 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:22:56 INFO - 2015-11-05 02:22:56,962 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:22:56 INFO - 2015-11-05 02:22:56,962 DEBUG : BROWSER_OUTPUT: |0;ai-astar;117;121;113;122;125;124;116;125;110;120 02:22:56 INFO - 2015-11-05 02:22:56,963 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;170;162;203;177;145;162;141;183;173;149 02:22:56 INFO - 2015-11-05 02:22:56,963 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;180;186;187;180;178;181;181;180;186 02:22:56 INFO - 2015-11-05 02:22:56,963 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;91;92;136;77;80;81;78;127;76 02:22:56 INFO - 2015-11-05 02:22:56,963 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;110;111;150;104;103;101;139;99;97;137 02:22:56 INFO - 2015-11-05 02:22:56,963 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;134;141;142;129;135;136;139;129;135;141 02:22:56 INFO - 2015-11-05 02:22:56,963 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;140;147;144;140;141;140;147;143;140;140 02:22:56 INFO - 2015-11-05 02:22:56,963 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;119;116;113;117;118;119;116;113;118 02:22:56 INFO - 2015-11-05 02:22:56,963 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;67;70;70;70;78;73;83;64;64 02:22:56 INFO - 2015-11-05 02:22:56,964 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;74;76;81;78;79;76;77;76;76 02:22:56 INFO - 2015-11-05 02:22:56,964 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;93;98;97;96;94;93;92;95;101;103 02:22:56 INFO - 2015-11-05 02:22:56,964 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;142;149;141;132;138;140;143;142;135;139 02:22:56 INFO - 2015-11-05 02:22:56,964 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;155;168;156;152;164;163;167;167;150 02:22:56 INFO - 2015-11-05 02:22:56,964 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;77;78;77;80;80;81;80;76;77 02:22:56 INFO - 2015-11-05 02:22:56,965 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:22:56 INFO - 2015-11-05 02:22:56,965 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:22:56 INFO - 2015-11-05 02:22:56,965 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,910 02:22:56 INFO - 2015-11-05 02:22:56,967 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:22:56 INFO - 2015-11-05 02:22:56,967 DEBUG : BROWSER_OUTPUT: __startTimestamp1446718976961__endTimestamp 02:22:56 INFO - 2015-11-05 02:22:56,967 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,967 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:22:56 INFO - 2015-11-05 02:22:56,967 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:22:56 INFO - 2015-11-05 02:22:56,967 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,967 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:119.30 Median:121.50 stddev:5.17 (4.3%) stddev-sans-first:5.41 02:22:56 INFO - 2015-11-05 02:22:56,968 DEBUG : BROWSER_OUTPUT: Values: 117.0 121.0 113.0 122.0 125.0 124.0 116.0 125.0 110.0 120.0 02:22:56 INFO - 2015-11-05 02:22:56,968 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,968 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:166.50 Median:171.50 stddev:18.94 (11.0%) stddev-sans-first:20.05 02:22:56 INFO - 2015-11-05 02:22:56,968 DEBUG : BROWSER_OUTPUT: Values: 170.0 162.0 203.0 177.0 145.0 162.0 141.0 183.0 173.0 149.0 02:22:56 INFO - 2015-11-05 02:22:56,968 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,968 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:181.90 Median:181.00 stddev:3.18 (1.8%) stddev-sans-first:3.30 02:22:56 INFO - 2015-11-05 02:22:56,968 DEBUG : BROWSER_OUTPUT: Values: 180.0 180.0 186.0 187.0 180.0 178.0 181.0 181.0 180.0 186.0 02:22:56 INFO - 2015-11-05 02:22:56,968 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,969 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:92.20 Median:80.50 stddev:21.52 (26.7%) stddev-sans-first:22.62 02:22:56 INFO - 2015-11-05 02:22:56,969 DEBUG : BROWSER_OUTPUT: Values: 84.0 91.0 92.0 136.0 77.0 80.0 81.0 78.0 127.0 76.0 02:22:56 INFO - 2015-11-05 02:22:56,969 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,969 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:115.10 Median:138.00 stddev:19.34 (14.0%) stddev-sans-first:20.43 02:22:56 INFO - 2015-11-05 02:22:56,969 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 150.0 104.0 103.0 101.0 139.0 99.0 97.0 137.0 02:22:56 INFO - 2015-11-05 02:22:56,969 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,970 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:136.10 Median:137.50 stddev:4.70 (3.4%) stddev-sans-first:4.92 02:22:56 INFO - 2015-11-05 02:22:56,971 DEBUG : BROWSER_OUTPUT: Values: 134.0 141.0 142.0 129.0 135.0 136.0 139.0 129.0 135.0 141.0 02:22:56 INFO - 2015-11-05 02:22:56,971 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,971 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:142.20 Median:142.00 stddev:2.90 (2.0%) stddev-sans-first:2.96 02:22:56 INFO - 2015-11-05 02:22:56,971 DEBUG : BROWSER_OUTPUT: Values: 140.0 147.0 144.0 140.0 141.0 140.0 147.0 143.0 140.0 140.0 02:22:56 INFO - 2015-11-05 02:22:56,971 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,971 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.70 Median:118.00 stddev:2.21 (1.9%) stddev-sans-first:2.30 02:22:56 INFO - 2015-11-05 02:22:56,972 DEBUG : BROWSER_OUTPUT: Values: 118.0 119.0 116.0 113.0 117.0 118.0 119.0 116.0 113.0 118.0 02:22:56 INFO - 2015-11-05 02:22:56,972 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,972 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.00 stddev:6.70 (9.6%) stddev-sans-first:6.26 02:22:56 INFO - 2015-11-05 02:22:56,972 DEBUG : BROWSER_OUTPUT: Values: 61.0 67.0 70.0 70.0 70.0 78.0 73.0 83.0 64.0 64.0 02:22:56 INFO - 2015-11-05 02:22:56,972 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,972 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:76.50 Median:76.50 stddev:2.51 (3.3%) stddev-sans-first:2.06 02:22:56 INFO - 2015-11-05 02:22:56,972 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 76.0 81.0 78.0 79.0 76.0 77.0 76.0 76.0 02:22:56 INFO - 2015-11-05 02:22:56,972 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,973 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:94.50 stddev:3.61 (3.8%) stddev-sans-first:3.64 02:22:56 INFO - 2015-11-05 02:22:56,973 DEBUG : BROWSER_OUTPUT: Values: 93.0 98.0 97.0 96.0 94.0 93.0 92.0 95.0 101.0 103.0 02:22:56 INFO - 2015-11-05 02:22:56,973 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,973 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:141.50 stddev:4.63 (3.3%) stddev-sans-first:4.86 02:22:56 INFO - 2015-11-05 02:22:56,973 DEBUG : BROWSER_OUTPUT: Values: 142.0 149.0 141.0 132.0 138.0 140.0 143.0 142.0 135.0 139.0 02:22:56 INFO - 2015-11-05 02:22:56,973 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,973 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:163.50 stddev:7.64 (4.7%) stddev-sans-first:7.00 02:22:56 INFO - 2015-11-05 02:22:56,973 DEBUG : BROWSER_OUTPUT: Values: 148.0 155.0 168.0 156.0 152.0 164.0 163.0 167.0 167.0 150.0 02:22:56 INFO - 2015-11-05 02:22:56,973 DEBUG : BROWSER_OUTPUT: 02:22:56 INFO - 2015-11-05 02:22:56,973 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.90 Median:79.00 stddev:2.42 (3.1%) stddev-sans-first:1.81 02:22:56 INFO - 2015-11-05 02:22:56,974 DEBUG : BROWSER_OUTPUT: Values: 73.0 77.0 78.0 77.0 80.0 80.0 81.0 80.0 76.0 77.0 02:22:56 INFO - 2015-11-05 02:22:56,974 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:22:56 INFO - 2015-11-05 02:22:56,974 DEBUG : BROWSER_OUTPUT: 02:22:57 INFO - 2015-11-05 02:22:57,670 INFO : Browser exited with error code: 0 02:22:57 INFO - 2015-11-05 02:22:57,726 INFO : Completed test kraken (00:01:00) 02:22:57 INFO - 2015-11-05 02:22:57,726 INFO : Starting test v8_7 02:22:57 INFO - 2015-11-05 02:22:57,726 DEBUG : operating with platform_type : mac_ 02:22:57 INFO - 2015-11-05 02:22:57,726 INFO : Initialising browser for v8_7 test... 02:22:57 INFO - 2015-11-05 02:22:57,741 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmp3Rfzcg/profile http://localhost:49277/getInfo.html 02:23:00 INFO - 2015-11-05 02:23:00,105 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:23:00 INFO - 2015-11-05 02:23:00,105 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:23:00 INFO - 2015-11-05 02:23:00,105 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 02:23:00 INFO - 2015-11-05 02:23:00,105 DEBUG : BROWSER_OUTPUT: __metrics 02:23:00 INFO - 2015-11-05 02:23:00,142 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:23:00 INFO - 2015-11-05 02:23:00,886 INFO : Browser initialized. 02:23:00 INFO - 2015-11-05 02:23:00,887 INFO : Running cycle 1/1 for v8_7 test... 02:23:00 INFO - 2015-11-05 02:23:00,887 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/T/tmp3Rfzcg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:23:12 INFO - 2015-11-05 02:23:12,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 199806976 02:23:12 INFO - 2015-11-05 02:23:12,878 DEBUG : BROWSER_OUTPUT: 02:23:35 INFO - 2015-11-05 02:23:35,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49277/tests/v8_7/run.html (next: http://localhost:49277/tests/v8_7/run.html) 02:23:36 INFO - 2015-11-05 02:23:36,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 522764288 02:23:36 INFO - 2015-11-05 02:23:36,005 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,005 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:23:36 INFO - 2015-11-05 02:23:36,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:23:36 INFO - 2015-11-05 02:23:36,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:23:36 INFO - 2015-11-05 02:23:36,005 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:23:36 INFO - 2015-11-05 02:23:36,005 DEBUG : BROWSER_OUTPUT: |0;Richards;182.81535648994515 02:23:36 INFO - 2015-11-05 02:23:36,006 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;215.79628830384118 02:23:36 INFO - 2015-11-05 02:23:36,006 DEBUG : BROWSER_OUTPUT: |2;Encrypt;361.14120621162874 02:23:36 INFO - 2015-11-05 02:23:36,006 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6401.273885350319 02:23:36 INFO - 2015-11-05 02:23:36,006 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1145.475372279496 02:23:36 INFO - 2015-11-05 02:23:36,006 DEBUG : BROWSER_OUTPUT: |5;Earley;766.4624808575804 02:23:36 INFO - 2015-11-05 02:23:36,007 DEBUG : BROWSER_OUTPUT: |6;Boyer;14169.014084507042 02:23:36 INFO - 2015-11-05 02:23:36,007 DEBUG : BROWSER_OUTPUT: |7;RegExp;33000 02:23:36 INFO - 2015-11-05 02:23:36,007 DEBUG : BROWSER_OUTPUT: |8;Splay;686.8131868131868 02:23:36 INFO - 2015-11-05 02:23:36,007 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6464.5161290322585 02:23:36 INFO - 2015-11-05 02:23:36,007 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:23:36 INFO - 2015-11-05 02:23:36,007 DEBUG : BROWSER_OUTPUT: __startTimestamp1446719016003__endTimestamp 02:23:36 INFO - 2015-11-05 02:23:36,008 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,008 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:23:36 INFO - 2015-11-05 02:23:36,008 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:23:36 INFO - 2015-11-05 02:23:36,008 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,008 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:182.82 Median:182.82 stddev:0.00 (0.0%) 02:23:36 INFO - 2015-11-05 02:23:36,008 DEBUG : BROWSER_OUTPUT: Values: 182.8 02:23:36 INFO - 2015-11-05 02:23:36,009 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,009 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:215.80 Median:215.80 stddev:0.00 (0.0%) 02:23:36 INFO - 2015-11-05 02:23:36,009 DEBUG : BROWSER_OUTPUT: Values: 215.8 02:23:36 INFO - 2015-11-05 02:23:36,009 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,009 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:361.14 Median:361.14 stddev:0.00 (0.0%) 02:23:36 INFO - 2015-11-05 02:23:36,009 DEBUG : BROWSER_OUTPUT: Values: 361.1 02:23:36 INFO - 2015-11-05 02:23:36,009 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,010 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6401.27 Median:6401.27 stddev:0.00 (0.0%) 02:23:36 INFO - 2015-11-05 02:23:36,010 DEBUG : BROWSER_OUTPUT: Values: 6401.3 02:23:36 INFO - 2015-11-05 02:23:36,010 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,010 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1145.48 Median:1145.48 stddev:0.00 (0.0%) 02:23:36 INFO - 2015-11-05 02:23:36,010 DEBUG : BROWSER_OUTPUT: Values: 1145.5 02:23:36 INFO - 2015-11-05 02:23:36,010 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,011 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:766.46 Median:766.46 stddev:0.00 (0.0%) 02:23:36 INFO - 2015-11-05 02:23:36,011 DEBUG : BROWSER_OUTPUT: Values: 766.5 02:23:36 INFO - 2015-11-05 02:23:36,011 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,011 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14169.01 Median:14169.01 stddev:0.00 (0.0%) 02:23:36 INFO - 2015-11-05 02:23:36,011 DEBUG : BROWSER_OUTPUT: Values: 14169.0 02:23:36 INFO - 2015-11-05 02:23:36,011 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,011 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33000.00 Median:33000.00 stddev:0.00 (0.0%) 02:23:36 INFO - 2015-11-05 02:23:36,011 DEBUG : BROWSER_OUTPUT: Values: 33000.0 02:23:36 INFO - 2015-11-05 02:23:36,012 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,012 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:686.81 Median:686.81 stddev:0.00 (0.0%) 02:23:36 INFO - 2015-11-05 02:23:36,012 DEBUG : BROWSER_OUTPUT: Values: 686.8 02:23:36 INFO - 2015-11-05 02:23:36,012 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,012 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6464.52 Median:6464.52 stddev:0.00 (0.0%) 02:23:36 INFO - 2015-11-05 02:23:36,012 DEBUG : BROWSER_OUTPUT: Values: 6464.5 02:23:36 INFO - 2015-11-05 02:23:36,012 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:23:36 INFO - 2015-11-05 02:23:36,012 DEBUG : BROWSER_OUTPUT: 02:23:36 INFO - 2015-11-05 02:23:36,696 INFO : Browser exited with error code: 0 02:23:36 INFO - 2015-11-05 02:23:36,719 INFO : Completed test v8_7 (00:00:38) 02:23:36 INFO - 2015-11-05 02:23:36,750 INFO : Completed test suite (00:20:15) 02:23:36 INFO - 2015-11-05 02:23:36,750 DEBUG : Working with test: dromaeo_css 02:23:36 INFO - 2015-11-05 02:23:36,750 DEBUG : Generating results file: dromaeo_css 02:23:36 INFO - 2015-11-05 02:23:36,752 DEBUG : Working with test: kraken 02:23:36 INFO - 2015-11-05 02:23:36,752 DEBUG : Generating results file: kraken 02:23:36 INFO - 2015-11-05 02:23:36,752 INFO : javascript benchmark 02:23:36 INFO - 2015-11-05 02:23:36,752 DEBUG : Working with test: v8_7 02:23:36 INFO - 2015-11-05 02:23:36,752 DEBUG : Generating results file: v8_7 02:23:36 INFO - 2015-11-05 02:23:36,752 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:23:36 INFO - 2015-11-05 02:23:36,817 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 02:23:36 INFO - 2015-11-05 02:23:36,817 DEBUG : process_Request line: dromaeo_css 6121.98 graph.html#tests=[[72,52,55]] 02:23:36 INFO - 2015-11-05 02:23:36,817 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:23:36 INFO - 2015-11-05 02:23:36,853 DEBUG : process_Request line: kraken 1689.70 graph.html#tests=[[232,52,55]] 02:23:36 INFO - 2015-11-05 02:23:36,853 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:23:36 INFO - 2015-11-05 02:23:36,885 DEBUG : process_Request line: v8_7 18107.33 graph.html#tests=[[230,52,55]] 02:23:36 INFO - 2015-11-05 02:23:36,886 INFO : javascript benchmark 02:23:36 INFO - 2015-11-05 02:23:36,888 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [309.7398185524159, 314.1235951694772, 319.1271871431635, 321.1249345533422, 331.3488994126541, 14038.29808509573, 14442.061266017728, 16209.75685364719, 16439.506814795546, 16555.337786488526, 13930.903277537342, 14070.577882663536, 15938.601534961632, 16517.66964660706, 17163.141842907837, 4842.29786680931, 5013.799448022093, 5049.166887463564, 5062.544371006608, 5080.339555857733, 3114.517249826269, 4980.576650984671, 4982.953579748258, 4984.3021976923255, 5011.123053465629, 3153.4166179256795, 3206.374756922401, 4275.593818587229, 4382.276924307485, 4413.249747542925, 4347.347897815337, 4378.036831896978, 4410.338449232609, 4418.469783625986, 4437.800298986554, 3663.5970043295215, 3695.2055308108884, 3785.848566057382, 3792.4500947362753, 3826.2921359548573, 12270.938645306716, 12337.568185113567, 12515.311657858814, 12527.812082818766, 12656.430460629294, 1697.7538256952796, 1782.7058535341653, 1784.1971112999202, 1859.7133607035778, 1878.6336664350458, 9027.593758280893, 9107.36248462608, 9110.362274640778, 9271.211946984515, 9297.209737172348, 1389.8957578181678, 1438.6834896322791, 1450.419832067171, 1457.1330058615108, 1459.6569806095558, 55610.0, 56608.43391566073, 56633.0, 56944.430555694744, 57160.142597861064, 5982.192404025488, 6014.398560143951, 6167.0, 6194.690265486708, 6212.0371342441995, 7237.384822290059, 7245.130584329809, 7246.166690830517, 7251.3836323912, 7255.419566434673, 5193.610479214074, 5325.360956685223, 5330.307060082165, 5353.518183363438, 5381.67709937405, 5688.374278829326, 5726.341470730836, 5753.453421924911, 5760.8271751847515, 5767.452092051249, 2798.2444739920516, 2812.662480502353, 2823.294176455886, 2837.730415610514, 2846.672632647231, 928.6007016982762, 971.7522031881825, 985.9408435493893, 1019.1999280564721, 1042.0309112525272, 374.3841380928412, 404.7126540156463, 410.72686663368523, 418.53751604477225, 422.88793469730547, 10606.575736970435, 10735.409552474688, 11017.779644407066, 11118.444077796077, 11131.077168812888, 389.7934094929692, 427.8010725012884, 441.0891509033835, 442.10032583692674, 464.8768076459741, 5720.399358067426, 5833.970830145907, 5946.167536544887, 5962.135490353874, 5983.700814959235, 539075.0, 547473.0, 559547.0, 563472.0, 572529.0, 69496.30503695, 72725.0, 72918.63540682262, 73657.31713414307, 74837.62581187059, 425.46816479400746, 438.18716281297736, 438.6030642268688, 439.31466911618617, 443.66724956282786, 10232.59069637206, 10253.231007674305, 10293.9485302576, 10358.533865975898, 10427.426491543038, 33532.0, 34231.82884085563, 34255.14362140966, 34605.30789384148, 34717.47923781095, 46892.7655361721, 47392.28911566261, 47412.2888156671, 47760.28359574539, 47878.760606196745, 5801.680907550125, 5849.093390524476, 5886.676232807236, 5903.321118071305, 5906.468417842415, 10626.36241825493, 10658.228860496172, 10930.579024726734, 11191.944040279746, 11203.495842686936, 9368.906310936803, 9374.296927730311, 9642.662506812228, 9658.227341812497, 9680.225581953286, 8948.776280593038, 9221.400608960395, 9248.075192480697, 9350.345475816628, 9384.249260059316, 7708.537487750753, 9253.120953509406, 9750.951245243728, 9754.951225243829, 9958.452285124387, 5862.3844496328975, 5874.911876321944, 5915.142304365757, 5915.674637894785, 5917.319508256605, 9491.098345657152, 9523.384770909612, 9527.285453591147, 9624.278179136452, 9703.126718595078], "dojo.html": [2880.884764609416, 2944.676085630581, 2950.631171103612, 2953.719396657317, 2981.865816038278, 4867.269909513575, 4905.411350637928, 4909.3126962225315, 4926.433460152083, 4999.025190087934, 4903.8528844134735, 4936.876578085541, 4946.455889852123, 4967.10592093423, 5027.1202539555525, 4506.0, 4605.815767369301, 4625.560571745679, 4637.397138372015, 4708.952910470885, 4615.976920115395, 4635.049814787961, 4637.281221410687, 4643.326717625942, 4744.4069491313585, 4594.678372513926, 4645.837395691152, 4650.674452788307, 4659.88350291242, 4709.081729062834, 4621.30680397943, 4685.1332503486965, 4690.859274221779, 4759.5002524734755, 4799.592034677056, 4651.767411629405, 4702.78837452312, 4728.3143944127905, 4731.7634118293945, 4756.6432517561325, 4780.282957556359, 4859.0, 4892.339534162878, 4975.825846095369, 4976.45259021511, 5080.568151707109, 5149.433562308143, 5170.560502357304, 5196.168613021899, 5233.895322093536, 5301.787928482856, 5360.544353729938, 5398.649087809319, 5400.83797486076, 5415.864603384907, 4772.427308722976, 4877.439094504107, 4899.118158731462, 5038.395392552917, 5045.873853153664, 5274.947250527523, 5435.755391007414, 5453.754581043862, 5458.61789674719, 5474.863128421742, 5177.068127736969, 5211.140161873249, 5214.921776173361, 5215.295935048795, 5282.049231138355, 5106.208537676666, 5234.26720259164, 5235.607329450307, 5297.54970827484, 5344.599155063386, 5030.547250747451, 5144.279800827887, 5153.433122356538, 5177.792888284502, 5265.289185959923, 5281.471852814765, 5292.867678308073, 5300.1519756838725, 5327.7336133193185, 5355.357357117093, 3904.0, 4027.275090483741, 4077.44954431148, 4150.813213405404, 4154.127633197002, 3660.743747937619, 3710.07248187953, 3714.238581090924, 3742.2702572998546, 3746.662800347982, 5047.116754567936, 5047.671901326402, 5049.26785616091, 5077.517635824591, 5132.255822905658, 5193.324867767166, 5323.574114070942, 5380.381256155514, 5409.188621706697, 5413.702246376409, 4925.236588328815, 5005.62457815658, 5023.799048038038, 5052.216906379517, 5077.847664570068, 4729.597984171384, 4771.021940502189, 4785.1625965455905, 4802.615790736802, 4808.447028591687, 5207.609429292894, 5337.546308563816, 5353.518183363516, 5494.890102198014, 5532.5297349724915, 5276.683398996072, 5346.091164501966, 5359.142537194186, 5371.838844834661, 5379.569634429158, 5420.918686219631, 5451.56387488992, 5455.727213639223, 5460.863478413072, 5549.056660367666, 5029.0947629427055, 5108.872278192926, 5110.029094472187, 5329.733513324396, 5335.706536140549, 5207.895842083061, 5220.243064755513, 5295.152775555893, 5296.867578310573, 5301.708406037705, 5035.219540971156, 5213.504717051874, 5224.268602395591, 5247.422783493889, 5269.736513174403, 4947.282644016669, 5057.468965758542, 5120.129577971679, 5235.554977826928, 5244.76398562058, 4963.404391473046, 4975.0796102721115, 4976.178930476575, 5037.118504261813, 5093.312402825719, 5215.191645294985, 5246.31797866275, 5247.580193584427, 5281.841544753664, 5312.442193569774, 4895.04546613407, 4998.87502812418, 5063.721495317793, 5128.051310507568, 5163.406208285945], "mootools.html": [1188.4295538141698, 1549.341529849814, 1641.7701521786953, 1651.1001504180224, 1686.3760408648802, 6502.284748677642, 6766.526343155975, 6919.861602767942, 7008.0, 7123.0740003799565, 7039.824004399892, 7136.678849451774, 7194.316539928712, 7208.207097219301, 7225.988361629376, 1784.7858257009177, 1838.8896666200071, 2043.7240972468712, 2078.2102800935622, 2089.2478707665227, 2001.3095482058739, 2021.4137900009052, 2040.2757021257462, 2040.8673436226672, 2046.0690385874466, 1945.2802463088606, 1948.9707654385195, 1960.0493760526133, 1993.8703984241051, 1996.5607566335384, 2003.6693945498976, 2029.573789504206, 2041.2243347527992, 2066.8036536529007, 2067.7105205271273, 2012.3962811156593, 2012.7383440152832, 2036.0430597619243, 2037.4193354893785, 2041.1121162294448, 7076.186238582577, 7150.427965762727, 7189.245129261404, 7194.4963852530345, 7256.092988376453, 4216.62050415461, 4318.5465526119615, 4322.589354011364, 4329.025969156946, 4342.630876375511, 2504.686914135733, 2585.75435333643, 2607.9478410431875, 2608.29576014475, 2636.670416197975, 678.6131904814258, 683.6000939450428, 734.720806093681, 771.4484143837184, 776.9184235655288, 9417.38786978851, 9435.90564094357, 9438.0, 9447.669331573363, 9541.33210675253, 3983.2830090583393, 4009.1981603679383, 4034.334334834778, 4050.2911990401562, 4121.196366708523, 8411.327093832479, 8413.368997325102, 8427.873581896276, 8435.0, 8502.404831661725, 4437.955620443819, 4439.556044395599, 4441.733495990251, 4464.598186163261, 4490.775461226991, 4031.9395209071886, 4045.9797701011894, 4054.4729185205733, 4075.1849630074103, 4090.3250963590676, 3349.8157601331673, 3402.387570237381, 3438.0717206354143, 3444.9655503445147, 3459.8270086496077, 1074.0655629602295, 1092.4974511724536, 1101.0621306500616, 1106.2919731371928, 1106.319613437746, 950.7290422229631, 971.1114330387617, 971.3977334052792, 1146.954121835134, 1184.135581025856, 6710.698018589175, 6791.524593278522, 6852.45180385568, 6861.519693621499, 6862.622555759481, 421.48157765948054, 424.5987541772995, 427.1755511862074, 432.9458817647794, 433.47982421094815, 5371.650842695212, 5378.273933019071, 5460.372057213392, 5463.016657001778, 5468.64453810509, 7667.003289572432, 8061.798455038554, 8281.792955176048, 8300.04549476818, 8377.748667539983, 7822.061352637606, 7963.362930965509, 8029.518228906284, 8033.558154301452, 8095.39284553649, 6678.9332106679285, 6788.355106264897, 6803.421709154777, 6822.4200942919415, 6862.176538815274, 6642.634655093823, 6796.0, 6806.727730890709, 6838.829029274308, 6921.653917304014, 7581.166071731995, 7637.961810190914, 7689.50018248812, 7729.652165652672, 7758.456908016385, 7747.0, 7835.529868207926, 7857.332126769289, 7989.480683755537, 8013.959930200312, 5997.4002599741425, 6148.661823599745, 6158.907616385847, 6163.322034576104, 6176.722047507783, 6638.966805165944, 6706.798796036127, 6731.4951378647775, 6842.794716158523, 6862.382385585322, 6430.710618022106, 6460.644664543307, 6470.708818103102, 6537.5750576212395, 6579.440747536513, 6171.783987560414, 6221.440070393686, 6288.0, 6396.840078998062, 6427.132337134427, 6344.199610182805, 6394.23269207698, 6406.295307516077, 6472.546921715435, 6485.124508191334, 5871.031279838779, 5911.201987731602, 5915.733791979285, 5991.910121348096, 6002.069679199731, 5968.970155149196, 5980.401959803985, 6036.336003039574, 6060.939390606038, 6092.025275955826], "ext.html": [516.7545415927435, 517.0744367582029, 530.1702835063128, 535.2078923193674, 543.0903237077894, 29904.0, 31012.22469438265, 36130.45804312937, 36793.63206367935, 37235.62764372356, 38980.80509597448, 39075.41386879199, 39500.0, 39610.80194599023, 39657.80171099148, 7764.262395072487, 8403.327733781314, 8476.618552165168, 8603.010653774802, 8611.224989750921, 7759.030121234846, 10117.089461948422, 10219.38683678978, 10332.586696532167, 10342.172626189888, 9947.701568952943, 10073.39559626421, 10087.899121008806, 10182.389056656624, 10190.64332748354, 7882.842343153105, 8197.590120493951, 9965.601375944954, 10065.899341006607, 10070.798584028315, 9651.565679544437, 9932.602695892156, 9938.453385063818, 9957.65148219816, 10035.69892903214, 36744.63255367439, 36853.0, 36888.26223475515, 36901.26197476035, 37089.07277318062, 2720.238714825993, 2757.7518023377793, 3017.411604737077, 3116.703913128249, 3197.2326641605846, 24662.383440413952, 24913.128040518495, 25021.249362519153, 25526.361840953938, 26401.867990660117, 2135.540858715368, 2168.913243470259, 2192.2984644913636, 2245.3376254005107, 2257.6274914639066, 257249.0, 258013.0, 258108.9999999981, 258426.0, 258646.0, 45985.7700711501, 48005.0, 52605.47394526083, 54413.45586544084, 54938.450615494134, 50986.0, 51186.0, 51349.22976155361, 51649.0, 51650.48349516457, 15489.380424782883, 15687.1372074537, 15907.602309942344, 15924.522264332089, 15943.123128228059, 12075.3358565278, 12106.152569320064, 12153.5138594457, 12243.632691019284, 12244.693882653006, 17456.12719364052, 17695.823041769676, 17713.557161071076, 17739.379121730937, 17924.283028678707, 7571.129320128146, 7822.217778222132, 7838.568878711726, 7877.818327250843, 7892.4080693947035, 808.7614153824636, 852.6930305090162, 966.5215718219526, 998.8152191844532, 1024.2676486312323, 26181.476370472483, 26347.868260658575, 26361.80964507404, 26490.86754566215, 26578.867105664736, 837.2004735477605, 1023.7952409518126, 1024.364893765855, 1050.1598721023151, 1122.399516258814, 12692.619221423372, 13520.12119212248, 13818.0, 14251.358688859027, 14657.706845863024, 313193.0, 318317.0, 318659.0, 318828.0, 320719.0, 51755.741221293654, 51757.7412112937, 52124.0, 52356.47643523592, 52423.47576524262, 1276.0748457368334, 1293.5407930184838, 1295.1710905020607, 1295.9935200323937, 1310.6461255460972, 26060.218193454228, 26649.200523984313, 26874.462510750065, 27250.318742031606, 27277.318067048483, 43731.56268437275, 43836.0, 43939.34090988574, 44179.77910110429, 44250.778746106065, 277473.0, 283035.0, 289196.0, 367610.0, 376822.0, 27211.455770884077, 27330.453390932467, 27866.582001270403, 28041.298967525974, 28210.15369538835, 33896.66103338935, 37231.06922326964, 37879.2424151521, 37949.620503794606, 38718.80640596891, 30784.0, 32054.519182212753, 32339.676603234606, 32656.183595410304, 33044.50433243455, 32211.963387779175, 32455.350892981536, 32523.674763252064, 32672.673273266962, 32689.34621307513, 32718.83640581782, 33262.66737332596, 33291.83354083214, 33371.16572085717, 33426.0, 24704.382390439663, 25208.495830082928, 28229.294267643472, 28951.0, 29653.555196671634, 21911.21714565179, 22136.335909922727, 22188.445288867908, 22195.33413997583, 22321.665175022063], "prototype.html": [294.3039711083288, 304.1392858211261, 305.62255614316325, 306.9002574163396, 311.89551500247416, 5526.253955715977, 5546.91679624806, 5573.749181286852, 5596.27248457701, 5620.775168993246, 5456.154296084103, 5461.453854614537, 5510.504054635082, 5535.142052981794, 5564.944350556493, 4202.6007529284825, 4375.540568240321, 4407.6033157015945, 4418.315161150027, 4424.0, 4189.727667701605, 4232.619064284214, 4284.935725964113, 4304.182205380983, 4333.674974376934, 4197.916041679165, 4211.894702632428, 4212.53662097169, 4238.215930052935, 4267.615914567688, 4196.811143498535, 4203.4115223868685, 4241.448611680493, 4241.87274381769, 4245.639120674747, 3691.8523259069607, 3747.1381582235967, 3761.2101458693705, 3767.830447629863, 3790.166163444038, 5326.067938110854, 5336.439673834269, 5371.677699338053, 5385.434529374437, 5435.320584926884, 4758.666893317469, 4761.857144285677, 4774.594159496447, 4831.685940413862, 4833.154198015369, 5600.411956744565, 5702.800401985952, 5730.255066841326, 5770.0, 5784.652920824764, 3881.6894648428056, 3910.1006768443417, 3910.921781564353, 3913.745606535566, 3945.408188771707, 5966.463018328372, 6061.424164704346, 6091.878162436771, 6116.235470566179, 6148.661823599745, 3975.5030621172355, 3981.7610943343493, 3993.4808474898077, 3994.141259629194, 3997.0, 3800.7149463790324, 3838.7504812187117, 3924.2543916656314, 3983.063979964706, 4017.5379831319187, 4626.097910907408, 4627.329037289574, 4699.483056863743, 4711.740854253049, 4713.528647135327, 5745.511631511368, 5753.626014309057, 5756.02147634903, 5821.27234095738, 5869.266341707286, 1435.2823588205897, 1460.58373363593, 1463.158683756844, 1465.0989641370693, 1466.1349803615917, 921.8386782313069, 927.9489628070386, 950.3062764182048, 960.4093482508347, 963.949295268147, 5660.349059858169, 5670.631408958405, 5671.914921276184, 5678.971605141948, 5708.885822283531, 6098.0243161094895, 6109.633421994695, 6148.9692551537855, 6180.845478863064, 6215.751369945242, 5589.776408943678, 5602.915956260659, 5642.153676948491, 5643.887122257532, 5696.3449203341315, 3275.5905511811025, 3324.335132973415, 3341.1480072581335, 3349.5143204235737, 3392.7625066245128, 6064.818055458343, 6093.055576385667, 6147.477464415485, 6166.290876549165, 6196.039613859859, 6165.630062196283, 6181.072839074175, 6183.196184495987, 6201.410865967726, 6230.688465576703, 5878.088896221093, 6125.785597504066, 6135.662538560422, 6196.349383314687, 6238.937610623836, 6072.1498990140535, 6130.63216207029, 6143.293521245114, 6149.600275982047, 6170.074488826533, 5956.434138756985, 5957.4042595740075, 6025.66858822769, 6033.698315084141, 6069.969650151721, 5981.431763982415, 6130.601510901777, 6235.314115447207, 6239.78160764371, 6244.188255526752, 3851.595582463801, 3900.64894159527, 3907.374820028782, 3936.626020528045, 3939.842406303716, 5858.502027327725, 5967.37342579023, 6095.8780824382375, 6169.043798211284, 6171.413715697002, 5779.364269930388, 5780.797672081457, 5862.267216597926, 5905.881882362414, 5937.287525496968, 5817.2146760188525, 5833.095870140135, 5905.675187864708, 5909.143174239625, 5910.143029260647, 5520.66875987442, 5698.458646428583, 5741.339745929272, 5745.683987380734, 5767.192593037062, 5796.9420305798085, 5830.591858570029, 5887.352391236875, 5914.290285165635, 6001.339852616296, 5720.513756330759, 5762.1068734346245, 5826.650400975955, 5854.736536855767, 5862.736176871966], "yui.html": [674.4974993629745, 684.5481338385713, 691.1050190003945, 693.6531734132933, 708.5890183693458, 11795.627732667082, 12691.17507362022, 12758.80861787074, 12788.0, 12923.289219092947, 11891.4054297285, 11999.940000300008, 12011.639650810468, 12015.33915634642, 12020.27878327301, 689.2487188964028, 689.3416786968434, 816.1919699497499, 831.7463173732009, 834.5034704350932, 822.4900561651784, 835.0105125426359, 836.7573403712946, 838.6016642094986, 839.2237180607943, 854.2397266432848, 861.2765277167179, 861.2894362151219, 862.8964524257067, 867.9088695686956, 710.0343532795395, 712.6223101756077, 861.814709837388, 862.211076864668, 866.0213958227226, 635.7139287320724, 643.5881036136876, 643.8519140597642, 648.5460177875506, 653.2716021635889, 12867.356632168448, 12869.485220591165, 12895.22628642275, 13011.21932684042, 13016.869831301661, 10704.30422022566, 10823.783524329549, 10896.18278629106, 11034.117270618332, 11064.18244268707, 8593.699220527315, 8719.171678690514, 8779.73660790171, 8836.0, 8953.865692014626, 2928.061831153397, 2961.481740695391, 3032.4844776387845, 3072.554479600468, 3123.344097739455, 46959.765201174116, 47146.0, 47393.52606473926, 47462.288065679044, 47477.76261118707, 8196.0, 8230.62962166704, 8303.875441868377, 8405.831883362422, 8460.957695211484, 17871.910640446713, 17878.642427151382, 18029.368972085915, 18041.188146533437, 18057.458276251735, 6446.645434501147, 6487.091807147003, 6601.108850305243, 6653.63405012729, 6675.499337549703, 3361.9495707564406, 3414.5048967899515, 3441.776284541547, 3456.861725531001, 3574.8748793792092, 2644.523985682557, 2690.1122629532206, 2702.121810411624, 2709.580015097663, 2723.9727602724115, 407.23643169058016, 415.2110989120695, 422.80550946564307, 423.65048834711484, 428.22491290763816, 470.6846412903363, 478.93294938708607, 499.4805402381555, 519.6258693740501, 538.2572050570188, 7144.3570078693165, 7285.089363829521, 7366.889496657554, 7630.351420129351, 7719.729809456642, 383.7601499063086, 423.3184572837729, 479.68101212693864, 549.6976662835425, 564.5596434780878, 3311.8012919224925, 3326.9001929941655, 3352.2792599591203, 3443.1220038889924, 3451.4650229214008, 52481.47518524766, 53186.734066330195, 53699.73150134303, 53807.73096134494, 58547.0, 49903.0, 50522.49477505252, 50547.494525055015, 51387.0, 51723.482765171866, 45970.77014614906, 46325.536744632795, 46573.06853862971, 47622.761886189655, 47645.5235447648, 7415.406767458699, 7429.888551671621, 7431.071116110486, 7538.623068846646, 7602.771916842504, 34406.483902740976, 34485.827570861984, 34533.82733086318, 35272.294554109285, 35289.117772055906, 45982.080358393316, 46062.0, 46505.30242046304, 46547.0, 46555.301670475645, 6963.338482844122, 7016.614086225307, 7144.285571442814, 7273.9636301818155, 7363.815904602214, 10194.337368071052, 10374.22193335518, 10426.635067772591, 10523.421211833116, 10539.42033188182, 9560.904390956279, 9575.952120239353, 9652.565634546321, 9805.362651427635, 9993.600255989679, 9315.34792564514, 9663.613455461984, 9720.75698107553, 9825.950870245602, 10180.032896874785, 9317.301202409712, 9772.071653192936, 9789.85315220258, 9902.554385052834, 10303.072723454925, 8141.185881411811, 8572.957135214285, 8682.0, 8824.647014119364, 9052.502112383881, 7962.761117166494, 8173.959130204311, 8473.95763021181, 8694.739157825275, 8724.738257852274]}, "summary": {"suite": 6121.978818517755, "subtests": {"jquery.html": {"filtered": 6334.078986801838, "value": 6334.078986801838}, "dojo.html": {"filtered": 4911.790304540403, "value": 4911.790304540403}, "mootools.html": {"filtered": 3973.033964170394, "value": 3973.033964170394}, "ext.html": {"filtered": 17276.49141226668, "value": 17276.49141226668}, "prototype.html": {"filtered": 4386.5229679214635, "value": 4386.5229679214635}, "yui.html": {"filtered": 5619.366257534597, "value": 5619.366257534597}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0022"}, "testrun": {"date": 1446717801, "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": "44.0a2", "id": "20151105004045", "branch": "Mozilla-Aurora", "revision": "ef5a44ab4ef0344d35f2e465566d37e4906af6ff"}}, {"talos_counters": {}, "results": {"audio-dft": [180.0, 180.0, 186.0, 187.0, 180.0, 178.0, 181.0, 181.0, 180.0, 186.0], "ai-astar": [117.0, 121.0, 113.0, 122.0, 125.0, 124.0, 116.0, 125.0, 110.0, 120.0], "imaging-gaussian-blur": [134.0, 141.0, 142.0, 129.0, 135.0, 136.0, 139.0, 129.0, 135.0, 141.0], "audio-beat-detection": [170.0, 162.0, 203.0, 177.0, 145.0, 162.0, 141.0, 183.0, 173.0, 149.0], "json-stringify-tinderbox": [72.0, 74.0, 76.0, 81.0, 78.0, 79.0, 76.0, 77.0, 76.0, 76.0], "stanford-crypto-pbkdf2": [148.0, 155.0, 168.0, 156.0, 152.0, 164.0, 163.0, 167.0, 167.0, 150.0], "json-parse-financial": [61.0, 67.0, 70.0, 70.0, 70.0, 78.0, 73.0, 83.0, 64.0, 64.0], "stanford-crypto-sha256-iterative": [73.0, 77.0, 78.0, 77.0, 80.0, 80.0, 81.0, 80.0, 76.0, 77.0], "audio-fft": [84.0, 91.0, 92.0, 136.0, 77.0, 80.0, 81.0, 78.0, 127.0, 76.0], "imaging-darkroom": [140.0, 147.0, 144.0, 140.0, 141.0, 140.0, 147.0, 143.0, 140.0, 140.0], "stanford-crypto-ccm": [142.0, 149.0, 141.0, 132.0, 138.0, 140.0, 143.0, 142.0, 135.0, 139.0], "audio-oscillator": [110.0, 111.0, 150.0, 104.0, 103.0, 101.0, 139.0, 99.0, 97.0, 137.0], "stanford-crypto-aes": [93.0, 98.0, 97.0, 96.0, 94.0, 93.0, 92.0, 95.0, 101.0, 103.0], "imaging-desaturate": [118.0, 119.0, 116.0, 113.0, 117.0, 118.0, 119.0, 116.0, 113.0, 118.0]}, "summary": {"suite": 1689.7000000000003, "subtests": {"audio-fft": {"filtered": 92.2, "value": 92.2}, "stanford-crypto-pbkdf2": {"filtered": 159.0, "value": 159.0}, "audio-beat-detection": {"filtered": 166.5, "value": 166.5}, "stanford-crypto-ccm": {"filtered": 140.1, "value": 140.1}, "imaging-darkroom": {"filtered": 142.2, "value": 142.2}, "json-parse-financial": {"filtered": 70.0, "value": 70.0}, "audio-oscillator": {"filtered": 115.1, "value": 115.1}, "ai-astar": {"filtered": 119.3, "value": 119.3}, "audio-dft": {"filtered": 181.9, "value": 181.9}, "stanford-crypto-sha256-iterative": {"filtered": 77.9, "value": 77.9}, "json-stringify-tinderbox": {"filtered": 76.5, "value": 76.5}, "imaging-gaussian-blur": {"filtered": 136.1, "value": 136.1}, "stanford-crypto-aes": {"filtered": 96.2, "value": 96.2}, "imaging-desaturate": {"filtered": 116.7, "value": 116.7}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0022"}, "testrun": {"date": 1446717801, "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": "44.0a2", "id": "20151105004045", "branch": "Mozilla-Aurora", "revision": "ef5a44ab4ef0344d35f2e465566d37e4906af6ff"}}, {"talos_counters": {}, "results": {"DeltaBlue": [215.79628830384118], "Encrypt": [361.14120621162874], "NavierStokes": [6464.5161290322585], "Decrypt": [6401.273885350319], "Splay": [686.8131868131868], "Richards": [182.81535648994515], "RegExp": [33000.0], "Earley": [766.4624808575804], "Boyer": [14169.014084507042], "RayTrace": [1145.475372279496]}, "summary": {"suite": 18107.32665087131, "subtests": {"DeltaBlue": {"filtered": 306.39081200000004, "value": 306.39081200000004}, "Encrypt": {"filtered": 737.0551889999997, "value": 737.0551889999997}, "NavierStokes": {"filtered": 229.56087824351292, "value": 229.56087824351292}, "Decrypt": {"filtered": 41.582504477611955, "value": 41.582504477611955}, "Splay": {"filtered": 118.65089600000005, "value": 118.65089600000005}, "RegExp": {"filtered": 27.605606060606068, "value": 27.605606060606068}, "Richards": {"filtered": 193.10194, "value": 193.10194}, "Earley": {"filtered": 869.5311468531465, "value": 869.5311468531465}, "Boyer": {"filtered": 47.0366530815109, "value": 47.0366530815109}, "RayTrace": {"filtered": 646.010397, "value": 646.010397}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0022"}, "testrun": {"date": 1446717801, "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": "44.0a2", "id": "20151105004045", "branch": "Mozilla-Aurora", "revision": "ef5a44ab4ef0344d35f2e465566d37e4906af6ff"}}] 02:23:36 INFO - RETURN: dromaeo_css: 6121.98 02:23:36 INFO - RETURN: kraken: 1689.70 02:23:36 INFO - RETURN: v8_7: 18107.33 02:23:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "18107.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1689.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6121.98"}}} 02:23:36 INFO - Return code: 0 02:23:36 INFO - # TBPL SUCCESS # 02:23:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:23:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:23:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:23:36 INFO - 2015-11-05 02:23:36.979 screenresolution[1656:9890] starting screenresolution argv=screenresolution get 02:23:36 INFO - 2015-11-05 02:23:36.986 screenresolution[1656:9890] Display 0: 1600x1200x32@60 02:23:36 INFO - 2015-11-05 02:23:36.992 screenresolution[1657:9893] starting screenresolution argv=screenresolution list 02:23:36 INFO - Available Modes on Display 0 02:23:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:23:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:23:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:23:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:23:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:23:37 INFO - Intel HD Graphics 3000: 02:23:37 INFO - Chipset Model: Intel HD Graphics 3000 02:23:37 INFO - Type: GPU 02:23:37 INFO - Bus: Built-In 02:23:37 INFO - VRAM (Total): 512 MB 02:23:37 INFO - VRAM (Dynamic, Max): 10 02:23:37 INFO - Vendor: Intel (0x8086) 02:23:37 INFO - Device ID: 0x0116 02:23:37 INFO - Revision ID: 0x0009 02:23:37 INFO - Displays: 02:23:37 INFO - Display: 02:23:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:23:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:23:37 INFO - Display Serial Number: 1600x1200 60 02:23:37 INFO - Main Display: Yes 02:23:37 INFO - Mirror: Off 02:23:37 INFO - Online: Yes 02:23:37 INFO - Rotation: Supported 02:23:37 INFO - Return code: 0 02:23:37 INFO - Running post-action listener: _resource_record_post_action 02:23:37 INFO - Running post-run listener: _resource_record_post_run 02:23:38 INFO - Total resource usage - Wall time: 1256s; CPU: 30.0%; Read bytes: 39318528; Write bytes: 683844608; Read time: 4481; Write time: 48634 02:23:38 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 333273600; Write bytes: 333291520; Read time: 34564; Write time: 3694 02:23:38 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 38208512; Write bytes: 340296704; Read time: 3949; Write time: 44127 02:23:38 INFO - Running post-run listener: _upload_blobber_files 02:23:38 INFO - Blob upload gear active. 02:23:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:23:38 INFO - Copying logs to upload dir... 02:23:38 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1319.267718 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-05 02:23:38.423705) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:23:38.427017) ========= 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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009946 build_url: 'https://queue.taskcluster.net/v1/task/s2KoqF7KQZ2EvWGRIgth7Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-05 02:23:38.452945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:23:38.453266) ========= 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.TPwsb6pnVa/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.mzXNtFYJmk/Listeners TMPDIR=/var/folders/t3/9v0z6_z94qn8mbw4kr2xzb9800000w/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.005459 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-05 02:23:38.502618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 02:23:38.502946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-05 02:23:38.503375) ========= ========= Total master_lag: 0.21 =========