builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0008 starttime: 1447957389.64 results: success (0) buildid: 20151119030404 builduid: 501e3dd1b6c343c983c59c1c7961f024 revision: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.644956) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.645418) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.645714) ========= 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.30tt3AY3oi/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.UgPiRvoUJs/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005711 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.667146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.667469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.683036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.683349) ========= 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.30tt3AY3oi/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.UgPiRvoUJs/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005400 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.731695) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.732019) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.732381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.732656) ========= 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.30tt3AY3oi/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.UgPiRvoUJs/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-19 10:23:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.62G=0s 2015-11-19 10:23:09 (1.62 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194993 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.941749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.942088) ========= 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.30tt3AY3oi/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.UgPiRvoUJs/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019705 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:09.991495) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-19 10:23:09.991914) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.30tt3AY3oi/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.UgPiRvoUJs/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-19 10:23:10,068 truncating revision to first 12 chars 2015-11-19 10:23:10,068 Setting DEBUG logging. 2015-11-19 10:23:10,068 attempt 1/10 2015-11-19 10:23:10,068 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d6155d7e6c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 10:23:12,240 unpacking tar archive at: mozilla-central-1d6155d7e6c9/testing/mozharness/ program finished with exit code 0 elapsedTime=2.417408 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-19 10:23:12.423412) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:12.423734) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:12.439596) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:12.439962) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 10:23:12.440406) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-19 10:23:12.440702) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.30tt3AY3oi/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.UgPiRvoUJs/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:23:12 INFO - MultiFileLogger online at 20151119 10:23:12 in /builds/slave/test 10:23:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:23:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:23:12 INFO - {'append_to_log': False, 10:23:12 INFO - 'base_work_dir': '/builds/slave/test', 10:23:12 INFO - 'blob_upload_branch': 'Firefox', 10:23:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:23:12 INFO - 'branch': 'Firefox', 10:23:12 INFO - 'buildbot_json_path': 'buildprops.json', 10:23:12 INFO - 'config_files': ('talos/mac_config.py',), 10:23:12 INFO - 'default_actions': ('clobber', 10:23:12 INFO - 'read-buildbot-config', 10:23:12 INFO - 'download-and-extract', 10:23:12 INFO - 'populate-webroot', 10:23:12 INFO - 'create-virtualenv', 10:23:12 INFO - 'install', 10:23:12 INFO - 'run-tests'), 10:23:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:23:12 INFO - 'download_minidump_stackwalk': True, 10:23:12 INFO - 'download_symbols': 'ondemand', 10:23:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:23:12 INFO - 'tooltool.py': '/tools/tooltool.py', 10:23:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:23:12 INFO - '/tools/misc-python/virtualenv.py')}, 10:23:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:23:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:23:12 INFO - 'installer_path': 'installer.exe', 10:23:12 INFO - 'log_level': 'info', 10:23:12 INFO - 'log_name': 'talos', 10:23:12 INFO - 'log_to_console': True, 10:23:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:23:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:23:12 INFO - 'opt_config_files': (), 10:23:12 INFO - 'pip_index': False, 10:23:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:23:12 INFO - 'cmd': ('bash', 10:23:12 INFO - '-c', 10:23:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:23:12 INFO - 'enabled': True, 10:23:12 INFO - 'halt_on_failure': False, 10:23:12 INFO - 'name': 'check_screen_resolution'},), 10:23:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:23:12 INFO - 'cmd': ('bash', 10:23:12 INFO - '-c', 10:23:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:23:12 INFO - 'enabled': True, 10:23:12 INFO - 'halt_on_failure': False, 10:23:12 INFO - 'name': 'check_screen_resolution'},), 10:23:12 INFO - 'run_cmd_checks_enabled': True, 10:23:12 INFO - 'sps_profile': False, 10:23:12 INFO - 'sps_profile_interval': 0, 10:23:12 INFO - 'suite': 'dromaeojs', 10:23:12 INFO - 'system_bits': '64', 10:23:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:23:12 INFO - 'title': 't-yosemite-r7-0008', 10:23:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:23:12 INFO - 'use_talos_json': True, 10:23:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:23:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:23:12 INFO - 'work_dir': 'build'} 10:23:12 INFO - ##### 10:23:12 INFO - ##### Running clobber step. 10:23:12 INFO - ##### 10:23:12 INFO - Running pre-action listener: _resource_record_pre_action 10:23:12 INFO - Running main action method: clobber 10:23:12 INFO - rmtree: /builds/slave/test/build 10:23:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:23:14 INFO - Running post-action listener: _resource_record_post_action 10:23:14 INFO - ##### 10:23:14 INFO - ##### Running read-buildbot-config step. 10:23:14 INFO - ##### 10:23:14 INFO - Running pre-action listener: _resource_record_pre_action 10:23:14 INFO - Running main action method: read_buildbot_config 10:23:14 INFO - Using buildbot properties: 10:23:14 INFO - { 10:23:14 INFO - "properties": { 10:23:14 INFO - "buildnumber": 0, 10:23:14 INFO - "product": "firefox", 10:23:14 INFO - "script_repo_revision": "production", 10:23:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:23:14 INFO - "repository": "", 10:23:14 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:23:14 INFO - "buildid": "20151119030404", 10:23:14 INFO - "slavename": "t-yosemite-r7-0008", 10:23:14 INFO - "stage_platform": "macosx64", 10:23:14 INFO - "basedir": "/builds/slave/test", 10:23:14 INFO - "nightly_build": "True", 10:23:14 INFO - "project": "", 10:23:14 INFO - "platform": "yosemite_r7", 10:23:14 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:23:14 INFO - "slavebuilddir": "test", 10:23:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:23:14 INFO - "branch": "mozilla-central", 10:23:14 INFO - "repo_path": "mozilla-central", 10:23:14 INFO - "pgo_build": "False", 10:23:14 INFO - "builduid": "501e3dd1b6c343c983c59c1c7961f024", 10:23:14 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 10:23:14 INFO - }, 10:23:14 INFO - "sourcestamp": { 10:23:14 INFO - "repository": "", 10:23:14 INFO - "hasPatch": false, 10:23:14 INFO - "project": "", 10:23:14 INFO - "branch": "mozilla-central-macosx64-talos", 10:23:14 INFO - "changes": [ 10:23:14 INFO - { 10:23:14 INFO - "category": null, 10:23:14 INFO - "files": [ 10:23:14 INFO - { 10:23:14 INFO - "url": null, 10:23:14 INFO - "name": "https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 10:23:14 INFO - } 10:23:14 INFO - ], 10:23:14 INFO - "repository": "", 10:23:14 INFO - "rev": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d", 10:23:14 INFO - "who": "sendchange", 10:23:14 INFO - "when": 1447956983, 10:23:14 INFO - "number": 6684099, 10:23:14 INFO - "comments": "", 10:23:14 INFO - "project": "", 10:23:14 INFO - "at": "Thu 19 Nov 2015 10:16:23", 10:23:14 INFO - "branch": "mozilla-central-macosx64-talos", 10:23:14 INFO - "revlink": "", 10:23:14 INFO - "properties": [ 10:23:14 INFO - [ 10:23:14 INFO - "buildid", 10:23:14 INFO - "20151119030404", 10:23:14 INFO - "Change" 10:23:14 INFO - ], 10:23:14 INFO - [ 10:23:14 INFO - "builduid", 10:23:14 INFO - "501e3dd1b6c343c983c59c1c7961f024", 10:23:14 INFO - "Change" 10:23:14 INFO - ], 10:23:14 INFO - [ 10:23:14 INFO - "nightly_build", 10:23:14 INFO - "True", 10:23:14 INFO - "Change" 10:23:14 INFO - ], 10:23:14 INFO - [ 10:23:14 INFO - "pgo_build", 10:23:14 INFO - "False", 10:23:14 INFO - "Change" 10:23:14 INFO - ] 10:23:14 INFO - ], 10:23:14 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 10:23:14 INFO - } 10:23:14 INFO - ], 10:23:14 INFO - "revision": "1d6155d7e6c91fa5ec1ef6927f3d3a044187896d" 10:23:14 INFO - } 10:23:14 INFO - } 10:23:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 10:23:14 INFO - Running post-action listener: _resource_record_post_action 10:23:14 INFO - ##### 10:23:14 INFO - ##### Running download-and-extract step. 10:23:14 INFO - ##### 10:23:14 INFO - Running pre-action listener: _resource_record_pre_action 10:23:14 INFO - Running main action method: download_and_extract 10:23:14 INFO - mkdir: /builds/slave/test/build/tests 10:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:14 INFO - https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:23:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/test_packages.json 10:23:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/test_packages.json 10:23:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:23:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:23:15 INFO - Downloaded 1149 bytes. 10:23:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:23:15 INFO - Using the following test package requirements: 10:23:15 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:23:15 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:23:15 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 10:23:15 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:23:15 INFO - u'jsshell-mac.zip'], 10:23:15 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:23:15 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 10:23:15 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:23:15 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:23:15 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 10:23:15 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:23:15 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 10:23:15 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:23:15 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 10:23:15 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:23:15 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:23:15 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 10:23:15 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:23:15 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')]} 10:23:15 INFO - https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:23:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:23:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:23:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/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 10:23:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/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 10:23:16 INFO - Downloaded 17463617 bytes. 10:23:16 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 10:23:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:23:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:23:19 INFO - Return code: 0 10:23:19 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 10:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:19 INFO - https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/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 10:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/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 10:23:21 INFO - Downloaded 17463617 bytes. 10:23:21 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 10:23:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:23:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:23:24 INFO - Return code: 0 10:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:24 INFO - https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:23:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:23:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:23:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/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 10:23:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/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 10:23:25 INFO - Downloaded 11130997 bytes. 10:23:25 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 10:23:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:23:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 10:23:25 INFO - Return code: 0 10:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:25 INFO - https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:23:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:23:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:23:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 10:23:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NF4A1vizQeagsEkkYpMCRw/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 10:23:28 INFO - Downloaded 108956076 bytes. 10:23:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:23:28 INFO - mkdir: /builds/slave/test/properties 10:23:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:23:28 INFO - Writing to file /builds/slave/test/properties/build_url 10:23:28 INFO - Contents: 10:23:28 INFO - build_url:https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:23:28 INFO - Running post-action listener: _resource_record_post_action 10:23:28 INFO - Running post-action listener: set_extra_try_arguments 10:23:28 INFO - ##### 10:23:28 INFO - ##### Running populate-webroot step. 10:23:28 INFO - ##### 10:23:28 INFO - Running pre-action listener: _resource_record_pre_action 10:23:28 INFO - Running main action method: populate_webroot 10:23:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:23:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:23:28 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:23:28 INFO - '../fennec_ids.txt'], 10:23:28 INFO - 'tests': ['tcheck2']}, 10:23:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:23:28 INFO - '--tppagecycles', 10:23:28 INFO - '7'], 10:23:28 INFO - 'tests': ['tsvgm']}}, 10:23:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:23:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:23:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:23:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:23:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:23:28 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:23:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:23:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:28 INFO - 'talos_options': ['--e10s'], 10:23:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:23:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:28 INFO - 'tests': ['damp', 'tps']}, 10:23:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:28 INFO - 'talos_options': ['--e10s'], 10:23:28 INFO - 'tests': ['damp', 'tps']}, 10:23:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:23:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:23:28 INFO - 'other': {'tests': ['a11yr', 10:23:28 INFO - 'ts_paint', 10:23:28 INFO - 'tpaint', 10:23:28 INFO - 'sessionrestore', 10:23:28 INFO - 'sessionrestore_no_auto_restore']}, 10:23:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:23:28 INFO - 'tests': ['a11yr', 10:23:28 INFO - 'ts_paint', 10:23:28 INFO - 'tpaint', 10:23:28 INFO - 'sessionrestore', 10:23:28 INFO - 'sessionrestore_no_auto_restore']}, 10:23:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:23:28 INFO - 'tests': ['a11yr', 10:23:28 INFO - 'ts_paint', 10:23:28 INFO - 'tpaint', 10:23:28 INFO - 'sessionrestore', 10:23:28 INFO - 'sessionrestore_no_auto_restore']}, 10:23:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:23:28 INFO - 'tests': ['a11yr', 10:23:28 INFO - 'ts_paint', 10:23:28 INFO - 'tpaint', 10:23:28 INFO - 'sessionrestore', 10:23:28 INFO - 'sessionrestore_no_auto_restore']}, 10:23:28 INFO - 'other_l64': {'tests': ['a11yr', 10:23:28 INFO - 'ts_paint', 10:23:28 INFO - 'tpaint', 10:23:28 INFO - 'sessionrestore', 10:23:28 INFO - 'sessionrestore_no_auto_restore']}, 10:23:28 INFO - 'other_nol64': {'tests': ['a11yr', 10:23:28 INFO - 'ts_paint', 10:23:28 INFO - 'tpaint', 10:23:28 INFO - 'sessionrestore', 10:23:28 INFO - 'sessionrestore_no_auto_restore']}, 10:23:28 INFO - 'svgr': {'tests': ['tsvgx', 10:23:28 INFO - 'tsvgr_opacity', 10:23:28 INFO - 'tart', 10:23:28 INFO - 'tscrollx', 10:23:28 INFO - 'cart']}, 10:23:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:23:28 INFO - 'tests': ['tsvgx', 10:23:28 INFO - 'tsvgr_opacity', 10:23:28 INFO - 'tart', 10:23:28 INFO - 'tscrollx', 10:23:28 INFO - 'cart']}, 10:23:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:28 INFO - 'tests': ['tp5o']}, 10:23:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:28 INFO - 'talos_options': ['--e10s'], 10:23:28 INFO - 'tests': ['tp5o']}, 10:23:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:28 INFO - 'talos_options': ['--xperf_path', 10:23:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:23:28 INFO - 'tests': ['tp5n']}, 10:23:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:23:28 INFO - 'talos_options': ['--e10s', 10:23:28 INFO - '--xperf_path', 10:23:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:23:28 INFO - 'tests': ['tp5n']}}, 10:23:28 INFO - 'talos.zip': {'path': '', 10:23:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:23:28 INFO - Running post-action listener: _resource_record_post_action 10:23:28 INFO - ##### 10:23:28 INFO - ##### Running create-virtualenv step. 10:23:28 INFO - ##### 10:23:28 INFO - Running pre-action listener: _resource_record_pre_action 10:23:28 INFO - Running main action method: create_virtualenv 10:23:28 INFO - Creating virtualenv /builds/slave/test/build/venv 10:23:28 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 10:23:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:23:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:23:28 INFO - Using real prefix '/tools/python27' 10:23:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:23:29 INFO - Installing distribute.............................................................................................................................................................................................done. 10:23:32 INFO - Installing pip.................done. 10:23:32 INFO - Return code: 0 10:23:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:32 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 0x105443490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105420228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffea149a420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053679f0>, '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 0x1050c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10535a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/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.UgPiRvoUJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:23:32 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 10:23:32 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 10:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/Render', 10:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:32 INFO - 'HOME': '/Users/cltbld', 10:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:32 INFO - 'LOGNAME': 'cltbld', 10:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:32 INFO - 'MOZ_NO_REMOTE': '1', 10:23:32 INFO - 'NO_EM_RESTART': '1', 10:23:32 INFO - 'PAGER': '/bin/cat', 10:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:32 INFO - 'PWD': '/builds/slave/test', 10:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:32 INFO - 'SHELL': '/bin/bash', 10:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgPiRvoUJs/Listeners', 10:23:32 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:32 INFO - 'USER': 'cltbld', 10:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:32 INFO - 'XPC_FLAGS': '0x0', 10:23:32 INFO - 'XPC_SERVICE_NAME': '0', 10:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:32 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 10:23:32 INFO - Cleaning up... 10:23:32 INFO - Return code: 0 10:23:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:32 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 0x105443490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105420228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffea149a420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053679f0>, '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 0x1050c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10535a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/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.UgPiRvoUJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:23:32 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 10:23:32 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 10:23:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/Render', 10:23:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:32 INFO - 'HOME': '/Users/cltbld', 10:23:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:32 INFO - 'LOGNAME': 'cltbld', 10:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:32 INFO - 'MOZ_NO_REMOTE': '1', 10:23:32 INFO - 'NO_EM_RESTART': '1', 10:23:32 INFO - 'PAGER': '/bin/cat', 10:23:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:32 INFO - 'PWD': '/builds/slave/test', 10:23:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:32 INFO - 'SHELL': '/bin/bash', 10:23:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgPiRvoUJs/Listeners', 10:23:32 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:23:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:32 INFO - 'USER': 'cltbld', 10:23:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:32 INFO - 'XPC_FLAGS': '0x0', 10:23:32 INFO - 'XPC_SERVICE_NAME': '0', 10:23:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:32 INFO - Downloading/unpacking psutil>=0.7.1 10:23:32 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 10:23:32 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 10:23:32 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 10:23:32 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 10:23:32 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 10:23:32 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 10:23:35 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:23:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:23:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:23:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:23:35 INFO - Installing collected packages: psutil 10:23:35 INFO - Running setup.py install for psutil 10:23:35 INFO - building 'psutil._psutil_osx' extension 10:23:35 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 10:23:35 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 10:23:35 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 10:23:35 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 10:23:35 INFO - building 'psutil._psutil_posix' extension 10:23:35 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 10:23:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:23:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:23:35 INFO - ^ 10:23:35 INFO - 1 warning generated. 10:23:35 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 10:23:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:23:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:23:36 INFO - Successfully installed psutil 10:23:36 INFO - Cleaning up... 10:23:36 INFO - Return code: 0 10:23:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:23:36 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')]} 10:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:36 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')]} 10:23:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:36 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 0x105443490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105420228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffea149a420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053679f0>, '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 0x1050c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10535a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/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.UgPiRvoUJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:23:36 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 10:23:36 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 10:23:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/Render', 10:23:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:36 INFO - 'HOME': '/Users/cltbld', 10:23:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:36 INFO - 'LOGNAME': 'cltbld', 10:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:36 INFO - 'MOZ_NO_REMOTE': '1', 10:23:36 INFO - 'NO_EM_RESTART': '1', 10:23:36 INFO - 'PAGER': '/bin/cat', 10:23:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:36 INFO - 'PWD': '/builds/slave/test', 10:23:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:36 INFO - 'SHELL': '/bin/bash', 10:23:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgPiRvoUJs/Listeners', 10:23:36 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:23:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:36 INFO - 'USER': 'cltbld', 10:23:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:36 INFO - 'XPC_FLAGS': '0x0', 10:23:36 INFO - 'XPC_SERVICE_NAME': '0', 10:23:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:23:36 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 10:23:36 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 10:23:36 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 10:23:36 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 10:23:36 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 10:23:36 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 10:23:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:23:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:23:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:23:38 INFO - Installing collected packages: mozsystemmonitor 10:23:38 INFO - Running setup.py install for mozsystemmonitor 10:23:38 INFO - Successfully installed mozsystemmonitor 10:23:38 INFO - Cleaning up... 10:23:38 INFO - Return code: 0 10:23:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:38 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 0x105443490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105420228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffea149a420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053679f0>, '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 0x1050c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10535a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/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.UgPiRvoUJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:23:38 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 10:23:38 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 10:23:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/Render', 10:23:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:38 INFO - 'HOME': '/Users/cltbld', 10:23:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:38 INFO - 'LOGNAME': 'cltbld', 10:23:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:38 INFO - 'MOZ_NO_REMOTE': '1', 10:23:38 INFO - 'NO_EM_RESTART': '1', 10:23:38 INFO - 'PAGER': '/bin/cat', 10:23:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:38 INFO - 'PWD': '/builds/slave/test', 10:23:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:38 INFO - 'SHELL': '/bin/bash', 10:23:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgPiRvoUJs/Listeners', 10:23:38 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:23:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:38 INFO - 'USER': 'cltbld', 10:23:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:38 INFO - 'XPC_FLAGS': '0x0', 10:23:38 INFO - 'XPC_SERVICE_NAME': '0', 10:23:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:39 INFO - Downloading/unpacking blobuploader==1.2.4 10:23:39 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 10:23:39 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 10:23:39 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 10:23:39 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 10:23:39 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 10:23:39 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 10:23:41 INFO - Downloading blobuploader-1.2.4.tar.gz 10:23:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:23:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:23:41 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 10:23:41 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 10:23:41 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 10:23:41 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 10:23:41 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 10:23:41 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 10:23:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:23:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:23:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:23:41 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 10:23:41 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 10:23:41 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 10:23:41 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 10:23:41 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 10:23:41 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 10:23:42 INFO - Downloading docopt-0.6.1.tar.gz 10:23:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:23:42 INFO - Installing collected packages: blobuploader, requests, docopt 10:23:42 INFO - Running setup.py install for blobuploader 10:23:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:23:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:23:42 INFO - Running setup.py install for requests 10:23:43 INFO - Running setup.py install for docopt 10:23:43 INFO - Successfully installed blobuploader requests docopt 10:23:43 INFO - Cleaning up... 10:23:43 INFO - Return code: 0 10:23:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:43 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 0x105443490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105420228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffea149a420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053679f0>, '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 0x1050c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10535a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/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.UgPiRvoUJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:23:43 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 10:23:43 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 10:23:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/Render', 10:23:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:43 INFO - 'HOME': '/Users/cltbld', 10:23:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:43 INFO - 'LOGNAME': 'cltbld', 10:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:43 INFO - 'MOZ_NO_REMOTE': '1', 10:23:43 INFO - 'NO_EM_RESTART': '1', 10:23:43 INFO - 'PAGER': '/bin/cat', 10:23:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:43 INFO - 'PWD': '/builds/slave/test', 10:23:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:43 INFO - 'SHELL': '/bin/bash', 10:23:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgPiRvoUJs/Listeners', 10:23:43 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:23:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:43 INFO - 'USER': 'cltbld', 10:23:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:43 INFO - 'XPC_FLAGS': '0x0', 10:23:43 INFO - 'XPC_SERVICE_NAME': '0', 10:23:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:23:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-i8ceFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:23:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-OnJqeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:23:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-0JjaRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:23:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-znHLM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:23:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:23:43 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-UINMgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:23:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-haILSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:23:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-KAUPYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:23:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-7IOHJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:23:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-QifTWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:23:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-cLEQof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:23:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-gZ3j9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:23:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Tgz0gS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:23:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-12QJMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:23:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-NUOBA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:23:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:44 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-s5TNAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:23:45 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-N6Cylf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:23:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:23:45 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-OS2kxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:23:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:23:45 INFO - Running setup.py install for manifestparser 10:23:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:23:45 INFO - Running setup.py install for mozcrash 10:23:45 INFO - Running setup.py install for mozdebug 10:23:45 INFO - Running setup.py install for mozdevice 10:23:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:23:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:23:45 INFO - Running setup.py install for mozfile 10:23:46 INFO - Running setup.py install for mozhttpd 10:23:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:23:46 INFO - Running setup.py install for mozinfo 10:23:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:23:46 INFO - Running setup.py install for mozInstall 10:23:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:23:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:23:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:23:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:23:46 INFO - Running setup.py install for mozleak 10:23:46 INFO - Running setup.py install for mozlog 10:23:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:23:46 INFO - Running setup.py install for moznetwork 10:23:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:23:46 INFO - Running setup.py install for mozprocess 10:23:47 INFO - Running setup.py install for mozprofile 10:23:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:23:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:23:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:23:47 INFO - Running setup.py install for mozrunner 10:23:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:23:47 INFO - Running setup.py install for mozscreenshot 10:23:47 INFO - Running setup.py install for moztest 10:23:47 INFO - Running setup.py install for mozversion 10:23:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:23:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:23:47 INFO - Cleaning up... 10:23:47 INFO - Return code: 0 10:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23: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')]} 10:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23: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')]} 10:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:47 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 0x105443490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105420228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffea149a420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053679f0>, '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 0x1050c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10535a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/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.UgPiRvoUJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:23:47 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 10:23:47 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 10:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/Render', 10:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:47 INFO - 'HOME': '/Users/cltbld', 10:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:47 INFO - 'LOGNAME': 'cltbld', 10:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:47 INFO - 'MOZ_NO_REMOTE': '1', 10:23:47 INFO - 'NO_EM_RESTART': '1', 10:23:47 INFO - 'PAGER': '/bin/cat', 10:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:47 INFO - 'PWD': '/builds/slave/test', 10:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:47 INFO - 'SHELL': '/bin/bash', 10:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgPiRvoUJs/Listeners', 10:23:47 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:47 INFO - 'USER': 'cltbld', 10:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:47 INFO - 'XPC_FLAGS': '0x0', 10:23:47 INFO - 'XPC_SERVICE_NAME': '0', 10:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:23:48 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-qkmh16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:23:48 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)) 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:23:48 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-gNrRCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:23:48 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)) 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:23:48 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ocwNRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:23:48 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)) 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:23:48 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-e0S1bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:23:48 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)) 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:23:48 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-tbPxyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:23:48 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)) 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:23:48 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-VCcdJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:23:48 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)) 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:23:48 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-j4JQc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:23:48 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)) 10:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:23:48 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-eBTJq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:23:49 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)) 10:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:23:49 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-xdEilX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:23:49 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)) 10:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:23:49 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-wem8Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:23:49 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)) 10:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:23:49 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-X_Fi95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:23:49 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)) 10:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:23:49 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-3V8wh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:23:49 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)) 10:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:23:49 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-CfcjQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:23:49 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)) 10:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:23:49 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-14dG4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:23:49 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)) 10:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:49 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-hKdLNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:23:49 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)) 10:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:23:49 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-XFtx0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:23:49 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)) 10:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:23:49 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-gY5jYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:23:50 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)) 10:23:50 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)) 10:23:50 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)) 10:23:50 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)) 10:23:50 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)) 10:23:50 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)) 10:23:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:23:50 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 10:23:50 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 10:23:50 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 10:23:50 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 10:23:50 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 10:23:50 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 10:23:52 INFO - Downloading blessings-1.5.1.tar.gz 10:23:52 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 10:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:23:52 INFO - Installing collected packages: blessings 10:23:52 INFO - Running setup.py install for blessings 10:23:52 INFO - Successfully installed blessings 10:23:52 INFO - Cleaning up... 10:23:52 INFO - Return code: 0 10:23:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:23:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:23:52 INFO - Reading from file tmpfile_stdout 10:23:52 INFO - Current package versions: 10:23:52 INFO - blessings == 1.5.1 10:23:52 INFO - blobuploader == 1.2.4 10:23:52 INFO - docopt == 0.6.1 10:23:52 INFO - manifestparser == 1.1 10:23:52 INFO - mozInstall == 1.12 10:23:52 INFO - mozcrash == 0.16 10:23:52 INFO - mozdebug == 0.1 10:23:52 INFO - mozdevice == 0.47 10:23:52 INFO - mozfile == 1.2 10:23:52 INFO - mozhttpd == 0.7 10:23:52 INFO - mozinfo == 0.9 10:23:52 INFO - mozleak == 0.1 10:23:52 INFO - mozlog == 3.0 10:23:52 INFO - moznetwork == 0.27 10:23:52 INFO - mozprocess == 0.22 10:23:52 INFO - mozprofile == 0.27 10:23:52 INFO - mozrunner == 6.11 10:23:52 INFO - mozscreenshot == 0.1 10:23:52 INFO - mozsystemmonitor == 0.0 10:23:52 INFO - moztest == 0.7 10:23:52 INFO - mozversion == 1.4 10:23:52 INFO - psutil == 3.1.1 10:23:52 INFO - requests == 1.2.3 10:23:52 INFO - wsgiref == 0.1.2 10:23:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:23:52 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 0x105443490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105420228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffea149a420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053679f0>, '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 0x1050c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10535a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/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.UgPiRvoUJs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:23:52 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 10:23:52 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 10:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/Render', 10:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:23:52 INFO - 'HOME': '/Users/cltbld', 10:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:23:52 INFO - 'LOGNAME': 'cltbld', 10:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:23:52 INFO - 'MOZ_NO_REMOTE': '1', 10:23:52 INFO - 'NO_EM_RESTART': '1', 10:23:52 INFO - 'PAGER': '/bin/cat', 10:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:23:52 INFO - 'PWD': '/builds/slave/test', 10:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:23:52 INFO - 'SHELL': '/bin/bash', 10:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgPiRvoUJs/Listeners', 10:23:52 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:23:52 INFO - 'USER': 'cltbld', 10:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:23:52 INFO - 'XPC_FLAGS': '0x0', 10:23:52 INFO - 'XPC_SERVICE_NAME': '0', 10:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:23:53 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)) 10:23:53 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)) 10:23:53 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)) 10:23:53 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)) 10:23:53 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)) 10:23:53 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)) 10:23:53 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)) 10:23:53 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)) 10:23:53 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)) 10:23:53 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)) 10:23:53 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)) 10:23:53 INFO - Cleaning up... 10:23:53 INFO - Return code: 0 10:23:53 INFO - Running post-action listener: _resource_record_post_action 10:23:53 INFO - Running post-action listener: _start_resource_monitoring 10:23:53 INFO - Starting resource monitoring. 10:23:53 INFO - ##### 10:23:53 INFO - ##### Running install step. 10:23:53 INFO - ##### 10:23:53 INFO - Running pre-action listener: _resource_record_pre_action 10:23:53 INFO - Running main action method: install 10:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:23:53 INFO - Reading from file tmpfile_stdout 10:23:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:23:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:23:53 INFO - Reading from file tmpfile_stdout 10:23:53 INFO - Output received: 10:23:53 INFO - Usage: mozinstall [options] installer 10:23:53 INFO - Options: 10:23:53 INFO - -h, --help show this help message and exit 10:23:53 INFO - -d DEST, --destination=DEST 10:23:53 INFO - Directory to install application into. [default: 10:23:53 INFO - "/builds/slave/test"] 10:23:53 INFO - --app=APP Application being installed. [default: firefox] 10:23:53 INFO - mkdir: /builds/slave/test/build/application 10:23:53 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'] 10:23:53 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 10:24:23 INFO - Reading from file tmpfile_stdout 10:24:23 INFO - Output received: 10:24:23 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 10:24:23 INFO - Running post-action listener: _resource_record_post_action 10:24:23 INFO - ##### 10:24:23 INFO - ##### Running run-tests step. 10:24:23 INFO - ##### 10:24:23 INFO - Running pre-action listener: _resource_record_pre_action 10:24:23 INFO - Running main action method: run_tests 10:24:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:24:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:24:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:24:23 INFO - 2015-11-19 10:24:23.567 screenresolution[2571:26019] starting screenresolution argv=screenresolution get 10:24:23 INFO - 2015-11-19 10:24:23.569 screenresolution[2571:26019] Display 0: 1600x1200x32@60 10:24:23 INFO - 2015-11-19 10:24:23.575 screenresolution[2572:26021] starting screenresolution argv=screenresolution list 10:24:23 INFO - Available Modes on Display 0 10:24:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:24:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:24:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:24:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:24:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:24:23 INFO - Intel Iris: 10:24:23 INFO - Chipset Model: Intel Iris 10:24:23 INFO - Type: GPU 10:24:23 INFO - Bus: Built-In 10:24:23 INFO - VRAM (Dynamic, Max): 1536 MB 10:24:23 INFO - Vendor: Intel (0x8086) 10:24:23 INFO - Device ID: 0x0a2e 10:24:23 INFO - Revision ID: 0x0009 10:24:23 INFO - Displays: 10:24:23 INFO - Display: 10:24:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:24:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:24:23 INFO - Display Serial Number: 1600x1200 60 10:24:23 INFO - Main Display: Yes 10:24:23 INFO - Mirror: Off 10:24:23 INFO - Online: Yes 10:24:23 INFO - Rotation: Supported 10:24:23 INFO - Return code: 0 10:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:24:23 INFO - Python 2.7.3 10:24:23 INFO - Return code: 0 10:24:23 INFO - grabbing minidump binary from tooltool 10:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:24:23 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 0x1053679f0>, '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 0x1050c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10535a8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:24:23 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 10:24:23 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 10:24:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:24:23 INFO - Return code: 0 10:24:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:24:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:24:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:24:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:24:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost'] in /builds/slave/test/build 10:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0008 --webServer localhost 10:24:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.30tt3AY3oi/Render', 10:24:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:24:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:24:23 INFO - 'HOME': '/Users/cltbld', 10:24:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:24:23 INFO - 'LOGNAME': 'cltbld', 10:24:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:24:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:24:23 INFO - 'MOZ_NO_REMOTE': '1', 10:24:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:24:23 INFO - 'NO_EM_RESTART': '1', 10:24:23 INFO - 'PAGER': '/bin/cat', 10:24:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:24:23 INFO - 'PWD': '/builds/slave/test', 10:24:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:24:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:24:23 INFO - 'SHELL': '/bin/bash', 10:24:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgPiRvoUJs/Listeners', 10:24:23 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 10:24:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:24:23 INFO - 'USER': 'cltbld', 10:24:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:24:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:24:23 INFO - 'XPC_FLAGS': '0x0', 10:24:23 INFO - 'XPC_SERVICE_NAME': '0', 10:24:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:24:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost'] with output_timeout 3600 10:24:24 INFO - mozversion INFO | application_buildid: 20151119030404 10:24:24 INFO - mozversion INFO | application_changeset: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d 10:24:24 INFO - mozversion INFO | application_display_name: Nightly 10:24:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:24:24 INFO - mozversion INFO | application_name: Firefox 10:24:24 INFO - mozversion INFO | application_remotingname: firefox 10:24:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 10:24:24 INFO - mozversion INFO | application_vendor: Mozilla 10:24:24 INFO - mozversion INFO | application_version: 45.0a1 10:24:24 INFO - mozversion INFO | platform_buildid: 20151119030404 10:24:24 INFO - mozversion INFO | platform_changeset: 1d6155d7e6c91fa5ec1ef6927f3d3a044187896d 10:24:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 10:24:24 INFO - mozversion INFO | platform_version: 45.0a1 10:24:24 INFO - 2015-11-19 10:24:24,128 DEBUG : using testdate: 1447957464 10:24:24 INFO - 2015-11-19 10:24:24,128 DEBUG : actual date: 1447957464 10:24:24 INFO - 2015-11-19 10:24:24,474 INFO : starting webserver on 'localhost:57223' 10:24:24 INFO - 2015-11-19 10:24:24,475 INFO : Starting test suite t-yosemite-r7-0008 10:24:24 INFO - 2015-11-19 10:24:24,475 INFO : Starting test dromaeo_css 10:24:24 INFO - 2015-11-19 10:24:24,475 DEBUG : operating with platform_type : mac_ 10:24:24 INFO - 2015-11-19 10:24:24,476 INFO : Initialising browser for dromaeo_css test... 10:24:24 INFO - 2015-11-19 10:24:24,488 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpCjN0Gu/profile http://localhost:57223/getInfo.html 10:24:26 INFO - 2015-11-19 10:24:26,830 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:24:26 INFO - 2015-11-19 10:24:26,830 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:24:26 INFO - 2015-11-19 10:24:26,830 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:24:26 INFO - 2015-11-19 10:24:26,830 DEBUG : BROWSER_OUTPUT: __metrics 10:24:26 INFO - 2015-11-19 10:24:26,846 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:24:27 INFO - 2015-11-19 10:24:27,111 DEBUG : BROWSER_OUTPUT: console.error: 10:24:27 INFO - 2015-11-19 10:24:27,114 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 10:24:27 INFO - 2015-11-19 10:24:27,114 DEBUG : BROWSER_OUTPUT: Stack: 10:24:27 INFO - 2015-11-19 10:24:27,114 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 10:24:27 INFO - 2015-11-19 10:24:27,115 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 10:24:27 INFO - 2015-11-19 10:24:27,115 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 10:24:27 INFO - 2015-11-19 10:24:27,115 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 10:24:27 INFO - 2015-11-19 10:24:27,115 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 10:24:27 INFO - 2015-11-19 10:24:27,115 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 10:24:27 INFO - 2015-11-19 10:24:27,115 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:24:27 INFO - 2015-11-19 10:24:27,115 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 10:24:27 INFO - 2015-11-19 10:24:27,115 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:24:27 INFO - 2015-11-19 10:24:27,115 DEBUG : BROWSER_OUTPUT: 10:24:27 INFO - 2015-11-19 10:24:27,479 INFO : Browser initialized. 10:24:27 INFO - 2015-11-19 10:24:27,480 INFO : Running cycle 1/1 for dromaeo_css test... 10:24:27 INFO - 2015-11-19 10:24:27,480 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpCjN0Gu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:24:39 INFO - 2015-11-19 10:24:39,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 226291712 10:24:39 INFO - 2015-11-19 10:24:39,390 DEBUG : BROWSER_OUTPUT: 10:25:36 INFO - 2015-11-19 10:25:36,400 DEBUG : BROWSER_OUTPUT: 1447957536397 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] 10:27:41 INFO - 2015-11-19 10:27:41,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57223/tests/dromaeo/cssquery-ext.html) 10:27:42 INFO - 2015-11-19 10:27:42,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 346681344 10:27:42 INFO - 2015-11-19 10:27:42,744 DEBUG : BROWSER_OUTPUT: 10:30:45 INFO - 2015-11-19 10:30:45,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/dromaeo/cssquery-ext.html (next: http://localhost:57223/tests/dromaeo/cssquery-jquery.html) 10:30:46 INFO - 2015-11-19 10:30:46,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 370184192 10:30:46 INFO - 2015-11-19 10:30:46,085 DEBUG : BROWSER_OUTPUT: 10:33:48 INFO - 2015-11-19 10:33:48,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57223/tests/dromaeo/cssquery-mootools.html) 10:33:48 INFO - 2015-11-19 10:33:48,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 345587712 10:33:48 INFO - 2015-11-19 10:33:48,869 DEBUG : BROWSER_OUTPUT: 10:36:50 INFO - 2015-11-19 10:36:50,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57223/tests/dromaeo/cssquery-prototype.html) 10:36:51 INFO - 2015-11-19 10:36:51,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 320090112 10:36:51 INFO - 2015-11-19 10:36:51,522 DEBUG : BROWSER_OUTPUT: 10:39:54 INFO - 2015-11-19 10:39:54,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57223/tests/dromaeo/cssquery-yui.html) 10:39:55 INFO - 2015-11-19 10:39:55,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 321142784 10:39:55 INFO - 2015-11-19 10:39:55,315 DEBUG : BROWSER_OUTPUT: 10:42:57 INFO - 2015-11-19 10:42:57,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/dromaeo/cssquery-yui.html (next: http://localhost:57223/tests/dromaeo/cssquery-dojo.html) 10:42:58 INFO - 2015-11-19 10:42:58,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 375934976 10:42:58 INFO - 2015-11-19 10:42:58,163 DEBUG : BROWSER_OUTPUT: 10:42:58 INFO - 2015-11-19 10:42:58,163 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:42:58 INFO - 2015-11-19 10:42:58,163 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:42:58 INFO - 2015-11-19 10:42:58,163 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:42:58 INFO - 2015-11-19 10:42:58,163 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:42:58 INFO - 2015-11-19 10:42:58,165 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3420.4527275635896;3492.1269682579355;3519.243362677024;3520.0847779577316;3545.929081418372;5707.3721890592005;5845.0647896336595;5907.6750778707155;5979.970100149499;5992.850178745528;4798.472168061519;5907.970460147693;5916.674582897949;5940.702964851762;5952.136940143688;5363.168708850125;5382.4886635769735;5450.373207081197;5466.972665136669;5478.972605136969;5482.945170548303;5485.286912701344;5488.1493368527945;5493.176023596453;5496.6701997880255;5471.8084867029465;5477.233187353754;5480.808171713991;5482.616216864821;5484.204790305424;5472.534834539069;5481.945180548223;5482.369527504348;5482.862928426782;5492.835214943558;5312.07038768214;5397.136458166714;5419.647722897999;5422.8373148805595;5442.619016668835;5920.052791553374;6021.2473440819895;6034.788782392639;6038.154658347835;6042.214512113441;6343.018781172841;6359.491240700733;6366.586171898812;6390.265119511269;6396.0725694774;6239.438450539428;6257.342978987232;6366.77716279928;6367.808965731036;6384.042393640944;6061.151438798572;6080.2399700037495;6113.724882380215;6117.327094019654;6119.908201376983;5087.949120508822;6486.67566621667;6507.837304067341;6516.837079072966;6536.24833144185;6134.467201660938;6169.043798211284;6224.751009959641;6250.74997000124;6272.6236425814595;6379.393957574023;6382.489400847921;6383.234011918599;6398.2641996170105;6414.102025716404;6402.103705481236;6402.263739669905;6403.3276505966205;6415.807525774234;6416.358364163546;6231.532635052389;6245.781397651061;6326.652034138075;6352.745890164434;6399.55203135776;5078.822241221539;5080.314157588752;5087.542121209109;5093;5099.133147364957;4538.455385353779;4551.226291530448;4561.521040290788;4566.817327306937;4605.723656580616;5829.5044921181325;5966.910496342558;5968.820935371946;5982.820515384546;6085.391460853968;6385.042243663488;6396.648184349905;6397.552171347961;6400.615963042233;6414.61512309263;6013.639181649115;6033.276006879202;6035.939640603538;6044.576879618385;6054.091886217103;5377.220303056113;5482.396936337;5483.232347471358;5487.149491828773;5488.396276409591;6402.519811014099;6424.10062591247;6437.645929473924;6443.226812782496;6446.419822216023;6272.780452684134;6386.489080873612;6386.744530218739;6402.231732192166;6420.357964203542;6496.090547323284;6516.185476815398;6521.673916304071;6523.086767852599;6534.150560427304;6222.968885155546;6391.93608063932;6391.93608063932;6393.552451328363;6418.390252925965;6247.937850565506;6263.6241825490615;6357.554971151975;6396.200474940632;6409.679516024087;6263.498920086291;6268.059791031199;6287.962486189727;6296.024116261987;6297.370262973666;6077.665728384981;6137.954115196617;6147.600405973598;6276.592021518587;6283.120363149072;6049.969750151397;6100.176476175659;6140;6151.384861513991;6153.046277826944;5214;6275.058741188858;6275.968620157053;6291;6309.022101574264;5984.102384642339;6096.817095487142;6180.845478863064;6182.907256391248;6194.752209911733 10:42:58 INFO - 2015-11-19 10:42:58,166 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.4230671255251;559.8600349912521;577.0536320434486;583.2359608912323;612.9816105516835;31905.361892762132;32147.51778723318;32170.03489895301;39097.8045109774;40372.99067523314;43406.565934340644;43587.564124358745;43852;43899;43902.90242743933;9667.806643867101;9861.852072218922;9868.45723485208;9869.358491698016;9883.357581757198;9661.710148695514;9788.90211097887;9797.853032204523;9797.902020979805;9818.018198180196;9687.5640596173;9745.025497450233;9767.267454940873;9769.658061967797;9783.657571984982;9630.566624501915;9737.026297370277;9743.220542356594;9745.366551174151;9747.268954828382;9598.616055357777;9717.90282097177;9747.317687761859;9750.366226195274;9761.170300524464;39830.40254396186;40101.799491002355;40222.396664050066;40287.39568906469;40314.58898938553;2735.3161709572605;3284.5237440571223;3293.9953314239146;3347.397468455677;3418.7948723076697;28430;28519.287017824514;28791;29887.551686724717;30042.24894377636;2595.662563866704;2629.907953221628;2645.8809353579136;2673.1980405878353;2735.974009746345;507041;507609;508490;508616;511201;56375.43624563784;57117.714411427674;57500.27499175032;64598;66442.33894152589;64947.35052649413;65465.672671636334;65670.67164664147;65774.34225657777;65774.67112664405;16305;16520.173991300388;16536.173191340386;16553.66892662164;16557.337706491606;11929.880701193051;12091.27452352844;12092.576759813364;12181.634550963485;12652.240865548096;16416.589585260463;17922.462326130237;20633.96830158486;21346;21437.67843482349;8763.605637746317;8937.955310223408;8955;8961.327900407496;9030.63877444895;938.5401153434768;963.1187463470985;987.7678745494803;1103.4648195625116;1119.47944205943;25175.62236566453;27896.721032789817;28383.864645414364;28511;28540.429191416057;1083.3824719909576;1091.5579190427889;1162.0297051961538;1179.2865316483576;1182.2492717124517;13889.097208681605;14749.598788115112;14791.112533248039;14825.627581824054;14860.03409778361;503072;556501;557658;558701;561022;49691.50308496941;57770;57938.420615794144;58109.418905811246;58220.4177958215;1126.284809146198;1305.4712841299288;1446.3346860444312;1450.173401161349;1456.431991523328;29158.854205728836;33042.66957330396;33432.1641958953;33557.49663755095;33724;48623.02753944972;49749.502504975935;56411.43588564062;57294.713526432104;58299.4170058294;500242;504929;508377;509624;510772;45275.77362113168;45531.08937821159;45881.77059114683;46356.30465542952;46549.3017604743;46635.76682116568;47448;47464;49134.262986055954;49259.75370123127;38808.6119138805;40013.39979900246;41708;43345.78327108344;43734.56265437305;36917.077073073386;40571.78284651465;42451.575484244764;43578.69263922088;43694.344584830615;39155.6084439152;39610.60389396069;40506.594934050285;40526.39210411787;40659;38729.6127038726;39246.803765980985;39434.40848387219;40361.798191010035;40557.797211013756;26417.867910660323;26677.599836002086;26933.59599605968;26957.191284261502;27088.768313610224 10:42:58 INFO - 2015-11-19 10:42:58,169 DEBUG : BROWSER_OUTPUT: |2;jquery.html;303.8070825026108;304.72574682785495;356.9072041269269;357.0555879698197;367.49836473214054;13756.862431375683;16181.867269291155;19507.219711211554;19893.801061989376;21033.894830525864;16916.238769255382;18587.721184182214;19375.612487750237;21176.364709058715;21811.127554897826;5041.647084704072;5157.974210128963;6037.396260373971;6215.595986260902;6219.471344935686;3607.7474576779637;3701.222743223926;3705.4256590228424;5104.545204616685;5153.149730294497;5019;5108.565771909392;5122.410922743895;5127.179651255799;5131.923021154667;4349.608535231844;4985.302057711905;5071.923921141186;5108.948910510903;5116.1814109742445;4280.272353699878;4294.377315289296;4295.012147206129;4299.226139294926;4300.462442194726;12674.683132921751;13390.86609133906;13902.721945561134;14456.927715361357;14489.347979340955;1907.0369463421023;1920.9135588898394;1929.9517512062312;1939.4957311099215;1964.0572525187847;10191.286609937308;10263.178945684327;10382.22133339995;10462.738431539196;10500.422476763775;1643.7698722178905;1645.2514106081703;1648.077076836975;1659.0460485221047;1668.8748343874136;88014;89279.55360223222;89849.55075224648;90587.09412905852;90666.09333906708;6766.28953959837;6809.93190068093;6876;6936.375726184668;7015.36861682451;7785.026871641045;7865.960670196612;7890.842183156305;7907.802304942307;7924.286814186751;5728.885422291531;5799.5650326225705;5834.066549352084;5835.503982161564;5840.503557197686;6268.402409314356;6276.152719382825;6291.402316779899;6342.080398342307;6356.713947872357;3111.7355024823146;3127.37452509499;3128.921776955549;3152.2119470132466;3155.4635711929027;1066.8399740039056;1098.1873413673825;1124.044562122206;1142.8457158283525;1157.988420115805;436.3433033284886;456.8332558616081;459.3844248706749;472.9550692684189;499.61779238882286;11852.407379630984;12472.43874025671;12550.497980080694;12563;12586.748265034648;426.6949131371023;474.36672042823216;478.90182512584835;495.7397366382678;517.167360549515;5358.356997160287;6605.70274337656;6623.635700036544;6672.7330906764155;6900;783885;784519.7908887229;794141.322227283;807410;807622;111141;117921.82078179109;119132;121806.3909680446;122176.38911805383;513.8946515964218;529.5366554265019;531.4764956517904;532.1751285507448;532.3319234360853;11518.884811152117;11845.170838041255;11873.703157420789;11998.340091295062;12021.218620789621;39626.1178268095;47020.7648961753;48957.79689913891;50815.72960676013;50944.98110037853;65705.67147164233;66716.6664166676;68361.31638683549;71395.28604714094;73721;6300.873982520232;6487.513436492376;6492.675366231764;6494.220693516808;6513.1532900722605;11992.64022079339;12173.75652486963;12323.137380383287;12543.749125017266;12547.686307842378;3402.438597631462;8933.776655583662;10521.105706015074;10725.552050473398;11017.669469915916;10675.786484270426;10789.028987391173;10986.176036797113;11040.33757974524;11259.268147570381;8927.776805579913;9315.97524272316;9566.56950437218;11316.547338106384;11423.771524569296;6019.1573179754;6399.488040956619;6554.672266386757;6558.704858281293;6568.211814582281;8992.59533320989;10964.06805421548;11071.225014248925;11106.16703747206;11115.777684446428 10:42:58 INFO - 2015-11-19 10:42:58,169 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1586.3099551695007;1599.7040547498714;1699.6430749542596;1842.8341449269565;1857.563472583943;7376.631168441577;7749.30256276935;8157.5921203939715;8293.709720159795;8322.084570697234;8082.191780821915;8119.91880081199;8213.671453141867;8219.794505137359;8247.05158906726;1952.1410579345113;2139.101577337522;2360.445295355594;2380.0955636858057;2380.5952987991996;2125.0543508138885;2375.6674065630827;2429.514097180562;2432.7567243275707;2433.853968761871;2348.213348528245;2358.870262135582;2387.5941090014653;2391.330427480308;2394.5091256292503;2136.807687308134;2186.9125234990584;2192.6710993350966;2338.5907466193435;2376.6316220985686;2367.739548649647;2421.128393778238;2423.09134074722;2423.236680445654;2425.223928342931;8115.95942020292;8229.135940726197;8234.423590348679;8251.463654862415;8263.173682631748;5082.695038297714;5188.5849132069725;5200.323957885488;5203.973980130113;5217.47825217479;3465.5148279240925;3501.212227248874;3609.4766258892314;3618.8914332570066;3621.8732344367822;1047.4919663962971;1049.2759995603085;1062.3148069495132;1071.7481391872905;1079.7354648111184;10714.571417143305;10809.78380432387;10838.078763305128;10841.13270938331;10846.67459976202;4557.612602928788;4620.976895115503;4693.272542755878;4705.6941298816155;4725.243960966229;9591.42451452915;9643.9035609643;9649.565769540248;9662.71011869645;9663.13031827139;5167.328247327823;5195.3246078009615;5197.558207552324;5200.583953283728;5213.504717051874;4697.201475749131;4706.882327941828;4732.0772449372735;4735.573798358164;4766.976165119152;3668.9816550917076;3735.6824669902817;3746.756460830037;3762.6801721853403;3787.981060094737;1226.0865655087018;1228.2507670321097;1233.1429656388723;1235.0983781839307;1254.5609036837216;1363.3524076063989;1365.7541642504445;1403.9789403158961;1405.3816320818808;1410.0763999580292;7536.397088232929;7713.6143192841255;7721.884171737428;7723.227677232232;7725.922740772633;480.7620227987169;485.58239913674214;487.64889279718545;490.11778798163164;511.3378175263043;5697.9430205698245;5843.5325173985975;5844.1818145459665;5855.268091488564;6076.361981991916;8897.199252067345;9293.67472138472;9898.257630677728;9911.157551608194;9986.151177149879;7503.962480187564;9760.609575616896;9824.11582957523;9857.35927164732;10197.847032294521;7720.382369410434;7792;7845.843083138419;7920.32677222431;7926.524408535506;6739.685761276504;7026.473014523829;7507.812304692427;7643.968064311247;7709.768706938801;8295.83408331818;8677.913220867964;8933.553322333728;9003.639854406012;9051.954740226256;9059.818803624023;9230.676926307548;9351.625934962525;9363.85954210701;9370.39092458988;7134.785956421316;7255.2019277878335;7307.2327405621645;7314.780556583311;7317.231690672403;7873.84252314939;7919.16848730875;7921.1682773307975;7944.801379965547;8010.639521221676;7052.541584796972;7229.710811567478;7416.851662966818;7435.442341824277;7467.215942325977;6657.4674026078765;6820.420264277592;7141.107361579802;7197.748078817216;7318.487705860539;6780.881154609434;6908.3091690830515;7373.18894921569;7380.557166570023;7390.593517356597;6710.261871194067;6738.831529211809;6762.188537375547;6770.4922130839395;6775.390214880685;6821.386075253053;6872.381485666314;6875.140607424072;6877.449804015767;6882.518223724292 10:42:58 INFO - 2015-11-19 10:42:58,173 DEBUG : BROWSER_OUTPUT: |4;prototype.html;316.43516323362803;323.0953330674112;329.14422501496097;330.6164848775421;332.9134425049488;5753.741081651326;6901.792186367385;7062.823429414268;7070.5404148730295;7078.929210707892;5458;6622.370874766902;6755.695993680284;6786.083878676377;6977.441804655616;5138.254953031808;5167.7932882684645;5180.4042535108565;5180.948190518094;5194.922076168841;5176.870578235536;5177.30106435632;5177.58579313654;5182.844514664566;5203.4536373680785;4845.73348465836;4945.35710357653;4996.050750357439;5031.27046578246;5074.3657042869645;5056.266841308026;5088.338515992916;5095.337606111182;5096.235564665311;5132.717700526469;4360.149770794665;4370.409994650713;4372.103718737651;4376.474823021226;4392.604665580113;5363.597730170253;6394.9360506394805;6695.665216739144;6703.195616525999;6722.226943901465;6039.607425517327;6041.848953776147;6052.878942421127;6057;6082.726277317532;7436.628168591603;7448.7392941247335;7451.85096298071;7460.925390746077;7480.401567874557;4586.495485496593;4896.902061958776;4898.804047838083;4903.166461701519;4911.852644420673;7760.611969401507;7849.5290282582655;7938.285554300141;7949.562774047425;7958.084820245688;4844.442889067803;4845.563899249085;4845.685030473008;4847.709137451764;4853.4418541867435;4134.4005119258145;4938.950610493921;4942;4945.950540494549;4950.925736113961;5738.311402631627;5934.317553481319;5943.881122377615;5955.880882382328;5964.314103878023;7470.6264686766535;7475.289847464483;7486.887696684554;7491.325780679765;7498.925010749823;1684.2925971091927;1699.2438364927489;1699.371232643905;1702.446704820938;1704.4375356132446;1057.259918057363;1080.448971024783;1088.385062439719;1098.0501865885951;1102.459794700607;5753.769849205984;6914.896276555855;6929.5842249464185;6950.270221626757;6960.060391847137;7516.173220945691;7743.109542402696;7744.49660772048;7767.262110099531;7996.24035716606;6162.445379915829;6545.280019197884;6845.794626161123;6922.238553759083;6952.165740111118;3542.75200735946;3965.9603403966166;4065.6340929316502;4134.214499245194;4135.421041054255;7813.984182056296;7930.325922296554;8067.354611631055;8127.552984585905;8130;6492.92866676993;7348.52234604749;7377.59825633128;8123.7156699515235;8128.878066828884;7843.843123137392;8072.677092916218;8130.268275855202;8131.83736325282;8133.186681331819;7838.372930165687;7841.5687137208;7843;7843.803904902423;7846.5292082475235;7682.577458239851;7686.154523002577;7686.46194766361;7692.499987500794;7693.49992250502;7957.880631790412;8116.228958248957;8120.269175774209;8197.139300373614;8214.548199849065;4834.419869615669;4868.926966095441;4886.071646387175;4887.193613053949;4887.951120488892;6562.5406221564035;6878.58728476293;7716.189800070912;7864.449488535747;7876.212378762078;7081.327273908971;7218.205997340393;7412.0364352633815;7429.257074292527;7508.211637777955;7464.477486576105;7475.140358858801;7490.550566966;7493.550386976799;7502.924970750222;7042.225355211025;7283.927160728324;7291.197968223385;7300.269973002657;7301.890471643036;6083.574149809471;7460.440466964891;7481.251874812693;7499.175090740124;7510.098788145239;5647.943520564741;7178.461615378763;7200.243974382614;7336;7390.815229619303 10:42:58 INFO - 2015-11-19 10:42:58,174 DEBUG : BROWSER_OUTPUT: |5;yui.html;660.2044536333715;784.5880912520929;805.8227190018197;806.27838084914;862.1895418306789;13037.348132593355;15389.923050384747;15639.843601563982;15656.21718914054;15660.451884184056;13556;14031.5088971886;14244.71510569788;14413.063150895185;14419.134851908866;951.2295041016764;973.4062222044547;973.435407463673;980.9901900981006;982.0474140084107;952.380952380951;967.0377973915928;969.8933117357085;972.523463502882;973.2749101919045;999.635133176389;1011.9949400252989;1012.4785735346303;1012.5645972231937;1018.7249442650517;998.7602975285952;1010.2574607663362;1010.5200029985772;1011.0496133634397;1012.5392946209457;751.3087959077607;756.8221467955026;757.5114051436792;761.1931352766086;762.9427792915498;13610.659733506642;13773.03588748788;13787.103838250481;13831.10097843647;14607.78088328676;10219.642312519101;10288.639897603547;10353.844692329621;10544.209184311207;10707.089897358734;9772.267079969031;9799.873014603269;9804.46075465849;9836.852447213298;9938.552765125587;3107.2231942014496;3137.6862313768443;3171.1120886151916;3224.838758062111;3280.7867488613165;38785.806070969746;41989.79005104985;61728.38271617271;68163.9999999995;72141.63929180373;7174.497785155094;7198.244184360671;7260.128784545888;7287.234840341794;7347.264475587232;9771.755706107404;12726.936365318114;12732.299723515296;12774.041946854024;12811.743765124646;5204.115300398941;5844.26946631671;6084.90872636902;6545.05096760967;6675.699593518303;4069.694772892045;4097.282975479279;4104.138130992465;4107.219628270619;4111.444954931106;3186.8406579671387;3216.565763621928;3220.5169224616493;3223.2747631782663;3233.8383080845865;520.354760097484;562.504995603866;564.6527385657873;585.7130006296884;586.4487381861037;474.12760520642183;512.229095211704;513.299346392172;529.3066083430718;537.3176066395733;8367.372447066495;8640.654373824977;8643;9263.25893928484;9308.44149351041;540.7377421950351;601.8044135655929;607.4988134788817;625.0873724362482;652.4063102576632;3650.3976843821;3677.485152078711;3686.1337585667347;3738.383166777451;3784.791836449022;104409.47795261127;104434.4334834978;104854.42718359231;104913;105105.47447262867;71889.64055179691;85958;87408;88256.11743882479;89286.55356723175;75569.62215188889;75783.62108189423;76091.09772255848;76644;77144;8806.339524535813;8862.556872156238;8977.685780997634;8989.415687980521;9177.77055573616;46331.53668463272;51333;53637;54491;54593;64622.38444038937;64829.351706484216;66544.3363915906;76200;76220;8139.10469848328;8197.959010204911;8226.794330141794;8229.95885020571;8487.490750554987;12115.515379384726;12159.331236782062;12208.755824883276;12212.145149839425;12577.119601627799;10038.001575918406;10046.481041414365;10124.291299608956;10201.438920859424;10322;11582.478788454708;11677.591284305008;11948.223365481215;12027.977621902237;12374;11421.428928553705;11475.713107172387;11594.6521604352;12157.81763273534;12267.57063502773;8110.391720620859;8740.344474164336;9783;10221.488925553842;10383.013613706686;9588.616455341707;9883.851742224017;10234.744131396477;10257.794844103226;10285.485725713834 10:42:58 INFO - 2015-11-19 10:42:58,174 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:42:58 INFO - 2015-11-19 10:42:58,174 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:42:58 INFO - 2015-11-19 10:42:58,174 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1117 10:42:58 INFO - 2015-11-19 10:42:58,174 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:42:58 INFO - 2015-11-19 10:42:58,174 DEBUG : BROWSER_OUTPUT: __startTimestamp1447958578161__endTimestamp 10:42:58 INFO - 2015-11-19 10:42:58,174 DEBUG : BROWSER_OUTPUT: 10:42:58 INFO - 2015-11-19 10:42:58,174 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:42:58 INFO - 2015-11-19 10:42:58,174 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:42:58 INFO - 2015-11-19 10:42:58,174 DEBUG : BROWSER_OUTPUT: 10:42:58 INFO - 2015-11-19 10:42:58,175 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5910.50 Median:6134.47 stddev:640.41 (10.4%) stddev-sans-first:611.86 10:42:58 INFO - 2015-11-19 10:42:58,175 DEBUG : BROWSER_OUTPUT: Values: 3420.5 3492.1 3519.2 3520.1 3545.9 5707.4 5845.1 5907.7 5980.0 5992.9 4798.5 5908.0 5916.7 5940.7 5952.1 5363.2 5382.5 5450.4 5467.0 5479.0 5482.9 5485.3 5488.1 5493.2 5496.7 5471.8 5477.2 5480.8 5482.6 5484.2 5472.5 5481.9 5482.4 5482.9 5492.8 5312.1 5397.1 5419.6 5422.8 5442.6 5920.1 6021.2 6034.8 6038.2 6042.2 6343.0 6359.5 6366.6 6390.3 6396.1 6239.4 6257.3 6366.8 6367.8 6384.0 6061.2 6080.2 6113.7 6117.3 6119.9 5087.9 6486.7 6507.8 6516.8 6536.2 6134.5 6169.0 6224.8 6250.7 6272.6 6379.4 6382.5 6383.2 6398.3 6414.1 6402.1 6402.3 6403.3 6415.8 6416.4 6231.5 6245.8 6326.7 6352.7 6399.6 5078.8 5080.3 5087.5 5093.0 5099.1 4538.5 4551.2 4561.5 4566.8 4605.7 5829.5 5966.9 5968.8 5982.8 6085.4 6385.0 6396.6 6397.6 6400.6 6414.6 6013.6 6033.3 6035.9 6044.6 6054.1 5377.2 5482.4 5483.2 5487.1 5488.4 6402.5 6424.1 6437.6 6443.2 6446.4 6272.8 6386.5 6386.7 6402.2 6420.4 6496.1 6516.2 6521.7 6523.1 6534.2 6223.0 6391.9 6391.9 6393.6 6418.4 6247.9 6263.6 6357.6 6396.2 6409.7 6263.5 6268.1 6288.0 6296.0 6297.4 6077.7 6138.0 6147.6 6276.6 6283.1 6050.0 6100.2 6140.0 6151.4 6153.0 5214.0 6275.1 6276.0 6291.0 6309.0 5984.1 6096.8 6180.8 6182.9 6194.8 10:42:58 INFO - 2015-11-19 10:42:58,175 DEBUG : BROWSER_OUTPUT: 10:42:58 INFO - 2015-11-19 10:42:58,175 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:67265.44 Median:43583.13 stddev:138595.02 (318.0%) stddev-sans-first:138893.31 10:42:58 INFO - 2015-11-19 10:42:58,176 DEBUG : BROWSER_OUTPUT: Values: 557.4 559.9 577.1 583.2 613.0 31905.4 32147.5 32170.0 39097.8 40373.0 43406.6 43587.6 43852.0 43899.0 43902.9 9667.8 9861.9 9868.5 9869.4 9883.4 9661.7 9788.9 9797.9 9797.9 9818.0 9687.6 9745.0 9767.3 9769.7 9783.7 9630.6 9737.0 9743.2 9745.4 9747.3 9598.6 9717.9 9747.3 9750.4 9761.2 39830.4 40101.8 40222.4 40287.4 40314.6 2735.3 3284.5 3294.0 3347.4 3418.8 28430.0 28519.3 28791.0 29887.6 30042.2 2595.7 2629.9 2645.9 2673.2 2736.0 507041.0 507609.0 508490.0 508616.0 511201.0 56375.4 57117.7 57500.3 64598.0 66442.3 64947.4 65465.7 65670.7 65774.3 65774.7 16305.0 16520.2 16536.2 16553.7 16557.3 11929.9 12091.3 12092.6 12181.6 12652.2 16416.6 17922.5 20634.0 21346.0 21437.7 8763.6 8938.0 8955.0 8961.3 9030.6 938.5 963.1 987.8 1103.5 1119.5 25175.6 27896.7 28383.9 28511.0 28540.4 1083.4 1091.6 1162.0 1179.3 1182.2 13889.1 14749.6 14791.1 14825.6 14860.0 503072.0 556501.0 557658.0 558701.0 561022.0 49691.5 57770.0 57938.4 58109.4 58220.4 1126.3 1305.5 1446.3 1450.2 1456.4 29158.9 33042.7 33432.2 33557.5 33724.0 48623.0 49749.5 56411.4 57294.7 58299.4 500242.0 504929.0 508377.0 509624.0 510772.0 45275.8 45531.1 45881.8 46356.3 46549.3 46635.8 47448.0 47464.0 49134.3 49259.8 38808.6 40013.4 41708.0 43345.8 43734.6 36917.1 40571.8 42451.6 43578.7 43694.3 39155.6 39610.6 40506.6 40526.4 40659.0 38729.6 39246.8 39434.4 40361.8 40557.8 26417.9 26677.6 26933.6 26957.2 27088.8 10:42:58 INFO - 2015-11-19 10:42:58,176 DEBUG : BROWSER_OUTPUT: 10:42:58 INFO - 2015-11-19 10:42:58,176 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37206.01 Median:2392.98 stddev:131026.01 (5475.4%) stddev-sans-first:131364.27 10:42:58 INFO - 2015-11-19 10:42:58,177 DEBUG : BROWSER_OUTPUT: Values: 303.8 304.7 356.9 357.1 367.5 13756.9 16181.9 19507.2 19893.8 21033.9 16916.2 18587.7 19375.6 21176.4 21811.1 5041.6 5158.0 6037.4 6215.6 6219.5 3607.7 3701.2 3705.4 5104.5 5153.1 5019.0 5108.6 5122.4 5127.2 5131.9 4349.6 4985.3 5071.9 5108.9 5116.2 4280.3 4294.4 4295.0 4299.2 4300.5 12674.7 13390.9 13902.7 14456.9 14489.3 1907.0 1920.9 1930.0 1939.5 1964.1 10191.3 10263.2 10382.2 10462.7 10500.4 1643.8 1645.3 1648.1 1659.0 1668.9 88014.0 89279.6 89849.6 90587.1 90666.1 6766.3 6809.9 6876.0 6936.4 7015.4 7785.0 7866.0 7890.8 7907.8 7924.3 5728.9 5799.6 5834.1 5835.5 5840.5 6268.4 6276.2 6291.4 6342.1 6356.7 3111.7 3127.4 3128.9 3152.2 3155.5 1066.8 1098.2 1124.0 1142.8 1158.0 436.3 456.8 459.4 473.0 499.6 11852.4 12472.4 12550.5 12563.0 12586.7 426.7 474.4 478.9 495.7 517.2 5358.4 6605.7 6623.6 6672.7 6900.0 783885.0 784519.8 794141.3 807410.0 807622.0 111141.0 117921.8 119132.0 121806.4 122176.4 513.9 529.5 531.5 532.2 532.3 11518.9 11845.2 11873.7 11998.3 12021.2 39626.1 47020.8 48957.8 50815.7 50945.0 65705.7 66716.7 68361.3 71395.3 73721.0 6300.9 6487.5 6492.7 6494.2 6513.2 11992.6 12173.8 12323.1 12543.7 12547.7 3402.4 8933.8 10521.1 10725.6 11017.7 10675.8 10789.0 10986.2 11040.3 11259.3 8927.8 9316.0 9566.6 11316.5 11423.8 6019.2 6399.5 6554.7 6558.7 6568.2 8992.6 10964.1 11071.2 11106.2 11115.8 10:42:58 INFO - 2015-11-19 10:42:58,178 DEBUG : BROWSER_OUTPUT: 10:42:58 INFO - 2015-11-19 10:42:58,178 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5710.11 Median:6366.91 stddev:2947.67 (46.3%) stddev-sans-first:2939.64 10:42:58 INFO - 2015-11-19 10:42:58,179 DEBUG : BROWSER_OUTPUT: Values: 1586.3 1599.7 1699.6 1842.8 1857.6 7376.6 7749.3 8157.6 8293.7 8322.1 8082.2 8119.9 8213.7 8219.8 8247.1 1952.1 2139.1 2360.4 2380.1 2380.6 2125.1 2375.7 2429.5 2432.8 2433.9 2348.2 2358.9 2387.6 2391.3 2394.5 2136.8 2186.9 2192.7 2338.6 2376.6 2367.7 2421.1 2423.1 2423.2 2425.2 8116.0 8229.1 8234.4 8251.5 8263.2 5082.7 5188.6 5200.3 5204.0 5217.5 3465.5 3501.2 3609.5 3618.9 3621.9 1047.5 1049.3 1062.3 1071.7 1079.7 10714.6 10809.8 10838.1 10841.1 10846.7 4557.6 4621.0 4693.3 4705.7 4725.2 9591.4 9643.9 9649.6 9662.7 9663.1 5167.3 5195.3 5197.6 5200.6 5213.5 4697.2 4706.9 4732.1 4735.6 4767.0 3669.0 3735.7 3746.8 3762.7 3788.0 1226.1 1228.3 1233.1 1235.1 1254.6 1363.4 1365.8 1404.0 1405.4 1410.1 7536.4 7713.6 7721.9 7723.2 7725.9 480.8 485.6 487.6 490.1 511.3 5697.9 5843.5 5844.2 5855.3 6076.4 8897.2 9293.7 9898.3 9911.2 9986.2 7504.0 9760.6 9824.1 9857.4 10197.8 7720.4 7792.0 7845.8 7920.3 7926.5 6739.7 7026.5 7507.8 7644.0 7709.8 8295.8 8677.9 8933.6 9003.6 9052.0 9059.8 9230.7 9351.6 9363.9 9370.4 7134.8 7255.2 7307.2 7314.8 7317.2 7873.8 7919.2 7921.2 7944.8 8010.6 7052.5 7229.7 7416.9 7435.4 7467.2 6657.5 6820.4 7141.1 7197.7 7318.5 6780.9 6908.3 7373.2 7380.6 7390.6 6710.3 6738.8 6762.2 6770.5 6775.4 6821.4 6872.4 6875.1 6877.4 6882.5 10:42:58 INFO - 2015-11-19 10:42:58,179 DEBUG : BROWSER_OUTPUT: 10:42:58 INFO - 2015-11-19 10:42:58,180 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6045.73 Median:6770.89 stddev:1956.70 (28.9%) stddev-sans-first:1914.35 10:42:58 INFO - 2015-11-19 10:42:58,180 DEBUG : BROWSER_OUTPUT: Values: 316.4 323.1 329.1 330.6 332.9 5753.7 6901.8 7062.8 7070.5 7078.9 5458.0 6622.4 6755.7 6786.1 6977.4 5138.3 5167.8 5180.4 5180.9 5194.9 5176.9 5177.3 5177.6 5182.8 5203.5 4845.7 4945.4 4996.1 5031.3 5074.4 5056.3 5088.3 5095.3 5096.2 5132.7 4360.1 4370.4 4372.1 4376.5 4392.6 5363.6 6394.9 6695.7 6703.2 6722.2 6039.6 6041.8 6052.9 6057.0 6082.7 7436.6 7448.7 7451.9 7460.9 7480.4 4586.5 4896.9 4898.8 4903.2 4911.9 7760.6 7849.5 7938.3 7949.6 7958.1 4844.4 4845.6 4845.7 4847.7 4853.4 4134.4 4939.0 4942.0 4946.0 4950.9 5738.3 5934.3 5943.9 5955.9 5964.3 7470.6 7475.3 7486.9 7491.3 7498.9 1684.3 1699.2 1699.4 1702.4 1704.4 1057.3 1080.4 1088.4 1098.1 1102.5 5753.8 6914.9 6929.6 6950.3 6960.1 7516.2 7743.1 7744.5 7767.3 7996.2 6162.4 6545.3 6845.8 6922.2 6952.2 3542.8 3966.0 4065.6 4134.2 4135.4 7814.0 7930.3 8067.4 8127.6 8130.0 6492.9 7348.5 7377.6 8123.7 8128.9 7843.8 8072.7 8130.3 8131.8 8133.2 7838.4 7841.6 7843.0 7843.8 7846.5 7682.6 7686.2 7686.5 7692.5 7693.5 7957.9 8116.2 8120.3 8197.1 8214.5 4834.4 4868.9 4886.1 4887.2 4888.0 6562.5 6878.6 7716.2 7864.4 7876.2 7081.3 7218.2 7412.0 7429.3 7508.2 7464.5 7475.1 7490.6 7493.6 7502.9 7042.2 7283.9 7291.2 7300.3 7301.9 6083.6 7460.4 7481.3 7499.2 7510.1 5647.9 7178.5 7200.2 7336.0 7390.8 10:42:58 INFO - 2015-11-19 10:42:58,180 DEBUG : BROWSER_OUTPUT: 10:42:58 INFO - 2015-11-19 10:42:58,180 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:17938.92 Median:2866.71 stddev:26667.72 (930.3%) stddev-sans-first:26710.97 10:42:58 INFO - 2015-11-19 10:42:58,181 DEBUG : BROWSER_OUTPUT: Values: 660.2 784.6 805.8 806.3 862.2 13037.3 15389.9 15639.8 15656.2 15660.5 13556.0 14031.5 14244.7 14413.1 14419.1 951.2 973.4 973.4 981.0 982.0 952.4 967.0 969.9 972.5 973.3 999.6 1012.0 1012.5 1012.6 1018.7 998.8 1010.3 1010.5 1011.0 1012.5 751.3 756.8 757.5 761.2 762.9 13610.7 13773.0 13787.1 13831.1 14607.8 10219.6 10288.6 10353.8 10544.2 10707.1 9772.3 9799.9 9804.5 9836.9 9938.6 3107.2 3137.7 3171.1 3224.8 3280.8 38785.8 41989.8 61728.4 68164.0 72141.6 7174.5 7198.2 7260.1 7287.2 7347.3 9771.8 12726.9 12732.3 12774.0 12811.7 5204.1 5844.3 6084.9 6545.1 6675.7 4069.7 4097.3 4104.1 4107.2 4111.4 3186.8 3216.6 3220.5 3223.3 3233.8 520.4 562.5 564.7 585.7 586.4 474.1 512.2 513.3 529.3 537.3 8367.4 8640.7 8643.0 9263.3 9308.4 540.7 601.8 607.5 625.1 652.4 3650.4 3677.5 3686.1 3738.4 3784.8 104409.5 104434.4 104854.4 104913.0 105105.5 71889.6 85958.0 87408.0 88256.1 89286.6 75569.6 75783.6 76091.1 76644.0 77144.0 8806.3 8862.6 8977.7 8989.4 9177.8 46331.5 51333.0 53637.0 54491.0 54593.0 64622.4 64829.4 66544.3 76200.0 76220.0 8139.1 8198.0 8226.8 8230.0 8487.5 12115.5 12159.3 12208.8 12212.1 12577.1 10038.0 10046.5 10124.3 10201.4 10322.0 11582.5 11677.6 11948.2 12028.0 12374.0 11421.4 11475.7 11594.7 12157.8 12267.6 8110.4 8740.3 9783.0 10221.5 10383.0 9588.6 9883.9 10234.7 10257.8 10285.5 10:42:58 INFO - 2015-11-19 10:42:58,181 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:42:58 INFO - 2015-11-19 10:42:58,181 DEBUG : BROWSER_OUTPUT: 10:42:58 INFO - 2015-11-19 10:42:58,702 INFO : Browser exited with error code: 0 10:42:58 INFO - 2015-11-19 10:42:58,726 INFO : Completed test dromaeo_css (00:18:34) 10:42:58 INFO - 2015-11-19 10:42:58,727 INFO : Starting test kraken 10:42:58 INFO - 2015-11-19 10:42:58,727 DEBUG : operating with platform_type : mac_ 10:42:58 INFO - 2015-11-19 10:42:58,727 INFO : Initialising browser for kraken test... 10:42:58 INFO - 2015-11-19 10:42:58,740 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpC3jtES/profile http://localhost:57223/getInfo.html 10:43:00 INFO - 2015-11-19 10:43:00,954 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:43:00 INFO - 2015-11-19 10:43:00,954 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:43:00 INFO - 2015-11-19 10:43:00,955 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:43:00 INFO - 2015-11-19 10:43:00,955 DEBUG : BROWSER_OUTPUT: __metrics 10:43:00 INFO - 2015-11-19 10:43:00,971 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:43:01 INFO - 2015-11-19 10:43:01,230 DEBUG : BROWSER_OUTPUT: console.error: 10:43:01 INFO - 2015-11-19 10:43:01,230 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 10:43:01 INFO - 2015-11-19 10:43:01,230 DEBUG : BROWSER_OUTPUT: Stack: 10:43:01 INFO - 2015-11-19 10:43:01,230 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 10:43:01 INFO - 2015-11-19 10:43:01,230 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 10:43:01 INFO - 2015-11-19 10:43:01,230 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 10:43:01 INFO - 2015-11-19 10:43:01,231 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 10:43:01 INFO - 2015-11-19 10:43:01,231 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 10:43:01 INFO - 2015-11-19 10:43:01,231 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 10:43:01 INFO - 2015-11-19 10:43:01,231 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:43:01 INFO - 2015-11-19 10:43:01,231 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 10:43:01 INFO - 2015-11-19 10:43:01,231 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:43:01 INFO - 2015-11-19 10:43:01,231 DEBUG : BROWSER_OUTPUT: 10:43:01 INFO - 2015-11-19 10:43:01,633 INFO : Browser initialized. 10:43:01 INFO - 2015-11-19 10:43:01,633 INFO : Running cycle 1/1 for kraken test... 10:43:01 INFO - 2015-11-19 10:43:01,634 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpC3jtES/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:43:13 INFO - 2015-11-19 10:43:13,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 226336768 10:43:13 INFO - 2015-11-19 10:43:13,583 DEBUG : BROWSER_OUTPUT: 10:43:16 INFO - 2015-11-19 10:43:16,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57223/tests/kraken/driver.html?testName=audio-beat-detection) 10:43:16 INFO - 2015-11-19 10:43:16,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 275378176 10:43:16 INFO - 2015-11-19 10:43:16,691 DEBUG : BROWSER_OUTPUT: 10:43:19 INFO - 2015-11-19 10:43:19,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57223/tests/kraken/driver.html?testName=audio-dft) 10:43:19 INFO - 2015-11-19 10:43:19,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 291147776 10:43:19 INFO - 2015-11-19 10:43:19,913 DEBUG : BROWSER_OUTPUT: 10:43:23 INFO - 2015-11-19 10:43:23,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57223/tests/kraken/driver.html?testName=audio-fft) 10:43:23 INFO - 2015-11-19 10:43:23,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 277471232 10:43:23 INFO - 2015-11-19 10:43:23,718 DEBUG : BROWSER_OUTPUT: 10:43:25 INFO - 2015-11-19 10:43:25,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57223/tests/kraken/driver.html?testName=audio-oscillator) 10:43:26 INFO - 2015-11-19 10:43:26,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 277778432 10:43:26 INFO - 2015-11-19 10:43:26,169 DEBUG : BROWSER_OUTPUT: 10:43:28 INFO - 2015-11-19 10:43:28,184 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57223/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:43:28 INFO - 2015-11-19 10:43:28,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 279953408 10:43:28 INFO - 2015-11-19 10:43:28,765 DEBUG : BROWSER_OUTPUT: 10:43:31 INFO - 2015-11-19 10:43:31,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57223/tests/kraken/driver.html?testName=imaging-darkroom) 10:43:32 INFO - 2015-11-19 10:43:32,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 281747456 10:43:32 INFO - 2015-11-19 10:43:32,031 DEBUG : BROWSER_OUTPUT: 10:43:34 INFO - 2015-11-19 10:43:34,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57223/tests/kraken/driver.html?testName=imaging-desaturate) 10:43:35 INFO - 2015-11-19 10:43:35,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 281985024 10:43:35 INFO - 2015-11-19 10:43:35,377 DEBUG : BROWSER_OUTPUT: 10:43:38 INFO - 2015-11-19 10:43:38,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57223/tests/kraken/driver.html?testName=json-parse-financial) 10:43:38 INFO - 2015-11-19 10:43:38,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 280760320 10:43:38 INFO - 2015-11-19 10:43:38,632 DEBUG : BROWSER_OUTPUT: 10:43:40 INFO - 2015-11-19 10:43:40,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57223/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:43:40 INFO - 2015-11-19 10:43:40,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 312659968 10:43:40 INFO - 2015-11-19 10:43:40,749 DEBUG : BROWSER_OUTPUT: 10:43:42 INFO - 2015-11-19 10:43:42,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57223/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:43:43 INFO - 2015-11-19 10:43:43,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 314634240 10:43:43 INFO - 2015-11-19 10:43:43,167 DEBUG : BROWSER_OUTPUT: 10:43:45 INFO - 2015-11-19 10:43:45,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57223/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:43:45 INFO - 2015-11-19 10:43:45,809 DEBUG : BROWSER_OUTPUT: RSS: Main: 323870720 10:43:45 INFO - 2015-11-19 10:43:45,809 DEBUG : BROWSER_OUTPUT: 10:43:48 INFO - 2015-11-19 10:43:48,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:43:48 INFO - 2015-11-19 10:43:48,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 325185536 10:43:48 INFO - 2015-11-19 10:43:48,943 DEBUG : BROWSER_OUTPUT: 10:43:51 INFO - 2015-11-19 10:43:51,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:43:52 INFO - 2015-11-19 10:43:52,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 324321280 10:43:52 INFO - 2015-11-19 10:43:52,042 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57223/tests/kraken/driver.html?testName=ai-astar) 10:43:53 INFO - 2015-11-19 10:43:53,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 384790528 10:43:53 INFO - 2015-11-19 10:43:53,964 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,965 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:43:53 INFO - 2015-11-19 10:43:53,965 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;103;109;108;108;100;109;101;109 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;119;143;158;120;141;139;114;179;145 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |2;audio-dft;187;181;179;186;184;184;185;186;188;183 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |3;audio-fft;64;70;77;73;55;58;57;72;72;54 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;82;120;75;75;73;115;75;76;114 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;85;86;83;84;85;85;84;84;84 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;92;92;92;92;92;93;93;92;93;92 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;85;87;85;84;82;86;84;86;84 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;54;56;55;55;54;55;65;54;53 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;64;63;67;68;67;68;67 10:43:53 INFO - 2015-11-19 10:43:53,966 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;82;82;80;82;81;81;79;83;83 10:43:53 INFO - 2015-11-19 10:43:53,967 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;125;131;121;127;120;132;131;120;117 10:43:53 INFO - 2015-11-19 10:43:53,967 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;128;124;132;136;134;110;152;180;179;134 10:43:53 INFO - 2015-11-19 10:43:53,967 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;65;64;65;64;64;65;65;65;62 10:43:53 INFO - 2015-11-19 10:43:53,967 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:43:53 INFO - 2015-11-19 10:43:53,967 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:43:53 INFO - 2015-11-19 10:43:53,967 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1052 10:43:53 INFO - 2015-11-19 10:43:53,967 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:43:53 INFO - 2015-11-19 10:43:53,967 DEBUG : BROWSER_OUTPUT: __startTimestamp1447958633964__endTimestamp 10:43:53 INFO - 2015-11-19 10:43:53,967 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,969 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:43:53 INFO - 2015-11-19 10:43:53,969 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:43:53 INFO - 2015-11-19 10:43:53,969 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:106.50 Median:108.50 stddev:3.69 (3.4%) stddev-sans-first:3.87 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 103.0 109.0 108.0 108.0 100.0 109.0 101.0 109.0 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.80 Median:144.00 stddev:19.70 (13.7%) stddev-sans-first:20.61 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: Values: 150.0 119.0 143.0 158.0 120.0 141.0 139.0 114.0 179.0 145.0 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:184.30 Median:185.50 stddev:2.75 (1.5%) stddev-sans-first:2.74 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: Values: 187.0 181.0 179.0 186.0 184.0 184.0 185.0 186.0 188.0 183.0 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:65.20 Median:71.00 stddev:8.60 (12.1%) stddev-sans-first:9.11 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: Values: 64.0 70.0 77.0 73.0 55.0 58.0 57.0 72.0 72.0 54.0 10:43:53 INFO - 2015-11-19 10:43:53,970 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,971 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:89.40 Median:75.00 stddev:19.21 (25.6%) stddev-sans-first:20.38 10:43:53 INFO - 2015-11-19 10:43:53,972 DEBUG : BROWSER_OUTPUT: Values: 89.0 82.0 120.0 75.0 75.0 73.0 115.0 75.0 76.0 114.0 10:43:53 INFO - 2015-11-19 10:43:53,972 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,972 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:84.50 Median:85.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 10:43:53 INFO - 2015-11-19 10:43:53,972 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 86.0 83.0 84.0 85.0 85.0 84.0 84.0 84.0 10:43:53 INFO - 2015-11-19 10:43:53,972 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,972 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:92.30 Median:92.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:43:53 INFO - 2015-11-19 10:43:53,972 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 92.0 92.0 92.0 93.0 93.0 92.0 93.0 92.0 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.42 (1.7%) stddev-sans-first:1.48 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 87.0 85.0 84.0 82.0 86.0 84.0 86.0 84.0 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:3.43 (6.2%) stddev-sans-first:3.61 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: Values: 57.0 54.0 56.0 55.0 55.0 54.0 55.0 65.0 54.0 53.0 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:67.00 stddev:1.96 (2.9%) stddev-sans-first:1.99 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 64.0 63.0 67.0 68.0 67.0 68.0 67.0 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:1.49 (1.8%) stddev-sans-first:1.33 10:43:53 INFO - 2015-11-19 10:43:53,973 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 82.0 80.0 82.0 81.0 81.0 79.0 83.0 83.0 10:43:53 INFO - 2015-11-19 10:43:53,974 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,974 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:126.00 stddev:5.46 (4.3%) stddev-sans-first:5.64 10:43:53 INFO - 2015-11-19 10:43:53,974 DEBUG : BROWSER_OUTPUT: Values: 121.0 125.0 131.0 121.0 127.0 120.0 132.0 131.0 120.0 117.0 10:43:53 INFO - 2015-11-19 10:43:53,974 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,974 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.90 Median:135.00 stddev:22.87 (16.9%) stddev-sans-first:23.78 10:43:53 INFO - 2015-11-19 10:43:53,974 DEBUG : BROWSER_OUTPUT: Values: 128.0 124.0 132.0 136.0 134.0 110.0 152.0 180.0 179.0 134.0 10:43:53 INFO - 2015-11-19 10:43:53,974 DEBUG : BROWSER_OUTPUT: 10:43:53 INFO - 2015-11-19 10:43:53,974 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:1.00 10:43:53 INFO - 2015-11-19 10:43:53,975 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 62.0 10:43:53 INFO - 2015-11-19 10:43:53,975 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:43:53 INFO - 2015-11-19 10:43:53,975 DEBUG : BROWSER_OUTPUT: 10:43:54 INFO - 2015-11-19 10:43:54,590 INFO : Browser exited with error code: 0 10:43:54 INFO - 2015-11-19 10:43:54,631 INFO : Completed test kraken (00:00:55) 10:43:54 INFO - 2015-11-19 10:43:54,631 INFO : Starting test v8_7 10:43:54 INFO - 2015-11-19 10:43:54,631 DEBUG : operating with platform_type : mac_ 10:43:54 INFO - 2015-11-19 10:43:54,631 INFO : Initialising browser for v8_7 test... 10:43:54 INFO - 2015-11-19 10:43:54,643 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpurmT3a/profile http://localhost:57223/getInfo.html 10:43:56 INFO - 2015-11-19 10:43:56,588 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:43:56 INFO - 2015-11-19 10:43:56,588 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:43:56 INFO - 2015-11-19 10:43:56,589 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:43:56 INFO - 2015-11-19 10:43:56,589 DEBUG : BROWSER_OUTPUT: __metrics 10:43:56 INFO - 2015-11-19 10:43:56,605 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:43:56 INFO - 2015-11-19 10:43:56,868 DEBUG : BROWSER_OUTPUT: console.error: 10:43:56 INFO - 2015-11-19 10:43:56,871 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 10:43:56 INFO - 2015-11-19 10:43:56,871 DEBUG : BROWSER_OUTPUT: Stack: 10:43:56 INFO - 2015-11-19 10:43:56,871 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 10:43:56 INFO - 2015-11-19 10:43:56,871 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 10:43:56 INFO - 2015-11-19 10:43:56,871 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 10:43:56 INFO - 2015-11-19 10:43:56,872 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 10:43:56 INFO - 2015-11-19 10:43:56,872 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 10:43:56 INFO - 2015-11-19 10:43:56,872 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 10:43:56 INFO - 2015-11-19 10:43:56,872 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:43:56 INFO - 2015-11-19 10:43:56,872 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 10:43:56 INFO - 2015-11-19 10:43:56,872 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 10:43:56 INFO - 2015-11-19 10:43:56,872 DEBUG : BROWSER_OUTPUT: 10:43:57 INFO - 2015-11-19 10:43:57,249 INFO : Browser initialized. 10:43:57 INFO - 2015-11-19 10:43:57,249 INFO : Running cycle 1/1 for v8_7 test... 10:43:57 INFO - 2015-11-19 10:43:57,249 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpurmT3a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:44:09 INFO - 2015-11-19 10:44:09,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 224231424 10:44:09 INFO - 2015-11-19 10:44:09,104 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57223/tests/v8_7/run.html (next: http://localhost:57223/tests/v8_7/run.html) 10:44:30 INFO - 2015-11-19 10:44:30,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 644788224 10:44:30 INFO - 2015-11-19 10:44:30,724 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,725 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:44:30 INFO - 2015-11-19 10:44:30,725 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |0;Richards;148.06040864672786 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.58840288252054 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4753.554502369669 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1763.668430335097 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |5;Earley;847.457627118644 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |6;Boyer;12512.5 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |7;RegExp;28714.285714285714 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |8;Splay;730.9941520467836 10:44:30 INFO - 2015-11-19 10:44:30,726 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4502.242152466368 10:44:30 INFO - 2015-11-19 10:44:30,727 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:44:30 INFO - 2015-11-19 10:44:30,727 DEBUG : BROWSER_OUTPUT: __startTimestamp1447958670724__endTimestamp 10:44:30 INFO - 2015-11-19 10:44:30,727 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,727 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:44:30 INFO - 2015-11-19 10:44:30,727 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:44:30 INFO - 2015-11-19 10:44:30,727 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,728 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.06 Median:148.06 stddev:0.00 (0.0%) 10:44:30 INFO - 2015-11-19 10:44:30,728 DEBUG : BROWSER_OUTPUT: Values: 148.1 10:44:30 INFO - 2015-11-19 10:44:30,728 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,728 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.59 Median:167.59 stddev:0.00 (0.0%) 10:44:30 INFO - 2015-11-19 10:44:30,728 DEBUG : BROWSER_OUTPUT: Values: 167.6 10:44:30 INFO - 2015-11-19 10:44:30,728 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,728 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 10:44:30 INFO - 2015-11-19 10:44:30,728 DEBUG : BROWSER_OUTPUT: Values: 279.4 10:44:30 INFO - 2015-11-19 10:44:30,728 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,728 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4753.55 Median:4753.55 stddev:0.00 (0.0%) 10:44:30 INFO - 2015-11-19 10:44:30,729 DEBUG : BROWSER_OUTPUT: Values: 4753.6 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1763.67 Median:1763.67 stddev:0.00 (0.0%) 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: Values: 1763.7 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:847.46 Median:847.46 stddev:0.00 (0.0%) 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: Values: 847.5 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: Values: 12512.5 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28714.29 Median:28714.29 stddev:0.00 (0.0%) 10:44:30 INFO - 2015-11-19 10:44:30,730 DEBUG : BROWSER_OUTPUT: Values: 28714.3 10:44:30 INFO - 2015-11-19 10:44:30,731 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,731 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:730.99 Median:730.99 stddev:0.00 (0.0%) 10:44:30 INFO - 2015-11-19 10:44:30,731 DEBUG : BROWSER_OUTPUT: Values: 731.0 10:44:30 INFO - 2015-11-19 10:44:30,731 DEBUG : BROWSER_OUTPUT: 10:44:30 INFO - 2015-11-19 10:44:30,731 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4502.24 Median:4502.24 stddev:0.00 (0.0%) 10:44:30 INFO - 2015-11-19 10:44:30,731 DEBUG : BROWSER_OUTPUT: Values: 4502.2 10:44:30 INFO - 2015-11-19 10:44:30,731 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:44:30 INFO - 2015-11-19 10:44:30,731 DEBUG : BROWSER_OUTPUT: 10:44:31 INFO - 2015-11-19 10:44:31,392 INFO : Browser exited with error code: 0 10:44:31 INFO - 2015-11-19 10:44:31,409 INFO : Completed test v8_7 (00:00:36) 10:44:31 INFO - 2015-11-19 10:44:31,872 INFO : Completed test suite (00:20:07) 10:44:31 INFO - 2015-11-19 10:44:31,873 DEBUG : Working with test: dromaeo_css 10:44:31 INFO - 2015-11-19 10:44:31,873 DEBUG : Generating results file: dromaeo_css 10:44:31 INFO - 2015-11-19 10:44:31,874 DEBUG : Working with test: kraken 10:44:31 INFO - 2015-11-19 10:44:31,874 DEBUG : Generating results file: kraken 10:44:31 INFO - 2015-11-19 10:44:31,874 INFO : javascript benchmark 10:44:31 INFO - 2015-11-19 10:44:31,874 DEBUG : Working with test: v8_7 10:44:31 INFO - 2015-11-19 10:44:31,875 DEBUG : Generating results file: v8_7 10:44:31 INFO - 2015-11-19 10:44:31,875 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:44:31 INFO - 2015-11-19 10:44:31,925 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 10:44:31 INFO - 2015-11-19 10:44:31,925 DEBUG : process_Request line: dromaeo_css 7258.73 graph.html#tests=[[72,1,59]] 10:44:31 INFO - 2015-11-19 10:44:31,925 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:44:31 INFO - 2015-11-19 10:44:31,965 DEBUG : process_Request line: kraken 1380.50 graph.html#tests=[[232,1,59]] 10:44:31 INFO - 2015-11-19 10:44:31,965 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:44:32 INFO - 2015-11-19 10:44:32,078 DEBUG : process_Request line: v8_7 20090.36 graph.html#tests=[[230,1,59]] 10:44:32 INFO - 2015-11-19 10:44:32,079 INFO : javascript benchmark 10:44:32 INFO - 2015-11-19 10:44:32,081 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3420.4527275635896, 3492.1269682579355, 3519.243362677024, 3520.0847779577316, 3545.929081418372, 5707.3721890592005, 5845.0647896336595, 5907.6750778707155, 5979.970100149499, 5992.850178745528, 4798.472168061519, 5907.970460147693, 5916.674582897949, 5940.702964851762, 5952.136940143688, 5363.168708850125, 5382.4886635769735, 5450.373207081197, 5466.972665136669, 5478.972605136969, 5482.945170548303, 5485.286912701344, 5488.1493368527945, 5493.176023596453, 5496.6701997880255, 5471.8084867029465, 5477.233187353754, 5480.808171713991, 5482.616216864821, 5484.204790305424, 5472.534834539069, 5481.945180548223, 5482.369527504348, 5482.862928426782, 5492.835214943558, 5312.07038768214, 5397.136458166714, 5419.647722897999, 5422.8373148805595, 5442.619016668835, 5920.052791553374, 6021.2473440819895, 6034.788782392639, 6038.154658347835, 6042.214512113441, 6343.018781172841, 6359.491240700733, 6366.586171898812, 6390.265119511269, 6396.0725694774, 6239.438450539428, 6257.342978987232, 6366.77716279928, 6367.808965731036, 6384.042393640944, 6061.151438798572, 6080.2399700037495, 6113.724882380215, 6117.327094019654, 6119.908201376983, 5087.949120508822, 6486.67566621667, 6507.837304067341, 6516.837079072966, 6536.24833144185, 6134.467201660938, 6169.043798211284, 6224.751009959641, 6250.74997000124, 6272.6236425814595, 6379.393957574023, 6382.489400847921, 6383.234011918599, 6398.2641996170105, 6414.102025716404, 6402.103705481236, 6402.263739669905, 6403.3276505966205, 6415.807525774234, 6416.358364163546, 6231.532635052389, 6245.781397651061, 6326.652034138075, 6352.745890164434, 6399.55203135776, 5078.822241221539, 5080.314157588752, 5087.542121209109, 5093.0, 5099.133147364957, 4538.455385353779, 4551.226291530448, 4561.521040290788, 4566.817327306937, 4605.723656580616, 5829.5044921181325, 5966.910496342558, 5968.820935371946, 5982.820515384546, 6085.391460853968, 6385.042243663488, 6396.648184349905, 6397.552171347961, 6400.615963042233, 6414.61512309263, 6013.639181649115, 6033.276006879202, 6035.939640603538, 6044.576879618385, 6054.091886217103, 5377.220303056113, 5482.396936337, 5483.232347471358, 5487.149491828773, 5488.396276409591, 6402.519811014099, 6424.10062591247, 6437.645929473924, 6443.226812782496, 6446.419822216023, 6272.780452684134, 6386.489080873612, 6386.744530218739, 6402.231732192166, 6420.357964203542, 6496.090547323284, 6516.185476815398, 6521.673916304071, 6523.086767852599, 6534.150560427304, 6222.968885155546, 6391.93608063932, 6391.93608063932, 6393.552451328363, 6418.390252925965, 6247.937850565506, 6263.6241825490615, 6357.554971151975, 6396.200474940632, 6409.679516024087, 6263.498920086291, 6268.059791031199, 6287.962486189727, 6296.024116261987, 6297.370262973666, 6077.665728384981, 6137.954115196617, 6147.600405973598, 6276.592021518587, 6283.120363149072, 6049.969750151397, 6100.176476175659, 6140.0, 6151.384861513991, 6153.046277826944, 5214.0, 6275.058741188858, 6275.968620157053, 6291.0, 6309.022101574264, 5984.102384642339, 6096.817095487142, 6180.845478863064, 6182.907256391248, 6194.752209911733], "unit": "ms", "name": "dojo.html", "value": 5871.411768941684}, {"lowerIsBetter": false, "replicates": [557.4230671255251, 559.8600349912521, 577.0536320434486, 583.2359608912323, 612.9816105516835, 31905.361892762132, 32147.51778723318, 32170.03489895301, 39097.8045109774, 40372.99067523314, 43406.565934340644, 43587.564124358745, 43852.0, 43899.0, 43902.90242743933, 9667.806643867101, 9861.852072218922, 9868.45723485208, 9869.358491698016, 9883.357581757198, 9661.710148695514, 9788.90211097887, 9797.853032204523, 9797.902020979805, 9818.018198180196, 9687.5640596173, 9745.025497450233, 9767.267454940873, 9769.658061967797, 9783.657571984982, 9630.566624501915, 9737.026297370277, 9743.220542356594, 9745.366551174151, 9747.268954828382, 9598.616055357777, 9717.90282097177, 9747.317687761859, 9750.366226195274, 9761.170300524464, 39830.40254396186, 40101.799491002355, 40222.396664050066, 40287.39568906469, 40314.58898938553, 2735.3161709572605, 3284.5237440571223, 3293.9953314239146, 3347.397468455677, 3418.7948723076697, 28430.0, 28519.287017824514, 28791.0, 29887.551686724717, 30042.24894377636, 2595.662563866704, 2629.907953221628, 2645.8809353579136, 2673.1980405878353, 2735.974009746345, 507041.0, 507609.0, 508490.0, 508616.0, 511201.0, 56375.43624563784, 57117.714411427674, 57500.27499175032, 64598.0, 66442.33894152589, 64947.35052649413, 65465.672671636334, 65670.67164664147, 65774.34225657777, 65774.67112664405, 16305.0, 16520.173991300388, 16536.173191340386, 16553.66892662164, 16557.337706491606, 11929.880701193051, 12091.27452352844, 12092.576759813364, 12181.634550963485, 12652.240865548096, 16416.589585260463, 17922.462326130237, 20633.96830158486, 21346.0, 21437.67843482349, 8763.605637746317, 8937.955310223408, 8955.0, 8961.327900407496, 9030.63877444895, 938.5401153434768, 963.1187463470985, 987.7678745494803, 1103.4648195625116, 1119.47944205943, 25175.62236566453, 27896.721032789817, 28383.864645414364, 28511.0, 28540.429191416057, 1083.3824719909576, 1091.5579190427889, 1162.0297051961538, 1179.2865316483576, 1182.2492717124517, 13889.097208681605, 14749.598788115112, 14791.112533248039, 14825.627581824054, 14860.03409778361, 503072.0, 556501.0, 557658.0, 558701.0, 561022.0, 49691.50308496941, 57770.0, 57938.420615794144, 58109.418905811246, 58220.4177958215, 1126.284809146198, 1305.4712841299288, 1446.3346860444312, 1450.173401161349, 1456.431991523328, 29158.854205728836, 33042.66957330396, 33432.1641958953, 33557.49663755095, 33724.0, 48623.02753944972, 49749.502504975935, 56411.43588564062, 57294.713526432104, 58299.4170058294, 500242.0, 504929.0, 508377.0, 509624.0, 510772.0, 45275.77362113168, 45531.08937821159, 45881.77059114683, 46356.30465542952, 46549.3017604743, 46635.76682116568, 47448.0, 47464.0, 49134.262986055954, 49259.75370123127, 38808.6119138805, 40013.39979900246, 41708.0, 43345.78327108344, 43734.56265437305, 36917.077073073386, 40571.78284651465, 42451.575484244764, 43578.69263922088, 43694.344584830615, 39155.6084439152, 39610.60389396069, 40506.594934050285, 40526.39210411787, 40659.0, 38729.6127038726, 39246.803765980985, 39434.40848387219, 40361.798191010035, 40557.797211013756, 26417.867910660323, 26677.599836002086, 26933.59599605968, 26957.191284261502, 27088.768313610224], "unit": "ms", "name": "ext.html", "value": 20471.54505297164}, {"lowerIsBetter": false, "replicates": [303.8070825026108, 304.72574682785495, 356.9072041269269, 357.0555879698197, 367.49836473214054, 13756.862431375683, 16181.867269291155, 19507.219711211554, 19893.801061989376, 21033.894830525864, 16916.238769255382, 18587.721184182214, 19375.612487750237, 21176.364709058715, 21811.127554897826, 5041.647084704072, 5157.974210128963, 6037.396260373971, 6215.595986260902, 6219.471344935686, 3607.7474576779637, 3701.222743223926, 3705.4256590228424, 5104.545204616685, 5153.149730294497, 5019.0, 5108.565771909392, 5122.410922743895, 5127.179651255799, 5131.923021154667, 4349.608535231844, 4985.302057711905, 5071.923921141186, 5108.948910510903, 5116.1814109742445, 4280.272353699878, 4294.377315289296, 4295.012147206129, 4299.226139294926, 4300.462442194726, 12674.683132921751, 13390.86609133906, 13902.721945561134, 14456.927715361357, 14489.347979340955, 1907.0369463421023, 1920.9135588898394, 1929.9517512062312, 1939.4957311099215, 1964.0572525187847, 10191.286609937308, 10263.178945684327, 10382.22133339995, 10462.738431539196, 10500.422476763775, 1643.7698722178905, 1645.2514106081703, 1648.077076836975, 1659.0460485221047, 1668.8748343874136, 88014.0, 89279.55360223222, 89849.55075224648, 90587.09412905852, 90666.09333906708, 6766.28953959837, 6809.93190068093, 6876.0, 6936.375726184668, 7015.36861682451, 7785.026871641045, 7865.960670196612, 7890.842183156305, 7907.802304942307, 7924.286814186751, 5728.885422291531, 5799.5650326225705, 5834.066549352084, 5835.503982161564, 5840.503557197686, 6268.402409314356, 6276.152719382825, 6291.402316779899, 6342.080398342307, 6356.713947872357, 3111.7355024823146, 3127.37452509499, 3128.921776955549, 3152.2119470132466, 3155.4635711929027, 1066.8399740039056, 1098.1873413673825, 1124.044562122206, 1142.8457158283525, 1157.988420115805, 436.3433033284886, 456.8332558616081, 459.3844248706749, 472.9550692684189, 499.61779238882286, 11852.407379630984, 12472.43874025671, 12550.497980080694, 12563.0, 12586.748265034648, 426.6949131371023, 474.36672042823216, 478.90182512584835, 495.7397366382678, 517.167360549515, 5358.356997160287, 6605.70274337656, 6623.635700036544, 6672.7330906764155, 6900.0, 783885.0, 784519.7908887229, 794141.322227283, 807410.0, 807622.0, 111141.0, 117921.82078179109, 119132.0, 121806.3909680446, 122176.38911805383, 513.8946515964218, 529.5366554265019, 531.4764956517904, 532.1751285507448, 532.3319234360853, 11518.884811152117, 11845.170838041255, 11873.703157420789, 11998.340091295062, 12021.218620789621, 39626.1178268095, 47020.7648961753, 48957.79689913891, 50815.72960676013, 50944.98110037853, 65705.67147164233, 66716.6664166676, 68361.31638683549, 71395.28604714094, 73721.0, 6300.873982520232, 6487.513436492376, 6492.675366231764, 6494.220693516808, 6513.1532900722605, 11992.64022079339, 12173.75652486963, 12323.137380383287, 12543.749125017266, 12547.686307842378, 3402.438597631462, 8933.776655583662, 10521.105706015074, 10725.552050473398, 11017.669469915916, 10675.786484270426, 10789.028987391173, 10986.176036797113, 11040.33757974524, 11259.268147570381, 8927.776805579913, 9315.97524272316, 9566.56950437218, 11316.547338106384, 11423.771524569296, 6019.1573179754, 6399.488040956619, 6554.672266386757, 6558.704858281293, 6568.211814582281, 8992.59533320989, 10964.06805421548, 11071.225014248925, 11106.16703747206, 11115.777684446428], "unit": "ms", "name": "jquery.html", "value": 7367.07461104021}, {"lowerIsBetter": false, "replicates": [1586.3099551695007, 1599.7040547498714, 1699.6430749542596, 1842.8341449269565, 1857.563472583943, 7376.631168441577, 7749.30256276935, 8157.5921203939715, 8293.709720159795, 8322.084570697234, 8082.191780821915, 8119.91880081199, 8213.671453141867, 8219.794505137359, 8247.05158906726, 1952.1410579345113, 2139.101577337522, 2360.445295355594, 2380.0955636858057, 2380.5952987991996, 2125.0543508138885, 2375.6674065630827, 2429.514097180562, 2432.7567243275707, 2433.853968761871, 2348.213348528245, 2358.870262135582, 2387.5941090014653, 2391.330427480308, 2394.5091256292503, 2136.807687308134, 2186.9125234990584, 2192.6710993350966, 2338.5907466193435, 2376.6316220985686, 2367.739548649647, 2421.128393778238, 2423.09134074722, 2423.236680445654, 2425.223928342931, 8115.95942020292, 8229.135940726197, 8234.423590348679, 8251.463654862415, 8263.173682631748, 5082.695038297714, 5188.5849132069725, 5200.323957885488, 5203.973980130113, 5217.47825217479, 3465.5148279240925, 3501.212227248874, 3609.4766258892314, 3618.8914332570066, 3621.8732344367822, 1047.4919663962971, 1049.2759995603085, 1062.3148069495132, 1071.7481391872905, 1079.7354648111184, 10714.571417143305, 10809.78380432387, 10838.078763305128, 10841.13270938331, 10846.67459976202, 4557.612602928788, 4620.976895115503, 4693.272542755878, 4705.6941298816155, 4725.243960966229, 9591.42451452915, 9643.9035609643, 9649.565769540248, 9662.71011869645, 9663.13031827139, 5167.328247327823, 5195.3246078009615, 5197.558207552324, 5200.583953283728, 5213.504717051874, 4697.201475749131, 4706.882327941828, 4732.0772449372735, 4735.573798358164, 4766.976165119152, 3668.9816550917076, 3735.6824669902817, 3746.756460830037, 3762.6801721853403, 3787.981060094737, 1226.0865655087018, 1228.2507670321097, 1233.1429656388723, 1235.0983781839307, 1254.5609036837216, 1363.3524076063989, 1365.7541642504445, 1403.9789403158961, 1405.3816320818808, 1410.0763999580292, 7536.397088232929, 7713.6143192841255, 7721.884171737428, 7723.227677232232, 7725.922740772633, 480.7620227987169, 485.58239913674214, 487.64889279718545, 490.11778798163164, 511.3378175263043, 5697.9430205698245, 5843.5325173985975, 5844.1818145459665, 5855.268091488564, 6076.361981991916, 8897.199252067345, 9293.67472138472, 9898.257630677728, 9911.157551608194, 9986.151177149879, 7503.962480187564, 9760.609575616896, 9824.11582957523, 9857.35927164732, 10197.847032294521, 7720.382369410434, 7792.0, 7845.843083138419, 7920.32677222431, 7926.524408535506, 6739.685761276504, 7026.473014523829, 7507.812304692427, 7643.968064311247, 7709.768706938801, 8295.83408331818, 8677.913220867964, 8933.553322333728, 9003.639854406012, 9051.954740226256, 9059.818803624023, 9230.676926307548, 9351.625934962525, 9363.85954210701, 9370.39092458988, 7134.785956421316, 7255.2019277878335, 7307.2327405621645, 7314.780556583311, 7317.231690672403, 7873.84252314939, 7919.16848730875, 7921.1682773307975, 7944.801379965547, 8010.639521221676, 7052.541584796972, 7229.710811567478, 7416.851662966818, 7435.442341824277, 7467.215942325977, 6657.4674026078765, 6820.420264277592, 7141.107361579802, 7197.748078817216, 7318.487705860539, 6780.881154609434, 6908.3091690830515, 7373.18894921569, 7380.557166570023, 7390.593517356597, 6710.261871194067, 6738.831529211809, 6762.188537375547, 6770.4922130839395, 6775.390214880685, 6821.386075253053, 6872.381485666314, 6875.140607424072, 6877.449804015767, 6882.518223724292], "unit": "ms", "name": "mootools.html", "value": 4624.147148147677}, {"lowerIsBetter": false, "replicates": [316.43516323362803, 323.0953330674112, 329.14422501496097, 330.6164848775421, 332.9134425049488, 5753.741081651326, 6901.792186367385, 7062.823429414268, 7070.5404148730295, 7078.929210707892, 5458.0, 6622.370874766902, 6755.695993680284, 6786.083878676377, 6977.441804655616, 5138.254953031808, 5167.7932882684645, 5180.4042535108565, 5180.948190518094, 5194.922076168841, 5176.870578235536, 5177.30106435632, 5177.58579313654, 5182.844514664566, 5203.4536373680785, 4845.73348465836, 4945.35710357653, 4996.050750357439, 5031.27046578246, 5074.3657042869645, 5056.266841308026, 5088.338515992916, 5095.337606111182, 5096.235564665311, 5132.717700526469, 4360.149770794665, 4370.409994650713, 4372.103718737651, 4376.474823021226, 4392.604665580113, 5363.597730170253, 6394.9360506394805, 6695.665216739144, 6703.195616525999, 6722.226943901465, 6039.607425517327, 6041.848953776147, 6052.878942421127, 6057.0, 6082.726277317532, 7436.628168591603, 7448.7392941247335, 7451.85096298071, 7460.925390746077, 7480.401567874557, 4586.495485496593, 4896.902061958776, 4898.804047838083, 4903.166461701519, 4911.852644420673, 7760.611969401507, 7849.5290282582655, 7938.285554300141, 7949.562774047425, 7958.084820245688, 4844.442889067803, 4845.563899249085, 4845.685030473008, 4847.709137451764, 4853.4418541867435, 4134.4005119258145, 4938.950610493921, 4942.0, 4945.950540494549, 4950.925736113961, 5738.311402631627, 5934.317553481319, 5943.881122377615, 5955.880882382328, 5964.314103878023, 7470.6264686766535, 7475.289847464483, 7486.887696684554, 7491.325780679765, 7498.925010749823, 1684.2925971091927, 1699.2438364927489, 1699.371232643905, 1702.446704820938, 1704.4375356132446, 1057.259918057363, 1080.448971024783, 1088.385062439719, 1098.0501865885951, 1102.459794700607, 5753.769849205984, 6914.896276555855, 6929.5842249464185, 6950.270221626757, 6960.060391847137, 7516.173220945691, 7743.109542402696, 7744.49660772048, 7767.262110099531, 7996.24035716606, 6162.445379915829, 6545.280019197884, 6845.794626161123, 6922.238553759083, 6952.165740111118, 3542.75200735946, 3965.9603403966166, 4065.6340929316502, 4134.214499245194, 4135.421041054255, 7813.984182056296, 7930.325922296554, 8067.354611631055, 8127.552984585905, 8130.0, 6492.92866676993, 7348.52234604749, 7377.59825633128, 8123.7156699515235, 8128.878066828884, 7843.843123137392, 8072.677092916218, 8130.268275855202, 8131.83736325282, 8133.186681331819, 7838.372930165687, 7841.5687137208, 7843.0, 7843.803904902423, 7846.5292082475235, 7682.577458239851, 7686.154523002577, 7686.46194766361, 7692.499987500794, 7693.49992250502, 7957.880631790412, 8116.228958248957, 8120.269175774209, 8197.139300373614, 8214.548199849065, 4834.419869615669, 4868.926966095441, 4886.071646387175, 4887.193613053949, 4887.951120488892, 6562.5406221564035, 6878.58728476293, 7716.189800070912, 7864.449488535747, 7876.212378762078, 7081.327273908971, 7218.205997340393, 7412.0364352633815, 7429.257074292527, 7508.211637777955, 7464.477486576105, 7475.140358858801, 7490.550566966, 7493.550386976799, 7502.924970750222, 7042.225355211025, 7283.927160728324, 7291.197968223385, 7300.269973002657, 7301.890471643036, 6083.574149809471, 7460.440466964891, 7481.251874812693, 7499.175090740124, 7510.098788145239, 5647.943520564741, 7178.461615378763, 7200.243974382614, 7336.0, 7390.815229619303], "unit": "ms", "name": "prototype.html", "value": 5384.146101025361}, {"lowerIsBetter": false, "replicates": [660.2044536333715, 784.5880912520929, 805.8227190018197, 806.27838084914, 862.1895418306789, 13037.348132593355, 15389.923050384747, 15639.843601563982, 15656.21718914054, 15660.451884184056, 13556.0, 14031.5088971886, 14244.71510569788, 14413.063150895185, 14419.134851908866, 951.2295041016764, 973.4062222044547, 973.435407463673, 980.9901900981006, 982.0474140084107, 952.380952380951, 967.0377973915928, 969.8933117357085, 972.523463502882, 973.2749101919045, 999.635133176389, 1011.9949400252989, 1012.4785735346303, 1012.5645972231937, 1018.7249442650517, 998.7602975285952, 1010.2574607663362, 1010.5200029985772, 1011.0496133634397, 1012.5392946209457, 751.3087959077607, 756.8221467955026, 757.5114051436792, 761.1931352766086, 762.9427792915498, 13610.659733506642, 13773.03588748788, 13787.103838250481, 13831.10097843647, 14607.78088328676, 10219.642312519101, 10288.639897603547, 10353.844692329621, 10544.209184311207, 10707.089897358734, 9772.267079969031, 9799.873014603269, 9804.46075465849, 9836.852447213298, 9938.552765125587, 3107.2231942014496, 3137.6862313768443, 3171.1120886151916, 3224.838758062111, 3280.7867488613165, 38785.806070969746, 41989.79005104985, 61728.38271617271, 68163.9999999995, 72141.63929180373, 7174.497785155094, 7198.244184360671, 7260.128784545888, 7287.234840341794, 7347.264475587232, 9771.755706107404, 12726.936365318114, 12732.299723515296, 12774.041946854024, 12811.743765124646, 5204.115300398941, 5844.26946631671, 6084.90872636902, 6545.05096760967, 6675.699593518303, 4069.694772892045, 4097.282975479279, 4104.138130992465, 4107.219628270619, 4111.444954931106, 3186.8406579671387, 3216.565763621928, 3220.5169224616493, 3223.2747631782663, 3233.8383080845865, 520.354760097484, 562.504995603866, 564.6527385657873, 585.7130006296884, 586.4487381861037, 474.12760520642183, 512.229095211704, 513.299346392172, 529.3066083430718, 537.3176066395733, 8367.372447066495, 8640.654373824977, 8643.0, 9263.25893928484, 9308.44149351041, 540.7377421950351, 601.8044135655929, 607.4988134788817, 625.0873724362482, 652.4063102576632, 3650.3976843821, 3677.485152078711, 3686.1337585667347, 3738.383166777451, 3784.791836449022, 104409.47795261127, 104434.4334834978, 104854.42718359231, 104913.0, 105105.47447262867, 71889.64055179691, 85958.0, 87408.0, 88256.11743882479, 89286.55356723175, 75569.62215188889, 75783.62108189423, 76091.09772255848, 76644.0, 77144.0, 8806.339524535813, 8862.556872156238, 8977.685780997634, 8989.415687980521, 9177.77055573616, 46331.53668463272, 51333.0, 53637.0, 54491.0, 54593.0, 64622.38444038937, 64829.351706484216, 66544.3363915906, 76200.0, 76220.0, 8139.10469848328, 8197.959010204911, 8226.794330141794, 8229.95885020571, 8487.490750554987, 12115.515379384726, 12159.331236782062, 12208.755824883276, 12212.145149839425, 12577.119601627799, 10038.001575918406, 10046.481041414365, 10124.291299608956, 10201.438920859424, 10322.0, 11582.478788454708, 11677.591284305008, 11948.223365481215, 12027.977621902237, 12374.0, 11421.428928553705, 11475.713107172387, 11594.6521604352, 12157.81763273534, 12267.57063502773, 8110.391720620859, 8740.344474164336, 9783.0, 10221.488925553842, 10383.013613706686, 9588.616455341707, 9883.851742224017, 10234.744131396477, 10257.794844103226, 10285.485725713834], "unit": "ms", "name": "yui.html", "value": 6634.22902774325}], "name": "dromaeo_css", "value": 7258.725820374299}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 109.0, 108.0, 108.0, 100.0, 109.0, 101.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 106.5}, {"lowerIsBetter": true, "replicates": [150.0, 119.0, 143.0, 158.0, 120.0, 141.0, 139.0, 114.0, 179.0, 145.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.8}, {"lowerIsBetter": true, "replicates": [187.0, 181.0, 179.0, 186.0, 184.0, 184.0, 185.0, 186.0, 188.0, 183.0], "unit": "ms", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [64.0, 70.0, 77.0, 73.0, 55.0, 58.0, 57.0, 72.0, 72.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 65.2}, {"lowerIsBetter": true, "replicates": [89.0, 82.0, 120.0, 75.0, 75.0, 73.0, 115.0, 75.0, 76.0, 114.0], "unit": "ms", "name": "audio-oscillator", "value": 89.4}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 83.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 84.5}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 92.0, 92.0, 92.0, 93.0, 93.0, 92.0, 93.0, 92.0], "unit": "ms", "name": "imaging-darkroom", "value": 92.3}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 87.0, 85.0, 84.0, 82.0, 86.0, 84.0, 86.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 84.7}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 56.0, 55.0, 55.0, 54.0, 55.0, 65.0, 54.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.8}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 63.0, 67.0, 68.0, 67.0, 68.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.6}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 82.0, 80.0, 82.0, 81.0, 81.0, 79.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.7}, {"lowerIsBetter": true, "replicates": [121.0, 125.0, 131.0, 121.0, 127.0, 120.0, 132.0, 131.0, 120.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [128.0, 124.0, 132.0, 136.0, 134.0, 110.0, 152.0, 180.0, 179.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.9}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.3}], "name": "kraken", "value": 1380.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.06040864672786], "unit": "score", "name": "Richards", "value": 238.42970799999995}, {"lowerIsBetter": false, "replicates": [167.58840288252054], "unit": "score", "name": "DeltaBlue", "value": 394.526106}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [4753.554502369669], "unit": "score", "name": "Decrypt", "value": 55.99620239282153}, {"lowerIsBetter": false, "replicates": [1763.668430335097], "unit": "score", "name": "RayTrace", "value": 419.5737630000002}, {"lowerIsBetter": false, "replicates": [847.457627118644], "unit": "score", "name": "Earley", "value": 786.42634}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [28714.285714285714], "unit": "score", "name": "RegExp", "value": 31.725845771144286}, {"lowerIsBetter": false, "replicates": [730.9941520467836], "unit": "score", "name": "Splay", "value": 111.47968800000002}, {"lowerIsBetter": false, "replicates": [4502.242152466368], "unit": "score", "name": "NavierStokes", "value": 329.61354581673305}], "name": "v8_7", "value": 20090.36289636425}]} 10:44:32 INFO - RETURN: dromaeo_css: 7258.73 10:44:32 INFO - RETURN: kraken: 1380.50 10:44:32 INFO - RETURN: v8_7: 20090.36 10:44:32 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,59]]", "result": "20090.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1380.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7258.73"}}} 10:44:32 INFO - Return code: 0 10:44:32 INFO - # TBPL SUCCESS # 10:44:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:44:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:44:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:44:32 INFO - 2015-11-19 10:44:32.162 screenresolution[2599:28295] starting screenresolution argv=screenresolution get 10:44:32 INFO - 2015-11-19 10:44:32.165 screenresolution[2599:28295] Display 0: 1600x1200x32@60 10:44:32 INFO - 2015-11-19 10:44:32.170 screenresolution[2600:28298] starting screenresolution argv=screenresolution list 10:44:32 INFO - Available Modes on Display 0 10:44:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:44:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:44:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:44:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:44:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:44:32 INFO - Intel Iris: 10:44:32 INFO - Chipset Model: Intel Iris 10:44:32 INFO - Type: GPU 10:44:32 INFO - Bus: Built-In 10:44:32 INFO - VRAM (Dynamic, Max): 1536 MB 10:44:32 INFO - Vendor: Intel (0x8086) 10:44:32 INFO - Device ID: 0x0a2e 10:44:32 INFO - Revision ID: 0x0009 10:44:32 INFO - Displays: 10:44:32 INFO - Display: 10:44:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:44:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:44:32 INFO - Display Serial Number: 1600x1200 60 10:44:32 INFO - Main Display: Yes 10:44:32 INFO - Mirror: Off 10:44:32 INFO - Online: Yes 10:44:32 INFO - Rotation: Supported 10:44:32 INFO - Return code: 0 10:44:32 INFO - Running post-action listener: _resource_record_post_action 10:44:32 INFO - Running post-run listener: _resource_record_post_run 10:44:33 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 114688; Write bytes: 686851584; Read time: 3; Write time: 2269 10:44:33 INFO - install - Wall time: 30s; CPU: 54.0%; Read bytes: 337132032; Write bytes: 334800384; Read time: 25843; Write time: 562 10:44:33 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 114688; Write bytes: 341299200; Read time: 3; Write time: 1676 10:44:33 INFO - Running post-run listener: _upload_blobber_files 10:44:33 INFO - Blob upload gear active. 10:44:33 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:44:33 INFO - Copying logs to upload dir... 10:44:33 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.041846 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-19 10:44:33.519628) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 10:44:33.523219) ========= 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.30tt3AY3oi/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.UgPiRvoUJs/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009751 build_url: 'https://queue.taskcluster.net/v1/task/NF4A1vizQeagsEkkYpMCRw/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-19 10:44:33.550136) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:44:33.550455) ========= 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.30tt3AY3oi/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.UgPiRvoUJs/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005219 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:44:33.598628) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 10:44:33.598970) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 10:44:33.599344) ========= ========= Total master_lag: 0.21 =========