builder: mozilla-aurora_yosemite_test-dromaeojs slave: t-yosemite-r5-0049 starttime: 1449123391.88 results: success (0) buildid: 20151202120924 builduid: 6ae4f61fe9db4d1ea31cb837b50b9d3c revision: d57fc3a1dda554cbde8557abfb60dce501d9a6a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.881114) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.881521) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.881819) ========= 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.yzAtEaGBra/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.SohQE1Dpcq/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.005548 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.913084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.913722) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.936109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.936638) ========= 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.yzAtEaGBra/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.SohQE1Dpcq/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.032013 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.986952) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.987272) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.987685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:31.988082) ========= 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.yzAtEaGBra/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.SohQE1Dpcq/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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-12-02 22:16:32-- 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% 9.14M=0.001s 2015-12-02 22:16:32 (9.14 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217588 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:32.216385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:32.216706) ========= 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.yzAtEaGBra/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.SohQE1Dpcq/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.115703 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:32.342400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:32.342796) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d57fc3a1dda554cbde8557abfb60dce501d9a6a7 --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 d57fc3a1dda554cbde8557abfb60dce501d9a6a7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yzAtEaGBra/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.SohQE1Dpcq/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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-12-02 22:16:32,427 truncating revision to first 12 chars 2015-12-02 22:16:32,427 Setting DEBUG logging. 2015-12-02 22:16:32,427 attempt 1/10 2015-12-02 22:16:32,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d57fc3a1dda5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 22:16:32,678 unpacking tar archive at: mozilla-aurora-d57fc3a1dda5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.514495 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:32.868797) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:32.869160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:32.877591) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:32.877856) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 22:16:32.878273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2015-12-02 22:16:32.878550) ========= /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.yzAtEaGBra/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.SohQE1Dpcq/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:16:33 INFO - MultiFileLogger online at 20151202 22:16:33 in /builds/slave/test 22:16:33 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 22:16:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:16:33 INFO - {'append_to_log': False, 22:16:33 INFO - 'base_work_dir': '/builds/slave/test', 22:16:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 22:16:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:16:33 INFO - 'branch': 'Mozilla-Aurora', 22:16:33 INFO - 'buildbot_json_path': 'buildprops.json', 22:16:33 INFO - 'config_files': ('talos/mac_config.py',), 22:16:33 INFO - 'default_actions': ('clobber', 22:16:33 INFO - 'read-buildbot-config', 22:16:33 INFO - 'download-and-extract', 22:16:33 INFO - 'populate-webroot', 22:16:33 INFO - 'create-virtualenv', 22:16:33 INFO - 'install', 22:16:33 INFO - 'run-tests'), 22:16:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:16:33 INFO - 'download_minidump_stackwalk': True, 22:16:33 INFO - 'download_symbols': 'ondemand', 22:16:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:16:33 INFO - 'tooltool.py': '/tools/tooltool.py', 22:16:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:16:33 INFO - '/tools/misc-python/virtualenv.py')}, 22:16:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:16:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:16:33 INFO - 'installer_path': 'installer.exe', 22:16:33 INFO - 'log_level': 'info', 22:16:33 INFO - 'log_name': 'talos', 22:16:33 INFO - 'log_to_console': True, 22:16:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:16:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:16:33 INFO - 'opt_config_files': (), 22:16:33 INFO - 'pip_index': False, 22:16:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:16:33 INFO - 'cmd': ('bash', 22:16:33 INFO - '-c', 22:16:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:16:33 INFO - 'enabled': True, 22:16:33 INFO - 'halt_on_failure': False, 22:16:33 INFO - 'name': 'check_screen_resolution'},), 22:16:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:16:33 INFO - 'cmd': ('bash', 22:16:33 INFO - '-c', 22:16:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:16:33 INFO - 'enabled': True, 22:16:33 INFO - 'halt_on_failure': False, 22:16:33 INFO - 'name': 'check_screen_resolution'},), 22:16:33 INFO - 'run_cmd_checks_enabled': True, 22:16:33 INFO - 'sps_profile': False, 22:16:33 INFO - 'sps_profile_interval': 0, 22:16:33 INFO - 'suite': 'dromaeojs', 22:16:33 INFO - 'system_bits': '64', 22:16:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:16:33 INFO - 'title': 't-yosemite-r5-0049', 22:16:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:16:33 INFO - 'use_talos_json': True, 22:16:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:16:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:16:33 INFO - 'work_dir': 'build'} 22:16:33 INFO - ##### 22:16:33 INFO - ##### Running clobber step. 22:16:33 INFO - ##### 22:16:33 INFO - Running pre-action listener: _resource_record_pre_action 22:16:33 INFO - Running main action method: clobber 22:16:33 INFO - rmtree: /builds/slave/test/build 22:16:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:16:38 INFO - Running post-action listener: _resource_record_post_action 22:16:38 INFO - ##### 22:16:38 INFO - ##### Running read-buildbot-config step. 22:16:38 INFO - ##### 22:16:38 INFO - Running pre-action listener: _resource_record_pre_action 22:16:38 INFO - Running main action method: read_buildbot_config 22:16:38 INFO - Using buildbot properties: 22:16:38 INFO - { 22:16:38 INFO - "properties": { 22:16:38 INFO - "buildnumber": 447, 22:16:38 INFO - "product": "firefox", 22:16:38 INFO - "script_repo_revision": "production", 22:16:38 INFO - "builddir": "mozilla-aurora_yosemite_test-dromaeojs", 22:16:38 INFO - "repository": "", 22:16:38 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-aurora talos dromaeojs", 22:16:38 INFO - "buildid": "20151202120924", 22:16:38 INFO - "slavename": "t-yosemite-r5-0049", 22:16:38 INFO - "pgo_build": "False", 22:16:38 INFO - "basedir": "/builds/slave/test", 22:16:38 INFO - "project": "", 22:16:38 INFO - "platform": "yosemite", 22:16:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:16:38 INFO - "slavebuilddir": "test", 22:16:38 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 22:16:38 INFO - "branch": "mozilla-aurora", 22:16:38 INFO - "repo_path": "releases/mozilla-aurora", 22:16:38 INFO - "stage_platform": "macosx64", 22:16:38 INFO - "builduid": "6ae4f61fe9db4d1ea31cb837b50b9d3c", 22:16:38 INFO - "revision": "d57fc3a1dda554cbde8557abfb60dce501d9a6a7" 22:16:38 INFO - }, 22:16:38 INFO - "sourcestamp": { 22:16:38 INFO - "repository": "", 22:16:38 INFO - "hasPatch": false, 22:16:38 INFO - "project": "", 22:16:38 INFO - "branch": "mozilla-aurora-macosx64-talos", 22:16:38 INFO - "changes": [ 22:16:38 INFO - { 22:16:38 INFO - "category": null, 22:16:38 INFO - "files": [ 22:16:38 INFO - { 22:16:38 INFO - "url": null, 22:16:38 INFO - "name": "https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg" 22:16:38 INFO - } 22:16:38 INFO - ], 22:16:38 INFO - "repository": "", 22:16:38 INFO - "rev": "d57fc3a1dda554cbde8557abfb60dce501d9a6a7", 22:16:38 INFO - "who": "catalin.badea392@gmail.com", 22:16:38 INFO - "when": 1449122639, 22:16:38 INFO - "number": 6737580, 22:16:38 INFO - "comments": "Bug 1189659 - Part 5 - Fix race in skip-waiting.https.html and add some logging for SkipWaitingFlag in ServiceWorkerManager. r=ehsan a=ritu", 22:16:38 INFO - "project": "", 22:16:38 INFO - "at": "Wed 02 Dec 2015 22:03:59", 22:16:38 INFO - "branch": "mozilla-aurora-macosx64-talos", 22:16:38 INFO - "revlink": "", 22:16:38 INFO - "properties": [ 22:16:38 INFO - [ 22:16:38 INFO - "buildid", 22:16:38 INFO - "20151202120924", 22:16:38 INFO - "Change" 22:16:38 INFO - ], 22:16:38 INFO - [ 22:16:38 INFO - "builduid", 22:16:38 INFO - "6ae4f61fe9db4d1ea31cb837b50b9d3c", 22:16:38 INFO - "Change" 22:16:38 INFO - ], 22:16:38 INFO - [ 22:16:38 INFO - "pgo_build", 22:16:38 INFO - "False", 22:16:38 INFO - "Change" 22:16:38 INFO - ] 22:16:38 INFO - ], 22:16:38 INFO - "revision": "d57fc3a1dda554cbde8557abfb60dce501d9a6a7" 22:16:38 INFO - } 22:16:38 INFO - ], 22:16:38 INFO - "revision": "d57fc3a1dda554cbde8557abfb60dce501d9a6a7" 22:16:38 INFO - } 22:16:38 INFO - } 22:16:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg. 22:16:38 INFO - Running post-action listener: _resource_record_post_action 22:16:38 INFO - ##### 22:16:38 INFO - ##### Running download-and-extract step. 22:16:38 INFO - ##### 22:16:38 INFO - Running pre-action listener: _resource_record_pre_action 22:16:38 INFO - Running main action method: download_and_extract 22:16:38 INFO - mkdir: /builds/slave/test/build/tests 22:16:38 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')]} 22:16:38 INFO - https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:16:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/test_packages.json 22:16:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/test_packages.json 22:16:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:16:39 INFO - Downloaded 1149 bytes. 22:16:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:16:39 INFO - Using the following test package requirements: 22:16:39 INFO - {u'common': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 22:16:39 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:16:39 INFO - u'firefox-44.0a2.en-US.mac.cppunittest.tests.zip'], 22:16:39 INFO - u'jittest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:16:39 INFO - u'jsshell-mac.zip'], 22:16:39 INFO - u'mochitest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:16:39 INFO - u'firefox-44.0a2.en-US.mac.mochitest.tests.zip'], 22:16:39 INFO - u'mozbase': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 22:16:39 INFO - u'reftest': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:16:39 INFO - u'firefox-44.0a2.en-US.mac.reftest.tests.zip'], 22:16:39 INFO - u'talos': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:16:39 INFO - u'firefox-44.0a2.en-US.mac.talos.tests.zip'], 22:16:39 INFO - u'web-platform': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:16:39 INFO - u'firefox-44.0a2.en-US.mac.web-platform.tests.zip'], 22:16:39 INFO - u'webapprt': [u'firefox-44.0a2.en-US.mac.common.tests.zip'], 22:16:39 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.mac.common.tests.zip', 22:16:39 INFO - u'firefox-44.0a2.en-US.mac.xpcshell.tests.zip']} 22:16:39 INFO - Downloading packages: [u'firefox-44.0a2.en-US.mac.common.tests.zip'] for test suite category: common 22:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:39 INFO - https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/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 22:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/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 22:16:41 INFO - Downloaded 17490054 bytes. 22:16:41 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 22:16:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:16:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 22:16:45 INFO - Return code: 0 22:16:45 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 22:16:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:45 INFO - https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:16:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:16:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:16:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/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 22:16:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/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 22:16:46 INFO - Downloaded 17490054 bytes. 22:16:46 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 22:16:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip 22:16:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.common.tests.zip'] with output_timeout 1760 22:16:52 INFO - Return code: 0 22:16: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')]} 22:16:52 INFO - https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:16:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 22:16:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.talos.tests.zip 22:16:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/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 22:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/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 22:16:54 INFO - Downloaded 11131307 bytes. 22:16:54 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 22:16:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip 22:16:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-44.0a2.en-US.mac.talos.tests.zip'] with output_timeout 1760 22:16:54 INFO - Return code: 0 22:16:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:54 INFO - https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 22:16:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:16:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:16:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-44.0a2.en-US.mac.dmg 22:16:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/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 22:16:58 INFO - Downloaded 108643533 bytes. 22:16:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:16:58 INFO - mkdir: /builds/slave/test/properties 22:16:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:16:58 INFO - Writing to file /builds/slave/test/properties/build_url 22:16:58 INFO - Contents: 22:16:58 INFO - build_url:https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg 22:16:58 INFO - Running post-action listener: _resource_record_post_action 22:16:58 INFO - Running post-action listener: set_extra_try_arguments 22:16:58 INFO - ##### 22:16:58 INFO - ##### Running populate-webroot step. 22:16:58 INFO - ##### 22:16:58 INFO - Running pre-action listener: _resource_record_pre_action 22:16:58 INFO - Running main action method: populate_webroot 22:16:58 INFO - Guessing talos json url... 22:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:58 INFO - https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt matches https://queue.taskcluster.net 22:16:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 22:16:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt 22:16:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.txt to /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 22:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OmKjGuncTx-GDDa9APMb1Q/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 22:16:59 INFO - Downloaded 107 bytes. 22:16:59 INFO - Reading from file /builds/slave/test/build/firefox-44.0a2.en-US.mac.txt 22:16:59 INFO - Contents: 22:16:59 INFO - 20151202120924 22:16:59 INFO - https://hg.mozilla.org/releases/mozilla-aurora/rev/d57fc3a1dda554cbde8557abfb60dce501d9a6a7 22:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:16:59 INFO - trying https://hg.mozilla.org/releases/mozilla-aurora/raw-file/d57fc3a1dd/testing/talos/talos.json 22:16:59 INFO - Downloading https://hg.mozilla.org/releases/mozilla-aurora/raw-file/d57fc3a1dd/testing/talos/talos.json to /builds/slave/test/build/talos.json 22:16:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/releases/mozilla-aurora/raw-file/d57fc3a1dd/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 22:16:59 INFO - Downloaded 4264 bytes. 22:16:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:16:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:16:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:16:59 INFO - '../fennec_ids.txt'], 22:16:59 INFO - 'tests': ['tcheck2']}, 22:16:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:16:59 INFO - '--tppagecycles', 22:16:59 INFO - '7'], 22:16:59 INFO - 'tests': ['tsvgm']}}, 22:16:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:16:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:16:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:16:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:16:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:16:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:16:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:16:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:59 INFO - 'talos_options': ['--e10s'], 22:16:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:16:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:59 INFO - 'tests': ['damp', 'tps']}, 22:16:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:59 INFO - 'talos_options': ['--e10s'], 22:16:59 INFO - 'tests': ['damp', 'tps']}, 22:16:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:16:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:16:59 INFO - 'other': {'tests': ['a11yr', 22:16:59 INFO - 'ts_paint', 22:16:59 INFO - 'tpaint', 22:16:59 INFO - 'sessionrestore', 22:16:59 INFO - 'sessionrestore_no_auto_restore']}, 22:16:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:16:59 INFO - 'tests': ['a11yr', 22:16:59 INFO - 'ts_paint', 22:16:59 INFO - 'tpaint', 22:16:59 INFO - 'sessionrestore', 22:16:59 INFO - 'sessionrestore_no_auto_restore']}, 22:16:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:16:59 INFO - 'tests': ['a11yr', 22:16:59 INFO - 'ts_paint', 22:16:59 INFO - 'tpaint', 22:16:59 INFO - 'sessionrestore', 22:16:59 INFO - 'sessionrestore_no_auto_restore']}, 22:16:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:16:59 INFO - 'tests': ['a11yr', 22:16:59 INFO - 'ts_paint', 22:16:59 INFO - 'tpaint', 22:16:59 INFO - 'sessionrestore', 22:16:59 INFO - 'sessionrestore_no_auto_restore']}, 22:16:59 INFO - 'other_l64': {'tests': ['a11yr', 22:16:59 INFO - 'ts_paint', 22:16:59 INFO - 'tpaint', 22:16:59 INFO - 'sessionrestore', 22:16:59 INFO - 'sessionrestore_no_auto_restore']}, 22:16:59 INFO - 'other_nol64': {'tests': ['a11yr', 22:16:59 INFO - 'ts_paint', 22:16:59 INFO - 'tpaint', 22:16:59 INFO - 'sessionrestore', 22:16:59 INFO - 'sessionrestore_no_auto_restore']}, 22:16:59 INFO - 'svgr': {'tests': ['tsvgx', 22:16:59 INFO - 'tsvgr_opacity', 22:16:59 INFO - 'tart', 22:16:59 INFO - 'tscrollx', 22:16:59 INFO - 'cart']}, 22:16:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:16:59 INFO - 'tests': ['tsvgx', 22:16:59 INFO - 'tsvgr_opacity', 22:16:59 INFO - 'tart', 22:16:59 INFO - 'tscrollx', 22:16:59 INFO - 'cart']}, 22:16:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:59 INFO - 'tests': ['tp5o']}, 22:16:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:59 INFO - 'talos_options': ['--e10s'], 22:16:59 INFO - 'tests': ['tp5o']}, 22:16:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:59 INFO - 'talos_options': ['--xperf_path', 22:16:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:16:59 INFO - 'tests': ['tp5n']}, 22:16:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:16:59 INFO - 'talos_options': ['--e10s', 22:16:59 INFO - '--xperf_path', 22:16:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 22:16:59 INFO - 'C:/slave/talos-data/talos/xperf.config'], 22:16:59 INFO - 'tests': ['tp5n']}}, 22:16:59 INFO - 'talos.zip': {'path': '', 22:16:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:16:59 INFO - Running post-action listener: _resource_record_post_action 22:16:59 INFO - ##### 22:16:59 INFO - ##### Running create-virtualenv step. 22:16:59 INFO - ##### 22:16:59 INFO - Running pre-action listener: _resource_record_pre_action 22:16:59 INFO - Running main action method: create_virtualenv 22:16:59 INFO - Creating virtualenv /builds/slave/test/build/venv 22:16:59 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 22:16:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:16:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:16:59 INFO - Using real prefix '/tools/python27' 22:16:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:17:00 INFO - Installing distribute.............................................................................................................................................................................................done. 22:17:04 INFO - Installing pip.................done. 22:17:04 INFO - Return code: 0 22:17:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:17:04 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')]} 22:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:04 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')]} 22:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:04 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 0x10ddb0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedcaf15ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd659f0>, '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 0x10dac4cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2f990>, '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.yzAtEaGBra/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.SohQE1Dpcq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:17:04 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 22:17:04 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 22:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yzAtEaGBra/Render', 22:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:17:04 INFO - 'HOME': '/Users/cltbld', 22:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:17:04 INFO - 'LOGNAME': 'cltbld', 22:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:04 INFO - 'MOZ_NO_REMOTE': '1', 22:17:04 INFO - 'NO_EM_RESTART': '1', 22:17:04 INFO - 'PAGER': '/bin/cat', 22:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:04 INFO - 'PWD': '/builds/slave/test', 22:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:17:04 INFO - 'SHELL': '/bin/bash', 22:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SohQE1Dpcq/Listeners', 22:17:04 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:17:04 INFO - 'USER': 'cltbld', 22:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:04 INFO - 'XPC_FLAGS': '0x0', 22:17:04 INFO - 'XPC_SERVICE_NAME': '0', 22:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:05 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 22:17:05 INFO - Cleaning up... 22:17:05 INFO - Return code: 0 22:17:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ddb0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedcaf15ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd659f0>, '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 0x10dac4cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2f990>, '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.yzAtEaGBra/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.SohQE1Dpcq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:17:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yzAtEaGBra/Render', 22:17:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:17:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:17:05 INFO - 'HOME': '/Users/cltbld', 22:17:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:17:05 INFO - 'LOGNAME': 'cltbld', 22:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:05 INFO - 'MOZ_NO_REMOTE': '1', 22:17:05 INFO - 'NO_EM_RESTART': '1', 22:17:05 INFO - 'PAGER': '/bin/cat', 22:17:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:05 INFO - 'PWD': '/builds/slave/test', 22:17:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:17:05 INFO - 'SHELL': '/bin/bash', 22:17:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SohQE1Dpcq/Listeners', 22:17:05 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:17:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:17:05 INFO - 'USER': 'cltbld', 22:17:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:17:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:05 INFO - 'XPC_FLAGS': '0x0', 22:17:05 INFO - 'XPC_SERVICE_NAME': '0', 22:17:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:05 INFO - Downloading/unpacking psutil>=0.7.1 22:17:05 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 22:17:05 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 22:17:05 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 22:17:05 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 22:17:05 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 22:17:05 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 22:17:08 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:17:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:17:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:17:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:17:08 INFO - Installing collected packages: psutil 22:17:08 INFO - Running setup.py install for psutil 22:17:08 INFO - building 'psutil._psutil_osx' extension 22:17:08 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 22:17:10 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 22:17:10 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 22:17:10 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 22:17:10 INFO - building 'psutil._psutil_posix' extension 22:17:10 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 22:17:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:17:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:17:11 INFO - ^ 22:17:11 INFO - 1 warning generated. 22:17:11 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 22:17:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:17:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:17:11 INFO - Successfully installed psutil 22:17:11 INFO - Cleaning up... 22:17:11 INFO - Return code: 0 22:17:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:17:11 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')]} 22:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:11 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')]} 22:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:11 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 0x10ddb0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedcaf15ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd659f0>, '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 0x10dac4cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2f990>, '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.yzAtEaGBra/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.SohQE1Dpcq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:17:11 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 22:17:11 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 22:17:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yzAtEaGBra/Render', 22:17:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:17:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:17:11 INFO - 'HOME': '/Users/cltbld', 22:17:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:17:11 INFO - 'LOGNAME': 'cltbld', 22:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:11 INFO - 'MOZ_NO_REMOTE': '1', 22:17:11 INFO - 'NO_EM_RESTART': '1', 22:17:11 INFO - 'PAGER': '/bin/cat', 22:17:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:11 INFO - 'PWD': '/builds/slave/test', 22:17:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:17:11 INFO - 'SHELL': '/bin/bash', 22:17:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SohQE1Dpcq/Listeners', 22:17:11 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:17:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:17:11 INFO - 'USER': 'cltbld', 22:17:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:17:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:11 INFO - 'XPC_FLAGS': '0x0', 22:17:11 INFO - 'XPC_SERVICE_NAME': '0', 22:17:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:17:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:17:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:17:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:17:14 INFO - Installing collected packages: mozsystemmonitor 22:17:14 INFO - Running setup.py install for mozsystemmonitor 22:17:14 INFO - Successfully installed mozsystemmonitor 22:17:14 INFO - Cleaning up... 22:17:14 INFO - Return code: 0 22:17:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:17: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')]} 22:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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')]} 22:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17: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', '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 0x10ddb0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedcaf15ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd659f0>, '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 0x10dac4cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2f990>, '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.yzAtEaGBra/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.SohQE1Dpcq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:17: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:17: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 blobuploader==1.2.4 22:17:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yzAtEaGBra/Render', 22:17:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:17:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:17:14 INFO - 'HOME': '/Users/cltbld', 22:17:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:17:14 INFO - 'LOGNAME': 'cltbld', 22:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:14 INFO - 'MOZ_NO_REMOTE': '1', 22:17:14 INFO - 'NO_EM_RESTART': '1', 22:17:14 INFO - 'PAGER': '/bin/cat', 22:17:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:14 INFO - 'PWD': '/builds/slave/test', 22:17:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:17:14 INFO - 'SHELL': '/bin/bash', 22:17:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SohQE1Dpcq/Listeners', 22:17:14 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:17:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:17:14 INFO - 'USER': 'cltbld', 22:17:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:17:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:14 INFO - 'XPC_FLAGS': '0x0', 22:17:14 INFO - 'XPC_SERVICE_NAME': '0', 22:17:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:14 INFO - Downloading/unpacking blobuploader==1.2.4 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:17 INFO - Downloading blobuploader-1.2.4.tar.gz 22:17:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:17:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:17:17 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 22:17:17 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 22:17:17 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 22:17:17 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 22:17:17 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 22:17:17 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 22:17:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:17:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:17:18 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 22:17:18 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 22:17:18 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 22:17:18 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 22:17:18 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 22:17:18 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 22:17:18 INFO - Downloading docopt-0.6.1.tar.gz 22:17:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:17:18 INFO - Installing collected packages: blobuploader, requests, docopt 22:17:18 INFO - Running setup.py install for blobuploader 22:17:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:17:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:17:18 INFO - Running setup.py install for requests 22:17:19 INFO - Running setup.py install for docopt 22:17:19 INFO - Successfully installed blobuploader requests docopt 22:17:19 INFO - Cleaning up... 22:17:19 INFO - Return code: 0 22:17:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:19 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 0x10ddb0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedcaf15ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd659f0>, '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 0x10dac4cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2f990>, '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.yzAtEaGBra/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.SohQE1Dpcq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:17:19 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 22:17:19 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 22:17:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yzAtEaGBra/Render', 22:17:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:17:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:17:19 INFO - 'HOME': '/Users/cltbld', 22:17:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:17:19 INFO - 'LOGNAME': 'cltbld', 22:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:19 INFO - 'MOZ_NO_REMOTE': '1', 22:17:19 INFO - 'NO_EM_RESTART': '1', 22:17:19 INFO - 'PAGER': '/bin/cat', 22:17:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:19 INFO - 'PWD': '/builds/slave/test', 22:17:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:17:19 INFO - 'SHELL': '/bin/bash', 22:17:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SohQE1Dpcq/Listeners', 22:17:19 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:17:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:17:19 INFO - 'USER': 'cltbld', 22:17:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:17:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:19 INFO - 'XPC_FLAGS': '0x0', 22:17:19 INFO - 'XPC_SERVICE_NAME': '0', 22:17:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:17:19 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-pxSDJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:17:20 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-rVpM2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:17:20 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-vutMHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:17:20 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-i4VWUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:17:20 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-mV9wjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:17:20 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-zCl3IS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:17:20 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-D1sVsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:17:20 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-eeRgzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:17:20 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-twfzmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:17:21 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-XuIjmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:17:21 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-5cnP_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:17:21 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-ZxiLjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:17:21 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-4kH1Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:17:21 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Ywc9C4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:21 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Qo0BWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:17:21 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-DFe02L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:17:21 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-Acobki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:17:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:17:22 INFO - Running setup.py install for manifestparser 22:17:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:17:22 INFO - Running setup.py install for mozcrash 22:17:22 INFO - Running setup.py install for mozdebug 22:17:22 INFO - Running setup.py install for mozdevice 22:17:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:17:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:17:22 INFO - Running setup.py install for mozfile 22:17:22 INFO - Running setup.py install for mozhttpd 22:17:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:17:23 INFO - Running setup.py install for mozinfo 22:17:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:17:23 INFO - Running setup.py install for mozInstall 22:17:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:17:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:17:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:17:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:17:23 INFO - Running setup.py install for mozleak 22:17:23 INFO - Running setup.py install for mozlog 22:17:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:17:23 INFO - Running setup.py install for moznetwork 22:17:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:17:23 INFO - Running setup.py install for mozprocess 22:17:24 INFO - Running setup.py install for mozprofile 22:17:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:17:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:17:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:17:24 INFO - Running setup.py install for mozrunner 22:17:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:17:24 INFO - Running setup.py install for mozscreenshot 22:17:24 INFO - Running setup.py install for moztest 22:17:24 INFO - Running setup.py install for mozversion 22:17:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:17:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:17:25 INFO - Cleaning up... 22:17:25 INFO - Return code: 0 22:17:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10ddb0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedcaf15ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd659f0>, '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 0x10dac4cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2f990>, '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.yzAtEaGBra/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.SohQE1Dpcq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:17:25 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 22:17:25 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 22:17:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yzAtEaGBra/Render', 22:17:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:17:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:17:25 INFO - 'HOME': '/Users/cltbld', 22:17:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:17:25 INFO - 'LOGNAME': 'cltbld', 22:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:25 INFO - 'MOZ_NO_REMOTE': '1', 22:17:25 INFO - 'NO_EM_RESTART': '1', 22:17:25 INFO - 'PAGER': '/bin/cat', 22:17:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:25 INFO - 'PWD': '/builds/slave/test', 22:17:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:17:25 INFO - 'SHELL': '/bin/bash', 22:17:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SohQE1Dpcq/Listeners', 22:17:25 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:17:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:17:25 INFO - 'USER': 'cltbld', 22:17:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:17:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:25 INFO - 'XPC_FLAGS': '0x0', 22:17:25 INFO - 'XPC_SERVICE_NAME': '0', 22:17:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:17:25 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-OD5ZcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:17:25 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)) 22:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:17:25 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-IqLm0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:17:25 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)) 22:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:17:25 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-kG3h2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:17:25 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)) 22:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:17:25 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-l8LCFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:17:25 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)) 22:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:17:25 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-LJsXEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:17:26 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)) 22:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:17:26 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-muo5IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:17:26 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)) 22:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:17:26 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-zgfhhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:17:26 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)) 22:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:17:26 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-rraroC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:17:26 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)) 22:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:17:26 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-dlV_22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:17:26 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)) 22:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:17:26 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-pBRqGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:17:26 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)) 22:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:17:26 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-L2lIS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:17:26 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)) 22:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:17:26 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-sY2xA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:17:26 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)) 22:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:17:26 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-4JGS37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:17:27 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)) 22:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:17:27 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-5WJ1E7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:17:27 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)) 22:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:27 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-i7ZQCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:17:27 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)) 22:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:17:27 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-V3mKqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:17:27 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)) 22:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:17:27 INFO - Running setup.py (path:/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/pip-ngbjs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:17:27 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)) 22:17:27 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)) 22:17:27 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)) 22:17:27 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)) 22:17:27 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)) 22:17:27 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)) 22:17:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17: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 22:17:29 INFO - Downloading blessings-1.5.1.tar.gz 22:17:30 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 22:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:17:30 INFO - Installing collected packages: blessings 22:17:30 INFO - Running setup.py install for blessings 22:17:30 INFO - Successfully installed blessings 22:17:30 INFO - Cleaning up... 22:17:30 INFO - Return code: 0 22:17:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:17:30 INFO - Reading from file tmpfile_stdout 22:17:30 INFO - Current package versions: 22:17:30 INFO - blessings == 1.5.1 22:17:30 INFO - blobuploader == 1.2.4 22:17:30 INFO - docopt == 0.6.1 22:17:30 INFO - manifestparser == 1.1 22:17:30 INFO - mozInstall == 1.12 22:17:30 INFO - mozcrash == 0.16 22:17:30 INFO - mozdebug == 0.1 22:17:30 INFO - mozdevice == 0.46 22:17:30 INFO - mozfile == 1.2 22:17:30 INFO - mozhttpd == 0.7 22:17:30 INFO - mozinfo == 0.8 22:17:30 INFO - mozleak == 0.1 22:17:30 INFO - mozlog == 3.0 22:17:30 INFO - moznetwork == 0.27 22:17:30 INFO - mozprocess == 0.22 22:17:30 INFO - mozprofile == 0.27 22:17:30 INFO - mozrunner == 6.11 22:17:30 INFO - mozscreenshot == 0.1 22:17:30 INFO - mozsystemmonitor == 0.0 22:17:30 INFO - moztest == 0.7 22:17:30 INFO - mozversion == 1.4 22:17:30 INFO - psutil == 3.1.1 22:17:30 INFO - requests == 1.2.3 22:17:30 INFO - wsgiref == 0.1.2 22:17:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:17:30 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 0x10ddb0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de1d228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fedcaf15ce0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd659f0>, '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 0x10dac4cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2f990>, '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.yzAtEaGBra/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.SohQE1Dpcq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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 22:17:30 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 22:17:30 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 22:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yzAtEaGBra/Render', 22:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:17:30 INFO - 'HOME': '/Users/cltbld', 22:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:17:30 INFO - 'LOGNAME': 'cltbld', 22:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:17:30 INFO - 'MOZ_NO_REMOTE': '1', 22:17:30 INFO - 'NO_EM_RESTART': '1', 22:17:30 INFO - 'PAGER': '/bin/cat', 22:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:17:30 INFO - 'PWD': '/builds/slave/test', 22:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:17:30 INFO - 'SHELL': '/bin/bash', 22:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SohQE1Dpcq/Listeners', 22:17:30 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:17:30 INFO - 'USER': 'cltbld', 22:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:17:30 INFO - 'XPC_FLAGS': '0x0', 22:17:30 INFO - 'XPC_SERVICE_NAME': '0', 22:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:17:31 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)) 22:17:31 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)) 22:17:31 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)) 22:17:31 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)) 22:17:31 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)) 22:17:31 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)) 22:17:31 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)) 22:17:31 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)) 22:17:31 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)) 22:17:31 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)) 22:17:31 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)) 22:17:31 INFO - Cleaning up... 22:17:31 INFO - Return code: 0 22:17:31 INFO - Running post-action listener: _resource_record_post_action 22:17:31 INFO - Running post-action listener: _start_resource_monitoring 22:17:31 INFO - Starting resource monitoring. 22:17:31 INFO - ##### 22:17:31 INFO - ##### Running install step. 22:17:31 INFO - ##### 22:17:31 INFO - Running pre-action listener: _resource_record_pre_action 22:17:31 INFO - Running main action method: install 22:17:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:17:31 INFO - Reading from file tmpfile_stdout 22:17:31 INFO - Detecting whether we're running mozinstall >=1.0... 22:17:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:17:31 INFO - Reading from file tmpfile_stdout 22:17:31 INFO - Output received: 22:17:31 INFO - Usage: mozinstall [options] installer 22:17:31 INFO - Options: 22:17:31 INFO - -h, --help show this help message and exit 22:17:31 INFO - -d DEST, --destination=DEST 22:17:31 INFO - Directory to install application into. [default: 22:17:31 INFO - "/builds/slave/test"] 22:17:31 INFO - --app=APP Application being installed. [default: firefox] 22:17:31 INFO - mkdir: /builds/slave/test/build/application 22:17:31 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'] 22:17:31 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 22:18:09 INFO - Reading from file tmpfile_stdout 22:18:09 INFO - Output received: 22:18:09 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 22:18:09 INFO - Running post-action listener: _resource_record_post_action 22:18:09 INFO - ##### 22:18:09 INFO - ##### Running run-tests step. 22:18:09 INFO - ##### 22:18:09 INFO - Running pre-action listener: _resource_record_pre_action 22:18:09 INFO - Running main action method: run_tests 22:18:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:18:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:18:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:18:09 INFO - 2015-12-02 22:18:09.208 screenresolution[1633:7608] starting screenresolution argv=screenresolution get 22:18:09 INFO - 2015-12-02 22:18:09.211 screenresolution[1633:7608] Display 0: 1600x1200x32@60 22:18:09 INFO - 2015-12-02 22:18:09.218 screenresolution[1634:7610] starting screenresolution argv=screenresolution list 22:18:09 INFO - Available Modes on Display 0 22:18:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:18:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:18:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:18:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:18:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:18:09 INFO - Intel HD Graphics 3000: 22:18:09 INFO - Chipset Model: Intel HD Graphics 3000 22:18:09 INFO - Type: GPU 22:18:09 INFO - Bus: Built-In 22:18:09 INFO - VRAM (Total): 512 MB 22:18:09 INFO - VRAM (Dynamic, Max): 10 22:18:09 INFO - Vendor: Intel (0x8086) 22:18:09 INFO - Device ID: 0x0116 22:18:09 INFO - Revision ID: 0x0009 22:18:09 INFO - Displays: 22:18:09 INFO - Display: 22:18:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:18:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:18:09 INFO - Display Serial Number: 1600x1200 60 22:18:09 INFO - Main Display: Yes 22:18:09 INFO - Mirror: Off 22:18:09 INFO - Online: Yes 22:18:09 INFO - Rotation: Supported 22:18:09 INFO - Return code: 0 22:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:18:09 INFO - Python 2.7.3 22:18:09 INFO - Return code: 0 22:18:09 INFO - grabbing minidump binary from tooltool 22:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:18:09 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 0x10dd659f0>, '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 0x10dac4cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dd2f990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:18:09 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 22:18:09 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 22:18:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:18:09 INFO - Return code: 0 22:18:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:18:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:18:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:18:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:18:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:18:09 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/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0049', '--webServer', 'localhost'] in /builds/slave/test/build 22:18:09 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/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0049 --webServer localhost 22:18:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yzAtEaGBra/Render', 22:18:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:18:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:18:09 INFO - 'HOME': '/Users/cltbld', 22:18:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:18:09 INFO - 'LOGNAME': 'cltbld', 22:18:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:18:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:18:09 INFO - 'MOZ_NO_REMOTE': '1', 22:18:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:18:09 INFO - 'NO_EM_RESTART': '1', 22:18:09 INFO - 'PAGER': '/bin/cat', 22:18:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:18:09 INFO - 'PWD': '/builds/slave/test', 22:18:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:18:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:18:09 INFO - 'SHELL': '/bin/bash', 22:18:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SohQE1Dpcq/Listeners', 22:18:09 INFO - 'TMPDIR': '/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/', 22:18:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:18:09 INFO - 'USER': 'cltbld', 22:18:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:18:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:18:09 INFO - 'XPC_FLAGS': '0x0', 22:18:09 INFO - 'XPC_SERVICE_NAME': '0', 22:18:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:18:09 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/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0049', '--webServer', 'localhost'] with output_timeout 3600 22:18:09 INFO - mozversion INFO | application_buildid: 20151202120924 22:18:09 INFO - mozversion INFO | application_changeset: d57fc3a1dda554cbde8557abfb60dce501d9a6a7 22:18:09 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 22:18:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:18:09 INFO - mozversion INFO | application_name: Firefox 22:18:09 INFO - mozversion INFO | application_remotingname: firefox-dev 22:18:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:18:09 INFO - mozversion INFO | application_vendor: Mozilla 22:18:09 INFO - mozversion INFO | application_version: 44.0a2 22:18:09 INFO - mozversion INFO | platform_buildid: 20151202120924 22:18:09 INFO - mozversion INFO | platform_changeset: d57fc3a1dda554cbde8557abfb60dce501d9a6a7 22:18:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 22:18:09 INFO - mozversion INFO | platform_version: 44.0a2 22:18:09 INFO - 2015-12-02 22:18:09,903 DEBUG : using testdate: 1449123489 22:18:09 INFO - 2015-12-02 22:18:09,903 DEBUG : actual date: 1449123489 22:18:09 INFO - 2015-12-02 22:18:09,912 INFO : starting webserver on 'localhost:49270' 22:18:09 INFO - 2015-12-02 22:18:09,913 INFO : Starting test suite t-yosemite-r5-0049 22:18:09 INFO - 2015-12-02 22:18:09,913 INFO : Starting test dromaeo_css 22:18:09 INFO - 2015-12-02 22:18:09,913 DEBUG : operating with platform_type : mac_ 22:18:09 INFO - 2015-12-02 22:18:09,914 INFO : Initialising browser for dromaeo_css test... 22:18:09 INFO - 2015-12-02 22:18:09,928 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpS5_WAH/profile http://localhost:49270/getInfo.html 22:18:12 INFO - 2015-12-02 22:18:12,646 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:18:12 INFO - 2015-12-02 22:18:12,647 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:18:12 INFO - 2015-12-02 22:18:12,647 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:18:12 INFO - 2015-12-02 22:18:12,647 DEBUG : BROWSER_OUTPUT: __metrics 22:18:12 INFO - 2015-12-02 22:18:12,663 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:18:13 INFO - 2015-12-02 22:18:13,306 INFO : Browser initialized. 22:18:13 INFO - 2015-12-02 22:18:13,306 INFO : Running cycle 1/1 for dromaeo_css test... 22:18:13 INFO - 2015-12-02 22:18:13,306 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpS5_WAH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:18:25 INFO - 2015-12-02 22:18:25,175 DEBUG : BROWSER_OUTPUT: RSS: Main: 198873088 22:18:25 INFO - 2015-12-02 22:18:25,175 DEBUG : BROWSER_OUTPUT: 22:19:16 INFO - 2015-12-02 22:19:16,765 DEBUG : BROWSER_OUTPUT: 1449123556765 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] 22:21:27 INFO - 2015-12-02 22:21:27,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 22:21:28 INFO - 2015-12-02 22:21:28,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 327368704 22:21:28 INFO - 2015-12-02 22:21:28,613 DEBUG : BROWSER_OUTPUT: 22:24:31 INFO - 2015-12-02 22:24:31,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 22:24:31 INFO - 2015-12-02 22:24:31,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 339521536 22:24:31 INFO - 2015-12-02 22:24:31,590 DEBUG : BROWSER_OUTPUT: 22:27:33 INFO - 2015-12-02 22:27:33,722 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 22:27:34 INFO - 2015-12-02 22:27:34,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 307646464 22:27:34 INFO - 2015-12-02 22:27:34,293 DEBUG : BROWSER_OUTPUT: 22:30:36 INFO - 2015-12-02 22:30:36,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 22:30:36 INFO - 2015-12-02 22:30:36,866 DEBUG : BROWSER_OUTPUT: RSS: Main: 297934848 22:30:36 INFO - 2015-12-02 22:30:36,866 DEBUG : BROWSER_OUTPUT: 22:33:39 INFO - 2015-12-02 22:33:39,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 22:33:40 INFO - 2015-12-02 22:33:40,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 299028480 22:33:40 INFO - 2015-12-02 22:33:40,487 DEBUG : BROWSER_OUTPUT: 22:36:43 INFO - 2015-12-02 22:36:43,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 22:36:43 INFO - 2015-12-02 22:36:43,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 342278144 22:36:43 INFO - 2015-12-02 22:36:43,378 DEBUG : BROWSER_OUTPUT: 22:36:43 INFO - 2015-12-02 22:36:43,378 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:36:43 INFO - 2015-12-02 22:36:43,378 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:36:43 INFO - 2015-12-02 22:36:43,379 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:36:43 INFO - 2015-12-02 22:36:43,379 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:36:43 INFO - 2015-12-02 22:36:43,379 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3201.7118459338662;3242.335321259142;3265.167382317509;3275.050235431725;3300.3729291434624;5444.0745073337575;5472.9179062314;5483.122700367942;5484.095124304495;5518.034343989801;5362.115250983593;5368.355797304319;5374.167004114369;5375.059364611187;5451.04606693828;4858.975705121469;4924.487863230825;4950.158473059589;4956.727379994099;4964.751762411883;5029.647924645276;5036.017976494585;5065.493450654923;5071.264666623338;5072.061668591323;4972.87567810804;4990.8003679852945;4996.125678006334;5001.749912504379;5027.597792176617;4832.806687732486;4896.069746748124;4919.950800491985;4948.826791062295;5025.422076461217;4995.725235112068;4995.9500404996215;4998.325226094467;5007;5047.318611987372;5207.6354655174155;5280.234366016906;5365.973170134124;5410.648307859977;5429.049916264638;5541.861453463655;5647.802326918538;5708;5720.713964301768;5752.5110365618975;5850.180974663551;5867.706614669292;5887.0286402743495;5896.734646940898;5910.143029260733;5342.759575819097;5452.482014208644;5463.453654634504;5498.367687715924;5523;5749.252597162342;5813.476787089182;5824.184614154022;5859.2382990211;5885.323187833368;5599.104143337128;5662.433756624305;5709.8287051388525;5727.0836666134055;5727.3699893011735;5561.193626924073;5638.464345887216;5884.029135192731;5884.823455296348;5885.588008839341;5528.861778455571;5592.636478628876;5676.829695109153;5685.317761868602;5703.54371650267;5710.71446427677;5723.885522289531;5726.141078838207;5727.713614319351;5740.54075673945;4314.697971142053;4405.603495685404;4519.028408892104;4523;4551.067031258584;3983.721139520264;4077.918441631151;4090.468239128954;4095.5290141634096;4112.280350938574;5393;5394.163904594794;5399.7030163340605;5411.512963833274;5444;5612.943870561242;5759.510441612426;5826.970865145647;5846.941530584725;5850.327212370632;5328;5387.838364849061;5450.645708028966;5459.017376872202;5465.453454654582;5014.874628134253;5054.7472626368535;5058.822941197041;5095.617828662865;5100.923486147711;5696.800611978727;5768.423157684198;5804.984127777622;5857.062869940789;5888.411158884077;5607.971960140173;5695.088785794253;5696.772129114789;5700.657960522382;5837.445442683108;5930.762769489172;5939.287285525765;5950.285965684146;5950.702464876826;5962.284525856925;5570.164475328733;5661.405552417102;5837.94162058374;5849.327327357409;5880.500157486662;5564.944350556442;5714.514266287412;5795.3625101237985;5822.272215973004;5836.416358364129;5749.54003679713;5759.049756790083;5795.072788353843;5798.768049277982;5799.3040835100055;5489.149181876815;5591.804286849941;5780.277465316835;5792.275965504312;5796.797112101056;5367.865803354947;5433.945660543344;5435.673859568438;5487.122060470306;5563.221149039218;5685.488306052475;5699.629524080921;5743.827685169452;5749.8562535936935;5766.192733017297;5345.091334473227;5449.727513624223;5620.3536593290655;5623.493885550321;5658.915116273177 22:36:43 INFO - 2015-12-02 22:36:43,380 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.366181383902;583.2883881664369;585.4526018173005;590.3742033444549;597.3160730963048;33160.66839331606;37820.24359512808;38621;38662.420063699064;38702.03244918875;42425.78787106068;42926.35610465846;43087;43139.56860431395;43151.56848431515;9291.81416371674;9474.905250947471;9496.810063798719;9583.28125390595;9629.422234665908;9173;9323.393979391318;9357.578908949114;9447;9451.621935122586;9330.813383732322;9332.813343733122;9350.485723285217;9420.905790942106;9425.057494250554;9306.720798376025;9395.671151509665;9412.670556530556;9519.143277105059;9527.09492598202;9164.404313719653;9273.489958052305;9312.90687093134;9332.533373331375;9391.953040234755;40587.594124058676;40603.59396406057;40669.389959150634;41123.7943810282;41169;3094.4430002599524;3109.238236632017;3216.1477208539754;3506.281212351462;3536.9115772105647;27908.581371279448;27953.86023069892;28532.286692832844;29134.708652913625;29500.8524957376;2330.382448651109;2344.9179278725164;2380.726216485109;2400.687910571632;2507.9749202507924;271260;271939;272962;274985;275083;60650;61998.38001619926;64069.679651601444;68004;68940.31059689439;65269;65297.34702653008;65418.672906636115;65846;66105.6694716533;16884.746728799077;17046.659066818593;17050.573735656708;17067.317307307818;17079.82920170807;12208.450619722134;12462.75074498505;12817.487300508063;12978.805317920238;13009.089363744448;21007.474813129487;21264.149434022776;21349.679754803692;21419.464513386978;21450.463738406354;9115.316351273681;9289.511504970507;9300.488473134043;9340.813183736287;9364.812703746024;920.9355345125776;929.4469790474657;953.3993584042148;1031.9690409287734;1190.2501424102759;27925.720742792717;28140.155795326173;28553.428931421255;28734;28829;1043.5512729526224;1060.6022741471947;1161.3786624156205;1185.8043422835308;1236.7323493419317;11667.824982625267;15072.321745521478;15193.696126077637;15415.383384664712;15440.691186176213;436701;443818;444503;444860;448299;58715.70642146762;58803.70598146982;59280.407195928354;59357.70321148367;59454;1466.6260103673494;1472.1240861687493;1477.940882364715;1487.5834766265464;1490.1282749591394;28388.148355549365;28736;28833;29157.125286241448;29313.560296595995;48015.27977080416;48082.51917480781;48124;48654.75672621614;48657.5134248653;305468;306513;307118;307650;308043;29141.562876556443;29489;32526;33164;33437.665623343455;41340.79329603453;41547.37678934879;42075.7896210517;42868.571314286455;43062;33937.83031084829;34804.82597586996;35991.64008359883;36218;40225.39661905015;36523.81738091292;36963;37162.25675486421;37197.25605487929;37737.81131094327;38951.80524097361;40709;41050;41903.371449428894;42036.15927681368;27489.037883673976;28873;32977.67022329746;32984.67015329816;33110.66889331076;24807.62788558137;25138.874305628357;25273.449131513647;25303;25492.8725356372 22:36:43 INFO - 2015-12-02 22:36:43,384 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.7887023555029;358.93718599245125;359.27068051854735;359.51824555096164;363.13392558747387;14835.703285934274;15081.472148474806;17713.291468341267;18416.81583184168;19017.429477115675;16161.595960101004;19258.13338399772;19629;19638.312659056937;19661.901690491562;4694.741789201593;4878.219484882419;4884.633652476061;5326.813561525338;5510.256115424427;3630.3283892479844;3665.28526937246;4865.537773911473;4907.2639104134305;4946.554810067093;4915.3855768029;4959.8016079356785;5001.049800537904;5004.024215278022;5012.147934851084;4790.281457781326;4925.13810083234;4931.728754918478;4971.577415919651;5001.44984051754;4144.5026596808275;4148.460700108966;4155.272827255249;4202.432671589358;4211.305134652778;13517.188968661912;13692.931535342359;13838.723225535534;13859.584212473643;14016.509422170277;1887.8206570375792;1977.1597071244664;2030.147338117994;2045.4681782736448;2105.3473423238843;9806.65676701312;9914.90085099147;10259.025392587691;10296.27926045177;10384.11735002518;1513.1299502785942;1520.7262692715308;1535.3167840311066;1564.1866229560565;1599.2323684631326;59957.40042599562;62911;63397;63728;63871.36128638701;6739.797806065826;6836.179658441019;6850.588964662136;6894.379820742121;6897.862042759117;7818.4136189785995;7827.452078354574;7847.568383738949;7851.05787305527;7878.290953814184;5668.121441176624;5676.489115979499;5725.398833122462;5727.971360143172;5756.194132821324;6086.756529738849;6094.8171554853425;6129.724162412702;6133.44798968095;6137.478314343331;3072.38552289543;3085.8457077146054;3101.9224519387194;3106.8757249709756;3124.109628755794;1055.8521806947033;1072.4155335342257;1093.606301731376;1115.1803424482998;1119.9440027998567;441.1992234095107;444.5909763017967;454.36615920790973;472.88887111528766;478.0963978081359;10987.450627468595;11228.887711122947;11463.426828658534;11530.76938461226;11817.468213930222;427.55320689879153;459.02457278283646;466.41697877652933;481.5449400316737;487.8341363936279;5071.797128114834;6376.1392212051705;6529.902051469232;6570.5400621956005;6623.569467984566;360623;362361;362616;386115;579044;78110.6094469524;79381;79686;79729;80415.19584804194;522.3183745212534;523.1577160771232;526.9183276592134;527.941926388097;528.3501293409129;10238.385696858213;11308.717282068013;11472.369019703996;11697.532098716296;11839.408029598659;37025.25949480941;37255.25489490141;37423.06442338855;37834.0541486465;38527;49930.25104623361;50130.498695014045;50278.24582631337;50574;50745;6379.74481020754;6425.10048593188;6426.132472116392;6430.839229019312;6436.356364363526;12422.774921280272;12560.05799565018;12685.80971285413;12697.80953285683;12768.361581921052;10469.633562825264;10587.311824731369;10888.40113793749;11003.394813285026;11044.061254793432;9901.801963960825;10407.479626018518;10538.789224215627;10621.787564248827;10759.569617215537;10885.891141088488;10983.231173817756;11018.944905275423;11151.776964460827;11283.153763467937;6517.576357536745;6520.087187793618;6577.671116444254;6589.637569933508;6633.867322653617;10639.095676867244;10798.622048228275;10927.180461465263;10955.452227388758;11056.834147487954 22:36:43 INFO - 2015-12-02 22:36:43,385 DEBUG : BROWSER_OUTPUT: |3;mootools.html;859.510079254825;1423.8362588302346;1502.5567457600007;1702.3190723710513;1882.0401595186452;6809.761658341959;7196.604186769726;7290.526115802482;7382.151052628949;7394.926050739491;7135.571865688063;7224.638768061589;7278.272172782719;7286.089238845145;7311.341979221869;1889.2820728123295;1967.2131147540954;2124.2458927080897;2137.540428807802;2159.66525188596;2241.764614715448;2241.8206543476563;2259.807916327114;2264.501809601893;2268.1154349803505;2118.5868755592664;2194.58302922445;2200.0869639099756;2203.5813195492806;2215.911363545464;1915.1764741161296;1945.6011517638922;2117.1743020222125;2140.3685912655646;2164.7835216478384;2204.1073365287084;2227.231605096239;2250.8199344052437;2253.7295524537;2258.7854153855355;7408.851822963565;7466.178720340758;7469.178390377054;7479.925200748032;7482.176960534337;4651.37206477128;4677.859664210079;4723.36234608327;4731.668783185179;4742.549457801503;2735.0700761741105;2760.1581517637114;2773.902913398021;2816.9295767605768;2835.6455443069617;817.0522194254695;878.1701292278799;884.5533005832078;894.9463032218088;896.4755617963499;9516.714498564985;9549.856752148724;9637.855432168522;9639.373440726331;9642.614295428175;4148.23257697321;4188.4136220929095;4196.9370459443135;4229.513605935295;4246.193223287565;8469.830603387898;8551.657933682707;8552.529610871337;8561;8568.186022327869;4722.338872557844;4726.291056341507;4775.474697783241;4788.95211047892;4790.592799612003;4320.848770293024;4331.155424692218;4366.6506679465565;4372.322290045048;4378.036831896978;3578.159132603836;3593.3531964246163;3643.289558536113;3660.5058317126845;3684.6499582539614;1112.8386383974441;1121.243160866412;1125.0774365020604;1126.915481338903;1141.2296699727651;984.2913102566141;1321.5969129415428;1328.0703507544758;1362.1758835904334;1377.4696741754296;6249.625022498664;7209.387202087882;7268.927310726931;7279.199288078307;7280.635968201569;668.7325069972051;675.6419097878132;679.9728010879609;687.4363022321648;688.7554918004137;5532.336119665666;5575.0522411190195;5629.577781666309;5629.634073785191;5642.943570564324;8441.915580844236;8613.956930215309;8682.78293042679;8729.170728780755;8785.209331160098;8657.393982421296;8730.432521886058;8731.912680873236;8739.606717697592;8757.737267881974;6790.796276111724;6998;7008.509404341749;7039.92960070403;7049.29507049291;6710.530262881747;6717.496187785838;6793.626350550569;6797.864042719217;6800.217974932748;7690.577018263825;7743.341815945482;7807.414443916842;7924.524528528307;7936.2857342839425;7895.486793358414;8037.357011439188;8046.517208967481;8117.837643246984;8141.8371632568205;6304.5271604628915;6335.3981371769605;6362.491000720024;6387.361263873576;6416.679166041773;7110.040144580622;7114.679839407136;7135.393491553276;7188;7198.388137008204;6565.901511477236;6779.389854913082;6781.38967492928;6797.524173307821;6883.8967415487805;6576.243731970884;6607.405333519814;6607.80176594703;6750.32496750321;6757.831054223684;6214.161088253028;6379.4896408286295;6417.550771446141;6738.056672065817;6765.492588055817;5848.4151584841175;5976.133460648269;6047.758089676364;6066.3023752269055;6070.150178974859;6098.481629061579;6150.846228844314;6155.753769849156;6158.476529495043;6183.84540386494 22:36:43 INFO - 2015-12-02 22:36:43,387 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.0290340591848;338.34192495596074;340.1411436123786;340.34483619033364;341.0399724774759;5932.495737862276;6067.302260240073;6154.661493617849;6175.289841668209;6202.224721909762;5920;5949.8215053548465;6009;6014.849628759283;6019.638821670703;4649.744264065475;4690.788914498856;4699.624030077603;4702.3416721659;4726.480087190398;4522.570355816209;4568.291914753202;4664.55686709762;4688.624910007191;4715.104130215265;4611.930821037688;4621.214393553104;4656.371389862359;4664.69679470835;4687.273472611751;4619.884502887421;4635.0729854029;4635.860924172281;4666.743329116897;4670.953290467086;4034.737742046787;4044.373122166069;4059.8579049733116;4075.6943229257627;4084.4894388201474;5833.32916714579;5910.261217347832;5931.703414829241;5944.673042982634;5945.10823376497;5323.201519772027;5330.333708286465;5383.788647554308;5383.838484845422;5394.730263486849;6271.341509141565;6365.822322870284;6441.677916104223;6454.93545064548;6463.48292136628;4349.151915376471;4357.2592659248;4403.669724770655;4460.50934397216;4468.910621787579;6479.319671434479;6546.312637173076;6560.901586476207;6587.374199451092;6620.37106474889;4439.578240067189;4473.507914129443;4493.348464472633;4513.052259025641;4537.886552836206;4373.409589705413;4531.56950089741;4556.407667003268;4572.291294849304;4682.1338052460405;5284.867878303073;5289.259503669489;5295.15277555597;5334.7065911374475;5349.946500535023;6353.682315884187;6376.553641245068;6426.485881129498;6434.485241180694;6437.967810160919;1645.5310236582516;1652.983470165307;1655.0979716054778;1669.4991502549187;1671.3732350368612;1070.352436775755;1101.2346419238713;1106.80630889594;1111.7053980695123;1120.7926533591149;6034.155218269446;6042.335343112254;6052.788152414644;6100.877982440326;6127;6558.442532384705;6565.343465653396;6642.7342906284175;6652.268250492539;6657;5953.880922381528;6030.427109424598;6050.576459647782;6076.3316035236085;6097.3292937776805;3615.457681347819;3650.580183278957;3672.4307732301536;3698.63013698628;3700.2414505026404;6644.90032649501;6667.566608170453;6707.564008339442;6726;6737.461003119739;6785.389314961677;6788.728450862009;6831.59010459374;6837.453003759687;6848.14398200225;6527.118838956775;6659.966700166468;6711.563748356243;6712.664366781642;6732.259451460433;6404.615723056631;6585.96707016481;6586.5389422739945;6677.966610166918;6683.231428385798;6425.325340839145;6438.581492202992;6510.18622672166;6529.216494020558;6537.215534135934;6631.734730610721;6690.364415380531;6714.3957043866285;6725.865482690417;6749.392554670103;4219.7046206765235;4249.978750106354;4279.828806847691;4287.807048682755;4351.477822661301;6517.315681853337;6520.282768895323;6594.90107648376;6612.4710023198995;6634.635095069818;6349.365063493614;6357.205349331333;6437.163168788027;6437.678116094083;6439.388258115471;6221.4089661482085;6316.273628532777;6358.554901156875;6382.170317858649;6422.6467544285515;6167.506599472121;6206.72069756871;6233.812985610439;6275.34108918557;6314.273858506147;6417.2299324081405;6436.420722135031;6451.451626611791;6485.805425837232;6489.415952564292;6088.391160883876;6277.5605707600025;6341.778037768656;6344;6363.395477429637 22:36:43 INFO - 2015-12-02 22:36:43,390 DEBUG : BROWSER_OUTPUT: |5;yui.html;658.4238791057825;750.0586763611667;752.5071078443618;794.4359504751626;803.4697099914056;14548.345324460399;14658.853411465881;14693.265336733148;14754.188519631416;14813.777793333094;13466.663333416645;13737;13753.10604810689;13902.235377054258;13929.30353482327;756.4402342266739;760.0613242645329;931.9534023298842;933.4399360383783;951.8524628682566;910.1490106750176;913.680211925824;929.061647735785;930.3998920696147;932.1936524905941;991.3952488981715;995.9502024898762;997.825380558403;998.3161534348958;1005.7636455432968;793.6111305460312;811.6631597886899;938.5588773276584;959.788846453779;964.2527041542791;709.2729951799396;709.6700034483938;712.1383126417041;713.564725517434;714.8606021825746;14162.575122746333;14189.929050354785;14253;14338.928305358511;14359.497417590333;11653.766924661544;11809.586664466788;11870.821937670942;11883.762324753543;11978.58074967372;9088.272938164997;9100.317476189246;9238.214751746109;9257.166854983017;9842;3274.1487213324467;3455.8963231102857;3479.8260086995547;3507.9649203507893;3512.2799826035857;52228.73885630548;52660.73669631666;52808.47191528074;52994.47005529934;53217;9075.410098343587;9374.578143983537;9380.460683081837;9458;9878.715766950394;20573;20600.793992060186;20625.17499300041;20641.483962900747;20658.58682826335;7413.406927445792;7437.7768666939;7539.095308562898;7561.546307221474;7728.304452599293;3905.6875449963936;3979.522457305142;4009.7794621296107;4065.1293856167786;4194.224068547267;2791.6370871786944;2844.886204551795;2846.8149570277865;2850.900218492343;2851.9144425667264;414.0229059419767;417.1469345189035;429.45030361137793;431.6352681983719;434.24224727849474;521.9222305938225;549.7427740636791;589.1957478042527;598.2641351138125;632.8322994406486;7734.458587898793;7845.0978137513775;7908.644111015018;7941.642626081724;7958.761237162895;508.72274610337456;564.4947771744348;603.9063945088518;621.8662987457718;627.0061951806347;3663.7618554793853;3734.8879533614036;3742.9438558421643;3790.3556395412293;3802.543694756647;58428.707856460445;59167;59407.405925940184;64179.35820641734;64888.675556621914;46969;46981.5301846984;47029.29456058162;54349.72825135928;58594;51830.22254666183;53318.466815332125;53584;54415;55061.449385505635;8104.5137291762685;8315.916840831514;8590.82818343642;8669.133086691281;8695.347848911484;37880.43179352367;38186.236275274896;38551.807240963615;38600.613993859704;38974.610253897095;48613.5138648609;49558.752206238736;50027.49972500374;50273.74863125661;50836;11026.724331891766;11060.944695276472;11073.280236784583;11738.295702257892;12059.942202846149;11789.41052947332;12082.758344832879;12165;12205.69485762863;12500.687482813002;10621.787564248518;10652.84020739674;10921.235513513977;11119;11624.244424112743;11286.153538484483;11297.096232301561;11349.546018159512;11405.258658187191;11659.067274618179;10352.17182625373;10367.377957322586;10543.736406589896;11057;11057.391843448688;9532.142107210384;9555.713328600154;9627.951860240653;9835.655752048644;9910.15763660097;9469.715908522756;9594.232461402931;9659.661911833333;9672.371295865747;9692 22:36:43 INFO - 2015-12-02 22:36:43,390 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:36:43 INFO - 2015-12-02 22:36:43,390 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:36:43 INFO - 2015-12-02 22:36:43,390 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,886 22:36:43 INFO - 2015-12-02 22:36:43,391 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:36:43 INFO - 2015-12-02 22:36:43,391 DEBUG : BROWSER_OUTPUT: __startTimestamp1449124603375__endTimestamp 22:36:43 INFO - 2015-12-02 22:36:43,391 DEBUG : BROWSER_OUTPUT: 22:36:43 INFO - 2015-12-02 22:36:43,391 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:36:43 INFO - 2015-12-02 22:36:43,391 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:36:43 INFO - 2015-12-02 22:36:43,391 DEBUG : BROWSER_OUTPUT: 22:36:43 INFO - 2015-12-02 22:36:43,391 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5375.87 Median:5528.86 stddev:567.16 (10.3%) stddev-sans-first:542.64 22:36:43 INFO - 2015-12-02 22:36:43,391 DEBUG : BROWSER_OUTPUT: Values: 3201.7 3242.3 3265.2 3275.1 3300.4 5444.1 5472.9 5483.1 5484.1 5518.0 5362.1 5368.4 5374.2 5375.1 5451.0 4859.0 4924.5 4950.2 4956.7 4964.8 5029.6 5036.0 5065.5 5071.3 5072.1 4972.9 4990.8 4996.1 5001.7 5027.6 4832.8 4896.1 4920.0 4948.8 5025.4 4995.7 4996.0 4998.3 5007.0 5047.3 5207.6 5280.2 5366.0 5410.6 5429.0 5541.9 5647.8 5708.0 5720.7 5752.5 5850.2 5867.7 5887.0 5896.7 5910.1 5342.8 5452.5 5463.5 5498.4 5523.0 5749.3 5813.5 5824.2 5859.2 5885.3 5599.1 5662.4 5709.8 5727.1 5727.4 5561.2 5638.5 5884.0 5884.8 5885.6 5528.9 5592.6 5676.8 5685.3 5703.5 5710.7 5723.9 5726.1 5727.7 5740.5 4314.7 4405.6 4519.0 4523.0 4551.1 3983.7 4077.9 4090.5 4095.5 4112.3 5393.0 5394.2 5399.7 5411.5 5444.0 5612.9 5759.5 5827.0 5846.9 5850.3 5328.0 5387.8 5450.6 5459.0 5465.5 5014.9 5054.7 5058.8 5095.6 5100.9 5696.8 5768.4 5805.0 5857.1 5888.4 5608.0 5695.1 5696.8 5700.7 5837.4 5930.8 5939.3 5950.3 5950.7 5962.3 5570.2 5661.4 5837.9 5849.3 5880.5 5564.9 5714.5 5795.4 5822.3 5836.4 5749.5 5759.0 5795.1 5798.8 5799.3 5489.1 5591.8 5780.3 5792.3 5796.8 5367.9 5433.9 5435.7 5487.1 5563.2 5685.5 5699.6 5743.8 5749.9 5766.2 5345.1 5449.7 5620.4 5623.5 5658.9 22:36:43 INFO - 2015-12-02 22:36:43,392 DEBUG : BROWSER_OUTPUT: 22:36:43 INFO - 2015-12-02 22:36:43,392 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:51241.20 Median:37467.53 stddev:92047.96 (245.7%) stddev-sans-first:92227.49 22:36:43 INFO - 2015-12-02 22:36:43,393 DEBUG : BROWSER_OUTPUT: Values: 546.4 583.3 585.5 590.4 597.3 33160.7 37820.2 38621.0 38662.4 38702.0 42425.8 42926.4 43087.0 43139.6 43151.6 9291.8 9474.9 9496.8 9583.3 9629.4 9173.0 9323.4 9357.6 9447.0 9451.6 9330.8 9332.8 9350.5 9420.9 9425.1 9306.7 9395.7 9412.7 9519.1 9527.1 9164.4 9273.5 9312.9 9332.5 9392.0 40587.6 40603.6 40669.4 41123.8 41169.0 3094.4 3109.2 3216.1 3506.3 3536.9 27908.6 27953.9 28532.3 29134.7 29500.9 2330.4 2344.9 2380.7 2400.7 2508.0 271260.0 271939.0 272962.0 274985.0 275083.0 60650.0 61998.4 64069.7 68004.0 68940.3 65269.0 65297.3 65418.7 65846.0 66105.7 16884.7 17046.7 17050.6 17067.3 17079.8 12208.5 12462.8 12817.5 12978.8 13009.1 21007.5 21264.1 21349.7 21419.5 21450.5 9115.3 9289.5 9300.5 9340.8 9364.8 920.9 929.4 953.4 1032.0 1190.3 27925.7 28140.2 28553.4 28734.0 28829.0 1043.6 1060.6 1161.4 1185.8 1236.7 11667.8 15072.3 15193.7 15415.4 15440.7 436701.0 443818.0 444503.0 444860.0 448299.0 58715.7 58803.7 59280.4 59357.7 59454.0 1466.6 1472.1 1477.9 1487.6 1490.1 28388.1 28736.0 28833.0 29157.1 29313.6 48015.3 48082.5 48124.0 48654.8 48657.5 305468.0 306513.0 307118.0 307650.0 308043.0 29141.6 29489.0 32526.0 33164.0 33437.7 41340.8 41547.4 42075.8 42868.6 43062.0 33937.8 34804.8 35991.6 36218.0 40225.4 36523.8 36963.0 37162.3 37197.3 37737.8 38951.8 40709.0 41050.0 41903.4 42036.2 27489.0 28873.0 32977.7 32984.7 33110.7 24807.6 25138.9 25273.4 25303.0 25492.9 22:36:43 INFO - 2015-12-02 22:36:43,393 DEBUG : BROWSER_OUTPUT: 22:36:43 INFO - 2015-12-02 22:36:43,393 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23819.15 Median:4178.85 stddev:69210.48 (1656.2%) stddev-sans-first:69382.21 22:36:43 INFO - 2015-12-02 22:36:43,395 DEBUG : BROWSER_OUTPUT: Values: 356.8 358.9 359.3 359.5 363.1 14835.7 15081.5 17713.3 18416.8 19017.4 16161.6 19258.1 19629.0 19638.3 19661.9 4694.7 4878.2 4884.6 5326.8 5510.3 3630.3 3665.3 4865.5 4907.3 4946.6 4915.4 4959.8 5001.0 5004.0 5012.1 4790.3 4925.1 4931.7 4971.6 5001.4 4144.5 4148.5 4155.3 4202.4 4211.3 13517.2 13692.9 13838.7 13859.6 14016.5 1887.8 1977.2 2030.1 2045.5 2105.3 9806.7 9914.9 10259.0 10296.3 10384.1 1513.1 1520.7 1535.3 1564.2 1599.2 59957.4 62911.0 63397.0 63728.0 63871.4 6739.8 6836.2 6850.6 6894.4 6897.9 7818.4 7827.5 7847.6 7851.1 7878.3 5668.1 5676.5 5725.4 5728.0 5756.2 6086.8 6094.8 6129.7 6133.4 6137.5 3072.4 3085.8 3101.9 3106.9 3124.1 1055.9 1072.4 1093.6 1115.2 1119.9 441.2 444.6 454.4 472.9 478.1 10987.5 11228.9 11463.4 11530.8 11817.5 427.6 459.0 466.4 481.5 487.8 5071.8 6376.1 6529.9 6570.5 6623.6 360623.0 362361.0 362616.0 386115.0 579044.0 78110.6 79381.0 79686.0 79729.0 80415.2 522.3 523.2 526.9 527.9 528.4 10238.4 11308.7 11472.4 11697.5 11839.4 37025.3 37255.3 37423.1 37834.1 38527.0 49930.3 50130.5 50278.2 50574.0 50745.0 6379.7 6425.1 6426.1 6430.8 6436.4 12422.8 12560.1 12685.8 12697.8 12768.4 10469.6 10587.3 10888.4 11003.4 11044.1 9901.8 10407.5 10538.8 10621.8 10759.6 10885.9 10983.2 11018.9 11151.8 11283.2 6517.6 6520.1 6577.7 6589.6 6633.9 10639.1 10798.6 10927.2 10955.5 11056.8 22:36:43 INFO - 2015-12-02 22:36:43,395 DEBUG : BROWSER_OUTPUT: 22:36:43 INFO - 2015-12-02 22:36:43,395 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5165.28 Median:6417.11 stddev:2629.70 (41.0%) stddev-sans-first:2617.14 22:36:43 INFO - 2015-12-02 22:36:43,396 DEBUG : BROWSER_OUTPUT: Values: 859.5 1423.8 1502.6 1702.3 1882.0 6809.8 7196.6 7290.5 7382.2 7394.9 7135.6 7224.6 7278.3 7286.1 7311.3 1889.3 1967.2 2124.2 2137.5 2159.7 2241.8 2241.8 2259.8 2264.5 2268.1 2118.6 2194.6 2200.1 2203.6 2215.9 1915.2 1945.6 2117.2 2140.4 2164.8 2204.1 2227.2 2250.8 2253.7 2258.8 7408.9 7466.2 7469.2 7479.9 7482.2 4651.4 4677.9 4723.4 4731.7 4742.5 2735.1 2760.2 2773.9 2816.9 2835.6 817.1 878.2 884.6 894.9 896.5 9516.7 9549.9 9637.9 9639.4 9642.6 4148.2 4188.4 4196.9 4229.5 4246.2 8469.8 8551.7 8552.5 8561.0 8568.2 4722.3 4726.3 4775.5 4789.0 4790.6 4320.8 4331.2 4366.7 4372.3 4378.0 3578.2 3593.4 3643.3 3660.5 3684.6 1112.8 1121.2 1125.1 1126.9 1141.2 984.3 1321.6 1328.1 1362.2 1377.5 6249.6 7209.4 7268.9 7279.2 7280.6 668.7 675.6 680.0 687.4 688.8 5532.3 5575.1 5629.6 5629.6 5642.9 8441.9 8614.0 8682.8 8729.2 8785.2 8657.4 8730.4 8731.9 8739.6 8757.7 6790.8 6998.0 7008.5 7039.9 7049.3 6710.5 6717.5 6793.6 6797.9 6800.2 7690.6 7743.3 7807.4 7924.5 7936.3 7895.5 8037.4 8046.5 8117.8 8141.8 6304.5 6335.4 6362.5 6387.4 6416.7 7110.0 7114.7 7135.4 7188.0 7198.4 6565.9 6779.4 6781.4 6797.5 6883.9 6576.2 6607.4 6607.8 6750.3 6757.8 6214.2 6379.5 6417.6 6738.1 6765.5 5848.4 5976.1 6047.8 6066.3 6070.2 6098.5 6150.8 6155.8 6158.5 6183.8 22:36:43 INFO - 2015-12-02 22:36:43,396 DEBUG : BROWSER_OUTPUT: 22:36:43 INFO - 2015-12-02 22:36:43,397 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5338.75 Median:6051.68 stddev:1595.68 (26.4%) stddev-sans-first:1555.20 22:36:43 INFO - 2015-12-02 22:36:43,397 DEBUG : BROWSER_OUTPUT: Values: 328.0 338.3 340.1 340.3 341.0 5932.5 6067.3 6154.7 6175.3 6202.2 5920.0 5949.8 6009.0 6014.8 6019.6 4649.7 4690.8 4699.6 4702.3 4726.5 4522.6 4568.3 4664.6 4688.6 4715.1 4611.9 4621.2 4656.4 4664.7 4687.3 4619.9 4635.1 4635.9 4666.7 4671.0 4034.7 4044.4 4059.9 4075.7 4084.5 5833.3 5910.3 5931.7 5944.7 5945.1 5323.2 5330.3 5383.8 5383.8 5394.7 6271.3 6365.8 6441.7 6454.9 6463.5 4349.2 4357.3 4403.7 4460.5 4468.9 6479.3 6546.3 6560.9 6587.4 6620.4 4439.6 4473.5 4493.3 4513.1 4537.9 4373.4 4531.6 4556.4 4572.3 4682.1 5284.9 5289.3 5295.2 5334.7 5349.9 6353.7 6376.6 6426.5 6434.5 6438.0 1645.5 1653.0 1655.1 1669.5 1671.4 1070.4 1101.2 1106.8 1111.7 1120.8 6034.2 6042.3 6052.8 6100.9 6127.0 6558.4 6565.3 6642.7 6652.3 6657.0 5953.9 6030.4 6050.6 6076.3 6097.3 3615.5 3650.6 3672.4 3698.6 3700.2 6644.9 6667.6 6707.6 6726.0 6737.5 6785.4 6788.7 6831.6 6837.5 6848.1 6527.1 6660.0 6711.6 6712.7 6732.3 6404.6 6586.0 6586.5 6678.0 6683.2 6425.3 6438.6 6510.2 6529.2 6537.2 6631.7 6690.4 6714.4 6725.9 6749.4 4219.7 4250.0 4279.8 4287.8 4351.5 6517.3 6520.3 6594.9 6612.5 6634.6 6349.4 6357.2 6437.2 6437.7 6439.4 6221.4 6316.3 6358.6 6382.2 6422.6 6167.5 6206.7 6233.8 6275.3 6314.3 6417.2 6436.4 6451.5 6485.8 6489.4 6088.4 6277.6 6341.8 6344.0 6363.4 22:36:43 INFO - 2015-12-02 22:36:43,398 DEBUG : BROWSER_OUTPUT: 22:36:43 INFO - 2015-12-02 22:36:43,398 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14478.62 Median:26176.07 stddev:17420.64 (66.6%) stddev-sans-first:17438.60 22:36:43 INFO - 2015-12-02 22:36:43,398 DEBUG : BROWSER_OUTPUT: Values: 658.4 750.1 752.5 794.4 803.5 14548.3 14658.9 14693.3 14754.2 14813.8 13466.7 13737.0 13753.1 13902.2 13929.3 756.4 760.1 932.0 933.4 951.9 910.1 913.7 929.1 930.4 932.2 991.4 996.0 997.8 998.3 1005.8 793.6 811.7 938.6 959.8 964.3 709.3 709.7 712.1 713.6 714.9 14162.6 14189.9 14253.0 14338.9 14359.5 11653.8 11809.6 11870.8 11883.8 11978.6 9088.3 9100.3 9238.2 9257.2 9842.0 3274.1 3455.9 3479.8 3508.0 3512.3 52228.7 52660.7 52808.5 52994.5 53217.0 9075.4 9374.6 9380.5 9458.0 9878.7 20573.0 20600.8 20625.2 20641.5 20658.6 7413.4 7437.8 7539.1 7561.5 7728.3 3905.7 3979.5 4009.8 4065.1 4194.2 2791.6 2844.9 2846.8 2850.9 2851.9 414.0 417.1 429.5 431.6 434.2 521.9 549.7 589.2 598.3 632.8 7734.5 7845.1 7908.6 7941.6 7958.8 508.7 564.5 603.9 621.9 627.0 3663.8 3734.9 3742.9 3790.4 3802.5 58428.7 59167.0 59407.4 64179.4 64888.7 46969.0 46981.5 47029.3 54349.7 58594.0 51830.2 53318.5 53584.0 54415.0 55061.4 8104.5 8315.9 8590.8 8669.1 8695.3 37880.4 38186.2 38551.8 38600.6 38974.6 48613.5 49558.8 50027.5 50273.7 50836.0 11026.7 11060.9 11073.3 11738.3 12059.9 11789.4 12082.8 12165.0 12205.7 12500.7 10621.8 10652.8 10921.2 11119.0 11624.2 11286.2 11297.1 11349.5 11405.3 11659.1 10352.2 10367.4 10543.7 11057.0 11057.4 9532.1 9555.7 9628.0 9835.7 9910.2 9469.7 9594.2 9659.7 9672.4 9692.0 22:36:43 INFO - 2015-12-02 22:36:43,398 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:36:43 INFO - 2015-12-02 22:36:43,398 DEBUG : BROWSER_OUTPUT: 22:36:44 INFO - 2015-12-02 22:36:44,037 INFO : Browser exited with error code: 0 22:36:44 INFO - 2015-12-02 22:36:44,064 INFO : Completed test dromaeo_css (00:18:34) 22:36:44 INFO - 2015-12-02 22:36:44,064 INFO : Starting test kraken 22:36:44 INFO - 2015-12-02 22:36:44,064 DEBUG : operating with platform_type : mac_ 22:36:44 INFO - 2015-12-02 22:36:44,065 INFO : Initialising browser for kraken test... 22:36:44 INFO - 2015-12-02 22:36:44,078 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpgpjZvj/profile http://localhost:49270/getInfo.html 22:36:46 INFO - 2015-12-02 22:36:46,234 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:36:46 INFO - 2015-12-02 22:36:46,234 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:36:46 INFO - 2015-12-02 22:36:46,234 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:36:46 INFO - 2015-12-02 22:36:46,234 DEBUG : BROWSER_OUTPUT: __metrics 22:36:46 INFO - 2015-12-02 22:36:46,250 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:36:46 INFO - 2015-12-02 22:36:46,851 INFO : Browser initialized. 22:36:46 INFO - 2015-12-02 22:36:46,851 INFO : Running cycle 1/1 for kraken test... 22:36:46 INFO - 2015-12-02 22:36:46,851 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpgpjZvj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:36:58 INFO - 2015-12-02 22:36:58,593 DEBUG : BROWSER_OUTPUT: RSS: Main: 197554176 22:36:58 INFO - 2015-12-02 22:36:58,593 DEBUG : BROWSER_OUTPUT: 22:37:01 INFO - 2015-12-02 22:37:01,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 22:37:01 INFO - 2015-12-02 22:37:01,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 262692864 22:37:01 INFO - 2015-12-02 22:37:01,783 DEBUG : BROWSER_OUTPUT: 22:37:04 INFO - 2015-12-02 22:37:04,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 22:37:04 INFO - 2015-12-02 22:37:04,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 275968000 22:37:04 INFO - 2015-12-02 22:37:04,991 DEBUG : BROWSER_OUTPUT: 22:37:07 INFO - 2015-12-02 22:37:07,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 22:37:08 INFO - 2015-12-02 22:37:08,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 260767744 22:37:08 INFO - 2015-12-02 22:37:08,417 DEBUG : BROWSER_OUTPUT: 22:37:10 INFO - 2015-12-02 22:37:10,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 22:37:11 INFO - 2015-12-02 22:37:11,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 262225920 22:37:11 INFO - 2015-12-02 22:37:11,023 DEBUG : BROWSER_OUTPUT: 22:37:13 INFO - 2015-12-02 22:37:13,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:37:13 INFO - 2015-12-02 22:37:13,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 261799936 22:37:13 INFO - 2015-12-02 22:37:13,768 DEBUG : BROWSER_OUTPUT: 22:37:16 INFO - 2015-12-02 22:37:16,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 22:37:17 INFO - 2015-12-02 22:37:17,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 264273920 22:37:17 INFO - 2015-12-02 22:37:17,366 DEBUG : BROWSER_OUTPUT: 22:37:20 INFO - 2015-12-02 22:37:20,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 22:37:21 INFO - 2015-12-02 22:37:21,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 263409664 22:37:21 INFO - 2015-12-02 22:37:21,044 DEBUG : BROWSER_OUTPUT: 22:37:23 INFO - 2015-12-02 22:37:23,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 22:37:24 INFO - 2015-12-02 22:37:24,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 262283264 22:37:24 INFO - 2015-12-02 22:37:24,485 DEBUG : BROWSER_OUTPUT: 22:37:26 INFO - 2015-12-02 22:37:26,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:37:26 INFO - 2015-12-02 22:37:26,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 296873984 22:37:26 INFO - 2015-12-02 22:37:26,652 DEBUG : BROWSER_OUTPUT: 22:37:28 INFO - 2015-12-02 22:37:28,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:37:29 INFO - 2015-12-02 22:37:29,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 297848832 22:37:29 INFO - 2015-12-02 22:37:29,075 DEBUG : BROWSER_OUTPUT: 22:37:31 INFO - 2015-12-02 22:37:31,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:37:31 INFO - 2015-12-02 22:37:31,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 304566272 22:37:31 INFO - 2015-12-02 22:37:31,727 DEBUG : BROWSER_OUTPUT: 22:37:34 INFO - 2015-12-02 22:37:34,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:37:34 INFO - 2015-12-02 22:37:34,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 307695616 22:37:34 INFO - 2015-12-02 22:37:34,845 DEBUG : BROWSER_OUTPUT: 22:37:37 INFO - 2015-12-02 22:37:37,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:37:37 INFO - 2015-12-02 22:37:37,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 306397184 22:37:37 INFO - 2015-12-02 22:37:37,987 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 22:37:39 INFO - 2015-12-02 22:37:39,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 365346816 22:37:39 INFO - 2015-12-02 22:37:39,962 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,962 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:37:39 INFO - 2015-12-02 22:37:39,962 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:37:39 INFO - 2015-12-02 22:37:39,962 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:37:39 INFO - 2015-12-02 22:37:39,962 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:37:39 INFO - 2015-12-02 22:37:39,962 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;104;106;109;110;97;107;98;105 22:37:39 INFO - 2015-12-02 22:37:39,963 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;129;158;150;127;146;129;161;148;127 22:37:39 INFO - 2015-12-02 22:37:39,963 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;162;161;159;161;162;162;162;161 22:37:39 INFO - 2015-12-02 22:37:39,963 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;81;74;120;67;68;70;70;111;65 22:37:39 INFO - 2015-12-02 22:37:39,963 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;101;97;135;87;88;88;126;88;88;129 22:37:39 INFO - 2015-12-02 22:37:39,963 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;120;115;115;114;120;114;115;115;114;114 22:37:39 INFO - 2015-12-02 22:37:39,963 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;124;124;124;124;124;124;124;124;125 22:37:39 INFO - 2015-12-02 22:37:39,963 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;101;101;101;101;101;100;101;100;101 22:37:39 INFO - 2015-12-02 22:37:39,963 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;64;62;62;62;64;63;70;56;58 22:37:39 INFO - 2015-12-02 22:37:39,963 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;64;64;65;65;64;65;66 22:37:39 INFO - 2015-12-02 22:37:39,964 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;83;82;81;82;85;82;83;87 22:37:39 INFO - 2015-12-02 22:37:39,964 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;120;120;116;121;127;121;119;119;121 22:37:39 INFO - 2015-12-02 22:37:39,964 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;136;145;145;146;136;146;150;144;144 22:37:39 INFO - 2015-12-02 22:37:39,964 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;68;68;69;69;68;68;68;69 22:37:39 INFO - 2015-12-02 22:37:39,964 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:37:39 INFO - 2015-12-02 22:37:39,964 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:37:39 INFO - 2015-12-02 22:37:39,964 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,903 22:37:39 INFO - 2015-12-02 22:37:39,964 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:37:39 INFO - 2015-12-02 22:37:39,964 DEBUG : BROWSER_OUTPUT: __startTimestamp1449124659955__endTimestamp 22:37:39 INFO - 2015-12-02 22:37:39,964 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,965 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:37:39 INFO - 2015-12-02 22:37:39,965 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:37:39 INFO - 2015-12-02 22:37:39,965 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,965 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.30 Median:109.00 stddev:4.52 (4.1%) stddev-sans-first:4.69 22:37:39 INFO - 2015-12-02 22:37:39,965 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 104.0 106.0 109.0 110.0 97.0 107.0 98.0 105.0 22:37:39 INFO - 2015-12-02 22:37:39,965 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,965 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.70 Median:149.00 stddev:13.40 (9.0%) stddev-sans-first:13.78 22:37:39 INFO - 2015-12-02 22:37:39,965 DEBUG : BROWSER_OUTPUT: Values: 152.0 129.0 158.0 150.0 127.0 146.0 129.0 161.0 148.0 127.0 22:37:39 INFO - 2015-12-02 22:37:39,965 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,966 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:0.97 22:37:39 INFO - 2015-12-02 22:37:39,966 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 162.0 161.0 159.0 161.0 162.0 162.0 162.0 161.0 22:37:39 INFO - 2015-12-02 22:37:39,966 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,966 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.30 Median:70.00 stddev:19.28 (27.5%) stddev-sans-first:20.41 22:37:39 INFO - 2015-12-02 22:37:39,966 DEBUG : BROWSER_OUTPUT: Values: 77.0 81.0 74.0 120.0 67.0 68.0 70.0 70.0 111.0 65.0 22:37:39 INFO - 2015-12-02 22:37:39,966 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,966 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:88.00 stddev:19.51 (22.2%) stddev-sans-first:20.68 22:37:39 INFO - 2015-12-02 22:37:39,967 DEBUG : BROWSER_OUTPUT: Values: 101.0 97.0 135.0 87.0 88.0 88.0 126.0 88.0 88.0 129.0 22:37:39 INFO - 2015-12-02 22:37:39,967 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,967 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.00 stddev:2.37 (2.1%) stddev-sans-first:1.90 22:37:39 INFO - 2015-12-02 22:37:39,967 DEBUG : BROWSER_OUTPUT: Values: 120.0 115.0 115.0 114.0 120.0 114.0 115.0 115.0 114.0 114.0 22:37:39 INFO - 2015-12-02 22:37:39,967 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,967 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:124.20 Median:124.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 22:37:39 INFO - 2015-12-02 22:37:39,967 DEBUG : BROWSER_OUTPUT: Values: 125.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 124.0 125.0 22:37:39 INFO - 2015-12-02 22:37:39,967 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,968 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:100.80 Median:101.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:37:39 INFO - 2015-12-02 22:37:39,968 DEBUG : BROWSER_OUTPUT: Values: 101.0 101.0 101.0 101.0 101.0 101.0 100.0 101.0 100.0 101.0 22:37:39 INFO - 2015-12-02 22:37:39,968 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,968 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.50 stddev:3.78 (6.1%) stddev-sans-first:3.94 22:37:39 INFO - 2015-12-02 22:37:39,968 DEBUG : BROWSER_OUTPUT: Values: 60.0 64.0 62.0 62.0 62.0 64.0 63.0 70.0 56.0 58.0 22:37:39 INFO - 2015-12-02 22:37:39,968 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,968 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:0.88 22:37:39 INFO - 2015-12-02 22:37:39,968 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 64.0 64.0 65.0 65.0 64.0 65.0 66.0 22:37:39 INFO - 2015-12-02 22:37:39,968 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,969 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.73 (2.1%) stddev-sans-first:1.83 22:37:39 INFO - 2015-12-02 22:37:39,969 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 83.0 82.0 81.0 82.0 85.0 82.0 83.0 87.0 22:37:39 INFO - 2015-12-02 22:37:39,969 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,969 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.00 stddev:3.86 (3.2%) stddev-sans-first:2.92 22:37:39 INFO - 2015-12-02 22:37:39,969 DEBUG : BROWSER_OUTPUT: Values: 129.0 120.0 120.0 116.0 121.0 127.0 121.0 119.0 119.0 121.0 22:37:39 INFO - 2015-12-02 22:37:39,969 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,969 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:145.50 stddev:4.51 (3.1%) stddev-sans-first:4.64 22:37:39 INFO - 2015-12-02 22:37:39,969 DEBUG : BROWSER_OUTPUT: Values: 147.0 136.0 145.0 145.0 146.0 136.0 146.0 150.0 144.0 144.0 22:37:39 INFO - 2015-12-02 22:37:39,969 DEBUG : BROWSER_OUTPUT: 22:37:39 INFO - 2015-12-02 22:37:39,970 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 22:37:39 INFO - 2015-12-02 22:37:39,970 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 68.0 69.0 69.0 68.0 68.0 68.0 69.0 22:37:39 INFO - 2015-12-02 22:37:39,970 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:37:39 INFO - 2015-12-02 22:37:39,970 DEBUG : BROWSER_OUTPUT: 22:37:40 INFO - 2015-12-02 22:37:40,551 INFO : Browser exited with error code: 0 22:37:40 INFO - 2015-12-02 22:37:40,598 INFO : Completed test kraken (00:00:56) 22:37:40 INFO - 2015-12-02 22:37:40,599 INFO : Starting test v8_7 22:37:40 INFO - 2015-12-02 22:37:40,599 DEBUG : operating with platform_type : mac_ 22:37:40 INFO - 2015-12-02 22:37:40,599 INFO : Initialising browser for v8_7 test... 22:37:40 INFO - 2015-12-02 22:37:40,612 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpMfRCWD/profile http://localhost:49270/getInfo.html 22:37:42 INFO - 2015-12-02 22:37:42,667 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:37:42 INFO - 2015-12-02 22:37:42,668 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:37:42 INFO - 2015-12-02 22:37:42,668 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:37:42 INFO - 2015-12-02 22:37:42,668 DEBUG : BROWSER_OUTPUT: __metrics 22:37:42 INFO - 2015-12-02 22:37:42,684 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:37:43 INFO - 2015-12-02 22:37:43,290 INFO : Browser initialized. 22:37:43 INFO - 2015-12-02 22:37:43,290 INFO : Running cycle 1/1 for v8_7 test... 22:37:43 INFO - 2015-12-02 22:37:43,290 DEBUG : command line: /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/T/tmpMfRCWD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:37:55 INFO - 2015-12-02 22:37:55,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 197652480 22:37:55 INFO - 2015-12-02 22:37:55,035 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/v8_7/run.html (next: http://localhost:49270/tests/v8_7/run.html) 22:38:16 INFO - 2015-12-02 22:38:16,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 520822784 22:38:16 INFO - 2015-12-02 22:38:16,671 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,671 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:38:16 INFO - 2015-12-02 22:38:16,671 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:38:16 INFO - 2015-12-02 22:38:16,671 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:38:16 INFO - 2015-12-02 22:38:16,672 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:38:16 INFO - 2015-12-02 22:38:16,672 DEBUG : BROWSER_OUTPUT: |0;Richards;166.03021749958492 22:38:16 INFO - 2015-12-02 22:38:16,672 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.35093761959433 22:38:16 INFO - 2015-12-02 22:38:16,672 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.0975292587776 22:38:16 INFO - 2015-12-02 22:38:16,672 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5791.907514450867 22:38:16 INFO - 2015-12-02 22:38:16,672 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1007.0493454179255 22:38:16 INFO - 2015-12-02 22:38:16,672 DEBUG : BROWSER_OUTPUT: |5;Earley;675.219446320054 22:38:16 INFO - 2015-12-02 22:38:16,673 DEBUG : BROWSER_OUTPUT: |6;Boyer;12500 22:38:16 INFO - 2015-12-02 22:38:16,673 DEBUG : BROWSER_OUTPUT: |7;RegExp;30909.090909090908 22:38:16 INFO - 2015-12-02 22:38:16,673 DEBUG : BROWSER_OUTPUT: |8;Splay;611.6207951070336 22:38:16 INFO - 2015-12-02 22:38:16,673 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5797.687861271676 22:38:16 INFO - 2015-12-02 22:38:16,673 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:38:16 INFO - 2015-12-02 22:38:16,673 DEBUG : BROWSER_OUTPUT: __startTimestamp1449124696669__endTimestamp 22:38:16 INFO - 2015-12-02 22:38:16,673 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,673 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:38:16 INFO - 2015-12-02 22:38:16,674 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:38:16 INFO - 2015-12-02 22:38:16,674 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,674 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 22:38:16 INFO - 2015-12-02 22:38:16,674 DEBUG : BROWSER_OUTPUT: Values: 166.0 22:38:16 INFO - 2015-12-02 22:38:16,674 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,674 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.35 Median:191.35 stddev:0.00 (0.0%) 22:38:16 INFO - 2015-12-02 22:38:16,674 DEBUG : BROWSER_OUTPUT: Values: 191.4 22:38:16 INFO - 2015-12-02 22:38:16,674 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,674 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.10 Median:325.10 stddev:0.00 (0.0%) 22:38:16 INFO - 2015-12-02 22:38:16,674 DEBUG : BROWSER_OUTPUT: Values: 325.1 22:38:16 INFO - 2015-12-02 22:38:16,675 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,675 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5791.91 Median:5791.91 stddev:0.00 (0.0%) 22:38:16 INFO - 2015-12-02 22:38:16,675 DEBUG : BROWSER_OUTPUT: Values: 5791.9 22:38:16 INFO - 2015-12-02 22:38:16,675 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,675 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1007.05 Median:1007.05 stddev:0.00 (0.0%) 22:38:16 INFO - 2015-12-02 22:38:16,675 DEBUG : BROWSER_OUTPUT: Values: 1007.0 22:38:16 INFO - 2015-12-02 22:38:16,675 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,675 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:675.22 Median:675.22 stddev:0.00 (0.0%) 22:38:16 INFO - 2015-12-02 22:38:16,676 DEBUG : BROWSER_OUTPUT: Values: 675.2 22:38:16 INFO - 2015-12-02 22:38:16,676 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,676 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 22:38:16 INFO - 2015-12-02 22:38:16,676 DEBUG : BROWSER_OUTPUT: Values: 12500.0 22:38:16 INFO - 2015-12-02 22:38:16,676 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,676 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30909.09 Median:30909.09 stddev:0.00 (0.0%) 22:38:16 INFO - 2015-12-02 22:38:16,676 DEBUG : BROWSER_OUTPUT: Values: 30909.1 22:38:16 INFO - 2015-12-02 22:38:16,676 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,676 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.62 Median:611.62 stddev:0.00 (0.0%) 22:38:16 INFO - 2015-12-02 22:38:16,677 DEBUG : BROWSER_OUTPUT: Values: 611.6 22:38:16 INFO - 2015-12-02 22:38:16,677 DEBUG : BROWSER_OUTPUT: 22:38:16 INFO - 2015-12-02 22:38:16,677 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 22:38:16 INFO - 2015-12-02 22:38:16,677 DEBUG : BROWSER_OUTPUT: Values: 5797.7 22:38:16 INFO - 2015-12-02 22:38:16,677 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:38:16 INFO - 2015-12-02 22:38:16,677 DEBUG : BROWSER_OUTPUT: 22:38:17 INFO - 2015-12-02 22:38:17,256 INFO : Browser exited with error code: 0 22:38:17 INFO - 2015-12-02 22:38:17,276 INFO : Completed test v8_7 (00:00:36) 22:38:17 INFO - 2015-12-02 22:38:17,416 INFO : Completed test suite (00:20:07) 22:38:17 INFO - 2015-12-02 22:38:17,416 DEBUG : Working with test: dromaeo_css 22:38:17 INFO - 2015-12-02 22:38:17,416 DEBUG : Generating results file: dromaeo_css 22:38:17 INFO - 2015-12-02 22:38:17,417 DEBUG : Working with test: kraken 22:38:17 INFO - 2015-12-02 22:38:17,417 DEBUG : Generating results file: kraken 22:38:17 INFO - 2015-12-02 22:38:17,417 INFO : javascript benchmark 22:38:17 INFO - 2015-12-02 22:38:17,417 DEBUG : Working with test: v8_7 22:38:17 INFO - 2015-12-02 22:38:17,418 DEBUG : Generating results file: v8_7 22:38:17 INFO - 2015-12-02 22:38:17,418 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:38:17 INFO - 2015-12-02 22:38:17,469 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,55]] 22:38:17 INFO - 2015-12-02 22:38:17,469 DEBUG : process_Request line: dromaeo_css 6712.39 graph.html#tests=[[72,52,55]] 22:38:17 INFO - 2015-12-02 22:38:17,469 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:38:17 INFO - 2015-12-02 22:38:17,493 DEBUG : process_Request line: kraken 1476.20 graph.html#tests=[[232,52,55]] 22:38:17 INFO - 2015-12-02 22:38:17,493 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:38:17 INFO - 2015-12-02 22:38:17,519 DEBUG : process_Request line: v8_7 20190.50 graph.html#tests=[[230,52,55]] 22:38:17 INFO - 2015-12-02 22:38:17,520 INFO : javascript benchmark 22:38:17 INFO - 2015-12-02 22:38:17,522 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [356.7887023555029, 358.93718599245125, 359.27068051854735, 359.51824555096164, 363.13392558747387, 14835.703285934274, 15081.472148474806, 17713.291468341267, 18416.81583184168, 19017.429477115675, 16161.595960101004, 19258.13338399772, 19629.0, 19638.312659056937, 19661.901690491562, 4694.741789201593, 4878.219484882419, 4884.633652476061, 5326.813561525338, 5510.256115424427, 3630.3283892479844, 3665.28526937246, 4865.537773911473, 4907.2639104134305, 4946.554810067093, 4915.3855768029, 4959.8016079356785, 5001.049800537904, 5004.024215278022, 5012.147934851084, 4790.281457781326, 4925.13810083234, 4931.728754918478, 4971.577415919651, 5001.44984051754, 4144.5026596808275, 4148.460700108966, 4155.272827255249, 4202.432671589358, 4211.305134652778, 13517.188968661912, 13692.931535342359, 13838.723225535534, 13859.584212473643, 14016.509422170277, 1887.8206570375792, 1977.1597071244664, 2030.147338117994, 2045.4681782736448, 2105.3473423238843, 9806.65676701312, 9914.90085099147, 10259.025392587691, 10296.27926045177, 10384.11735002518, 1513.1299502785942, 1520.7262692715308, 1535.3167840311066, 1564.1866229560565, 1599.2323684631326, 59957.40042599562, 62911.0, 63397.0, 63728.0, 63871.36128638701, 6739.797806065826, 6836.179658441019, 6850.588964662136, 6894.379820742121, 6897.862042759117, 7818.4136189785995, 7827.452078354574, 7847.568383738949, 7851.05787305527, 7878.290953814184, 5668.121441176624, 5676.489115979499, 5725.398833122462, 5727.971360143172, 5756.194132821324, 6086.756529738849, 6094.8171554853425, 6129.724162412702, 6133.44798968095, 6137.478314343331, 3072.38552289543, 3085.8457077146054, 3101.9224519387194, 3106.8757249709756, 3124.109628755794, 1055.8521806947033, 1072.4155335342257, 1093.606301731376, 1115.1803424482998, 1119.9440027998567, 441.1992234095107, 444.5909763017967, 454.36615920790973, 472.88887111528766, 478.0963978081359, 10987.450627468595, 11228.887711122947, 11463.426828658534, 11530.76938461226, 11817.468213930222, 427.55320689879153, 459.02457278283646, 466.41697877652933, 481.5449400316737, 487.8341363936279, 5071.797128114834, 6376.1392212051705, 6529.902051469232, 6570.5400621956005, 6623.569467984566, 360623.0, 362361.0, 362616.0, 386115.0, 579044.0, 78110.6094469524, 79381.0, 79686.0, 79729.0, 80415.19584804194, 522.3183745212534, 523.1577160771232, 526.9183276592134, 527.941926388097, 528.3501293409129, 10238.385696858213, 11308.717282068013, 11472.369019703996, 11697.532098716296, 11839.408029598659, 37025.25949480941, 37255.25489490141, 37423.06442338855, 37834.0541486465, 38527.0, 49930.25104623361, 50130.498695014045, 50278.24582631337, 50574.0, 50745.0, 6379.74481020754, 6425.10048593188, 6426.132472116392, 6430.839229019312, 6436.356364363526, 12422.774921280272, 12560.05799565018, 12685.80971285413, 12697.80953285683, 12768.361581921052, 10469.633562825264, 10587.311824731369, 10888.40113793749, 11003.394813285026, 11044.061254793432, 9901.801963960825, 10407.479626018518, 10538.789224215627, 10621.787564248827, 10759.569617215537, 10885.891141088488, 10983.231173817756, 11018.944905275423, 11151.776964460827, 11283.153763467937, 6517.576357536745, 6520.087187793618, 6577.671116444254, 6589.637569933508, 6633.867322653617, 10639.095676867244, 10798.622048228275, 10927.180461465263, 10955.452227388758, 11056.834147487954], "dojo.html": [3201.7118459338662, 3242.335321259142, 3265.167382317509, 3275.050235431725, 3300.3729291434624, 5444.0745073337575, 5472.9179062314, 5483.122700367942, 5484.095124304495, 5518.034343989801, 5362.115250983593, 5368.355797304319, 5374.167004114369, 5375.059364611187, 5451.04606693828, 4858.975705121469, 4924.487863230825, 4950.158473059589, 4956.727379994099, 4964.751762411883, 5029.647924645276, 5036.017976494585, 5065.493450654923, 5071.264666623338, 5072.061668591323, 4972.87567810804, 4990.8003679852945, 4996.125678006334, 5001.749912504379, 5027.597792176617, 4832.806687732486, 4896.069746748124, 4919.950800491985, 4948.826791062295, 5025.422076461217, 4995.725235112068, 4995.9500404996215, 4998.325226094467, 5007.0, 5047.318611987372, 5207.6354655174155, 5280.234366016906, 5365.973170134124, 5410.648307859977, 5429.049916264638, 5541.861453463655, 5647.802326918538, 5708.0, 5720.713964301768, 5752.5110365618975, 5850.180974663551, 5867.706614669292, 5887.0286402743495, 5896.734646940898, 5910.143029260733, 5342.759575819097, 5452.482014208644, 5463.453654634504, 5498.367687715924, 5523.0, 5749.252597162342, 5813.476787089182, 5824.184614154022, 5859.2382990211, 5885.323187833368, 5599.104143337128, 5662.433756624305, 5709.8287051388525, 5727.0836666134055, 5727.3699893011735, 5561.193626924073, 5638.464345887216, 5884.029135192731, 5884.823455296348, 5885.588008839341, 5528.861778455571, 5592.636478628876, 5676.829695109153, 5685.317761868602, 5703.54371650267, 5710.71446427677, 5723.885522289531, 5726.141078838207, 5727.713614319351, 5740.54075673945, 4314.697971142053, 4405.603495685404, 4519.028408892104, 4523.0, 4551.067031258584, 3983.721139520264, 4077.918441631151, 4090.468239128954, 4095.5290141634096, 4112.280350938574, 5393.0, 5394.163904594794, 5399.7030163340605, 5411.512963833274, 5444.0, 5612.943870561242, 5759.510441612426, 5826.970865145647, 5846.941530584725, 5850.327212370632, 5328.0, 5387.838364849061, 5450.645708028966, 5459.017376872202, 5465.453454654582, 5014.874628134253, 5054.7472626368535, 5058.822941197041, 5095.617828662865, 5100.923486147711, 5696.800611978727, 5768.423157684198, 5804.984127777622, 5857.062869940789, 5888.411158884077, 5607.971960140173, 5695.088785794253, 5696.772129114789, 5700.657960522382, 5837.445442683108, 5930.762769489172, 5939.287285525765, 5950.285965684146, 5950.702464876826, 5962.284525856925, 5570.164475328733, 5661.405552417102, 5837.94162058374, 5849.327327357409, 5880.500157486662, 5564.944350556442, 5714.514266287412, 5795.3625101237985, 5822.272215973004, 5836.416358364129, 5749.54003679713, 5759.049756790083, 5795.072788353843, 5798.768049277982, 5799.3040835100055, 5489.149181876815, 5591.804286849941, 5780.277465316835, 5792.275965504312, 5796.797112101056, 5367.865803354947, 5433.945660543344, 5435.673859568438, 5487.122060470306, 5563.221149039218, 5685.488306052475, 5699.629524080921, 5743.827685169452, 5749.8562535936935, 5766.192733017297, 5345.091334473227, 5449.727513624223, 5620.3536593290655, 5623.493885550321, 5658.915116273177], "mootools.html": [859.510079254825, 1423.8362588302346, 1502.5567457600007, 1702.3190723710513, 1882.0401595186452, 6809.761658341959, 7196.604186769726, 7290.526115802482, 7382.151052628949, 7394.926050739491, 7135.571865688063, 7224.638768061589, 7278.272172782719, 7286.089238845145, 7311.341979221869, 1889.2820728123295, 1967.2131147540954, 2124.2458927080897, 2137.540428807802, 2159.66525188596, 2241.764614715448, 2241.8206543476563, 2259.807916327114, 2264.501809601893, 2268.1154349803505, 2118.5868755592664, 2194.58302922445, 2200.0869639099756, 2203.5813195492806, 2215.911363545464, 1915.1764741161296, 1945.6011517638922, 2117.1743020222125, 2140.3685912655646, 2164.7835216478384, 2204.1073365287084, 2227.231605096239, 2250.8199344052437, 2253.7295524537, 2258.7854153855355, 7408.851822963565, 7466.178720340758, 7469.178390377054, 7479.925200748032, 7482.176960534337, 4651.37206477128, 4677.859664210079, 4723.36234608327, 4731.668783185179, 4742.549457801503, 2735.0700761741105, 2760.1581517637114, 2773.902913398021, 2816.9295767605768, 2835.6455443069617, 817.0522194254695, 878.1701292278799, 884.5533005832078, 894.9463032218088, 896.4755617963499, 9516.714498564985, 9549.856752148724, 9637.855432168522, 9639.373440726331, 9642.614295428175, 4148.23257697321, 4188.4136220929095, 4196.9370459443135, 4229.513605935295, 4246.193223287565, 8469.830603387898, 8551.657933682707, 8552.529610871337, 8561.0, 8568.186022327869, 4722.338872557844, 4726.291056341507, 4775.474697783241, 4788.95211047892, 4790.592799612003, 4320.848770293024, 4331.155424692218, 4366.6506679465565, 4372.322290045048, 4378.036831896978, 3578.159132603836, 3593.3531964246163, 3643.289558536113, 3660.5058317126845, 3684.6499582539614, 1112.8386383974441, 1121.243160866412, 1125.0774365020604, 1126.915481338903, 1141.2296699727651, 984.2913102566141, 1321.5969129415428, 1328.0703507544758, 1362.1758835904334, 1377.4696741754296, 6249.625022498664, 7209.387202087882, 7268.927310726931, 7279.199288078307, 7280.635968201569, 668.7325069972051, 675.6419097878132, 679.9728010879609, 687.4363022321648, 688.7554918004137, 5532.336119665666, 5575.0522411190195, 5629.577781666309, 5629.634073785191, 5642.943570564324, 8441.915580844236, 8613.956930215309, 8682.78293042679, 8729.170728780755, 8785.209331160098, 8657.393982421296, 8730.432521886058, 8731.912680873236, 8739.606717697592, 8757.737267881974, 6790.796276111724, 6998.0, 7008.509404341749, 7039.92960070403, 7049.29507049291, 6710.530262881747, 6717.496187785838, 6793.626350550569, 6797.864042719217, 6800.217974932748, 7690.577018263825, 7743.341815945482, 7807.414443916842, 7924.524528528307, 7936.2857342839425, 7895.486793358414, 8037.357011439188, 8046.517208967481, 8117.837643246984, 8141.8371632568205, 6304.5271604628915, 6335.3981371769605, 6362.491000720024, 6387.361263873576, 6416.679166041773, 7110.040144580622, 7114.679839407136, 7135.393491553276, 7188.0, 7198.388137008204, 6565.901511477236, 6779.389854913082, 6781.38967492928, 6797.524173307821, 6883.8967415487805, 6576.243731970884, 6607.405333519814, 6607.80176594703, 6750.32496750321, 6757.831054223684, 6214.161088253028, 6379.4896408286295, 6417.550771446141, 6738.056672065817, 6765.492588055817, 5848.4151584841175, 5976.133460648269, 6047.758089676364, 6066.3023752269055, 6070.150178974859, 6098.481629061579, 6150.846228844314, 6155.753769849156, 6158.476529495043, 6183.84540386494], "ext.html": [546.366181383902, 583.2883881664369, 585.4526018173005, 590.3742033444549, 597.3160730963048, 33160.66839331606, 37820.24359512808, 38621.0, 38662.420063699064, 38702.03244918875, 42425.78787106068, 42926.35610465846, 43087.0, 43139.56860431395, 43151.56848431515, 9291.81416371674, 9474.905250947471, 9496.810063798719, 9583.28125390595, 9629.422234665908, 9173.0, 9323.393979391318, 9357.578908949114, 9447.0, 9451.621935122586, 9330.813383732322, 9332.813343733122, 9350.485723285217, 9420.905790942106, 9425.057494250554, 9306.720798376025, 9395.671151509665, 9412.670556530556, 9519.143277105059, 9527.09492598202, 9164.404313719653, 9273.489958052305, 9312.90687093134, 9332.533373331375, 9391.953040234755, 40587.594124058676, 40603.59396406057, 40669.389959150634, 41123.7943810282, 41169.0, 3094.4430002599524, 3109.238236632017, 3216.1477208539754, 3506.281212351462, 3536.9115772105647, 27908.581371279448, 27953.86023069892, 28532.286692832844, 29134.708652913625, 29500.8524957376, 2330.382448651109, 2344.9179278725164, 2380.726216485109, 2400.687910571632, 2507.9749202507924, 271260.0, 271939.0, 272962.0, 274985.0, 275083.0, 60650.0, 61998.38001619926, 64069.679651601444, 68004.0, 68940.31059689439, 65269.0, 65297.34702653008, 65418.672906636115, 65846.0, 66105.6694716533, 16884.746728799077, 17046.659066818593, 17050.573735656708, 17067.317307307818, 17079.82920170807, 12208.450619722134, 12462.75074498505, 12817.487300508063, 12978.805317920238, 13009.089363744448, 21007.474813129487, 21264.149434022776, 21349.679754803692, 21419.464513386978, 21450.463738406354, 9115.316351273681, 9289.511504970507, 9300.488473134043, 9340.813183736287, 9364.812703746024, 920.9355345125776, 929.4469790474657, 953.3993584042148, 1031.9690409287734, 1190.2501424102759, 27925.720742792717, 28140.155795326173, 28553.428931421255, 28734.0, 28829.0, 1043.5512729526224, 1060.6022741471947, 1161.3786624156205, 1185.8043422835308, 1236.7323493419317, 11667.824982625267, 15072.321745521478, 15193.696126077637, 15415.383384664712, 15440.691186176213, 436701.0, 443818.0, 444503.0, 444860.0, 448299.0, 58715.70642146762, 58803.70598146982, 59280.407195928354, 59357.70321148367, 59454.0, 1466.6260103673494, 1472.1240861687493, 1477.940882364715, 1487.5834766265464, 1490.1282749591394, 28388.148355549365, 28736.0, 28833.0, 29157.125286241448, 29313.560296595995, 48015.27977080416, 48082.51917480781, 48124.0, 48654.75672621614, 48657.5134248653, 305468.0, 306513.0, 307118.0, 307650.0, 308043.0, 29141.562876556443, 29489.0, 32526.0, 33164.0, 33437.665623343455, 41340.79329603453, 41547.37678934879, 42075.7896210517, 42868.571314286455, 43062.0, 33937.83031084829, 34804.82597586996, 35991.64008359883, 36218.0, 40225.39661905015, 36523.81738091292, 36963.0, 37162.25675486421, 37197.25605487929, 37737.81131094327, 38951.80524097361, 40709.0, 41050.0, 41903.371449428894, 42036.15927681368, 27489.037883673976, 28873.0, 32977.67022329746, 32984.67015329816, 33110.66889331076, 24807.62788558137, 25138.874305628357, 25273.449131513647, 25303.0, 25492.8725356372], "prototype.html": [328.0290340591848, 338.34192495596074, 340.1411436123786, 340.34483619033364, 341.0399724774759, 5932.495737862276, 6067.302260240073, 6154.661493617849, 6175.289841668209, 6202.224721909762, 5920.0, 5949.8215053548465, 6009.0, 6014.849628759283, 6019.638821670703, 4649.744264065475, 4690.788914498856, 4699.624030077603, 4702.3416721659, 4726.480087190398, 4522.570355816209, 4568.291914753202, 4664.55686709762, 4688.624910007191, 4715.104130215265, 4611.930821037688, 4621.214393553104, 4656.371389862359, 4664.69679470835, 4687.273472611751, 4619.884502887421, 4635.0729854029, 4635.860924172281, 4666.743329116897, 4670.953290467086, 4034.737742046787, 4044.373122166069, 4059.8579049733116, 4075.6943229257627, 4084.4894388201474, 5833.32916714579, 5910.261217347832, 5931.703414829241, 5944.673042982634, 5945.10823376497, 5323.201519772027, 5330.333708286465, 5383.788647554308, 5383.838484845422, 5394.730263486849, 6271.341509141565, 6365.822322870284, 6441.677916104223, 6454.93545064548, 6463.48292136628, 4349.151915376471, 4357.2592659248, 4403.669724770655, 4460.50934397216, 4468.910621787579, 6479.319671434479, 6546.312637173076, 6560.901586476207, 6587.374199451092, 6620.37106474889, 4439.578240067189, 4473.507914129443, 4493.348464472633, 4513.052259025641, 4537.886552836206, 4373.409589705413, 4531.56950089741, 4556.407667003268, 4572.291294849304, 4682.1338052460405, 5284.867878303073, 5289.259503669489, 5295.15277555597, 5334.7065911374475, 5349.946500535023, 6353.682315884187, 6376.553641245068, 6426.485881129498, 6434.485241180694, 6437.967810160919, 1645.5310236582516, 1652.983470165307, 1655.0979716054778, 1669.4991502549187, 1671.3732350368612, 1070.352436775755, 1101.2346419238713, 1106.80630889594, 1111.7053980695123, 1120.7926533591149, 6034.155218269446, 6042.335343112254, 6052.788152414644, 6100.877982440326, 6127.0, 6558.442532384705, 6565.343465653396, 6642.7342906284175, 6652.268250492539, 6657.0, 5953.880922381528, 6030.427109424598, 6050.576459647782, 6076.3316035236085, 6097.3292937776805, 3615.457681347819, 3650.580183278957, 3672.4307732301536, 3698.63013698628, 3700.2414505026404, 6644.90032649501, 6667.566608170453, 6707.564008339442, 6726.0, 6737.461003119739, 6785.389314961677, 6788.728450862009, 6831.59010459374, 6837.453003759687, 6848.14398200225, 6527.118838956775, 6659.966700166468, 6711.563748356243, 6712.664366781642, 6732.259451460433, 6404.615723056631, 6585.96707016481, 6586.5389422739945, 6677.966610166918, 6683.231428385798, 6425.325340839145, 6438.581492202992, 6510.18622672166, 6529.216494020558, 6537.215534135934, 6631.734730610721, 6690.364415380531, 6714.3957043866285, 6725.865482690417, 6749.392554670103, 4219.7046206765235, 4249.978750106354, 4279.828806847691, 4287.807048682755, 4351.477822661301, 6517.315681853337, 6520.282768895323, 6594.90107648376, 6612.4710023198995, 6634.635095069818, 6349.365063493614, 6357.205349331333, 6437.163168788027, 6437.678116094083, 6439.388258115471, 6221.4089661482085, 6316.273628532777, 6358.554901156875, 6382.170317858649, 6422.6467544285515, 6167.506599472121, 6206.72069756871, 6233.812985610439, 6275.34108918557, 6314.273858506147, 6417.2299324081405, 6436.420722135031, 6451.451626611791, 6485.805425837232, 6489.415952564292, 6088.391160883876, 6277.5605707600025, 6341.778037768656, 6344.0, 6363.395477429637], "yui.html": [658.4238791057825, 750.0586763611667, 752.5071078443618, 794.4359504751626, 803.4697099914056, 14548.345324460399, 14658.853411465881, 14693.265336733148, 14754.188519631416, 14813.777793333094, 13466.663333416645, 13737.0, 13753.10604810689, 13902.235377054258, 13929.30353482327, 756.4402342266739, 760.0613242645329, 931.9534023298842, 933.4399360383783, 951.8524628682566, 910.1490106750176, 913.680211925824, 929.061647735785, 930.3998920696147, 932.1936524905941, 991.3952488981715, 995.9502024898762, 997.825380558403, 998.3161534348958, 1005.7636455432968, 793.6111305460312, 811.6631597886899, 938.5588773276584, 959.788846453779, 964.2527041542791, 709.2729951799396, 709.6700034483938, 712.1383126417041, 713.564725517434, 714.8606021825746, 14162.575122746333, 14189.929050354785, 14253.0, 14338.928305358511, 14359.497417590333, 11653.766924661544, 11809.586664466788, 11870.821937670942, 11883.762324753543, 11978.58074967372, 9088.272938164997, 9100.317476189246, 9238.214751746109, 9257.166854983017, 9842.0, 3274.1487213324467, 3455.8963231102857, 3479.8260086995547, 3507.9649203507893, 3512.2799826035857, 52228.73885630548, 52660.73669631666, 52808.47191528074, 52994.47005529934, 53217.0, 9075.410098343587, 9374.578143983537, 9380.460683081837, 9458.0, 9878.715766950394, 20573.0, 20600.793992060186, 20625.17499300041, 20641.483962900747, 20658.58682826335, 7413.406927445792, 7437.7768666939, 7539.095308562898, 7561.546307221474, 7728.304452599293, 3905.6875449963936, 3979.522457305142, 4009.7794621296107, 4065.1293856167786, 4194.224068547267, 2791.6370871786944, 2844.886204551795, 2846.8149570277865, 2850.900218492343, 2851.9144425667264, 414.0229059419767, 417.1469345189035, 429.45030361137793, 431.6352681983719, 434.24224727849474, 521.9222305938225, 549.7427740636791, 589.1957478042527, 598.2641351138125, 632.8322994406486, 7734.458587898793, 7845.0978137513775, 7908.644111015018, 7941.642626081724, 7958.761237162895, 508.72274610337456, 564.4947771744348, 603.9063945088518, 621.8662987457718, 627.0061951806347, 3663.7618554793853, 3734.8879533614036, 3742.9438558421643, 3790.3556395412293, 3802.543694756647, 58428.707856460445, 59167.0, 59407.405925940184, 64179.35820641734, 64888.675556621914, 46969.0, 46981.5301846984, 47029.29456058162, 54349.72825135928, 58594.0, 51830.22254666183, 53318.466815332125, 53584.0, 54415.0, 55061.449385505635, 8104.5137291762685, 8315.916840831514, 8590.82818343642, 8669.133086691281, 8695.347848911484, 37880.43179352367, 38186.236275274896, 38551.807240963615, 38600.613993859704, 38974.610253897095, 48613.5138648609, 49558.752206238736, 50027.49972500374, 50273.74863125661, 50836.0, 11026.724331891766, 11060.944695276472, 11073.280236784583, 11738.295702257892, 12059.942202846149, 11789.41052947332, 12082.758344832879, 12165.0, 12205.69485762863, 12500.687482813002, 10621.787564248518, 10652.84020739674, 10921.235513513977, 11119.0, 11624.244424112743, 11286.153538484483, 11297.096232301561, 11349.546018159512, 11405.258658187191, 11659.067274618179, 10352.17182625373, 10367.377957322586, 10543.736406589896, 11057.0, 11057.391843448688, 9532.142107210384, 9555.713328600154, 9627.951860240653, 9835.655752048644, 9910.15763660097, 9469.715908522756, 9594.232461402931, 9659.661911833333, 9672.371295865747, 9692.0]}, "summary": {"suite": 6712.386701850321, "subtests": {"jquery.html": {"filtered": 6929.298579112031, "value": 6929.298579112031}, "dojo.html": {"filtered": 5340.853366902777, "value": 5340.853366902777}, "mootools.html": {"filtered": 4225.40212360944, "value": 4225.40212360944}, "ext.html": {"filtered": 19138.03838793216, "value": 19138.03838793216}, "prototype.html": {"filtered": 4821.787154362651, "value": 4821.787154362651}, "yui.html": {"filtered": 6337.945977161048, "value": 6337.945977161048}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0049"}, "testrun": {"date": 1449123489, "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": "20151202120924", "branch": "Mozilla-Aurora", "revision": "d57fc3a1dda554cbde8557abfb60dce501d9a6a7"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 161.0, 162.0, 161.0, 159.0, 161.0, 162.0, 162.0, 162.0, 161.0], "ai-astar": [108.0, 109.0, 104.0, 106.0, 109.0, 110.0, 97.0, 107.0, 98.0, 105.0], "imaging-gaussian-blur": [120.0, 115.0, 115.0, 114.0, 120.0, 114.0, 115.0, 115.0, 114.0, 114.0], "audio-beat-detection": [152.0, 129.0, 158.0, 150.0, 127.0, 146.0, 129.0, 161.0, 148.0, 127.0], "json-stringify-tinderbox": [63.0, 64.0, 63.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 66.0], "stanford-crypto-pbkdf2": [147.0, 136.0, 145.0, 145.0, 146.0, 136.0, 146.0, 150.0, 144.0, 144.0], "json-parse-financial": [60.0, 64.0, 62.0, 62.0, 62.0, 64.0, 63.0, 70.0, 56.0, 58.0], "stanford-crypto-sha256-iterative": [68.0, 70.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 69.0], "audio-fft": [77.0, 81.0, 74.0, 120.0, 67.0, 68.0, 70.0, 70.0, 111.0, 65.0], "imaging-darkroom": [125.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 124.0, 125.0], "stanford-crypto-ccm": [129.0, 120.0, 120.0, 116.0, 121.0, 127.0, 121.0, 119.0, 119.0, 121.0], "audio-oscillator": [101.0, 97.0, 135.0, 87.0, 88.0, 88.0, 126.0, 88.0, 88.0, 129.0], "stanford-crypto-aes": [83.0, 83.0, 83.0, 82.0, 81.0, 82.0, 85.0, 82.0, 83.0, 87.0], "imaging-desaturate": [101.0, 101.0, 101.0, 101.0, 101.0, 101.0, 100.0, 101.0, 100.0, 101.0]}, "summary": {"suite": 1476.2, "subtests": {"audio-fft": {"filtered": 80.3, "value": 80.3}, "stanford-crypto-pbkdf2": {"filtered": 143.9, "value": 143.9}, "audio-beat-detection": {"filtered": 142.7, "value": 142.7}, "stanford-crypto-ccm": {"filtered": 121.3, "value": 121.3}, "imaging-darkroom": {"filtered": 124.2, "value": 124.2}, "json-parse-financial": {"filtered": 62.1, "value": 62.1}, "audio-oscillator": {"filtered": 102.7, "value": 102.7}, "ai-astar": {"filtered": 105.3, "value": 105.3}, "audio-dft": {"filtered": 161.4, "value": 161.4}, "stanford-crypto-sha256-iterative": {"filtered": 68.5, "value": 68.5}, "json-stringify-tinderbox": {"filtered": 64.3, "value": 64.3}, "imaging-gaussian-blur": {"filtered": 115.6, "value": 115.6}, "stanford-crypto-aes": {"filtered": 83.1, "value": 83.1}, "imaging-desaturate": {"filtered": 100.8, "value": 100.8}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0049"}, "testrun": {"date": 1449123489, "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": "20151202120924", "branch": "Mozilla-Aurora", "revision": "d57fc3a1dda554cbde8557abfb60dce501d9a6a7"}}, {"talos_counters": {}, "results": {"DeltaBlue": [191.35093761959433], "Encrypt": [325.0975292587776], "NavierStokes": [5797.687861271676], "Decrypt": [5791.907514450867], "Splay": [611.6207951070336], "Richards": [166.03021749958492], "RegExp": [30909.090909090908], "Earley": [675.219446320054], "Boyer": [12500.0], "RayTrace": [1007.0493454179255]}, "summary": {"suite": 20190.496875344143, "subtests": {"DeltaBlue": {"filtered": 345.53266799999994, "value": 345.53266799999994}, "Encrypt": {"filtered": 818.7727560000003, "value": 818.7727560000003}, "NavierStokes": {"filtered": 255.96410767696923, "value": 255.96410767696923}, "Decrypt": {"filtered": 45.95739820359278, "value": 45.95739820359278}, "Splay": {"filtered": 133.23778500000006, "value": 133.23778500000006}, "RegExp": {"filtered": 29.47304411764707, "value": 29.47304411764707}, "Richards": {"filtered": 212.62394600000007, "value": 212.62394600000007}, "Earley": {"filtered": 987.0317029999998, "value": 987.0317029999998}, "Boyer": {"filtered": 53.31704, "value": 53.31704}, "RayTrace": {"filtered": 734.8090770000001, "value": 734.8090770000001}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0049"}, "testrun": {"date": 1449123489, "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": "20151202120924", "branch": "Mozilla-Aurora", "revision": "d57fc3a1dda554cbde8557abfb60dce501d9a6a7"}}] 22:38:17 INFO - RETURN: dromaeo_css: 6712.39 22:38:17 INFO - RETURN: kraken: 1476.20 22:38:17 INFO - RETURN: v8_7: 20190.50 22:38:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,55]]", "result": "20190.50"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,55]]", "result": "1476.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,55]]", "result": "6712.39"}}} 22:38:17 INFO - Return code: 0 22:38:17 INFO - # TBPL SUCCESS # 22:38:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:38:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:38:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:38:17 INFO - 2015-12-02 22:38:17.626 screenresolution[1663:9977] starting screenresolution argv=screenresolution get 22:38:17 INFO - 2015-12-02 22:38:17.629 screenresolution[1663:9977] Display 0: 1600x1200x32@60 22:38:17 INFO - 2015-12-02 22:38:17.636 screenresolution[1664:9980] starting screenresolution argv=screenresolution list 22:38:17 INFO - Available Modes on Display 0 22:38:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:38:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:38:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:38:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:38:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:38:17 INFO - Intel HD Graphics 3000: 22:38:17 INFO - Chipset Model: Intel HD Graphics 3000 22:38:17 INFO - Type: GPU 22:38:17 INFO - Bus: Built-In 22:38:17 INFO - VRAM (Total): 512 MB 22:38:17 INFO - VRAM (Dynamic, Max): 10 22:38:17 INFO - Vendor: Intel (0x8086) 22:38:17 INFO - Device ID: 0x0116 22:38:17 INFO - Revision ID: 0x0009 22:38:17 INFO - Displays: 22:38:17 INFO - Display: 22:38:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:38:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:38:17 INFO - Display Serial Number: 1600x1200 60 22:38:17 INFO - Main Display: Yes 22:38:17 INFO - Mirror: Off 22:38:17 INFO - Online: Yes 22:38:17 INFO - Rotation: Supported 22:38:17 INFO - Return code: 0 22:38:17 INFO - Running post-action listener: _resource_record_post_action 22:38:17 INFO - Running post-run listener: _resource_record_post_run 22:38:18 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 38552576; Write bytes: 681843712; Read time: 4449; Write time: 48168 22:38:18 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 343499264; Write bytes: 344317952; Read time: 33699; Write time: 4813 22:38:19 INFO - run-tests - Wall time: 1209s; CPU: 30.0%; Read bytes: 36021248; Write bytes: 336198656; Read time: 3661; Write time: 43332 22:38:19 INFO - Running post-run listener: _upload_blobber_files 22:38:19 INFO - Blob upload gear active. 22:38:19 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:38:19 INFO - Copying logs to upload dir... 22:38:19 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1306.141864 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2015-12-02 22:38:19.054067) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 22:38:19.060251) ========= 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.yzAtEaGBra/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.SohQE1Dpcq/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010027 build_url: 'https://queue.taskcluster.net/v1/task/OmKjGuncTx-GDDa9APMb1Q/artifacts/public/build/firefox-44.0a2.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 22:38:19.082631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 22:38:19.083001) ========= 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.yzAtEaGBra/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.SohQE1Dpcq/Listeners TMPDIR=/var/folders/v2/nkfw7r7n24gfr4117_1d0yb000000w/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.005117 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 22:38:19.132854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 22:38:19.133191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 22:38:19.133607) ========= ========= Total master_lag: 0.17 =========