builder: mozilla-inbound_yosemite_test-dromaeojs slave: t-yosemite-r5-0006 starttime: 1447672847.39 results: success (0) buildid: 20151116023436 builduid: e5982f6aa5f04318a991488a9f786092 revision: 6b311176b6354995c31b7cb761323f9566493e71 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.387289) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.387850) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.388200) ========= 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.sg9cJmNwsL/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.6NaMQftA2B/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006039 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.446017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.446815) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.476691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.477380) ========= 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.sg9cJmNwsL/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.6NaMQftA2B/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.027758 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.531307) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.531775) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.532334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.532674) ========= 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.sg9cJmNwsL/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.6NaMQftA2B/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-16 03:20:47-- 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% 16.7M=0.001s 2015-11-16 03:20:47 (16.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.225372 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.777471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:47.778064) ========= 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.sg9cJmNwsL/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.6NaMQftA2B/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.208350 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:48.004426) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 03:20:48.007911) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6b311176b6354995c31b7cb761323f9566493e71 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6b311176b6354995c31b7cb761323f9566493e71 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sg9cJmNwsL/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.6NaMQftA2B/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-16 03:20:48,091 truncating revision to first 12 chars 2015-11-16 03:20:48,091 Setting DEBUG logging. 2015-11-16 03:20:48,091 attempt 1/10 2015-11-16 03:20:48,091 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6b311176b635?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 03:20:49,113 unpacking tar archive at: mozilla-inbound-6b311176b635/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289169 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-16 03:20:49.314456) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:49.314852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:49.328196) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:49.328599) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 03:20:49.329111) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-16 03:20:49.329448) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sg9cJmNwsL/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.6NaMQftA2B/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 03:20:49 INFO - MultiFileLogger online at 20151116 03:20:49 in /builds/slave/test 03:20:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 03:20:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:20:49 INFO - {'append_to_log': False, 03:20:49 INFO - 'base_work_dir': '/builds/slave/test', 03:20:49 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 03:20:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:20:49 INFO - 'branch': 'Mozilla-Inbound', 03:20:49 INFO - 'buildbot_json_path': 'buildprops.json', 03:20:49 INFO - 'config_files': ('talos/mac_config.py',), 03:20:49 INFO - 'default_actions': ('clobber', 03:20:49 INFO - 'read-buildbot-config', 03:20:49 INFO - 'download-and-extract', 03:20:49 INFO - 'populate-webroot', 03:20:49 INFO - 'create-virtualenv', 03:20:49 INFO - 'install', 03:20:49 INFO - 'run-tests'), 03:20:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:20:49 INFO - 'download_minidump_stackwalk': True, 03:20:49 INFO - 'download_symbols': 'ondemand', 03:20:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:20:49 INFO - 'tooltool.py': '/tools/tooltool.py', 03:20:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:20:49 INFO - '/tools/misc-python/virtualenv.py')}, 03:20:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:20:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:20:49 INFO - 'installer_path': 'installer.exe', 03:20:49 INFO - 'log_level': 'info', 03:20:49 INFO - 'log_name': 'talos', 03:20:49 INFO - 'log_to_console': True, 03:20:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:20:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:20:49 INFO - 'opt_config_files': (), 03:20:49 INFO - 'pip_index': False, 03:20:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:49 INFO - 'cmd': ('bash', 03:20:49 INFO - '-c', 03:20:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:49 INFO - 'enabled': True, 03:20:49 INFO - 'halt_on_failure': False, 03:20:49 INFO - 'name': 'check_screen_resolution'},), 03:20:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:20:49 INFO - 'cmd': ('bash', 03:20:49 INFO - '-c', 03:20:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:20:49 INFO - 'enabled': True, 03:20:49 INFO - 'halt_on_failure': False, 03:20:49 INFO - 'name': 'check_screen_resolution'},), 03:20:49 INFO - 'run_cmd_checks_enabled': True, 03:20:49 INFO - 'sps_profile': False, 03:20:49 INFO - 'sps_profile_interval': 0, 03:20:49 INFO - 'suite': 'dromaeojs', 03:20:49 INFO - 'system_bits': '64', 03:20:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:20:49 INFO - 'title': 't-yosemite-r5-0006', 03:20:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:20:49 INFO - 'use_talos_json': True, 03:20:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:20:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:20:49 INFO - 'work_dir': 'build'} 03:20:49 INFO - ##### 03:20:49 INFO - ##### Running clobber step. 03:20:49 INFO - ##### 03:20:49 INFO - Running pre-action listener: _resource_record_pre_action 03:20:49 INFO - Running main action method: clobber 03:20:49 INFO - rmtree: /builds/slave/test/build 03:20:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:20:55 INFO - Running post-action listener: _resource_record_post_action 03:20:55 INFO - ##### 03:20:55 INFO - ##### Running read-buildbot-config step. 03:20:55 INFO - ##### 03:20:55 INFO - Running pre-action listener: _resource_record_pre_action 03:20:55 INFO - Running main action method: read_buildbot_config 03:20:55 INFO - Using buildbot properties: 03:20:55 INFO - { 03:20:55 INFO - "properties": { 03:20:55 INFO - "buildnumber": 3301, 03:20:55 INFO - "product": "firefox", 03:20:55 INFO - "script_repo_revision": "production", 03:20:55 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs", 03:20:55 INFO - "repository": "", 03:20:55 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs", 03:20:55 INFO - "buildid": "20151116023436", 03:20:55 INFO - "slavename": "t-yosemite-r5-0006", 03:20:55 INFO - "pgo_build": "False", 03:20:55 INFO - "basedir": "/builds/slave/test", 03:20:55 INFO - "project": "", 03:20:55 INFO - "platform": "yosemite", 03:20:55 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:20:55 INFO - "slavebuilddir": "test", 03:20:55 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 03:20:55 INFO - "branch": "mozilla-inbound", 03:20:55 INFO - "repo_path": "integration/mozilla-inbound", 03:20:55 INFO - "stage_platform": "macosx64", 03:20:55 INFO - "builduid": "e5982f6aa5f04318a991488a9f786092", 03:20:55 INFO - "revision": "6b311176b6354995c31b7cb761323f9566493e71" 03:20:55 INFO - }, 03:20:55 INFO - "sourcestamp": { 03:20:55 INFO - "repository": "", 03:20:55 INFO - "hasPatch": false, 03:20:55 INFO - "project": "", 03:20:55 INFO - "branch": "mozilla-inbound-macosx64-talos", 03:20:55 INFO - "changes": [ 03:20:55 INFO - { 03:20:55 INFO - "category": null, 03:20:55 INFO - "files": [ 03:20:55 INFO - { 03:20:55 INFO - "url": null, 03:20:55 INFO - "name": "https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 03:20:55 INFO - } 03:20:55 INFO - ], 03:20:55 INFO - "repository": "", 03:20:55 INFO - "rev": "6b311176b6354995c31b7cb761323f9566493e71", 03:20:55 INFO - "who": "nigelbabu@gmail.com", 03:20:55 INFO - "when": 1447672689, 03:20:55 INFO - "number": 6665483, 03:20:55 INFO - "comments": "Backed out changeset 0080bcc1cecc (bug 1223225) for Windows 8 PGO bc1 bustage ON A CLOSED TREE", 03:20:55 INFO - "project": "", 03:20:55 INFO - "at": "Mon 16 Nov 2015 03:18:09", 03:20:55 INFO - "branch": "mozilla-inbound-macosx64-talos", 03:20:55 INFO - "revlink": "", 03:20:55 INFO - "properties": [ 03:20:55 INFO - [ 03:20:55 INFO - "buildid", 03:20:55 INFO - "20151116023436", 03:20:55 INFO - "Change" 03:20:55 INFO - ], 03:20:55 INFO - [ 03:20:55 INFO - "builduid", 03:20:55 INFO - "e5982f6aa5f04318a991488a9f786092", 03:20:55 INFO - "Change" 03:20:55 INFO - ], 03:20:55 INFO - [ 03:20:55 INFO - "pgo_build", 03:20:55 INFO - "False", 03:20:55 INFO - "Change" 03:20:55 INFO - ] 03:20:55 INFO - ], 03:20:55 INFO - "revision": "6b311176b6354995c31b7cb761323f9566493e71" 03:20:55 INFO - } 03:20:55 INFO - ], 03:20:55 INFO - "revision": "6b311176b6354995c31b7cb761323f9566493e71" 03:20:55 INFO - } 03:20:55 INFO - } 03:20:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 03:20:55 INFO - Running post-action listener: _resource_record_post_action 03:20:55 INFO - ##### 03:20:55 INFO - ##### Running download-and-extract step. 03:20:55 INFO - ##### 03:20:55 INFO - Running pre-action listener: _resource_record_pre_action 03:20:55 INFO - Running main action method: download_and_extract 03:20:55 INFO - mkdir: /builds/slave/test/build/tests 03:20:55 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')]} 03:20:55 INFO - https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:20:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/test_packages.json 03:20:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/test_packages.json 03:20:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:20:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:20:55 INFO - Downloaded 1149 bytes. 03:20:55 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:20:55 INFO - Using the following test package requirements: 03:20:55 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:20:55 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:20:55 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 03:20:55 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:20:55 INFO - u'jsshell-mac.zip'], 03:20:55 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:20:55 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 03:20:55 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:20:55 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:20:55 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 03:20:55 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:20:55 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 03:20:55 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:20:55 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 03:20:55 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:20:55 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:20:55 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 03:20:55 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:20:55 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')]} 03:20:55 INFO - https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:20:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:20:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:20:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/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 03:20:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/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 03:20:56 INFO - Downloaded 17464056 bytes. 03:20:56 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 03:20:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:20:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:21:03 INFO - Return code: 0 03:21:03 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 03:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:03 INFO - https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:21:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:21:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:21:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/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 03:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/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 03:21:04 INFO - Downloaded 17464056 bytes. 03:21:04 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 03:21:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:21:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:21:10 INFO - Return code: 0 03:21:10 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')]} 03:21:10 INFO - https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:21:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:21:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:21:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/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 03:21:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/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 03:21:11 INFO - Downloaded 11131693 bytes. 03:21:11 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 03:21:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:21:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 03:21:11 INFO - Return code: 0 03:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:11 INFO - https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:21:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:21:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:21:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 03:21:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FEv3LKoyTOyIFyqDJQpI_g/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 03:21:15 INFO - Downloaded 108777555 bytes. 03:21:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:21:15 INFO - mkdir: /builds/slave/test/properties 03:21:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:15 INFO - Contents: 03:21:15 INFO - build_url:https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:21:15 INFO - Running post-action listener: _resource_record_post_action 03:21:15 INFO - Running post-action listener: set_extra_try_arguments 03:21:15 INFO - ##### 03:21:15 INFO - ##### Running populate-webroot step. 03:21:15 INFO - ##### 03:21:15 INFO - Running pre-action listener: _resource_record_pre_action 03:21:15 INFO - Running main action method: populate_webroot 03:21:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:21:15 INFO - '../fennec_ids.txt'], 03:21:15 INFO - 'tests': ['tcheck2']}, 03:21:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:15 INFO - '--tppagecycles', 03:21:15 INFO - '7'], 03:21:15 INFO - 'tests': ['tsvgm']}}, 03:21:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:21:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:21:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:21:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:21:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:21:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:15 INFO - 'talos_options': ['--e10s'], 03:21:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:15 INFO - 'tests': ['damp', 'tps']}, 03:21:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:15 INFO - 'talos_options': ['--e10s'], 03:21:15 INFO - 'tests': ['damp', 'tps']}, 03:21:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:21:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:15 INFO - 'other': {'tests': ['a11yr', 03:21:15 INFO - 'ts_paint', 03:21:15 INFO - 'tpaint', 03:21:15 INFO - 'sessionrestore', 03:21:15 INFO - 'sessionrestore_no_auto_restore']}, 03:21:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:21:15 INFO - 'tests': ['a11yr', 03:21:15 INFO - 'ts_paint', 03:21:15 INFO - 'tpaint', 03:21:15 INFO - 'sessionrestore', 03:21:15 INFO - 'sessionrestore_no_auto_restore']}, 03:21:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:21:15 INFO - 'tests': ['a11yr', 03:21:15 INFO - 'ts_paint', 03:21:15 INFO - 'tpaint', 03:21:15 INFO - 'sessionrestore', 03:21:15 INFO - 'sessionrestore_no_auto_restore']}, 03:21:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:21:15 INFO - 'tests': ['a11yr', 03:21:15 INFO - 'ts_paint', 03:21:15 INFO - 'tpaint', 03:21:15 INFO - 'sessionrestore', 03:21:15 INFO - 'sessionrestore_no_auto_restore']}, 03:21:15 INFO - 'other_l64': {'tests': ['a11yr', 03:21:15 INFO - 'ts_paint', 03:21:15 INFO - 'tpaint', 03:21:15 INFO - 'sessionrestore', 03:21:15 INFO - 'sessionrestore_no_auto_restore']}, 03:21:15 INFO - 'other_nol64': {'tests': ['a11yr', 03:21:15 INFO - 'ts_paint', 03:21:15 INFO - 'tpaint', 03:21:15 INFO - 'sessionrestore', 03:21:15 INFO - 'sessionrestore_no_auto_restore']}, 03:21:15 INFO - 'svgr': {'tests': ['tsvgx', 03:21:15 INFO - 'tsvgr_opacity', 03:21:15 INFO - 'tart', 03:21:15 INFO - 'tscrollx', 03:21:15 INFO - 'cart']}, 03:21:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:21:15 INFO - 'tests': ['tsvgx', 03:21:15 INFO - 'tsvgr_opacity', 03:21:15 INFO - 'tart', 03:21:15 INFO - 'tscrollx', 03:21:15 INFO - 'cart']}, 03:21:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:15 INFO - 'tests': ['tp5o']}, 03:21:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:15 INFO - 'talos_options': ['--e10s'], 03:21:15 INFO - 'tests': ['tp5o']}, 03:21:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:15 INFO - 'talos_options': ['--xperf_path', 03:21:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:15 INFO - 'tests': ['tp5n']}, 03:21:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:15 INFO - 'talos_options': ['--e10s', 03:21:15 INFO - '--xperf_path', 03:21:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:15 INFO - 'tests': ['tp5n']}}, 03:21:15 INFO - 'talos.zip': {'path': '', 03:21:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:15 INFO - Running post-action listener: _resource_record_post_action 03:21:15 INFO - ##### 03:21:15 INFO - ##### Running create-virtualenv step. 03:21:15 INFO - ##### 03:21:15 INFO - Running pre-action listener: _resource_record_pre_action 03:21:15 INFO - Running main action method: create_virtualenv 03:21:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:15 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 03:21:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:15 INFO - Using real prefix '/tools/python27' 03:21:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:20 INFO - Installing pip.................done. 03:21:20 INFO - Return code: 0 03:21:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105746490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba805611a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056699f0>, '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 0x1053c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10565d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/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.6NaMQftA2B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:21:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/Render', 03:21:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:20 INFO - 'HOME': '/Users/cltbld', 03:21:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:20 INFO - 'LOGNAME': 'cltbld', 03:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:20 INFO - 'MOZ_NO_REMOTE': '1', 03:21:20 INFO - 'NO_EM_RESTART': '1', 03:21:20 INFO - 'PAGER': '/bin/cat', 03:21:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:20 INFO - 'PWD': '/builds/slave/test', 03:21:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:20 INFO - 'SHELL': '/bin/bash', 03:21:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NaMQftA2B/Listeners', 03:21:20 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 03:21:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:20 INFO - 'USER': 'cltbld', 03:21:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:20 INFO - 'XPC_FLAGS': '0x0', 03:21:20 INFO - 'XPC_SERVICE_NAME': '0', 03:21:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:21 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 03:21:21 INFO - Cleaning up... 03:21:21 INFO - Return code: 0 03:21:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:21:21 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')]} 03:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:21 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')]} 03:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:21 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 0x105746490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba805611a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056699f0>, '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 0x1053c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10565d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/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.6NaMQftA2B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:21 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 03:21:21 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 03:21:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/Render', 03:21:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:21 INFO - 'HOME': '/Users/cltbld', 03:21:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:21 INFO - 'LOGNAME': 'cltbld', 03:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:21 INFO - 'MOZ_NO_REMOTE': '1', 03:21:21 INFO - 'NO_EM_RESTART': '1', 03:21:21 INFO - 'PAGER': '/bin/cat', 03:21:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:21 INFO - 'PWD': '/builds/slave/test', 03:21:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:21 INFO - 'SHELL': '/bin/bash', 03:21:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NaMQftA2B/Listeners', 03:21:21 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 03:21:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:21 INFO - 'USER': 'cltbld', 03:21:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:21 INFO - 'XPC_FLAGS': '0x0', 03:21:21 INFO - 'XPC_SERVICE_NAME': '0', 03:21:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:21 INFO - Downloading/unpacking psutil>=0.7.1 03:21:21 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 03:21:21 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 03:21:21 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 03:21:21 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 03:21:21 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 03:21:21 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 03:21:24 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:21:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:24 INFO - Installing collected packages: psutil 03:21:24 INFO - Running setup.py install for psutil 03:21:24 INFO - building 'psutil._psutil_osx' extension 03:21:24 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 03:21:26 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 03:21:27 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 03:21:27 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 03:21:27 INFO - building 'psutil._psutil_posix' extension 03:21:27 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 03:21:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:21:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:21:27 INFO - ^ 03:21:27 INFO - 1 warning generated. 03:21:27 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 03:21:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:27 INFO - Successfully installed psutil 03:21:27 INFO - Cleaning up... 03:21:28 INFO - Return code: 0 03:21:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:28 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 0x105746490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba805611a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056699f0>, '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 0x1053c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10565d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/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.6NaMQftA2B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:28 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 03:21:28 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 03:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/Render', 03:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:28 INFO - 'HOME': '/Users/cltbld', 03:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:28 INFO - 'LOGNAME': 'cltbld', 03:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:28 INFO - 'MOZ_NO_REMOTE': '1', 03:21:28 INFO - 'NO_EM_RESTART': '1', 03:21:28 INFO - 'PAGER': '/bin/cat', 03:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:28 INFO - 'PWD': '/builds/slave/test', 03:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:28 INFO - 'SHELL': '/bin/bash', 03:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NaMQftA2B/Listeners', 03:21:28 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 03:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:28 INFO - 'USER': 'cltbld', 03:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:28 INFO - 'XPC_FLAGS': '0x0', 03:21:28 INFO - 'XPC_SERVICE_NAME': '0', 03:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:21:28 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 03:21:28 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 03:21:28 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 03:21:28 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 03:21:28 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 03:21:28 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 03:21:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:21:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:21:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:21:30 INFO - Installing collected packages: mozsystemmonitor 03:21:30 INFO - Running setup.py install for mozsystemmonitor 03:21:30 INFO - Successfully installed mozsystemmonitor 03:21:30 INFO - Cleaning up... 03:21:31 INFO - Return code: 0 03:21:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105746490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba805611a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056699f0>, '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 0x1053c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10565d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/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.6NaMQftA2B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:21:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/Render', 03:21:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:31 INFO - 'HOME': '/Users/cltbld', 03:21:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:31 INFO - 'LOGNAME': 'cltbld', 03:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:31 INFO - 'MOZ_NO_REMOTE': '1', 03:21:31 INFO - 'NO_EM_RESTART': '1', 03:21:31 INFO - 'PAGER': '/bin/cat', 03:21:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:31 INFO - 'PWD': '/builds/slave/test', 03:21:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:31 INFO - 'SHELL': '/bin/bash', 03:21:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NaMQftA2B/Listeners', 03:21:31 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 03:21:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:31 INFO - 'USER': 'cltbld', 03:21:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:31 INFO - 'XPC_FLAGS': '0x0', 03:21:31 INFO - 'XPC_SERVICE_NAME': '0', 03:21:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21:33 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 03:21:33 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 03:21:33 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 03:21:33 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 03:21:33 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 03:21:33 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 03:21:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:34 INFO - Downloading docopt-0.6.1.tar.gz 03:21:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:35 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:35 INFO - Running setup.py install for blobuploader 03:21:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:35 INFO - Running setup.py install for requests 03:21:35 INFO - Running setup.py install for docopt 03:21:35 INFO - Successfully installed blobuploader requests docopt 03:21:35 INFO - Cleaning up... 03:21:35 INFO - Return code: 0 03:21:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:35 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 0x105746490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba805611a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056699f0>, '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 0x1053c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10565d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/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.6NaMQftA2B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:35 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 03:21:35 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 03:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/Render', 03:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:35 INFO - 'HOME': '/Users/cltbld', 03:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:35 INFO - 'LOGNAME': 'cltbld', 03:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:35 INFO - 'MOZ_NO_REMOTE': '1', 03:21:35 INFO - 'NO_EM_RESTART': '1', 03:21:35 INFO - 'PAGER': '/bin/cat', 03:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:35 INFO - 'PWD': '/builds/slave/test', 03:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:35 INFO - 'SHELL': '/bin/bash', 03:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NaMQftA2B/Listeners', 03:21:35 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 03:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:35 INFO - 'USER': 'cltbld', 03:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:35 INFO - 'XPC_FLAGS': '0x0', 03:21:35 INFO - 'XPC_SERVICE_NAME': '0', 03:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:36 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-Li2fpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:36 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-Tajh_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:36 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-Yc1e83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:36 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-BKp76H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:36 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-86RTcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:36 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-4ad4KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:37 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-VyAjrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:37 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-xy6fTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:37 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-zYWIIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:37 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-78jIoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:37 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-nBzdjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:37 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-FQDMMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:37 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-xhLmbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:37 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-6GHJfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:38 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-0xEWK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:38 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-dEYRVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:38 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-ORBNIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:38 INFO - Running setup.py install for manifestparser 03:21:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:38 INFO - Running setup.py install for mozcrash 03:21:38 INFO - Running setup.py install for mozdebug 03:21:38 INFO - Running setup.py install for mozdevice 03:21:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Running setup.py install for mozfile 03:21:39 INFO - Running setup.py install for mozhttpd 03:21:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Running setup.py install for mozinfo 03:21:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Running setup.py install for mozInstall 03:21:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:39 INFO - Running setup.py install for mozleak 03:21:39 INFO - Running setup.py install for mozlog 03:21:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Running setup.py install for moznetwork 03:21:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Running setup.py install for mozprocess 03:21:40 INFO - Running setup.py install for mozprofile 03:21:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Running setup.py install for mozrunner 03:21:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:40 INFO - Running setup.py install for mozscreenshot 03:21:41 INFO - Running setup.py install for moztest 03:21:41 INFO - Running setup.py install for mozversion 03:21:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:41 INFO - Cleaning up... 03:21:41 INFO - Return code: 0 03:21:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:41 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')]} 03:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:41 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')]} 03:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:41 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 0x105746490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba805611a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056699f0>, '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 0x1053c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10565d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/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.6NaMQftA2B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21:41 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 03:21:41 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 03:21:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/Render', 03:21:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:41 INFO - 'HOME': '/Users/cltbld', 03:21:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:41 INFO - 'LOGNAME': 'cltbld', 03:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:41 INFO - 'MOZ_NO_REMOTE': '1', 03:21:41 INFO - 'NO_EM_RESTART': '1', 03:21:41 INFO - 'PAGER': '/bin/cat', 03:21:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:41 INFO - 'PWD': '/builds/slave/test', 03:21:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:41 INFO - 'SHELL': '/bin/bash', 03:21:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NaMQftA2B/Listeners', 03:21:41 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 03:21:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:41 INFO - 'USER': 'cltbld', 03:21:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:41 INFO - 'XPC_FLAGS': '0x0', 03:21:41 INFO - 'XPC_SERVICE_NAME': '0', 03:21:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:41 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-yFc30w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:41 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)) 03:21:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:41 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-CozNah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:42 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-FGrsIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:42 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-cz8fOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:42 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-N6o2ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:42 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-QkP9Sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:42 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-2mPRc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:42 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-QtVR8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:42 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-Mni8uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:42 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)) 03:21:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:42 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-nU0Yn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:43 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)) 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:43 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-c0wgQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:43 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)) 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:43 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-qLKhNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:43 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)) 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:43 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-_n8CPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:43 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)) 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:43 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-0H_cR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:43 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)) 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:43 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-KLvlGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:43 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)) 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:43 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-GXghsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:43 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)) 03:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:43 INFO - Running setup.py (path:/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/pip-3LUvt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:43 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)) 03:21:43 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)) 03:21:43 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)) 03:21:43 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)) 03:21:43 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)) 03:21:43 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)) 03:21:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:43 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 03:21:43 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 03:21:43 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 03:21:43 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 03:21:43 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 03:21:43 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 03:21:46 INFO - Downloading blessings-1.5.1.tar.gz 03:21:46 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 03:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:46 INFO - Installing collected packages: blessings 03:21:46 INFO - Running setup.py install for blessings 03:21:46 INFO - Successfully installed blessings 03:21:46 INFO - Cleaning up... 03:21:46 INFO - Return code: 0 03:21:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:47 INFO - Reading from file tmpfile_stdout 03:21:47 INFO - Current package versions: 03:21:47 INFO - blessings == 1.5.1 03:21:47 INFO - blobuploader == 1.2.4 03:21:47 INFO - docopt == 0.6.1 03:21:47 INFO - manifestparser == 1.1 03:21:47 INFO - mozInstall == 1.12 03:21:47 INFO - mozcrash == 0.16 03:21:47 INFO - mozdebug == 0.1 03:21:47 INFO - mozdevice == 0.47 03:21:47 INFO - mozfile == 1.2 03:21:47 INFO - mozhttpd == 0.7 03:21:47 INFO - mozinfo == 0.9 03:21:47 INFO - mozleak == 0.1 03:21:47 INFO - mozlog == 3.0 03:21:47 INFO - moznetwork == 0.27 03:21:47 INFO - mozprocess == 0.22 03:21:47 INFO - mozprofile == 0.27 03:21:47 INFO - mozrunner == 6.11 03:21:47 INFO - mozscreenshot == 0.1 03:21:47 INFO - mozsystemmonitor == 0.0 03:21:47 INFO - moztest == 0.7 03:21:47 INFO - mozversion == 1.4 03:21:47 INFO - psutil == 3.1.1 03:21:47 INFO - requests == 1.2.3 03:21:47 INFO - wsgiref == 0.1.2 03:21:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21: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')]} 03:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21: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')]} 03:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21: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/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 0x105746490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105723228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba805611a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056699f0>, '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 0x1053c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10565d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/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.6NaMQftA2B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:21: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/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 03:21: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/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 03:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/Render', 03:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:21:47 INFO - 'HOME': '/Users/cltbld', 03:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:21:47 INFO - 'LOGNAME': 'cltbld', 03:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:47 INFO - 'MOZ_NO_REMOTE': '1', 03:21:47 INFO - 'NO_EM_RESTART': '1', 03:21:47 INFO - 'PAGER': '/bin/cat', 03:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:47 INFO - 'PWD': '/builds/slave/test', 03:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:21:47 INFO - 'SHELL': '/bin/bash', 03:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NaMQftA2B/Listeners', 03:21:47 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 03:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:21:47 INFO - 'USER': 'cltbld', 03:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:47 INFO - 'XPC_FLAGS': '0x0', 03:21:47 INFO - 'XPC_SERVICE_NAME': '0', 03:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:47 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)) 03:21:47 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)) 03:21:47 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)) 03:21:47 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)) 03:21:47 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)) 03:21:47 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)) 03:21:47 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)) 03:21:47 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)) 03:21:47 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)) 03:21:47 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)) 03:21:47 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)) 03:21:47 INFO - Cleaning up... 03:21:47 INFO - Return code: 0 03:21:47 INFO - Running post-action listener: _resource_record_post_action 03:21:47 INFO - Running post-action listener: _start_resource_monitoring 03:21:47 INFO - Starting resource monitoring. 03:21:47 INFO - ##### 03:21:47 INFO - ##### Running install step. 03:21:47 INFO - ##### 03:21:47 INFO - Running pre-action listener: _resource_record_pre_action 03:21:47 INFO - Running main action method: install 03:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:47 INFO - Reading from file tmpfile_stdout 03:21:47 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:48 INFO - Reading from file tmpfile_stdout 03:21:48 INFO - Output received: 03:21:48 INFO - Usage: mozinstall [options] installer 03:21:48 INFO - Options: 03:21:48 INFO - -h, --help show this help message and exit 03:21:48 INFO - -d DEST, --destination=DEST 03:21:48 INFO - Directory to install application into. [default: 03:21:48 INFO - "/builds/slave/test"] 03:21:48 INFO - --app=APP Application being installed. [default: firefox] 03:21:48 INFO - mkdir: /builds/slave/test/build/application 03:21:48 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'] 03:21:48 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 03:22:26 INFO - Reading from file tmpfile_stdout 03:22:26 INFO - Output received: 03:22:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:22:26 INFO - Running post-action listener: _resource_record_post_action 03:22:26 INFO - ##### 03:22:26 INFO - ##### Running run-tests step. 03:22:26 INFO - ##### 03:22:26 INFO - Running pre-action listener: _resource_record_pre_action 03:22:26 INFO - Running main action method: run_tests 03:22:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:22:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:22:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:22:26 INFO - 2015-11-16 03:22:26.236 screenresolution[1638:7627] starting screenresolution argv=screenresolution get 03:22:26 INFO - 2015-11-16 03:22:26.239 screenresolution[1638:7627] Display 0: 1600x1200x32@60 03:22:26 INFO - 2015-11-16 03:22:26.245 screenresolution[1639:7629] starting screenresolution argv=screenresolution list 03:22:26 INFO - Available Modes on Display 0 03:22:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:22:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:22:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:22:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:22:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:22:26 INFO - Intel HD Graphics 3000: 03:22:26 INFO - Chipset Model: Intel HD Graphics 3000 03:22:26 INFO - Type: GPU 03:22:26 INFO - Bus: Built-In 03:22:26 INFO - VRAM (Total): 512 MB 03:22:26 INFO - VRAM (Dynamic, Max): 10 03:22:26 INFO - Vendor: Intel (0x8086) 03:22:26 INFO - Device ID: 0x0116 03:22:26 INFO - Revision ID: 0x0009 03:22:26 INFO - Displays: 03:22:26 INFO - Display: 03:22:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:22:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:22:26 INFO - Display Serial Number: 1600x1200 60 03:22:26 INFO - Main Display: Yes 03:22:26 INFO - Mirror: Off 03:22:26 INFO - Online: Yes 03:22:26 INFO - Rotation: Supported 03:22:26 INFO - Return code: 0 03:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:22:26 INFO - Python 2.7.3 03:22:26 INFO - Return code: 0 03:22:26 INFO - grabbing minidump binary from tooltool 03:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:26 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 0x1056699f0>, '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 0x1053c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10565d8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:22:26 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 03:22:26 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 03:22:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:26 INFO - Return code: 0 03:22:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:22:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:22:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:22:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:22:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0006', '--webServer', 'localhost'] in /builds/slave/test/build 03:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0006 --webServer localhost 03:22:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sg9cJmNwsL/Render', 03:22:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:22:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:22:26 INFO - 'HOME': '/Users/cltbld', 03:22:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:22:26 INFO - 'LOGNAME': 'cltbld', 03:22:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:22:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:22:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:26 INFO - 'MOZ_NO_REMOTE': '1', 03:22:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:22:26 INFO - 'NO_EM_RESTART': '1', 03:22:26 INFO - 'PAGER': '/bin/cat', 03:22:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:22:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:22:26 INFO - 'PWD': '/builds/slave/test', 03:22:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:22:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:22:26 INFO - 'SHELL': '/bin/bash', 03:22:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6NaMQftA2B/Listeners', 03:22:26 INFO - 'TMPDIR': '/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/', 03:22:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:22:26 INFO - 'USER': 'cltbld', 03:22:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:22:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:22:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:26 INFO - 'XPC_FLAGS': '0x0', 03:22:26 INFO - 'XPC_SERVICE_NAME': '0', 03:22:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:22:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0006', '--webServer', 'localhost'] with output_timeout 3600 03:22:27 INFO - mozversion INFO | application_buildid: 20151116023436 03:22:27 INFO - mozversion INFO | application_changeset: 6b311176b6354995c31b7cb761323f9566493e71 03:22:27 INFO - mozversion INFO | application_display_name: Nightly 03:22:27 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:27 INFO - mozversion INFO | application_name: Firefox 03:22:27 INFO - mozversion INFO | application_remotingname: firefox 03:22:27 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:22:27 INFO - mozversion INFO | application_vendor: Mozilla 03:22:27 INFO - mozversion INFO | application_version: 45.0a1 03:22:27 INFO - mozversion INFO | platform_buildid: 20151116023436 03:22:27 INFO - mozversion INFO | platform_changeset: 6b311176b6354995c31b7cb761323f9566493e71 03:22:27 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 03:22:27 INFO - mozversion INFO | platform_version: 45.0a1 03:22:27 INFO - 2015-11-16 03:22:27,005 DEBUG : using testdate: 1447672947 03:22:27 INFO - 2015-11-16 03:22:27,005 DEBUG : actual date: 1447672947 03:22:27 INFO - 2015-11-16 03:22:27,015 INFO : starting webserver on 'localhost:49266' 03:22:27 INFO - 2015-11-16 03:22:27,016 INFO : Starting test suite t-yosemite-r5-0006 03:22:27 INFO - 2015-11-16 03:22:27,016 INFO : Starting test dromaeo_css 03:22:27 INFO - 2015-11-16 03:22:27,017 DEBUG : operating with platform_type : mac_ 03:22:27 INFO - 2015-11-16 03:22:27,018 INFO : Initialising browser for dromaeo_css test... 03:22:27 INFO - 2015-11-16 03:22:27,054 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpq8Ad_e/profile http://localhost:49266/getInfo.html 03:22:30 INFO - 2015-11-16 03:22:30,187 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:22:30 INFO - 2015-11-16 03:22:30,187 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:22:30 INFO - 2015-11-16 03:22:30,187 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:22:30 INFO - 2015-11-16 03:22:30,187 DEBUG : BROWSER_OUTPUT: __metrics 03:22:30 INFO - 2015-11-16 03:22:30,208 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:22:30 INFO - 2015-11-16 03:22:30,950 INFO : Browser initialized. 03:22:30 INFO - 2015-11-16 03:22:30,951 INFO : Running cycle 1/1 for dromaeo_css test... 03:22:30 INFO - 2015-11-16 03:22:30,951 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpq8Ad_e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:22:42 INFO - 2015-11-16 03:22:42,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 228708352 03:22:42 INFO - 2015-11-16 03:22:42,925 DEBUG : BROWSER_OUTPUT: 03:23:33 INFO - 2015-11-16 03:23:33,919 DEBUG : BROWSER_OUTPUT: 1447673013914 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] 03:25:45 INFO - 2015-11-16 03:25:45,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 03:25:46 INFO - 2015-11-16 03:25:46,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 349364224 03:25:46 INFO - 2015-11-16 03:25:46,269 DEBUG : BROWSER_OUTPUT: 03:28:48 INFO - 2015-11-16 03:28:48,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 03:28:49 INFO - 2015-11-16 03:28:49,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 363372544 03:28:49 INFO - 2015-11-16 03:28:49,439 DEBUG : BROWSER_OUTPUT: 03:31:51 INFO - 2015-11-16 03:31:51,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 03:31:52 INFO - 2015-11-16 03:31:52,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 332316672 03:31:52 INFO - 2015-11-16 03:31:52,251 DEBUG : BROWSER_OUTPUT: 03:34:54 INFO - 2015-11-16 03:34:54,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 03:34:54 INFO - 2015-11-16 03:34:54,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 320933888 03:34:54 INFO - 2015-11-16 03:34:54,967 DEBUG : BROWSER_OUTPUT: 03:37:58 INFO - 2015-11-16 03:37:58,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 03:37:58 INFO - 2015-11-16 03:37:58,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 322428928 03:37:58 INFO - 2015-11-16 03:37:58,958 DEBUG : BROWSER_OUTPUT: 03:41:01 INFO - 2015-11-16 03:41:01,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 03:41:02 INFO - 2015-11-16 03:41:02,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 373739520 03:41:02 INFO - 2015-11-16 03:41:02,086 DEBUG : BROWSER_OUTPUT: 03:41:02 INFO - 2015-11-16 03:41:02,087 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:41:02 INFO - 2015-11-16 03:41:02,087 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:41:02 INFO - 2015-11-16 03:41:02,087 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:41:02 INFO - 2015-11-16 03:41:02,087 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:41:02 INFO - 2015-11-16 03:41:02,088 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3172.7303179229766;3239.7408207343406;3247.3829972305243;3250.707436330733;3293.4565796643556;5277.340332458442;5334.946650533493;5346.010987967229;5394.676319420838;5422.240886275925;5326.174442961337;5393.649412788176;5443.346798384199;5452.754626041828;5505.587080968923;4880.682755620891;4950.480199579047;4988.451270360276;5003.2995380646735;5089;5080.1617733074;5107.029664363778;5114.079465696173;5129.820456284031;5207.505286997748;4728.95271047292;4831.758412079382;4843.830465933711;4874.65877388583;5052.570531504808;4629.1436084324505;4955.430125535573;4959.05777902201;4959.603231741452;4966.354373931402;4919.385076865392;4925.236588328779;4926.901461970776;4963.305137280783;4972.428170760337;5191.792328306901;5298.470152984709;5331.600129990266;5356.812511562116;5459.017376872162;5707.229524014288;5751.424857514216;5784.392638772911;5812.738426770806;5812.854678633025;5747.6551406915305;5748.109043098327;5765.827025189251;5767.711614419304;5834.912476312858;5255.264263003182;5368.4363141869935;5375.139977603643;5400.189971504266;5450.863728406743;5752.798652047159;5848.619839710405;5856.882862342729;5906.173135760997;5953.553483488756;5698;5708.229389032511;5711.143328500675;5746.310442746813;5776.624519406225;5649.4633009864;5708.971455142698;5784.074548072288;5928.140419639129;5933.258342707161;5393.865153371197;5472.288602481652;5530.585206109477;5534.0315444797;5546.473085056913;5769.423057694197;5784.363719990798;5809.186713860063;5828.009238429478;5842.152887831326;4434.11317736454;4536.977315113403;4544.7500387479;4596.218642830727;4655.3249778782565;4051.6150965658217;4053.5135783705555;4109.404136400265;4122.752634841919;4135.462389889295;5421;5442.591805614595;5463.754131064112;5502.532284755761;5526.751296191681;5719.48524632785;5787.131930210502;5860.501857342174;5874.265716785402;5924.289085309791;5291.7354132294;5364.8122315718765;5432.402435732066;5439.347278326626;5464.726763661801;5079.31429257053;5158.4067832199025;5197.870053248624;5207.71357575337;5216.634835561475;5721.685307308138;5800.651960882192;5813.593048486566;5865.560082993792;5922.644641321534;5851.063829787214;5864.765409383577;5921;5921.61509501881;5963.821085367446;5908.438698323653;5935.584509084322;5941.22764040672;5969.194158788508;5975.760969561169;5572.331320241597;5612;5638.492535671645;5788.305403351625;5812.21535092757;5748.310202775527;5791;5803.970980145073;5819.5635327351465;5830.154627579062;5725.370209276893;5735.7418916148035;5752.856178595402;5793.565482588739;5798.362180160095;5549.528290095387;5730.169125476866;5745.511631511368;5773.6824474654295;5792.53659707214;5430.755615997368;5523.005858945428;5575.9163612545035;5582.581306401955;5621.971890140523;5592.3009623797025;5667.40492248308;5670.092785154356;5685.459881311269;5696.971515142398;5402.054640437829;5457.972710136424;5508.779648814003;5520.282363292907;5556.944430555643 03:41:02 INFO - 2015-11-16 03:41:02,091 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.3541773833487;571.6827160925687;574.1703238819907;574.178924138482;578.199194116149;31318.373632527335;32085.51871721926;40187.79906100469;40585;40605.59394406062;42951.78524107383;43348.349774753406;43526.34710479345;43582.12835743283;43590;8318.085010648823;9279.582418791153;9341;9489.762755931122;9490.857637135448;8433.662653493853;11206.831897521544;11459;11477.885221147764;11483.655490335303;11101.500432480558;11226.831597526043;11227.943860280728;11261.943690281578;11287.435628218598;8529.658813647447;8654.48073115615;11193.10455163585;11257.43712814356;11273.549058037668;10944.507497162567;11073.280236784583;11092.611758588411;11101.888981110167;11111.333320000826;39634.40548391776;40107.398389023896;40129.598704012875;40137.59862401397;40138.598614013776;2859.7140285971236;2898.884044638212;2909.5199292116777;2946.2781618503604;3008.9699103008907;27528.724712752817;27587.72412275892;27768.58347124795;27857;28097.157085287476;2355.3051849704207;2376.4534157143953;2382.344855164826;2481.2928315430195;2484.5776218042975;258415.9999999981;258630;258678;259193;260911;54473.45526544763;55306.72346638241;57842.7107864458;59239.70380148072;59575.702121489114;55305.44694553003;55551;55706.442935570936;55708.44291557113;55809.16286255628;11845.5854045108;11982.64052078439;11988.520459181535;11992.160548761503;12047.03623710101;8492.363072769567;8497.787555311043;8499.150084991452;8504.31965442763;8506.829863402822;19258.793781887132;19521.84468444332;19605.901970490057;19715;19730.802691973182;8729.345299102593;8907.51008694515;8908.10918908104;8933.042161600244;8945.105489451133;903.8599017152352;908.3096846396786;938.2775263047552;1085.4789700943434;1186.3830807979975;26433.867830661107;26746.19761407161;26766.5985010225;28981.56527652087;30073.248168795955;1005.6329439754437;1006.0643601450721;1022.197574903697;1034.5965073621144;1035.6530562261576;13706.314684265746;14054.367553460119;14114.788278175836;14135.78796318056;14267.574512332929;306996;311939;312437;312646;312859;53719;54036.72981635145;54039.72980135074;54053.45946540484;54069;1359.456217512983;1360.693843885118;1383.1424516799648;1385.4621370278983;1386.8543802900954;24794.752052479245;25760.29156957636;27788.30529236785;30598.694013060474;30761;49311.26033109578;49685;49738;49738.75130624323;49765;258106;259168;259232;260151;260198;26714.19857404281;30943.226419339695;31289;31332.843335783175;31373;36713.81643091767;37552.624473756005;37742.24515509619;38259.234815304095;38492;32555;34207.14482137867;34422.31155376828;34508.82745586256;34554.30891382208;34955.126121847155;35232;35772.64227357693;38127.23745525129;38199;32704.83647581747;33381.49927751134;33602.83198583991;33660.32679346448;33710.662893370754;28263.57604635891;31292.530612040384;31342.37315253728;31356.216094596904;31457.370852583277;24034.51930961406;24137.879310603334;24318.635220471355;24379;24603.630945535475 03:41:02 INFO - 2015-11-16 03:41:02,092 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.48701973001033;340.23447243701673;340.23956457317905;340.25823704324563;340.7870081199249;13663.93168034161;14243;16794.83205167948;16861.74707379389;17546.561335966606;11335.37655428951;13484.528041518548;14177.291135443238;16703.331866725315;16782.83217167828;4298.204832106055;4402.559744025588;4406.184855801671;4407.382966384709;4411.691181617288;3318.0875259303643;4393.670474714393;4396.318570621543;4435.401220835178;4438.4451943507065;4295.720778149426;4718.764061796914;4730.172219861528;4736.100140973222;4738.786754596052;4674.392328997243;4710.175719249152;4714.669973101867;4721.433427988663;4736.313234580966;3852.2873268445146;3946.0332218606627;3949.5852935441653;3955.149642826806;3962.86129985452;12606.873931260754;12837.229766214057;12842.357882105858;12856.292903890282;13067.86932130676;1775.1834156288123;1832.6976048951908;1852.9258829646799;1894.1855002348984;1910.6274276516085;9132.543372831398;9275.257979361635;9459.52702364879;9586.376885502421;9604.279679024032;1501.6396064944336;1519.9012064215901;1557.9922100389426;1569.9372025118982;1628.307969113134;54467;56224;56577;56642;56812.715936420056;6503.349665033459;6525.2169739631545;6525.4453371463005;6544.509161812883;6551.63965981866;7424.368928641018;7438.181800001996;7448.553086814808;7448.553086814808;7448.85102297951;4893.779779909913;4893.972265824217;4903.239997800275;4911.950880491221;4944.752762361867;4887.291342755351;4888.535589119028;4924.729139897268;4933.605311575066;4935;2946.2487065798086;2981.8658160382834;2988.2828121251177;3000.564918086865;3007.8345690987207;1023.8617786598862;1028.4651980969854;1031.1802117316752;1051.8842927278147;1100.1089117814436;413.4005691746919;439.9494058183286;452.45027291839915;454.57270166043816;455.94072770539617;11276.379799110964;11806.94096529529;11905.226160299553;11940.88059119415;12007.579734709418;407.0657840256618;458.3972076719104;460.1441319146385;474.5065132262408;486.65204378869277;6088.695565221809;6196.752129914843;6279.246490421178;6345.0482427636225;6356.68216589178;561873;565197;570699;590475;591562;64510.354896451376;64822;64956;65844;66096;484.2711718863089;489.4615922485309;491.8081948040267;493.49416847730646;493.86418734847484;10415.84376234342;10558.366498009837;10608.204384671026;10676.786464270826;10757.085647719718;32124.69942459468;32201.194970124998;32209.47202175045;32280.35439291248;32458.513122303655;40255.1948961025;40458.595414045485;40493.59506405016;40888.182236354514;41345;6082.787102451393;6227.688615569294;6234.781782637586;6240.032794916795;6241.594296370721;10728.946355268174;10830.025297723243;10845.186611004365;11079.335239885633;11742.70643233926;9473.57368918414;9520.571574279036;10126.696199114038;10134.746631334276;10162.644307449204;9645.71062868115;9719.77189922386;9746.415215087118;9890.357126786736;9930.106290433896;7964.123946365779;9944.850827237453;10301.381917084998;10465.476726163814;10485.842712359168;6124.081387791689;6188.319284878749;6212.782552610637;6223.128761973237;6224.439800417984;9940.652077177265;10044.899551004688;10090.747731306776;10230.693079207636;10233.130183934449 03:41:02 INFO - 2015-11-16 03:41:02,095 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1315.9473621055158;1745.1274362818588;1819.3109272921477;1836.6418548383072;1842.7604411426512;7380.963095184523;7713.267239612235;7860.135385107634;7862.999999999993;7877.7636670899965;8008.239217274349;8178.263956243937;8194.713185038525;8201;8240.464369815958;2010.2763005318075;2051.815336619704;2220.0897631970897;2238.6194346961056;2262.242148880127;2278.943026424336;2284.8057915077156;2290.5991451496006;2290.633498640218;2291.6906217660653;2192.1560199323217;2247.7077979862597;2247.78646028627;2252.3017864462067;2254.8872556372116;1986.4537252255673;2044.836413086957;2202.7466841313135;2246.056656204398;2248.6627005949076;2303.1363238785457;2317.4206448387904;2351.659009443621;2351.670766092748;2365.065799009382;8074.515529068275;8158.755237342889;8168.959155204246;8193.09875913649;8209.466384685036;4910.631702622318;4986.750662466899;4991.101601711691;4999.500049995007;5027.2207807789855;2777.2084955787504;2863.541833306661;2864.871080801369;2917.0811194473886;2918.83946382951;859.0807835615893;862.0474375814697;862.3360012790116;867.4491697771897;894.7718331825408;10928.289661172077;10931.945340273247;10940.890591094067;10943.06983906369;10951.616693415772;4351.6518678505645;4448.532904045029;4470.374147619336;4524.479684836286;4528.479224889114;9444.150026497648;9460.810783784285;9464.053594640618;9466.90533094674;9469.337146399686;4991.176455884811;5005.574526165244;5010;5014.824481143142;5025.547700706954;4538.364628951949;4548.340490628841;4548.431446069241;4556.157110934488;4567.086582683477;3765.359888818907;3811.923761524754;3852.3643598805884;3873.0704630888386;3878.941815872764;1228.9139760216879;1247.9376031198403;1248.8813562711528;1252.1735654468189;1261.0920137500984;925.7593025813202;1267.2966503590412;1280.4942047891218;1302.7329397473495;1304.1457845111277;7036.19083805369;7748.457607967501;7872.173421790744;7878.763637090897;7902.3678105751405;661.622874961277;671.1811589860363;1172.4255114993591;1262.3246563088887;1290.864459231786;5983.401659834069;6042.728077236535;6057.57596968208;6060.818175454743;6067.45392914631;9474.147326740627;9787.168090712226;9792.608295668237;9803.117719405145;9936.751581210528;9757.463339516253;9764.707058788248;9773.951130244302;9788.461634610023;9798.75503112428;6992.3357281058215;7595.5442673439775;7597.848043039108;7607.049118860143;7615.695372185161;7078.1506219254015;7166.53417527859;7201.603911784902;7205.135383753983;7208.098987626547;7926.128125906261;7976.282134607914;7986.440949133505;8039.87940180886;8124.065732440845;8140.226678465537;8194.22154895284;8310.168983101641;8313.085560588452;8321.16788321163;7082.645867706491;7176.677049532679;7181.138263408425;7182.712691492282;7184.712611495482;7734.6132693366235;7789.065312162576;7797.376209903307;7805.9609701953395;7817.335526480086;6886.931130688829;7118.28817118284;7164.928350716426;7195.208527062124;7252.057232559733;7175.103112110986;7196.9640151801;7235.674394652148;7236.819079523054;7254.637268136466;6610.768623098168;6911.481638877205;7335.413166946525;7394.593297368697;7411.666475008746;6388.265349484869;6593.670316484061;6650.334966503505;6658.467322614276;6679.8664026718225;6726;6749.93250067493;6768.357006084414;6775.559588626724;6785.050092986887 03:41:02 INFO - 2015-11-16 03:41:02,096 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.485758214111;322.6708757067791;327.8131465064913;333.1587740954092;333.2651503434926;6222.253329600454;6374.45817105546;6381.946978748501;6427.068075129109;6429.710663020163;6207.255129384469;6332.208473940757;6362;6390.360963903608;6390.776322828702;4821.686590371623;4830.830920917769;4835.951640483585;4847.1032858921035;4852.539008794177;4564.863054108382;4662.323963025359;4718.363020992157;4808.615310775147;4826.49321821209;4764.475907650173;4773.785179666923;4786.066716990188;4797.2324428091515;4802.327674125625;4761.50004249554;4764.332993380929;4780.259059845712;4786.449558300805;4791.281307803857;4128.896777580554;4139.503259608836;4144.979275103605;4147.97926010368;4150.91698166035;6008.3390827009;6117.418845209742;6188.47397971173;6203.348648391944;6207.131001659771;5492.450754924515;5494.752736126884;5509.173623956399;5510.008198524264;5529.723513824333;6335.746570137189;6534.183227096613;6707;6719.798406047827;6749.19009718832;4378.321360189144;4417.447819022622;4441.889527618096;4455.910881782346;4460.531644177379;6957.478189135835;7055.647217639149;7061.964690176516;7070.186928503236;7079.89380159298;4627.421572303462;4628.5371462853445;4636.675432719745;4662;4675.509071547439;4592.2193227151465;4775.403074615673;4775.498572649822;4780.211265141283;4781.330613714083;5502.504774570308;5514.751836167382;5514.91727624086;5519.475649813261;5525.171224316305;6707.3628005339415;6721.260661327348;6725.6973436195485;6729.192496900403;6734;1582.849629285216;1617.8705703543687;1663.160104147422;1685.6544408396248;1686.569924669226;1080.7622323088908;1099.2030777686273;1099.780043991189;1103.3214573037685;1106.7288514314046;6316.873662526816;6332.208473940757;6340.1123842661145;6353.5870168438905;6375.139356186855;6911;6917.066196063568;6919.342662447059;6931.306869313028;6959.09531760878;6119.143319935212;6313.43179113882;6314.210723659543;6318.494520438354;6331.968340158362;3695.0392897846755;3715.535558055243;3736.178040831013;3737.906552336159;3740.588535261119;6884.139482564679;6886.2769409212315;6887.449004079662;6906.654667266616;6907.34380233877;6825;7047;7062.329078737512;7072.823179420556;7081.964590177016;6857.794266172023;6894.517383783087;6901.62041087735;6918.619475928872;6919.619420931897;6814.761483348059;6926.480513961373;6989.091418115612;7065.01089847432;7083.185433675193;6903;6946.0970073892095;6952.895706564304;6967.930320696728;6987.580745155307;7032.296770323132;7063.223045464892;7066.434685225273;7080;7102.857942841011;4689.273162659793;4691.483936767021;4699.026408908335;4699.741514216751;4724.267738500538;7045.048918395951;7050;7053.612051337021;7057.7176912922905;7091.361777439849;6668.66656667155;6852.760153394607;6868.244493105654;6887.896681549681;6891.069705589681;6779.762708305186;6784.830379240559;6792.76225332111;6868.896966545606;6916.481263905127;6686.83282917931;6695.12963314766;6707.4969377297875;6720.193576770819;6727;6679;6835.7949261522235;6865.794026179223;6866.690998905161;6899.0341352211735;6702.664866756545;6704.966475167788;6706.631135287606;6709.966450167718;6716.059751634873 03:41:02 INFO - 2015-11-16 03:41:02,098 DEBUG : BROWSER_OUTPUT: |5;yui.html;742.6620887496193;772.1082150116614;773.0684525147199;774.2644487736652;779.9922000779991;13528.932355338222;13788.655283617914;13854.584362469117;13876.514321998731;13878.37547310371;12948.676283092927;13103.606891793237;13109.60671179866;13116.409761560728;13138.211707297569;699.7935608995346;712.6258714175048;898.9685361012366;909.56340956341;910.517425764346;897.0670502677208;907.1518130547959;911.6854685133651;912.6167009855843;913.2237598041645;748.7304570354668;758.2682711183706;953.2516974175273;959.5250351076227;959.9424034557949;921.2767977137948;936.9390989585689;938.1134827587932;938.1416004356006;938.5119737736408;700.2052670219338;701.0255744515129;701.5194591704699;701.8140192848899;701.8140192848899;13400.128991615515;13517.594472165752;13539;13541.84894283987;13558.525451609245;11046.558137674483;11403;11569.53721851125;11781.823272650918;11798.587049453314;9553.158705701062;9590.42457452555;9660.275479339078;9774.5601447935;10195.79608407835;3292.736581073508;3354.245294808673;3365.96634033659;3423.6062852772;3543.5924868640177;45571.3164302539;46014;46037.76981115073;46341.30488042648;46407;8816.955915220382;8832.293416526663;8928.687495937611;9066;9070.138336857988;19050.52373690669;19106.426807195527;19138.61722765537;19152.23391064342;19176.52058698516;6828.180618325733;6974.721011159497;7095.900135479009;7155.642217889084;7237.819054523679;3830.272248272819;3889.766614003169;3909.198614284065;3911.3350730375905;3926.4895563577124;2964.86658100386;2988.04382597571;2993.730564249228;2997.520396736512;3004.474217012058;417.7680100581094;427.7134320005604;432.9805158767863;434.38751360581426;437.6170850505807;504.53078636868065;575.2320651929637;585.9501942334949;589.2339958054512;604.6493034040246;7849.764507064797;7941.967544219215;7986.520808751494;8105.959470202729;8186.386021048445;526.9156934890399;571.9227904232959;594.2957595249643;619.0992106485054;654.7086546486768;3674.834632441493;3829.061879839457;3918.393458681927;3945.3884647879627;4013.6588389986596;56432.43567564354;57086.714566426905;57136.42863571394;57317.71341143268;57427.42572574304;47978.5202147981;48351.5164848354;48694.75652621714;49103.26345104826;49271;42541.574584254384;42769.78615106905;43260.3510947336;44951.77524112424;44976.3253551197;7738.92261077382;8148.592570371577;8282.668693252203;8480.406371553932;8691.688343862257;33497.49753753647;33660.49509257412;33753.662463375054;34534.30931381408;34749;40996.18007639771;41096.38355424611;44159.55840441555;44519;45093;7428.220036896264;7452.292032256927;7468.3278504934815;7470.140933792466;7699.653515591924;11207.495662695035;11228.66314010581;11314.587934671581;11511.53953841837;11757.529698811952;10083;10180.79638407213;10484.161267098461;10849.07782838436;11037.392943388191;10390.272680912565;10646.148308135176;10724.410157441416;10748.140148787921;11210.55157793679;8103.790357906541;9280.767980800263;9980.550875210487;10527.789444211227;10606.310589811637;8449.112843151626;8671.653133874574;8676.826463470821;8745.318723126033;8844.46933184011;8698.739037828875;9399.248060155307;9446.622135114518;9457.290703197425;9514.476703781358 03:41:02 INFO - 2015-11-16 03:41:02,098 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:41:02 INFO - 2015-11-16 03:41:02,098 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:41:02 INFO - 2015-11-16 03:41:02,098 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,945 03:41:02 INFO - 2015-11-16 03:41:02,098 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:41:02 INFO - 2015-11-16 03:41:02,098 DEBUG : BROWSER_OUTPUT: __startTimestamp1447674062085__endTimestamp 03:41:02 INFO - 2015-11-16 03:41:02,099 DEBUG : BROWSER_OUTPUT: 03:41:02 INFO - 2015-11-16 03:41:02,099 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:41:02 INFO - 2015-11-16 03:41:02,099 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:41:02 INFO - 2015-11-16 03:41:02,100 DEBUG : BROWSER_OUTPUT: 03:41:02 INFO - 2015-11-16 03:41:02,100 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5382.73 Median:5526.75 stddev:571.14 (10.3%) stddev-sans-first:545.95 03:41:02 INFO - 2015-11-16 03:41:02,100 DEBUG : BROWSER_OUTPUT: Values: 3172.7 3239.7 3247.4 3250.7 3293.5 5277.3 5334.9 5346.0 5394.7 5422.2 5326.2 5393.6 5443.3 5452.8 5505.6 4880.7 4950.5 4988.5 5003.3 5089.0 5080.2 5107.0 5114.1 5129.8 5207.5 4729.0 4831.8 4843.8 4874.7 5052.6 4629.1 4955.4 4959.1 4959.6 4966.4 4919.4 4925.2 4926.9 4963.3 4972.4 5191.8 5298.5 5331.6 5356.8 5459.0 5707.2 5751.4 5784.4 5812.7 5812.9 5747.7 5748.1 5765.8 5767.7 5834.9 5255.3 5368.4 5375.1 5400.2 5450.9 5752.8 5848.6 5856.9 5906.2 5953.6 5698.0 5708.2 5711.1 5746.3 5776.6 5649.5 5709.0 5784.1 5928.1 5933.3 5393.9 5472.3 5530.6 5534.0 5546.5 5769.4 5784.4 5809.2 5828.0 5842.2 4434.1 4537.0 4544.8 4596.2 4655.3 4051.6 4053.5 4109.4 4122.8 4135.5 5421.0 5442.6 5463.8 5502.5 5526.8 5719.5 5787.1 5860.5 5874.3 5924.3 5291.7 5364.8 5432.4 5439.3 5464.7 5079.3 5158.4 5197.9 5207.7 5216.6 5721.7 5800.7 5813.6 5865.6 5922.6 5851.1 5864.8 5921.0 5921.6 5963.8 5908.4 5935.6 5941.2 5969.2 5975.8 5572.3 5612.0 5638.5 5788.3 5812.2 5748.3 5791.0 5804.0 5819.6 5830.2 5725.4 5735.7 5752.9 5793.6 5798.4 5549.5 5730.2 5745.5 5773.7 5792.5 5430.8 5523.0 5575.9 5582.6 5622.0 5592.3 5667.4 5670.1 5685.5 5697.0 5402.1 5458.0 5508.8 5520.3 5556.9 03:41:02 INFO - 2015-11-16 03:41:02,101 DEBUG : BROWSER_OUTPUT: 03:41:02 INFO - 2015-11-16 03:41:02,102 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44503.70 Median:312752.50 stddev:72467.52 (23.2%) stddev-sans-first:72595.68 03:41:02 INFO - 2015-11-16 03:41:02,102 DEBUG : BROWSER_OUTPUT: Values: 554.4 571.7 574.2 574.2 578.2 31318.4 32085.5 40187.8 40585.0 40605.6 42951.8 43348.3 43526.3 43582.1 43590.0 8318.1 9279.6 9341.0 9489.8 9490.9 8433.7 11206.8 11459.0 11477.9 11483.7 11101.5 11226.8 11227.9 11261.9 11287.4 8529.7 8654.5 11193.1 11257.4 11273.5 10944.5 11073.3 11092.6 11101.9 11111.3 39634.4 40107.4 40129.6 40137.6 40138.6 2859.7 2898.9 2909.5 2946.3 3009.0 27528.7 27587.7 27768.6 27857.0 28097.2 2355.3 2376.5 2382.3 2481.3 2484.6 258416.0 258630.0 258678.0 259193.0 260911.0 54473.5 55306.7 57842.7 59239.7 59575.7 55305.4 55551.0 55706.4 55708.4 55809.2 11845.6 11982.6 11988.5 11992.2 12047.0 8492.4 8497.8 8499.2 8504.3 8506.8 19258.8 19521.8 19605.9 19715.0 19730.8 8729.3 8907.5 8908.1 8933.0 8945.1 903.9 908.3 938.3 1085.5 1186.4 26433.9 26746.2 26766.6 28981.6 30073.2 1005.6 1006.1 1022.2 1034.6 1035.7 13706.3 14054.4 14114.8 14135.8 14267.6 306996.0 311939.0 312437.0 312646.0 312859.0 53719.0 54036.7 54039.7 54053.5 54069.0 1359.5 1360.7 1383.1 1385.5 1386.9 24794.8 25760.3 27788.3 30598.7 30761.0 49311.3 49685.0 49738.0 49738.8 49765.0 258106.0 259168.0 259232.0 260151.0 260198.0 26714.2 30943.2 31289.0 31332.8 31373.0 36713.8 37552.6 37742.2 38259.2 38492.0 32555.0 34207.1 34422.3 34508.8 34554.3 34955.1 35232.0 35772.6 38127.2 38199.0 32704.8 33381.5 33602.8 33660.3 33710.7 28263.6 31292.5 31342.4 31356.2 31457.4 24034.5 24137.9 24318.6 24379.0 24603.6 03:41:02 INFO - 2015-11-16 03:41:02,102 DEBUG : BROWSER_OUTPUT: 03:41:02 INFO - 2015-11-16 03:41:02,102 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26927.87 Median:4409.54 stddev:94211.78 (2136.5%) stddev-sans-first:94454.91 03:41:02 INFO - 2015-11-16 03:41:02,103 DEBUG : BROWSER_OUTPUT: Values: 337.5 340.2 340.2 340.3 340.8 13663.9 14243.0 16794.8 16861.7 17546.6 11335.4 13484.5 14177.3 16703.3 16782.8 4298.2 4402.6 4406.2 4407.4 4411.7 3318.1 4393.7 4396.3 4435.4 4438.4 4295.7 4718.8 4730.2 4736.1 4738.8 4674.4 4710.2 4714.7 4721.4 4736.3 3852.3 3946.0 3949.6 3955.1 3962.9 12606.9 12837.2 12842.4 12856.3 13067.9 1775.2 1832.7 1852.9 1894.2 1910.6 9132.5 9275.3 9459.5 9586.4 9604.3 1501.6 1519.9 1558.0 1569.9 1628.3 54467.0 56224.0 56577.0 56642.0 56812.7 6503.3 6525.2 6525.4 6544.5 6551.6 7424.4 7438.2 7448.6 7448.6 7448.9 4893.8 4894.0 4903.2 4912.0 4944.8 4887.3 4888.5 4924.7 4933.6 4935.0 2946.2 2981.9 2988.3 3000.6 3007.8 1023.9 1028.5 1031.2 1051.9 1100.1 413.4 439.9 452.5 454.6 455.9 11276.4 11806.9 11905.2 11940.9 12007.6 407.1 458.4 460.1 474.5 486.7 6088.7 6196.8 6279.2 6345.0 6356.7 561873.0 565197.0 570699.0 590475.0 591562.0 64510.4 64822.0 64956.0 65844.0 66096.0 484.3 489.5 491.8 493.5 493.9 10415.8 10558.4 10608.2 10676.8 10757.1 32124.7 32201.2 32209.5 32280.4 32458.5 40255.2 40458.6 40493.6 40888.2 41345.0 6082.8 6227.7 6234.8 6240.0 6241.6 10728.9 10830.0 10845.2 11079.3 11742.7 9473.6 9520.6 10126.7 10134.7 10162.6 9645.7 9719.8 9746.4 9890.4 9930.1 7964.1 9944.9 10301.4 10465.5 10485.8 6124.1 6188.3 6212.8 6223.1 6224.4 9940.7 10044.9 10090.7 10230.7 10233.1 03:41:02 INFO - 2015-11-16 03:41:02,104 DEBUG : BROWSER_OUTPUT: 03:41:02 INFO - 2015-11-16 03:41:02,104 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5593.56 Median:6737.97 stddev:2913.15 (43.2%) stddev-sans-first:2903.58 03:41:02 INFO - 2015-11-16 03:41:02,106 DEBUG : BROWSER_OUTPUT: Values: 1315.9 1745.1 1819.3 1836.6 1842.8 7381.0 7713.3 7860.1 7863.0 7877.8 8008.2 8178.3 8194.7 8201.0 8240.5 2010.3 2051.8 2220.1 2238.6 2262.2 2278.9 2284.8 2290.6 2290.6 2291.7 2192.2 2247.7 2247.8 2252.3 2254.9 1986.5 2044.8 2202.7 2246.1 2248.7 2303.1 2317.4 2351.7 2351.7 2365.1 8074.5 8158.8 8169.0 8193.1 8209.5 4910.6 4986.8 4991.1 4999.5 5027.2 2777.2 2863.5 2864.9 2917.1 2918.8 859.1 862.0 862.3 867.4 894.8 10928.3 10931.9 10940.9 10943.1 10951.6 4351.7 4448.5 4470.4 4524.5 4528.5 9444.2 9460.8 9464.1 9466.9 9469.3 4991.2 5005.6 5010.0 5014.8 5025.5 4538.4 4548.3 4548.4 4556.2 4567.1 3765.4 3811.9 3852.4 3873.1 3878.9 1228.9 1247.9 1248.9 1252.2 1261.1 925.8 1267.3 1280.5 1302.7 1304.1 7036.2 7748.5 7872.2 7878.8 7902.4 661.6 671.2 1172.4 1262.3 1290.9 5983.4 6042.7 6057.6 6060.8 6067.5 9474.1 9787.2 9792.6 9803.1 9936.8 9757.5 9764.7 9774.0 9788.5 9798.8 6992.3 7595.5 7597.8 7607.0 7615.7 7078.2 7166.5 7201.6 7205.1 7208.1 7926.1 7976.3 7986.4 8039.9 8124.1 8140.2 8194.2 8310.2 8313.1 8321.2 7082.6 7176.7 7181.1 7182.7 7184.7 7734.6 7789.1 7797.4 7806.0 7817.3 6886.9 7118.3 7164.9 7195.2 7252.1 7175.1 7197.0 7235.7 7236.8 7254.6 6610.8 6911.5 7335.4 7394.6 7411.7 6388.3 6593.7 6650.3 6658.5 6679.9 6726.0 6749.9 6768.4 6775.6 6785.1 03:41:02 INFO - 2015-11-16 03:41:02,106 DEBUG : BROWSER_OUTPUT: 03:41:02 INFO - 2015-11-16 03:41:02,106 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5587.38 Median:6337.93 stddev:1712.07 (27.0%) stddev-sans-first:1670.52 03:41:02 INFO - 2015-11-16 03:41:02,107 DEBUG : BROWSER_OUTPUT: Values: 315.5 322.7 327.8 333.2 333.3 6222.3 6374.5 6381.9 6427.1 6429.7 6207.3 6332.2 6362.0 6390.4 6390.8 4821.7 4830.8 4836.0 4847.1 4852.5 4564.9 4662.3 4718.4 4808.6 4826.5 4764.5 4773.8 4786.1 4797.2 4802.3 4761.5 4764.3 4780.3 4786.4 4791.3 4128.9 4139.5 4145.0 4148.0 4150.9 6008.3 6117.4 6188.5 6203.3 6207.1 5492.5 5494.8 5509.2 5510.0 5529.7 6335.7 6534.2 6707.0 6719.8 6749.2 4378.3 4417.4 4441.9 4455.9 4460.5 6957.5 7055.6 7062.0 7070.2 7079.9 4627.4 4628.5 4636.7 4662.0 4675.5 4592.2 4775.4 4775.5 4780.2 4781.3 5502.5 5514.8 5514.9 5519.5 5525.2 6707.4 6721.3 6725.7 6729.2 6734.0 1582.8 1617.9 1663.2 1685.7 1686.6 1080.8 1099.2 1099.8 1103.3 1106.7 6316.9 6332.2 6340.1 6353.6 6375.1 6911.0 6917.1 6919.3 6931.3 6959.1 6119.1 6313.4 6314.2 6318.5 6332.0 3695.0 3715.5 3736.2 3737.9 3740.6 6884.1 6886.3 6887.4 6906.7 6907.3 6825.0 7047.0 7062.3 7072.8 7082.0 6857.8 6894.5 6901.6 6918.6 6919.6 6814.8 6926.5 6989.1 7065.0 7083.2 6903.0 6946.1 6952.9 6967.9 6987.6 7032.3 7063.2 7066.4 7080.0 7102.9 4689.3 4691.5 4699.0 4699.7 4724.3 7045.0 7050.0 7053.6 7057.7 7091.4 6668.7 6852.8 6868.2 6887.9 6891.1 6779.8 6784.8 6792.8 6868.9 6916.5 6686.8 6695.1 6707.5 6720.2 6727.0 6679.0 6835.8 6865.8 6866.7 6899.0 6702.7 6705.0 6706.6 6710.0 6716.1 03:41:02 INFO - 2015-11-16 03:41:02,107 DEBUG : BROWSER_OUTPUT: 03:41:02 INFO - 2015-11-16 03:41:02,107 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13178.73 Median:48899.01 stddev:15464.02 (31.6%) stddev-sans-first:15479.20 03:41:02 INFO - 2015-11-16 03:41:02,108 DEBUG : BROWSER_OUTPUT: Values: 742.7 772.1 773.1 774.3 780.0 13528.9 13788.7 13854.6 13876.5 13878.4 12948.7 13103.6 13109.6 13116.4 13138.2 699.8 712.6 899.0 909.6 910.5 897.1 907.2 911.7 912.6 913.2 748.7 758.3 953.3 959.5 959.9 921.3 936.9 938.1 938.1 938.5 700.2 701.0 701.5 701.8 701.8 13400.1 13517.6 13539.0 13541.8 13558.5 11046.6 11403.0 11569.5 11781.8 11798.6 9553.2 9590.4 9660.3 9774.6 10195.8 3292.7 3354.2 3366.0 3423.6 3543.6 45571.3 46014.0 46037.8 46341.3 46407.0 8817.0 8832.3 8928.7 9066.0 9070.1 19050.5 19106.4 19138.6 19152.2 19176.5 6828.2 6974.7 7095.9 7155.6 7237.8 3830.3 3889.8 3909.2 3911.3 3926.5 2964.9 2988.0 2993.7 2997.5 3004.5 417.8 427.7 433.0 434.4 437.6 504.5 575.2 586.0 589.2 604.6 7849.8 7942.0 7986.5 8106.0 8186.4 526.9 571.9 594.3 619.1 654.7 3674.8 3829.1 3918.4 3945.4 4013.7 56432.4 57086.7 57136.4 57317.7 57427.4 47978.5 48351.5 48694.8 49103.3 49271.0 42541.6 42769.8 43260.4 44951.8 44976.3 7738.9 8148.6 8282.7 8480.4 8691.7 33497.5 33660.5 33753.7 34534.3 34749.0 40996.2 41096.4 44159.6 44519.0 45093.0 7428.2 7452.3 7468.3 7470.1 7699.7 11207.5 11228.7 11314.6 11511.5 11757.5 10083.0 10180.8 10484.2 10849.1 11037.4 10390.3 10646.1 10724.4 10748.1 11210.6 8103.8 9280.8 9980.6 10527.8 10606.3 8449.1 8671.7 8676.8 8745.3 8844.5 8698.7 9399.2 9446.6 9457.3 9514.5 03:41:02 INFO - 2015-11-16 03:41:02,108 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:41:02 INFO - 2015-11-16 03:41:02,108 DEBUG : BROWSER_OUTPUT: 03:41:02 INFO - 2015-11-16 03:41:02,837 INFO : Browser exited with error code: 0 03:41:02 INFO - 2015-11-16 03:41:02,865 INFO : Completed test dromaeo_css (00:18:35) 03:41:02 INFO - 2015-11-16 03:41:02,865 INFO : Starting test kraken 03:41:02 INFO - 2015-11-16 03:41:02,865 DEBUG : operating with platform_type : mac_ 03:41:02 INFO - 2015-11-16 03:41:02,865 INFO : Initialising browser for kraken test... 03:41:02 INFO - 2015-11-16 03:41:02,878 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpCDgW2L/profile http://localhost:49266/getInfo.html 03:41:05 INFO - 2015-11-16 03:41:05,062 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:41:05 INFO - 2015-11-16 03:41:05,063 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:41:05 INFO - 2015-11-16 03:41:05,063 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:41:05 INFO - 2015-11-16 03:41:05,063 DEBUG : BROWSER_OUTPUT: __metrics 03:41:05 INFO - 2015-11-16 03:41:05,078 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:41:05 INFO - 2015-11-16 03:41:05,767 INFO : Browser initialized. 03:41:05 INFO - 2015-11-16 03:41:05,768 INFO : Running cycle 1/1 for kraken test... 03:41:05 INFO - 2015-11-16 03:41:05,768 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpCDgW2L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:41:17 INFO - 2015-11-16 03:41:17,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 229339136 03:41:17 INFO - 2015-11-16 03:41:17,640 DEBUG : BROWSER_OUTPUT: 03:41:20 INFO - 2015-11-16 03:41:20,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:20 INFO - 2015-11-16 03:41:20,769 DEBUG : BROWSER_OUTPUT: RSS: Main: 285577216 03:41:20 INFO - 2015-11-16 03:41:20,769 DEBUG : BROWSER_OUTPUT: 03:41:23 INFO - 2015-11-16 03:41:23,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 03:41:23 INFO - 2015-11-16 03:41:23,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 299294720 03:41:23 INFO - 2015-11-16 03:41:23,985 DEBUG : BROWSER_OUTPUT: 03:41:26 INFO - 2015-11-16 03:41:26,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 03:41:27 INFO - 2015-11-16 03:41:27,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 280997888 03:41:27 INFO - 2015-11-16 03:41:27,524 DEBUG : BROWSER_OUTPUT: 03:41:29 INFO - 2015-11-16 03:41:29,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 03:41:30 INFO - 2015-11-16 03:41:30,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 283291648 03:41:30 INFO - 2015-11-16 03:41:30,167 DEBUG : BROWSER_OUTPUT: 03:41:32 INFO - 2015-11-16 03:41:32,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:32 INFO - 2015-11-16 03:41:32,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 282841088 03:41:32 INFO - 2015-11-16 03:41:32,911 DEBUG : BROWSER_OUTPUT: 03:41:35 INFO - 2015-11-16 03:41:35,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:36 INFO - 2015-11-16 03:41:36,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 283533312 03:41:36 INFO - 2015-11-16 03:41:36,512 DEBUG : BROWSER_OUTPUT: 03:41:39 INFO - 2015-11-16 03:41:39,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:40 INFO - 2015-11-16 03:41:40,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 283856896 03:41:40 INFO - 2015-11-16 03:41:40,200 DEBUG : BROWSER_OUTPUT: 03:41:42 INFO - 2015-11-16 03:41:42,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 03:41:43 INFO - 2015-11-16 03:41:43,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 284364800 03:41:43 INFO - 2015-11-16 03:41:43,562 DEBUG : BROWSER_OUTPUT: 03:41:45 INFO - 2015-11-16 03:41:45,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:45 INFO - 2015-11-16 03:41:45,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 317083648 03:41:45 INFO - 2015-11-16 03:41:45,709 DEBUG : BROWSER_OUTPUT: 03:41:47 INFO - 2015-11-16 03:41:47,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:48 INFO - 2015-11-16 03:41:48,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 317919232 03:41:48 INFO - 2015-11-16 03:41:48,163 DEBUG : BROWSER_OUTPUT: 03:41:50 INFO - 2015-11-16 03:41:50,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:50 INFO - 2015-11-16 03:41:50,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 327892992 03:41:50 INFO - 2015-11-16 03:41:50,823 DEBUG : BROWSER_OUTPUT: 03:41:53 INFO - 2015-11-16 03:41:53,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:53 INFO - 2015-11-16 03:41:53,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 329609216 03:41:53 INFO - 2015-11-16 03:41:53,969 DEBUG : BROWSER_OUTPUT: 03:41:56 INFO - 2015-11-16 03:41:56,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:57 INFO - 2015-11-16 03:41:57,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 328347648 03:41:57 INFO - 2015-11-16 03:41:57,191 DEBUG : BROWSER_OUTPUT: 03:41:58 INFO - 2015-11-16 03:41:58,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 03:41:59 INFO - 2015-11-16 03:41:59,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 386813952 03:41:59 INFO - 2015-11-16 03:41:59,177 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,178 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:41:59 INFO - 2015-11-16 03:41:59,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:41:59 INFO - 2015-11-16 03:41:59,178 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:41:59 INFO - 2015-11-16 03:41:59,178 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:41:59 INFO - 2015-11-16 03:41:59,178 DEBUG : BROWSER_OUTPUT: |0;ai-astar;107;107;104;106;107;108;105;105;98;106 03:41:59 INFO - 2015-11-16 03:41:59,178 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;130;149;164;126;149;146;126;164;127 03:41:59 INFO - 2015-11-16 03:41:59,178 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;159;160;162;162;162;161;161;162;160 03:41:59 INFO - 2015-11-16 03:41:59,179 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;80;87;85;68;71;104;80;82;66 03:41:59 INFO - 2015-11-16 03:41:59,179 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;98;98;134;88;89;89;127;88;88;132 03:41:59 INFO - 2015-11-16 03:41:59,179 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;119;120;114;119;120;120;114;114;114;120 03:41:59 INFO - 2015-11-16 03:41:59,179 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;125;124;125;125;125;125;131;126;124;124 03:41:59 INFO - 2015-11-16 03:41:59,179 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;93;93;100;93;93;93;100;93;94;100 03:41:59 INFO - 2015-11-16 03:41:59,179 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;59;59;59;59;59;67;58;58 03:41:59 INFO - 2015-11-16 03:41:59,179 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;70;69;70;70;70;70;70;71 03:41:59 INFO - 2015-11-16 03:41:59,179 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;87;85;84;84;85;84;84;86;86 03:41:59 INFO - 2015-11-16 03:41:59,179 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;127;135;122;128;134;124;129;133;123 03:41:59 INFO - 2015-11-16 03:41:59,180 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;151;153;154;152;146;154;155;151;152 03:41:59 INFO - 2015-11-16 03:41:59,180 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;72;70;71;71;70;71;70;70 03:41:59 INFO - 2015-11-16 03:41:59,180 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:41:59 INFO - 2015-11-16 03:41:59,180 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:41:59 INFO - 2015-11-16 03:41:59,180 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,902 03:41:59 INFO - 2015-11-16 03:41:59,180 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:41:59 INFO - 2015-11-16 03:41:59,180 DEBUG : BROWSER_OUTPUT: __startTimestamp1447674119177__endTimestamp 03:41:59 INFO - 2015-11-16 03:41:59,180 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,184 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:41:59 INFO - 2015-11-16 03:41:59,184 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:41:59 INFO - 2015-11-16 03:41:59,184 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,184 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:105.30 Median:107.00 stddev:2.83 (2.6%) stddev-sans-first:2.93 03:41:59 INFO - 2015-11-16 03:41:59,184 DEBUG : BROWSER_OUTPUT: Values: 107.0 107.0 104.0 106.0 107.0 108.0 105.0 105.0 98.0 106.0 03:41:59 INFO - 2015-11-16 03:41:59,185 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,185 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.50 Median:149.00 stddev:15.22 (10.2%) stddev-sans-first:15.66 03:41:59 INFO - 2015-11-16 03:41:59,185 DEBUG : BROWSER_OUTPUT: Values: 154.0 130.0 149.0 164.0 126.0 149.0 146.0 126.0 164.0 127.0 03:41:59 INFO - 2015-11-16 03:41:59,185 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,185 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.05 (0.7%) stddev-sans-first:1.12 03:41:59 INFO - 2015-11-16 03:41:59,185 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 160.0 162.0 162.0 162.0 161.0 161.0 162.0 160.0 03:41:59 INFO - 2015-11-16 03:41:59,186 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,186 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:80.00 stddev:10.95 (13.7%) stddev-sans-first:11.59 03:41:59 INFO - 2015-11-16 03:41:59,186 DEBUG : BROWSER_OUTPUT: Values: 78.0 80.0 87.0 85.0 68.0 71.0 104.0 80.0 82.0 66.0 03:41:59 INFO - 2015-11-16 03:41:59,186 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,186 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.10 Median:88.50 stddev:19.71 (22.3%) stddev-sans-first:20.81 03:41:59 INFO - 2015-11-16 03:41:59,186 DEBUG : BROWSER_OUTPUT: Values: 98.0 98.0 134.0 88.0 89.0 89.0 127.0 88.0 88.0 132.0 03:41:59 INFO - 2015-11-16 03:41:59,186 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,187 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:119.50 stddev:2.95 (2.5%) stddev-sans-first:3.07 03:41:59 INFO - 2015-11-16 03:41:59,187 DEBUG : BROWSER_OUTPUT: Values: 119.0 120.0 114.0 119.0 120.0 120.0 114.0 114.0 114.0 120.0 03:41:59 INFO - 2015-11-16 03:41:59,187 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,187 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:125.40 Median:125.00 stddev:2.07 (1.7%) stddev-sans-first:2.19 03:41:59 INFO - 2015-11-16 03:41:59,187 DEBUG : BROWSER_OUTPUT: Values: 125.0 124.0 125.0 125.0 125.0 125.0 131.0 126.0 124.0 124.0 03:41:59 INFO - 2015-11-16 03:41:59,187 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,187 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:93.00 stddev:3.33 (3.6%) stddev-sans-first:3.43 03:41:59 INFO - 2015-11-16 03:41:59,187 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 100.0 93.0 93.0 93.0 100.0 93.0 94.0 100.0 03:41:59 INFO - 2015-11-16 03:41:59,188 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,188 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.00 stddev:2.68 (4.5%) stddev-sans-first:2.83 03:41:59 INFO - 2015-11-16 03:41:59,188 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 59.0 59.0 59.0 59.0 59.0 67.0 58.0 58.0 03:41:59 INFO - 2015-11-16 03:41:59,188 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,188 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 03:41:59 INFO - 2015-11-16 03:41:59,188 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 70.0 69.0 70.0 70.0 70.0 70.0 70.0 71.0 03:41:59 INFO - 2015-11-16 03:41:59,188 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,188 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:1.05 (1.2%) stddev-sans-first:1.12 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 85.0 84.0 84.0 85.0 84.0 84.0 86.0 86.0 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:128.50 stddev:4.59 (3.6%) stddev-sans-first:4.85 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: Values: 127.0 127.0 135.0 122.0 128.0 134.0 124.0 129.0 133.0 123.0 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:153.00 stddev:2.51 (1.6%) stddev-sans-first:2.65 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: Values: 153.0 151.0 153.0 154.0 152.0 146.0 154.0 155.0 151.0 152.0 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 72.0 70.0 71.0 71.0 70.0 71.0 70.0 70.0 03:41:59 INFO - 2015-11-16 03:41:59,189 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:41:59 INFO - 2015-11-16 03:41:59,190 DEBUG : BROWSER_OUTPUT: 03:41:59 INFO - 2015-11-16 03:41:59,819 INFO : Browser exited with error code: 0 03:41:59 INFO - 2015-11-16 03:41:59,868 INFO : Completed test kraken (00:00:57) 03:41:59 INFO - 2015-11-16 03:41:59,868 INFO : Starting test v8_7 03:41:59 INFO - 2015-11-16 03:41:59,868 DEBUG : operating with platform_type : mac_ 03:41:59 INFO - 2015-11-16 03:41:59,868 INFO : Initialising browser for v8_7 test... 03:41:59 INFO - 2015-11-16 03:41:59,880 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpykoP5Q/profile http://localhost:49266/getInfo.html 03:42:01 INFO - 2015-11-16 03:42:01,982 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:42:01 INFO - 2015-11-16 03:42:01,982 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:42:01 INFO - 2015-11-16 03:42:01,982 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:42:01 INFO - 2015-11-16 03:42:01,982 DEBUG : BROWSER_OUTPUT: __metrics 03:42:01 INFO - 2015-11-16 03:42:01,998 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:42:02 INFO - 2015-11-16 03:42:02,814 INFO : Browser initialized. 03:42:02 INFO - 2015-11-16 03:42:02,815 INFO : Running cycle 1/1 for v8_7 test... 03:42:02 INFO - 2015-11-16 03:42:02,815 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/tmpykoP5Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:42:14 INFO - 2015-11-16 03:42:14,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 229638144 03:42:14 INFO - 2015-11-16 03:42:14,666 DEBUG : BROWSER_OUTPUT: 03:42:36 INFO - 2015-11-16 03:42:36,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49266/tests/v8_7/run.html (next: http://localhost:49266/tests/v8_7/run.html) 03:42:36 INFO - 2015-11-16 03:42:36,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 725127168 03:42:36 INFO - 2015-11-16 03:42:36,997 DEBUG : BROWSER_OUTPUT: 03:42:36 INFO - 2015-11-16 03:42:36,997 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:42:36 INFO - 2015-11-16 03:42:36,997 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:42:36 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:42:36 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:42:36 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: |0;Richards;166.36167027116952 03:42:36 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;198.4914648670107 03:42:37 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.5208333333333 03:42:37 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5737.142857142857 03:42:37 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1912.0458891013384 03:42:37 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: |5;Earley;941.6195856873823 03:42:37 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: |6;Boyer;12432.098765432098 03:42:37 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: |7;RegExp;30029.41176470588 03:42:37 INFO - 2015-11-16 03:42:36,998 DEBUG : BROWSER_OUTPUT: |8;Splay;677.0480704129993 03:42:37 INFO - 2015-11-16 03:42:36,999 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5797.687861271676 03:42:37 INFO - 2015-11-16 03:42:36,999 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:42:37 INFO - 2015-11-16 03:42:36,999 DEBUG : BROWSER_OUTPUT: __startTimestamp1447674156992__endTimestamp 03:42:37 INFO - 2015-11-16 03:42:36,999 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:36,999 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:42:37 INFO - 2015-11-16 03:42:36,999 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:42:37 INFO - 2015-11-16 03:42:36,999 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:36,999 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.36 Median:166.36 stddev:0.00 (0.0%) 03:42:37 INFO - 2015-11-16 03:42:36,999 DEBUG : BROWSER_OUTPUT: Values: 166.4 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:198.49 Median:198.49 stddev:0.00 (0.0%) 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: Values: 198.5 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.52 Median:325.52 stddev:0.00 (0.0%) 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: Values: 325.5 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5737.14 Median:5737.14 stddev:0.00 (0.0%) 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: Values: 5737.1 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:37,000 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1912.05 Median:1912.05 stddev:0.00 (0.0%) 03:42:37 INFO - 2015-11-16 03:42:37,001 DEBUG : BROWSER_OUTPUT: Values: 1912.0 03:42:37 INFO - 2015-11-16 03:42:37,001 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:37,001 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:941.62 Median:941.62 stddev:0.00 (0.0%) 03:42:37 INFO - 2015-11-16 03:42:37,001 DEBUG : BROWSER_OUTPUT: Values: 941.6 03:42:37 INFO - 2015-11-16 03:42:37,001 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:37,001 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12432.10 Median:12432.10 stddev:0.00 (0.0%) 03:42:37 INFO - 2015-11-16 03:42:37,001 DEBUG : BROWSER_OUTPUT: Values: 12432.1 03:42:37 INFO - 2015-11-16 03:42:37,001 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:37,001 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:30029.41 Median:30029.41 stddev:0.00 (0.0%) 03:42:37 INFO - 2015-11-16 03:42:37,001 DEBUG : BROWSER_OUTPUT: Values: 30029.4 03:42:37 INFO - 2015-11-16 03:42:37,002 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:37,002 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:677.05 Median:677.05 stddev:0.00 (0.0%) 03:42:37 INFO - 2015-11-16 03:42:37,002 DEBUG : BROWSER_OUTPUT: Values: 677.0 03:42:37 INFO - 2015-11-16 03:42:37,002 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:37,002 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5797.69 Median:5797.69 stddev:0.00 (0.0%) 03:42:37 INFO - 2015-11-16 03:42:37,002 DEBUG : BROWSER_OUTPUT: Values: 5797.7 03:42:37 INFO - 2015-11-16 03:42:37,002 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:42:37 INFO - 2015-11-16 03:42:37,002 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-11-16 03:42:37,689 INFO : Browser exited with error code: 0 03:42:37 INFO - 2015-11-16 03:42:37,709 INFO : Completed test v8_7 (00:00:37) 03:42:37 INFO - 2015-11-16 03:42:37,870 INFO : Completed test suite (00:20:10) 03:42:37 INFO - 2015-11-16 03:42:37,870 DEBUG : Working with test: dromaeo_css 03:42:37 INFO - 2015-11-16 03:42:37,870 DEBUG : Generating results file: dromaeo_css 03:42:37 INFO - 2015-11-16 03:42:37,871 DEBUG : Working with test: kraken 03:42:37 INFO - 2015-11-16 03:42:37,871 DEBUG : Generating results file: kraken 03:42:37 INFO - 2015-11-16 03:42:37,871 INFO : javascript benchmark 03:42:37 INFO - 2015-11-16 03:42:37,871 DEBUG : Working with test: v8_7 03:42:37 INFO - 2015-11-16 03:42:37,871 DEBUG : Generating results file: v8_7 03:42:37 INFO - 2015-11-16 03:42:37,872 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:42:37 INFO - 2015-11-16 03:42:37,922 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,55]] 03:42:37 INFO - 2015-11-16 03:42:37,922 DEBUG : process_Request line: dromaeo_css 6634.73 graph.html#tests=[[72,63,55]] 03:42:37 INFO - 2015-11-16 03:42:37,922 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:42:37 INFO - 2015-11-16 03:42:37,952 DEBUG : process_Request line: kraken 1496.10 graph.html#tests=[[232,63,55]] 03:42:37 INFO - 2015-11-16 03:42:37,952 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:42:37 INFO - 2015-11-16 03:42:37,980 DEBUG : process_Request line: v8_7 18131.25 graph.html#tests=[[230,63,55]] 03:42:37 INFO - 2015-11-16 03:42:37,981 INFO : javascript benchmark 03:42:38 INFO - 2015-11-16 03:42:37,983 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [337.48701973001033, 340.23447243701673, 340.23956457317905, 340.25823704324563, 340.7870081199249, 13663.93168034161, 14243.0, 16794.83205167948, 16861.74707379389, 17546.561335966606, 11335.37655428951, 13484.528041518548, 14177.291135443238, 16703.331866725315, 16782.83217167828, 4298.204832106055, 4402.559744025588, 4406.184855801671, 4407.382966384709, 4411.691181617288, 3318.0875259303643, 4393.670474714393, 4396.318570621543, 4435.401220835178, 4438.4451943507065, 4295.720778149426, 4718.764061796914, 4730.172219861528, 4736.100140973222, 4738.786754596052, 4674.392328997243, 4710.175719249152, 4714.669973101867, 4721.433427988663, 4736.313234580966, 3852.2873268445146, 3946.0332218606627, 3949.5852935441653, 3955.149642826806, 3962.86129985452, 12606.873931260754, 12837.229766214057, 12842.357882105858, 12856.292903890282, 13067.86932130676, 1775.1834156288123, 1832.6976048951908, 1852.9258829646799, 1894.1855002348984, 1910.6274276516085, 9132.543372831398, 9275.257979361635, 9459.52702364879, 9586.376885502421, 9604.279679024032, 1501.6396064944336, 1519.9012064215901, 1557.9922100389426, 1569.9372025118982, 1628.307969113134, 54467.0, 56224.0, 56577.0, 56642.0, 56812.715936420056, 6503.349665033459, 6525.2169739631545, 6525.4453371463005, 6544.509161812883, 6551.63965981866, 7424.368928641018, 7438.181800001996, 7448.553086814808, 7448.553086814808, 7448.85102297951, 4893.779779909913, 4893.972265824217, 4903.239997800275, 4911.950880491221, 4944.752762361867, 4887.291342755351, 4888.535589119028, 4924.729139897268, 4933.605311575066, 4935.0, 2946.2487065798086, 2981.8658160382834, 2988.2828121251177, 3000.564918086865, 3007.8345690987207, 1023.8617786598862, 1028.4651980969854, 1031.1802117316752, 1051.8842927278147, 1100.1089117814436, 413.4005691746919, 439.9494058183286, 452.45027291839915, 454.57270166043816, 455.94072770539617, 11276.379799110964, 11806.94096529529, 11905.226160299553, 11940.88059119415, 12007.579734709418, 407.0657840256618, 458.3972076719104, 460.1441319146385, 474.5065132262408, 486.65204378869277, 6088.695565221809, 6196.752129914843, 6279.246490421178, 6345.0482427636225, 6356.68216589178, 561873.0, 565197.0, 570699.0, 590475.0, 591562.0, 64510.354896451376, 64822.0, 64956.0, 65844.0, 66096.0, 484.2711718863089, 489.4615922485309, 491.8081948040267, 493.49416847730646, 493.86418734847484, 10415.84376234342, 10558.366498009837, 10608.204384671026, 10676.786464270826, 10757.085647719718, 32124.69942459468, 32201.194970124998, 32209.47202175045, 32280.35439291248, 32458.513122303655, 40255.1948961025, 40458.595414045485, 40493.59506405016, 40888.182236354514, 41345.0, 6082.787102451393, 6227.688615569294, 6234.781782637586, 6240.032794916795, 6241.594296370721, 10728.946355268174, 10830.025297723243, 10845.186611004365, 11079.335239885633, 11742.70643233926, 9473.57368918414, 9520.571574279036, 10126.696199114038, 10134.746631334276, 10162.644307449204, 9645.71062868115, 9719.77189922386, 9746.415215087118, 9890.357126786736, 9930.106290433896, 7964.123946365779, 9944.850827237453, 10301.381917084998, 10465.476726163814, 10485.842712359168, 6124.081387791689, 6188.319284878749, 6212.782552610637, 6223.128761973237, 6224.439800417984, 9940.652077177265, 10044.899551004688, 10090.747731306776, 10230.693079207636, 10233.130183934449], "dojo.html": [3172.7303179229766, 3239.7408207343406, 3247.3829972305243, 3250.707436330733, 3293.4565796643556, 5277.340332458442, 5334.946650533493, 5346.010987967229, 5394.676319420838, 5422.240886275925, 5326.174442961337, 5393.649412788176, 5443.346798384199, 5452.754626041828, 5505.587080968923, 4880.682755620891, 4950.480199579047, 4988.451270360276, 5003.2995380646735, 5089.0, 5080.1617733074, 5107.029664363778, 5114.079465696173, 5129.820456284031, 5207.505286997748, 4728.95271047292, 4831.758412079382, 4843.830465933711, 4874.65877388583, 5052.570531504808, 4629.1436084324505, 4955.430125535573, 4959.05777902201, 4959.603231741452, 4966.354373931402, 4919.385076865392, 4925.236588328779, 4926.901461970776, 4963.305137280783, 4972.428170760337, 5191.792328306901, 5298.470152984709, 5331.600129990266, 5356.812511562116, 5459.017376872162, 5707.229524014288, 5751.424857514216, 5784.392638772911, 5812.738426770806, 5812.854678633025, 5747.6551406915305, 5748.109043098327, 5765.827025189251, 5767.711614419304, 5834.912476312858, 5255.264263003182, 5368.4363141869935, 5375.139977603643, 5400.189971504266, 5450.863728406743, 5752.798652047159, 5848.619839710405, 5856.882862342729, 5906.173135760997, 5953.553483488756, 5698.0, 5708.229389032511, 5711.143328500675, 5746.310442746813, 5776.624519406225, 5649.4633009864, 5708.971455142698, 5784.074548072288, 5928.140419639129, 5933.258342707161, 5393.865153371197, 5472.288602481652, 5530.585206109477, 5534.0315444797, 5546.473085056913, 5769.423057694197, 5784.363719990798, 5809.186713860063, 5828.009238429478, 5842.152887831326, 4434.11317736454, 4536.977315113403, 4544.7500387479, 4596.218642830727, 4655.3249778782565, 4051.6150965658217, 4053.5135783705555, 4109.404136400265, 4122.752634841919, 4135.462389889295, 5421.0, 5442.591805614595, 5463.754131064112, 5502.532284755761, 5526.751296191681, 5719.48524632785, 5787.131930210502, 5860.501857342174, 5874.265716785402, 5924.289085309791, 5291.7354132294, 5364.8122315718765, 5432.402435732066, 5439.347278326626, 5464.726763661801, 5079.31429257053, 5158.4067832199025, 5197.870053248624, 5207.71357575337, 5216.634835561475, 5721.685307308138, 5800.651960882192, 5813.593048486566, 5865.560082993792, 5922.644641321534, 5851.063829787214, 5864.765409383577, 5921.0, 5921.61509501881, 5963.821085367446, 5908.438698323653, 5935.584509084322, 5941.22764040672, 5969.194158788508, 5975.760969561169, 5572.331320241597, 5612.0, 5638.492535671645, 5788.305403351625, 5812.21535092757, 5748.310202775527, 5791.0, 5803.970980145073, 5819.5635327351465, 5830.154627579062, 5725.370209276893, 5735.7418916148035, 5752.856178595402, 5793.565482588739, 5798.362180160095, 5549.528290095387, 5730.169125476866, 5745.511631511368, 5773.6824474654295, 5792.53659707214, 5430.755615997368, 5523.005858945428, 5575.9163612545035, 5582.581306401955, 5621.971890140523, 5592.3009623797025, 5667.40492248308, 5670.092785154356, 5685.459881311269, 5696.971515142398, 5402.054640437829, 5457.972710136424, 5508.779648814003, 5520.282363292907, 5556.944430555643], "mootools.html": [1315.9473621055158, 1745.1274362818588, 1819.3109272921477, 1836.6418548383072, 1842.7604411426512, 7380.963095184523, 7713.267239612235, 7860.135385107634, 7862.999999999993, 7877.7636670899965, 8008.239217274349, 8178.263956243937, 8194.713185038525, 8201.0, 8240.464369815958, 2010.2763005318075, 2051.815336619704, 2220.0897631970897, 2238.6194346961056, 2262.242148880127, 2278.943026424336, 2284.8057915077156, 2290.5991451496006, 2290.633498640218, 2291.6906217660653, 2192.1560199323217, 2247.7077979862597, 2247.78646028627, 2252.3017864462067, 2254.8872556372116, 1986.4537252255673, 2044.836413086957, 2202.7466841313135, 2246.056656204398, 2248.6627005949076, 2303.1363238785457, 2317.4206448387904, 2351.659009443621, 2351.670766092748, 2365.065799009382, 8074.515529068275, 8158.755237342889, 8168.959155204246, 8193.09875913649, 8209.466384685036, 4910.631702622318, 4986.750662466899, 4991.101601711691, 4999.500049995007, 5027.2207807789855, 2777.2084955787504, 2863.541833306661, 2864.871080801369, 2917.0811194473886, 2918.83946382951, 859.0807835615893, 862.0474375814697, 862.3360012790116, 867.4491697771897, 894.7718331825408, 10928.289661172077, 10931.945340273247, 10940.890591094067, 10943.06983906369, 10951.616693415772, 4351.6518678505645, 4448.532904045029, 4470.374147619336, 4524.479684836286, 4528.479224889114, 9444.150026497648, 9460.810783784285, 9464.053594640618, 9466.90533094674, 9469.337146399686, 4991.176455884811, 5005.574526165244, 5010.0, 5014.824481143142, 5025.547700706954, 4538.364628951949, 4548.340490628841, 4548.431446069241, 4556.157110934488, 4567.086582683477, 3765.359888818907, 3811.923761524754, 3852.3643598805884, 3873.0704630888386, 3878.941815872764, 1228.9139760216879, 1247.9376031198403, 1248.8813562711528, 1252.1735654468189, 1261.0920137500984, 925.7593025813202, 1267.2966503590412, 1280.4942047891218, 1302.7329397473495, 1304.1457845111277, 7036.19083805369, 7748.457607967501, 7872.173421790744, 7878.763637090897, 7902.3678105751405, 661.622874961277, 671.1811589860363, 1172.4255114993591, 1262.3246563088887, 1290.864459231786, 5983.401659834069, 6042.728077236535, 6057.57596968208, 6060.818175454743, 6067.45392914631, 9474.147326740627, 9787.168090712226, 9792.608295668237, 9803.117719405145, 9936.751581210528, 9757.463339516253, 9764.707058788248, 9773.951130244302, 9788.461634610023, 9798.75503112428, 6992.3357281058215, 7595.5442673439775, 7597.848043039108, 7607.049118860143, 7615.695372185161, 7078.1506219254015, 7166.53417527859, 7201.603911784902, 7205.135383753983, 7208.098987626547, 7926.128125906261, 7976.282134607914, 7986.440949133505, 8039.87940180886, 8124.065732440845, 8140.226678465537, 8194.22154895284, 8310.168983101641, 8313.085560588452, 8321.16788321163, 7082.645867706491, 7176.677049532679, 7181.138263408425, 7182.712691492282, 7184.712611495482, 7734.6132693366235, 7789.065312162576, 7797.376209903307, 7805.9609701953395, 7817.335526480086, 6886.931130688829, 7118.28817118284, 7164.928350716426, 7195.208527062124, 7252.057232559733, 7175.103112110986, 7196.9640151801, 7235.674394652148, 7236.819079523054, 7254.637268136466, 6610.768623098168, 6911.481638877205, 7335.413166946525, 7394.593297368697, 7411.666475008746, 6388.265349484869, 6593.670316484061, 6650.334966503505, 6658.467322614276, 6679.8664026718225, 6726.0, 6749.93250067493, 6768.357006084414, 6775.559588626724, 6785.050092986887], "ext.html": [554.3541773833487, 571.6827160925687, 574.1703238819907, 574.178924138482, 578.199194116149, 31318.373632527335, 32085.51871721926, 40187.79906100469, 40585.0, 40605.59394406062, 42951.78524107383, 43348.349774753406, 43526.34710479345, 43582.12835743283, 43590.0, 8318.085010648823, 9279.582418791153, 9341.0, 9489.762755931122, 9490.857637135448, 8433.662653493853, 11206.831897521544, 11459.0, 11477.885221147764, 11483.655490335303, 11101.500432480558, 11226.831597526043, 11227.943860280728, 11261.943690281578, 11287.435628218598, 8529.658813647447, 8654.48073115615, 11193.10455163585, 11257.43712814356, 11273.549058037668, 10944.507497162567, 11073.280236784583, 11092.611758588411, 11101.888981110167, 11111.333320000826, 39634.40548391776, 40107.398389023896, 40129.598704012875, 40137.59862401397, 40138.598614013776, 2859.7140285971236, 2898.884044638212, 2909.5199292116777, 2946.2781618503604, 3008.9699103008907, 27528.724712752817, 27587.72412275892, 27768.58347124795, 27857.0, 28097.157085287476, 2355.3051849704207, 2376.4534157143953, 2382.344855164826, 2481.2928315430195, 2484.5776218042975, 258415.9999999981, 258630.0, 258678.0, 259193.0, 260911.0, 54473.45526544763, 55306.72346638241, 57842.7107864458, 59239.70380148072, 59575.702121489114, 55305.44694553003, 55551.0, 55706.442935570936, 55708.44291557113, 55809.16286255628, 11845.5854045108, 11982.64052078439, 11988.520459181535, 11992.160548761503, 12047.03623710101, 8492.363072769567, 8497.787555311043, 8499.150084991452, 8504.31965442763, 8506.829863402822, 19258.793781887132, 19521.84468444332, 19605.901970490057, 19715.0, 19730.802691973182, 8729.345299102593, 8907.51008694515, 8908.10918908104, 8933.042161600244, 8945.105489451133, 903.8599017152352, 908.3096846396786, 938.2775263047552, 1085.4789700943434, 1186.3830807979975, 26433.867830661107, 26746.19761407161, 26766.5985010225, 28981.56527652087, 30073.248168795955, 1005.6329439754437, 1006.0643601450721, 1022.197574903697, 1034.5965073621144, 1035.6530562261576, 13706.314684265746, 14054.367553460119, 14114.788278175836, 14135.78796318056, 14267.574512332929, 306996.0, 311939.0, 312437.0, 312646.0, 312859.0, 53719.0, 54036.72981635145, 54039.72980135074, 54053.45946540484, 54069.0, 1359.456217512983, 1360.693843885118, 1383.1424516799648, 1385.4621370278983, 1386.8543802900954, 24794.752052479245, 25760.29156957636, 27788.30529236785, 30598.694013060474, 30761.0, 49311.26033109578, 49685.0, 49738.0, 49738.75130624323, 49765.0, 258106.0, 259168.0, 259232.0, 260151.0, 260198.0, 26714.19857404281, 30943.226419339695, 31289.0, 31332.843335783175, 31373.0, 36713.81643091767, 37552.624473756005, 37742.24515509619, 38259.234815304095, 38492.0, 32555.0, 34207.14482137867, 34422.31155376828, 34508.82745586256, 34554.30891382208, 34955.126121847155, 35232.0, 35772.64227357693, 38127.23745525129, 38199.0, 32704.83647581747, 33381.49927751134, 33602.83198583991, 33660.32679346448, 33710.662893370754, 28263.57604635891, 31292.530612040384, 31342.37315253728, 31356.216094596904, 31457.370852583277, 24034.51930961406, 24137.879310603334, 24318.635220471355, 24379.0, 24603.630945535475], "prototype.html": [315.485758214111, 322.6708757067791, 327.8131465064913, 333.1587740954092, 333.2651503434926, 6222.253329600454, 6374.45817105546, 6381.946978748501, 6427.068075129109, 6429.710663020163, 6207.255129384469, 6332.208473940757, 6362.0, 6390.360963903608, 6390.776322828702, 4821.686590371623, 4830.830920917769, 4835.951640483585, 4847.1032858921035, 4852.539008794177, 4564.863054108382, 4662.323963025359, 4718.363020992157, 4808.615310775147, 4826.49321821209, 4764.475907650173, 4773.785179666923, 4786.066716990188, 4797.2324428091515, 4802.327674125625, 4761.50004249554, 4764.332993380929, 4780.259059845712, 4786.449558300805, 4791.281307803857, 4128.896777580554, 4139.503259608836, 4144.979275103605, 4147.97926010368, 4150.91698166035, 6008.3390827009, 6117.418845209742, 6188.47397971173, 6203.348648391944, 6207.131001659771, 5492.450754924515, 5494.752736126884, 5509.173623956399, 5510.008198524264, 5529.723513824333, 6335.746570137189, 6534.183227096613, 6707.0, 6719.798406047827, 6749.19009718832, 4378.321360189144, 4417.447819022622, 4441.889527618096, 4455.910881782346, 4460.531644177379, 6957.478189135835, 7055.647217639149, 7061.964690176516, 7070.186928503236, 7079.89380159298, 4627.421572303462, 4628.5371462853445, 4636.675432719745, 4662.0, 4675.509071547439, 4592.2193227151465, 4775.403074615673, 4775.498572649822, 4780.211265141283, 4781.330613714083, 5502.504774570308, 5514.751836167382, 5514.91727624086, 5519.475649813261, 5525.171224316305, 6707.3628005339415, 6721.260661327348, 6725.6973436195485, 6729.192496900403, 6734.0, 1582.849629285216, 1617.8705703543687, 1663.160104147422, 1685.6544408396248, 1686.569924669226, 1080.7622323088908, 1099.2030777686273, 1099.780043991189, 1103.3214573037685, 1106.7288514314046, 6316.873662526816, 6332.208473940757, 6340.1123842661145, 6353.5870168438905, 6375.139356186855, 6911.0, 6917.066196063568, 6919.342662447059, 6931.306869313028, 6959.09531760878, 6119.143319935212, 6313.43179113882, 6314.210723659543, 6318.494520438354, 6331.968340158362, 3695.0392897846755, 3715.535558055243, 3736.178040831013, 3737.906552336159, 3740.588535261119, 6884.139482564679, 6886.2769409212315, 6887.449004079662, 6906.654667266616, 6907.34380233877, 6825.0, 7047.0, 7062.329078737512, 7072.823179420556, 7081.964590177016, 6857.794266172023, 6894.517383783087, 6901.62041087735, 6918.619475928872, 6919.619420931897, 6814.761483348059, 6926.480513961373, 6989.091418115612, 7065.01089847432, 7083.185433675193, 6903.0, 6946.0970073892095, 6952.895706564304, 6967.930320696728, 6987.580745155307, 7032.296770323132, 7063.223045464892, 7066.434685225273, 7080.0, 7102.857942841011, 4689.273162659793, 4691.483936767021, 4699.026408908335, 4699.741514216751, 4724.267738500538, 7045.048918395951, 7050.0, 7053.612051337021, 7057.7176912922905, 7091.361777439849, 6668.66656667155, 6852.760153394607, 6868.244493105654, 6887.896681549681, 6891.069705589681, 6779.762708305186, 6784.830379240559, 6792.76225332111, 6868.896966545606, 6916.481263905127, 6686.83282917931, 6695.12963314766, 6707.4969377297875, 6720.193576770819, 6727.0, 6679.0, 6835.7949261522235, 6865.794026179223, 6866.690998905161, 6899.0341352211735, 6702.664866756545, 6704.966475167788, 6706.631135287606, 6709.966450167718, 6716.059751634873], "yui.html": [742.6620887496193, 772.1082150116614, 773.0684525147199, 774.2644487736652, 779.9922000779991, 13528.932355338222, 13788.655283617914, 13854.584362469117, 13876.514321998731, 13878.37547310371, 12948.676283092927, 13103.606891793237, 13109.60671179866, 13116.409761560728, 13138.211707297569, 699.7935608995346, 712.6258714175048, 898.9685361012366, 909.56340956341, 910.517425764346, 897.0670502677208, 907.1518130547959, 911.6854685133651, 912.6167009855843, 913.2237598041645, 748.7304570354668, 758.2682711183706, 953.2516974175273, 959.5250351076227, 959.9424034557949, 921.2767977137948, 936.9390989585689, 938.1134827587932, 938.1416004356006, 938.5119737736408, 700.2052670219338, 701.0255744515129, 701.5194591704699, 701.8140192848899, 701.8140192848899, 13400.128991615515, 13517.594472165752, 13539.0, 13541.84894283987, 13558.525451609245, 11046.558137674483, 11403.0, 11569.53721851125, 11781.823272650918, 11798.587049453314, 9553.158705701062, 9590.42457452555, 9660.275479339078, 9774.5601447935, 10195.79608407835, 3292.736581073508, 3354.245294808673, 3365.96634033659, 3423.6062852772, 3543.5924868640177, 45571.3164302539, 46014.0, 46037.76981115073, 46341.30488042648, 46407.0, 8816.955915220382, 8832.293416526663, 8928.687495937611, 9066.0, 9070.138336857988, 19050.52373690669, 19106.426807195527, 19138.61722765537, 19152.23391064342, 19176.52058698516, 6828.180618325733, 6974.721011159497, 7095.900135479009, 7155.642217889084, 7237.819054523679, 3830.272248272819, 3889.766614003169, 3909.198614284065, 3911.3350730375905, 3926.4895563577124, 2964.86658100386, 2988.04382597571, 2993.730564249228, 2997.520396736512, 3004.474217012058, 417.7680100581094, 427.7134320005604, 432.9805158767863, 434.38751360581426, 437.6170850505807, 504.53078636868065, 575.2320651929637, 585.9501942334949, 589.2339958054512, 604.6493034040246, 7849.764507064797, 7941.967544219215, 7986.520808751494, 8105.959470202729, 8186.386021048445, 526.9156934890399, 571.9227904232959, 594.2957595249643, 619.0992106485054, 654.7086546486768, 3674.834632441493, 3829.061879839457, 3918.393458681927, 3945.3884647879627, 4013.6588389986596, 56432.43567564354, 57086.714566426905, 57136.42863571394, 57317.71341143268, 57427.42572574304, 47978.5202147981, 48351.5164848354, 48694.75652621714, 49103.26345104826, 49271.0, 42541.574584254384, 42769.78615106905, 43260.3510947336, 44951.77524112424, 44976.3253551197, 7738.92261077382, 8148.592570371577, 8282.668693252203, 8480.406371553932, 8691.688343862257, 33497.49753753647, 33660.49509257412, 33753.662463375054, 34534.30931381408, 34749.0, 40996.18007639771, 41096.38355424611, 44159.55840441555, 44519.0, 45093.0, 7428.220036896264, 7452.292032256927, 7468.3278504934815, 7470.140933792466, 7699.653515591924, 11207.495662695035, 11228.66314010581, 11314.587934671581, 11511.53953841837, 11757.529698811952, 10083.0, 10180.79638407213, 10484.161267098461, 10849.07782838436, 11037.392943388191, 10390.272680912565, 10646.148308135176, 10724.410157441416, 10748.140148787921, 11210.55157793679, 8103.790357906541, 9280.767980800263, 9980.550875210487, 10527.789444211227, 10606.310589811637, 8449.112843151626, 8671.653133874574, 8676.826463470821, 8745.318723126033, 8844.46933184011, 8698.739037828875, 9399.248060155307, 9446.622135114518, 9457.290703197425, 9514.476703781358]}, "summary": {"lowerIsBetter": false, "suite": 6634.732078729865, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6450.51687249844, "unit": "ms", "value": 6450.51687249844}, "dojo.html": {"lowerIsBetter": false, "filtered": 5347.258025025004, "unit": "ms", "value": 5347.258025025004}, "mootools.html": {"lowerIsBetter": false, "filtered": 4563.372502270935, "unit": "ms", "value": 4563.372502270935}, "ext.html": {"lowerIsBetter": false, "filtered": 18005.31885018948, "unit": "ms", "value": 18005.31885018948}, "prototype.html": {"lowerIsBetter": false, "filtered": 5017.251489774353, "unit": "ms", "value": 5017.251489774353}, "yui.html": {"lowerIsBetter": false, "filtered": 5998.297922241935, "unit": "ms", "value": 5998.297922241935}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0006"}, "testrun": {"date": 1447672947, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116023436", "branch": "Mozilla-Inbound", "revision": "6b311176b6354995c31b7cb761323f9566493e71"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 159.0, 160.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 160.0], "ai-astar": [107.0, 107.0, 104.0, 106.0, 107.0, 108.0, 105.0, 105.0, 98.0, 106.0], "imaging-gaussian-blur": [119.0, 120.0, 114.0, 119.0, 120.0, 120.0, 114.0, 114.0, 114.0, 120.0], "audio-beat-detection": [154.0, 130.0, 149.0, 164.0, 126.0, 149.0, 146.0, 126.0, 164.0, 127.0], "json-stringify-tinderbox": [68.0, 68.0, 70.0, 69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 71.0], "stanford-crypto-pbkdf2": [153.0, 151.0, 153.0, 154.0, 152.0, 146.0, 154.0, 155.0, 151.0, 152.0], "json-parse-financial": [59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 67.0, 58.0, 58.0], "stanford-crypto-sha256-iterative": [70.0, 72.0, 72.0, 70.0, 71.0, 71.0, 70.0, 71.0, 70.0, 70.0], "audio-fft": [78.0, 80.0, 87.0, 85.0, 68.0, 71.0, 104.0, 80.0, 82.0, 66.0], "imaging-darkroom": [125.0, 124.0, 125.0, 125.0, 125.0, 125.0, 131.0, 126.0, 124.0, 124.0], "stanford-crypto-ccm": [127.0, 127.0, 135.0, 122.0, 128.0, 134.0, 124.0, 129.0, 133.0, 123.0], "audio-oscillator": [98.0, 98.0, 134.0, 88.0, 89.0, 89.0, 127.0, 88.0, 88.0, 132.0], "stanford-crypto-aes": [85.0, 87.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 86.0, 86.0], "imaging-desaturate": [93.0, 93.0, 100.0, 93.0, 93.0, 93.0, 100.0, 93.0, 94.0, 100.0]}, "summary": {"lowerIsBetter": true, "suite": 1496.1, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.1, "unit": "ms", "value": 80.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 152.1, "unit": "ms", "value": 152.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.5, "unit": "ms", "value": 143.5}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 128.2, "unit": "ms", "value": 128.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 125.4, "unit": "ms", "value": 125.4}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.5, "unit": "ms", "value": 59.5}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.1, "unit": "ms", "value": 103.1}, "ai-astar": {"lowerIsBetter": true, "filtered": 105.3, "unit": "ms", "value": 105.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.0, "unit": "ms", "value": 161.0}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 70.7, "unit": "ms", "value": 70.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.6, "unit": "ms", "value": 69.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 117.4, "unit": "ms", "value": 117.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 85.0, "unit": "ms", "value": 85.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.2, "unit": "ms", "value": 95.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0006"}, "testrun": {"date": 1447672947, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116023436", "branch": "Mozilla-Inbound", "revision": "6b311176b6354995c31b7cb761323f9566493e71"}}, {"talos_counters": {}, "results": {"DeltaBlue": [198.4914648670107], "Encrypt": [325.5208333333333], "NavierStokes": [5797.687861271676], "Decrypt": [5737.142857142857], "Splay": [677.0480704129993], "Richards": [166.36167027116952], "RegExp": [30029.41176470588], "Earley": [941.6195856873823], "Boyer": [12432.098765432098], "RayTrace": [1912.0458891013384]}, "summary": {"lowerIsBetter": false, "suite": 18131.24861015268, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 333.10248399999995, "unit": "score", "value": 333.10248399999995}, "Encrypt": {"lowerIsBetter": false, "filtered": 817.7080319999998, "unit": "score", "value": 817.7080319999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 255.96410767696923, "unit": "score", "value": 255.96410767696923}, "Decrypt": {"lowerIsBetter": false, "filtered": 46.3960906374502, "unit": "score", "value": 46.3960906374502}, "Splay": {"lowerIsBetter": false, "filtered": 120.36220700000004, "unit": "score", "value": 120.36220700000004}, "RegExp": {"lowerIsBetter": false, "filtered": 30.336425073457388, "unit": "score", "value": 30.336425073457388}, "Richards": {"lowerIsBetter": false, "filtered": 212.20032200000009, "unit": "score", "value": 212.20032200000009}, "Earley": {"lowerIsBetter": false, "filtered": 707.7837059999998, "unit": "score", "value": 707.7837059999998}, "Boyer": {"lowerIsBetter": false, "filtered": 53.608245283018846, "unit": "score", "value": 53.608245283018846}, "RayTrace": {"lowerIsBetter": false, "filtered": 387.0142470000002, "unit": "score", "value": 387.0142470000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0006"}, "testrun": {"date": 1447672947, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116023436", "branch": "Mozilla-Inbound", "revision": "6b311176b6354995c31b7cb761323f9566493e71"}}] 03:42:38 INFO - RETURN: dromaeo_css: 6634.73 03:42:38 INFO - RETURN: kraken: 1496.10 03:42:38 INFO - RETURN: v8_7: 18131.25 03:42:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,55]]", "result": "18131.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,55]]", "result": "1496.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,55]]", "result": "6634.73"}}} 03:42:38 INFO - Return code: 0 03:42:38 INFO - # TBPL SUCCESS # 03:42:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:42:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:42:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:42:38 INFO - 2015-11-16 03:42:38.106 screenresolution[1688:10046] starting screenresolution argv=screenresolution get 03:42:38 INFO - 2015-11-16 03:42:38.109 screenresolution[1688:10046] Display 0: 1600x1200x32@60 03:42:38 INFO - 2015-11-16 03:42:38.116 screenresolution[1689:10049] starting screenresolution argv=screenresolution list 03:42:38 INFO - Available Modes on Display 0 03:42:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:42:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:42:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:42:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:42:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:42:38 INFO - Intel HD Graphics 3000: 03:42:38 INFO - Chipset Model: Intel HD Graphics 3000 03:42:38 INFO - Type: GPU 03:42:38 INFO - Bus: Built-In 03:42:38 INFO - VRAM (Total): 512 MB 03:42:38 INFO - VRAM (Dynamic, Max): 10 03:42:38 INFO - Vendor: Intel (0x8086) 03:42:38 INFO - Device ID: 0x0116 03:42:38 INFO - Revision ID: 0x0009 03:42:38 INFO - Displays: 03:42:38 INFO - Display: 03:42:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:42:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:42:38 INFO - Display Serial Number: 1600x1200 60 03:42:38 INFO - Main Display: Yes 03:42:38 INFO - Mirror: Off 03:42:38 INFO - Online: Yes 03:42:38 INFO - Rotation: Supported 03:42:38 INFO - Return code: 0 03:42:38 INFO - Running post-action listener: _resource_record_post_action 03:42:38 INFO - Running post-run listener: _resource_record_post_run 03:42:39 INFO - Total resource usage - Wall time: 1251s; CPU: 30.0%; Read bytes: 37007360; Write bytes: 686754816; Read time: 7618; Write time: 48355 03:42:39 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 337013248; Write bytes: 333674496; Read time: 33390; Write time: 5174 03:42:39 INFO - run-tests - Wall time: 1212s; CPU: 30.0%; Read bytes: 35860480; Write bytes: 338848768; Read time: 6783; Write time: 40095 03:42:39 INFO - Running post-run listener: _upload_blobber_files 03:42:39 INFO - Blob upload gear active. 03:42:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:42:39 INFO - Copying logs to upload dir... 03:42:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1310.167336 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-16 03:42:39.538153) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 03:42:39.542112) ========= 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.sg9cJmNwsL/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.6NaMQftA2B/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010011 build_url: 'https://queue.taskcluster.net/v1/task/FEv3LKoyTOyIFyqDJQpI_g/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-16 03:42:39.569711) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:42:39.570344) ========= 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.sg9cJmNwsL/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.6NaMQftA2B/Listeners TMPDIR=/var/folders/qn/0tq7qsfs55z3zcj458fr0sg000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005301 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 03:42:39.622381) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 03:42:39.622858) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 03:42:39.623337) ========= ========= Total master_lag: 0.24 =========