builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0036 starttime: 1447825224.92 results: success (0) buildid: 20151117194634 builduid: f1569fe656714f5ea5eb13214d174b0d revision: 0959ed75ce40771dc7db7bf11911749e6e4d859b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:24.921734) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:24.922334) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:24.922691) ========= 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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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.006340 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:24.984536) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:24.984886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:25.054888) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:25.055325) ========= 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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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.005389 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:25.122196) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:25.122581) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:25.123016) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:25.123355) ========= 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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-17 21:40:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.102, 63.245.215.25, ... Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 6.17M=0.002s 2015-11-17 21:40:25 (6.17 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.548859 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:25.696510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:25.696831) ========= 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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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.019717 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:25.747246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:25.747724) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0959ed75ce40771dc7db7bf11911749e6e4d859b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0959ed75ce40771dc7db7bf11911749e6e4d859b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hKJHjLHPnS/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.Z5DtIjiXga/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-17 21:40:25,827 truncating revision to first 12 chars 2015-11-17 21:40:25,827 Setting DEBUG logging. 2015-11-17 21:40:25,827 attempt 1/10 2015-11-17 21:40:25,827 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0959ed75ce40?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 21:40:26,115 unpacking tar archive at: mozilla-inbound-0959ed75ce40/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712935 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:26.479657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:26.479982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:26.494100) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:26.494508) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 21:40:26.494987) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-17 21:40:26.495295) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hKJHjLHPnS/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.Z5DtIjiXga/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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 21:40:26 INFO - MultiFileLogger online at 20151117 21:40:26 in /builds/slave/test 21:40:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:40:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:40:26 INFO - {'append_to_log': False, 21:40:26 INFO - 'base_work_dir': '/builds/slave/test', 21:40:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:40:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:40:26 INFO - 'branch': 'Mozilla-Inbound', 21:40:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:40:26 INFO - 'config_files': ('talos/mac_config.py',), 21:40:26 INFO - 'default_actions': ('clobber', 21:40:26 INFO - 'read-buildbot-config', 21:40:26 INFO - 'download-and-extract', 21:40:26 INFO - 'populate-webroot', 21:40:26 INFO - 'create-virtualenv', 21:40:26 INFO - 'install', 21:40:26 INFO - 'run-tests'), 21:40:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:40:26 INFO - 'download_minidump_stackwalk': True, 21:40:26 INFO - 'download_symbols': 'ondemand', 21:40:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:40:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:40:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:40:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:40:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:40:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:40:26 INFO - 'installer_path': 'installer.exe', 21:40:26 INFO - 'log_level': 'info', 21:40:26 INFO - 'log_name': 'talos', 21:40:26 INFO - 'log_to_console': True, 21:40:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:40:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:40:26 INFO - 'opt_config_files': (), 21:40:26 INFO - 'pip_index': False, 21:40:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:40:26 INFO - 'cmd': ('bash', 21:40:26 INFO - '-c', 21:40:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:40:26 INFO - 'enabled': True, 21:40:26 INFO - 'halt_on_failure': False, 21:40:26 INFO - 'name': 'check_screen_resolution'},), 21:40:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:40:26 INFO - 'cmd': ('bash', 21:40:26 INFO - '-c', 21:40:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:40:26 INFO - 'enabled': True, 21:40:26 INFO - 'halt_on_failure': False, 21:40:26 INFO - 'name': 'check_screen_resolution'},), 21:40:26 INFO - 'run_cmd_checks_enabled': True, 21:40:26 INFO - 'sps_profile': False, 21:40:26 INFO - 'sps_profile_interval': 0, 21:40:26 INFO - 'suite': 'dromaeojs', 21:40:26 INFO - 'system_bits': '64', 21:40:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:40:26 INFO - 'title': 't-yosemite-r5-0036', 21:40:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:40:26 INFO - 'use_talos_json': True, 21:40:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:40:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:40:26 INFO - 'work_dir': 'build'} 21:40:26 INFO - ##### 21:40:26 INFO - ##### Running clobber step. 21:40:26 INFO - ##### 21:40:26 INFO - Running pre-action listener: _resource_record_pre_action 21:40:26 INFO - Running main action method: clobber 21:40:26 INFO - rmtree: /builds/slave/test/build 21:40:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:40:26 INFO - Running post-action listener: _resource_record_post_action 21:40:26 INFO - ##### 21:40:26 INFO - ##### Running read-buildbot-config step. 21:40:26 INFO - ##### 21:40:26 INFO - Running pre-action listener: _resource_record_pre_action 21:40:26 INFO - Running main action method: read_buildbot_config 21:40:26 INFO - Using buildbot properties: 21:40:26 INFO - { 21:40:26 INFO - "properties": { 21:40:26 INFO - "buildnumber": 3172, 21:40:26 INFO - "product": "firefox", 21:40:26 INFO - "script_repo_revision": "production", 21:40:26 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 21:40:26 INFO - "repository": "", 21:40:26 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 21:40:26 INFO - "buildid": "20151117194634", 21:40:26 INFO - "slavename": "t-yosemite-r5-0036", 21:40:26 INFO - "pgo_build": "False", 21:40:26 INFO - "basedir": "/builds/slave/test", 21:40:26 INFO - "project": "", 21:40:26 INFO - "platform": "yosemite", 21:40:26 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:40:26 INFO - "slavebuilddir": "test", 21:40:26 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 21:40:26 INFO - "branch": "mozilla-inbound", 21:40:26 INFO - "repo_path": "integration/mozilla-inbound", 21:40:26 INFO - "stage_platform": "macosx64", 21:40:26 INFO - "builduid": "f1569fe656714f5ea5eb13214d174b0d", 21:40:26 INFO - "revision": "0959ed75ce40771dc7db7bf11911749e6e4d859b" 21:40:26 INFO - }, 21:40:26 INFO - "sourcestamp": { 21:40:26 INFO - "repository": "", 21:40:26 INFO - "hasPatch": false, 21:40:26 INFO - "project": "", 21:40:26 INFO - "branch": "mozilla-inbound-macosx64-talos", 21:40:26 INFO - "changes": [ 21:40:26 INFO - { 21:40:26 INFO - "category": null, 21:40:26 INFO - "files": [ 21:40:26 INFO - { 21:40:26 INFO - "url": null, 21:40:26 INFO - "name": "https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 21:40:26 INFO - } 21:40:26 INFO - ], 21:40:26 INFO - "repository": "", 21:40:26 INFO - "rev": "0959ed75ce40771dc7db7bf11911749e6e4d859b", 21:40:26 INFO - "who": "philringnalda@gmail.com", 21:40:26 INFO - "when": 1447825199, 21:40:26 INFO - "number": 6676054, 21:40:26 INFO - "comments": "Back out bf4205bd5198 (bug 1216175) for Android hangs in test_fetch_cors.html", 21:40:26 INFO - "project": "", 21:40:26 INFO - "at": "Tue 17 Nov 2015 21:39:59", 21:40:26 INFO - "branch": "mozilla-inbound-macosx64-talos", 21:40:26 INFO - "revlink": "", 21:40:26 INFO - "properties": [ 21:40:26 INFO - [ 21:40:26 INFO - "buildid", 21:40:26 INFO - "20151117194634", 21:40:26 INFO - "Change" 21:40:26 INFO - ], 21:40:26 INFO - [ 21:40:26 INFO - "builduid", 21:40:26 INFO - "f1569fe656714f5ea5eb13214d174b0d", 21:40:26 INFO - "Change" 21:40:26 INFO - ], 21:40:26 INFO - [ 21:40:26 INFO - "pgo_build", 21:40:26 INFO - "False", 21:40:26 INFO - "Change" 21:40:26 INFO - ] 21:40:26 INFO - ], 21:40:26 INFO - "revision": "0959ed75ce40771dc7db7bf11911749e6e4d859b" 21:40:26 INFO - } 21:40:26 INFO - ], 21:40:26 INFO - "revision": "0959ed75ce40771dc7db7bf11911749e6e4d859b" 21:40:26 INFO - } 21:40:26 INFO - } 21:40:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 21:40:26 INFO - Running post-action listener: _resource_record_post_action 21:40:26 INFO - ##### 21:40:26 INFO - ##### Running download-and-extract step. 21:40:26 INFO - ##### 21:40:26 INFO - Running pre-action listener: _resource_record_pre_action 21:40:26 INFO - Running main action method: download_and_extract 21:40:26 INFO - mkdir: /builds/slave/test/build/tests 21:40:26 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')]} 21:40:26 INFO - https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:40:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/test_packages.json 21:40:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/test_packages.json 21:40:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:40:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:40:27 INFO - Downloaded 1149 bytes. 21:40:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:40:27 INFO - Using the following test package requirements: 21:40:27 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:40:27 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:40:27 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 21:40:27 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:40:27 INFO - u'jsshell-mac.zip'], 21:40:27 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:40:27 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 21:40:27 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:40:27 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:40:27 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 21:40:27 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:40:27 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 21:40:27 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:40:27 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 21:40:27 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:40:27 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:40:27 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 21:40:27 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:40:27 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')]} 21:40:27 INFO - https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:40:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:40:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:40:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:40:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:40:29 INFO - Downloaded 17463533 bytes. 21:40:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 21:40:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:40:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:40:35 INFO - Return code: 0 21:40:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:40:35 INFO - https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:40:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:40:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:40:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:40:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:40:41 INFO - Downloaded 17463533 bytes. 21:40:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 21:40:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:40:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:40:47 INFO - Return code: 0 21:40:47 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')]} 21:40:47 INFO - https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:40:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:40:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:40:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:40:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:40:48 INFO - Downloaded 11130997 bytes. 21:40:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 21:40:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:40:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 21:40:49 INFO - Return code: 0 21:40:49 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')]} 21:40:49 INFO - https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:40:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:40:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:40:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 21:40:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 21:40:52 INFO - Downloaded 108846580 bytes. 21:40:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:40:52 INFO - mkdir: /builds/slave/test/properties 21:40:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:40:52 INFO - Writing to file /builds/slave/test/properties/build_url 21:40:52 INFO - Contents: 21:40:52 INFO - build_url:https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:40:52 INFO - Running post-action listener: _resource_record_post_action 21:40:52 INFO - Running post-action listener: set_extra_try_arguments 21:40:52 INFO - ##### 21:40:52 INFO - ##### Running populate-webroot step. 21:40:52 INFO - ##### 21:40:52 INFO - Running pre-action listener: _resource_record_pre_action 21:40:52 INFO - Running main action method: populate_webroot 21:40:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:40:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:40:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:40:52 INFO - '../fennec_ids.txt'], 21:40:52 INFO - 'tests': ['tcheck2']}, 21:40:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:40:52 INFO - '--tppagecycles', 21:40:52 INFO - '7'], 21:40:52 INFO - 'tests': ['tsvgm']}}, 21:40:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:40:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:40:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:40:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:40:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:40:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:40:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:52 INFO - 'talos_options': ['--e10s'], 21:40:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:52 INFO - 'tests': ['damp', 'tps']}, 21:40:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:52 INFO - 'talos_options': ['--e10s'], 21:40:52 INFO - 'tests': ['damp', 'tps']}, 21:40:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:40:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:40:52 INFO - 'other': {'tests': ['a11yr', 21:40:52 INFO - 'ts_paint', 21:40:52 INFO - 'tpaint', 21:40:52 INFO - 'sessionrestore', 21:40:52 INFO - 'sessionrestore_no_auto_restore']}, 21:40:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:40:52 INFO - 'tests': ['a11yr', 21:40:52 INFO - 'ts_paint', 21:40:52 INFO - 'tpaint', 21:40:52 INFO - 'sessionrestore', 21:40:52 INFO - 'sessionrestore_no_auto_restore']}, 21:40:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:40:52 INFO - 'tests': ['a11yr', 21:40:52 INFO - 'ts_paint', 21:40:52 INFO - 'tpaint', 21:40:52 INFO - 'sessionrestore', 21:40:52 INFO - 'sessionrestore_no_auto_restore']}, 21:40:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:40:52 INFO - 'tests': ['a11yr', 21:40:52 INFO - 'ts_paint', 21:40:52 INFO - 'tpaint', 21:40:52 INFO - 'sessionrestore', 21:40:52 INFO - 'sessionrestore_no_auto_restore']}, 21:40:52 INFO - 'other_l64': {'tests': ['a11yr', 21:40:52 INFO - 'ts_paint', 21:40:52 INFO - 'tpaint', 21:40:52 INFO - 'sessionrestore', 21:40:52 INFO - 'sessionrestore_no_auto_restore']}, 21:40:52 INFO - 'other_nol64': {'tests': ['a11yr', 21:40:52 INFO - 'ts_paint', 21:40:52 INFO - 'tpaint', 21:40:52 INFO - 'sessionrestore', 21:40:52 INFO - 'sessionrestore_no_auto_restore']}, 21:40:52 INFO - 'svgr': {'tests': ['tsvgx', 21:40:52 INFO - 'tsvgr_opacity', 21:40:52 INFO - 'tart', 21:40:52 INFO - 'tscrollx', 21:40:52 INFO - 'cart']}, 21:40:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:40:52 INFO - 'tests': ['tsvgx', 21:40:52 INFO - 'tsvgr_opacity', 21:40:52 INFO - 'tart', 21:40:52 INFO - 'tscrollx', 21:40:52 INFO - 'cart']}, 21:40:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:52 INFO - 'tests': ['tp5o']}, 21:40:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:52 INFO - 'talos_options': ['--e10s'], 21:40:52 INFO - 'tests': ['tp5o']}, 21:40:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:52 INFO - 'talos_options': ['--xperf_path', 21:40:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:52 INFO - 'tests': ['tp5n']}, 21:40:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:40:52 INFO - 'talos_options': ['--e10s', 21:40:52 INFO - '--xperf_path', 21:40:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:52 INFO - 'tests': ['tp5n']}}, 21:40:52 INFO - 'talos.zip': {'path': '', 21:40:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:40:52 INFO - Running post-action listener: _resource_record_post_action 21:40:52 INFO - ##### 21:40:52 INFO - ##### Running create-virtualenv step. 21:40:52 INFO - ##### 21:40:52 INFO - Running pre-action listener: _resource_record_pre_action 21:40:52 INFO - Running main action method: create_virtualenv 21:40:52 INFO - Creating virtualenv /builds/slave/test/build/venv 21:40:52 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 21:40:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:40:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:40:52 INFO - Using real prefix '/tools/python27' 21:40:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:40:53 INFO - Installing distribute.............................................................................................................................................................................................done. 21:40:57 INFO - Installing pip.................done. 21:40:57 INFO - Return code: 0 21:40:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:57 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 0x106c5e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f849b5635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b829f0>, '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 0x1068e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b758c8>, '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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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 21:40:57 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 21:40:57 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 21:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKJHjLHPnS/Render', 21:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:57 INFO - 'HOME': '/Users/cltbld', 21:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:57 INFO - 'LOGNAME': 'cltbld', 21:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:57 INFO - 'MOZ_NO_REMOTE': '1', 21:40:57 INFO - 'NO_EM_RESTART': '1', 21:40:57 INFO - 'PAGER': '/bin/cat', 21:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:57 INFO - 'PWD': '/builds/slave/test', 21:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:57 INFO - 'SHELL': '/bin/bash', 21:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z5DtIjiXga/Listeners', 21:40:57 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 21:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:57 INFO - 'USER': 'cltbld', 21:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:57 INFO - 'XPC_FLAGS': '0x0', 21:40:57 INFO - 'XPC_SERVICE_NAME': '0', 21:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:57 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 21:40:57 INFO - Cleaning up... 21:40:57 INFO - Return code: 0 21:40:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:57 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 0x106c5e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f849b5635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b829f0>, '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 0x1068e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b758c8>, '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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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 21:40:57 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 21:40:57 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 21:40:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKJHjLHPnS/Render', 21:40:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:57 INFO - 'HOME': '/Users/cltbld', 21:40:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:57 INFO - 'LOGNAME': 'cltbld', 21:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:57 INFO - 'MOZ_NO_REMOTE': '1', 21:40:57 INFO - 'NO_EM_RESTART': '1', 21:40:57 INFO - 'PAGER': '/bin/cat', 21:40:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:57 INFO - 'PWD': '/builds/slave/test', 21:40:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:57 INFO - 'SHELL': '/bin/bash', 21:40:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z5DtIjiXga/Listeners', 21:40:57 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 21:40:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:57 INFO - 'USER': 'cltbld', 21:40:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:57 INFO - 'XPC_FLAGS': '0x0', 21:40:57 INFO - 'XPC_SERVICE_NAME': '0', 21:40:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:58 INFO - Downloading/unpacking psutil>=0.7.1 21:40:58 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 21:40:58 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 21:40:58 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 21:40:58 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 21:40:58 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 21:40:58 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 21:41:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:41:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:41:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:41:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:41:01 INFO - Installing collected packages: psutil 21:41:01 INFO - Running setup.py install for psutil 21:41:01 INFO - building 'psutil._psutil_osx' extension 21:41:01 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 21:41:01 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 21:41:02 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 21:41:02 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 21:41:02 INFO - building 'psutil._psutil_posix' extension 21:41:02 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 21:41:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:41:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:41:02 INFO - ^ 21:41:02 INFO - 1 warning generated. 21:41:02 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 21:41:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:41:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:41:02 INFO - Successfully installed psutil 21:41:02 INFO - Cleaning up... 21:41:02 INFO - Return code: 0 21:41:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:02 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 0x106c5e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f849b5635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b829f0>, '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 0x1068e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b758c8>, '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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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 21:41:02 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 21:41:02 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 21:41:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKJHjLHPnS/Render', 21:41:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:02 INFO - 'HOME': '/Users/cltbld', 21:41:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:02 INFO - 'LOGNAME': 'cltbld', 21:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:02 INFO - 'MOZ_NO_REMOTE': '1', 21:41:02 INFO - 'NO_EM_RESTART': '1', 21:41:02 INFO - 'PAGER': '/bin/cat', 21:41:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:02 INFO - 'PWD': '/builds/slave/test', 21:41:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:02 INFO - 'SHELL': '/bin/bash', 21:41:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z5DtIjiXga/Listeners', 21:41:02 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 21:41:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:02 INFO - 'USER': 'cltbld', 21:41:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:02 INFO - 'XPC_FLAGS': '0x0', 21:41:02 INFO - 'XPC_SERVICE_NAME': '0', 21:41:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:41:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:41:02 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 21:41:02 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 21:41:02 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 21:41:02 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 21:41:02 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 21:41:02 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 21:41:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:41:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:41:05 INFO - Installing collected packages: mozsystemmonitor 21:41:05 INFO - Running setup.py install for mozsystemmonitor 21:41:05 INFO - Successfully installed mozsystemmonitor 21:41:05 INFO - Cleaning up... 21:41:05 INFO - Return code: 0 21:41:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:41: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')]} 21:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41: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')]} 21:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41: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', '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 0x106c5e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f849b5635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b829f0>, '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 0x1068e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b758c8>, '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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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 21:41: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:41: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 blobuploader==1.2.4 21:41:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKJHjLHPnS/Render', 21:41:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:05 INFO - 'HOME': '/Users/cltbld', 21:41:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:05 INFO - 'LOGNAME': 'cltbld', 21:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:05 INFO - 'MOZ_NO_REMOTE': '1', 21:41:05 INFO - 'NO_EM_RESTART': '1', 21:41:05 INFO - 'PAGER': '/bin/cat', 21:41:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:05 INFO - 'PWD': '/builds/slave/test', 21:41:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:05 INFO - 'SHELL': '/bin/bash', 21:41:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z5DtIjiXga/Listeners', 21:41:05 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 21:41:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:05 INFO - 'USER': 'cltbld', 21:41:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:05 INFO - 'XPC_FLAGS': '0x0', 21:41:05 INFO - 'XPC_SERVICE_NAME': '0', 21:41:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:08 INFO - Downloading blobuploader-1.2.4.tar.gz 21:41:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:41:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:41:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:41:09 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 21:41:09 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 21:41:09 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 21:41:09 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 21:41:09 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 21:41:09 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 21:41:09 INFO - Downloading docopt-0.6.1.tar.gz 21:41:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:41:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:41:10 INFO - Running setup.py install for blobuploader 21:41:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:41:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:41:10 INFO - Running setup.py install for requests 21:41:10 INFO - Running setup.py install for docopt 21:41:11 INFO - Successfully installed blobuploader requests docopt 21:41:11 INFO - Cleaning up... 21:41:11 INFO - Return code: 0 21:41:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41: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')]} 21:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41: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')]} 21:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:11 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 0x106c5e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f849b5635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b829f0>, '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 0x1068e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b758c8>, '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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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 21:41:11 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 21:41:11 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 21:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKJHjLHPnS/Render', 21:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:11 INFO - 'HOME': '/Users/cltbld', 21:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:11 INFO - 'LOGNAME': 'cltbld', 21:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:11 INFO - 'MOZ_NO_REMOTE': '1', 21:41:11 INFO - 'NO_EM_RESTART': '1', 21:41:11 INFO - 'PAGER': '/bin/cat', 21:41:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:11 INFO - 'PWD': '/builds/slave/test', 21:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:11 INFO - 'SHELL': '/bin/bash', 21:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z5DtIjiXga/Listeners', 21:41:11 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 21:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:11 INFO - 'USER': 'cltbld', 21:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:11 INFO - 'XPC_FLAGS': '0x0', 21:41:11 INFO - 'XPC_SERVICE_NAME': '0', 21:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:11 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-VZ9kAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:11 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-Am2J5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:11 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-N2zd5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:11 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-Ux5DRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:12 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-FiSPm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:12 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-etOp5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:12 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-raBnrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:12 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-DfS5q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:12 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-fyTCig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:12 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-MhxMYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:12 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-VhF83w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:12 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-cOTkoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:13 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-JhhWtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:13 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-EpOeLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:13 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-TPoYMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:13 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-sWDYvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:13 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-cqu802-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:41:13 INFO - Running setup.py install for manifestparser 21:41:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:41:13 INFO - Running setup.py install for mozcrash 21:41:14 INFO - Running setup.py install for mozdebug 21:41:14 INFO - Running setup.py install for mozdevice 21:41:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:41:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:41:14 INFO - Running setup.py install for mozfile 21:41:14 INFO - Running setup.py install for mozhttpd 21:41:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:41:14 INFO - Running setup.py install for mozinfo 21:41:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:41:14 INFO - Running setup.py install for mozInstall 21:41:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:41:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:41:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:41:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:41:15 INFO - Running setup.py install for mozleak 21:41:15 INFO - Running setup.py install for mozlog 21:41:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:41:15 INFO - Running setup.py install for moznetwork 21:41:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:41:15 INFO - Running setup.py install for mozprocess 21:41:15 INFO - Running setup.py install for mozprofile 21:41:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:41:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:41:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:41:16 INFO - Running setup.py install for mozrunner 21:41:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:41:16 INFO - Running setup.py install for mozscreenshot 21:41:16 INFO - Running setup.py install for moztest 21:41:16 INFO - Running setup.py install for mozversion 21:41:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:41:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:41:16 INFO - Cleaning up... 21:41:16 INFO - Return code: 0 21:41:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:16 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')]} 21:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:16 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')]} 21:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:16 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 0x106c5e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f849b5635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b829f0>, '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 0x1068e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b758c8>, '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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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 21:41:16 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 21:41:16 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 21:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKJHjLHPnS/Render', 21:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:16 INFO - 'HOME': '/Users/cltbld', 21:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:16 INFO - 'LOGNAME': 'cltbld', 21:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:16 INFO - 'MOZ_NO_REMOTE': '1', 21:41:16 INFO - 'NO_EM_RESTART': '1', 21:41:16 INFO - 'PAGER': '/bin/cat', 21:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:16 INFO - 'PWD': '/builds/slave/test', 21:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:16 INFO - 'SHELL': '/bin/bash', 21:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z5DtIjiXga/Listeners', 21:41:16 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 21:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:16 INFO - 'USER': 'cltbld', 21:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:16 INFO - 'XPC_FLAGS': '0x0', 21:41:16 INFO - 'XPC_SERVICE_NAME': '0', 21:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:17 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-02Ti0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:17 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-1rh2qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:17 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-zB9Nwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:17 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)) 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:17 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-Q_YnBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:17 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-lnkq2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:17 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)) 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:17 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-e9FvVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:18 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-_wmSID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:18 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-BVFDzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:18 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-0g18aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:18 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-tJY31v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:18 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-6IUUdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:18 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-4IEUKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:18 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)) 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:18 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-CEAj7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:18 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)) 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:18 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-m1EFQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:19 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-47Cwoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:19 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-hCamBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:19 INFO - Running setup.py (path:/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/pip-R8bzNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:41:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:22 INFO - Downloading blessings-1.5.1.tar.gz 21:41:22 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 21:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:41:22 INFO - Installing collected packages: blessings 21:41:22 INFO - Running setup.py install for blessings 21:41:22 INFO - Successfully installed blessings 21:41:22 INFO - Cleaning up... 21:41:22 INFO - Return code: 0 21:41:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:41:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:22 INFO - Reading from file tmpfile_stdout 21:41:22 INFO - Current package versions: 21:41:22 INFO - blessings == 1.5.1 21:41:22 INFO - blobuploader == 1.2.4 21:41:22 INFO - docopt == 0.6.1 21:41:22 INFO - manifestparser == 1.1 21:41:22 INFO - mozInstall == 1.12 21:41:22 INFO - mozcrash == 0.16 21:41:22 INFO - mozdebug == 0.1 21:41:22 INFO - mozdevice == 0.47 21:41:22 INFO - mozfile == 1.2 21:41:22 INFO - mozhttpd == 0.7 21:41:22 INFO - mozinfo == 0.9 21:41:22 INFO - mozleak == 0.1 21:41:22 INFO - mozlog == 3.0 21:41:22 INFO - moznetwork == 0.27 21:41:22 INFO - mozprocess == 0.22 21:41:22 INFO - mozprofile == 0.27 21:41:22 INFO - mozrunner == 6.11 21:41:22 INFO - mozscreenshot == 0.1 21:41:22 INFO - mozsystemmonitor == 0.0 21:41:22 INFO - moztest == 0.7 21:41:22 INFO - mozversion == 1.4 21:41:22 INFO - psutil == 3.1.1 21:41:22 INFO - requests == 1.2.3 21:41:22 INFO - wsgiref == 0.1.2 21:41:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c5e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c3b228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f849b5635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b829f0>, '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 0x1068e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b758c8>, '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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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 21:41:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:41:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKJHjLHPnS/Render', 21:41:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:22 INFO - 'HOME': '/Users/cltbld', 21:41:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:22 INFO - 'LOGNAME': 'cltbld', 21:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:22 INFO - 'MOZ_NO_REMOTE': '1', 21:41:22 INFO - 'NO_EM_RESTART': '1', 21:41:22 INFO - 'PAGER': '/bin/cat', 21:41:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:22 INFO - 'PWD': '/builds/slave/test', 21:41:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:22 INFO - 'SHELL': '/bin/bash', 21:41:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z5DtIjiXga/Listeners', 21:41:22 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 21:41:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:22 INFO - 'USER': 'cltbld', 21:41:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:22 INFO - 'XPC_FLAGS': '0x0', 21:41:22 INFO - 'XPC_SERVICE_NAME': '0', 21:41:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:23 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)) 21:41:23 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)) 21:41:23 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)) 21:41:23 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)) 21:41:23 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)) 21:41:23 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)) 21:41:23 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)) 21:41:23 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)) 21:41:23 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)) 21:41:23 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)) 21:41:23 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)) 21:41:23 INFO - Cleaning up... 21:41:23 INFO - Return code: 0 21:41:23 INFO - Running post-action listener: _resource_record_post_action 21:41:23 INFO - Running post-action listener: _start_resource_monitoring 21:41:23 INFO - Starting resource monitoring. 21:41:23 INFO - ##### 21:41:23 INFO - ##### Running install step. 21:41:23 INFO - ##### 21:41:23 INFO - Running pre-action listener: _resource_record_pre_action 21:41:23 INFO - Running main action method: install 21:41:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:23 INFO - Reading from file tmpfile_stdout 21:41:23 INFO - Detecting whether we're running mozinstall >=1.0... 21:41:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:41:23 INFO - Reading from file tmpfile_stdout 21:41:23 INFO - Output received: 21:41:23 INFO - Usage: mozinstall [options] installer 21:41:23 INFO - Options: 21:41:23 INFO - -h, --help show this help message and exit 21:41:23 INFO - -d DEST, --destination=DEST 21:41:23 INFO - Directory to install application into. [default: 21:41:23 INFO - "/builds/slave/test"] 21:41:23 INFO - --app=APP Application being installed. [default: firefox] 21:41:23 INFO - mkdir: /builds/slave/test/build/application 21:41:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:42:03 INFO - Reading from file tmpfile_stdout 21:42:03 INFO - Output received: 21:42:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:42:03 INFO - Running post-action listener: _resource_record_post_action 21:42:03 INFO - ##### 21:42:03 INFO - ##### Running run-tests step. 21:42:03 INFO - ##### 21:42:03 INFO - Running pre-action listener: _resource_record_pre_action 21:42:03 INFO - Running main action method: run_tests 21:42:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:42:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:42:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:42:03 INFO - 2015-11-17 21:42:03.441 screenresolution[1936:9149] starting screenresolution argv=screenresolution get 21:42:03 INFO - 2015-11-17 21:42:03.445 screenresolution[1936:9149] Display 0: 1600x1200x32@60 21:42:03 INFO - 2015-11-17 21:42:03.452 screenresolution[1937:9151] starting screenresolution argv=screenresolution list 21:42:03 INFO - Available Modes on Display 0 21:42:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:42:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:42:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:42:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:42:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:42:03 INFO - Intel HD Graphics 3000: 21:42:03 INFO - Chipset Model: Intel HD Graphics 3000 21:42:03 INFO - Type: GPU 21:42:03 INFO - Bus: Built-In 21:42:03 INFO - VRAM (Total): 512 MB 21:42:03 INFO - VRAM (Dynamic, Max): 10 21:42:03 INFO - Vendor: Intel (0x8086) 21:42:03 INFO - Device ID: 0x0116 21:42:03 INFO - Revision ID: 0x0009 21:42:03 INFO - Displays: 21:42:03 INFO - Display: 21:42:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:42:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:42:03 INFO - Display Serial Number: 1600x1200 60 21:42:03 INFO - Main Display: Yes 21:42:03 INFO - Mirror: Off 21:42:03 INFO - Online: Yes 21:42:03 INFO - Rotation: Supported 21:42:03 INFO - Return code: 0 21:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:42:03 INFO - Python 2.7.3 21:42:03 INFO - Return code: 0 21:42:03 INFO - grabbing minidump binary from tooltool 21:42:03 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')]} 21:42:03 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 0x106b829f0>, '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 0x1068e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b758c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:42:03 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 21:42:03 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 21:42:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:42:03 INFO - Return code: 0 21:42:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:42:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:42:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:42:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:42:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:42:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0036', '--webServer', 'localhost'] in /builds/slave/test/build 21:42:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0036 --webServer localhost 21:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKJHjLHPnS/Render', 21:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:42:03 INFO - 'HOME': '/Users/cltbld', 21:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:42:03 INFO - 'LOGNAME': 'cltbld', 21:42:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:42:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:03 INFO - 'MOZ_NO_REMOTE': '1', 21:42:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:42:03 INFO - 'NO_EM_RESTART': '1', 21:42:03 INFO - 'PAGER': '/bin/cat', 21:42:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:03 INFO - 'PWD': '/builds/slave/test', 21:42:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:42:03 INFO - 'SHELL': '/bin/bash', 21:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Z5DtIjiXga/Listeners', 21:42:03 INFO - 'TMPDIR': '/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/', 21:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:42:03 INFO - 'USER': 'cltbld', 21:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:03 INFO - 'XPC_FLAGS': '0x0', 21:42:03 INFO - 'XPC_SERVICE_NAME': '0', 21:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:42:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0036', '--webServer', 'localhost'] with output_timeout 3600 21:42:04 INFO - mozversion INFO | application_buildid: 20151117194634 21:42:04 INFO - mozversion INFO | application_changeset: 0959ed75ce40771dc7db7bf11911749e6e4d859b 21:42:04 INFO - mozversion INFO | application_display_name: Nightly 21:42:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:42:04 INFO - mozversion INFO | application_name: Firefox 21:42:04 INFO - mozversion INFO | application_remotingname: firefox 21:42:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:42:04 INFO - mozversion INFO | application_vendor: Mozilla 21:42:04 INFO - mozversion INFO | application_version: 45.0a1 21:42:04 INFO - mozversion INFO | platform_buildid: 20151117194634 21:42:04 INFO - mozversion INFO | platform_changeset: 0959ed75ce40771dc7db7bf11911749e6e4d859b 21:42:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:42:04 INFO - mozversion INFO | platform_version: 45.0a1 21:42:04 INFO - 2015-11-17 21:42:04,207 DEBUG : using testdate: 1447825324 21:42:04 INFO - 2015-11-17 21:42:04,207 DEBUG : actual date: 1447825324 21:42:04 INFO - 2015-11-17 21:42:04,219 INFO : starting webserver on 'localhost:49330' 21:42:04 INFO - 2015-11-17 21:42:04,220 INFO : Starting test suite t-yosemite-r5-0036 21:42:04 INFO - 2015-11-17 21:42:04,220 INFO : Starting test dromaeo_css 21:42:04 INFO - 2015-11-17 21:42:04,220 DEBUG : operating with platform_type : mac_ 21:42:04 INFO - 2015-11-17 21:42:04,221 INFO : Initialising browser for dromaeo_css test... 21:42:04 INFO - 2015-11-17 21:42:04,249 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmpUxKP5V/profile http://localhost:49330/getInfo.html 21:42:07 INFO - 2015-11-17 21:42:07,974 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:42:07 INFO - 2015-11-17 21:42:07,975 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:42:07 INFO - 2015-11-17 21:42:07,975 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:42:07 INFO - 2015-11-17 21:42:07,975 DEBUG : BROWSER_OUTPUT: __metrics 21:42:07 INFO - 2015-11-17 21:42:07,994 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:42:08 INFO - 2015-11-17 21:42:08,758 INFO : Browser initialized. 21:42:08 INFO - 2015-11-17 21:42:08,759 INFO : Running cycle 1/1 for dromaeo_css test... 21:42:08 INFO - 2015-11-17 21:42:08,759 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmpUxKP5V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:42:20 INFO - 2015-11-17 21:42:20,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 230076416 21:42:20 INFO - 2015-11-17 21:42:20,875 DEBUG : BROWSER_OUTPUT: 21:43:12 INFO - 2015-11-17 21:43:12,525 DEBUG : BROWSER_OUTPUT: 1447825392520 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] 21:45:22 INFO - 2015-11-17 21:45:22,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49330/tests/dromaeo/cssquery-ext.html) 21:45:23 INFO - 2015-11-17 21:45:23,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 357658624 21:45:23 INFO - 2015-11-17 21:45:23,748 DEBUG : BROWSER_OUTPUT: 21:48:26 INFO - 2015-11-17 21:48:26,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-ext.html (next: http://localhost:49330/tests/dromaeo/cssquery-jquery.html) 21:48:27 INFO - 2015-11-17 21:48:27,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 377290752 21:48:27 INFO - 2015-11-17 21:48:27,193 DEBUG : BROWSER_OUTPUT: 21:51:29 INFO - 2015-11-17 21:51:29,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49330/tests/dromaeo/cssquery-mootools.html) 21:51:30 INFO - 2015-11-17 21:51:30,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 341274624 21:51:30 INFO - 2015-11-17 21:51:30,279 DEBUG : BROWSER_OUTPUT: 21:54:32 INFO - 2015-11-17 21:54:32,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49330/tests/dromaeo/cssquery-prototype.html) 21:54:32 INFO - 2015-11-17 21:54:32,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 332103680 21:54:33 INFO - 2015-11-17 21:54:32,999 DEBUG : BROWSER_OUTPUT: 21:57:36 INFO - 2015-11-17 21:57:36,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49330/tests/dromaeo/cssquery-yui.html) 21:57:36 INFO - 2015-11-17 21:57:36,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 333041664 21:57:36 INFO - 2015-11-17 21:57:36,890 DEBUG : BROWSER_OUTPUT: 22:00:39 INFO - 2015-11-17 22:00:39,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/dromaeo/cssquery-yui.html (next: http://localhost:49330/tests/dromaeo/cssquery-dojo.html) 22:00:39 INFO - 2015-11-17 22:00:39,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 389795840 22:00:39 INFO - 2015-11-17 22:00:39,936 DEBUG : BROWSER_OUTPUT: 22:00:39 INFO - 2015-11-17 22:00:39,936 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:00:39 INFO - 2015-11-17 22:00:39,937 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:00:39 INFO - 2015-11-17 22:00:39,937 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:00:39 INFO - 2015-11-17 22:00:39,937 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:00:39 INFO - 2015-11-17 22:00:39,937 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2703.405250844814;2811.690714021457;2814.9296267593313;2830.773538116948;2834.3339315260896;4375.803088861001;4385.56144385562;4608.631309495241;4623.237165867637;4638.837640682576;4511.548845115487;4608.23964045932;4638.327442520833;4673.485916549177;4708.976455117729;4173.165366926627;4239.851605193819;4243.511996120439;4279.636230920375;4322;4283.657307415415;4347.521772605027;4379.956200438002;4392.2094023076;4465.866024019285;4164.9583504165175;4305.160493703729;4313.956860431387;4323.978380108079;4384.868453946387;4224.176285624305;4238.766867822269;4297.548757380461;4319.136172765459;4359.803808828578;4306.720063195882;4308.763018034007;4314.460692413449;4348.086901750637;4352.238358287287;4519.209138400766;4550.226461501553;4551.5676010778925;4553.408056952608;4560.8859778505475;4690.413698287714;4778.450478195017;4894.5105489451125;4905.509449055102;4919.065377578248;4909.091818013679;4915.188993816016;4920.40955085392;4926.236433352836;4971.353724015891;4575.908481830378;4583.472900616472;4592.586667199968;4602.861914142548;4655.767211639439;4822.300766388854;4918.901621967612;4950.331705219821;4990.950090499121;4992.80028798844;4701.64737644678;4733;4782.019685964369;4783.091212669582;4800.687955282895;4853.344798452164;4863.9513604864205;4874.878128046827;4894.412670479565;4903.313536104948;4749.4063242094735;4772;4819.204831202812;4832.299316599074;4843.830465933675;4731.668783185213;4790;4790.449098353734;4792.880177995578;4837.395325584302;3646;3735.103575142001;3752.1745216052423;3753.3244016076824;3758.924821503609;3436.7250619950346;3447.413939630269;3449.2066824629974;3526.6297038811067;3529.170644898447;4362.280223763107;4488.842890498817;4522.592966632953;4524.072565124142;4608.400907882021;4845.878853028703;4932.679375840559;4989.950100499022;5003.149464591028;5089.592832573385;4517.11916176349;4539.319102134707;4587.266037433995;4607.493175750665;4633.536646335407;4086.8569600063856;4229.238737027365;4229.788510574459;4330.069035157457;4349.652027837766;4940.728259945738;4984.651074424755;5045.772940217699;5069.974650126799;5073.467285934924;4908.533689299511;4931.50684931504;4940.654154209171;4960.206366981266;5016.523430274118;4814.494478079751;4984.800607975641;4985.077760614298;5029.044481548641;5096.210087436453;4806.49531799156;4876.975615121902;4884.535969082932;4928;4944.431390390151;4921.237208232729;4936.679115857458;4959.925601115914;4970.900581988412;4974.17926042199;4595.4025976622825;4747.477777444547;4766.603039242393;4835.395575553056;4884.023195360871;4548.431446069241;4568.748718820497;4595.333676616939;4715.575598196178;4749.928751068667;4661.440627124767;4684.6954947929635;4718.079974404958;4732.976335118303;4754.904901901873;4582.793774280232;4686.414198225222;4801.4718380977365;4865.902681946271;4881.170201065898;4686.507916668701;4704.435467743892;4727.57451829337;4740.668153229379;4749.026449577759 22:00:39 INFO - 2015-11-17 22:00:39,941 DEBUG : BROWSER_OUTPUT: |1;ext.html;490.7595278313626;498.526399920076;500.9298698182255;508.5600955173775;529.952304292614;27360.589591156124;28486.43919510061;34578.308433831306;35320.82339588299;35361;36805.44791828125;37181.81409092951;37308.44037339442;37344.25311493769;37363.62636373635;7423.554586724814;7985.800354991128;8133.593320333989;8152.755417337489;8155.79610509739;7415.6292185390785;7499.775006749806;9954.552045157949;10093.192544596415;10190.388576685422;9898.158656514204;9902.455364954925;9915;9937.403755774676;9992.150667193297;7413.073365829271;9763.414195148278;9924.255680823968;9931.50342482873;10030.996900309947;7247.20280769115;9822.557984890696;9959.253056020827;9992.900070999269;10075.34510256831;35345.46981795275;35398.29203415943;35445.468317975254;35484.46773298403;35773.46339804905;2607.9869600651873;2667.3585366948764;2762.4475104979083;2828.4343131373807;3167.2873603439043;23769;24194.274171774876;24207.2737817864;24371.14700985457;24524.264272071865;2201.119552179125;2210.602091623507;2234.2850287907877;2239.283429302624;2240.215924426454;231564;232890.8355458229;235569;235890.84654920417;235993;52216.73891630518;52534.73732631312;52587;52639;52649.73675131676;48681.26978095331;50042.49957500451;56798.43201568014;57688.71155644195;57767.42232577704;14662;14690.265486725835;14843.183624900517;14846.109233446028;14949.925250373679;11192.664220073248;11297.661070167907;11313.377764222882;11342.432878356049;11427.542898283975;17161.65676686459;17171.742423863652;17286.827131728773;17314.567135821704;17375.3049878006;7260.564366138048;7354.154272258652;7371.557706537625;7387.150477695026;7439.590822504814;744.9702011919571;745.4669911013651;754.9396048316122;821.3675469888153;842.9915700842913;24504.6324305132;24763.876180618983;24802.751972480044;24837.87581062083;24863.62704559433;927.3230541704594;1010.545254635417;1031.1544533482622;1045.0803293102022;1078.1967434261526;12808.231506109478;12862.614121576367;12967.546135885199;13059.21644701321;13094.214347139203;272952;278784;279275;280920;281917;48185.759071205124;48375.274370884465;48723;48726;48823.511764882605;1094.4691824465128;1122.2761318949233;1122.8764835868049;1253.8244645749419;1373.8969577281744;24136.87931560331;25527.234182974542;25580.744192557835;25601.615975760007;25652.102176424483;38404.615953840104;39889;40525.594744052185;40538.1892362157;40619.7969010153;156624;159902.2004889968;348615;361231;363822;25797.484050319264;26254.474910502064;26437;26463.735362646126;26488.73511264863;34970.82514587411;36178.63821361752;36206.45690314595;36378.27243455063;36778.26443471169;30008.098947136732;30691.846540767154;31039.534406984367;31144.688553114178;31181.68818311788;29760.25599359947;30427.695723042485;30752.69247307498;30880.845595771876;31476.842615786776;28745.71254287514;29400.7059929398;29424.852875735483;29738.405231895675;29783;25782.742172578033;27420.17739467819;27658;27789;27883.302917426416;20899.791002089783;20993.475163121046;21052.684209737174;21078.57842843165;21109.155633774477 22:00:39 INFO - 2015-11-17 22:00:39,941 DEBUG : BROWSER_OUTPUT: |2;jquery.html;292.6853632345228;298.2484139967284;303.85415000799617;304.23788410032876;306.3108006984285;12714.872851271484;13168.539101131462;15380.154091524962;15452.381904723812;15758.133302668348;13751.931240343783;15250.237488125576;15455.30451129699;15522.767158492632;15567.221638918038;4150.896227594304;4278.358246263055;4287.292596721537;4628.560286772759;4815.518448155174;3015.8793648254045;3102.7362674172723;3102.87588496461;3462.5325581046613;4349.826006959718;4221.26127927613;4274.957250427503;4284.378765079062;4336.588024137718;4352.564743525638;4224.112936283384;4325.416068830715;4326.113146804897;4339.41417908583;4346.500152482442;3627.4014787560286;3670.9082272943124;3677.8344974476213;3678.6321367863266;3680.1719613087107;10991.890081099247;11514.309141451457;11568.652940411717;11859.40702964857;11863.94068029663;1557.8130624325154;1605.710972025035;1654.1729135432283;1658.1377683604578;1722.46603552899;8433.28317093048;8495.235428811437;8540.82918341636;8778.736637900873;8850.778730531789;1338.558275768994;1341.423188029147;1374.7250549889961;1387.7779555271109;1416.0087938443028;50715;50939;51702.7414862927;53470.19794703083;53576.464235357926;5725.112607545837;5756.769729210869;5765.625234359753;5784.855378615568;5840.970795145997;6641.236257830411;6683.030960510699;6753;6755.560888542229;6773.966130169416;4739.66822322441;4767.95232047682;4930.926036109461;4963.057019166346;5007.674501157413;5018.498150185025;5041.924371134436;5089.134847076006;5113.948860511422;5118.87202819925;2612.8171028027855;2673.31830383251;2673.866306684658;2677.906273280426;2683.0475181310744;909.554318383987;916.9679061232824;928.1414691410554;930.432436213909;976.7069879036261;329.8911359251441;341.7202576351579;360.55651548595375;361.272036845756;412.4226083483148;9347.485888276211;9351.812963740824;9420.057994200663;9547.140757331874;9824.754381140528;301.78573213018564;310.21979721001696;352.85885645741394;355.934152181842;373.01151947339224;4580.358749775034;5145.922811157836;5188.040212560688;5324.41431442541;5358.196270559447;485077;501391;514013;525648.7175641203;528097;61107;62206;62861.37138628555;62875.68562157251;63974;394.8282497113765;395.7553494260592;399.6023956163578;400.24154227738273;400.3314464843718;9044.50255235942;9103.635854565744;9159.954200228956;9197.586108625263;9201.30990175726;31692;31716.682833171373;31907.202319942186;31912.68087319097;32203.35593288168;41746.791266043474;41790;42277;42847.14305713806;43346;6932.861342773217;6965.164180298397;6979.616121113388;7121.715131394893;7124.287571242834;10587.153027757915;10608.416537090534;10618.1505479563;10739.248252622241;10744.946275268574;7280.96359518199;8971.775705607151;8993.505357205155;8998.82002359936;9102.908970910206;8602.354823388147;8712.912870871463;8775.824483510421;8848.247898928663;9009.549522523717;8677.088905664814;8894.42186257891;9018.729438116867;9061.501617411106;9159.816803663756;6875.828104297432;6943.652817359213;6956.443484521125;6964.512484126265;7042.753503627348;8982.730518084469;9070.909290907006;9193.86209206849;9260.768480787765;9264.166225039779 22:00:39 INFO - 2015-11-17 22:00:39,944 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1304.4847285322292;1456.97814532782;1548.6051056980473;1554.5025591810618;1565.0531428485758;5652.689102099383;5797.449242321984;5853.795117170895;6186.2885768136675;6244.750209991606;6028.969855150729;6079.118527813464;6095.51235901128;6106.816795496131;6182.907256391158;1853.0364210610473;1869.7943226245102;1879.0322983663425;1886.9904601038447;1892.6309369672852;1855.9907200463979;1857;1887.1413506854349;1888.5467487802966;1918.856085793564;1820.4265656318285;1838.8253115953962;1848.4362269507794;1850.4356171367726;1863.68317386044;1811.1306572845042;1865.7108148237046;1867.7852047014565;1872.6254749050177;1891.1773378580363;1861.1345724238158;1881.4731875075001;1887.1790771014516;1908.8282054615013;1922.9711554326695;5528.640638358494;6033.78881739137;6104.664243466607;6150.876982460326;6161.353057928943;3454.481827725836;3568.7145028397667;3619.2761447710564;3784.0539865033743;3789.829457674384;2365.136725095345;2375.2161786610377;2389.0443822470975;2413.7827595516314;2418.4074901649033;784.4744021505605;795.6260557538005;798.2496453333847;808.7654580171743;815.9796005099861;7803.804904877366;7834.33408160307;7877.881831772528;7898.842023159562;7902.999999999943;3386.2211691311136;3448.4310088835564;3489.1277180704824;3516.9472457913153;3533.9823300883845;7004.474664400191;7075.787726368218;7080.044194033842;7088.503804733722;7106;3898.2203559288255;3944.8422063117155;3949.5260568731937;3953.0710283083454;3957;3605.891823245307;3608.4226523756074;3609.151849315409;3610;3640.4903313536124;2786.9024584139456;2842.872070756821;2843.8720257588457;2871.7128287171536;2875.051233093074;927.8190752803274;937.4796987671771;941.9529023548795;944.1266828183902;953.1993125774383;871.1941454154882;925.1765928323797;1145.9598914038136;1159.6636975277245;1171.1099564331;5693.516051135617;5820;5840.29916410025;5845;5857.88284234313;927.800522887569;1012.8480727890875;1015.9339642923186;1025.9281850270559;1030.701096681954;4714.504976977437;4730.148573256778;4766.142094422968;4769.904601907942;4774.7135171889795;6576.309487503839;6739.5619284746335;6782.1861376635115;6962.756303529352;6987.091678081919;6868.7252509900045;6885.483588730865;6902.585844849325;6912.965435172792;6956.513044086865;5739.71301434935;5757.510611598061;5798.855028624318;5808.186853840466;5857.4435428634215;5836.970815145897;5857.150713146655;5865.00294949851;5877.853053673522;5920.348761636303;6276.9372306276355;6441.581297215666;6462.7091780870915;6482.254540727877;6486.2216534016225;6465.127207827071;6525.1517302750335;6643;6659.766908158192;6672.633005184762;5288.233206185158;5362.222477740628;5385.596080294072;5386.865328366665;5448.400675925565;5986.970065149646;6006.909896351645;6017.338092809699;6041.758329666764;6062.090686396899;5451.781928722807;5641.689707065987;5712.34308054579;5731.742071606871;5776;5503.2020357048805;5588.860278492907;5656.462636049569;5659.9151012735665;5685.857853553694;5316.255724198538;5565.833025009256;5567.415421380697;5619.353774316006;5642.85892852682;5111.821086262112;5140.614453916046;5147.794088236578;5162.97418512905;5193.662411943212;5149.48505149497;5207.635465517377;5229.6339256251695;5260.921086183634;5314.734263286898 22:00:39 INFO - 2015-11-17 22:00:39,946 DEBUG : BROWSER_OUTPUT: |4;prototype.html;275.9737824906633;283.0672932686798;285.07919420272515;288.10399657066534;290.1267185770832;5589.049861523541;5602.215689803425;5663.745131469083;5669.971650141743;5724.513416359614;5286.629935904488;5464.672119672822;5495.422980587041;5502.614816962814;5598.720063996804;4175.874723758285;4237.559229861847;4239.300515414953;4249.873783447389;4312.116016216668;4221.873343799691;4339.674524410681;4346.913061738764;4352.499462561798;4358.3462480628;4300.956990430102;4321.611055005049;4324.718893271943;4325.783710814462;4342.565743425664;3951.190006048782;4126.66986641068;4181.686373521983;4205.957940420587;4277.978610106929;3646.0702520857276;3702.4446333049987;3703.3519134151684;3705.8517659293598;3708.8145592720257;5383.757730902119;5387.542058924996;5394.514493695587;5396.487333703292;5399.1091469907415;4748.3589715388325;4790.592799612037;4810.037992401533;4825.131476334259;4826.34844296019;5675.432456754333;5803.53571714266;5836.941630583682;5882.705864706748;5887.646741195542;3927.56796752357;3972.920541589152;3974.721769476138;3976.363781794899;3981.1838573092446;6128.172696685935;6137.1101190328045;6148.108524264001;6158.137860699506;6162.1681073055015;4048.1296521248073;4050;4055.168690418457;4059.7414801411064;4063.512378514597;3990.4014397840556;4057.39139129133;4103.938440923389;4109.260333140063;4112.3420252759415;4768.260919557474;4783.497732738082;4784.760761961888;4797.904041919142;4798;5873.941260587425;5876.030454974882;5876.853078672982;5891.9116213255975;5920.467157955719;1443.076431084107;1453.6729235921832;1467.4057006912217;1468.6548661064642;1469.169918995764;898.1557336104041;901.6844104563351;948.9762755931157;956.4548207521785;957.066859811692;5413.323334583177;5510.752016159283;5630.5214056805635;5673.319201695823;5705.800296989585;6169.753209871555;6195.101710252078;6197;6209.844753881189;6217.813465596039;5670.376258611549;5681.914771278434;5682.971585142048;5685.857853553612;5722.599418040781;3225.870965161414;3267.8529466174077;3349.7487688423466;3352.5641666583674;3384.492326151048;6381.074744162071;6383.585066970725;6386.8722625547225;6396.648184349812;6421.871562568723;6353.968230158912;6374.171357723466;6377.904331435032;6384.58500197495;6396.488280937514;6158.846028849314;6397.936020639827;6406.199225096863;6411.134496843053;6417.390347917034;6217.067439883873;6228.906566401598;6231.096491008869;6245.406686364788;6248.4376406123665;6048.788292409745;6066.211392518944;6069.878602428015;6101.389861013863;6109.816705498843;6184.072389141665;6342.365763423621;6397.232332120176;6404.903926441014;6412.102305677302;3936.3701807710627;3960;3963.7027222957818;3964.6431821135084;3973.7218394712095;6206.06908963641;6206.193194884636;6207.720652570735;6208.317085120723;6215.160953271431;5989.131575921379;6006.639601623917;6025.758969641165;6036.094585812163;6038.275406951194;5787.826365209051;5941.7623295067715;5965.164876917322;5977.491913187254;5983.222181116601;5692.829215123553;5832.679202643895;5837.328707198726;5852.4440178183;5889.587728858939;5673.546116310603;5888.116782482491;5905.435059709266;6006.429389208019;6011;5438.891222175455;5633.38032816398;5745.6552606843725;5836.153757705194;5861.648301101947 22:00:39 INFO - 2015-11-17 22:00:39,949 DEBUG : BROWSER_OUTPUT: |5;yui.html;581.5057201378828;639.3798015924555;650.3593959949451;670.2325836916731;691.9342662447066;11489.540418383265;12247.20393174443;12412.751744965119;12420.875791242084;12424.316662583555;11315.094792416607;11443.771124577503;11588.42057897104;11599.216188114855;11604;778.8792737125755;779.0612312163857;792.374024520628;792.6472719639762;795.459087820282;619.1888625900085;627.0374974414275;628.8019273928697;793.7420338390017;806.5402720449346;826.1531929771971;829.0465964141256;840.4537050916891;846.3144852669327;848.7368915636173;832.8251067275879;833.9249467547919;834.6995081770558;845.0577605969362;845.446232717571;487.7853744352474;488.2895387211634;600.4385899184276;619.5415392609482;621.9937800621981;12210.57262995791;12286.815697764541;12290.631281061582;12434.378281086;12434.81347779784;10211.79576408475;10350.120239779628;10363.63727269542;10371.636992705295;10385.324953877975;8233.259006689366;8468.364872634576;8504.149585041509;8519.659213631508;8521.531315777629;2553.2978430931457;2580.7935365170742;2680.1825443239804;2895.565665150223;3039.027511196396;36074;36822.07944801402;40563.39154912678;40720.38919416181;41058.38412423816;5908.113782932509;5941.316748573883;5972.790952316648;6074.635521868702;6304.810855674337;10498.370097794157;10579.460929376894;10594.311369761095;10614.257002009785;10745.462726863625;5577.442255774471;5599.7480113394995;5666.206731057655;5692.117721753135;5731.8853622928145;3213.903582892517;3257.788243764148;3295.24209431832;3331.8833840815455;3435.175557866144;2169.761326254111;2186.0709198590853;2187.278198194592;2190.518086021073;2194.3746032380695;318.50313510923036;324.6039831405681;333.0325404699352;333.90149905777855;335.5403097756041;439.8944253379166;449.50105383024817;452.7125275450047;485.5726960275006;565.0168706450746;6436.195475565554;7163.247858974837;7205.819854503575;7291;7309.378702810321;345.93254315408757;370.283501424744;471.93864797576094;527.7493190734447;531.0812294730139;3242.967570324314;3351.9664803352143;3414.2830005698584;3433.210361616792;3448.9310213795584;47305.29042064303;47912;48025.27962080572;50751.492485074676;51174.48825511697;45023;45740.54259457363;46125.76937115293;46338.76830615893;47226.76386618045;40169.39745903814;42641.5075472357;42704.35943460851;43314.13371732548;43475.56524434715;6964;7410.184879663125;7415.295546923034;7490.060406915337;7546.056742907137;31873.97197266256;32084.839575801972;32326.515102273956;32891.671083288864;33000;39062.6093739059;39225.80387098046;40777.388339174344;42491.201407774606;43177.3523397143;6097.634141951497;6396.136521569715;6463.418292353711;6532.934670653232;6854.794356169323;9632;9652.662156824477;9652.9034709652;9749.415035097916;10514.474276286308;9364.81270374575;9390.95304523473;9460.385074970105;9597.47213903242;9618.230541556799;9166.954165229132;9443.763905902408;9486.810263794547;9533.094356036165;9564.521773911416;8792.384533082879;8988.056254093226;9105.544722763967;9195.954020230123;9885.654002109892;7886.132525422085;7952.960235198787;8178.263956243966;8316.731083396384;8331.041930177864;7254.709811607477;7446.292602202782;7813.296803287732;7942.44402891792;8448.619812108593 22:00:39 INFO - 2015-11-17 22:00:39,949 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:00:39 INFO - 2015-11-17 22:00:39,949 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:00:39 INFO - 2015-11-17 22:00:39,950 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1015 22:00:39 INFO - 2015-11-17 22:00:39,950 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:00:39 INFO - 2015-11-17 22:00:39,950 DEBUG : BROWSER_OUTPUT: __startTimestamp1447826439934__endTimestamp 22:00:39 INFO - 2015-11-17 22:00:39,950 DEBUG : BROWSER_OUTPUT: 22:00:39 INFO - 2015-11-17 22:00:39,950 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:00:39 INFO - 2015-11-17 22:00:39,950 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:00:39 INFO - 2015-11-17 22:00:39,951 DEBUG : BROWSER_OUTPUT: 22:00:39 INFO - 2015-11-17 22:00:39,951 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4559.64 Median:4686.51 stddev:470.07 (10.0%) stddev-sans-first:448.39 22:00:39 INFO - 2015-11-17 22:00:39,951 DEBUG : BROWSER_OUTPUT: Values: 2703.4 2811.7 2814.9 2830.8 2834.3 4375.8 4385.6 4608.6 4623.2 4638.8 4511.5 4608.2 4638.3 4673.5 4709.0 4173.2 4239.9 4243.5 4279.6 4322.0 4283.7 4347.5 4380.0 4392.2 4465.9 4165.0 4305.2 4314.0 4324.0 4384.9 4224.2 4238.8 4297.5 4319.1 4359.8 4306.7 4308.8 4314.5 4348.1 4352.2 4519.2 4550.2 4551.6 4553.4 4560.9 4690.4 4778.5 4894.5 4905.5 4919.1 4909.1 4915.2 4920.4 4926.2 4971.4 4575.9 4583.5 4592.6 4602.9 4655.8 4822.3 4918.9 4950.3 4991.0 4992.8 4701.6 4733.0 4782.0 4783.1 4800.7 4853.3 4864.0 4874.9 4894.4 4903.3 4749.4 4772.0 4819.2 4832.3 4843.8 4731.7 4790.0 4790.4 4792.9 4837.4 3646.0 3735.1 3752.2 3753.3 3758.9 3436.7 3447.4 3449.2 3526.6 3529.2 4362.3 4488.8 4522.6 4524.1 4608.4 4845.9 4932.7 4990.0 5003.1 5089.6 4517.1 4539.3 4587.3 4607.5 4633.5 4086.9 4229.2 4229.8 4330.1 4349.7 4940.7 4984.7 5045.8 5070.0 5073.5 4908.5 4931.5 4940.7 4960.2 5016.5 4814.5 4984.8 4985.1 5029.0 5096.2 4806.5 4877.0 4884.5 4928.0 4944.4 4921.2 4936.7 4959.9 4970.9 4974.2 4595.4 4747.5 4766.6 4835.4 4884.0 4548.4 4568.7 4595.3 4715.6 4749.9 4661.4 4684.7 4718.1 4733.0 4754.9 4582.8 4686.4 4801.5 4865.9 4881.2 4686.5 4704.4 4727.6 4740.7 4749.0 22:00:39 INFO - 2015-11-17 22:00:39,951 DEBUG : BROWSER_OUTPUT: 22:00:39 INFO - 2015-11-17 22:00:39,951 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41257.15 Median:29771.63 stddev:71051.96 (238.7%) stddev-sans-first:71185.35 22:00:39 INFO - 2015-11-17 22:00:39,953 DEBUG : BROWSER_OUTPUT: Values: 490.8 498.5 500.9 508.6 530.0 27360.6 28486.4 34578.3 35320.8 35361.0 36805.4 37181.8 37308.4 37344.3 37363.6 7423.6 7985.8 8133.6 8152.8 8155.8 7415.6 7499.8 9954.6 10093.2 10190.4 9898.2 9902.5 9915.0 9937.4 9992.2 7413.1 9763.4 9924.3 9931.5 10031.0 7247.2 9822.6 9959.3 9992.9 10075.3 35345.5 35398.3 35445.5 35484.5 35773.5 2608.0 2667.4 2762.4 2828.4 3167.3 23769.0 24194.3 24207.3 24371.1 24524.3 2201.1 2210.6 2234.3 2239.3 2240.2 231564.0 232890.8 235569.0 235890.8 235993.0 52216.7 52534.7 52587.0 52639.0 52649.7 48681.3 50042.5 56798.4 57688.7 57767.4 14662.0 14690.3 14843.2 14846.1 14949.9 11192.7 11297.7 11313.4 11342.4 11427.5 17161.7 17171.7 17286.8 17314.6 17375.3 7260.6 7354.2 7371.6 7387.2 7439.6 745.0 745.5 754.9 821.4 843.0 24504.6 24763.9 24802.8 24837.9 24863.6 927.3 1010.5 1031.2 1045.1 1078.2 12808.2 12862.6 12967.5 13059.2 13094.2 272952.0 278784.0 279275.0 280920.0 281917.0 48185.8 48375.3 48723.0 48726.0 48823.5 1094.5 1122.3 1122.9 1253.8 1373.9 24136.9 25527.2 25580.7 25601.6 25652.1 38404.6 39889.0 40525.6 40538.2 40619.8 156624.0 159902.2 348615.0 361231.0 363822.0 25797.5 26254.5 26437.0 26463.7 26488.7 34970.8 36178.6 36206.5 36378.3 36778.3 30008.1 30691.8 31039.5 31144.7 31181.7 29760.3 30427.7 30752.7 30880.8 31476.8 28745.7 29400.7 29424.9 29738.4 29783.0 25782.7 27420.2 27658.0 27789.0 27883.3 20899.8 20993.5 21052.7 21078.6 21109.2 22:00:39 INFO - 2015-11-17 22:00:39,953 DEBUG : BROWSER_OUTPUT: 22:00:39 INFO - 2015-11-17 22:00:39,953 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24559.78 Median:4753.81 stddev:83658.32 (1759.8%) stddev-sans-first:83873.15 22:00:39 INFO - 2015-11-17 22:00:39,953 DEBUG : BROWSER_OUTPUT: Values: 292.7 298.2 303.9 304.2 306.3 12714.9 13168.5 15380.2 15452.4 15758.1 13751.9 15250.2 15455.3 15522.8 15567.2 4150.9 4278.4 4287.3 4628.6 4815.5 3015.9 3102.7 3102.9 3462.5 4349.8 4221.3 4275.0 4284.4 4336.6 4352.6 4224.1 4325.4 4326.1 4339.4 4346.5 3627.4 3670.9 3677.8 3678.6 3680.2 10991.9 11514.3 11568.7 11859.4 11863.9 1557.8 1605.7 1654.2 1658.1 1722.5 8433.3 8495.2 8540.8 8778.7 8850.8 1338.6 1341.4 1374.7 1387.8 1416.0 50715.0 50939.0 51702.7 53470.2 53576.5 5725.1 5756.8 5765.6 5784.9 5841.0 6641.2 6683.0 6753.0 6755.6 6774.0 4739.7 4768.0 4930.9 4963.1 5007.7 5018.5 5041.9 5089.1 5113.9 5118.9 2612.8 2673.3 2673.9 2677.9 2683.0 909.6 917.0 928.1 930.4 976.7 329.9 341.7 360.6 361.3 412.4 9347.5 9351.8 9420.1 9547.1 9824.8 301.8 310.2 352.9 355.9 373.0 4580.4 5145.9 5188.0 5324.4 5358.2 485077.0 501391.0 514013.0 525648.7 528097.0 61107.0 62206.0 62861.4 62875.7 63974.0 394.8 395.8 399.6 400.2 400.3 9044.5 9103.6 9160.0 9197.6 9201.3 31692.0 31716.7 31907.2 31912.7 32203.4 41746.8 41790.0 42277.0 42847.1 43346.0 6932.9 6965.2 6979.6 7121.7 7124.3 10587.2 10608.4 10618.2 10739.2 10744.9 7281.0 8971.8 8993.5 8998.8 9102.9 8602.4 8712.9 8775.8 8848.2 9009.5 8677.1 8894.4 9018.7 9061.5 9159.8 6875.8 6943.7 6956.4 6964.5 7042.8 8982.7 9070.9 9193.9 9260.8 9264.2 22:00:39 INFO - 2015-11-17 22:00:39,954 DEBUG : BROWSER_OUTPUT: 22:00:39 INFO - 2015-11-17 22:00:39,954 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4308.22 Median:5547.24 stddev:2115.30 (38.1%) stddev-sans-first:2109.18 22:00:39 INFO - 2015-11-17 22:00:39,955 DEBUG : BROWSER_OUTPUT: Values: 1304.5 1457.0 1548.6 1554.5 1565.1 5652.7 5797.4 5853.8 6186.3 6244.8 6029.0 6079.1 6095.5 6106.8 6182.9 1853.0 1869.8 1879.0 1887.0 1892.6 1856.0 1857.0 1887.1 1888.5 1918.9 1820.4 1838.8 1848.4 1850.4 1863.7 1811.1 1865.7 1867.8 1872.6 1891.2 1861.1 1881.5 1887.2 1908.8 1923.0 5528.6 6033.8 6104.7 6150.9 6161.4 3454.5 3568.7 3619.3 3784.1 3789.8 2365.1 2375.2 2389.0 2413.8 2418.4 784.5 795.6 798.2 808.8 816.0 7803.8 7834.3 7877.9 7898.8 7903.0 3386.2 3448.4 3489.1 3516.9 3534.0 7004.5 7075.8 7080.0 7088.5 7106.0 3898.2 3944.8 3949.5 3953.1 3957.0 3605.9 3608.4 3609.2 3610.0 3640.5 2786.9 2842.9 2843.9 2871.7 2875.1 927.8 937.5 942.0 944.1 953.2 871.2 925.2 1146.0 1159.7 1171.1 5693.5 5820.0 5840.3 5845.0 5857.9 927.8 1012.8 1015.9 1025.9 1030.7 4714.5 4730.1 4766.1 4769.9 4774.7 6576.3 6739.6 6782.2 6962.8 6987.1 6868.7 6885.5 6902.6 6913.0 6956.5 5739.7 5757.5 5798.9 5808.2 5857.4 5837.0 5857.2 5865.0 5877.9 5920.3 6276.9 6441.6 6462.7 6482.3 6486.2 6465.1 6525.2 6643.0 6659.8 6672.6 5288.2 5362.2 5385.6 5386.9 5448.4 5987.0 6006.9 6017.3 6041.8 6062.1 5451.8 5641.7 5712.3 5731.7 5776.0 5503.2 5588.9 5656.5 5659.9 5685.9 5316.3 5565.8 5567.4 5619.4 5642.9 5111.8 5140.6 5147.8 5163.0 5193.7 5149.5 5207.6 5229.6 5260.9 5314.7 22:00:39 INFO - 2015-11-17 22:00:39,955 DEBUG : BROWSER_OUTPUT: 22:00:39 INFO - 2015-11-17 22:00:39,955 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4932.68 Median:5673.43 stddev:1525.98 (26.9%) stddev-sans-first:1489.69 22:00:39 INFO - 2015-11-17 22:00:39,957 DEBUG : BROWSER_OUTPUT: Values: 276.0 283.1 285.1 288.1 290.1 5589.0 5602.2 5663.7 5670.0 5724.5 5286.6 5464.7 5495.4 5502.6 5598.7 4175.9 4237.6 4239.3 4249.9 4312.1 4221.9 4339.7 4346.9 4352.5 4358.3 4301.0 4321.6 4324.7 4325.8 4342.6 3951.2 4126.7 4181.7 4206.0 4278.0 3646.1 3702.4 3703.4 3705.9 3708.8 5383.8 5387.5 5394.5 5396.5 5399.1 4748.4 4790.6 4810.0 4825.1 4826.3 5675.4 5803.5 5836.9 5882.7 5887.6 3927.6 3972.9 3974.7 3976.4 3981.2 6128.2 6137.1 6148.1 6158.1 6162.2 4048.1 4050.0 4055.2 4059.7 4063.5 3990.4 4057.4 4103.9 4109.3 4112.3 4768.3 4783.5 4784.8 4797.9 4798.0 5873.9 5876.0 5876.9 5891.9 5920.5 1443.1 1453.7 1467.4 1468.7 1469.2 898.2 901.7 949.0 956.5 957.1 5413.3 5510.8 5630.5 5673.3 5705.8 6169.8 6195.1 6197.0 6209.8 6217.8 5670.4 5681.9 5683.0 5685.9 5722.6 3225.9 3267.9 3349.7 3352.6 3384.5 6381.1 6383.6 6386.9 6396.6 6421.9 6354.0 6374.2 6377.9 6384.6 6396.5 6158.8 6397.9 6406.2 6411.1 6417.4 6217.1 6228.9 6231.1 6245.4 6248.4 6048.8 6066.2 6069.9 6101.4 6109.8 6184.1 6342.4 6397.2 6404.9 6412.1 3936.4 3960.0 3963.7 3964.6 3973.7 6206.1 6206.2 6207.7 6208.3 6215.2 5989.1 6006.6 6025.8 6036.1 6038.3 5787.8 5941.8 5965.2 5977.5 5983.2 5692.8 5832.7 5837.3 5852.4 5889.6 5673.5 5888.1 5905.4 6006.4 6011.0 5438.9 5633.4 5745.7 5836.2 5861.6 22:00:39 INFO - 2015-11-17 22:00:39,957 DEBUG : BROWSER_OUTPUT: 22:00:39 INFO - 2015-11-17 22:00:39,957 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11643.83 Median:529.42 stddev:14163.46 (2675.3%) stddev-sans-first:14178.83 22:00:39 INFO - 2015-11-17 22:00:39,958 DEBUG : BROWSER_OUTPUT: Values: 581.5 639.4 650.4 670.2 691.9 11489.5 12247.2 12412.8 12420.9 12424.3 11315.1 11443.8 11588.4 11599.2 11604.0 778.9 779.1 792.4 792.6 795.5 619.2 627.0 628.8 793.7 806.5 826.2 829.0 840.5 846.3 848.7 832.8 833.9 834.7 845.1 845.4 487.8 488.3 600.4 619.5 622.0 12210.6 12286.8 12290.6 12434.4 12434.8 10211.8 10350.1 10363.6 10371.6 10385.3 8233.3 8468.4 8504.1 8519.7 8521.5 2553.3 2580.8 2680.2 2895.6 3039.0 36074.0 36822.1 40563.4 40720.4 41058.4 5908.1 5941.3 5972.8 6074.6 6304.8 10498.4 10579.5 10594.3 10614.3 10745.5 5577.4 5599.7 5666.2 5692.1 5731.9 3213.9 3257.8 3295.2 3331.9 3435.2 2169.8 2186.1 2187.3 2190.5 2194.4 318.5 324.6 333.0 333.9 335.5 439.9 449.5 452.7 485.6 565.0 6436.2 7163.2 7205.8 7291.0 7309.4 345.9 370.3 471.9 527.7 531.1 3243.0 3352.0 3414.3 3433.2 3448.9 47305.3 47912.0 48025.3 50751.5 51174.5 45023.0 45740.5 46125.8 46338.8 47226.8 40169.4 42641.5 42704.4 43314.1 43475.6 6964.0 7410.2 7415.3 7490.1 7546.1 31874.0 32084.8 32326.5 32891.7 33000.0 39062.6 39225.8 40777.4 42491.2 43177.4 6097.6 6396.1 6463.4 6532.9 6854.8 9632.0 9652.7 9652.9 9749.4 10514.5 9364.8 9391.0 9460.4 9597.5 9618.2 9167.0 9443.8 9486.8 9533.1 9564.5 8792.4 8988.1 9105.5 9196.0 9885.7 7886.1 7953.0 8178.3 8316.7 8331.0 7254.7 7446.3 7813.3 7942.4 8448.6 22:00:39 INFO - 2015-11-17 22:00:39,958 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:00:39 INFO - 2015-11-17 22:00:39,958 DEBUG : BROWSER_OUTPUT: 22:00:40 INFO - 2015-11-17 22:00:40,680 INFO : Browser exited with error code: 0 22:00:40 INFO - 2015-11-17 22:00:40,712 INFO : Completed test dromaeo_css (00:18:36) 22:00:40 INFO - 2015-11-17 22:00:40,712 INFO : Starting test kraken 22:00:40 INFO - 2015-11-17 22:00:40,712 DEBUG : operating with platform_type : mac_ 22:00:40 INFO - 2015-11-17 22:00:40,712 INFO : Initialising browser for kraken test... 22:00:40 INFO - 2015-11-17 22:00:40,727 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmpFmgZ9e/profile http://localhost:49330/getInfo.html 22:00:43 INFO - 2015-11-17 22:00:43,192 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:00:43 INFO - 2015-11-17 22:00:43,193 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:00:43 INFO - 2015-11-17 22:00:43,193 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:00:43 INFO - 2015-11-17 22:00:43,193 DEBUG : BROWSER_OUTPUT: __metrics 22:00:43 INFO - 2015-11-17 22:00:43,210 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:43 INFO - 2015-11-17 22:00:43,974 INFO : Browser initialized. 22:00:43 INFO - 2015-11-17 22:00:43,974 INFO : Running cycle 1/1 for kraken test... 22:00:43 INFO - 2015-11-17 22:00:43,975 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmpFmgZ9e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:00:56 INFO - 2015-11-17 22:00:56,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 229138432 22:00:56 INFO - 2015-11-17 22:00:56,065 DEBUG : BROWSER_OUTPUT: 22:00:58 INFO - 2015-11-17 22:00:58,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49330/tests/kraken/driver.html?testName=audio-beat-detection) 22:00:59 INFO - 2015-11-17 22:00:59,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 285618176 22:00:59 INFO - 2015-11-17 22:00:59,507 DEBUG : BROWSER_OUTPUT: 22:01:02 INFO - 2015-11-17 22:01:02,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49330/tests/kraken/driver.html?testName=audio-dft) 22:01:03 INFO - 2015-11-17 22:01:03,014 DEBUG : BROWSER_OUTPUT: RSS: Main: 300380160 22:01:03 INFO - 2015-11-17 22:01:03,014 DEBUG : BROWSER_OUTPUT: 22:01:06 INFO - 2015-11-17 22:01:06,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49330/tests/kraken/driver.html?testName=audio-fft) 22:01:06 INFO - 2015-11-17 22:01:06,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 282365952 22:01:06 INFO - 2015-11-17 22:01:06,833 DEBUG : BROWSER_OUTPUT: 22:01:09 INFO - 2015-11-17 22:01:09,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49330/tests/kraken/driver.html?testName=audio-oscillator) 22:01:09 INFO - 2015-11-17 22:01:09,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 283275264 22:01:09 INFO - 2015-11-17 22:01:09,712 DEBUG : BROWSER_OUTPUT: 22:01:12 INFO - 2015-11-17 22:01:12,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49330/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:01:12 INFO - 2015-11-17 22:01:12,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 285798400 22:01:12 INFO - 2015-11-17 22:01:12,698 DEBUG : BROWSER_OUTPUT: 22:01:16 INFO - 2015-11-17 22:01:16,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49330/tests/kraken/driver.html?testName=imaging-darkroom) 22:01:16 INFO - 2015-11-17 22:01:16,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 285659136 22:01:16 INFO - 2015-11-17 22:01:16,659 DEBUG : BROWSER_OUTPUT: 22:01:20 INFO - 2015-11-17 22:01:20,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49330/tests/kraken/driver.html?testName=imaging-desaturate) 22:01:20 INFO - 2015-11-17 22:01:20,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 282763264 22:01:20 INFO - 2015-11-17 22:01:20,731 DEBUG : BROWSER_OUTPUT: 22:01:23 INFO - 2015-11-17 22:01:23,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49330/tests/kraken/driver.html?testName=json-parse-financial) 22:01:24 INFO - 2015-11-17 22:01:24,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 282644480 22:01:24 INFO - 2015-11-17 22:01:24,471 DEBUG : BROWSER_OUTPUT: 22:01:26 INFO - 2015-11-17 22:01:26,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49330/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:01:26 INFO - 2015-11-17 22:01:26,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 319799296 22:01:26 INFO - 2015-11-17 22:01:26,772 DEBUG : BROWSER_OUTPUT: 22:01:28 INFO - 2015-11-17 22:01:28,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:01:29 INFO - 2015-11-17 22:01:29,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 321576960 22:01:29 INFO - 2015-11-17 22:01:29,383 DEBUG : BROWSER_OUTPUT: 22:01:31 INFO - 2015-11-17 22:01:31,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:01:32 INFO - 2015-11-17 22:01:32,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 328413184 22:01:32 INFO - 2015-11-17 22:01:32,271 DEBUG : BROWSER_OUTPUT: 22:01:35 INFO - 2015-11-17 22:01:35,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:01:35 INFO - 2015-11-17 22:01:35,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 328491008 22:01:35 INFO - 2015-11-17 22:01:35,725 DEBUG : BROWSER_OUTPUT: 22:01:38 INFO - 2015-11-17 22:01:38,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:01:39 INFO - 2015-11-17 22:01:39,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 329269248 22:01:39 INFO - 2015-11-17 22:01:39,225 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49330/tests/kraken/driver.html?testName=ai-astar) 22:01:41 INFO - 2015-11-17 22:01:41,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 387846144 22:01:41 INFO - 2015-11-17 22:01:41,374 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,374 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:01:41 INFO - 2015-11-17 22:01:41,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:01:41 INFO - 2015-11-17 22:01:41,375 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:01:41 INFO - 2015-11-17 22:01:41,375 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:01:41 INFO - 2015-11-17 22:01:41,375 DEBUG : BROWSER_OUTPUT: |0;ai-astar;121;124;121;130;125;123;113;123;130;120 22:01:41 INFO - 2015-11-17 22:01:41,375 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;175;152;175;187;149;168;173;150;189;145 22:01:41 INFO - 2015-11-17 22:01:41,375 DEBUG : BROWSER_OUTPUT: |2;audio-dft;178;188;184;182;182;179;182;185;183;181 22:01:41 INFO - 2015-11-17 22:01:41,375 DEBUG : BROWSER_OUTPUT: |3;audio-fft;88;86;99;99;79;82;82;97;96;79 22:01:41 INFO - 2015-11-17 22:01:41,376 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;111;108;151;102;105;100;144;99;100;153 22:01:41 INFO - 2015-11-17 22:01:41,376 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;141;139;130;138;137;142;135;132;135;135 22:01:41 INFO - 2015-11-17 22:01:41,376 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;142;148;145;141;142;148;145;142;141;147 22:01:41 INFO - 2015-11-17 22:01:41,376 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;114;118;111;115;118;107;114;118;118;108 22:01:41 INFO - 2015-11-17 22:01:41,376 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;70;70;72;73;73;72;80;68;69 22:01:41 INFO - 2015-11-17 22:01:41,377 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;78;77;82;80;82;78;78;78;79 22:01:41 INFO - 2015-11-17 22:01:41,377 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;96;98;100;100;101;97;98;101;102;101 22:01:41 INFO - 2015-11-17 22:01:41,377 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;149;142;142;145;144;147;152;145;157;149 22:01:41 INFO - 2015-11-17 22:01:41,377 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;172;178;181;175;171;160;177;179;175;169 22:01:41 INFO - 2015-11-17 22:01:41,377 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;80;80;84;83;86;84;80;81;78 22:01:41 INFO - 2015-11-17 22:01:41,377 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:01:41 INFO - 2015-11-17 22:01:41,377 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:01:41 INFO - 2015-11-17 22:01:41,378 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,949 22:01:41 INFO - 2015-11-17 22:01:41,378 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:01:41 INFO - 2015-11-17 22:01:41,378 DEBUG : BROWSER_OUTPUT: __startTimestamp1447826501369__endTimestamp 22:01:41 INFO - 2015-11-17 22:01:41,378 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,378 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:01:41 INFO - 2015-11-17 22:01:41,378 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:01:41 INFO - 2015-11-17 22:01:41,379 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,379 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:123.00 Median:123.50 stddev:4.94 (4.0%) stddev-sans-first:5.19 22:01:41 INFO - 2015-11-17 22:01:41,379 DEBUG : BROWSER_OUTPUT: Values: 121.0 124.0 121.0 130.0 125.0 123.0 113.0 123.0 130.0 120.0 22:01:41 INFO - 2015-11-17 22:01:41,379 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,379 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:166.30 Median:174.00 stddev:16.21 (9.3%) stddev-sans-first:16.89 22:01:41 INFO - 2015-11-17 22:01:41,380 DEBUG : BROWSER_OUTPUT: Values: 175.0 152.0 175.0 187.0 149.0 168.0 173.0 150.0 189.0 145.0 22:01:41 INFO - 2015-11-17 22:01:41,380 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,380 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.40 Median:182.50 stddev:2.88 (1.6%) stddev-sans-first:2.57 22:01:41 INFO - 2015-11-17 22:01:41,380 DEBUG : BROWSER_OUTPUT: Values: 178.0 188.0 184.0 182.0 182.0 179.0 182.0 185.0 183.0 181.0 22:01:41 INFO - 2015-11-17 22:01:41,380 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,381 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.70 Median:92.00 stddev:8.30 (9.0%) stddev-sans-first:8.80 22:01:41 INFO - 2015-11-17 22:01:41,381 DEBUG : BROWSER_OUTPUT: Values: 88.0 86.0 99.0 99.0 79.0 82.0 82.0 97.0 96.0 79.0 22:01:41 INFO - 2015-11-17 22:01:41,381 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,381 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:117.30 Median:127.50 stddev:22.53 (17.7%) stddev-sans-first:23.78 22:01:41 INFO - 2015-11-17 22:01:41,382 DEBUG : BROWSER_OUTPUT: Values: 111.0 108.0 151.0 102.0 105.0 100.0 144.0 99.0 100.0 153.0 22:01:41 INFO - 2015-11-17 22:01:41,382 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,382 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:136.40 Median:137.50 stddev:3.78 (2.7%) stddev-sans-first:3.62 22:01:41 INFO - 2015-11-17 22:01:41,382 DEBUG : BROWSER_OUTPUT: Values: 141.0 139.0 130.0 138.0 137.0 142.0 135.0 132.0 135.0 135.0 22:01:41 INFO - 2015-11-17 22:01:41,383 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,383 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.10 Median:145.00 stddev:2.85 (2.0%) stddev-sans-first:2.92 22:01:41 INFO - 2015-11-17 22:01:41,383 DEBUG : BROWSER_OUTPUT: Values: 142.0 148.0 145.0 141.0 142.0 148.0 145.0 142.0 141.0 147.0 22:01:41 INFO - 2015-11-17 22:01:41,383 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,383 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:114.10 Median:116.50 stddev:4.20 (3.6%) stddev-sans-first:4.46 22:01:41 INFO - 2015-11-17 22:01:41,383 DEBUG : BROWSER_OUTPUT: Values: 114.0 118.0 111.0 115.0 118.0 107.0 114.0 118.0 118.0 108.0 22:01:41 INFO - 2015-11-17 22:01:41,384 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,384 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:72.00 stddev:3.66 (5.1%) stddev-sans-first:3.52 22:01:41 INFO - 2015-11-17 22:01:41,384 DEBUG : BROWSER_OUTPUT: Values: 67.0 70.0 70.0 72.0 73.0 73.0 72.0 80.0 68.0 69.0 22:01:41 INFO - 2015-11-17 22:01:41,384 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,384 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.60 Median:78.50 stddev:2.37 (3.0%) stddev-sans-first:1.83 22:01:41 INFO - 2015-11-17 22:01:41,384 DEBUG : BROWSER_OUTPUT: Values: 74.0 78.0 77.0 82.0 80.0 82.0 78.0 78.0 78.0 79.0 22:01:41 INFO - 2015-11-17 22:01:41,384 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,384 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:99.40 Median:99.00 stddev:2.01 (2.0%) stddev-sans-first:1.72 22:01:41 INFO - 2015-11-17 22:01:41,385 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 100.0 100.0 101.0 97.0 98.0 101.0 102.0 101.0 22:01:41 INFO - 2015-11-17 22:01:41,385 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,385 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:148.00 stddev:4.71 (3.2%) stddev-sans-first:4.95 22:01:41 INFO - 2015-11-17 22:01:41,386 DEBUG : BROWSER_OUTPUT: Values: 149.0 142.0 142.0 145.0 144.0 147.0 152.0 145.0 157.0 149.0 22:01:41 INFO - 2015-11-17 22:01:41,386 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,386 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:176.00 stddev:6.09 (3.5%) stddev-sans-first:6.43 22:01:41 INFO - 2015-11-17 22:01:41,387 DEBUG : BROWSER_OUTPUT: Values: 172.0 178.0 181.0 175.0 171.0 160.0 177.0 179.0 175.0 169.0 22:01:41 INFO - 2015-11-17 22:01:41,387 DEBUG : BROWSER_OUTPUT: 22:01:41 INFO - 2015-11-17 22:01:41,387 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.50 Median:82.00 stddev:2.59 (3.2%) stddev-sans-first:2.59 22:01:41 INFO - 2015-11-17 22:01:41,387 DEBUG : BROWSER_OUTPUT: Values: 79.0 80.0 80.0 84.0 83.0 86.0 84.0 80.0 81.0 78.0 22:01:41 INFO - 2015-11-17 22:01:41,387 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:01:41 INFO - 2015-11-17 22:01:41,387 DEBUG : BROWSER_OUTPUT: 22:01:42 INFO - 2015-11-17 22:01:42,146 INFO : Browser exited with error code: 0 22:01:42 INFO - 2015-11-17 22:01:42,202 INFO : Completed test kraken (00:01:01) 22:01:42 INFO - 2015-11-17 22:01:42,202 INFO : Starting test v8_7 22:01:42 INFO - 2015-11-17 22:01:42,202 DEBUG : operating with platform_type : mac_ 22:01:42 INFO - 2015-11-17 22:01:42,202 INFO : Initialising browser for v8_7 test... 22:01:42 INFO - 2015-11-17 22:01:42,216 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmpiI95VJ/profile http://localhost:49330/getInfo.html 22:01:44 INFO - 2015-11-17 22:01:44,738 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:01:44 INFO - 2015-11-17 22:01:44,738 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:01:44 INFO - 2015-11-17 22:01:44,738 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:01:44 INFO - 2015-11-17 22:01:44,738 DEBUG : BROWSER_OUTPUT: __metrics 22:01:44 INFO - 2015-11-17 22:01:44,755 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:01:45 INFO - 2015-11-17 22:01:45,514 INFO : Browser initialized. 22:01:45 INFO - 2015-11-17 22:01:45,515 INFO : Running cycle 1/1 for v8_7 test... 22:01:45 INFO - 2015-11-17 22:01:45,515 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/T/tmpiI95VJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:01:57 INFO - 2015-11-17 22:01:57,570 DEBUG : BROWSER_OUTPUT: RSS: Main: 228945920 22:01:57 INFO - 2015-11-17 22:01:57,570 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49330/tests/v8_7/run.html (next: http://localhost:49330/tests/v8_7/run.html) 22:02:20 INFO - 2015-11-17 22:02:20,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 641060864 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: |0;Richards;189.82536066818528 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;226.1931689662972 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: |2;Encrypt;359.45363048166786 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6756.756756756757 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2212.3893805309735 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: |5;Earley;1018.3299389002036 22:02:20 INFO - 2015-11-17 22:02:20,467 DEBUG : BROWSER_OUTPUT: |6;Boyer;14623.188405797102 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: |7;RegExp;33883.333333333336 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: |8;Splay;789.2659826361484 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6512.987012987013 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: __startTimestamp1447826540460__endTimestamp 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:189.83 Median:189.83 stddev:0.00 (0.0%) 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: Values: 189.8 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:226.19 Median:226.19 stddev:0.00 (0.0%) 22:02:20 INFO - 2015-11-17 22:02:20,468 DEBUG : BROWSER_OUTPUT: Values: 226.2 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:359.45 Median:359.45 stddev:0.00 (0.0%) 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: Values: 359.5 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6756.76 Median:6756.76 stddev:0.00 (0.0%) 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: Values: 6756.8 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2212.39 Median:2212.39 stddev:0.00 (0.0%) 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: Values: 2212.4 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1018.33 Median:1018.33 stddev:0.00 (0.0%) 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: Values: 1018.3 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,469 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14623.19 Median:14623.19 stddev:0.00 (0.0%) 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: Values: 14623.2 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33883.33 Median:33883.33 stddev:0.00 (0.0%) 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: Values: 33883.3 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: Values: 789.3 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6512.99 Median:6512.99 stddev:0.00 (0.0%) 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: Values: 6513.0 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:02:20 INFO - 2015-11-17 22:02:20,470 DEBUG : BROWSER_OUTPUT: 22:02:21 INFO - 2015-11-17 22:02:21,225 INFO : Browser exited with error code: 0 22:02:21 INFO - 2015-11-17 22:02:21,248 INFO : Completed test v8_7 (00:00:39) 22:02:21 INFO - 2015-11-17 22:02:21,469 INFO : Completed test suite (00:20:17) 22:02:21 INFO - 2015-11-17 22:02:21,469 DEBUG : Working with test: dromaeo_css 22:02:21 INFO - 2015-11-17 22:02:21,469 DEBUG : Generating results file: dromaeo_css 22:02:21 INFO - 2015-11-17 22:02:21,470 DEBUG : Working with test: kraken 22:02:21 INFO - 2015-11-17 22:02:21,470 DEBUG : Generating results file: kraken 22:02:21 INFO - 2015-11-17 22:02:21,470 INFO : javascript benchmark 22:02:21 INFO - 2015-11-17 22:02:21,470 DEBUG : Working with test: v8_7 22:02:21 INFO - 2015-11-17 22:02:21,470 DEBUG : Generating results file: v8_7 22:02:21 INFO - 2015-11-17 22:02:21,471 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:02:21 INFO - 2015-11-17 22:02:21,540 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 22:02:21 INFO - 2015-11-17 22:02:21,540 DEBUG : process_Request line: dromaeo_css 5739.41 graph.html#tests=[[72,63,55]] 22:02:21 INFO - 2015-11-17 22:02:21,540 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:02:21 INFO - 2015-11-17 22:02:21,576 DEBUG : process_Request line: kraken 1724.10 graph.html#tests=[[232,63,55]] 22:02:21 INFO - 2015-11-17 22:02:21,576 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:02:21 INFO - 2015-11-17 22:02:21,608 DEBUG : process_Request line: v8_7 15928.49 graph.html#tests=[[230,63,55]] 22:02:21 INFO - 2015-11-17 22:02:21,609 INFO : javascript benchmark 22:02:21 INFO - 2015-11-17 22:02:21,611 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2703.405250844814, 2811.690714021457, 2814.9296267593313, 2830.773538116948, 2834.3339315260896, 4375.803088861001, 4385.56144385562, 4608.631309495241, 4623.237165867637, 4638.837640682576, 4511.548845115487, 4608.23964045932, 4638.327442520833, 4673.485916549177, 4708.976455117729, 4173.165366926627, 4239.851605193819, 4243.511996120439, 4279.636230920375, 4322.0, 4283.657307415415, 4347.521772605027, 4379.956200438002, 4392.2094023076, 4465.866024019285, 4164.9583504165175, 4305.160493703729, 4313.956860431387, 4323.978380108079, 4384.868453946387, 4224.176285624305, 4238.766867822269, 4297.548757380461, 4319.136172765459, 4359.803808828578, 4306.720063195882, 4308.763018034007, 4314.460692413449, 4348.086901750637, 4352.238358287287, 4519.209138400766, 4550.226461501553, 4551.5676010778925, 4553.408056952608, 4560.8859778505475, 4690.413698287714, 4778.450478195017, 4894.5105489451125, 4905.509449055102, 4919.065377578248, 4909.091818013679, 4915.188993816016, 4920.40955085392, 4926.236433352836, 4971.353724015891, 4575.908481830378, 4583.472900616472, 4592.586667199968, 4602.861914142548, 4655.767211639439, 4822.300766388854, 4918.901621967612, 4950.331705219821, 4990.950090499121, 4992.80028798844, 4701.64737644678, 4733.0, 4782.019685964369, 4783.091212669582, 4800.687955282895, 4853.344798452164, 4863.9513604864205, 4874.878128046827, 4894.412670479565, 4903.313536104948, 4749.4063242094735, 4772.0, 4819.204831202812, 4832.299316599074, 4843.830465933675, 4731.668783185213, 4790.0, 4790.449098353734, 4792.880177995578, 4837.395325584302, 3646.0, 3735.103575142001, 3752.1745216052423, 3753.3244016076824, 3758.924821503609, 3436.7250619950346, 3447.413939630269, 3449.2066824629974, 3526.6297038811067, 3529.170644898447, 4362.280223763107, 4488.842890498817, 4522.592966632953, 4524.072565124142, 4608.400907882021, 4845.878853028703, 4932.679375840559, 4989.950100499022, 5003.149464591028, 5089.592832573385, 4517.11916176349, 4539.319102134707, 4587.266037433995, 4607.493175750665, 4633.536646335407, 4086.8569600063856, 4229.238737027365, 4229.788510574459, 4330.069035157457, 4349.652027837766, 4940.728259945738, 4984.651074424755, 5045.772940217699, 5069.974650126799, 5073.467285934924, 4908.533689299511, 4931.50684931504, 4940.654154209171, 4960.206366981266, 5016.523430274118, 4814.494478079751, 4984.800607975641, 4985.077760614298, 5029.044481548641, 5096.210087436453, 4806.49531799156, 4876.975615121902, 4884.535969082932, 4928.0, 4944.431390390151, 4921.237208232729, 4936.679115857458, 4959.925601115914, 4970.900581988412, 4974.17926042199, 4595.4025976622825, 4747.477777444547, 4766.603039242393, 4835.395575553056, 4884.023195360871, 4548.431446069241, 4568.748718820497, 4595.333676616939, 4715.575598196178, 4749.928751068667, 4661.440627124767, 4684.6954947929635, 4718.079974404958, 4732.976335118303, 4754.904901901873, 4582.793774280232, 4686.414198225222, 4801.4718380977365, 4865.902681946271, 4881.170201065898, 4686.507916668701, 4704.435467743892, 4727.57451829337, 4740.668153229379, 4749.026449577759], "unit": "ms", "name": "dojo.html", "value": 4531.451987995106}, {"lowerIsBetter": false, "replicates": [490.7595278313626, 498.526399920076, 500.9298698182255, 508.5600955173775, 529.952304292614, 27360.589591156124, 28486.43919510061, 34578.308433831306, 35320.82339588299, 35361.0, 36805.44791828125, 37181.81409092951, 37308.44037339442, 37344.25311493769, 37363.62636373635, 7423.554586724814, 7985.800354991128, 8133.593320333989, 8152.755417337489, 8155.79610509739, 7415.6292185390785, 7499.775006749806, 9954.552045157949, 10093.192544596415, 10190.388576685422, 9898.158656514204, 9902.455364954925, 9915.0, 9937.403755774676, 9992.150667193297, 7413.073365829271, 9763.414195148278, 9924.255680823968, 9931.50342482873, 10030.996900309947, 7247.20280769115, 9822.557984890696, 9959.253056020827, 9992.900070999269, 10075.34510256831, 35345.46981795275, 35398.29203415943, 35445.468317975254, 35484.46773298403, 35773.46339804905, 2607.9869600651873, 2667.3585366948764, 2762.4475104979083, 2828.4343131373807, 3167.2873603439043, 23769.0, 24194.274171774876, 24207.2737817864, 24371.14700985457, 24524.264272071865, 2201.119552179125, 2210.602091623507, 2234.2850287907877, 2239.283429302624, 2240.215924426454, 231564.0, 232890.8355458229, 235569.0, 235890.84654920417, 235993.0, 52216.73891630518, 52534.73732631312, 52587.0, 52639.0, 52649.73675131676, 48681.26978095331, 50042.49957500451, 56798.43201568014, 57688.71155644195, 57767.42232577704, 14662.0, 14690.265486725835, 14843.183624900517, 14846.109233446028, 14949.925250373679, 11192.664220073248, 11297.661070167907, 11313.377764222882, 11342.432878356049, 11427.542898283975, 17161.65676686459, 17171.742423863652, 17286.827131728773, 17314.567135821704, 17375.3049878006, 7260.564366138048, 7354.154272258652, 7371.557706537625, 7387.150477695026, 7439.590822504814, 744.9702011919571, 745.4669911013651, 754.9396048316122, 821.3675469888153, 842.9915700842913, 24504.6324305132, 24763.876180618983, 24802.751972480044, 24837.87581062083, 24863.62704559433, 927.3230541704594, 1010.545254635417, 1031.1544533482622, 1045.0803293102022, 1078.1967434261526, 12808.231506109478, 12862.614121576367, 12967.546135885199, 13059.21644701321, 13094.214347139203, 272952.0, 278784.0, 279275.0, 280920.0, 281917.0, 48185.759071205124, 48375.274370884465, 48723.0, 48726.0, 48823.511764882605, 1094.4691824465128, 1122.2761318949233, 1122.8764835868049, 1253.8244645749419, 1373.8969577281744, 24136.87931560331, 25527.234182974542, 25580.744192557835, 25601.615975760007, 25652.102176424483, 38404.615953840104, 39889.0, 40525.594744052185, 40538.1892362157, 40619.7969010153, 156624.0, 159902.2004889968, 348615.0, 361231.0, 363822.0, 25797.484050319264, 26254.474910502064, 26437.0, 26463.735362646126, 26488.73511264863, 34970.82514587411, 36178.63821361752, 36206.45690314595, 36378.27243455063, 36778.26443471169, 30008.098947136732, 30691.846540767154, 31039.534406984367, 31144.688553114178, 31181.68818311788, 29760.25599359947, 30427.695723042485, 30752.69247307498, 30880.845595771876, 31476.842615786776, 28745.71254287514, 29400.7059929398, 29424.852875735483, 29738.405231895675, 29783.0, 25782.742172578033, 27420.17739467819, 27658.0, 27789.0, 27883.302917426416, 20899.791002089783, 20993.475163121046, 21052.684209737174, 21078.57842843165, 21109.155633774477], "unit": "ms", "name": "ext.html", "value": 16378.514705856604}, {"lowerIsBetter": false, "replicates": [292.6853632345228, 298.2484139967284, 303.85415000799617, 304.23788410032876, 306.3108006984285, 12714.872851271484, 13168.539101131462, 15380.154091524962, 15452.381904723812, 15758.133302668348, 13751.931240343783, 15250.237488125576, 15455.30451129699, 15522.767158492632, 15567.221638918038, 4150.896227594304, 4278.358246263055, 4287.292596721537, 4628.560286772759, 4815.518448155174, 3015.8793648254045, 3102.7362674172723, 3102.87588496461, 3462.5325581046613, 4349.826006959718, 4221.26127927613, 4274.957250427503, 4284.378765079062, 4336.588024137718, 4352.564743525638, 4224.112936283384, 4325.416068830715, 4326.113146804897, 4339.41417908583, 4346.500152482442, 3627.4014787560286, 3670.9082272943124, 3677.8344974476213, 3678.6321367863266, 3680.1719613087107, 10991.890081099247, 11514.309141451457, 11568.652940411717, 11859.40702964857, 11863.94068029663, 1557.8130624325154, 1605.710972025035, 1654.1729135432283, 1658.1377683604578, 1722.46603552899, 8433.28317093048, 8495.235428811437, 8540.82918341636, 8778.736637900873, 8850.778730531789, 1338.558275768994, 1341.423188029147, 1374.7250549889961, 1387.7779555271109, 1416.0087938443028, 50715.0, 50939.0, 51702.7414862927, 53470.19794703083, 53576.464235357926, 5725.112607545837, 5756.769729210869, 5765.625234359753, 5784.855378615568, 5840.970795145997, 6641.236257830411, 6683.030960510699, 6753.0, 6755.560888542229, 6773.966130169416, 4739.66822322441, 4767.95232047682, 4930.926036109461, 4963.057019166346, 5007.674501157413, 5018.498150185025, 5041.924371134436, 5089.134847076006, 5113.948860511422, 5118.87202819925, 2612.8171028027855, 2673.31830383251, 2673.866306684658, 2677.906273280426, 2683.0475181310744, 909.554318383987, 916.9679061232824, 928.1414691410554, 930.432436213909, 976.7069879036261, 329.8911359251441, 341.7202576351579, 360.55651548595375, 361.272036845756, 412.4226083483148, 9347.485888276211, 9351.812963740824, 9420.057994200663, 9547.140757331874, 9824.754381140528, 301.78573213018564, 310.21979721001696, 352.85885645741394, 355.934152181842, 373.01151947339224, 4580.358749775034, 5145.922811157836, 5188.040212560688, 5324.41431442541, 5358.196270559447, 485077.0, 501391.0, 514013.0, 525648.7175641203, 528097.0, 61107.0, 62206.0, 62861.37138628555, 62875.68562157251, 63974.0, 394.8282497113765, 395.7553494260592, 399.6023956163578, 400.24154227738273, 400.3314464843718, 9044.50255235942, 9103.635854565744, 9159.954200228956, 9197.586108625263, 9201.30990175726, 31692.0, 31716.682833171373, 31907.202319942186, 31912.68087319097, 32203.35593288168, 41746.791266043474, 41790.0, 42277.0, 42847.14305713806, 43346.0, 6932.861342773217, 6965.164180298397, 6979.616121113388, 7121.715131394893, 7124.287571242834, 10587.153027757915, 10608.416537090534, 10618.1505479563, 10739.248252622241, 10744.946275268574, 7280.96359518199, 8971.775705607151, 8993.505357205155, 8998.82002359936, 9102.908970910206, 8602.354823388147, 8712.912870871463, 8775.824483510421, 8848.247898928663, 9009.549522523717, 8677.088905664814, 8894.42186257891, 9018.729438116867, 9061.501617411106, 9159.816803663756, 6875.828104297432, 6943.652817359213, 6956.443484521125, 6964.512484126265, 7042.753503627348, 8982.730518084469, 9070.909290907006, 9193.86209206849, 9260.768480787765, 9264.166225039779], "unit": "ms", "name": "jquery.html", "value": 5905.311170960631}, {"lowerIsBetter": false, "replicates": [1304.4847285322292, 1456.97814532782, 1548.6051056980473, 1554.5025591810618, 1565.0531428485758, 5652.689102099383, 5797.449242321984, 5853.795117170895, 6186.2885768136675, 6244.750209991606, 6028.969855150729, 6079.118527813464, 6095.51235901128, 6106.816795496131, 6182.907256391158, 1853.0364210610473, 1869.7943226245102, 1879.0322983663425, 1886.9904601038447, 1892.6309369672852, 1855.9907200463979, 1857.0, 1887.1413506854349, 1888.5467487802966, 1918.856085793564, 1820.4265656318285, 1838.8253115953962, 1848.4362269507794, 1850.4356171367726, 1863.68317386044, 1811.1306572845042, 1865.7108148237046, 1867.7852047014565, 1872.6254749050177, 1891.1773378580363, 1861.1345724238158, 1881.4731875075001, 1887.1790771014516, 1908.8282054615013, 1922.9711554326695, 5528.640638358494, 6033.78881739137, 6104.664243466607, 6150.876982460326, 6161.353057928943, 3454.481827725836, 3568.7145028397667, 3619.2761447710564, 3784.0539865033743, 3789.829457674384, 2365.136725095345, 2375.2161786610377, 2389.0443822470975, 2413.7827595516314, 2418.4074901649033, 784.4744021505605, 795.6260557538005, 798.2496453333847, 808.7654580171743, 815.9796005099861, 7803.804904877366, 7834.33408160307, 7877.881831772528, 7898.842023159562, 7902.999999999943, 3386.2211691311136, 3448.4310088835564, 3489.1277180704824, 3516.9472457913153, 3533.9823300883845, 7004.474664400191, 7075.787726368218, 7080.044194033842, 7088.503804733722, 7106.0, 3898.2203559288255, 3944.8422063117155, 3949.5260568731937, 3953.0710283083454, 3957.0, 3605.891823245307, 3608.4226523756074, 3609.151849315409, 3610.0, 3640.4903313536124, 2786.9024584139456, 2842.872070756821, 2843.8720257588457, 2871.7128287171536, 2875.051233093074, 927.8190752803274, 937.4796987671771, 941.9529023548795, 944.1266828183902, 953.1993125774383, 871.1941454154882, 925.1765928323797, 1145.9598914038136, 1159.6636975277245, 1171.1099564331, 5693.516051135617, 5820.0, 5840.29916410025, 5845.0, 5857.88284234313, 927.800522887569, 1012.8480727890875, 1015.9339642923186, 1025.9281850270559, 1030.701096681954, 4714.504976977437, 4730.148573256778, 4766.142094422968, 4769.904601907942, 4774.7135171889795, 6576.309487503839, 6739.5619284746335, 6782.1861376635115, 6962.756303529352, 6987.091678081919, 6868.7252509900045, 6885.483588730865, 6902.585844849325, 6912.965435172792, 6956.513044086865, 5739.71301434935, 5757.510611598061, 5798.855028624318, 5808.186853840466, 5857.4435428634215, 5836.970815145897, 5857.150713146655, 5865.00294949851, 5877.853053673522, 5920.348761636303, 6276.9372306276355, 6441.581297215666, 6462.7091780870915, 6482.254540727877, 6486.2216534016225, 6465.127207827071, 6525.1517302750335, 6643.0, 6659.766908158192, 6672.633005184762, 5288.233206185158, 5362.222477740628, 5385.596080294072, 5386.865328366665, 5448.400675925565, 5986.970065149646, 6006.909896351645, 6017.338092809699, 6041.758329666764, 6062.090686396899, 5451.781928722807, 5641.689707065987, 5712.34308054579, 5731.742071606871, 5776.0, 5503.2020357048805, 5588.860278492907, 5656.462636049569, 5659.9151012735665, 5685.857853553694, 5316.255724198538, 5565.833025009256, 5567.415421380697, 5619.353774316006, 5642.85892852682, 5111.821086262112, 5140.614453916046, 5147.794088236578, 5162.97418512905, 5193.662411943212, 5149.48505149497, 5207.635465517377, 5229.6339256251695, 5260.921086183634, 5314.734263286898], "unit": "ms", "name": "mootools.html", "value": 3608.9536000956823}, {"lowerIsBetter": false, "replicates": [275.9737824906633, 283.0672932686798, 285.07919420272515, 288.10399657066534, 290.1267185770832, 5589.049861523541, 5602.215689803425, 5663.745131469083, 5669.971650141743, 5724.513416359614, 5286.629935904488, 5464.672119672822, 5495.422980587041, 5502.614816962814, 5598.720063996804, 4175.874723758285, 4237.559229861847, 4239.300515414953, 4249.873783447389, 4312.116016216668, 4221.873343799691, 4339.674524410681, 4346.913061738764, 4352.499462561798, 4358.3462480628, 4300.956990430102, 4321.611055005049, 4324.718893271943, 4325.783710814462, 4342.565743425664, 3951.190006048782, 4126.66986641068, 4181.686373521983, 4205.957940420587, 4277.978610106929, 3646.0702520857276, 3702.4446333049987, 3703.3519134151684, 3705.8517659293598, 3708.8145592720257, 5383.757730902119, 5387.542058924996, 5394.514493695587, 5396.487333703292, 5399.1091469907415, 4748.3589715388325, 4790.592799612037, 4810.037992401533, 4825.131476334259, 4826.34844296019, 5675.432456754333, 5803.53571714266, 5836.941630583682, 5882.705864706748, 5887.646741195542, 3927.56796752357, 3972.920541589152, 3974.721769476138, 3976.363781794899, 3981.1838573092446, 6128.172696685935, 6137.1101190328045, 6148.108524264001, 6158.137860699506, 6162.1681073055015, 4048.1296521248073, 4050.0, 4055.168690418457, 4059.7414801411064, 4063.512378514597, 3990.4014397840556, 4057.39139129133, 4103.938440923389, 4109.260333140063, 4112.3420252759415, 4768.260919557474, 4783.497732738082, 4784.760761961888, 4797.904041919142, 4798.0, 5873.941260587425, 5876.030454974882, 5876.853078672982, 5891.9116213255975, 5920.467157955719, 1443.076431084107, 1453.6729235921832, 1467.4057006912217, 1468.6548661064642, 1469.169918995764, 898.1557336104041, 901.6844104563351, 948.9762755931157, 956.4548207521785, 957.066859811692, 5413.323334583177, 5510.752016159283, 5630.5214056805635, 5673.319201695823, 5705.800296989585, 6169.753209871555, 6195.101710252078, 6197.0, 6209.844753881189, 6217.813465596039, 5670.376258611549, 5681.914771278434, 5682.971585142048, 5685.857853553612, 5722.599418040781, 3225.870965161414, 3267.8529466174077, 3349.7487688423466, 3352.5641666583674, 3384.492326151048, 6381.074744162071, 6383.585066970725, 6386.8722625547225, 6396.648184349812, 6421.871562568723, 6353.968230158912, 6374.171357723466, 6377.904331435032, 6384.58500197495, 6396.488280937514, 6158.846028849314, 6397.936020639827, 6406.199225096863, 6411.134496843053, 6417.390347917034, 6217.067439883873, 6228.906566401598, 6231.096491008869, 6245.406686364788, 6248.4376406123665, 6048.788292409745, 6066.211392518944, 6069.878602428015, 6101.389861013863, 6109.816705498843, 6184.072389141665, 6342.365763423621, 6397.232332120176, 6404.903926441014, 6412.102305677302, 3936.3701807710627, 3960.0, 3963.7027222957818, 3964.6431821135084, 3973.7218394712095, 6206.06908963641, 6206.193194884636, 6207.720652570735, 6208.317085120723, 6215.160953271431, 5989.131575921379, 6006.639601623917, 6025.758969641165, 6036.094585812163, 6038.275406951194, 5787.826365209051, 5941.7623295067715, 5965.164876917322, 5977.491913187254, 5983.222181116601, 5692.829215123553, 5832.679202643895, 5837.328707198726, 5852.4440178183, 5889.587728858939, 5673.546116310603, 5888.116782482491, 5905.435059709266, 6006.429389208019, 6011.0, 5438.891222175455, 5633.38032816398, 5745.6552606843725, 5836.153757705194, 5861.648301101947], "unit": "ms", "name": "prototype.html", "value": 4422.033728091688}, {"lowerIsBetter": false, "replicates": [581.5057201378828, 639.3798015924555, 650.3593959949451, 670.2325836916731, 691.9342662447066, 11489.540418383265, 12247.20393174443, 12412.751744965119, 12420.875791242084, 12424.316662583555, 11315.094792416607, 11443.771124577503, 11588.42057897104, 11599.216188114855, 11604.0, 778.8792737125755, 779.0612312163857, 792.374024520628, 792.6472719639762, 795.459087820282, 619.1888625900085, 627.0374974414275, 628.8019273928697, 793.7420338390017, 806.5402720449346, 826.1531929771971, 829.0465964141256, 840.4537050916891, 846.3144852669327, 848.7368915636173, 832.8251067275879, 833.9249467547919, 834.6995081770558, 845.0577605969362, 845.446232717571, 487.7853744352474, 488.2895387211634, 600.4385899184276, 619.5415392609482, 621.9937800621981, 12210.57262995791, 12286.815697764541, 12290.631281061582, 12434.378281086, 12434.81347779784, 10211.79576408475, 10350.120239779628, 10363.63727269542, 10371.636992705295, 10385.324953877975, 8233.259006689366, 8468.364872634576, 8504.149585041509, 8519.659213631508, 8521.531315777629, 2553.2978430931457, 2580.7935365170742, 2680.1825443239804, 2895.565665150223, 3039.027511196396, 36074.0, 36822.07944801402, 40563.39154912678, 40720.38919416181, 41058.38412423816, 5908.113782932509, 5941.316748573883, 5972.790952316648, 6074.635521868702, 6304.810855674337, 10498.370097794157, 10579.460929376894, 10594.311369761095, 10614.257002009785, 10745.462726863625, 5577.442255774471, 5599.7480113394995, 5666.206731057655, 5692.117721753135, 5731.8853622928145, 3213.903582892517, 3257.788243764148, 3295.24209431832, 3331.8833840815455, 3435.175557866144, 2169.761326254111, 2186.0709198590853, 2187.278198194592, 2190.518086021073, 2194.3746032380695, 318.50313510923036, 324.6039831405681, 333.0325404699352, 333.90149905777855, 335.5403097756041, 439.8944253379166, 449.50105383024817, 452.7125275450047, 485.5726960275006, 565.0168706450746, 6436.195475565554, 7163.247858974837, 7205.819854503575, 7291.0, 7309.378702810321, 345.93254315408757, 370.283501424744, 471.93864797576094, 527.7493190734447, 531.0812294730139, 3242.967570324314, 3351.9664803352143, 3414.2830005698584, 3433.210361616792, 3448.9310213795584, 47305.29042064303, 47912.0, 48025.27962080572, 50751.492485074676, 51174.48825511697, 45023.0, 45740.54259457363, 46125.76937115293, 46338.76830615893, 47226.76386618045, 40169.39745903814, 42641.5075472357, 42704.35943460851, 43314.13371732548, 43475.56524434715, 6964.0, 7410.184879663125, 7415.295546923034, 7490.060406915337, 7546.056742907137, 31873.97197266256, 32084.839575801972, 32326.515102273956, 32891.671083288864, 33000.0, 39062.6093739059, 39225.80387098046, 40777.388339174344, 42491.201407774606, 43177.3523397143, 6097.634141951497, 6396.136521569715, 6463.418292353711, 6532.934670653232, 6854.794356169323, 9632.0, 9652.662156824477, 9652.9034709652, 9749.415035097916, 10514.474276286308, 9364.81270374575, 9390.95304523473, 9460.385074970105, 9597.47213903242, 9618.230541556799, 9166.954165229132, 9443.763905902408, 9486.810263794547, 9533.094356036165, 9564.521773911416, 8792.384533082879, 8988.056254093226, 9105.544722763967, 9195.954020230123, 9885.654002109892, 7886.132525422085, 7952.960235198787, 8178.263956243966, 8316.731083396384, 8331.041930177864, 7254.709811607477, 7446.292602202782, 7813.296803287732, 7942.44402891792, 8448.619812108593], "unit": "ms", "name": "yui.html", "value": 5109.763903069329}], "name": "dromaeo_css", "value": 5739.41172308287}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [121.0, 124.0, 121.0, 130.0, 125.0, 123.0, 113.0, 123.0, 130.0, 120.0], "unit": "ms", "name": "ai-astar", "value": 123.0}, {"lowerIsBetter": true, "replicates": [175.0, 152.0, 175.0, 187.0, 149.0, 168.0, 173.0, 150.0, 189.0, 145.0], "unit": "ms", "name": "audio-beat-detection", "value": 166.3}, {"lowerIsBetter": true, "replicates": [178.0, 188.0, 184.0, 182.0, 182.0, 179.0, 182.0, 185.0, 183.0, 181.0], "unit": "ms", "name": "audio-dft", "value": 182.4}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 99.0, 99.0, 79.0, 82.0, 82.0, 97.0, 96.0, 79.0], "unit": "ms", "name": "audio-fft", "value": 88.7}, {"lowerIsBetter": true, "replicates": [111.0, 108.0, 151.0, 102.0, 105.0, 100.0, 144.0, 99.0, 100.0, 153.0], "unit": "ms", "name": "audio-oscillator", "value": 117.3}, {"lowerIsBetter": true, "replicates": [141.0, 139.0, 130.0, 138.0, 137.0, 142.0, 135.0, 132.0, 135.0, 135.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 136.4}, {"lowerIsBetter": true, "replicates": [142.0, 148.0, 145.0, 141.0, 142.0, 148.0, 145.0, 142.0, 141.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 144.1}, {"lowerIsBetter": true, "replicates": [114.0, 118.0, 111.0, 115.0, 118.0, 107.0, 114.0, 118.0, 118.0, 108.0], "unit": "ms", "name": "imaging-desaturate", "value": 114.1}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 70.0, 72.0, 73.0, 73.0, 72.0, 80.0, 68.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [74.0, 78.0, 77.0, 82.0, 80.0, 82.0, 78.0, 78.0, 78.0, 79.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 78.6}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 100.0, 100.0, 101.0, 97.0, 98.0, 101.0, 102.0, 101.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 99.4}, {"lowerIsBetter": true, "replicates": [149.0, 142.0, 142.0, 145.0, 144.0, 147.0, 152.0, 145.0, 157.0, 149.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 147.2}, {"lowerIsBetter": true, "replicates": [172.0, 178.0, 181.0, 175.0, 171.0, 160.0, 177.0, 179.0, 175.0, 169.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 173.7}, {"lowerIsBetter": true, "replicates": [79.0, 80.0, 80.0, 84.0, 83.0, 86.0, 84.0, 80.0, 81.0, 78.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 81.5}], "name": "kraken", "value": 1724.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [189.82536066818528], "unit": "score", "name": "Richards", "value": 185.97093599999994}, {"lowerIsBetter": false, "replicates": [226.1931689662972], "unit": "score", "name": "DeltaBlue", "value": 292.3076779999999}, {"lowerIsBetter": false, "replicates": [359.45363048166786], "unit": "score", "name": "Encrypt", "value": 740.5155419999998}, {"lowerIsBetter": false, "replicates": [6756.756756756757], "unit": "score", "name": "Decrypt", "value": 39.394787999999984}, {"lowerIsBetter": false, "replicates": [2212.3893805309735], "unit": "score", "name": "RayTrace", "value": 334.47502800000007}, {"lowerIsBetter": false, "replicates": [1018.3299389002036], "unit": "score", "name": "Earley", "value": 654.4666659999999}, {"lowerIsBetter": false, "replicates": [14623.188405797102], "unit": "score", "name": "Boyer", "value": 45.57576511397421}, {"lowerIsBetter": false, "replicates": [33883.333333333336], "unit": "score", "name": "RegExp", "value": 26.88593212001966}, {"lowerIsBetter": false, "replicates": [789.2659826361484], "unit": "score", "name": "Splay", "value": 103.24909700000003}, {"lowerIsBetter": false, "replicates": [6512.987012987013], "unit": "score", "name": "NavierStokes", "value": 227.85244267198416}], "name": "v8_7", "value": 15928.493120443616}]} 22:02:21 INFO - RETURN: dromaeo_css: 5739.41 22:02:21 INFO - RETURN: kraken: 1724.10 22:02:21 INFO - RETURN: v8_7: 15928.49 22:02:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "15928.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1724.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "5739.41"}}} 22:02:21 INFO - Return code: 0 22:02:21 INFO - # TBPL SUCCESS # 22:02:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:02:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:02:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:02:21 INFO - 2015-11-17 22:02:21.694 screenresolution[1964:11298] starting screenresolution argv=screenresolution get 22:02:21 INFO - 2015-11-17 22:02:21.697 screenresolution[1964:11298] Display 0: 1600x1200x32@60 22:02:21 INFO - 2015-11-17 22:02:21.704 screenresolution[1965:11301] starting screenresolution argv=screenresolution list 22:02:21 INFO - Available Modes on Display 0 22:02:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:02:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:02:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:02:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:02:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:02:21 INFO - Intel HD Graphics 3000: 22:02:21 INFO - Chipset Model: Intel HD Graphics 3000 22:02:21 INFO - Type: GPU 22:02:21 INFO - Bus: Built-In 22:02:21 INFO - VRAM (Total): 512 MB 22:02:21 INFO - VRAM (Dynamic, Max): 10 22:02:21 INFO - Vendor: Intel (0x8086) 22:02:21 INFO - Device ID: 0x0116 22:02:21 INFO - Revision ID: 0x0009 22:02:21 INFO - Displays: 22:02:21 INFO - Display: 22:02:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:02:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:02:21 INFO - Display Serial Number: 1600x1200 60 22:02:21 INFO - Main Display: Yes 22:02:21 INFO - Mirror: Off 22:02:21 INFO - Online: Yes 22:02:21 INFO - Rotation: Supported 22:02:21 INFO - Return code: 0 22:02:21 INFO - Running post-action listener: _resource_record_post_action 22:02:21 INFO - Running post-run listener: _resource_record_post_run 22:02:23 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 40551424; Write bytes: 686644224; Read time: 5047; Write time: 45046 22:02:23 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 342680064; Write bytes: 346636288; Read time: 35434; Write time: 7354 22:02:23 INFO - run-tests - Wall time: 1219s; CPU: 30.0%; Read bytes: 39375872; Write bytes: 338164736; Read time: 4919; Write time: 37418 22:02:23 INFO - Running post-run listener: _upload_blobber_files 22:02:23 INFO - Blob upload gear active. 22:02:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:02:23 INFO - Copying logs to upload dir... 22:02:23 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1316.602757 ========= master_lag: 3.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2015-11-17 22:02:26.190922) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 22:02:26.194736) ========= 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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010169 build_url: 'https://queue.taskcluster.net/v1/task/FpNSGhOwTviVQkuLL0xYoQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 22:02:26.221250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:02:26.221587) ========= 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.hKJHjLHPnS/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.Z5DtIjiXga/Listeners TMPDIR=/var/folders/yn/jzplg3bs5gxfxzxx1xn4w0hr00000w/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.005109 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:02:26.271513) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 22:02:26.271856) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 22:02:26.272251) ========= ========= Total master_lag: 3.35 =========