builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0008 starttime: 1448343051.45 results: success (0) buildid: 20151123203633 builduid: b31e97283d164f19990ec0a07fe5811b revision: f6cccadd2eed5ef737f26006f58bcdec048d4e34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.449903) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.450654) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.451006) ========= 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.tz3BVx7zld/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.ymLBa6SPIn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005313 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.479520) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.479919) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.916811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.917575) ========= 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.tz3BVx7zld/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.ymLBa6SPIn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005781 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.962319) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.965541) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.966337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:51.966876) ========= 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.tz3BVx7zld/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.ymLBa6SPIn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-23 21:30:52-- 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% 8.67M=0.001s 2015-11-23 21:30:52 (8.67 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.680181 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:52.709561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:52.709846) ========= 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.tz3BVx7zld/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.ymLBa6SPIn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025570 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:52.767163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 21:30:52.767696) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f6cccadd2eed5ef737f26006f58bcdec048d4e34 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f6cccadd2eed5ef737f26006f58bcdec048d4e34 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tz3BVx7zld/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.ymLBa6SPIn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-23 21:30:52,861 truncating revision to first 12 chars 2015-11-23 21:30:52,861 Setting DEBUG logging. 2015-11-23 21:30:52,861 attempt 1/10 2015-11-23 21:30:52,861 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f6cccadd2eed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 21:30:54,198 unpacking tar archive at: fx-team-f6cccadd2eed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.632963 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 21:30:54.432772) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:54.433139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:54.443877) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:54.444168) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 21:30:54.444633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2015-11-23 21:30:54.444924) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tz3BVx7zld/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.ymLBa6SPIn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 21:30:54 INFO - MultiFileLogger online at 20151123 21:30:54 in /builds/slave/test 21:30:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:30:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:30:54 INFO - {'append_to_log': False, 21:30:54 INFO - 'base_work_dir': '/builds/slave/test', 21:30:54 INFO - 'blob_upload_branch': 'Fx-Team', 21:30:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:30:54 INFO - 'branch': 'Fx-Team', 21:30:54 INFO - 'buildbot_json_path': 'buildprops.json', 21:30:54 INFO - 'config_files': ('talos/mac_config.py',), 21:30:54 INFO - 'default_actions': ('clobber', 21:30:54 INFO - 'read-buildbot-config', 21:30:54 INFO - 'download-and-extract', 21:30:54 INFO - 'populate-webroot', 21:30:54 INFO - 'create-virtualenv', 21:30:54 INFO - 'install', 21:30:54 INFO - 'run-tests'), 21:30:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:30:54 INFO - 'download_minidump_stackwalk': True, 21:30:54 INFO - 'download_symbols': 'ondemand', 21:30:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:30:54 INFO - 'tooltool.py': '/tools/tooltool.py', 21:30:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:30:54 INFO - '/tools/misc-python/virtualenv.py')}, 21:30:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:30:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:30:54 INFO - 'installer_path': 'installer.exe', 21:30:54 INFO - 'log_level': 'info', 21:30:54 INFO - 'log_name': 'talos', 21:30:54 INFO - 'log_to_console': True, 21:30:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:30:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:30:54 INFO - 'opt_config_files': (), 21:30:54 INFO - 'pip_index': False, 21:30:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:30:54 INFO - 'cmd': ('bash', 21:30:54 INFO - '-c', 21:30:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:30:54 INFO - 'enabled': True, 21:30:54 INFO - 'halt_on_failure': False, 21:30:54 INFO - 'name': 'check_screen_resolution'},), 21:30:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:30:54 INFO - 'cmd': ('bash', 21:30:54 INFO - '-c', 21:30:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:30:54 INFO - 'enabled': True, 21:30:54 INFO - 'halt_on_failure': False, 21:30:54 INFO - 'name': 'check_screen_resolution'},), 21:30:54 INFO - 'run_cmd_checks_enabled': True, 21:30:54 INFO - 'sps_profile': False, 21:30:54 INFO - 'sps_profile_interval': 0, 21:30:54 INFO - 'suite': 'dromaeojs', 21:30:54 INFO - 'system_bits': '64', 21:30:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:30:54 INFO - 'title': 't-yosemite-r7-0008', 21:30:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:30:54 INFO - 'use_talos_json': True, 21:30:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:30:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:30:54 INFO - 'work_dir': 'build'} 21:30:54 INFO - ##### 21:30:54 INFO - ##### Running clobber step. 21:30:54 INFO - ##### 21:30:54 INFO - Running pre-action listener: _resource_record_pre_action 21:30:54 INFO - Running main action method: clobber 21:30:54 INFO - rmtree: /builds/slave/test/build 21:30:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:30:56 INFO - Running post-action listener: _resource_record_post_action 21:30:56 INFO - ##### 21:30:56 INFO - ##### Running read-buildbot-config step. 21:30:56 INFO - ##### 21:30:56 INFO - Running pre-action listener: _resource_record_pre_action 21:30:56 INFO - Running main action method: read_buildbot_config 21:30:56 INFO - Using buildbot properties: 21:30:56 INFO - { 21:30:56 INFO - "properties": { 21:30:56 INFO - "buildnumber": 16, 21:30:56 INFO - "product": "firefox", 21:30:56 INFO - "script_repo_revision": "production", 21:30:56 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 21:30:56 INFO - "repository": "", 21:30:56 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 21:30:56 INFO - "buildid": "20151123203633", 21:30:56 INFO - "slavename": "t-yosemite-r7-0008", 21:30:56 INFO - "pgo_build": "False", 21:30:56 INFO - "basedir": "/builds/slave/test", 21:30:56 INFO - "project": "", 21:30:56 INFO - "platform": "yosemite_r7", 21:30:56 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:30:56 INFO - "slavebuilddir": "test", 21:30:56 INFO - "scheduler": "tests-fx-team-macosx64-talos", 21:30:56 INFO - "branch": "fx-team", 21:30:56 INFO - "repo_path": "integration/fx-team", 21:30:56 INFO - "stage_platform": "macosx64", 21:30:56 INFO - "builduid": "b31e97283d164f19990ec0a07fe5811b", 21:30:56 INFO - "revision": "f6cccadd2eed5ef737f26006f58bcdec048d4e34" 21:30:56 INFO - }, 21:30:56 INFO - "sourcestamp": { 21:30:56 INFO - "repository": "", 21:30:56 INFO - "hasPatch": false, 21:30:56 INFO - "project": "", 21:30:56 INFO - "branch": "fx-team-macosx64-talos", 21:30:56 INFO - "changes": [ 21:30:56 INFO - { 21:30:56 INFO - "category": null, 21:30:56 INFO - "files": [ 21:30:56 INFO - { 21:30:56 INFO - "url": null, 21:30:56 INFO - "name": "https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 21:30:56 INFO - } 21:30:56 INFO - ], 21:30:56 INFO - "repository": "", 21:30:56 INFO - "rev": "f6cccadd2eed5ef737f26006f58bcdec048d4e34", 21:30:56 INFO - "who": "nchen@mozilla.com", 21:30:56 INFO - "when": 1448342995, 21:30:56 INFO - "number": 6698965, 21:30:56 INFO - "comments": "Bug 1221270 - Schedule and perform GMP updates in AddonUpdateService; r=snorp\nThis patch moves the GMP update process from browser.js startup to\nAddonUpdateService. It also uses the Gecko:ScheduleRun event in\nGeckoService to schedule headless runs in order to perform updates\nperiodically.", 21:30:56 INFO - "project": "", 21:30:56 INFO - "at": "Mon 23 Nov 2015 21:29:55", 21:30:56 INFO - "branch": "fx-team-macosx64-talos", 21:30:56 INFO - "revlink": "", 21:30:56 INFO - "properties": [ 21:30:56 INFO - [ 21:30:56 INFO - "buildid", 21:30:56 INFO - "20151123203633", 21:30:56 INFO - "Change" 21:30:56 INFO - ], 21:30:56 INFO - [ 21:30:56 INFO - "builduid", 21:30:56 INFO - "b31e97283d164f19990ec0a07fe5811b", 21:30:56 INFO - "Change" 21:30:56 INFO - ], 21:30:56 INFO - [ 21:30:56 INFO - "pgo_build", 21:30:56 INFO - "False", 21:30:56 INFO - "Change" 21:30:56 INFO - ] 21:30:56 INFO - ], 21:30:56 INFO - "revision": "f6cccadd2eed5ef737f26006f58bcdec048d4e34" 21:30:56 INFO - } 21:30:56 INFO - ], 21:30:56 INFO - "revision": "f6cccadd2eed5ef737f26006f58bcdec048d4e34" 21:30:56 INFO - } 21:30:56 INFO - } 21:30:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 21:30:56 INFO - Running post-action listener: _resource_record_post_action 21:30:56 INFO - ##### 21:30:56 INFO - ##### Running download-and-extract step. 21:30:56 INFO - ##### 21:30:56 INFO - Running pre-action listener: _resource_record_pre_action 21:30:56 INFO - Running main action method: download_and_extract 21:30:56 INFO - mkdir: /builds/slave/test/build/tests 21:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:56 INFO - https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:30:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/test_packages.json 21:30:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/test_packages.json 21:30:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:30:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:30:57 INFO - Downloaded 1149 bytes. 21:30:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:30:57 INFO - Using the following test package requirements: 21:30:57 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:30:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:30:57 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 21:30:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:30:57 INFO - u'jsshell-mac.zip'], 21:30:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:30:57 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 21:30:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:30:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:30:57 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 21:30:57 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:30:57 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 21:30:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:30:57 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 21:30:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:30:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:30:57 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 21:30:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:57 INFO - https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:30:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:30:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:30:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:30:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:30:59 INFO - Downloaded 17526951 bytes. 21:30:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 21:30:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:30:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:31:02 INFO - Return code: 0 21:31:02 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:02 INFO - https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:31:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:31:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:31:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:31:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:31:06 INFO - Downloaded 17526951 bytes. 21:31:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 21:31:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:31:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:31:10 INFO - Return code: 0 21:31: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')]} 21:31:10 INFO - https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:31:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:31:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:31:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:31:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:31:12 INFO - Downloaded 11130997 bytes. 21:31:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 21:31:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:31:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 21:31:12 INFO - Return code: 0 21:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:12 INFO - https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:31:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:31:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:31:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 21:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 21:31:15 INFO - Downloaded 109910408 bytes. 21:31:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:31:15 INFO - mkdir: /builds/slave/test/properties 21:31:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:31:15 INFO - Writing to file /builds/slave/test/properties/build_url 21:31:15 INFO - Contents: 21:31:15 INFO - build_url:https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:31:15 INFO - Running post-action listener: _resource_record_post_action 21:31:15 INFO - Running post-action listener: set_extra_try_arguments 21:31:15 INFO - ##### 21:31:15 INFO - ##### Running populate-webroot step. 21:31:15 INFO - ##### 21:31:15 INFO - Running pre-action listener: _resource_record_pre_action 21:31:15 INFO - Running main action method: populate_webroot 21:31:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:31:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:31:15 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:31:15 INFO - '../fennec_ids.txt'], 21:31:15 INFO - 'tests': ['tcheck2']}, 21:31:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:31:15 INFO - '--tppagecycles', 21:31:15 INFO - '7'], 21:31:15 INFO - 'tests': ['tsvgm']}}, 21:31:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:31:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:31:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:31:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:31:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:31:15 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:31:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:31:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:15 INFO - 'talos_options': ['--e10s'], 21:31:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:31:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:15 INFO - 'tests': ['damp', 'tps']}, 21:31:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:15 INFO - 'talos_options': ['--e10s'], 21:31:15 INFO - 'tests': ['damp', 'tps']}, 21:31:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:31:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:31:15 INFO - 'other': {'tests': ['a11yr', 21:31:15 INFO - 'ts_paint', 21:31:15 INFO - 'tpaint', 21:31:15 INFO - 'sessionrestore', 21:31:15 INFO - 'sessionrestore_no_auto_restore']}, 21:31:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:31:15 INFO - 'tests': ['a11yr', 21:31:15 INFO - 'ts_paint', 21:31:15 INFO - 'tpaint', 21:31:15 INFO - 'sessionrestore', 21:31:15 INFO - 'sessionrestore_no_auto_restore']}, 21:31:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:31:15 INFO - 'tests': ['a11yr', 21:31:15 INFO - 'ts_paint', 21:31:15 INFO - 'tpaint', 21:31:15 INFO - 'sessionrestore', 21:31:15 INFO - 'sessionrestore_no_auto_restore']}, 21:31:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:31:15 INFO - 'tests': ['a11yr', 21:31:15 INFO - 'ts_paint', 21:31:15 INFO - 'tpaint', 21:31:15 INFO - 'sessionrestore', 21:31:15 INFO - 'sessionrestore_no_auto_restore']}, 21:31:15 INFO - 'other_l64': {'tests': ['a11yr', 21:31:15 INFO - 'ts_paint', 21:31:15 INFO - 'tpaint', 21:31:15 INFO - 'sessionrestore', 21:31:15 INFO - 'sessionrestore_no_auto_restore']}, 21:31:15 INFO - 'other_nol64': {'tests': ['a11yr', 21:31:15 INFO - 'ts_paint', 21:31:15 INFO - 'tpaint', 21:31:15 INFO - 'sessionrestore', 21:31:15 INFO - 'sessionrestore_no_auto_restore']}, 21:31:15 INFO - 'svgr': {'tests': ['tsvgx', 21:31:15 INFO - 'tsvgr_opacity', 21:31:15 INFO - 'tart', 21:31:15 INFO - 'tscrollx', 21:31:15 INFO - 'cart']}, 21:31:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:31:15 INFO - 'tests': ['tsvgx', 21:31:15 INFO - 'tsvgr_opacity', 21:31:15 INFO - 'tart', 21:31:15 INFO - 'tscrollx', 21:31:15 INFO - 'cart']}, 21:31:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:15 INFO - 'tests': ['tp5o']}, 21:31:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:15 INFO - 'talos_options': ['--e10s'], 21:31:15 INFO - 'tests': ['tp5o']}, 21:31:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:15 INFO - 'talos_options': ['--xperf_path', 21:31:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:31:15 INFO - 'tests': ['tp5n']}, 21:31:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:31:15 INFO - 'talos_options': ['--e10s', 21:31:15 INFO - '--xperf_path', 21:31:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:31:15 INFO - 'tests': ['tp5n']}}, 21:31:15 INFO - 'talos.zip': {'path': '', 21:31:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:31:15 INFO - Running post-action listener: _resource_record_post_action 21:31:15 INFO - ##### 21:31:15 INFO - ##### Running create-virtualenv step. 21:31:15 INFO - ##### 21:31:15 INFO - Running pre-action listener: _resource_record_pre_action 21:31:15 INFO - Running main action method: create_virtualenv 21:31:15 INFO - Creating virtualenv /builds/slave/test/build/venv 21:31: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 21:31:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:31:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:31:15 INFO - Using real prefix '/tools/python27' 21:31:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:31:16 INFO - Installing distribute.............................................................................................................................................................................................done. 21:31:19 INFO - Installing pip.................done. 21:31:19 INFO - Return code: 0 21:31:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:19 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 0x10a275490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a252228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a04c4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1999f0>, '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 0x109ef8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/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.ymLBa6SPIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/Render', 21:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:31:19 INFO - 'HOME': '/Users/cltbld', 21:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:31:19 INFO - 'LOGNAME': 'cltbld', 21:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:19 INFO - 'MOZ_NO_REMOTE': '1', 21:31:19 INFO - 'NO_EM_RESTART': '1', 21:31:19 INFO - 'PAGER': '/bin/cat', 21:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:19 INFO - 'PWD': '/builds/slave/test', 21:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:31:19 INFO - 'SHELL': '/bin/bash', 21:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ymLBa6SPIn/Listeners', 21:31:19 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 21:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:31:19 INFO - 'USER': 'cltbld', 21:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:19 INFO - 'XPC_FLAGS': '0x0', 21:31:19 INFO - 'XPC_SERVICE_NAME': '0', 21:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:31:19 INFO - Cleaning up... 21:31:19 INFO - Return code: 0 21:31:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:19 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 0x10a275490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a252228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a04c4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1999f0>, '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 0x109ef8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/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.ymLBa6SPIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 21:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:31:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/Render', 21:31:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:31:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:31:19 INFO - 'HOME': '/Users/cltbld', 21:31:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:31:19 INFO - 'LOGNAME': 'cltbld', 21:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:19 INFO - 'MOZ_NO_REMOTE': '1', 21:31:19 INFO - 'NO_EM_RESTART': '1', 21:31:19 INFO - 'PAGER': '/bin/cat', 21:31:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:19 INFO - 'PWD': '/builds/slave/test', 21:31:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:31:19 INFO - 'SHELL': '/bin/bash', 21:31:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ymLBa6SPIn/Listeners', 21:31:19 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 21:31:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:31:19 INFO - 'USER': 'cltbld', 21:31:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:31:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:19 INFO - 'XPC_FLAGS': '0x0', 21:31:19 INFO - 'XPC_SERVICE_NAME': '0', 21:31:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:19 INFO - Downloading/unpacking psutil>=0.7.1 21:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:22 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:31:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:31:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:31:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:31:22 INFO - Installing collected packages: psutil 21:31:22 INFO - Running setup.py install for psutil 21:31:22 INFO - building 'psutil._psutil_osx' extension 21:31:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:31:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:31:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:31:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 21:31:23 INFO - building 'psutil._psutil_posix' extension 21:31:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 21:31:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:31:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:31:23 INFO - ^ 21:31:23 INFO - 1 warning generated. 21:31:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 21:31:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:31:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:31:23 INFO - Successfully installed psutil 21:31:23 INFO - Cleaning up... 21:31:24 INFO - Return code: 0 21:31:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:24 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 0x10a275490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a252228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a04c4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1999f0>, '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 0x109ef8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/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.ymLBa6SPIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 21:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:31:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/Render', 21:31:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:31:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:31:24 INFO - 'HOME': '/Users/cltbld', 21:31:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:31:24 INFO - 'LOGNAME': 'cltbld', 21:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:24 INFO - 'MOZ_NO_REMOTE': '1', 21:31:24 INFO - 'NO_EM_RESTART': '1', 21:31:24 INFO - 'PAGER': '/bin/cat', 21:31:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:24 INFO - 'PWD': '/builds/slave/test', 21:31:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:31:24 INFO - 'SHELL': '/bin/bash', 21:31:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ymLBa6SPIn/Listeners', 21:31:24 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 21:31:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:31:24 INFO - 'USER': 'cltbld', 21:31:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:31:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:24 INFO - 'XPC_FLAGS': '0x0', 21:31:24 INFO - 'XPC_SERVICE_NAME': '0', 21:31:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:31:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:31:26 INFO - Installing collected packages: mozsystemmonitor 21:31:26 INFO - Running setup.py install for mozsystemmonitor 21:31:26 INFO - Successfully installed mozsystemmonitor 21:31:26 INFO - Cleaning up... 21:31:26 INFO - Return code: 0 21:31:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:26 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 0x10a275490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a252228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a04c4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1999f0>, '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 0x109ef8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/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.ymLBa6SPIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/Render', 21:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:31:26 INFO - 'HOME': '/Users/cltbld', 21:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:31:26 INFO - 'LOGNAME': 'cltbld', 21:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:26 INFO - 'MOZ_NO_REMOTE': '1', 21:31:26 INFO - 'NO_EM_RESTART': '1', 21:31:26 INFO - 'PAGER': '/bin/cat', 21:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:26 INFO - 'PWD': '/builds/slave/test', 21:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:31:26 INFO - 'SHELL': '/bin/bash', 21:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ymLBa6SPIn/Listeners', 21:31:26 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 21:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:31:26 INFO - 'USER': 'cltbld', 21:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:26 INFO - 'XPC_FLAGS': '0x0', 21:31:26 INFO - 'XPC_SERVICE_NAME': '0', 21:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:27 INFO - Downloading/unpacking blobuploader==1.2.4 21:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:29 INFO - Downloading blobuploader-1.2.4.tar.gz 21:31:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:31:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:31:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:30 INFO - Downloading docopt-0.6.1.tar.gz 21:31:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:31:30 INFO - Installing collected packages: blobuploader, requests, docopt 21:31:30 INFO - Running setup.py install for blobuploader 21:31:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:31:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:31:30 INFO - Running setup.py install for requests 21:31:30 INFO - Running setup.py install for docopt 21:31:31 INFO - Successfully installed blobuploader requests docopt 21:31:31 INFO - Cleaning up... 21:31:31 INFO - Return code: 0 21:31:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:31: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')]} 21:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31: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')]} 21:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:31 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 0x10a275490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a252228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a04c4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1999f0>, '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 0x109ef8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/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.ymLBa6SPIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/Render', 21:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:31:31 INFO - 'HOME': '/Users/cltbld', 21:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:31:31 INFO - 'LOGNAME': 'cltbld', 21:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:31 INFO - 'MOZ_NO_REMOTE': '1', 21:31:31 INFO - 'NO_EM_RESTART': '1', 21:31:31 INFO - 'PAGER': '/bin/cat', 21:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:31 INFO - 'PWD': '/builds/slave/test', 21:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:31:31 INFO - 'SHELL': '/bin/bash', 21:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ymLBa6SPIn/Listeners', 21:31:31 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 21:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:31:31 INFO - 'USER': 'cltbld', 21:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:31 INFO - 'XPC_FLAGS': '0x0', 21:31:31 INFO - 'XPC_SERVICE_NAME': '0', 21:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:31:31 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ZesXqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:31:31 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-zo5rfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:31:31 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ptQYHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:31:31 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-87zTuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:31:31 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-CBgVuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:31:31 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Mh1sPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:31:32 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Yvilyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:31:32 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-npIaCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:31:32 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-sloDYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:31:32 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-JcQiiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:31:32 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-6Q8MJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:31:32 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-81406I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:31:32 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-euGmnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:31:32 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-AilrYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:32 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ddGwD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:31:32 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Z6RJRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:31:33 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-38uveF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:31:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:31:33 INFO - Running setup.py install for manifestparser 21:31:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:31:33 INFO - Running setup.py install for mozcrash 21:31:33 INFO - Running setup.py install for mozdebug 21:31:33 INFO - Running setup.py install for mozdevice 21:31:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:31:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:31:33 INFO - Running setup.py install for mozfile 21:31:33 INFO - Running setup.py install for mozhttpd 21:31:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:31:34 INFO - Running setup.py install for mozinfo 21:31:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:31:34 INFO - Running setup.py install for mozInstall 21:31:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:31:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:31:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:31:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:31:34 INFO - Running setup.py install for mozleak 21:31:34 INFO - Running setup.py install for mozlog 21:31:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:31:34 INFO - Running setup.py install for moznetwork 21:31:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:31:34 INFO - Running setup.py install for mozprocess 21:31:34 INFO - Running setup.py install for mozprofile 21:31:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:31:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:31:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:31:35 INFO - Running setup.py install for mozrunner 21:31:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:31:35 INFO - Running setup.py install for mozscreenshot 21:31:35 INFO - Running setup.py install for moztest 21:31:35 INFO - Running setup.py install for mozversion 21:31:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:31:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:31:35 INFO - Cleaning up... 21:31:35 INFO - Return code: 0 21:31:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:35 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 0x10a275490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a252228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a04c4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1999f0>, '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 0x109ef8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/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.ymLBa6SPIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:31:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/Render', 21:31:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:31:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:31:35 INFO - 'HOME': '/Users/cltbld', 21:31:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:31:35 INFO - 'LOGNAME': 'cltbld', 21:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:35 INFO - 'MOZ_NO_REMOTE': '1', 21:31:35 INFO - 'NO_EM_RESTART': '1', 21:31:35 INFO - 'PAGER': '/bin/cat', 21:31:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:35 INFO - 'PWD': '/builds/slave/test', 21:31:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:31:35 INFO - 'SHELL': '/bin/bash', 21:31:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ymLBa6SPIn/Listeners', 21:31:35 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 21:31:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:31:35 INFO - 'USER': 'cltbld', 21:31:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:31:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:35 INFO - 'XPC_FLAGS': '0x0', 21:31:35 INFO - 'XPC_SERVICE_NAME': '0', 21:31:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:31:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-X4CL8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:31:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-BOIqql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:31:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ybnShs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:31:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-5YDaPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:31:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-vHboFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:31:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-zZU70G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:31:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-CdMblt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:31:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-_wPKc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:31:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-ZfdRlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:31:36 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-MN_sJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:31:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-vtOwNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:31:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-xQhq3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:31:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-Wsy_Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:31:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-JPd8Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-1pSpMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:31:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-VS24_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:31:37 INFO - Running setup.py (path:/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/pip-OFfyYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:31:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:31:39 INFO - Downloading blessings-1.5.1.tar.gz 21:31:39 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 21:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:31:40 INFO - Installing collected packages: blessings 21:31:40 INFO - Running setup.py install for blessings 21:31:40 INFO - Successfully installed blessings 21:31:40 INFO - Cleaning up... 21:31:40 INFO - Return code: 0 21:31:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:31:40 INFO - Reading from file tmpfile_stdout 21:31:40 INFO - Current package versions: 21:31:40 INFO - blessings == 1.5.1 21:31:40 INFO - blobuploader == 1.2.4 21:31:40 INFO - docopt == 0.6.1 21:31:40 INFO - manifestparser == 1.1 21:31:40 INFO - mozInstall == 1.12 21:31:40 INFO - mozcrash == 0.16 21:31:40 INFO - mozdebug == 0.1 21:31:40 INFO - mozdevice == 0.47 21:31:40 INFO - mozfile == 1.2 21:31:40 INFO - mozhttpd == 0.7 21:31:40 INFO - mozinfo == 0.9 21:31:40 INFO - mozleak == 0.1 21:31:40 INFO - mozlog == 3.1 21:31:40 INFO - moznetwork == 0.27 21:31:40 INFO - mozprocess == 0.22 21:31:40 INFO - mozprofile == 0.27 21:31:40 INFO - mozrunner == 6.11 21:31:40 INFO - mozscreenshot == 0.1 21:31:40 INFO - mozsystemmonitor == 0.0 21:31:40 INFO - moztest == 0.7 21:31:40 INFO - mozversion == 1.4 21:31:40 INFO - psutil == 3.1.1 21:31:40 INFO - requests == 1.2.3 21:31:40 INFO - wsgiref == 0.1.2 21:31:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:31:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a275490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a252228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86a04c4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a1999f0>, '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 0x109ef8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18c8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/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.ymLBa6SPIn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:31:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/Render', 21:31:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:31:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:31:40 INFO - 'HOME': '/Users/cltbld', 21:31:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:31:40 INFO - 'LOGNAME': 'cltbld', 21:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:40 INFO - 'MOZ_NO_REMOTE': '1', 21:31:40 INFO - 'NO_EM_RESTART': '1', 21:31:40 INFO - 'PAGER': '/bin/cat', 21:31:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:40 INFO - 'PWD': '/builds/slave/test', 21:31:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:31:40 INFO - 'SHELL': '/bin/bash', 21:31:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ymLBa6SPIn/Listeners', 21:31:40 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 21:31:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:31:40 INFO - 'USER': 'cltbld', 21:31:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:31:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:40 INFO - 'XPC_FLAGS': '0x0', 21:31:40 INFO - 'XPC_SERVICE_NAME': '0', 21:31:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:31:40 INFO - Cleaning up... 21:31:40 INFO - Return code: 0 21:31:40 INFO - Running post-action listener: _resource_record_post_action 21:31:40 INFO - Running post-action listener: _start_resource_monitoring 21:31:40 INFO - Starting resource monitoring. 21:31:40 INFO - ##### 21:31:40 INFO - ##### Running install step. 21:31:40 INFO - ##### 21:31:40 INFO - Running pre-action listener: _resource_record_pre_action 21:31:40 INFO - Running main action method: install 21:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:31:41 INFO - Reading from file tmpfile_stdout 21:31:41 INFO - Detecting whether we're running mozinstall >=1.0... 21:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:31:41 INFO - Reading from file tmpfile_stdout 21:31:41 INFO - Output received: 21:31:41 INFO - Usage: mozinstall [options] installer 21:31:41 INFO - Options: 21:31:41 INFO - -h, --help show this help message and exit 21:31:41 INFO - -d DEST, --destination=DEST 21:31:41 INFO - Directory to install application into. [default: 21:31:41 INFO - "/builds/slave/test"] 21:31:41 INFO - --app=APP Application being installed. [default: firefox] 21:31:41 INFO - mkdir: /builds/slave/test/build/application 21:31:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:32:12 INFO - Reading from file tmpfile_stdout 21:32:12 INFO - Output received: 21:32:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:32:12 INFO - Running post-action listener: _resource_record_post_action 21:32:12 INFO - ##### 21:32:12 INFO - ##### Running run-tests step. 21:32:12 INFO - ##### 21:32:12 INFO - Running pre-action listener: _resource_record_pre_action 21:32:12 INFO - Running main action method: run_tests 21:32:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:32:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:32:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:32:12 INFO - 2015-11-23 21:32:12.562 screenresolution[1652:8439] starting screenresolution argv=screenresolution get 21:32:12 INFO - 2015-11-23 21:32:12.564 screenresolution[1652:8439] Display 0: 1600x1200x32@60 21:32:12 INFO - 2015-11-23 21:32:12.570 screenresolution[1653:8442] starting screenresolution argv=screenresolution list 21:32:12 INFO - Available Modes on Display 0 21:32:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:32:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:32:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:32:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:32:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:32:12 INFO - Intel Iris: 21:32:12 INFO - Chipset Model: Intel Iris 21:32:12 INFO - Type: GPU 21:32:12 INFO - Bus: Built-In 21:32:12 INFO - VRAM (Dynamic, Max): 1536 MB 21:32:12 INFO - Vendor: Intel (0x8086) 21:32:12 INFO - Device ID: 0x0a2e 21:32:12 INFO - Revision ID: 0x0009 21:32:12 INFO - Displays: 21:32:12 INFO - Display: 21:32:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:32:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:32:12 INFO - Display Serial Number: 1600x1200 60 21:32:12 INFO - Main Display: Yes 21:32:12 INFO - Mirror: Off 21:32:12 INFO - Online: Yes 21:32:12 INFO - Rotation: Supported 21:32:12 INFO - Return code: 0 21:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:32:12 INFO - Python 2.7.3 21:32:12 INFO - Return code: 0 21:32:12 INFO - grabbing minidump binary from tooltool 21:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:32:12 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 0x10a1999f0>, '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 0x109ef8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18c8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:32:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:32:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 21:32:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:32:12 INFO - Return code: 0 21:32:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:32:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:32:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:32:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:32:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:32:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost'] in /builds/slave/test/build 21:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0008 --webServer localhost 21:32:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tz3BVx7zld/Render', 21:32:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:32:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:32:12 INFO - 'HOME': '/Users/cltbld', 21:32:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:32:12 INFO - 'LOGNAME': 'cltbld', 21:32:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:32:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:32:12 INFO - 'MOZ_NO_REMOTE': '1', 21:32:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:32:12 INFO - 'NO_EM_RESTART': '1', 21:32:12 INFO - 'PAGER': '/bin/cat', 21:32:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:32:12 INFO - 'PWD': '/builds/slave/test', 21:32:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:32:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:32:12 INFO - 'SHELL': '/bin/bash', 21:32:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ymLBa6SPIn/Listeners', 21:32:12 INFO - 'TMPDIR': '/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/', 21:32:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:32:12 INFO - 'USER': 'cltbld', 21:32:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:32:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:32:12 INFO - 'XPC_FLAGS': '0x0', 21:32:12 INFO - 'XPC_SERVICE_NAME': '0', 21:32:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:32:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0008', '--webServer', 'localhost'] with output_timeout 3600 21:32:13 INFO - mozversion INFO | application_buildid: 20151123203633 21:32:13 INFO - mozversion INFO | application_changeset: f6cccadd2eed5ef737f26006f58bcdec048d4e34 21:32:13 INFO - mozversion INFO | application_display_name: Nightly 21:32:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:32:13 INFO - mozversion INFO | application_name: Firefox 21:32:13 INFO - mozversion INFO | application_remotingname: firefox 21:32:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:32:13 INFO - mozversion INFO | application_vendor: Mozilla 21:32:13 INFO - mozversion INFO | application_version: 45.0a1 21:32:13 INFO - mozversion INFO | platform_buildid: 20151123203633 21:32:13 INFO - mozversion INFO | platform_changeset: f6cccadd2eed5ef737f26006f58bcdec048d4e34 21:32:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:32:13 INFO - mozversion INFO | platform_version: 45.0a1 21:32:13 INFO - 2015-11-23 21:32:13,146 DEBUG : using testdate: 1448343133 21:32:13 INFO - 2015-11-23 21:32:13,146 DEBUG : actual date: 1448343133 21:32:13 INFO - 2015-11-23 21:32:13,672 INFO : starting webserver on 'localhost:49273' 21:32:13 INFO - 2015-11-23 21:32:13,672 INFO : Starting test suite t-yosemite-r7-0008 21:32:13 INFO - 2015-11-23 21:32:13,673 INFO : Starting test dromaeo_css 21:32:13 INFO - 2015-11-23 21:32:13,673 DEBUG : operating with platform_type : mac_ 21:32:13 INFO - 2015-11-23 21:32:13,674 INFO : Initialising browser for dromaeo_css test... 21:32:13 INFO - 2015-11-23 21:32:13,686 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpWUVaNs/profile http://localhost:49273/getInfo.html 21:32:15 INFO - 2015-11-23 21:32:15,977 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:32:15 INFO - 2015-11-23 21:32:15,977 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:32:15 INFO - 2015-11-23 21:32:15,977 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:32:15 INFO - 2015-11-23 21:32:15,977 DEBUG : BROWSER_OUTPUT: __metrics 21:32:15 INFO - 2015-11-23 21:32:15,993 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:32:16 INFO - 2015-11-23 21:32:16,655 INFO : Browser initialized. 21:32:16 INFO - 2015-11-23 21:32:16,655 INFO : Running cycle 1/1 for dromaeo_css test... 21:32:16 INFO - 2015-11-23 21:32:16,656 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpWUVaNs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:32:28 INFO - 2015-11-23 21:32:28,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 228683776 21:32:28 INFO - 2015-11-23 21:32:28,491 DEBUG : BROWSER_OUTPUT: 21:33:19 INFO - 2015-11-23 21:33:19,877 DEBUG : BROWSER_OUTPUT: 1448343199870 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:35:30 INFO - 2015-11-23 21:35:30,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 21:35:32 INFO - 2015-11-23 21:35:32,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 424751104 21:35:32 INFO - 2015-11-23 21:35:32,412 DEBUG : BROWSER_OUTPUT: 21:38:35 INFO - 2015-11-23 21:38:35,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 21:38:35 INFO - 2015-11-23 21:38:35,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 366596096 21:38:35 INFO - 2015-11-23 21:38:35,712 DEBUG : BROWSER_OUTPUT: 21:41:37 INFO - 2015-11-23 21:41:37,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 21:41:38 INFO - 2015-11-23 21:41:38,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 331366400 21:41:38 INFO - 2015-11-23 21:41:38,384 DEBUG : BROWSER_OUTPUT: 21:44:40 INFO - 2015-11-23 21:44:40,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 21:44:40 INFO - 2015-11-23 21:44:40,999 DEBUG : BROWSER_OUTPUT: RSS: Main: 320159744 21:44:40 INFO - 2015-11-23 21:44:40,999 DEBUG : BROWSER_OUTPUT: 21:47:44 INFO - 2015-11-23 21:47:44,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 21:47:44 INFO - 2015-11-23 21:47:44,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 322351104 21:47:44 INFO - 2015-11-23 21:47:44,785 DEBUG : BROWSER_OUTPUT: 21:50:47 INFO - 2015-11-23 21:50:47,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 21:50:47 INFO - 2015-11-23 21:50:47,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 413986816 21:50:47 INFO - 2015-11-23 21:50:47,881 DEBUG : BROWSER_OUTPUT: 21:50:47 INFO - 2015-11-23 21:50:47,881 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:50:47 INFO - 2015-11-23 21:50:47,881 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:50:47 INFO - 2015-11-23 21:50:47,881 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:50:47 INFO - 2015-11-23 21:50:47,881 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:50:47 INFO - 2015-11-23 21:50:47,881 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3386.9153271168216;3459.827008649567;3467.878624248152;3499.3351263259997;3533.3463309287786;5621.550275977922;5678.432156784324;5722.399148089453;5737.942620573793;5755.39568345324;5671.971640141804;5705.25831641887;5714.285714285715;5721.942780572193;5731.770729170838;5111.923321150176;5113.795448182087;5133.383993920735;5166.974165129188;5230.816921407752;5167.715775632339;5212.061828870802;5217.37391513019;5223.895522089556;5238.214267859814;5061.139606266925;5214.634975551713;5214.947850521484;5221.399539053001;5245.134552798783;5137.255098010804;5198.090334191501;5202.167653175474;5250.842474725745;5264.921026184629;5176.275321454999;5200;5221.164613661796;5222.712750798704;5278.1291086970605;5400.810971615974;5471;5645.604807663465;5646.435356464362;5770.6249093808765;5778.3643799182055;6103.389661033905;6220.1913751212505;6234.657093859836;6318.083877837687;6313.842153946142;6320.905186422207;6339.809805705836;6343.397377249154;6346.904796428057;5852.356240813507;5854.121881717776;5854.297484301911;5857.531397488234;5857.677827719516;6143.972489078594;6237.500999919996;6283.96858015707;6296.212973378328;6305.243370795534;5035.345405097314;6157.138000679908;6159.753609855556;6167.321594624587;6172.382761723881;6288.748450061947;6298.212723409574;6301.117843501914;6310.400511951358;6314.778982735582;5952.494038006731;6045.941960156955;6102.176206212104;6115.510759139347;6205.875882482415;5189.844304670866;6146.815595532052;6182;6203.348648391854;6207.937920620736;4954.133026720309;4959.7272150032095;4972.5027497249985;4980.103581355391;4996.90006199874;4439.200943830077;4441.511433742286;4441.911161776747;4475.7985890635;4499.415076040159;5586.022446071921;5639.887202256014;5678.006348888928;5683.431656834284;5714.342850572154;6304.684765761694;6346.650934198571;6346.777862774781;6357.936420635734;6364.045393191059;5697.601167918206;5712.800051998243;5720.914186287209;5721.971390143022;5770.221020162308;5267.525922666979;5366.195070739421;5375.892482150335;5376.059189641797;5416.647917885325;5338.97330513345;6275.6548389839;6290.654014029181;6327.145835312266;6360.840978975562;6132.244930544546;6147.631142131487;6191.9690401547705;6193.969030154821;6247.468965138014;5493.697846618475;6184.134221209124;6292.4651404629285;6332.683365831782;6340.841478963062;6123.29128149534;6180.258368995749;6183.598066125687;6185.474234689922;6190.071489276645;6095.994160963392;6184.907226391518;6184.907226391698;6194.101855231056;6283.842903927439;6027.758889644365;6053.545984051302;6061.848453788691;6065.423784740443;6078.848028799315;5913.852153696192;5980.34216236205;5997.220361352996;6017.608855424383;6019.337872833898;5166.734150133241;5741.25363702716;5790.710464476843;5901.1443340714495;5910.645361278337;6061.575689701855;6122.571420000557;6125.816225513242;6138.907916381168;6139.676133582418;5753.108268218432;5966.820995370146;5967.7911273106965;5969.703307538278;5977.462028417463 21:50:47 INFO - 2015-11-23 21:50:47,885 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.8681959739461;562.1848319936091;578.9750705775397;584.6550535184241;619.1641284266241;27450.725492745067;32702.67297327029;41406.96482587933;41891.22978931895;41903.58096419043;44035;44160.33759493602;44320;44449.77775111128;44458.555414445924;8711.08533603972;8985.966613839395;9772.70681879543;9977.501124943723;9990.650327238549;8781.868271975925;8889.511076890769;8890.777730556723;12059.758804823898;12209.023278137727;11886.7622647547;11964.34196119213;11971.341576213348;11986.400679966011;11993.640190794247;11861.881381186207;11967.2819630822;11975.820362694567;11979.94010029953;12053.758924821543;8860.512671803048;8937.910620893774;8945.105489451003;8952.060033696433;8961.372703910729;43181.35227971583;44015.339769903476;44039;44039;44091.338629920574;3062.448759223339;3086.922826929322;3095.1024202981334;3159.8104113753247;3202.711755941976;28801;29249.561256581168;29775.70224297751;29908.102756917327;30104.548431773543;2723.1149876290283;2813.563897595876;2870.2537340291674;2988.5367767995995;2995.8352290624007;412584;418326;440637;490122;640514;58803;59092.1136182949;59153.704231478565;59271.70364148238;59435.40564594385;61899.69050154721;62623;62809;62817.37182628115;62916.685416572625;13766.692164244381;15904.284307206204;16264.349426023064;16304.940178888335;16475.83524164743;12498.500059997497;12498.50005999768;12508.81236781449;12511.3744312784;12512.249265044127;21269.255576054762;21337.89331053335;21436;21498.24756133528;21501.03245353963;8715.172058654418;8900.643974241088;8901.287896968228;8920.152585504367;8976.102389761103;957.8946315905245;977.628501169551;988.8813342398959;1032.9070383665505;1107.2692023264606;29900.85049574738;30481.479281740576;30587;30616.693833061385;30666;1131.7510147767478;1163.9698866503036;1171.976560468786;1192.821076838481;1224.6895821471119;14438.566842994727;15329.31018104188;15418.614534636723;15637.609059773597;15683.1374274416;513164;520517;521504;522477;522497;60153.39846601566;60724;60736.69631651814;60832;60891;1434.8923830712738;1442.3797766960308;1450.050217107796;1453.6438572549582;1590.2764242269739;29811.850940745157;30022.399552009276;30562.694373056875;30597.694023059485;30753.846230768704;52109.21836172536;52468;52470;52561.7371913138;52651.73674131605;534632;543209;543349;636283;636410;24192.395190120387;30240.09279721612;30426.239344016576;30428.39143217079;30432.695673043872;42200.78899605482;42593.78703106465;42620.360694588984;43925.12149757051;44857.327140092275;29268.56097158502;37580.81209593934;37630.43554346632;38456.615433845305;38716.80641596774;37089.44365834461;37722.36308822574;38076.809615951744;38878.222435551696;39761.80119099386;36871.07822304464;37604;37830.62169378271;38035.42946855855;38112;28052.579211312255;31733;33772.32455350929;33821.49267760936;33983;24420.633690494302;25087.623685644365;25117.87441062856;25183.048041125207;25499.490010199323 21:50:47 INFO - 2015-11-23 21:50:47,886 DEBUG : BROWSER_OUTPUT: |2;jquery.html;361.47225051424937;362.78051778673904;364.7865998390941;368.02840501077145;368.28001257541507;15976.12131332779;16011.95922265052;18243.543911402223;20371.796282037176;21215.257465988714;15089.849101508982;17533.3863314784;20143.29498467554;20160;20210.595788084265;6472.126262954488;6533.967330163343;6559.409653131217;6565.704543295539;6574.835629109287;4650.186217411956;4787.880302992436;4794.2329227323635;6530.510211734115;7330.596817175053;5550.4449555044575;7526;7534.246575342449;7543.924560754404;7547.283008114247;5702.600817942745;5727.312722473288;5729.997250481191;5741.253637027202;5747.540196784247;5370.865728356784;5632.887342253132;5638.097904335286;5641.661500309994;5642.802501912413;12427.13010089294;12468.75062498754;12657.873421265762;12859.935700321439;12882.677933051655;1957.1584218785915;2112.091800525773;2125.107454868959;2185.2351676912954;2252.8873556322283;9798.559064842098;10168.13570846479;10169.796604067877;11655.950964413243;13959.581212563638;1695.542203605032;1719.1404297851075;1745.2059313012549;1782.3316256403848;1822.6263615958696;94772;103174;103222;104429.99999999924;104649;8874.600642971081;9485.098915603006;10673.039426451656;10828.675139745821;11171.329720216812;13253.602391928258;13267.601971940858;13284.335783210994;13291;13324.267165306;8174.3051840593025;8183.95908020456;8231.259186673109;8284.005919289602;8291.170882911661;8216.21945915137;8273.8345233095;8308.169183081643;8339.916600833914;8345.082040975487;4006.6193711597352;4367.170237654899;4384.8903777405185;4388.05656783793;4420.58004489573;1740.1995082262301;1776.3427531813054;1795.0845069014897;1815.1650240889076;1817.881837680573;389.2351529245047;812.4191203289677;888.0143041224236;922.8846394200725;1012.6810054832704;8607.908565948113;11253.324800511995;11271.718207044889;11303.886961130447;11405.97346238826;414.75114931041736;427.12865753861774;434.4873049801265;436.1843352930041;441.50110375275733;5925.4370834770625;6050.122732203894;6070.3019152798;6089.42150495711;6104.359042300494;731771;763640;766751;777895;797025;120053.39973300077;121670;122826;123738;125794;474.1205064605108;477.6799544305254;478.9281607758864;479.08255690352587;480.58909632264607;8487.618057187317;11111.333320000502;11117.833232501358;11127;11133.276337038067;51601;51672.48327516827;51926.74036629793;52958.73520632372;53322;74789.51262924242;75817.803727104;76277.23722762702;77414.2258577407;77543.44913101819;9619.663311784054;9668.274879383933;9958.55186516594;9968.202543796624;10061.195104391485;11913.404329783303;11966.521339146337;12014.279143251433;12706;19811.603767924847;15417.460388886335;15616.687666246384;15766.527004189893;15894.68210635804;16033.118178499828;14969.925150374178;15232.543023709306;15473.5357939262;15636.609084772972;15798.60503487422;12595.93702031484;15278.541643750705;16285.100612683273;16454.012759234483;16552.917235413744;9789.559469824018;9822.607095716377;10001.199904007808;10020.899791002288;10069.093781559695;10378;15195.848041519885;15302.699270561681;15959.521214363587;16679.166041697623 21:50:47 INFO - 2015-11-23 21:50:47,887 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1549.6048507630553;1562.8749700024;1568.9529314120573;1903.7144428335744;1945.5038965063907;7154.141503019639;7607.809804754877;8061.717839875613;8126.674933002688;8145.674173033086;8202.261796438319;8314.459560128602;8345.874811877811;8353.37349698772;8357.498550086999;2350.2831636350907;2367.562001029806;2372.50177462733;2372.6559648850994;2376.2039716694926;2388.2715771689627;2399.9760002400017;2417.2989832948424;2422.539717453687;2426.2478631624163;2346.4133966508375;2361.2798096580536;2367.2898130560848;2385.3917251100943;2387.486690361572;2334.101370972171;2358.351453350334;2366.7751563601432;2369.526094781042;2382.106709983756;2357.5284943011466;2383.642453631952;2392.222527678494;2397.2328854766306;2401.375642333006;7628.275313845176;8393.370497212734;8440.535770532619;8444.366672499587;8447.366447516399;4805.8558243252755;4902.313676085351;5003.899922001576;5132.307138536287;5159.638825282232;3506.9649303506894;3562.109472631842;3616.5117709109195;3650.8174591270595;3660.4875317455576;1042.1298215989657;1061.2253055269618;1066.3655125200494;1068.0921216965594;1078.7626722121122;11080.224384293102;11138.94430527842;11166.497507612177;11173.273737207055;11182.496787644575;4693.953060469352;4698.718076915396;4745.454272758677;4753.073150735573;4771.165046116916;9841.55712992917;9871.062249086326;9879.209663226924;9907.356021858555;9914.454704991294;5216.191490319006;5223.634345595848;5227.921581176285;5234.555062819627;5269.657472264291;4739.194336962724;4740.620750339965;4744.4069491313585;4744.644151688637;4751.64362672801;3650.543682039745;3725.0501122213664;3728.496652951871;3737.439384092408;3767.962320376816;1211.4306276050243;1220.1519943639264;1232.5008371609513;1233.1676118619896;1236.8824961628811;1384.6192297118373;1405.7891316302637;1424.4658253155067;1426.9143851368951;1427.2506933859806;7971.960140199262;8091.271785539329;8099.878501822477;8142.552159631277;8144.4298899077685;1124.606387764276;1152.8386025956372;1216.8174773783826;1219.432963671897;1235.209465941798;6010.248718910137;6146.508279337642;6247.9062814057825;6247.96876015617;6273.65494897785;9621.470819104876;10162.593496260215;10309.381437113798;10326.277160598685;10375.118114960162;9968.252381071448;10031.899681003097;10086.949565252127;10249.282550221562;10298.588056477656;7877.133515313311;7938.0077490313715;7955.5226686399;8027.518348899085;8040.396970227256;7823.178566250462;7941.563214023284;7942;7956;7959.681612735426;7693.769186924401;8842.115788421106;8996.55017249148;9071.002189758989;9121.087891210826;9266.21237194846;9431.905680943377;9464.810703785748;9465.716028519155;9482.38364506305;6911.965440172767;6914.170299564084;6977.7208911642965;6997.05539752127;7008.404285635778;8022.478538895187;8068.556229407204;8085.353171746364;8094.635741391769;8126.878096828434;7409.777706668809;7509.324160825552;7510.39916806665;7649.541027538366;7660.34887034586;6645.568038077509;7233.710651574089;7346.926530734624;7427.814304642211;7489.251074892467;7463.701451941862;7507.174210836694;7524.473286869867;7563.886541701769;7569.394448444001;6784.457243420416;6834.760783372558;6855.931440685529;6871.381575658214;6884.90010546788;6882.139732533434;6920.273371295942;6942.340477654615;6944.097267355211;6945.791626251221 21:50:47 INFO - 2015-11-23 21:50:47,891 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.39759060195024;321.84873109638477;324.2574504384959;327.6854219948849;330.336024590573;6796.796096117118;6863.519553631248;6925.168979722428;6926.6536673166265;6958.652067396635;6485.124508191393;6581.473482121431;6663.133792606966;6699.162604674416;6832.248452670215;4927.634735327045;4947.703137811724;5004.824831130911;5013.473585273548;5013.749312534377;4990.4261009983775;4997.575206107485;5013.197888337867;5019.949800501985;5025.396952365703;4701.43582770068;4803.423589169304;4807.389524509276;4817.590504807095;4958.330625365584;4897.730624815634;4923.679960802554;4937.012597480482;4940;4968.503149685021;4240.363945408182;4243.151369726067;4246.936295955563;4250.744955302661;4259.744415335059;6381.649009304487;6528.694261147742;6549.607023578553;6557.114789503404;6565.015247712881;4553.9981204135365;6009;6012.158297838306;6030.306514750772;6035.939640603626;7019.82450438738;7296.635168241567;7297.160826504967;7306.2693730626515;7353.411727061823;4817.686850354751;4828.203346447832;4833.4441539222735;4833.661643684944;4834.226523756182;6121.84695382619;7486.962565187194;7797.57113358765;7816.140224575292;7832.020997375385;4745.335653008581;4772.665913386029;4779.761011949388;4780.450248221429;4780.880477988078;4839.588634966068;4857.854264372075;4866.4403593586485;4867.9269810952155;4868.123737727243;5681.488666020078;5914.172015917775;5921.61509501881;5922.851928701817;5924.20023296858;7423.740169094056;7424.294692004251;7424.777256682308;7424.925750742424;7430.034095567542;1669.6660667866474;1688.5694147992183;1692.7037768390483;1692.8222536633723;1693.3734518228334;1038.631285893512;1063.994680026595;1065.9626913058005;1068.893110688925;1078.563181911327;6770.187577490634;6801.625910574966;6803.48973826965;6811.4550835933005;6817.659117044227;7392.112946446461;7627.8855817162785;7635.732749353857;7643.273888980538;7658.846823063507;6329.3354197809485;6676.998450232407;6681.599104053676;6708.832279192961;6709.094272273278;4078.408630748525;4111.588841115924;4119.423280740699;4119.752814831059;4121.052158003676;8016.078151012592;8027.237412445808;8031.55826429552;8040.597970101471;8043.316318113026;7753.302202801775;8033.758987230392;8055.113937466874;8060.596970151469;8074.677012919535;8040.517568945882;8043.39674524413;8048.275655191061;8050.07424146219;8052.436329456999;7436.256374362737;7737.535747854921;7747.883781743391;7761.3790896727;7769.53382797034;6181.84545386369;7606.467547271859;7608.201138880338;7624.504407213513;7625.351845093229;8001.319887809602;8006.239407256301;8024.638891249791;8031.036275646959;8041.356691464552;4556.2937744649635;4693.530646935279;4701.835435759732;4747.454042785124;4759.881002974815;6157.353477884758;7497.212792656693;7498.475106742694;7505.399568034435;7523.661435235318;5931.347551769216;7306.744263950736;7319.268073192638;7321.414286857145;7334.779956601311;6110;7095.716171353088;7201.639918003974;7315;7377.151627562685;6208.379162083756;6750.0212469192675;7127.7148914042855;7151.535150215427;7158;7093.467989900675;7144.3570078693165;7267.527610705287;7276.235995220637;7325.047743793273;6294.370562943669;7238.6018768968215;7248.0939882514685;7254.854902901807;7260.382867456114 21:50:47 INFO - 2015-11-23 21:50:47,892 DEBUG : BROWSER_OUTPUT: |5;yui.html;642.0689999500726;681.6114814555705;704.1128178495095;724.9311315425035;747.9065116860394;15082.773758393632;15582.636861678733;15617.531474055797;15620.375184992616;15624.2969066392;14100.224487653175;14194.148351098942;14276.500322488715;14317.355718992645;15830.84169158308;943.0239701908527;955.1308309438413;958.089814676057;958.865758793766;959.8416261316875;956.4548207521715;960.3901522533207;961.1589858873485;961.1877963121151;963.2823546457898;998.9500524973759;1002.9749256268578;1004.8643433136542;1006.9144122749575;1007.3653598233103;995.8107959487746;995.8506224066412;997.2470784557648;997.4962643864874;1002.2332915319786;750.0811505905277;751.1587022534796;751.5640928261595;751.6880494594736;752.9872321727267;14699;14722.926385368111;14885.925570372186;14922.62693432662;14939.775903361458;10794.460276986198;12388.62834114969;12773.616791496177;12805.359732013456;12993.87006129936;10242.23183261251;10349;10475.58097676092;10688.572457101707;10716.946415267952;3544.1848374873666;3621.2395396966667;3625.311190873752;3681.116532032293;3723.5345581802276;62753.37246627521;63703.6814815923;65095;72802.27197728008;81765.36469270581;9513.619455221713;9614.326997110134;9626.855597166048;9754;9891.554880030415;21556.13775448996;21698.566028679652;21713.56572868534;21765.12939482403;21771.782282177293;6766.76316328936;6847.691853866588;7272.490925635155;7353.77938661841;7607.961960190274;3278.7049165575213;3750.137468382233;3879.941800872989;3930.037140900498;4069.654079403225;3456.0668619473104;3494.2312691207894;3495.965040349615;3497.0732755819727;3500.0199944015717;627.1001113402282;640.8846407646575;646.0664340028613;648.5946283572767;654.1071437487794;496.84846121932435;506.85554616933996;517.361059092021;521.9478052194826;548.14763043467;8063.637136328879;8454.577271136419;8455.196756308142;8592.355573332025;8671;522.1384715219841;568.5792513539951;579.8840231953626;601.4586871815401;630.3066626710581;3907.5115610548683;4196.328587425997;4409.977950110293;4430.224710675683;4508.436445444319;96563.51718241505;97651;98503;98606.50696746471;100010;83666.16333836583;83862.58068709739;84121;84921.57539212388;85860.14139858646;63876;71790;73041.8870679058;77355.22644773593;79067.99999999885;8655.17775811297;8906.421082629608;9111.498867562348;9173.633054677739;9238.676646317346;41499.75500734983;52608.47391526036;52880.47119528755;55169.724151378985;55599.72200138973;75290;75669.62165189139;76190.47619047477;78657;78836;9634.662786802428;10669.46652667348;10879.423354917806;11115.333080015225;11695.76608467843;12098.93950530277;12161.635150945485;12166.026717862727;12332.691682708004;12398.504059837505;11873.16887817879;11898.940505297418;11899.881001190224;11924.880751192377;11982.940085299517;11693.941530292634;11707.121965852766;11743.236689615147;11746.70633234176;11761.764764704487;11260;11738.41307934617;11768.470418831344;11935.820962685393;12068.456919438822;9732.902670973483;9903.207743380657;10000.899991000288;10076.244281678757;10451.634192803216;9888.570360214384;10200.464338318016;10205;10213.182945364204;10261.794764104825 21:50:47 INFO - 2015-11-23 21:50:47,892 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:50:47 INFO - 2015-11-23 21:50:47,892 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:50:47 INFO - 2015-11-23 21:50:47,892 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1765 21:50:47 INFO - 2015-11-23 21:50:47,892 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:50:47 INFO - 2015-11-23 21:50:47,892 DEBUG : BROWSER_OUTPUT: __startTimestamp1448344247878__endTimestamp 21:50:47 INFO - 2015-11-23 21:50:47,893 DEBUG : BROWSER_OUTPUT: 21:50:47 INFO - 2015-11-23 21:50:47,893 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:50:47 INFO - 2015-11-23 21:50:47,893 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:50:47 INFO - 2015-11-23 21:50:47,893 DEBUG : BROWSER_OUTPUT: 21:50:47 INFO - 2015-11-23 21:50:47,893 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5710.32 Median:5857.53 stddev:622.39 (10.6%) stddev-sans-first:597.01 21:50:47 INFO - 2015-11-23 21:50:47,894 DEBUG : BROWSER_OUTPUT: Values: 3386.9 3459.8 3467.9 3499.3 3533.3 5621.6 5678.4 5722.4 5737.9 5755.4 5672.0 5705.3 5714.3 5721.9 5731.8 5111.9 5113.8 5133.4 5167.0 5230.8 5167.7 5212.1 5217.4 5223.9 5238.2 5061.1 5214.6 5214.9 5221.4 5245.1 5137.3 5198.1 5202.2 5250.8 5264.9 5176.3 5200.0 5221.2 5222.7 5278.1 5400.8 5471.0 5645.6 5646.4 5770.6 5778.4 6103.4 6220.2 6234.7 6318.1 6313.8 6320.9 6339.8 6343.4 6346.9 5852.4 5854.1 5854.3 5857.5 5857.7 6144.0 6237.5 6284.0 6296.2 6305.2 5035.3 6157.1 6159.8 6167.3 6172.4 6288.7 6298.2 6301.1 6310.4 6314.8 5952.5 6045.9 6102.2 6115.5 6205.9 5189.8 6146.8 6182.0 6203.3 6207.9 4954.1 4959.7 4972.5 4980.1 4996.9 4439.2 4441.5 4441.9 4475.8 4499.4 5586.0 5639.9 5678.0 5683.4 5714.3 6304.7 6346.7 6346.8 6357.9 6364.0 5697.6 5712.8 5720.9 5722.0 5770.2 5267.5 5366.2 5375.9 5376.1 5416.6 5339.0 6275.7 6290.7 6327.1 6360.8 6132.2 6147.6 6192.0 6194.0 6247.5 5493.7 6184.1 6292.5 6332.7 6340.8 6123.3 6180.3 6183.6 6185.5 6190.1 6096.0 6184.9 6184.9 6194.1 6283.8 6027.8 6053.5 6061.8 6065.4 6078.8 5913.9 5980.3 5997.2 6017.6 6019.3 5166.7 5741.3 5790.7 5901.1 5910.6 6061.6 6122.6 6125.8 6138.9 6139.7 5753.1 5966.8 5967.8 5969.7 5977.5 21:50:47 INFO - 2015-11-23 21:50:47,894 DEBUG : BROWSER_OUTPUT: 21:50:47 INFO - 2015-11-23 21:50:47,894 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66899.18 Median:37617.22 stddev:141496.02 (376.1%) stddev-sans-first:141805.29 21:50:47 INFO - 2015-11-23 21:50:47,896 DEBUG : BROWSER_OUTPUT: Values: 560.9 562.2 579.0 584.7 619.2 27450.7 32702.7 41407.0 41891.2 41903.6 44035.0 44160.3 44320.0 44449.8 44458.6 8711.1 8986.0 9772.7 9977.5 9990.7 8781.9 8889.5 8890.8 12059.8 12209.0 11886.8 11964.3 11971.3 11986.4 11993.6 11861.9 11967.3 11975.8 11979.9 12053.8 8860.5 8937.9 8945.1 8952.1 8961.4 43181.4 44015.3 44039.0 44039.0 44091.3 3062.4 3086.9 3095.1 3159.8 3202.7 28801.0 29249.6 29775.7 29908.1 30104.5 2723.1 2813.6 2870.3 2988.5 2995.8 412584.0 418326.0 440637.0 490122.0 640514.0 58803.0 59092.1 59153.7 59271.7 59435.4 61899.7 62623.0 62809.0 62817.4 62916.7 13766.7 15904.3 16264.3 16304.9 16475.8 12498.5 12498.5 12508.8 12511.4 12512.2 21269.3 21337.9 21436.0 21498.2 21501.0 8715.2 8900.6 8901.3 8920.2 8976.1 957.9 977.6 988.9 1032.9 1107.3 29900.9 30481.5 30587.0 30616.7 30666.0 1131.8 1164.0 1172.0 1192.8 1224.7 14438.6 15329.3 15418.6 15637.6 15683.1 513164.0 520517.0 521504.0 522477.0 522497.0 60153.4 60724.0 60736.7 60832.0 60891.0 1434.9 1442.4 1450.1 1453.6 1590.3 29811.9 30022.4 30562.7 30597.7 30753.8 52109.2 52468.0 52470.0 52561.7 52651.7 534632.0 543209.0 543349.0 636283.0 636410.0 24192.4 30240.1 30426.2 30428.4 30432.7 42200.8 42593.8 42620.4 43925.1 44857.3 29268.6 37580.8 37630.4 38456.6 38716.8 37089.4 37722.4 38076.8 38878.2 39761.8 36871.1 37604.0 37830.6 38035.4 38112.0 28052.6 31733.0 33772.3 33821.5 33983.0 24420.6 25087.6 25117.9 25183.0 25499.5 21:50:47 INFO - 2015-11-23 21:50:47,896 DEBUG : BROWSER_OUTPUT: 21:50:47 INFO - 2015-11-23 21:50:47,896 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38517.73 Median:363.78 stddev:126544.44 (34785.6%) stddev-sans-first:126867.00 21:50:47 INFO - 2015-11-23 21:50:47,897 DEBUG : BROWSER_OUTPUT: Values: 361.5 362.8 364.8 368.0 368.3 15976.1 16012.0 18243.5 20371.8 21215.3 15089.8 17533.4 20143.3 20160.0 20210.6 6472.1 6534.0 6559.4 6565.7 6574.8 4650.2 4787.9 4794.2 6530.5 7330.6 5550.4 7526.0 7534.2 7543.9 7547.3 5702.6 5727.3 5730.0 5741.3 5747.5 5370.9 5632.9 5638.1 5641.7 5642.8 12427.1 12468.8 12657.9 12859.9 12882.7 1957.2 2112.1 2125.1 2185.2 2252.9 9798.6 10168.1 10169.8 11656.0 13959.6 1695.5 1719.1 1745.2 1782.3 1822.6 94772.0 103174.0 103222.0 104430.0 104649.0 8874.6 9485.1 10673.0 10828.7 11171.3 13253.6 13267.6 13284.3 13291.0 13324.3 8174.3 8184.0 8231.3 8284.0 8291.2 8216.2 8273.8 8308.2 8339.9 8345.1 4006.6 4367.2 4384.9 4388.1 4420.6 1740.2 1776.3 1795.1 1815.2 1817.9 389.2 812.4 888.0 922.9 1012.7 8607.9 11253.3 11271.7 11303.9 11406.0 414.8 427.1 434.5 436.2 441.5 5925.4 6050.1 6070.3 6089.4 6104.4 731771.0 763640.0 766751.0 777895.0 797025.0 120053.4 121670.0 122826.0 123738.0 125794.0 474.1 477.7 478.9 479.1 480.6 8487.6 11111.3 11117.8 11127.0 11133.3 51601.0 51672.5 51926.7 52958.7 53322.0 74789.5 75817.8 76277.2 77414.2 77543.4 9619.7 9668.3 9958.6 9968.2 10061.2 11913.4 11966.5 12014.3 12706.0 19811.6 15417.5 15616.7 15766.5 15894.7 16033.1 14969.9 15232.5 15473.5 15636.6 15798.6 12595.9 15278.5 16285.1 16454.0 16552.9 9789.6 9822.6 10001.2 10020.9 10069.1 10378.0 15195.8 15302.7 15959.5 16679.2 21:50:47 INFO - 2015-11-23 21:50:47,897 DEBUG : BROWSER_OUTPUT: 21:50:47 INFO - 2015-11-23 21:50:47,898 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5852.86 Median:5231.24 stddev:3013.46 (57.6%) stddev-sans-first:3004.55 21:50:47 INFO - 2015-11-23 21:50:47,898 DEBUG : BROWSER_OUTPUT: Values: 1549.6 1562.9 1569.0 1903.7 1945.5 7154.1 7607.8 8061.7 8126.7 8145.7 8202.3 8314.5 8345.9 8353.4 8357.5 2350.3 2367.6 2372.5 2372.7 2376.2 2388.3 2400.0 2417.3 2422.5 2426.2 2346.4 2361.3 2367.3 2385.4 2387.5 2334.1 2358.4 2366.8 2369.5 2382.1 2357.5 2383.6 2392.2 2397.2 2401.4 7628.3 8393.4 8440.5 8444.4 8447.4 4805.9 4902.3 5003.9 5132.3 5159.6 3507.0 3562.1 3616.5 3650.8 3660.5 1042.1 1061.2 1066.4 1068.1 1078.8 11080.2 11138.9 11166.5 11173.3 11182.5 4694.0 4698.7 4745.5 4753.1 4771.2 9841.6 9871.1 9879.2 9907.4 9914.5 5216.2 5223.6 5227.9 5234.6 5269.7 4739.2 4740.6 4744.4 4744.6 4751.6 3650.5 3725.1 3728.5 3737.4 3768.0 1211.4 1220.2 1232.5 1233.2 1236.9 1384.6 1405.8 1424.5 1426.9 1427.3 7972.0 8091.3 8099.9 8142.6 8144.4 1124.6 1152.8 1216.8 1219.4 1235.2 6010.2 6146.5 6247.9 6248.0 6273.7 9621.5 10162.6 10309.4 10326.3 10375.1 9968.3 10031.9 10086.9 10249.3 10298.6 7877.1 7938.0 7955.5 8027.5 8040.4 7823.2 7941.6 7942.0 7956.0 7959.7 7693.8 8842.1 8996.6 9071.0 9121.1 9266.2 9431.9 9464.8 9465.7 9482.4 6912.0 6914.2 6977.7 6997.1 7008.4 8022.5 8068.6 8085.4 8094.6 8126.9 7409.8 7509.3 7510.4 7649.5 7660.3 6645.6 7233.7 7346.9 7427.8 7489.3 7463.7 7507.2 7524.5 7563.9 7569.4 6784.5 6834.8 6855.9 6871.4 6884.9 6882.1 6920.3 6942.3 6944.1 6945.8 21:50:47 INFO - 2015-11-23 21:50:47,898 DEBUG : BROWSER_OUTPUT: 21:50:47 INFO - 2015-11-23 21:50:47,898 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5963.05 Median:6670.07 stddev:1929.99 (28.9%) stddev-sans-first:1888.28 21:50:47 INFO - 2015-11-23 21:50:47,899 DEBUG : BROWSER_OUTPUT: Values: 315.4 321.8 324.3 327.7 330.3 6796.8 6863.5 6925.2 6926.7 6958.7 6485.1 6581.5 6663.1 6699.2 6832.2 4927.6 4947.7 5004.8 5013.5 5013.7 4990.4 4997.6 5013.2 5019.9 5025.4 4701.4 4803.4 4807.4 4817.6 4958.3 4897.7 4923.7 4937.0 4940.0 4968.5 4240.4 4243.2 4246.9 4250.7 4259.7 6381.6 6528.7 6549.6 6557.1 6565.0 4554.0 6009.0 6012.2 6030.3 6035.9 7019.8 7296.6 7297.2 7306.3 7353.4 4817.7 4828.2 4833.4 4833.7 4834.2 6121.8 7487.0 7797.6 7816.1 7832.0 4745.3 4772.7 4779.8 4780.5 4780.9 4839.6 4857.9 4866.4 4867.9 4868.1 5681.5 5914.2 5921.6 5922.9 5924.2 7423.7 7424.3 7424.8 7424.9 7430.0 1669.7 1688.6 1692.7 1692.8 1693.4 1038.6 1064.0 1066.0 1068.9 1078.6 6770.2 6801.6 6803.5 6811.5 6817.7 7392.1 7627.9 7635.7 7643.3 7658.8 6329.3 6677.0 6681.6 6708.8 6709.1 4078.4 4111.6 4119.4 4119.8 4121.1 8016.1 8027.2 8031.6 8040.6 8043.3 7753.3 8033.8 8055.1 8060.6 8074.7 8040.5 8043.4 8048.3 8050.1 8052.4 7436.3 7737.5 7747.9 7761.4 7769.5 6181.8 7606.5 7608.2 7624.5 7625.4 8001.3 8006.2 8024.6 8031.0 8041.4 4556.3 4693.5 4701.8 4747.5 4759.9 6157.4 7497.2 7498.5 7505.4 7523.7 5931.3 7306.7 7319.3 7321.4 7334.8 6110.0 7095.7 7201.6 7315.0 7377.2 6208.4 6750.0 7127.7 7151.5 7158.0 7093.5 7144.4 7267.5 7276.2 7325.0 6294.4 7238.6 7248.1 7254.9 7260.4 21:50:47 INFO - 2015-11-23 21:50:47,899 DEBUG : BROWSER_OUTPUT: 21:50:47 INFO - 2015-11-23 21:50:47,899 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18837.69 Median:519.65 stddev:26682.47 (5134.7%) stddev-sans-first:26722.34 21:50:47 INFO - 2015-11-23 21:50:47,900 DEBUG : BROWSER_OUTPUT: Values: 642.1 681.6 704.1 724.9 747.9 15082.8 15582.6 15617.5 15620.4 15624.3 14100.2 14194.1 14276.5 14317.4 15830.8 943.0 955.1 958.1 958.9 959.8 956.5 960.4 961.2 961.2 963.3 999.0 1003.0 1004.9 1006.9 1007.4 995.8 995.9 997.2 997.5 1002.2 750.1 751.2 751.6 751.7 753.0 14699.0 14722.9 14885.9 14922.6 14939.8 10794.5 12388.6 12773.6 12805.4 12993.9 10242.2 10349.0 10475.6 10688.6 10716.9 3544.2 3621.2 3625.3 3681.1 3723.5 62753.4 63703.7 65095.0 72802.3 81765.4 9513.6 9614.3 9626.9 9754.0 9891.6 21556.1 21698.6 21713.6 21765.1 21771.8 6766.8 6847.7 7272.5 7353.8 7608.0 3278.7 3750.1 3879.9 3930.0 4069.7 3456.1 3494.2 3496.0 3497.1 3500.0 627.1 640.9 646.1 648.6 654.1 496.8 506.9 517.4 521.9 548.1 8063.6 8454.6 8455.2 8592.4 8671.0 522.1 568.6 579.9 601.5 630.3 3907.5 4196.3 4410.0 4430.2 4508.4 96563.5 97651.0 98503.0 98606.5 100010.0 83666.2 83862.6 84121.0 84921.6 85860.1 63876.0 71790.0 73041.9 77355.2 79068.0 8655.2 8906.4 9111.5 9173.6 9238.7 41499.8 52608.5 52880.5 55169.7 55599.7 75290.0 75669.6 76190.5 78657.0 78836.0 9634.7 10669.5 10879.4 11115.3 11695.8 12098.9 12161.6 12166.0 12332.7 12398.5 11873.2 11898.9 11899.9 11924.9 11982.9 11693.9 11707.1 11743.2 11746.7 11761.8 11260.0 11738.4 11768.5 11935.8 12068.5 9732.9 9903.2 10000.9 10076.2 10451.6 9888.6 10200.5 10205.0 10213.2 10261.8 21:50:47 INFO - 2015-11-23 21:50:47,900 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:50:47 INFO - 2015-11-23 21:50:47,901 DEBUG : BROWSER_OUTPUT: 21:50:48 INFO - 2015-11-23 21:50:48,291 INFO : Browser exited with error code: 0 21:50:48 INFO - 2015-11-23 21:50:48,316 INFO : Completed test dromaeo_css (00:18:34) 21:50:48 INFO - 2015-11-23 21:50:48,316 INFO : Starting test kraken 21:50:48 INFO - 2015-11-23 21:50:48,316 DEBUG : operating with platform_type : mac_ 21:50:48 INFO - 2015-11-23 21:50:48,316 INFO : Initialising browser for kraken test... 21:50:48 INFO - 2015-11-23 21:50:48,329 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmp6JBCbf/profile http://localhost:49273/getInfo.html 21:50:50 INFO - 2015-11-23 21:50:50,317 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:50:50 INFO - 2015-11-23 21:50:50,317 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:50:50 INFO - 2015-11-23 21:50:50,317 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:50:50 INFO - 2015-11-23 21:50:50,317 DEBUG : BROWSER_OUTPUT: __metrics 21:50:50 INFO - 2015-11-23 21:50:50,325 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:50:50 INFO - 2015-11-23 21:50:50,968 INFO : Browser initialized. 21:50:50 INFO - 2015-11-23 21:50:50,969 INFO : Running cycle 1/1 for kraken test... 21:50:50 INFO - 2015-11-23 21:50:50,969 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmp6JBCbf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:51:02 INFO - 2015-11-23 21:51:02,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 226148352 21:51:02 INFO - 2015-11-23 21:51:02,871 DEBUG : BROWSER_OUTPUT: 21:51:05 INFO - 2015-11-23 21:51:05,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 21:51:06 INFO - 2015-11-23 21:51:06,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 275648512 21:51:06 INFO - 2015-11-23 21:51:06,058 DEBUG : BROWSER_OUTPUT: 21:51:08 INFO - 2015-11-23 21:51:08,698 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 21:51:09 INFO - 2015-11-23 21:51:09,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 290856960 21:51:09 INFO - 2015-11-23 21:51:09,300 DEBUG : BROWSER_OUTPUT: 21:51:12 INFO - 2015-11-23 21:51:12,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 21:51:13 INFO - 2015-11-23 21:51:13,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 276234240 21:51:13 INFO - 2015-11-23 21:51:13,068 DEBUG : BROWSER_OUTPUT: 21:51:14 INFO - 2015-11-23 21:51:14,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 21:51:15 INFO - 2015-11-23 21:51:15,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 280797184 21:51:15 INFO - 2015-11-23 21:51:15,494 DEBUG : BROWSER_OUTPUT: 21:51:17 INFO - 2015-11-23 21:51:17,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:51:18 INFO - 2015-11-23 21:51:18,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 279801856 21:51:18 INFO - 2015-11-23 21:51:18,225 DEBUG : BROWSER_OUTPUT: 21:51:20 INFO - 2015-11-23 21:51:20,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 21:51:21 INFO - 2015-11-23 21:51:21,529 DEBUG : BROWSER_OUTPUT: RSS: Main: 280997888 21:51:21 INFO - 2015-11-23 21:51:21,529 DEBUG : BROWSER_OUTPUT: 21:51:24 INFO - 2015-11-23 21:51:24,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 21:51:24 INFO - 2015-11-23 21:51:24,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 279801856 21:51:24 INFO - 2015-11-23 21:51:24,953 DEBUG : BROWSER_OUTPUT: 21:51:27 INFO - 2015-11-23 21:51:27,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 21:51:28 INFO - 2015-11-23 21:51:28,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 280043520 21:51:28 INFO - 2015-11-23 21:51:28,221 DEBUG : BROWSER_OUTPUT: 21:51:29 INFO - 2015-11-23 21:51:29,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:51:30 INFO - 2015-11-23 21:51:30,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 313372672 21:51:30 INFO - 2015-11-23 21:51:30,295 DEBUG : BROWSER_OUTPUT: 21:51:32 INFO - 2015-11-23 21:51:32,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:51:32 INFO - 2015-11-23 21:51:32,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 316121088 21:51:32 INFO - 2015-11-23 21:51:32,676 DEBUG : BROWSER_OUTPUT: 21:51:34 INFO - 2015-11-23 21:51:34,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:51:35 INFO - 2015-11-23 21:51:35,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 325120000 21:51:35 INFO - 2015-11-23 21:51:35,436 DEBUG : BROWSER_OUTPUT: 21:51:37 INFO - 2015-11-23 21:51:37,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:51:38 INFO - 2015-11-23 21:51:38,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 325050368 21:51:38 INFO - 2015-11-23 21:51:38,540 DEBUG : BROWSER_OUTPUT: 21:51:40 INFO - 2015-11-23 21:51:40,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:51:41 INFO - 2015-11-23 21:51:41,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 324460544 21:51:41 INFO - 2015-11-23 21:51:41,571 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 21:51:43 INFO - 2015-11-23 21:51:43,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 384352256 21:51:43 INFO - 2015-11-23 21:51:43,471 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,471 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |0;ai-astar;144;160;104;108;109;110;98;111;110;106 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;121;144;159;138;167;162;111;157;116 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |2;audio-dft;183;181;183;183;183;182;182;184;179;183 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |3;audio-fft;66;64;78;72;55;56;55;68;73;55 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;83;85;149;110;111;75;113;77;75;108 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;89;90;89;88;90;88;88;103;89;89 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;141;94;94;95;95;95;95;96;96;94 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;84;84;85;85;86;86;87;86;86;90 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;55;56;55;53;54;53;63;53;52 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;66;65;64;66;67;66;67;67;67 21:51:43 INFO - 2015-11-23 21:51:43,472 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;80;84;106;103;105;79;84;82 21:51:43 INFO - 2015-11-23 21:51:43,473 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;121;123;119;119;122;119;119;120;123 21:51:43 INFO - 2015-11-23 21:51:43,473 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;134;135;133;133;107;147;170;136;121 21:51:43 INFO - 2015-11-23 21:51:43,473 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;63;65;65;65;65;64;64;65;64;65 21:51:43 INFO - 2015-11-23 21:51:43,473 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:51:43 INFO - 2015-11-23 21:51:43,473 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:51:43 INFO - 2015-11-23 21:51:43,473 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1031 21:51:43 INFO - 2015-11-23 21:51:43,473 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:51:43 INFO - 2015-11-23 21:51:43,473 DEBUG : BROWSER_OUTPUT: __startTimestamp1448344303468__endTimestamp 21:51:43 INFO - 2015-11-23 21:51:43,473 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,475 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:51:43 INFO - 2015-11-23 21:51:43,475 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:51:43 INFO - 2015-11-23 21:51:43,475 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,475 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.00 Median:110.50 stddev:19.71 (17.8%) stddev-sans-first:18.12 21:51:43 INFO - 2015-11-23 21:51:43,475 DEBUG : BROWSER_OUTPUT: Values: 144.0 160.0 104.0 108.0 109.0 110.0 98.0 111.0 110.0 106.0 21:51:43 INFO - 2015-11-23 21:51:43,475 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,475 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.40 Median:153.00 stddev:20.23 (13.2%) stddev-sans-first:21.32 21:51:43 INFO - 2015-11-23 21:51:43,475 DEBUG : BROWSER_OUTPUT: Values: 149.0 121.0 144.0 159.0 138.0 167.0 162.0 111.0 157.0 116.0 21:51:43 INFO - 2015-11-23 21:51:43,475 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,475 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:182.30 Median:183.00 stddev:1.42 (0.8%) stddev-sans-first:1.48 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: Values: 183.0 181.0 183.0 183.0 183.0 182.0 182.0 184.0 179.0 183.0 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:64.20 Median:67.00 stddev:8.61 (12.9%) stddev-sans-first:9.11 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: Values: 66.0 64.0 78.0 72.0 55.0 56.0 55.0 68.0 73.0 55.0 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:98.60 Median:75.00 stddev:23.87 (31.8%) stddev-sans-first:24.64 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 149.0 110.0 111.0 75.0 113.0 77.0 75.0 108.0 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:90.30 Median:89.00 stddev:4.52 (5.1%) stddev-sans-first:4.77 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: Values: 89.0 90.0 89.0 88.0 90.0 88.0 88.0 103.0 89.0 89.0 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:99.50 Median:95.00 stddev:14.60 (15.4%) stddev-sans-first:0.78 21:51:43 INFO - 2015-11-23 21:51:43,476 DEBUG : BROWSER_OUTPUT: Values: 141.0 94.0 94.0 95.0 95.0 95.0 95.0 96.0 96.0 94.0 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.73 (2.0%) stddev-sans-first:1.69 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 85.0 85.0 86.0 86.0 87.0 86.0 86.0 90.0 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:3.13 (5.7%) stddev-sans-first:3.30 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: Values: 56.0 55.0 56.0 55.0 53.0 54.0 53.0 63.0 53.0 52.0 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.50 stddev:1.20 (1.8%) stddev-sans-first:1.05 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 65.0 64.0 66.0 67.0 66.0 67.0 67.0 67.0 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,477 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:82.50 stddev:11.02 (13.4%) stddev-sans-first:11.48 21:51:43 INFO - 2015-11-23 21:51:43,479 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 80.0 84.0 106.0 103.0 105.0 79.0 84.0 82.0 21:51:43 INFO - 2015-11-23 21:51:43,479 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,479 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:121.50 stddev:2.87 (2.4%) stddev-sans-first:1.74 21:51:43 INFO - 2015-11-23 21:51:43,479 DEBUG : BROWSER_OUTPUT: Values: 128.0 121.0 123.0 119.0 119.0 122.0 119.0 119.0 120.0 123.0 21:51:43 INFO - 2015-11-23 21:51:43,479 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,479 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.10 Median:135.00 stddev:16.19 (12.0%) stddev-sans-first:17.17 21:51:43 INFO - 2015-11-23 21:51:43,479 DEBUG : BROWSER_OUTPUT: Values: 135.0 134.0 135.0 133.0 133.0 107.0 147.0 170.0 136.0 121.0 21:51:43 INFO - 2015-11-23 21:51:43,480 DEBUG : BROWSER_OUTPUT: 21:51:43 INFO - 2015-11-23 21:51:43,480 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 21:51:43 INFO - 2015-11-23 21:51:43,480 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 65.0 65.0 65.0 64.0 64.0 65.0 64.0 65.0 21:51:43 INFO - 2015-11-23 21:51:43,480 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:51:43 INFO - 2015-11-23 21:51:43,480 DEBUG : BROWSER_OUTPUT: 21:51:44 INFO - 2015-11-23 21:51:44,095 INFO : Browser exited with error code: 0 21:51:44 INFO - 2015-11-23 21:51:44,141 INFO : Completed test kraken (00:00:55) 21:51:44 INFO - 2015-11-23 21:51:44,141 INFO : Starting test v8_7 21:51:44 INFO - 2015-11-23 21:51:44,142 DEBUG : operating with platform_type : mac_ 21:51:44 INFO - 2015-11-23 21:51:44,142 INFO : Initialising browser for v8_7 test... 21:51:44 INFO - 2015-11-23 21:51:44,154 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpvJD0hS/profile http://localhost:49273/getInfo.html 21:51:46 INFO - 2015-11-23 21:51:46,360 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:51:46 INFO - 2015-11-23 21:51:46,361 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:51:46 INFO - 2015-11-23 21:51:46,361 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:51:46 INFO - 2015-11-23 21:51:46,361 DEBUG : BROWSER_OUTPUT: __metrics 21:51:46 INFO - 2015-11-23 21:51:46,378 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:51:47 INFO - 2015-11-23 21:51:47,190 INFO : Browser initialized. 21:51:47 INFO - 2015-11-23 21:51:47,190 INFO : Running cycle 1/1 for v8_7 test... 21:51:47 INFO - 2015-11-23 21:51:47,190 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/tmpvJD0hS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:51:59 INFO - 2015-11-23 21:51:59,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 226021376 21:51:59 INFO - 2015-11-23 21:51:59,057 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49273/tests/v8_7/run.html (next: http://localhost:49273/tests/v8_7/run.html) 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 291876864 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: |0;Richards;175.5001755001755 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.08247422680412 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.928390188892 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4766.666666666667 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1733.102253032929 21:52:20 INFO - 2015-11-23 21:52:20,825 DEBUG : BROWSER_OUTPUT: |5;Earley;792.3930269413629 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: |6;Boyer;12108.43373493976 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: |7;RegExp;29823.529411764706 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: |8;Splay;597.7286312014345 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4545.454545454545 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: __startTimestamp1448344340820__endTimestamp 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:175.50 Median:175.50 stddev:0.00 (0.0%) 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: Values: 175.5 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,826 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.08 Median:161.08 stddev:0.00 (0.0%) 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: Values: 161.1 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.93 Median:281.93 stddev:0.00 (0.0%) 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: Values: 281.9 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4766.67 Median:4766.67 stddev:0.00 (0.0%) 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: Values: 4766.7 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1733.10 Median:1733.10 stddev:0.00 (0.0%) 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: Values: 1733.1 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: Values: 792.4 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,827 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: Values: 12108.4 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29823.53 Median:29823.53 stddev:0.00 (0.0%) 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: Values: 29823.5 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.73 Median:597.73 stddev:0.00 (0.0%) 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: Values: 597.7 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4545.45 Median:4545.45 stddev:0.00 (0.0%) 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: Values: 4545.5 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:52:20 INFO - 2015-11-23 21:52:20,828 DEBUG : BROWSER_OUTPUT: 21:52:21 INFO - 2015-11-23 21:52:21,398 INFO : Browser exited with error code: 0 21:52:21 INFO - 2015-11-23 21:52:21,416 INFO : Completed test v8_7 (00:00:37) 21:52:21 INFO - 2015-11-23 21:52:21,792 INFO : Completed test suite (00:20:08) 21:52:21 INFO - 2015-11-23 21:52:21,792 DEBUG : Working with test: dromaeo_css 21:52:21 INFO - 2015-11-23 21:52:21,792 DEBUG : Generating results file: dromaeo_css 21:52:21 INFO - 2015-11-23 21:52:21,793 DEBUG : Working with test: kraken 21:52:21 INFO - 2015-11-23 21:52:21,793 DEBUG : Generating results file: kraken 21:52:21 INFO - 2015-11-23 21:52:21,793 INFO : javascript benchmark 21:52:21 INFO - 2015-11-23 21:52:21,793 DEBUG : Working with test: v8_7 21:52:21 INFO - 2015-11-23 21:52:21,793 DEBUG : Generating results file: v8_7 21:52:21 INFO - 2015-11-23 21:52:21,794 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:52:22 INFO - 2015-11-23 21:52:22,178 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 21:52:22 INFO - 2015-11-23 21:52:22,178 DEBUG : process_Request line: dromaeo_css 7544.47 graph.html#tests=[[72,64,59]] 21:52:22 INFO - 2015-11-23 21:52:22,178 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:52:22 INFO - 2015-11-23 21:52:22,206 DEBUG : process_Request line: kraken 1409.90 graph.html#tests=[[232,64,59]] 21:52:22 INFO - 2015-11-23 21:52:22,207 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:52:22 INFO - 2015-11-23 21:52:22,232 DEBUG : process_Request line: v8_7 20351.99 graph.html#tests=[[230,64,59]] 21:52:22 INFO - 2015-11-23 21:52:22,233 INFO : javascript benchmark 21:52:22 INFO - 2015-11-23 21:52:22,235 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3386.9153271168216, 3459.827008649567, 3467.878624248152, 3499.3351263259997, 3533.3463309287786, 5621.550275977922, 5678.432156784324, 5722.399148089453, 5737.942620573793, 5755.39568345324, 5671.971640141804, 5705.25831641887, 5714.285714285715, 5721.942780572193, 5731.770729170838, 5111.923321150176, 5113.795448182087, 5133.383993920735, 5166.974165129188, 5230.816921407752, 5167.715775632339, 5212.061828870802, 5217.37391513019, 5223.895522089556, 5238.214267859814, 5061.139606266925, 5214.634975551713, 5214.947850521484, 5221.399539053001, 5245.134552798783, 5137.255098010804, 5198.090334191501, 5202.167653175474, 5250.842474725745, 5264.921026184629, 5176.275321454999, 5200.0, 5221.164613661796, 5222.712750798704, 5278.1291086970605, 5400.810971615974, 5471.0, 5645.604807663465, 5646.435356464362, 5770.6249093808765, 5778.3643799182055, 6103.389661033905, 6220.1913751212505, 6234.657093859836, 6318.083877837687, 6313.842153946142, 6320.905186422207, 6339.809805705836, 6343.397377249154, 6346.904796428057, 5852.356240813507, 5854.121881717776, 5854.297484301911, 5857.531397488234, 5857.677827719516, 6143.972489078594, 6237.500999919996, 6283.96858015707, 6296.212973378328, 6305.243370795534, 5035.345405097314, 6157.138000679908, 6159.753609855556, 6167.321594624587, 6172.382761723881, 6288.748450061947, 6298.212723409574, 6301.117843501914, 6310.400511951358, 6314.778982735582, 5952.494038006731, 6045.941960156955, 6102.176206212104, 6115.510759139347, 6205.875882482415, 5189.844304670866, 6146.815595532052, 6182.0, 6203.348648391854, 6207.937920620736, 4954.133026720309, 4959.7272150032095, 4972.5027497249985, 4980.103581355391, 4996.90006199874, 4439.200943830077, 4441.511433742286, 4441.911161776747, 4475.7985890635, 4499.415076040159, 5586.022446071921, 5639.887202256014, 5678.006348888928, 5683.431656834284, 5714.342850572154, 6304.684765761694, 6346.650934198571, 6346.777862774781, 6357.936420635734, 6364.045393191059, 5697.601167918206, 5712.800051998243, 5720.914186287209, 5721.971390143022, 5770.221020162308, 5267.525922666979, 5366.195070739421, 5375.892482150335, 5376.059189641797, 5416.647917885325, 5338.97330513345, 6275.6548389839, 6290.654014029181, 6327.145835312266, 6360.840978975562, 6132.244930544546, 6147.631142131487, 6191.9690401547705, 6193.969030154821, 6247.468965138014, 5493.697846618475, 6184.134221209124, 6292.4651404629285, 6332.683365831782, 6340.841478963062, 6123.29128149534, 6180.258368995749, 6183.598066125687, 6185.474234689922, 6190.071489276645, 6095.994160963392, 6184.907226391518, 6184.907226391698, 6194.101855231056, 6283.842903927439, 6027.758889644365, 6053.545984051302, 6061.848453788691, 6065.423784740443, 6078.848028799315, 5913.852153696192, 5980.34216236205, 5997.220361352996, 6017.608855424383, 6019.337872833898, 5166.734150133241, 5741.25363702716, 5790.710464476843, 5901.1443340714495, 5910.645361278337, 6061.575689701855, 6122.571420000557, 6125.816225513242, 6138.907916381168, 6139.676133582418, 5753.108268218432, 5966.820995370146, 5967.7911273106965, 5969.703307538278, 5977.462028417463], "unit": "ms", "name": "dojo.html", "value": 5673.221989909416}, {"lowerIsBetter": false, "replicates": [560.8681959739461, 562.1848319936091, 578.9750705775397, 584.6550535184241, 619.1641284266241, 27450.725492745067, 32702.67297327029, 41406.96482587933, 41891.22978931895, 41903.58096419043, 44035.0, 44160.33759493602, 44320.0, 44449.77775111128, 44458.555414445924, 8711.08533603972, 8985.966613839395, 9772.70681879543, 9977.501124943723, 9990.650327238549, 8781.868271975925, 8889.511076890769, 8890.777730556723, 12059.758804823898, 12209.023278137727, 11886.7622647547, 11964.34196119213, 11971.341576213348, 11986.400679966011, 11993.640190794247, 11861.881381186207, 11967.2819630822, 11975.820362694567, 11979.94010029953, 12053.758924821543, 8860.512671803048, 8937.910620893774, 8945.105489451003, 8952.060033696433, 8961.372703910729, 43181.35227971583, 44015.339769903476, 44039.0, 44039.0, 44091.338629920574, 3062.448759223339, 3086.922826929322, 3095.1024202981334, 3159.8104113753247, 3202.711755941976, 28801.0, 29249.561256581168, 29775.70224297751, 29908.102756917327, 30104.548431773543, 2723.1149876290283, 2813.563897595876, 2870.2537340291674, 2988.5367767995995, 2995.8352290624007, 412584.0, 418326.0, 440637.0, 490122.0, 640514.0, 58803.0, 59092.1136182949, 59153.704231478565, 59271.70364148238, 59435.40564594385, 61899.69050154721, 62623.0, 62809.0, 62817.37182628115, 62916.685416572625, 13766.692164244381, 15904.284307206204, 16264.349426023064, 16304.940178888335, 16475.83524164743, 12498.500059997497, 12498.50005999768, 12508.81236781449, 12511.3744312784, 12512.249265044127, 21269.255576054762, 21337.89331053335, 21436.0, 21498.24756133528, 21501.03245353963, 8715.172058654418, 8900.643974241088, 8901.287896968228, 8920.152585504367, 8976.102389761103, 957.8946315905245, 977.628501169551, 988.8813342398959, 1032.9070383665505, 1107.2692023264606, 29900.85049574738, 30481.479281740576, 30587.0, 30616.693833061385, 30666.0, 1131.7510147767478, 1163.9698866503036, 1171.976560468786, 1192.821076838481, 1224.6895821471119, 14438.566842994727, 15329.31018104188, 15418.614534636723, 15637.609059773597, 15683.1374274416, 513164.0, 520517.0, 521504.0, 522477.0, 522497.0, 60153.39846601566, 60724.0, 60736.69631651814, 60832.0, 60891.0, 1434.8923830712738, 1442.3797766960308, 1450.050217107796, 1453.6438572549582, 1590.2764242269739, 29811.850940745157, 30022.399552009276, 30562.694373056875, 30597.694023059485, 30753.846230768704, 52109.21836172536, 52468.0, 52470.0, 52561.7371913138, 52651.73674131605, 534632.0, 543209.0, 543349.0, 636283.0, 636410.0, 24192.395190120387, 30240.09279721612, 30426.239344016576, 30428.39143217079, 30432.695673043872, 42200.78899605482, 42593.78703106465, 42620.360694588984, 43925.12149757051, 44857.327140092275, 29268.56097158502, 37580.81209593934, 37630.43554346632, 38456.615433845305, 38716.80641596774, 37089.44365834461, 37722.36308822574, 38076.809615951744, 38878.222435551696, 39761.80119099386, 36871.07822304464, 37604.0, 37830.62169378271, 38035.42946855855, 38112.0, 28052.579211312255, 31733.0, 33772.32455350929, 33821.49267760936, 33983.0, 24420.633690494302, 25087.623685644365, 25117.87441062856, 25183.048041125207, 25499.490010199323], "unit": "ms", "name": "ext.html", "value": 20296.717930985513}, {"lowerIsBetter": false, "replicates": [361.47225051424937, 362.78051778673904, 364.7865998390941, 368.02840501077145, 368.28001257541507, 15976.12131332779, 16011.95922265052, 18243.543911402223, 20371.796282037176, 21215.257465988714, 15089.849101508982, 17533.3863314784, 20143.29498467554, 20160.0, 20210.595788084265, 6472.126262954488, 6533.967330163343, 6559.409653131217, 6565.704543295539, 6574.835629109287, 4650.186217411956, 4787.880302992436, 4794.2329227323635, 6530.510211734115, 7330.596817175053, 5550.4449555044575, 7526.0, 7534.246575342449, 7543.924560754404, 7547.283008114247, 5702.600817942745, 5727.312722473288, 5729.997250481191, 5741.253637027202, 5747.540196784247, 5370.865728356784, 5632.887342253132, 5638.097904335286, 5641.661500309994, 5642.802501912413, 12427.13010089294, 12468.75062498754, 12657.873421265762, 12859.935700321439, 12882.677933051655, 1957.1584218785915, 2112.091800525773, 2125.107454868959, 2185.2351676912954, 2252.8873556322283, 9798.559064842098, 10168.13570846479, 10169.796604067877, 11655.950964413243, 13959.581212563638, 1695.542203605032, 1719.1404297851075, 1745.2059313012549, 1782.3316256403848, 1822.6263615958696, 94772.0, 103174.0, 103222.0, 104429.99999999924, 104649.0, 8874.600642971081, 9485.098915603006, 10673.039426451656, 10828.675139745821, 11171.329720216812, 13253.602391928258, 13267.601971940858, 13284.335783210994, 13291.0, 13324.267165306, 8174.3051840593025, 8183.95908020456, 8231.259186673109, 8284.005919289602, 8291.170882911661, 8216.21945915137, 8273.8345233095, 8308.169183081643, 8339.916600833914, 8345.082040975487, 4006.6193711597352, 4367.170237654899, 4384.8903777405185, 4388.05656783793, 4420.58004489573, 1740.1995082262301, 1776.3427531813054, 1795.0845069014897, 1815.1650240889076, 1817.881837680573, 389.2351529245047, 812.4191203289677, 888.0143041224236, 922.8846394200725, 1012.6810054832704, 8607.908565948113, 11253.324800511995, 11271.718207044889, 11303.886961130447, 11405.97346238826, 414.75114931041736, 427.12865753861774, 434.4873049801265, 436.1843352930041, 441.50110375275733, 5925.4370834770625, 6050.122732203894, 6070.3019152798, 6089.42150495711, 6104.359042300494, 731771.0, 763640.0, 766751.0, 777895.0, 797025.0, 120053.39973300077, 121670.0, 122826.0, 123738.0, 125794.0, 474.1205064605108, 477.6799544305254, 478.9281607758864, 479.08255690352587, 480.58909632264607, 8487.618057187317, 11111.333320000502, 11117.833232501358, 11127.0, 11133.276337038067, 51601.0, 51672.48327516827, 51926.74036629793, 52958.73520632372, 53322.0, 74789.51262924242, 75817.803727104, 76277.23722762702, 77414.2258577407, 77543.44913101819, 9619.663311784054, 9668.274879383933, 9958.55186516594, 9968.202543796624, 10061.195104391485, 11913.404329783303, 11966.521339146337, 12014.279143251433, 12706.0, 19811.603767924847, 15417.460388886335, 15616.687666246384, 15766.527004189893, 15894.68210635804, 16033.118178499828, 14969.925150374178, 15232.543023709306, 15473.5357939262, 15636.609084772972, 15798.60503487422, 12595.93702031484, 15278.541643750705, 16285.100612683273, 16454.012759234483, 16552.917235413744, 9789.559469824018, 9822.607095716377, 10001.199904007808, 10020.899791002288, 10069.093781559695, 10378.0, 15195.848041519885, 15302.699270561681, 15959.521214363587, 16679.166041697623], "unit": "ms", "name": "jquery.html", "value": 8861.94136538566}, {"lowerIsBetter": false, "replicates": [1549.6048507630553, 1562.8749700024, 1568.9529314120573, 1903.7144428335744, 1945.5038965063907, 7154.141503019639, 7607.809804754877, 8061.717839875613, 8126.674933002688, 8145.674173033086, 8202.261796438319, 8314.459560128602, 8345.874811877811, 8353.37349698772, 8357.498550086999, 2350.2831636350907, 2367.562001029806, 2372.50177462733, 2372.6559648850994, 2376.2039716694926, 2388.2715771689627, 2399.9760002400017, 2417.2989832948424, 2422.539717453687, 2426.2478631624163, 2346.4133966508375, 2361.2798096580536, 2367.2898130560848, 2385.3917251100943, 2387.486690361572, 2334.101370972171, 2358.351453350334, 2366.7751563601432, 2369.526094781042, 2382.106709983756, 2357.5284943011466, 2383.642453631952, 2392.222527678494, 2397.2328854766306, 2401.375642333006, 7628.275313845176, 8393.370497212734, 8440.535770532619, 8444.366672499587, 8447.366447516399, 4805.8558243252755, 4902.313676085351, 5003.899922001576, 5132.307138536287, 5159.638825282232, 3506.9649303506894, 3562.109472631842, 3616.5117709109195, 3650.8174591270595, 3660.4875317455576, 1042.1298215989657, 1061.2253055269618, 1066.3655125200494, 1068.0921216965594, 1078.7626722121122, 11080.224384293102, 11138.94430527842, 11166.497507612177, 11173.273737207055, 11182.496787644575, 4693.953060469352, 4698.718076915396, 4745.454272758677, 4753.073150735573, 4771.165046116916, 9841.55712992917, 9871.062249086326, 9879.209663226924, 9907.356021858555, 9914.454704991294, 5216.191490319006, 5223.634345595848, 5227.921581176285, 5234.555062819627, 5269.657472264291, 4739.194336962724, 4740.620750339965, 4744.4069491313585, 4744.644151688637, 4751.64362672801, 3650.543682039745, 3725.0501122213664, 3728.496652951871, 3737.439384092408, 3767.962320376816, 1211.4306276050243, 1220.1519943639264, 1232.5008371609513, 1233.1676118619896, 1236.8824961628811, 1384.6192297118373, 1405.7891316302637, 1424.4658253155067, 1426.9143851368951, 1427.2506933859806, 7971.960140199262, 8091.271785539329, 8099.878501822477, 8142.552159631277, 8144.4298899077685, 1124.606387764276, 1152.8386025956372, 1216.8174773783826, 1219.432963671897, 1235.209465941798, 6010.248718910137, 6146.508279337642, 6247.9062814057825, 6247.96876015617, 6273.65494897785, 9621.470819104876, 10162.593496260215, 10309.381437113798, 10326.277160598685, 10375.118114960162, 9968.252381071448, 10031.899681003097, 10086.949565252127, 10249.282550221562, 10298.588056477656, 7877.133515313311, 7938.0077490313715, 7955.5226686399, 8027.518348899085, 8040.396970227256, 7823.178566250462, 7941.563214023284, 7942.0, 7956.0, 7959.681612735426, 7693.769186924401, 8842.115788421106, 8996.55017249148, 9071.002189758989, 9121.087891210826, 9266.21237194846, 9431.905680943377, 9464.810703785748, 9465.716028519155, 9482.38364506305, 6911.965440172767, 6914.170299564084, 6977.7208911642965, 6997.05539752127, 7008.404285635778, 8022.478538895187, 8068.556229407204, 8085.353171746364, 8094.635741391769, 8126.878096828434, 7409.777706668809, 7509.324160825552, 7510.39916806665, 7649.541027538366, 7660.34887034586, 6645.568038077509, 7233.710651574089, 7346.926530734624, 7427.814304642211, 7489.251074892467, 7463.701451941862, 7507.174210836694, 7524.473286869867, 7563.886541701769, 7569.394448444001, 6784.457243420416, 6834.760783372558, 6855.931440685529, 6871.381575658214, 6884.90010546788, 6882.139732533434, 6920.273371295942, 6942.340477654615, 6944.097267355211, 6945.791626251221], "unit": "ms", "name": "mootools.html", "value": 4820.945730606842}, {"lowerIsBetter": false, "replicates": [315.39759060195024, 321.84873109638477, 324.2574504384959, 327.6854219948849, 330.336024590573, 6796.796096117118, 6863.519553631248, 6925.168979722428, 6926.6536673166265, 6958.652067396635, 6485.124508191393, 6581.473482121431, 6663.133792606966, 6699.162604674416, 6832.248452670215, 4927.634735327045, 4947.703137811724, 5004.824831130911, 5013.473585273548, 5013.749312534377, 4990.4261009983775, 4997.575206107485, 5013.197888337867, 5019.949800501985, 5025.396952365703, 4701.43582770068, 4803.423589169304, 4807.389524509276, 4817.590504807095, 4958.330625365584, 4897.730624815634, 4923.679960802554, 4937.012597480482, 4940.0, 4968.503149685021, 4240.363945408182, 4243.151369726067, 4246.936295955563, 4250.744955302661, 4259.744415335059, 6381.649009304487, 6528.694261147742, 6549.607023578553, 6557.114789503404, 6565.015247712881, 4553.9981204135365, 6009.0, 6012.158297838306, 6030.306514750772, 6035.939640603626, 7019.82450438738, 7296.635168241567, 7297.160826504967, 7306.2693730626515, 7353.411727061823, 4817.686850354751, 4828.203346447832, 4833.4441539222735, 4833.661643684944, 4834.226523756182, 6121.84695382619, 7486.962565187194, 7797.57113358765, 7816.140224575292, 7832.020997375385, 4745.335653008581, 4772.665913386029, 4779.761011949388, 4780.450248221429, 4780.880477988078, 4839.588634966068, 4857.854264372075, 4866.4403593586485, 4867.9269810952155, 4868.123737727243, 5681.488666020078, 5914.172015917775, 5921.61509501881, 5922.851928701817, 5924.20023296858, 7423.740169094056, 7424.294692004251, 7424.777256682308, 7424.925750742424, 7430.034095567542, 1669.6660667866474, 1688.5694147992183, 1692.7037768390483, 1692.8222536633723, 1693.3734518228334, 1038.631285893512, 1063.994680026595, 1065.9626913058005, 1068.893110688925, 1078.563181911327, 6770.187577490634, 6801.625910574966, 6803.48973826965, 6811.4550835933005, 6817.659117044227, 7392.112946446461, 7627.8855817162785, 7635.732749353857, 7643.273888980538, 7658.846823063507, 6329.3354197809485, 6676.998450232407, 6681.599104053676, 6708.832279192961, 6709.094272273278, 4078.408630748525, 4111.588841115924, 4119.423280740699, 4119.752814831059, 4121.052158003676, 8016.078151012592, 8027.237412445808, 8031.55826429552, 8040.597970101471, 8043.316318113026, 7753.302202801775, 8033.758987230392, 8055.113937466874, 8060.596970151469, 8074.677012919535, 8040.517568945882, 8043.39674524413, 8048.275655191061, 8050.07424146219, 8052.436329456999, 7436.256374362737, 7737.535747854921, 7747.883781743391, 7761.3790896727, 7769.53382797034, 6181.84545386369, 7606.467547271859, 7608.201138880338, 7624.504407213513, 7625.351845093229, 8001.319887809602, 8006.239407256301, 8024.638891249791, 8031.036275646959, 8041.356691464552, 4556.2937744649635, 4693.530646935279, 4701.835435759732, 4747.454042785124, 4759.881002974815, 6157.353477884758, 7497.212792656693, 7498.475106742694, 7505.399568034435, 7523.661435235318, 5931.347551769216, 7306.744263950736, 7319.268073192638, 7321.414286857145, 7334.779956601311, 6110.0, 7095.716171353088, 7201.639918003974, 7315.0, 7377.151627562685, 6208.379162083756, 6750.0212469192675, 7127.7148914042855, 7151.535150215427, 7158.0, 7093.467989900675, 7144.3570078693165, 7267.527610705287, 7276.235995220637, 7325.047743793273, 6294.370562943669, 7238.6018768968215, 7248.0939882514685, 7254.854902901807, 7260.382867456114], "unit": "ms", "name": "prototype.html", "value": 5310.8096763572985}, {"lowerIsBetter": false, "replicates": [642.0689999500726, 681.6114814555705, 704.1128178495095, 724.9311315425035, 747.9065116860394, 15082.773758393632, 15582.636861678733, 15617.531474055797, 15620.375184992616, 15624.2969066392, 14100.224487653175, 14194.148351098942, 14276.500322488715, 14317.355718992645, 15830.84169158308, 943.0239701908527, 955.1308309438413, 958.089814676057, 958.865758793766, 959.8416261316875, 956.4548207521715, 960.3901522533207, 961.1589858873485, 961.1877963121151, 963.2823546457898, 998.9500524973759, 1002.9749256268578, 1004.8643433136542, 1006.9144122749575, 1007.3653598233103, 995.8107959487746, 995.8506224066412, 997.2470784557648, 997.4962643864874, 1002.2332915319786, 750.0811505905277, 751.1587022534796, 751.5640928261595, 751.6880494594736, 752.9872321727267, 14699.0, 14722.926385368111, 14885.925570372186, 14922.62693432662, 14939.775903361458, 10794.460276986198, 12388.62834114969, 12773.616791496177, 12805.359732013456, 12993.87006129936, 10242.23183261251, 10349.0, 10475.58097676092, 10688.572457101707, 10716.946415267952, 3544.1848374873666, 3621.2395396966667, 3625.311190873752, 3681.116532032293, 3723.5345581802276, 62753.37246627521, 63703.6814815923, 65095.0, 72802.27197728008, 81765.36469270581, 9513.619455221713, 9614.326997110134, 9626.855597166048, 9754.0, 9891.554880030415, 21556.13775448996, 21698.566028679652, 21713.56572868534, 21765.12939482403, 21771.782282177293, 6766.76316328936, 6847.691853866588, 7272.490925635155, 7353.77938661841, 7607.961960190274, 3278.7049165575213, 3750.137468382233, 3879.941800872989, 3930.037140900498, 4069.654079403225, 3456.0668619473104, 3494.2312691207894, 3495.965040349615, 3497.0732755819727, 3500.0199944015717, 627.1001113402282, 640.8846407646575, 646.0664340028613, 648.5946283572767, 654.1071437487794, 496.84846121932435, 506.85554616933996, 517.361059092021, 521.9478052194826, 548.14763043467, 8063.637136328879, 8454.577271136419, 8455.196756308142, 8592.355573332025, 8671.0, 522.1384715219841, 568.5792513539951, 579.8840231953626, 601.4586871815401, 630.3066626710581, 3907.5115610548683, 4196.328587425997, 4409.977950110293, 4430.224710675683, 4508.436445444319, 96563.51718241505, 97651.0, 98503.0, 98606.50696746471, 100010.0, 83666.16333836583, 83862.58068709739, 84121.0, 84921.57539212388, 85860.14139858646, 63876.0, 71790.0, 73041.8870679058, 77355.22644773593, 79067.99999999885, 8655.17775811297, 8906.421082629608, 9111.498867562348, 9173.633054677739, 9238.676646317346, 41499.75500734983, 52608.47391526036, 52880.47119528755, 55169.724151378985, 55599.72200138973, 75290.0, 75669.62165189139, 76190.47619047477, 78657.0, 78836.0, 9634.662786802428, 10669.46652667348, 10879.423354917806, 11115.333080015225, 11695.76608467843, 12098.93950530277, 12161.635150945485, 12166.026717862727, 12332.691682708004, 12398.504059837505, 11873.16887817879, 11898.940505297418, 11899.881001190224, 11924.880751192377, 11982.940085299517, 11693.941530292634, 11707.121965852766, 11743.236689615147, 11746.70633234176, 11761.764764704487, 11260.0, 11738.41307934617, 11768.470418831344, 11935.820962685393, 12068.456919438822, 9732.902670973483, 9903.207743380657, 10000.899991000288, 10076.244281678757, 10451.634192803216, 9888.570360214384, 10200.464338318016, 10205.0, 10213.182945364204, 10261.794764104825], "unit": "ms", "name": "yui.html", "value": 7057.652973355353}], "name": "dromaeo_css", "value": 7544.470828956731}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [144.0, 160.0, 104.0, 108.0, 109.0, 110.0, 98.0, 111.0, 110.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 116.0}, {"lowerIsBetter": true, "replicates": [149.0, 121.0, 144.0, 159.0, 138.0, 167.0, 162.0, 111.0, 157.0, 116.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.4}, {"lowerIsBetter": true, "replicates": [183.0, 181.0, 183.0, 183.0, 183.0, 182.0, 182.0, 184.0, 179.0, 183.0], "unit": "ms", "name": "audio-dft", "value": 182.3}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 78.0, 72.0, 55.0, 56.0, 55.0, 68.0, 73.0, 55.0], "unit": "ms", "name": "audio-fft", "value": 64.2}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 149.0, 110.0, 111.0, 75.0, 113.0, 77.0, 75.0, 108.0], "unit": "ms", "name": "audio-oscillator", "value": 98.6}, {"lowerIsBetter": true, "replicates": [89.0, 90.0, 89.0, 88.0, 90.0, 88.0, 88.0, 103.0, 89.0, 89.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 90.3}, {"lowerIsBetter": true, "replicates": [141.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 99.5}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 85.0, 85.0, 86.0, 86.0, 87.0, 86.0, 86.0, 90.0], "unit": "ms", "name": "imaging-desaturate", "value": 85.9}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 55.0, 53.0, 54.0, 53.0, 63.0, 53.0, 52.0], "unit": "ms", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 65.0, 64.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.9}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 80.0, 84.0, 106.0, 103.0, 105.0, 79.0, 84.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [128.0, 121.0, 123.0, 119.0, 119.0, 122.0, 119.0, 119.0, 120.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [135.0, 134.0, 135.0, 133.0, 133.0, 107.0, 147.0, 170.0, 136.0, 121.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.1}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.5}], "name": "kraken", "value": 1409.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [175.5001755001755], "unit": "score", "name": "Richards", "value": 201.15079599999999}, {"lowerIsBetter": false, "replicates": [161.08247422680412], "unit": "score", "name": "DeltaBlue", "value": 410.460544}, {"lowerIsBetter": false, "replicates": [281.928390188892], "unit": "score", "name": "Encrypt", "value": 944.1440070000003}, {"lowerIsBetter": false, "replicates": [4766.666666666667], "unit": "score", "name": "Decrypt", "value": 55.84216783216784}, {"lowerIsBetter": false, "replicates": [1733.102253032929], "unit": "score", "name": "RayTrace", "value": 426.97365299999996}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [29823.529411764706], "unit": "score", "name": "RegExp", "value": 30.545848126232723}, {"lowerIsBetter": false, "replicates": [597.7286312014345], "unit": "score", "name": "Splay", "value": 136.33444300000005}, {"lowerIsBetter": false, "replicates": [4545.454545454545], "unit": "score", "name": "NavierStokes", "value": 326.4799999999998}], "name": "v8_7", "value": 20351.985748424562}]} 21:52:22 INFO - RETURN: dromaeo_css: 7544.47 21:52:22 INFO - RETURN: kraken: 1409.90 21:52:22 INFO - RETURN: v8_7: 20351.99 21:52:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20351.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1409.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7544.47"}}} 21:52:22 INFO - Return code: 0 21:52:22 INFO - # TBPL SUCCESS # 21:52:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:52:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:52:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:52:22 INFO - 2015-11-23 21:52:22.335 screenresolution[1681:11066] starting screenresolution argv=screenresolution get 21:52:22 INFO - 2015-11-23 21:52:22.338 screenresolution[1681:11066] Display 0: 1600x1200x32@60 21:52:22 INFO - 2015-11-23 21:52:22.344 screenresolution[1682:11069] starting screenresolution argv=screenresolution list 21:52:22 INFO - Available Modes on Display 0 21:52:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:52:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:52:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:52:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:52:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:52:22 INFO - Intel Iris: 21:52:22 INFO - Chipset Model: Intel Iris 21:52:22 INFO - Type: GPU 21:52:22 INFO - Bus: Built-In 21:52:22 INFO - VRAM (Dynamic, Max): 1536 MB 21:52:22 INFO - Vendor: Intel (0x8086) 21:52:22 INFO - Device ID: 0x0a2e 21:52:22 INFO - Revision ID: 0x0009 21:52:22 INFO - Displays: 21:52:22 INFO - Display: 21:52:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:52:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:52:22 INFO - Display Serial Number: 1600x1200 60 21:52:22 INFO - Main Display: Yes 21:52:22 INFO - Mirror: Off 21:52:22 INFO - Online: Yes 21:52:22 INFO - Rotation: Supported 21:52:22 INFO - Return code: 0 21:52:22 INFO - Running post-action listener: _resource_record_post_action 21:52:22 INFO - Running post-run listener: _resource_record_post_run 21:52:23 INFO - Total resource usage - Wall time: 1241s; CPU: 52.0%; Read bytes: 33267200; Write bytes: 692900864; Read time: 345; Write time: 2219 21:52:23 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 337834496; Write bytes: 338965504; Read time: 26420; Write time: 666 21:52:23 INFO - run-tests - Wall time: 1210s; CPU: 52.0%; Read bytes: 31510016; Write bytes: 342671360; Read time: 328; Write time: 1515 21:52:23 INFO - Running post-run listener: _upload_blobber_files 21:52:23 INFO - Blob upload gear active. 21:52:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:52:23 INFO - Copying logs to upload dir... 21:52:23 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1289.219912 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2015-11-23 21:52:23.697251) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 21:52:23.700765) ========= 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.tz3BVx7zld/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.ymLBa6SPIn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009281 build_url: 'https://queue.taskcluster.net/v1/task/XdD5SyI_QMOdOBsDK9Y4UQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 21:52:23.723791) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:52:23.724102) ========= 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.tz3BVx7zld/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.ymLBa6SPIn/Listeners TMPDIR=/var/folders/6j/h2_l2tgj0h5b111_ddr5tl_h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004930 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 21:52:23.773120) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 21:52:23.773449) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 21:52:23.773790) ========= ========= Total master_lag: 0.28 =========