builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0045 starttime: 1470020159.42 results: success (0) buildid: 20160708030201 builduid: e85acada7d724f7a8e21fcd91df4f8ad revision: 45682df2d2d45e5a8385fd842579e661a4b60bc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 19:55:59.424014) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-31 19:55:59.424474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 19:55:59.424795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-31 19:55:59.518748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 19:55:59.519043) ========= 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.khEFlxFL2x/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.B6c2iqKpLp/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 --2016-07-31 19:55:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.6M=0.001s 2016-07-31 19:55:59 (18.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141093 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 19:55:59.698662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 19:55:59.698985) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.khEFlxFL2x/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.B6c2iqKpLp/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.027470 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 19:55:59.750457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-31 19:55:59.750854) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45682df2d2d45e5a8385fd842579e661a4b60bc5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 45682df2d2d45e5a8385fd842579e661a4b60bc5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.khEFlxFL2x/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.B6c2iqKpLp/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 2016-07-31 19:55:59,826 truncating revision to first 12 chars 2016-07-31 19:55:59,826 Setting DEBUG logging. 2016-07-31 19:55:59,827 attempt 1/10 2016-07-31 19:55:59,827 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45682df2d2d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-31 19:56:00,541 unpacking tar archive at: mozilla-central-45682df2d2d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.979187 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-31 19:56:00.753655) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 19:56:00.753931) ========= script_repo_revision: 45682df2d2d45e5a8385fd842579e661a4b60bc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-31 19:56:00.754302) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 19:56:00.754580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-31 19:56:00.773600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-31 19:56:00.773935) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.khEFlxFL2x/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.B6c2iqKpLp/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 19:56:00 INFO - MultiFileLogger online at 20160731 19:56:00 in /builds/slave/test 19:56:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:56:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:56:00 INFO - {'append_to_log': False, 19:56:00 INFO - 'base_work_dir': '/builds/slave/test', 19:56:00 INFO - 'blob_upload_branch': 'Firefox', 19:56:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:56:00 INFO - 'branch': 'Firefox', 19:56:00 INFO - 'buildbot_json_path': 'buildprops.json', 19:56:00 INFO - 'config_files': ('talos/mac_config.py',), 19:56:00 INFO - 'default_actions': ('clobber', 19:56:00 INFO - 'read-buildbot-config', 19:56:00 INFO - 'download-and-extract', 19:56:00 INFO - 'populate-webroot', 19:56:00 INFO - 'create-virtualenv', 19:56:00 INFO - 'install', 19:56:00 INFO - 'run-tests'), 19:56:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:56:00 INFO - 'download_minidump_stackwalk': True, 19:56:00 INFO - 'download_symbols': 'ondemand', 19:56:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:56:00 INFO - 'tooltool.py': '/tools/tooltool.py', 19:56:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:56:00 INFO - '/tools/misc-python/virtualenv.py')}, 19:56:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:56:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:56:00 INFO - 'installer_path': 'installer.exe', 19:56:00 INFO - 'log_level': 'info', 19:56:00 INFO - 'log_name': 'talos', 19:56:00 INFO - 'log_to_console': True, 19:56:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:56:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:56:00 INFO - 'opt_config_files': (), 19:56:00 INFO - 'pip_index': False, 19:56:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:56:00 INFO - 'cmd': ('bash', 19:56:00 INFO - '-c', 19:56:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:56:00 INFO - 'enabled': True, 19:56:00 INFO - 'halt_on_failure': False, 19:56:00 INFO - 'name': 'check_screen_resolution'},), 19:56:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:56:00 INFO - 'cmd': ('bash', 19:56:00 INFO - '-c', 19:56:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:56:00 INFO - 'enabled': True, 19:56:00 INFO - 'halt_on_failure': False, 19:56:00 INFO - 'name': 'check_screen_resolution'},), 19:56:00 INFO - 'run_cmd_checks_enabled': True, 19:56:00 INFO - 'sps_profile': False, 19:56:00 INFO - 'sps_profile_interval': 0, 19:56:00 INFO - 'suite': 'dromaeojs', 19:56:00 INFO - 'system_bits': '32', 19:56:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:56:00 INFO - 'title': 't-yosemite-r7-0045', 19:56:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:56:00 INFO - 'use_talos_json': True, 19:56:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:56:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:56:00 INFO - 'work_dir': 'build'} 19:56:00 INFO - ##### 19:56:00 INFO - ##### Running clobber step. 19:56:00 INFO - ##### 19:56:00 INFO - Running pre-action listener: _resource_record_pre_action 19:56:00 INFO - Running main action method: clobber 19:56:00 INFO - rmtree: /builds/slave/test/build 19:56:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:56:03 INFO - Running post-action listener: _resource_record_post_action 19:56:03 INFO - ##### 19:56:03 INFO - ##### Finished clobber step (success) 19:56:03 INFO - ##### 19:56:03 INFO - ##### 19:56:03 INFO - ##### Running read-buildbot-config step. 19:56:03 INFO - ##### 19:56:03 INFO - Running pre-action listener: _resource_record_pre_action 19:56:03 INFO - Running main action method: read_buildbot_config 19:56:03 INFO - Using buildbot properties: 19:56:03 INFO - { 19:56:03 INFO - "project": "", 19:56:03 INFO - "product": "firefox", 19:56:03 INFO - "script_repo_revision": "production", 19:56:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:56:03 INFO - "repository": "", 19:56:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:56:03 INFO - "buildid": "20160708030201", 19:56:03 INFO - "stage_platform": "macosx64", 19:56:03 INFO - "basedir": "/builds/slave/test", 19:56:03 INFO - "nightly_build": "True", 19:56:03 INFO - "buildnumber": 32, 19:56:03 INFO - "slavename": "t-yosemite-r7-0045", 19:56:03 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:56:03 INFO - "platform": "yosemite_r7", 19:56:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:56:03 INFO - "branch": "mozilla-central", 19:56:03 INFO - "repo_path": "mozilla-central", 19:56:03 INFO - "revision": "45682df2d2d45e5a8385fd842579e661a4b60bc5", 19:56:03 INFO - "pgo_build": "False", 19:56:03 INFO - "builduid": "e85acada7d724f7a8e21fcd91df4f8ad", 19:56:03 INFO - "slavebuilddir": "test" 19:56:03 INFO - } 19:56:03 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.dmg. 19:56:03 INFO - Running post-action listener: _resource_record_post_action 19:56:03 INFO - ##### 19:56:03 INFO - ##### Finished read-buildbot-config step (success) 19:56:03 INFO - ##### 19:56:03 INFO - ##### 19:56:03 INFO - ##### Running download-and-extract step. 19:56:03 INFO - ##### 19:56:03 INFO - Running pre-action listener: _resource_record_pre_action 19:56:03 INFO - Running main action method: download_and_extract 19:56:03 INFO - mkdir: /builds/slave/test/build/tests 19:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.test_packages.json 19:56:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 19:56:03 INFO - Downloaded 1199 bytes. 19:56:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:56:03 INFO - Using the following test package requirements: 19:56:03 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:56:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:56:03 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 19:56:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:56:03 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 19:56:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:56:03 INFO - u'jsshell-mac.zip'], 19:56:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:56:03 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 19:56:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:56:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:56:03 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 19:56:03 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:56:03 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 19:56:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:56:03 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 19:56:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:56:03 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 19:56:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.common.tests.zip 19:56:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:56:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:56:03 INFO - Downloaded 18806412 bytes. 19:56:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:56:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:56:06 INFO - Return code: 0 19:56:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:56:06 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')]} 19:56:06 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.common.tests.zip 19:56:06 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:56:07 INFO - Downloaded 18806412 bytes. 19:56:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:56:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:56:10 INFO - Return code: 0 19:56: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')]} 19:56:10 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.talos.tests.zip 19:56:10 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:56:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:56:11 INFO - Downloaded 14403333 bytes. 19:56:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:56:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:56:12 INFO - Return code: 0 19:56: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')]} 19:56:12 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.dmg 19:56:12 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 19:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 19:56:13 INFO - Downloaded 112613152 bytes. 19:56:13 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.dmg 19:56:13 INFO - mkdir: /builds/slave/test/properties 19:56:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:56:13 INFO - Writing to file /builds/slave/test/properties/build_url 19:56:13 INFO - Contents: 19:56:13 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.dmg 19:56:13 INFO - Running post-action listener: _resource_record_post_action 19:56:13 INFO - Running post-action listener: set_extra_try_arguments 19:56:13 INFO - ##### 19:56:13 INFO - ##### Finished download-and-extract step (success) 19:56:13 INFO - ##### 19:56:13 INFO - ##### 19:56:13 INFO - ##### Running populate-webroot step. 19:56:13 INFO - ##### 19:56:13 INFO - Running pre-action listener: _resource_record_pre_action 19:56:13 INFO - Running main action method: populate_webroot 19:56:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:56:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:56:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:56:13 INFO - '--tppagecycles', 19:56:13 INFO - '7'], 19:56:13 INFO - 'tests': ['tsvgm']}}, 19:56:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:56:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:56:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:56:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:56:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:13 INFO - 'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:56:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:13 INFO - 'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['damp', 'tps']}, 19:56:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:13 INFO - 'tests': ['damp', 'tps']}, 19:56:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['dromaeo_dom']}, 19:56:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:56:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['basic_compositor_video']}, 19:56:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:56:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['a11yr', 19:56:13 INFO - 'ts_paint', 19:56:13 INFO - 'tpaint', 19:56:13 INFO - 'sessionrestore', 19:56:13 INFO - 'sessionrestore_no_auto_restore', 19:56:13 INFO - 'tabpaint']}, 19:56:13 INFO - 'other-e10s': {'tests': ['a11yr', 19:56:13 INFO - 'ts_paint', 19:56:13 INFO - 'tpaint', 19:56:13 INFO - 'sessionrestore', 19:56:13 INFO - 'sessionrestore_no_auto_restore', 19:56:13 INFO - 'tabpaint']}, 19:56:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:56:13 INFO - 'ts_paint', 19:56:13 INFO - 'tpaint', 19:56:13 INFO - 'sessionrestore', 19:56:13 INFO - 'sessionrestore_no_auto_restore', 19:56:13 INFO - 'tabpaint']}, 19:56:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:56:13 INFO - 'ts_paint', 19:56:13 INFO - 'tpaint', 19:56:13 INFO - 'sessionrestore', 19:56:13 INFO - 'sessionrestore_no_auto_restore', 19:56:13 INFO - 'tabpaint']}, 19:56:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['a11yr', 19:56:13 INFO - 'ts_paint', 19:56:13 INFO - 'tpaint', 19:56:13 INFO - 'sessionrestore', 19:56:13 INFO - 'sessionrestore_no_auto_restore', 19:56:13 INFO - 'tabpaint']}, 19:56:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['a11yr', 19:56:13 INFO - 'ts_paint', 19:56:13 INFO - 'tpaint', 19:56:13 INFO - 'sessionrestore', 19:56:13 INFO - 'sessionrestore_no_auto_restore', 19:56:13 INFO - 'tabpaint']}, 19:56:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['tsvgx', 19:56:13 INFO - 'tsvgr_opacity', 19:56:13 INFO - 'tart', 19:56:13 INFO - 'tscrollx', 19:56:13 INFO - 'cart']}, 19:56:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:56:13 INFO - 'tsvgr_opacity', 19:56:13 INFO - 'tart', 19:56:13 INFO - 'tscrollx', 19:56:13 INFO - 'cart']}, 19:56:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:13 INFO - 'talos_options': ['--disable-e10s'], 19:56:13 INFO - 'tests': ['tp5o']}, 19:56:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:13 INFO - 'tests': ['tp5o']}, 19:56:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:13 INFO - 'talos_options': ['--disable-e10s', 19:56:13 INFO - '--xperf_path', 19:56:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:13 INFO - 'tests': ['tp5n']}, 19:56:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:56:13 INFO - 'talos_options': ['--xperf_path', 19:56:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:56:13 INFO - 'tests': ['tp5n']}}, 19:56:13 INFO - 'talos.zip': {'path': '', 19:56:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:56:13 INFO - Running post-action listener: _resource_record_post_action 19:56:13 INFO - ##### 19:56:13 INFO - ##### Finished populate-webroot step (success) 19:56:13 INFO - ##### 19:56:13 INFO - ##### 19:56:13 INFO - ##### Running create-virtualenv step. 19:56:13 INFO - ##### 19:56:13 INFO - Running pre-action listener: _resource_record_pre_action 19:56:13 INFO - Running main action method: create_virtualenv 19:56:13 INFO - Creating virtualenv /builds/slave/test/build/venv 19:56:13 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 19:56:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:56:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:56:13 INFO - Using real prefix '/tools/python27' 19:56:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:56:14 INFO - Installing distribute.............................................................................................................................................................................................done. 19:56:17 INFO - Installing pip.................done. 19:56:17 INFO - Return code: 0 19:56:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:56:17 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')]} 19:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:17 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')]} 19:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x108d14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108da9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e15adff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c78d30>, '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 0x1089dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c70b20>, '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.khEFlxFL2x/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.B6c2iqKpLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 19:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:56:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khEFlxFL2x/Render', 19:56:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:17 INFO - 'HOME': '/Users/cltbld', 19:56:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:17 INFO - 'LOGNAME': 'cltbld', 19:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:17 INFO - 'MOZ_NO_REMOTE': '1', 19:56:17 INFO - 'NO_EM_RESTART': '1', 19:56:17 INFO - 'PAGER': '/bin/cat', 19:56:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:17 INFO - 'PWD': '/builds/slave/test', 19:56:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:17 INFO - 'SHELL': '/bin/bash', 19:56:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6c2iqKpLp/Listeners', 19:56:17 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 19:56:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:17 INFO - 'USER': 'cltbld', 19:56:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:17 INFO - 'XPC_FLAGS': '0x0', 19:56:17 INFO - 'XPC_SERVICE_NAME': '0', 19:56:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:17 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 19:56:17 INFO - Cleaning up... 19:56:17 INFO - Return code: 0 19:56:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:56:17 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')]} 19:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:17 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')]} 19:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108da9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e15adff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c78d30>, '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 0x1089dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c70b20>, '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.khEFlxFL2x/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.B6c2iqKpLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 19:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 19:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 19:56:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khEFlxFL2x/Render', 19:56:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:17 INFO - 'HOME': '/Users/cltbld', 19:56:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:17 INFO - 'LOGNAME': 'cltbld', 19:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:17 INFO - 'MOZ_NO_REMOTE': '1', 19:56:17 INFO - 'NO_EM_RESTART': '1', 19:56:17 INFO - 'PAGER': '/bin/cat', 19:56:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:17 INFO - 'PWD': '/builds/slave/test', 19:56:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:17 INFO - 'SHELL': '/bin/bash', 19:56:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6c2iqKpLp/Listeners', 19:56:17 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 19:56:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:17 INFO - 'USER': 'cltbld', 19:56:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:17 INFO - 'XPC_FLAGS': '0x0', 19:56:17 INFO - 'XPC_SERVICE_NAME': '0', 19:56:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:17 INFO - Downloading/unpacking psutil>=3.1.1 19:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:56:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:21 INFO - Installing collected packages: psutil 19:56:21 INFO - Running setup.py install for psutil 19:56:22 INFO - building 'psutil._psutil_osx' extension 19:56: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 19:56: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:56: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:56:22 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 19:56:22 INFO - building 'psutil._psutil_posix' extension 19:56:22 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 19:56:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:56:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:56:22 INFO - ^ 19:56:22 INFO - 1 warning generated. 19:56:22 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 19:56:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:56:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:56:23 INFO - Successfully installed psutil 19:56:23 INFO - Cleaning up... 19:56:23 INFO - Return code: 0 19:56:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108da9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e15adff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c78d30>, '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 0x1089dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c70b20>, '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.khEFlxFL2x/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.B6c2iqKpLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 19:56:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 19:56:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 19:56:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khEFlxFL2x/Render', 19:56:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:23 INFO - 'HOME': '/Users/cltbld', 19:56:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:23 INFO - 'LOGNAME': 'cltbld', 19:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:23 INFO - 'MOZ_NO_REMOTE': '1', 19:56:23 INFO - 'NO_EM_RESTART': '1', 19:56:23 INFO - 'PAGER': '/bin/cat', 19:56:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:23 INFO - 'PWD': '/builds/slave/test', 19:56:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:23 INFO - 'SHELL': '/bin/bash', 19:56:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6c2iqKpLp/Listeners', 19:56:23 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 19:56:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:23 INFO - 'USER': 'cltbld', 19:56:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:23 INFO - 'XPC_FLAGS': '0x0', 19:56:23 INFO - 'XPC_SERVICE_NAME': '0', 19:56:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:56:23 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 19:56:23 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 19:56:23 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 19:56:23 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 19:56:23 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 19:56:23 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 19:56:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:56:25 INFO - Installing collected packages: mozsystemmonitor 19:56:25 INFO - Running setup.py install for mozsystemmonitor 19:56:25 INFO - Successfully installed mozsystemmonitor 19:56:25 INFO - Cleaning up... 19:56:26 INFO - Return code: 0 19:56:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:56: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')]} 19:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56: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')]} 19:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108da9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e15adff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c78d30>, '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 0x1089dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c70b20>, '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.khEFlxFL2x/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.B6c2iqKpLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 19:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema==2.5.1 19:56:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khEFlxFL2x/Render', 19:56:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:26 INFO - 'HOME': '/Users/cltbld', 19:56:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:26 INFO - 'LOGNAME': 'cltbld', 19:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:26 INFO - 'MOZ_NO_REMOTE': '1', 19:56:26 INFO - 'NO_EM_RESTART': '1', 19:56:26 INFO - 'PAGER': '/bin/cat', 19:56:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:26 INFO - 'PWD': '/builds/slave/test', 19:56:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:26 INFO - 'SHELL': '/bin/bash', 19:56:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6c2iqKpLp/Listeners', 19:56:26 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 19:56:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:26 INFO - 'USER': 'cltbld', 19:56:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:26 INFO - 'XPC_FLAGS': '0x0', 19:56:26 INFO - 'XPC_SERVICE_NAME': '0', 19:56:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:26 INFO - Downloading/unpacking jsonschema==2.5.1 19:56:26 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 19:56:26 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 19:56:26 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 19:56:26 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 19:56:26 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 19:56:26 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 19:56:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:56:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:29 INFO - Downloading functools32-3.2.3-2.tar.gz 19:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:56:29 INFO - warning: no files found matching '*.txt' 19:56:29 INFO - no previously-included directories found matching 'build' 19:56:29 INFO - no previously-included directories found matching 'dist' 19:56:29 INFO - no previously-included directories found matching '.git*' 19:56:29 INFO - Installing collected packages: jsonschema, functools32 19:56:29 INFO - Running setup.py install for functools32 19:56:29 INFO - warning: no files found matching '*.txt' 19:56:29 INFO - no previously-included directories found matching 'build' 19:56:29 INFO - no previously-included directories found matching 'dist' 19:56:29 INFO - no previously-included directories found matching '.git*' 19:56:29 INFO - Successfully installed jsonschema functools32 19:56:29 INFO - Cleaning up... 19:56:29 INFO - Return code: 0 19:56:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:56:29 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')]} 19:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:29 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')]} 19:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x108d14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108da9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e15adff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c78d30>, '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 0x1089dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c70b20>, '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.khEFlxFL2x/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.B6c2iqKpLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 19:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khEFlxFL2x/Render', 19:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:29 INFO - 'HOME': '/Users/cltbld', 19:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:29 INFO - 'LOGNAME': 'cltbld', 19:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:29 INFO - 'MOZ_NO_REMOTE': '1', 19:56:29 INFO - 'NO_EM_RESTART': '1', 19:56:29 INFO - 'PAGER': '/bin/cat', 19:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:29 INFO - 'PWD': '/builds/slave/test', 19:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:29 INFO - 'SHELL': '/bin/bash', 19:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6c2iqKpLp/Listeners', 19:56:29 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 19:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:29 INFO - 'USER': 'cltbld', 19:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:29 INFO - 'XPC_FLAGS': '0x0', 19:56:29 INFO - 'XPC_SERVICE_NAME': '0', 19:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:29 INFO - Downloading/unpacking blobuploader==1.2.4 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56:32 INFO - Downloading blobuploader-1.2.4.tar.gz 19:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:56:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:56:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:33 INFO - Downloading docopt-0.6.1.tar.gz 19:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:56:33 INFO - Installing collected packages: blobuploader, requests, docopt 19:56:33 INFO - Running setup.py install for blobuploader 19:56:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:56:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:56:33 INFO - Running setup.py install for requests 19:56:34 INFO - Running setup.py install for docopt 19:56:34 INFO - Successfully installed blobuploader requests docopt 19:56:34 INFO - Cleaning up... 19:56:34 INFO - Return code: 0 19:56:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:34 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')]} 19:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:34 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')]} 19:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x108d14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108da9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e15adff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c78d30>, '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 0x1089dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c70b20>, '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.khEFlxFL2x/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.B6c2iqKpLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 19:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 19:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 19:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khEFlxFL2x/Render', 19:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:34 INFO - 'HOME': '/Users/cltbld', 19:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:34 INFO - 'LOGNAME': 'cltbld', 19:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:34 INFO - 'MOZ_NO_REMOTE': '1', 19:56:34 INFO - 'NO_EM_RESTART': '1', 19:56:34 INFO - 'PAGER': '/bin/cat', 19:56:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:34 INFO - 'PWD': '/builds/slave/test', 19:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:34 INFO - 'SHELL': '/bin/bash', 19:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6c2iqKpLp/Listeners', 19:56:34 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 19:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:34 INFO - 'USER': 'cltbld', 19:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:34 INFO - 'XPC_FLAGS': '0x0', 19:56:34 INFO - 'XPC_SERVICE_NAME': '0', 19:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:34 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-zSIM1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:35 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-zqAzgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:35 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Y8AoAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:35 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-nKShF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:35 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-hPDHPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:35 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-CYpneJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:35 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-g1YDpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:35 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Mzzl_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:35 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-F49BQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:35 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-fC7Vs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:35 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-NjwvRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:36 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-2LFTqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:36 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-eRUumo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:36 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-KHbmSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:36 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Ez7swt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:36 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-zCZY9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:36 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-KU45g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:56:36 INFO - Running setup.py install for manifestparser 19:56:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:56:36 INFO - Running setup.py install for mozcrash 19:56:36 INFO - Running setup.py install for mozdebug 19:56:37 INFO - Running setup.py install for mozdevice 19:56:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:56:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:56:37 INFO - Running setup.py install for mozfile 19:56:37 INFO - Running setup.py install for mozhttpd 19:56:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:56:37 INFO - Running setup.py install for mozinfo 19:56:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:56:37 INFO - Running setup.py install for mozInstall 19:56:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:56:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:56:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:56:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:56:37 INFO - Running setup.py install for mozleak 19:56:37 INFO - Running setup.py install for mozlog 19:56:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:56:38 INFO - Running setup.py install for moznetwork 19:56:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:56:38 INFO - Running setup.py install for mozprocess 19:56:38 INFO - Running setup.py install for mozprofile 19:56:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:56:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:56:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:56:38 INFO - Running setup.py install for mozrunner 19:56:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:56:38 INFO - Running setup.py install for mozscreenshot 19:56:38 INFO - Running setup.py install for moztest 19:56:39 INFO - Running setup.py install for mozversion 19:56:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:56:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:56:39 INFO - Cleaning up... 19:56:39 INFO - Return code: 0 19:56:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x108d14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108da9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e15adff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c78d30>, '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 0x1089dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c70b20>, '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.khEFlxFL2x/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.B6c2iqKpLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 19:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:56:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khEFlxFL2x/Render', 19:56:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:39 INFO - 'HOME': '/Users/cltbld', 19:56:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:39 INFO - 'LOGNAME': 'cltbld', 19:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:39 INFO - 'MOZ_NO_REMOTE': '1', 19:56:39 INFO - 'NO_EM_RESTART': '1', 19:56:39 INFO - 'PAGER': '/bin/cat', 19:56:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:39 INFO - 'PWD': '/builds/slave/test', 19:56:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:39 INFO - 'SHELL': '/bin/bash', 19:56:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6c2iqKpLp/Listeners', 19:56:39 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 19:56:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:39 INFO - 'USER': 'cltbld', 19:56:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:39 INFO - 'XPC_FLAGS': '0x0', 19:56:39 INFO - 'XPC_SERVICE_NAME': '0', 19:56:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:39 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-hnWRZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:39 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)) 19:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:39 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-bzME2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 19:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:39 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Ho_AR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:39 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)) 19:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:39 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-_mlJ3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 19:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:39 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Pukwti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:40 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)) 19:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:40 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-zNHJ1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:40 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)) 19:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:40 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-DHSDqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:40 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)) 19:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:40 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-QBJQYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:40 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)) 19:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:40 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-mKp4hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:40 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)) 19:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:40 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-a3QysK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 19:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:40 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-i5H1lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:40 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)) 19:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:40 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-afCYZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 19:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:40 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-HTcbMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 19:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:40 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-GTupuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 19:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:40 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-Izxn1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:41 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)) 19:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:41 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-WQ7_If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:41 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)) 19:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:41 INFO - Running setup.py (path:/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/pip-wRDVSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:41 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)) 19:56:41 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:56:41 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:56:41 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)) 19:56:41 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:56:41 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:56:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:56:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:56:43 INFO - Downloading blessings-1.6.tar.gz 19:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:56:43 INFO - Installing collected packages: blessings 19:56:43 INFO - Running setup.py install for blessings 19:56:44 INFO - Successfully installed blessings 19:56:44 INFO - Cleaning up... 19:56:44 INFO - Return code: 0 19:56:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:56:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:44 INFO - Reading from file tmpfile_stdout 19:56:44 INFO - Current package versions: 19:56:44 INFO - blessings == 1.6 19:56:44 INFO - blobuploader == 1.2.4 19:56:44 INFO - docopt == 0.6.1 19:56:44 INFO - functools32 == 3.2.3-2 19:56:44 INFO - jsonschema == 2.5.1 19:56:44 INFO - manifestparser == 1.1 19:56:44 INFO - mozInstall == 1.12 19:56:44 INFO - mozcrash == 0.17 19:56:44 INFO - mozdebug == 0.1 19:56:44 INFO - mozdevice == 0.48 19:56:44 INFO - mozfile == 1.2 19:56:44 INFO - mozhttpd == 0.7 19:56:44 INFO - mozinfo == 0.9 19:56:44 INFO - mozleak == 0.1 19:56:44 INFO - mozlog == 3.2 19:56:44 INFO - moznetwork == 0.27 19:56:44 INFO - mozprocess == 0.23 19:56:44 INFO - mozprofile == 0.28 19:56:44 INFO - mozrunner == 6.12 19:56:44 INFO - mozscreenshot == 0.1 19:56:44 INFO - mozsystemmonitor == 0.3 19:56:44 INFO - moztest == 0.7 19:56:44 INFO - mozversion == 1.4 19:56:44 INFO - psutil == 3.1.1 19:56:44 INFO - requests == 1.2.3 19:56:44 INFO - wsgiref == 0.1.2 19:56:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:44 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')]} 19:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:44 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')]} 19:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x108d14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108da9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e15adff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c78d30>, '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 0x1089dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c70b20>, '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.khEFlxFL2x/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.B6c2iqKpLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 19:56:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 19:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 19:56:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khEFlxFL2x/Render', 19:56:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:44 INFO - 'HOME': '/Users/cltbld', 19:56:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:44 INFO - 'LOGNAME': 'cltbld', 19:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:44 INFO - 'MOZ_NO_REMOTE': '1', 19:56:44 INFO - 'NO_EM_RESTART': '1', 19:56:44 INFO - 'PAGER': '/bin/cat', 19:56:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:44 INFO - 'PWD': '/builds/slave/test', 19:56:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:44 INFO - 'SHELL': '/bin/bash', 19:56:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6c2iqKpLp/Listeners', 19:56:44 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 19:56:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:44 INFO - 'USER': 'cltbld', 19:56:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:44 INFO - 'XPC_FLAGS': '0x0', 19:56:44 INFO - 'XPC_SERVICE_NAME': '0', 19:56:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:56:44 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 2)) 19:56:44 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 3)) 19:56:44 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 4)) 19:56:44 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 5)) 19:56:44 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 6)) 19:56:44 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 7)) 19:56:44 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 8)) 19:56:44 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 9)) 19:56:44 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:56:44 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 4)) 19:56:44 INFO - Cleaning up... 19:56:44 INFO - Return code: 0 19:56:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:56:44 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')]} 19:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:44 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')]} 19:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108d14a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108da9618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8e15adff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c78d30>, '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 0x1089dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c70b20>, '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.khEFlxFL2x/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.B6c2iqKpLp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 19:56:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 19:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 19:56:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khEFlxFL2x/Render', 19:56:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:56:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:56:44 INFO - 'HOME': '/Users/cltbld', 19:56:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:56:44 INFO - 'LOGNAME': 'cltbld', 19:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:44 INFO - 'MOZ_NO_REMOTE': '1', 19:56:44 INFO - 'NO_EM_RESTART': '1', 19:56:44 INFO - 'PAGER': '/bin/cat', 19:56:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:44 INFO - 'PWD': '/builds/slave/test', 19:56:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:56:44 INFO - 'SHELL': '/bin/bash', 19:56:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6c2iqKpLp/Listeners', 19:56:44 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 19:56:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:56:44 INFO - 'USER': 'cltbld', 19:56:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:56:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:44 INFO - 'XPC_FLAGS': '0x0', 19:56:44 INFO - 'XPC_SERVICE_NAME': '0', 19:56:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:56:44 INFO - Cleaning up... 19:56:44 INFO - Return code: 0 19:56:44 INFO - Running post-action listener: _resource_record_post_action 19:56:44 INFO - Running post-action listener: _start_resource_monitoring 19:56:44 INFO - Starting resource monitoring. 19:56:44 INFO - ##### 19:56:44 INFO - ##### Finished create-virtualenv step (success) 19:56:44 INFO - ##### 19:56:44 INFO - ##### 19:56:44 INFO - ##### Running install step. 19:56:44 INFO - ##### 19:56:44 INFO - Running pre-action listener: _resource_record_pre_action 19:56:44 INFO - Running main action method: install 19:56:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:45 INFO - Reading from file tmpfile_stdout 19:56:45 INFO - Detecting whether we're running mozinstall >=1.0... 19:56:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:56:45 INFO - Reading from file tmpfile_stdout 19:56:45 INFO - Output received: 19:56:45 INFO - Usage: mozinstall [options] installer 19:56:45 INFO - Options: 19:56:45 INFO - -h, --help show this help message and exit 19:56:45 INFO - -d DEST, --destination=DEST 19:56:45 INFO - Directory to install application into. [default: 19:56:45 INFO - "/builds/slave/test"] 19:56:45 INFO - --app=APP Application being installed. [default: firefox] 19:56:45 INFO - mkdir: /builds/slave/test/build/application 19:56:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:57:19 INFO - Reading from file tmpfile_stdout 19:57:19 INFO - Output received: 19:57:19 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 19:57:19 INFO - Running post-action listener: _resource_record_post_action 19:57:19 INFO - ##### 19:57:19 INFO - ##### Finished install step (success) 19:57:19 INFO - ##### 19:57:19 INFO - ##### 19:57:19 INFO - ##### Running run-tests step. 19:57:19 INFO - ##### 19:57:19 INFO - Running pre-action listener: _resource_record_pre_action 19:57:19 INFO - Running main action method: run_tests 19:57:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:57:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:57:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:57:19 INFO - 2016-07-31 19:57:19.308 screenresolution[1637:7542] starting screenresolution argv=screenresolution get 19:57:19 INFO - 2016-07-31 19:57:19.310 screenresolution[1637:7542] Display 0: 1600x1200x32@60 19:57:19 INFO - 2016-07-31 19:57:19.316 screenresolution[1638:7544] starting screenresolution argv=screenresolution list 19:57:19 INFO - Available Modes on Display 0 19:57:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:57:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:57:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:57:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:57:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:57:19 INFO - Intel Iris: 19:57:19 INFO - Chipset Model: Intel Iris 19:57:19 INFO - Type: GPU 19:57:19 INFO - Bus: Built-In 19:57:19 INFO - VRAM (Dynamic, Max): 1536 MB 19:57:19 INFO - Vendor: Intel (0x8086) 19:57:19 INFO - Device ID: 0x0a2e 19:57:19 INFO - Revision ID: 0x0009 19:57:19 INFO - Displays: 19:57:19 INFO - Display: 19:57:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:57:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:57:19 INFO - Display Serial Number: 1600x1200 60 19:57:19 INFO - Main Display: Yes 19:57:19 INFO - Mirror: Off 19:57:19 INFO - Online: Yes 19:57:19 INFO - Rotation: Supported 19:57:19 INFO - Return code: 0 19:57:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:57:19 INFO - Python 2.7.3 19:57:19 INFO - Return code: 0 19:57:19 INFO - grabbing minidump binary from tooltool 19:57: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')]} 19:57:19 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c78d30>, '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 0x1089dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108c70b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:57:19 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 19:57:19 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 19:57:19 INFO - Calling ['/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'] with output_timeout 600 19:57:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:57:19 INFO - Return code: 0 19:57:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:57:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:57:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:57:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:57:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:57:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:57:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.khEFlxFL2x/Render', 19:57:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:57:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:57:19 INFO - 'HOME': '/Users/cltbld', 19:57:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:57:19 INFO - 'LOGNAME': 'cltbld', 19:57:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:57:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:19 INFO - 'MOZ_NO_REMOTE': '1', 19:57:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:57:19 INFO - 'NO_EM_RESTART': '1', 19:57:19 INFO - 'PAGER': '/bin/cat', 19:57:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:19 INFO - 'PWD': '/builds/slave/test', 19:57:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:57:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:57:19 INFO - 'SHELL': '/bin/bash', 19:57:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.B6c2iqKpLp/Listeners', 19:57:19 INFO - 'TMPDIR': '/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/', 19:57:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:57:19 INFO - 'USER': 'cltbld', 19:57:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:57:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:19 INFO - 'XPC_FLAGS': '0x0', 19:57:19 INFO - 'XPC_SERVICE_NAME': '0', 19:57:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:57:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:57:19 INFO - mozversion application_buildid: 20160708030201 19:57:19 INFO - mozversion application_changeset: 45682df2d2d45e5a8385fd842579e661a4b60bc5 19:57:19 INFO - mozversion application_display_name: Nightly 19:57:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:57:19 INFO - mozversion application_name: Firefox 19:57:19 INFO - mozversion application_remotingname: firefox 19:57:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:57:19 INFO - mozversion application_vendor: Mozilla 19:57:19 INFO - mozversion application_version: 50.0a1 19:57:19 INFO - mozversion platform_buildid: 20160708030201 19:57:19 INFO - mozversion platform_changeset: 45682df2d2d45e5a8385fd842579e661a4b60bc5 19:57:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:57:19 INFO - mozversion platform_version: 50.0a1 19:57:19 INFO - using testdate: 1470020239 19:57:19 INFO - actual date: 1470020239 19:57:19 INFO - starting webserver on 'localhost:49267' 19:57:19 INFO - SUITE-START | Running 2 tests 19:57:19 INFO - TEST-START | dromaeo_css 19:57:19 INFO - operating with platform_type : mac_ 19:57:19 INFO - Initialising browser for dromaeo_css test... 19:57:19 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpCcB62c/profile http://localhost:49267/getInfo.html) 19:57:22 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 19:57:22 INFO - PROCESS | 1648 | colorDepth:24 19:57:22 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 19:57:22 INFO - PROCESS | 1648 | __metrics 19:57:22 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:57:22 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:57:23 INFO - TEST-INFO | 1648: exit 0 19:57:23 INFO - Browser initialized. 19:57:23 INFO - Running cycle 1/1 for dromaeo_css test... 19:57:23 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpCcB62c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:57:35 INFO - PROCESS | 1651 | RSS: Main: 243609600 19:57:35 INFO - PROCESS | 1651 | 19:58:26 INFO - PROCESS | 1651 | 1470020306783 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] 20:00:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 20:00:39 INFO - PROCESS | 1651 | RSS: Main: 372719616 20:00:39 INFO - PROCESS | 1651 | 20:03:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 20:03:43 INFO - PROCESS | 1651 | RSS: Main: 381005824 20:03:43 INFO - PROCESS | 1651 | 20:06:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 20:06:46 INFO - PROCESS | 1651 | RSS: Main: 371437568 20:06:46 INFO - PROCESS | 1651 | 20:09:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 20:09:49 INFO - PROCESS | 1651 | RSS: Main: 369913856 20:09:49 INFO - PROCESS | 1651 | 20:12:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 20:12:53 INFO - PROCESS | 1651 | RSS: Main: 336097280 20:12:53 INFO - PROCESS | 1651 | 20:15:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 20:15:56 INFO - PROCESS | 1651 | RSS: Main: 434364416 20:15:56 INFO - PROCESS | 1651 | 20:15:56 INFO - PROCESS | 1651 | __start_tp_report 20:15:56 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 20:15:56 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 20:15:56 INFO - PROCESS | 1651 | |i|pagename|runs| 20:15:56 INFO - PROCESS | 1651 | |0;dojo.html;3035.2563621912636;3278.1968417737644;3349.363620912028;3359.47928071149;3363.1255873472905;5535.142052981784;5623.887522249553;5649.180868774025;5769.913451298234;5811.7384717687755;5641.605087643867;5711.971440142804;5780.132980052994;5810.15752715857;5839.270091238595;4502.57225563571;4769.666123371366;5136.460671629481;5213.687178769267;5291.86770330741;5325.068113080215;5339.866503337409;5358.2498450217;5368.8389348319615;5396.082665946798;5147.794088236466;5195.584353251731;5202.869928251824;5277;5277.6305658603915;5036.949630503685;5161.148410512261;5242.082635538765;5257.948410317914;5266.183741520071;5127.6154288428515;5141.048905952373;5180.171172612364;5184.066867963765;5283.28675628789;5698;5793.65238085712;5802.187693722883;5806.912896306559;5827.766889324422;6043.879122417571;6089.5993921397885;6107.765388666977;6250.874982500324;6274.309825919146;6174.104754810527;6213.782517611907;6236.656983865885;6297.244330680302;6317.052442133717;5874.089516125007;5883.70581470929;5884.558658100659;5887.911681324784;5906;6121.5139442231075;6207.689615519206;6266.874662506724;6302.968485157637;6304.810855674337;6115.635867915819;6184.628922264678;6192.535559833031;6199.690015499207;6220.626762394271;6287.308396076428;6289.056641503811;6294.118823364733;6305.716242769086;6308.779192728232;6033.155358249848;6084.209052823105;6093.6554992613665;6214;6248.5313601480075;6121.081837724377;6173.043178307369;6173.660448675366;6229.688515574203;6261.123442718023;4954.925676114861;4966.577840883565;4968.105740966661;4973.229149481836;4997.350344455271;4418.160549495586;4430.246858034142;4466.062126953376;4473.261911784584;4479.865604031885;5567.8886422272135;5630.127330263816;5647.29408823897;5654.293213348332;5672.376038635747;5934.376890426443;6002.789902353396;6195.938040619536;6234.407731265523;6269.843253918597;5355.892882142335;5411.080116380225;5453.372862120907;5458.235846981426;5492.945070549244;5228.6339956203465;5256.185291279858;5261.631685782035;5265.76304066318;5306.018386598492;6162.753489860355;6204.410580994799;6215.440610345091;6230.190075290183;6245.656488892972;6153.4154255345675;6323.494120470259;6328.0824280478155;6329.778457753957;6361.45927596141;6250.624962502083;6286.717097730521;6326.557141000086;6337.683115844282;6436.388543088399;5911.674857882857;6029.457348838626;6107.188815080279;6125;6130.877382452415;6288.842778930563;6310.873782524232;6328.6202827830475;6330.841728956629;6333.8733225336155;6092.390760923872;6150.323464419;6167.660778657038;6185.567010309235;6190.938090619216;4976.825811096594;5898.675572843535;6059;6116.847078823065;6129.938700612936;5967.880642387215;5984.341722410444;5984.491318237999;5987.610805297816;5993.910091348546;5808.82573522795;6090.9949858272885;6121.0206366981065;6138.355472675305;6143.877122457437;5759.798407055733;5836.678982655994;5887.205227294432;5906.232189815297;5979.162917191509 20:15:56 INFO - PROCESS | 1651 | |1;ext.html;465.8928446457315;509.9949000509995;523.2177894048398;532.2362409941734;555.4612026334454;30803;32679;32693;32711.50932736011;32754.508682369782;33327.00018999428;42391.57608423915;42765.358519622234;43387.6983690489;45935.851603709925;9746.17157541608;9920.851187232198;9927.2058235341;9934.403935763841;9953.751156221117;7572.886406703904;9798.265130115235;9900.059494348025;9916.355436896614;9922.007799220093;8757.25563327118;11958.0433565315;12169.965552928012;12196.63410097694;12366.505339786398;12159.635210943687;12236.63290101294;12242.938785306105;12247.203931744498;12258.44836982338;8801.911980880173;11662.650120496399;12005.879941200563;12093.939530302292;12105.636830895088;39497.21005579872;41800.79099604513;41934.79032604848;41967.58032419698;42036.36945445821;3437.6218615952225;3605.3330133925306;4237.0466645004935;4245.172191422674;4398.120375924796;31072.689273107204;32191.83904080488;33295.83464578728;33306.00081997544;33350.33299334024;2950.7491863191653;3287.208471383102;3370.0563842123997;3453.568303962005;3466.843992020365;537746.8013939383;542775;543243;544056;544575;63353.36646633567;63756;63906;63914;63977.36022639714;66177.00734488986;66366.33633663699;66381.6723665524;66441.00338494926;66486;14779.778303325458;16432.589185270463;16689.33242670304;16689.91655041717;16714.91642541804;11490.94254528722;11784.057275418118;11791;11795.469203885847;12542.1847579907;7692.423068269902;7868.842623147505;14435.48862430745;18320;18953.147108380155;8026.518408895485;8239.382046346547;8245.711400100967;8300;8315.584220788936;861.7759382560579;879.6613303878053;1018.2108865629197;1056.0884798514712;1083.5480456188745;27382.589261161098;30960.0711978641;31189.220269493446;31320.21699457532;32043.679563204536;1088.1186239146316;1092.7213560542011;1112.3659514076899;1190.7142285851332;1225.4301749686438;16420.589485262964;16970.151492425328;17024.914875425544;17134.914325428294;17202.483925482255;703984;706400;710003;712184;714421;60327.69836150791;60554;60846.39153608407;60930.0860487093;61311.38688613146;1267.157340368663;1300.5058077930514;1388.4238041213187;1408.0917808013978;1440.107133577189;27549;30007.849960750056;31145.508359331652;31248.531272030483;32085.197870053435;49499.752501237264;50545.24182137197;50722;50736.49263507318;50776.730581735756;586900;591213.0439347947;592689;593476.2609495744;593767;23019.65470517977;25644.615330770426;25995.360649508704;26138.86930565335;26293.73706262913;45778.77110614425;46473.605791826296;46717.76641116773;46980;47269.81825454391;38699.41950870683;38798.6120138795;38972.6102738969;39008.609913900495;39672.20655586814;37878.62121378751;37912;38355;38575.61424385833;39324.803375982934;29557.408851823275;37182.256354873294;38127.85616431511;38180.23639527249;38208.80895595504;32662;32819.68721251219;33374;33414.111333736466;33760;25255.242342729747;25354.36614084589;25579;25752.484950301263;25961.350966225997 20:15:56 INFO - PROCESS | 1651 | |2;jquery.html;359.55056179775283;373.6338388379388;375.68630193788186;381.5159031367979;393.8365578285012;15749.448769293078;16069.276882540284;20405.693914591273;20554.48613784656;20957.48510178777;20995.370138895818;21147.57704845906;21374.89312553439;21414.464638384048;22038.008289626967;5553.888922221553;5883.323417806942;5947.821565353035;6111.633302001894;6145.723442445101;6066.726997285133;6095.573309868311;6150;6156.353582873801;6174.598651087687;5880.852978675546;5930.822075337746;6019;6024.006039003559;6096.695165241742;5922.496587790043;5983.85040373992;6012.909806352886;6014.909776353358;6015.789447369321;5119.308893299394;5220.895582088337;5262.789488420459;5263.710495922723;5265.86835329116;26559.601605975924;26848.79180436885;26882.865585671945;27225.45549089027;27619.86190069057;2421.370443684637;2650.8011899107646;3170.5537549819187;3180.8886688965777;3284.6222684391364;15509.5347139586;15809.683806323808;16375.017498949983;16429.83570164295;16789.908655937325;1549.6513284511007;1695.7965044194775;1799.9560255052038;1908.3225454963426;1955.0811118774295;79101;80844;87958;99097;113779.43110284478;8822.911770882209;11214.943925280484;11242;11265.605703800327;11335.886641133648;13762.449502019806;13899.374528146056;13915.791263131061;13929.930350348184;13946.86053139476;8432.198941100585;8493.915060849313;8609.82780344402;8699.913000870038;8735.725695236706;7547.339585291227;8561.458937391204;8828.602712877935;8929.821403571892;8965.372423930263;5815.680137592389;6646.6676666166495;6680.131582894192;6799.558028728117;6830.385265326145;1815.4735126813341;1827.7075667893073;1870.6165236126562;1880.1915176473974;1902.9714554281697;389.5987133252754;399.7321794397761;865.6840253307623;917.7705573606598;978.8335982882927;9961.601535938626;11758.941205293919;12113.273203607812;12279.324637144864;12310.692232694255;401.17358242021527;429.5661382004198;431.49515067370623;435.1862018026311;437.26757680885027;6114.205153330038;6202.069689546604;6277.466415354746;6305.306416294204;6315.368463153648;595822;616782;636285;643474;644000;91651;103685.44471832928;126946;129265;131382.34308828585;413.3489753637972;449.16679559417463;449.802087081683;449.88303041208866;450.3762289229441;9956.253281003808;11428.371439570903;11443.828342574701;11717.238379505305;11816.350100744541;54413.639659007255;54449.63875903134;54476.39286795969;56748;57346.13980790208;76611.4677706454;78222;79130;82476.76284855852;82535.7619635694;8339.416240863082;8341.20758527939;8379.874301885598;8419.789505262417;8433.650615901672;9355.298352623717;12835.486580536674;12842.935785321388;13572.93213533926;13620.455181793013;11047.281926674741;11442.256253343507;11565.421728913689;11614;11716.882831171579;11441.313521188755;11713.355765432983;11717.589884354007;11759.882401175879;11880.168388212742;11957;11978.76042479163;12007.579734709243;12107.213031152947;12140.575079872162;8374;8381.706640267561;8504.489730616182;8544.786380340542;8774.868376974478;10467.476626168813;11680.824787628022;11930.701732456759;11949.462274197856;12028.458719357475 20:15:56 INFO - PROCESS | 1651 | |3;mootools.html;1567.9294431750573;1596.3614554178328;1828.0950929290004;1940.640981418437;1955.7848636649967;7721.652525636346;8695.608697608606;8974.416662916907;9150.90849091509;9159.725208243746;7623.809404764884;7914.24814642608;7955.607768640493;8770.51762153083;8944.150305720963;2353.7057867766484;2387.3792813868345;2388.164142550102;2392.294273189413;2392.35406440261;2173.8913154291345;2254;2365.219477572397;2368.2421625079983;2398.46034642205;1846.4645252876649;2023.9392818215476;2089.8223650989607;2153.4723992621753;2162.50262439639;2279.5782780185637;2350.2831636350907;2351.3886389538757;2365.73976862545;2366.6568347589673;1757.5693954981111;2328.580855446019;2359.7050368703913;2363.3382652857053;2370.2415227127326;8970.50662213578;9032.8645070324;9054.320925930515;9056.275497960214;9067.591958361889;5204.68771873685;5425.945740542584;5428.972855135738;5441.863953401157;5445.50990410865;3556.4309710446464;3679.797611131387;3703.666669999713;3703.759255648374;3721.8511259549855;1058.6185028537755;1094.4199574225672;1113.3542545323692;1116.6315116011697;1117.3742704085657;11981.820272695917;12052.276863388224;12079.214851034654;12080.577179798665;12095.697607559794;4518.593326600556;4660.347551342815;4801.879953001203;4834.20235661119;4841.080194762983;10042.648507302356;10091.091801737879;10110.039546243095;10111.696649100539;10135.797284054424;5401.162819762943;5402.486763757437;5407.486288802557;5425.430329815392;5425.755840987165;4368.27923392643;4531.161735079021;4735.502772208937;4922.532359425849;4933.901321973541;3956.1098752780395;3957.08986933007;4067.8169482373364;4085.6935729820384;4122.628963393249;1287.6394609509352;1297.7411910446851;1299.5061876487064;1310.652677040585;1312.3503865586595;662.6752891083335;828.9088200297963;886.5389997201419;889.6619284671913;974.6491263145263;6158.230221222348;6203.31763506014;6255.468285195719;6292.528060395489;6374.681265936684;956.8947415784259;976.8778902637171;995.4127065031666;1018.6231094494937;1030.7991190263408;3977.5226972763453;4161.271777438997;4169.520505141887;4175.269327867611;4240.236757383639;9823.557939892722;10693.465326733633;11185.776284474265;11195.44022798873;11240.707318658458;9913.553890074963;11117.110631149488;11146.386948717736;11153.330800152016;11163.218574699855;5953.851153721192;8217.876731849026;8228.21831925966;8289.088200297962;8469.618867150994;5971.402859713994;6047.455728984412;6140.140380346666;6207.596506227081;6238.344973777688;10090.821391261728;10097;10160.593576256866;10269.281150319406;10433.791324173626;10164.542595583365;10461.372317660966;10505;10537.209709271681;10583.682489525327;7710.344620707078;7821.256980586835;7853.489523180975;7885.2114788520685;7902.4863383879865;8391.622376993171;8446.239838414573;8446.324294056338;8473;8473.406861519881;6309.747610095545;6424.935750642434;7649.31156195945;7676.501027433199;7756.883646745417;7485.962570187115;7486.775396738107;7582.090149182133;7636.579988100708;7645.235476452311;7144.142702875481;7166.498345115792;7205.7838264852135;7223.494355395072;7225.277472252733;5190.40310364313;5196.32447781786;5215.217717342429;5231.3199284092825;5315.01672190646;5181.663191892515;5252.632315737862;5276.261323414802;5285.5243028126115;5420.241166236651 20:15:56 INFO - PROCESS | 1651 | |4;prototype.html;276.34644066782056;289.882597547993;294.4097085343886;302.5084238113066;305.2734491909256;3960.485136932198;4896.853094407169;5345.679259244448;5359.330083739533;5397.352317721869;4072.6131017553357;5019.824306149286;5241.633085684004;5316.441773613773;5359.810912507052;3624.275144971003;4053.9257096869205;4079.673626109904;4089.631933126018;4097.262492751303;3196.5205219217073;3467.323871844991;3722.4044152935535;4110.095778928646;4118.279301122307;3779.848806047755;3858.1704933439446;3990.1221731219084;4051.4733084699096;4069.9593004070025;3631.981840090809;3874.9612503874882;4016.2168377166463;4021.919561608781;4049.959500405017;2828.37775689348;3212.100611828668;3255.4953982132806;3358.4886800939676;3537.8678822776724;4360.825566977317;4631.58315751584;4785.444730462614;5001.748863238888;5196.53231209193;4606.6870941781435;4627.490975992638;4632;4644.233701439259;4662.860114196579;4869.634777391674;5350.197470379435;5577.247071645357;5585.692786896719;5648.774049038034;3107.3996891600846;3905.8632947846972;3923.588023257574;3933.4689816874643;3946.4474973503734;4816.05083831255;5830.504407125357;5835.949529084805;5839.270091238595;5862.325832529271;3477.7217822574135;3567.928641427157;3864.091938394475;3982.542007669097;3984.5019372578427;3318.9170270742943;3701.3152566775234;3839.040239940015;4053.108316170438;4066.4510291110914;3599.3521166190335;4612.423447069116;4630.3748993886065;4636.588973733639;4661.743604101739;5529.368836193333;5545.168224766237;5556.6943818089585;5575.526080283222;5577;1261.4323554400557;1355.5729945067271;1376.204053709898;1376.8141300924447;1377.8346598408255;731.334485618085;848.7029539661193;899.4917871402637;899.8650202469682;909.940853844498;4375.671824613167;5037.740564858712;5096.362954630671;5152;5153.613478989091;4747.786349614275;5026.29631851541;5564.803567233064;5626.578006649518;5638;4301.763403012802;4791.95208047922;4871.391076115486;5034.194528875362;5125.256837758504;2289.6719902456534;2829.957550636742;2888.8844446221915;2986.3728616990243;3009.714077162666;4952.984638149171;5323.547498462674;5354.277172581729;5920.763169473259;5963.7912673056235;5563.969151259761;5844.795432159939;5859.707014649336;5985.22192115031;6011.909821352683;5984.730687119003;6023.608465449732;6028.758849646053;6044.9395506044375;6055.39532024014;5540.69526176048;5783.852371389383;5800.883982320414;5812.273465816773;5833.649981001154;5702.287214098238;5705.942940570707;5728.885422291614;5736.368999410145;5759.531319513498;4938.259261110862;5433.239346491573;5741.483266506035;6032.245969253843;6041.69791510414;3487.0062032320666;3772.43413487979;4046.251443482965;4059.512858457004;4071.0026043619505;4970.502949705001;5253.632245742761;5275.7362131894015;5716.742746576498;5749.396313387034;4608.5161058088415;5446.428125046971;5507.421720719267;5554.527865131509;5643.915341269966;4317.654587632919;4440.622547083534;5597.63615365;5626.184203290418;5639.830805075854;4303.235673373902;4787.850915780118;4884.438289596742;5220;5513.228148059355;4667.183242932405;5589.55283577321;5637.774489020558;5640.210370548209;5659.26429564154;5145.703337712902;5503.936023991004;5517.44825517445;5517.779288828402;5519.862003449946 20:15:56 INFO - PROCESS | 1651 | |5;yui.html;742.7363286033457;768.9423293253008;778.7741554949065;849.3672214200418;850.6044689219514;17530;18255.54361140972;18266.634667306647;18329.17518711658;18344.81655183448;14902.031367961075;16059.518214453556;16141.112238826889;16145.354185832553;16268.186590670479;817.9222973817477;925.0980294213122;926.0785518409192;928.424376886328;929.1498279074639;705.5872314695883;732;732.4177279063158;734.4014628078125;735.6138027535533;930.1953809954374;962.5379817687514;963.7590602349412;964.9035096490366;972.533184071646;956.9760755981087;962.8748262725836;963.8457846744487;964.2045312617049;965.0783501755876;559.3930585314938;680.73451353972;696.7491702986921;717.4368121025022;718.5365439291628;15773;15812.525624231292;15817.288222030036;15835.20823958809;15836.20818959059;12040.096992725494;13912.37394317248;14194.929025354808;14313.141211527342;14347.497837575635;12135.089868259827;13021.218726876417;13338.066335356529;13439;13531.32343382827;4584.587387135174;4628.907421851578;4679.916515048598;4718.528147185254;4756.191447453941;121742;124602.37698811539;125482;127676.36161819224;127856.99999999907;10937.179711521667;11046.613368532224;11158.247584186563;11195;11376.601818936297;22059;22199.22302719397;22269.777302227096;22286.665700014513;22294.9934505892;7960.920390796134;8007.959960200162;8028.11690714021;8099.14958929304;8165.305948994402;4422.668299877522;4499.752513611783;4543.204939135638;4674.69614475058;4724.385829842167;3583.229605634801;3716.9814150929615;3719.6466335698065;3722;3723.6090210528046;693.4591019005184;695.9234484206734;697.6825544377297;699.7445932234799;704.0671110778239;657.3722095398882;661.9871596457427;673.8584897171551;685.8491131950963;693.8716337477482;9106;9403.34176607631;9600.477338836017;9715.951420242853;9996.950015249877;671.4359937652396;685.2325395557008;695.9756408525677;704.225352112672;704.2957042957042;4695.765211739467;4743.217369134123;4752.477227504972;4765.11845308619;4791.353167322437;85494.57252713821;91291;118506;149862.25068874584;150550;99038;107147.46426267819;132367.33816330857;132674.67325326815;133303;101508;111569.44215279035;111960.4401977985;114976;115065.4246728761;9838.950805245928;10150.086492215736;10153.84769228477;10170.389776613427;10193.643222487177;66040;66692.33307666861;66716;68382.65808670924;68791;58889.4111058901;69613.65193174002;76800.27849611916;98850.5057474708;102590.48704756428;13436.596902092953;13743.450261989408;13915.095518791246;13964.790528141883;14373.568792936228;15089.04823924487;15400.306986185873;15536.378544858531;15620.218989050729;15906.52280431589;14275.500357487437;14339.354729037426;14415;14552.563423097325;14809.889258305455;14195.858041419453;14364.28178591087;14882.330295136528;15015;15049.398024078915;11225.326480411202;13970.580882573133;14186.645333866736;14223.644408889446;14799.778003330173;11398.20212585111;11485.310881347146;11580.710482237675;11614.941925290319;11690.357030363071;10998.34009959405;11502.309861408343;11612.5354985803;11772.646820595053;11783.646490605295 20:15:56 INFO - PROCESS | 1651 | __end_tp_report 20:15:56 INFO - PROCESS | 1651 | __start_cc_report 20:15:56 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1331 20:15:56 INFO - PROCESS | 1651 | __end_cc_report 20:15:56 INFO - PROCESS | 1651 | __startTimestamp1470021356429__endTimestamp 20:15:56 INFO - PROCESS | 1651 | 20:15:56 INFO - PROCESS | 1651 | ------- Summary: start ------- 20:15:56 INFO - PROCESS | 1651 | Number of tests: 6 20:15:56 INFO - PROCESS | 1651 | 20:15:56 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5720.74 Median:5911.67 stddev:654.52 (11.1%) stddev-sans-first:621.70 20:15:56 INFO - PROCESS | 1651 | Values: 3035.3 3278.2 3349.4 3359.5 3363.1 5535.1 5623.9 5649.2 5769.9 5811.7 5641.6 5712.0 5780.1 5810.2 5839.3 4502.6 4769.7 5136.5 5213.7 5291.9 5325.1 5339.9 5358.2 5368.8 5396.1 5147.8 5195.6 5202.9 5277.0 5277.6 5036.9 5161.1 5242.1 5257.9 5266.2 5127.6 5141.0 5180.2 5184.1 5283.3 5698.0 5793.7 5802.2 5806.9 5827.8 6043.9 6089.6 6107.8 6250.9 6274.3 6174.1 6213.8 6236.7 6297.2 6317.1 5874.1 5883.7 5884.6 5887.9 5906.0 6121.5 6207.7 6266.9 6303.0 6304.8 6115.6 6184.6 6192.5 6199.7 6220.6 6287.3 6289.1 6294.1 6305.7 6308.8 6033.2 6084.2 6093.7 6214.0 6248.5 6121.1 6173.0 6173.7 6229.7 6261.1 4954.9 4966.6 4968.1 4973.2 4997.4 4418.2 4430.2 4466.1 4473.3 4479.9 5567.9 5630.1 5647.3 5654.3 5672.4 5934.4 6002.8 6195.9 6234.4 6269.8 5355.9 5411.1 5453.4 5458.2 5492.9 5228.6 5256.2 5261.6 5265.8 5306.0 6162.8 6204.4 6215.4 6230.2 6245.7 6153.4 6323.5 6328.1 6329.8 6361.5 6250.6 6286.7 6326.6 6337.7 6436.4 5911.7 6029.5 6107.2 6125.0 6130.9 6288.8 6310.9 6328.6 6330.8 6333.9 6092.4 6150.3 6167.7 6185.6 6190.9 4976.8 5898.7 6059.0 6116.8 6129.9 5967.9 5984.3 5984.5 5987.6 5993.9 5808.8 6091.0 6121.0 6138.4 6143.9 5759.8 5836.7 5887.2 5906.2 5979.2 20:15:56 INFO - PROCESS | 1651 | 20:15:56 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:74189.67 Median:38019.93 stddev:165626.51 (435.6%) stddev-sans-first:165998.64 20:15:56 INFO - PROCESS | 1651 | Values: 465.9 510.0 523.2 532.2 555.5 30803.0 32679.0 32693.0 32711.5 32754.5 33327.0 42391.6 42765.4 43387.7 45935.9 9746.2 9920.9 9927.2 9934.4 9953.8 7572.9 9798.3 9900.1 9916.4 9922.0 8757.3 11958.0 12170.0 12196.6 12366.5 12159.6 12236.6 12242.9 12247.2 12258.4 8801.9 11662.7 12005.9 12093.9 12105.6 39497.2 41800.8 41934.8 41967.6 42036.4 3437.6 3605.3 4237.0 4245.2 4398.1 31072.7 32191.8 33295.8 33306.0 33350.3 2950.7 3287.2 3370.1 3453.6 3466.8 537746.8 542775.0 543243.0 544056.0 544575.0 63353.4 63756.0 63906.0 63914.0 63977.4 66177.0 66366.3 66381.7 66441.0 66486.0 14779.8 16432.6 16689.3 16689.9 16714.9 11490.9 11784.1 11791.0 11795.5 12542.2 7692.4 7868.8 14435.5 18320.0 18953.1 8026.5 8239.4 8245.7 8300.0 8315.6 861.8 879.7 1018.2 1056.1 1083.5 27382.6 30960.1 31189.2 31320.2 32043.7 1088.1 1092.7 1112.4 1190.7 1225.4 16420.6 16970.2 17024.9 17134.9 17202.5 703984.0 706400.0 710003.0 712184.0 714421.0 60327.7 60554.0 60846.4 60930.1 61311.4 1267.2 1300.5 1388.4 1408.1 1440.1 27549.0 30007.8 31145.5 31248.5 32085.2 49499.8 50545.2 50722.0 50736.5 50776.7 586900.0 591213.0 592689.0 593476.3 593767.0 23019.7 25644.6 25995.4 26138.9 26293.7 45778.8 46473.6 46717.8 46980.0 47269.8 38699.4 38798.6 38972.6 39008.6 39672.2 37878.6 37912.0 38355.0 38575.6 39324.8 29557.4 37182.3 38127.9 38180.2 38208.8 32662.0 32819.7 33374.0 33414.1 33760.0 25255.2 25354.4 25579.0 25752.5 25961.4 20:15:56 INFO - PROCESS | 1651 | 20:15:56 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:34616.86 Median:430.53 stddev:103875.28 (24127.3%) stddev-sans-first:104134.83 20:15:56 INFO - PROCESS | 1651 | Values: 359.6 373.6 375.7 381.5 393.8 15749.4 16069.3 20405.7 20554.5 20957.5 20995.4 21147.6 21374.9 21414.5 22038.0 5553.9 5883.3 5947.8 6111.6 6145.7 6066.7 6095.6 6150.0 6156.4 6174.6 5880.9 5930.8 6019.0 6024.0 6096.7 5922.5 5983.9 6012.9 6014.9 6015.8 5119.3 5220.9 5262.8 5263.7 5265.9 26559.6 26848.8 26882.9 27225.5 27619.9 2421.4 2650.8 3170.6 3180.9 3284.6 15509.5 15809.7 16375.0 16429.8 16789.9 1549.7 1695.8 1800.0 1908.3 1955.1 79101.0 80844.0 87958.0 99097.0 113779.4 8822.9 11214.9 11242.0 11265.6 11335.9 13762.4 13899.4 13915.8 13929.9 13946.9 8432.2 8493.9 8609.8 8699.9 8735.7 7547.3 8561.5 8828.6 8929.8 8965.4 5815.7 6646.7 6680.1 6799.6 6830.4 1815.5 1827.7 1870.6 1880.2 1903.0 389.6 399.7 865.7 917.8 978.8 9961.6 11758.9 12113.3 12279.3 12310.7 401.2 429.6 431.5 435.2 437.3 6114.2 6202.1 6277.5 6305.3 6315.4 595822.0 616782.0 636285.0 643474.0 644000.0 91651.0 103685.4 126946.0 129265.0 131382.3 413.3 449.2 449.8 449.9 450.4 9956.3 11428.4 11443.8 11717.2 11816.4 54413.6 54449.6 54476.4 56748.0 57346.1 76611.5 78222.0 79130.0 82476.8 82535.8 8339.4 8341.2 8379.9 8419.8 8433.7 9355.3 12835.5 12842.9 13572.9 13620.5 11047.3 11442.3 11565.4 11614.0 11716.9 11441.3 11713.4 11717.6 11759.9 11880.2 11957.0 11978.8 12007.6 12107.2 12140.6 8374.0 8381.7 8504.5 8544.8 8774.9 10467.5 11680.8 11930.7 11949.5 12028.5 20:15:56 INFO - PROCESS | 1651 | 20:15:56 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5803.56 Median:4818.04 stddev:3268.81 (67.8%) stddev-sans-first:3262.48 20:15:56 INFO - PROCESS | 1651 | Values: 1567.9 1596.4 1828.1 1940.6 1955.8 7721.7 8695.6 8974.4 9150.9 9159.7 7623.8 7914.2 7955.6 8770.5 8944.2 2353.7 2387.4 2388.2 2392.3 2392.4 2173.9 2254.0 2365.2 2368.2 2398.5 1846.5 2023.9 2089.8 2153.5 2162.5 2279.6 2350.3 2351.4 2365.7 2366.7 1757.6 2328.6 2359.7 2363.3 2370.2 8970.5 9032.9 9054.3 9056.3 9067.6 5204.7 5425.9 5429.0 5441.9 5445.5 3556.4 3679.8 3703.7 3703.8 3721.9 1058.6 1094.4 1113.4 1116.6 1117.4 11981.8 12052.3 12079.2 12080.6 12095.7 4518.6 4660.3 4801.9 4834.2 4841.1 10042.6 10091.1 10110.0 10111.7 10135.8 5401.2 5402.5 5407.5 5425.4 5425.8 4368.3 4531.2 4735.5 4922.5 4933.9 3956.1 3957.1 4067.8 4085.7 4122.6 1287.6 1297.7 1299.5 1310.7 1312.4 662.7 828.9 886.5 889.7 974.6 6158.2 6203.3 6255.5 6292.5 6374.7 956.9 976.9 995.4 1018.6 1030.8 3977.5 4161.3 4169.5 4175.3 4240.2 9823.6 10693.5 11185.8 11195.4 11240.7 9913.6 11117.1 11146.4 11153.3 11163.2 5953.9 8217.9 8228.2 8289.1 8469.6 5971.4 6047.5 6140.1 6207.6 6238.3 10090.8 10097.0 10160.6 10269.3 10433.8 10164.5 10461.4 10505.0 10537.2 10583.7 7710.3 7821.3 7853.5 7885.2 7902.5 8391.6 8446.2 8446.3 8473.0 8473.4 6309.7 6424.9 7649.3 7676.5 7756.9 7486.0 7486.8 7582.1 7636.6 7645.2 7144.1 7166.5 7205.8 7223.5 7225.3 5190.4 5196.3 5215.2 5231.3 5315.0 5181.7 5252.6 5276.3 5285.5 5420.2 20:15:56 INFO - PROCESS | 1651 | 20:15:56 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4474.91 Median:4945.62 stddev:1401.14 (28.3%) stddev-sans-first:1369.18 20:15:56 INFO - PROCESS | 1651 | Values: 276.3 289.9 294.4 302.5 305.3 3960.5 4896.9 5345.7 5359.3 5397.4 4072.6 5019.8 5241.6 5316.4 5359.8 3624.3 4053.9 4079.7 4089.6 4097.3 3196.5 3467.3 3722.4 4110.1 4118.3 3779.8 3858.2 3990.1 4051.5 4070.0 3632.0 3875.0 4016.2 4021.9 4050.0 2828.4 3212.1 3255.5 3358.5 3537.9 4360.8 4631.6 4785.4 5001.7 5196.5 4606.7 4627.5 4632.0 4644.2 4662.9 4869.6 5350.2 5577.2 5585.7 5648.8 3107.4 3905.9 3923.6 3933.5 3946.4 4816.1 5830.5 5835.9 5839.3 5862.3 3477.7 3567.9 3864.1 3982.5 3984.5 3318.9 3701.3 3839.0 4053.1 4066.5 3599.4 4612.4 4630.4 4636.6 4661.7 5529.4 5545.2 5556.7 5575.5 5577.0 1261.4 1355.6 1376.2 1376.8 1377.8 731.3 848.7 899.5 899.9 909.9 4375.7 5037.7 5096.4 5152.0 5153.6 4747.8 5026.3 5564.8 5626.6 5638.0 4301.8 4792.0 4871.4 5034.2 5125.3 2289.7 2830.0 2888.9 2986.4 3009.7 4953.0 5323.5 5354.3 5920.8 5963.8 5564.0 5844.8 5859.7 5985.2 6011.9 5984.7 6023.6 6028.8 6044.9 6055.4 5540.7 5783.9 5800.9 5812.3 5833.6 5702.3 5705.9 5728.9 5736.4 5759.5 4938.3 5433.2 5741.5 6032.2 6041.7 3487.0 3772.4 4046.3 4059.5 4071.0 4970.5 5253.6 5275.7 5716.7 5749.4 4608.5 5446.4 5507.4 5554.5 5643.9 4317.7 4440.6 5597.6 5626.2 5639.8 4303.2 4787.9 4884.4 5220.0 5513.2 4667.2 5589.6 5637.8 5640.2 5659.3 5145.7 5503.9 5517.4 5517.8 5519.9 20:15:56 INFO - PROCESS | 1651 | 20:15:56 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:24531.56 Median:22290.83 stddev:37794.43 (169.6%) stddev-sans-first:37858.25 20:15:56 INFO - PROCESS | 1651 | Values: 742.7 768.9 778.8 849.4 850.6 17530.0 18255.5 18266.6 18329.2 18344.8 14902.0 16059.5 16141.1 16145.4 16268.2 817.9 925.1 926.1 928.4 929.1 705.6 732.0 732.4 734.4 735.6 930.2 962.5 963.8 964.9 972.5 957.0 962.9 963.8 964.2 965.1 559.4 680.7 696.7 717.4 718.5 15773.0 15812.5 15817.3 15835.2 15836.2 12040.1 13912.4 14194.9 14313.1 14347.5 12135.1 13021.2 13338.1 13439.0 13531.3 4584.6 4628.9 4679.9 4718.5 4756.2 121742.0 124602.4 125482.0 127676.4 127857.0 10937.2 11046.6 11158.2 11195.0 11376.6 22059.0 22199.2 22269.8 22286.7 22295.0 7960.9 8008.0 8028.1 8099.1 8165.3 4422.7 4499.8 4543.2 4674.7 4724.4 3583.2 3717.0 3719.6 3722.0 3723.6 693.5 695.9 697.7 699.7 704.1 657.4 662.0 673.9 685.8 693.9 9106.0 9403.3 9600.5 9716.0 9997.0 671.4 685.2 696.0 704.2 704.3 4695.8 4743.2 4752.5 4765.1 4791.4 85494.6 91291.0 118506.0 149862.3 150550.0 99038.0 107147.5 132367.3 132674.7 133303.0 101508.0 111569.4 111960.4 114976.0 115065.4 9839.0 10150.1 10153.8 10170.4 10193.6 66040.0 66692.3 66716.0 68382.7 68791.0 58889.4 69613.7 76800.3 98850.5 102590.5 13436.6 13743.5 13915.1 13964.8 14373.6 15089.0 15400.3 15536.4 15620.2 15906.5 14275.5 14339.4 14415.0 14552.6 14809.9 14195.9 14364.3 14882.3 15015.0 15049.4 11225.3 13970.6 14186.6 14223.6 14799.8 11398.2 11485.3 11580.7 11614.9 11690.4 10998.3 11502.3 11612.5 11772.6 11783.6 20:15:56 INFO - PROCESS | 1651 | -------- Summary: end -------- 20:15:56 INFO - PROCESS | 1651 | 20:15:57 INFO - TEST-INFO | 1651: exit 0 20:15:57 INFO - TEST-OK | dromaeo_css | took 1117138ms 20:15:57 INFO - TEST-START | kraken 20:15:57 INFO - operating with platform_type : mac_ 20:15:57 INFO - Initialising browser for kraken test... 20:15:57 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpvjISeq/profile http://localhost:49267/getInfo.html) 20:15:59 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 20:15:59 INFO - PROCESS | 1660 | colorDepth:24 20:15:59 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 20:15:59 INFO - PROCESS | 1660 | __metrics 20:15:59 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:15:59 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:16:00 INFO - TEST-INFO | 1660: exit 0 20:16:00 INFO - Browser initialized. 20:16:00 INFO - Running cycle 1/1 for kraken test... 20:16:00 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/T/tmpvjISeq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:11 INFO - PROCESS | 1662 | RSS: Main: 243863552 20:16:11 INFO - PROCESS | 1662 | 20:16:14 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 20:16:15 INFO - PROCESS | 1662 | RSS: Main: 293928960 20:16:15 INFO - PROCESS | 1662 | 20:16:18 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 20:16:18 INFO - PROCESS | 1662 | RSS: Main: 304484352 20:16:18 INFO - PROCESS | 1662 | 20:16:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 20:16:22 INFO - PROCESS | 1662 | RSS: Main: 388689920 20:16:22 INFO - PROCESS | 1662 | 20:16:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 20:16:25 INFO - PROCESS | 1662 | RSS: Main: 290099200 20:16:25 INFO - PROCESS | 1662 | 20:16:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:16:28 INFO - PROCESS | 1662 | RSS: Main: 294027264 20:16:28 INFO - PROCESS | 1662 | 20:16:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 20:16:31 INFO - PROCESS | 1662 | RSS: Main: 328929280 20:16:31 INFO - PROCESS | 1662 | 20:16:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 20:16:34 INFO - PROCESS | 1662 | RSS: Main: 332353536 20:16:34 INFO - PROCESS | 1662 | 20:16:37 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 20:16:38 INFO - PROCESS | 1662 | RSS: Main: 329252864 20:16:38 INFO - PROCESS | 1662 | 20:16:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:16:40 INFO - PROCESS | 1662 | RSS: Main: 311549952 20:16:40 INFO - PROCESS | 1662 | 20:16:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:16:43 INFO - PROCESS | 1662 | RSS: Main: 317755392 20:16:43 INFO - PROCESS | 1662 | 20:16:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:16:45 INFO - PROCESS | 1662 | RSS: Main: 315912192 20:16:45 INFO - PROCESS | 1662 | 20:16:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:16:49 INFO - PROCESS | 1662 | RSS: Main: 324927488 20:16:49 INFO - PROCESS | 1662 | 20:16:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:16:52 INFO - PROCESS | 1662 | RSS: Main: 326430720 20:16:52 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 20:16:54 INFO - PROCESS | 1662 | RSS: Main: 369872896 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | __start_tp_report 20:16:54 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 20:16:54 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 20:16:54 INFO - PROCESS | 1662 | |i|pagename|runs| 20:16:54 INFO - PROCESS | 1662 | |0;ai-astar;100;110;111;111;111;111;112;112;111;111 20:16:54 INFO - PROCESS | 1662 | |1;audio-beat-detection;142;108;104;156;108;105;129;108;141;106 20:16:54 INFO - PROCESS | 1662 | |2;audio-dft;184;183;185;184;181;183;180;179;180;182 20:16:54 INFO - PROCESS | 1662 | |3;audio-fft;78;73;57;106;57;57;60;68;83;56 20:16:54 INFO - PROCESS | 1662 | |4;audio-oscillator;85;87;92;69;70;68;96;70;68;124 20:16:54 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;86;83;88;83;86;82;92;130;86;83 20:16:54 INFO - PROCESS | 1662 | |6;imaging-darkroom;92;93;105;149;92;93;93;93;93;92 20:16:54 INFO - PROCESS | 1662 | |7;imaging-desaturate;86;85;86;84;85;84;86;86;85;86 20:16:54 INFO - PROCESS | 1662 | |8;json-parse-financial;55;53;54;54;53;53;53;55;53;53 20:16:54 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;65;73;74;74;72;70;69;70;70;72 20:16:54 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;80;83;83;85;83;79;84;91;102;78 20:16:54 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;139;125;126;122;156;142;156;135;178;137 20:16:54 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;162;164;163;164;160;165;162;162;159;162 20:16:54 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;67;67;68;65;65;65;66;67;65;65 20:16:54 INFO - PROCESS | 1662 | __end_tp_report 20:16:54 INFO - PROCESS | 1662 | __start_cc_report 20:16:54 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2042 20:16:54 INFO - PROCESS | 1662 | __end_cc_report 20:16:54 INFO - PROCESS | 1662 | __startTimestamp1470021414763__endTimestamp 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | ------- Summary: start ------- 20:16:54 INFO - PROCESS | 1662 | Number of tests: 14 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.56 (3.2%) stddev-sans-first:0.60 20:16:54 INFO - PROCESS | 1662 | Values: 100.0 110.0 111.0 111.0 111.0 111.0 112.0 112.0 111.0 111.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:118.50 stddev:19.45 (16.4%) stddev-sans-first:19.05 20:16:54 INFO - PROCESS | 1662 | Values: 142.0 108.0 104.0 156.0 108.0 105.0 129.0 108.0 141.0 106.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:182.10 Median:183.00 stddev:2.02 (1.1%) stddev-sans-first:2.03 20:16:54 INFO - PROCESS | 1662 | Values: 184.0 183.0 185.0 184.0 181.0 183.0 180.0 179.0 180.0 182.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:69.50 Median:64.00 stddev:16.13 (25.2%) stddev-sans-first:16.82 20:16:54 INFO - PROCESS | 1662 | Values: 78.0 73.0 57.0 106.0 57.0 57.0 60.0 68.0 83.0 56.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:77.50 stddev:18.06 (23.3%) stddev-sans-first:19.14 20:16:54 INFO - PROCESS | 1662 | Values: 85.0 87.0 92.0 69.0 70.0 68.0 96.0 70.0 68.0 124.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:89.90 Median:86.00 stddev:14.40 (16.7%) stddev-sans-first:15.21 20:16:54 INFO - PROCESS | 1662 | Values: 86.0 83.0 88.0 83.0 86.0 82.0 92.0 130.0 86.0 83.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:93.00 stddev:17.83 (19.2%) stddev-sans-first:18.70 20:16:54 INFO - PROCESS | 1662 | Values: 92.0 93.0 105.0 149.0 92.0 93.0 93.0 93.0 93.0 92.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 20:16:54 INFO - PROCESS | 1662 | Values: 86.0 85.0 86.0 84.0 85.0 84.0 86.0 86.0 85.0 86.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:0.84 (1.6%) stddev-sans-first:0.73 20:16:54 INFO - PROCESS | 1662 | Values: 55.0 53.0 54.0 54.0 53.0 53.0 53.0 55.0 53.0 53.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:72.00 stddev:2.73 (3.8%) stddev-sans-first:1.88 20:16:54 INFO - PROCESS | 1662 | Values: 65.0 73.0 74.0 74.0 72.0 70.0 69.0 70.0 70.0 72.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.00 stddev:7.05 (8.5%) stddev-sans-first:7.26 20:16:54 INFO - PROCESS | 1662 | Values: 80.0 83.0 83.0 85.0 83.0 79.0 84.0 91.0 102.0 78.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:140.50 stddev:17.37 (12.4%) stddev-sans-first:18.39 20:16:54 INFO - PROCESS | 1662 | Values: 139.0 125.0 126.0 122.0 156.0 142.0 156.0 135.0 178.0 137.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:1.83 (1.1%) stddev-sans-first:1.94 20:16:54 INFO - PROCESS | 1662 | Values: 162.0 164.0 163.0 164.0 160.0 165.0 162.0 162.0 159.0 162.0 20:16:54 INFO - PROCESS | 1662 | 20:16:54 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.15 (1.7%) stddev-sans-first:1.17 20:16:54 INFO - PROCESS | 1662 | Values: 67.0 67.0 68.0 65.0 65.0 65.0 66.0 67.0 65.0 65.0 20:16:54 INFO - PROCESS | 1662 | -------- Summary: end -------- 20:16:54 INFO - PROCESS | 1662 | 20:16:55 INFO - TEST-INFO | 1662: exit 0 20:16:55 INFO - TEST-OK | kraken | took 58575ms 20:16:55 INFO - SUITE-END | took 1175s 20:16:55 INFO - Completed test suite (00:19:36) 20:16:55 INFO - javascript benchmark 20:16:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3035.2563621912636, 3278.1968417737644, 3349.363620912028, 3359.47928071149, 3363.1255873472905, 5535.142052981784, 5623.887522249553, 5649.180868774025, 5769.913451298234, 5811.7384717687755, 5641.605087643867, 5711.971440142804, 5780.132980052994, 5810.15752715857, 5839.270091238595, 4502.57225563571, 4769.666123371366, 5136.460671629481, 5213.687178769267, 5291.86770330741, 5325.068113080215, 5339.866503337409, 5358.2498450217, 5368.8389348319615, 5396.082665946798, 5147.794088236466, 5195.584353251731, 5202.869928251824, 5277.0, 5277.6305658603915, 5036.949630503685, 5161.148410512261, 5242.082635538765, 5257.948410317914, 5266.183741520071, 5127.6154288428515, 5141.048905952373, 5180.171172612364, 5184.066867963765, 5283.28675628789, 5698.0, 5793.65238085712, 5802.187693722883, 5806.912896306559, 5827.766889324422, 6043.879122417571, 6089.5993921397885, 6107.765388666977, 6250.874982500324, 6274.309825919146, 6174.104754810527, 6213.782517611907, 6236.656983865885, 6297.244330680302, 6317.052442133717, 5874.089516125007, 5883.70581470929, 5884.558658100659, 5887.911681324784, 5906.0, 6121.5139442231075, 6207.689615519206, 6266.874662506724, 6302.968485157637, 6304.810855674337, 6115.635867915819, 6184.628922264678, 6192.535559833031, 6199.690015499207, 6220.626762394271, 6287.308396076428, 6289.056641503811, 6294.118823364733, 6305.716242769086, 6308.779192728232, 6033.155358249848, 6084.209052823105, 6093.6554992613665, 6214.0, 6248.5313601480075, 6121.081837724377, 6173.043178307369, 6173.660448675366, 6229.688515574203, 6261.123442718023, 4954.925676114861, 4966.577840883565, 4968.105740966661, 4973.229149481836, 4997.350344455271, 4418.160549495586, 4430.246858034142, 4466.062126953376, 4473.261911784584, 4479.865604031885, 5567.8886422272135, 5630.127330263816, 5647.29408823897, 5654.293213348332, 5672.376038635747, 5934.376890426443, 6002.789902353396, 6195.938040619536, 6234.407731265523, 6269.843253918597, 5355.892882142335, 5411.080116380225, 5453.372862120907, 5458.235846981426, 5492.945070549244, 5228.6339956203465, 5256.185291279858, 5261.631685782035, 5265.76304066318, 5306.018386598492, 6162.753489860355, 6204.410580994799, 6215.440610345091, 6230.190075290183, 6245.656488892972, 6153.4154255345675, 6323.494120470259, 6328.0824280478155, 6329.778457753957, 6361.45927596141, 6250.624962502083, 6286.717097730521, 6326.557141000086, 6337.683115844282, 6436.388543088399, 5911.674857882857, 6029.457348838626, 6107.188815080279, 6125.0, 6130.877382452415, 6288.842778930563, 6310.873782524232, 6328.6202827830475, 6330.841728956629, 6333.8733225336155, 6092.390760923872, 6150.323464419, 6167.660778657038, 6185.567010309235, 6190.938090619216, 4976.825811096594, 5898.675572843535, 6059.0, 6116.847078823065, 6129.938700612936, 5967.880642387215, 5984.341722410444, 5984.491318237999, 5987.610805297816, 5993.910091348546, 5808.82573522795, 6090.9949858272885, 6121.0206366981065, 6138.355472675305, 6143.877122457437, 5759.798407055733, 5836.678982655994, 5887.205227294432, 5906.232189815297, 5979.162917191509], "value": 5677.382110266121, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.8928446457315, 509.9949000509995, 523.2177894048398, 532.2362409941734, 555.4612026334454, 30803.0, 32679.0, 32693.0, 32711.50932736011, 32754.508682369782, 33327.00018999428, 42391.57608423915, 42765.358519622234, 43387.6983690489, 45935.851603709925, 9746.17157541608, 9920.851187232198, 9927.2058235341, 9934.403935763841, 9953.751156221117, 7572.886406703904, 9798.265130115235, 9900.059494348025, 9916.355436896614, 9922.007799220093, 8757.25563327118, 11958.0433565315, 12169.965552928012, 12196.63410097694, 12366.505339786398, 12159.635210943687, 12236.63290101294, 12242.938785306105, 12247.203931744498, 12258.44836982338, 8801.911980880173, 11662.650120496399, 12005.879941200563, 12093.939530302292, 12105.636830895088, 39497.21005579872, 41800.79099604513, 41934.79032604848, 41967.58032419698, 42036.36945445821, 3437.6218615952225, 3605.3330133925306, 4237.0466645004935, 4245.172191422674, 4398.120375924796, 31072.689273107204, 32191.83904080488, 33295.83464578728, 33306.00081997544, 33350.33299334024, 2950.7491863191653, 3287.208471383102, 3370.0563842123997, 3453.568303962005, 3466.843992020365, 537746.8013939383, 542775.0, 543243.0, 544056.0, 544575.0, 63353.36646633567, 63756.0, 63906.0, 63914.0, 63977.36022639714, 66177.00734488986, 66366.33633663699, 66381.6723665524, 66441.00338494926, 66486.0, 14779.778303325458, 16432.589185270463, 16689.33242670304, 16689.91655041717, 16714.91642541804, 11490.94254528722, 11784.057275418118, 11791.0, 11795.469203885847, 12542.1847579907, 7692.423068269902, 7868.842623147505, 14435.48862430745, 18320.0, 18953.147108380155, 8026.518408895485, 8239.382046346547, 8245.711400100967, 8300.0, 8315.584220788936, 861.7759382560579, 879.6613303878053, 1018.2108865629197, 1056.0884798514712, 1083.5480456188745, 27382.589261161098, 30960.0711978641, 31189.220269493446, 31320.21699457532, 32043.679563204536, 1088.1186239146316, 1092.7213560542011, 1112.3659514076899, 1190.7142285851332, 1225.4301749686438, 16420.589485262964, 16970.151492425328, 17024.914875425544, 17134.914325428294, 17202.483925482255, 703984.0, 706400.0, 710003.0, 712184.0, 714421.0, 60327.69836150791, 60554.0, 60846.39153608407, 60930.0860487093, 61311.38688613146, 1267.157340368663, 1300.5058077930514, 1388.4238041213187, 1408.0917808013978, 1440.107133577189, 27549.0, 30007.849960750056, 31145.508359331652, 31248.531272030483, 32085.197870053435, 49499.752501237264, 50545.24182137197, 50722.0, 50736.49263507318, 50776.730581735756, 586900.0, 591213.0439347947, 592689.0, 593476.2609495744, 593767.0, 23019.65470517977, 25644.615330770426, 25995.360649508704, 26138.86930565335, 26293.73706262913, 45778.77110614425, 46473.605791826296, 46717.76641116773, 46980.0, 47269.81825454391, 38699.41950870683, 38798.6120138795, 38972.6102738969, 39008.609913900495, 39672.20655586814, 37878.62121378751, 37912.0, 38355.0, 38575.61424385833, 39324.803375982934, 29557.408851823275, 37182.256354873294, 38127.85616431511, 38180.23639527249, 38208.80895595504, 32662.0, 32819.68721251219, 33374.0, 33414.111333736466, 33760.0, 25255.242342729747, 25354.36614084589, 25579.0, 25752.484950301263, 25961.350966225997], "value": 20451.24301023717, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.55056179775283, 373.6338388379388, 375.68630193788186, 381.5159031367979, 393.8365578285012, 15749.448769293078, 16069.276882540284, 20405.693914591273, 20554.48613784656, 20957.48510178777, 20995.370138895818, 21147.57704845906, 21374.89312553439, 21414.464638384048, 22038.008289626967, 5553.888922221553, 5883.323417806942, 5947.821565353035, 6111.633302001894, 6145.723442445101, 6066.726997285133, 6095.573309868311, 6150.0, 6156.353582873801, 6174.598651087687, 5880.852978675546, 5930.822075337746, 6019.0, 6024.006039003559, 6096.695165241742, 5922.496587790043, 5983.85040373992, 6012.909806352886, 6014.909776353358, 6015.789447369321, 5119.308893299394, 5220.895582088337, 5262.789488420459, 5263.710495922723, 5265.86835329116, 26559.601605975924, 26848.79180436885, 26882.865585671945, 27225.45549089027, 27619.86190069057, 2421.370443684637, 2650.8011899107646, 3170.5537549819187, 3180.8886688965777, 3284.6222684391364, 15509.5347139586, 15809.683806323808, 16375.017498949983, 16429.83570164295, 16789.908655937325, 1549.6513284511007, 1695.7965044194775, 1799.9560255052038, 1908.3225454963426, 1955.0811118774295, 79101.0, 80844.0, 87958.0, 99097.0, 113779.43110284478, 8822.911770882209, 11214.943925280484, 11242.0, 11265.605703800327, 11335.886641133648, 13762.449502019806, 13899.374528146056, 13915.791263131061, 13929.930350348184, 13946.86053139476, 8432.198941100585, 8493.915060849313, 8609.82780344402, 8699.913000870038, 8735.725695236706, 7547.339585291227, 8561.458937391204, 8828.602712877935, 8929.821403571892, 8965.372423930263, 5815.680137592389, 6646.6676666166495, 6680.131582894192, 6799.558028728117, 6830.385265326145, 1815.4735126813341, 1827.7075667893073, 1870.6165236126562, 1880.1915176473974, 1902.9714554281697, 389.5987133252754, 399.7321794397761, 865.6840253307623, 917.7705573606598, 978.8335982882927, 9961.601535938626, 11758.941205293919, 12113.273203607812, 12279.324637144864, 12310.692232694255, 401.17358242021527, 429.5661382004198, 431.49515067370623, 435.1862018026311, 437.26757680885027, 6114.205153330038, 6202.069689546604, 6277.466415354746, 6305.306416294204, 6315.368463153648, 595822.0, 616782.0, 636285.0, 643474.0, 644000.0, 91651.0, 103685.44471832928, 126946.0, 129265.0, 131382.34308828585, 413.3489753637972, 449.16679559417463, 449.802087081683, 449.88303041208866, 450.3762289229441, 9956.253281003808, 11428.371439570903, 11443.828342574701, 11717.238379505305, 11816.350100744541, 54413.639659007255, 54449.63875903134, 54476.39286795969, 56748.0, 57346.13980790208, 76611.4677706454, 78222.0, 79130.0, 82476.76284855852, 82535.7619635694, 8339.416240863082, 8341.20758527939, 8379.874301885598, 8419.789505262417, 8433.650615901672, 9355.298352623717, 12835.486580536674, 12842.935785321388, 13572.93213533926, 13620.455181793013, 11047.281926674741, 11442.256253343507, 11565.421728913689, 11614.0, 11716.882831171579, 11441.313521188755, 11713.355765432983, 11717.589884354007, 11759.882401175879, 11880.168388212742, 11957.0, 11978.76042479163, 12007.579734709243, 12107.213031152947, 12140.575079872162, 8374.0, 8381.706640267561, 8504.489730616182, 8544.786380340542, 8774.868376974478, 10467.476626168813, 11680.824787628022, 11930.701732456759, 11949.462274197856, 12028.458719357475], "value": 8938.053511455437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1567.9294431750573, 1596.3614554178328, 1828.0950929290004, 1940.640981418437, 1955.7848636649967, 7721.652525636346, 8695.608697608606, 8974.416662916907, 9150.90849091509, 9159.725208243746, 7623.809404764884, 7914.24814642608, 7955.607768640493, 8770.51762153083, 8944.150305720963, 2353.7057867766484, 2387.3792813868345, 2388.164142550102, 2392.294273189413, 2392.35406440261, 2173.8913154291345, 2254.0, 2365.219477572397, 2368.2421625079983, 2398.46034642205, 1846.4645252876649, 2023.9392818215476, 2089.8223650989607, 2153.4723992621753, 2162.50262439639, 2279.5782780185637, 2350.2831636350907, 2351.3886389538757, 2365.73976862545, 2366.6568347589673, 1757.5693954981111, 2328.580855446019, 2359.7050368703913, 2363.3382652857053, 2370.2415227127326, 8970.50662213578, 9032.8645070324, 9054.320925930515, 9056.275497960214, 9067.591958361889, 5204.68771873685, 5425.945740542584, 5428.972855135738, 5441.863953401157, 5445.50990410865, 3556.4309710446464, 3679.797611131387, 3703.666669999713, 3703.759255648374, 3721.8511259549855, 1058.6185028537755, 1094.4199574225672, 1113.3542545323692, 1116.6315116011697, 1117.3742704085657, 11981.820272695917, 12052.276863388224, 12079.214851034654, 12080.577179798665, 12095.697607559794, 4518.593326600556, 4660.347551342815, 4801.879953001203, 4834.20235661119, 4841.080194762983, 10042.648507302356, 10091.091801737879, 10110.039546243095, 10111.696649100539, 10135.797284054424, 5401.162819762943, 5402.486763757437, 5407.486288802557, 5425.430329815392, 5425.755840987165, 4368.27923392643, 4531.161735079021, 4735.502772208937, 4922.532359425849, 4933.901321973541, 3956.1098752780395, 3957.08986933007, 4067.8169482373364, 4085.6935729820384, 4122.628963393249, 1287.6394609509352, 1297.7411910446851, 1299.5061876487064, 1310.652677040585, 1312.3503865586595, 662.6752891083335, 828.9088200297963, 886.5389997201419, 889.6619284671913, 974.6491263145263, 6158.230221222348, 6203.31763506014, 6255.468285195719, 6292.528060395489, 6374.681265936684, 956.8947415784259, 976.8778902637171, 995.4127065031666, 1018.6231094494937, 1030.7991190263408, 3977.5226972763453, 4161.271777438997, 4169.520505141887, 4175.269327867611, 4240.236757383639, 9823.557939892722, 10693.465326733633, 11185.776284474265, 11195.44022798873, 11240.707318658458, 9913.553890074963, 11117.110631149488, 11146.386948717736, 11153.330800152016, 11163.218574699855, 5953.851153721192, 8217.876731849026, 8228.21831925966, 8289.088200297962, 8469.618867150994, 5971.402859713994, 6047.455728984412, 6140.140380346666, 6207.596506227081, 6238.344973777688, 10090.821391261728, 10097.0, 10160.593576256866, 10269.281150319406, 10433.791324173626, 10164.542595583365, 10461.372317660966, 10505.0, 10537.209709271681, 10583.682489525327, 7710.344620707078, 7821.256980586835, 7853.489523180975, 7885.2114788520685, 7902.4863383879865, 8391.622376993171, 8446.239838414573, 8446.324294056338, 8473.0, 8473.406861519881, 6309.747610095545, 6424.935750642434, 7649.31156195945, 7676.501027433199, 7756.883646745417, 7485.962570187115, 7486.775396738107, 7582.090149182133, 7636.579988100708, 7645.235476452311, 7144.142702875481, 7166.498345115792, 7205.7838264852135, 7223.494355395072, 7225.277472252733, 5190.40310364313, 5196.32447781786, 5215.217717342429, 5231.3199284092825, 5315.01672190646, 5181.663191892515, 5252.632315737862, 5276.261323414802, 5285.5243028126115, 5420.241166236651], "value": 4652.47412320101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.34644066782056, 289.882597547993, 294.4097085343886, 302.5084238113066, 305.2734491909256, 3960.485136932198, 4896.853094407169, 5345.679259244448, 5359.330083739533, 5397.352317721869, 4072.6131017553357, 5019.824306149286, 5241.633085684004, 5316.441773613773, 5359.810912507052, 3624.275144971003, 4053.9257096869205, 4079.673626109904, 4089.631933126018, 4097.262492751303, 3196.5205219217073, 3467.323871844991, 3722.4044152935535, 4110.095778928646, 4118.279301122307, 3779.848806047755, 3858.1704933439446, 3990.1221731219084, 4051.4733084699096, 4069.9593004070025, 3631.981840090809, 3874.9612503874882, 4016.2168377166463, 4021.919561608781, 4049.959500405017, 2828.37775689348, 3212.100611828668, 3255.4953982132806, 3358.4886800939676, 3537.8678822776724, 4360.825566977317, 4631.58315751584, 4785.444730462614, 5001.748863238888, 5196.53231209193, 4606.6870941781435, 4627.490975992638, 4632.0, 4644.233701439259, 4662.860114196579, 4869.634777391674, 5350.197470379435, 5577.247071645357, 5585.692786896719, 5648.774049038034, 3107.3996891600846, 3905.8632947846972, 3923.588023257574, 3933.4689816874643, 3946.4474973503734, 4816.05083831255, 5830.504407125357, 5835.949529084805, 5839.270091238595, 5862.325832529271, 3477.7217822574135, 3567.928641427157, 3864.091938394475, 3982.542007669097, 3984.5019372578427, 3318.9170270742943, 3701.3152566775234, 3839.040239940015, 4053.108316170438, 4066.4510291110914, 3599.3521166190335, 4612.423447069116, 4630.3748993886065, 4636.588973733639, 4661.743604101739, 5529.368836193333, 5545.168224766237, 5556.6943818089585, 5575.526080283222, 5577.0, 1261.4323554400557, 1355.5729945067271, 1376.204053709898, 1376.8141300924447, 1377.8346598408255, 731.334485618085, 848.7029539661193, 899.4917871402637, 899.8650202469682, 909.940853844498, 4375.671824613167, 5037.740564858712, 5096.362954630671, 5152.0, 5153.613478989091, 4747.786349614275, 5026.29631851541, 5564.803567233064, 5626.578006649518, 5638.0, 4301.763403012802, 4791.95208047922, 4871.391076115486, 5034.194528875362, 5125.256837758504, 2289.6719902456534, 2829.957550636742, 2888.8844446221915, 2986.3728616990243, 3009.714077162666, 4952.984638149171, 5323.547498462674, 5354.277172581729, 5920.763169473259, 5963.7912673056235, 5563.969151259761, 5844.795432159939, 5859.707014649336, 5985.22192115031, 6011.909821352683, 5984.730687119003, 6023.608465449732, 6028.758849646053, 6044.9395506044375, 6055.39532024014, 5540.69526176048, 5783.852371389383, 5800.883982320414, 5812.273465816773, 5833.649981001154, 5702.287214098238, 5705.942940570707, 5728.885422291614, 5736.368999410145, 5759.531319513498, 4938.259261110862, 5433.239346491573, 5741.483266506035, 6032.245969253843, 6041.69791510414, 3487.0062032320666, 3772.43413487979, 4046.251443482965, 4059.512858457004, 4071.0026043619505, 4970.502949705001, 5253.632245742761, 5275.7362131894015, 5716.742746576498, 5749.396313387034, 4608.5161058088415, 5446.428125046971, 5507.421720719267, 5554.527865131509, 5643.915341269966, 4317.654587632919, 4440.622547083534, 5597.63615365, 5626.184203290418, 5639.830805075854, 4303.235673373902, 4787.850915780118, 4884.438289596742, 5220.0, 5513.228148059355, 4667.183242932405, 5589.55283577321, 5637.774489020558, 5640.210370548209, 5659.26429564154, 5145.703337712902, 5503.936023991004, 5517.44825517445, 5517.779288828402, 5519.862003449946], "value": 4029.80603625493, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.7363286033457, 768.9423293253008, 778.7741554949065, 849.3672214200418, 850.6044689219514, 17530.0, 18255.54361140972, 18266.634667306647, 18329.17518711658, 18344.81655183448, 14902.031367961075, 16059.518214453556, 16141.112238826889, 16145.354185832553, 16268.186590670479, 817.9222973817477, 925.0980294213122, 926.0785518409192, 928.424376886328, 929.1498279074639, 705.5872314695883, 732.0, 732.4177279063158, 734.4014628078125, 735.6138027535533, 930.1953809954374, 962.5379817687514, 963.7590602349412, 964.9035096490366, 972.533184071646, 956.9760755981087, 962.8748262725836, 963.8457846744487, 964.2045312617049, 965.0783501755876, 559.3930585314938, 680.73451353972, 696.7491702986921, 717.4368121025022, 718.5365439291628, 15773.0, 15812.525624231292, 15817.288222030036, 15835.20823958809, 15836.20818959059, 12040.096992725494, 13912.37394317248, 14194.929025354808, 14313.141211527342, 14347.497837575635, 12135.089868259827, 13021.218726876417, 13338.066335356529, 13439.0, 13531.32343382827, 4584.587387135174, 4628.907421851578, 4679.916515048598, 4718.528147185254, 4756.191447453941, 121742.0, 124602.37698811539, 125482.0, 127676.36161819224, 127856.99999999907, 10937.179711521667, 11046.613368532224, 11158.247584186563, 11195.0, 11376.601818936297, 22059.0, 22199.22302719397, 22269.777302227096, 22286.665700014513, 22294.9934505892, 7960.920390796134, 8007.959960200162, 8028.11690714021, 8099.14958929304, 8165.305948994402, 4422.668299877522, 4499.752513611783, 4543.204939135638, 4674.69614475058, 4724.385829842167, 3583.229605634801, 3716.9814150929615, 3719.6466335698065, 3722.0, 3723.6090210528046, 693.4591019005184, 695.9234484206734, 697.6825544377297, 699.7445932234799, 704.0671110778239, 657.3722095398882, 661.9871596457427, 673.8584897171551, 685.8491131950963, 693.8716337477482, 9106.0, 9403.34176607631, 9600.477338836017, 9715.951420242853, 9996.950015249877, 671.4359937652396, 685.2325395557008, 695.9756408525677, 704.225352112672, 704.2957042957042, 4695.765211739467, 4743.217369134123, 4752.477227504972, 4765.11845308619, 4791.353167322437, 85494.57252713821, 91291.0, 118506.0, 149862.25068874584, 150550.0, 99038.0, 107147.46426267819, 132367.33816330857, 132674.67325326815, 133303.0, 101508.0, 111569.44215279035, 111960.4401977985, 114976.0, 115065.4246728761, 9838.950805245928, 10150.086492215736, 10153.84769228477, 10170.389776613427, 10193.643222487177, 66040.0, 66692.33307666861, 66716.0, 68382.65808670924, 68791.0, 58889.4111058901, 69613.65193174002, 76800.27849611916, 98850.5057474708, 102590.48704756428, 13436.596902092953, 13743.450261989408, 13915.095518791246, 13964.790528141883, 14373.568792936228, 15089.04823924487, 15400.306986185873, 15536.378544858531, 15620.218989050729, 15906.52280431589, 14275.500357487437, 14339.354729037426, 14415.0, 14552.563423097325, 14809.889258305455, 14195.858041419453, 14364.28178591087, 14882.330295136528, 15015.0, 15049.398024078915, 11225.326480411202, 13970.580882573133, 14186.645333866736, 14223.644408889446, 14799.778003330173, 11398.20212585111, 11485.310881347146, 11580.710482237675, 11614.941925290319, 11690.357030363071, 10998.34009959405, 11502.309861408343, 11612.5354985803, 11772.646820595053, 11783.646490605295], "value": 8133.1523105698425, "unit": "score"}], "name": "dromaeo_css", "value": 7354.684611910556, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 111.0, 111.0, 111.0, 111.0, 112.0, 112.0, 111.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 104.0, 156.0, 108.0, 105.0, 129.0, 108.0, 141.0, 106.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 185.0, 184.0, 181.0, 183.0, 180.0, 179.0, 180.0, 182.0], "value": 182.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 57.0, 106.0, 57.0, 57.0, 60.0, 68.0, 83.0, 56.0], "value": 69.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 92.0, 69.0, 70.0, 68.0, 96.0, 70.0, 68.0, 124.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 88.0, 83.0, 86.0, 82.0, 92.0, 130.0, 86.0, 83.0], "value": 89.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 105.0, 149.0, 92.0, 93.0, 93.0, 93.0, 93.0, 92.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 84.0, 85.0, 84.0, 86.0, 86.0, 85.0, 86.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 53.0, 53.0, 53.0, 55.0, 53.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 74.0, 74.0, 72.0, 70.0, 69.0, 70.0, 70.0, 72.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 83.0, 85.0, 83.0, 79.0, 84.0, 91.0, 102.0, 78.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 125.0, 126.0, 122.0, 156.0, 142.0, 156.0, 135.0, 178.0, 137.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 164.0, 160.0, 165.0, 162.0, 162.0, 159.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 65.0, 65.0, 65.0, 66.0, 67.0, 65.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1419.0999999999997, "alertThreshold": 2.0}]} 20:16:55 INFO - Return code: 0 20:16:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:16:56 INFO - # TBPL SUCCESS # 20:16:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:16:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:16:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:16:56 INFO - 2016-07-31 20:16:56.046 screenresolution[1666:9757] starting screenresolution argv=screenresolution get 20:16:56 INFO - 2016-07-31 20:16:56.049 screenresolution[1666:9757] Display 0: 1600x1200x32@60 20:16:56 INFO - 2016-07-31 20:16:56.055 screenresolution[1667:9761] starting screenresolution argv=screenresolution list 20:16:56 INFO - Available Modes on Display 0 20:16:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:16:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:16:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:16:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:16:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:16:56 INFO - Intel Iris: 20:16:56 INFO - Chipset Model: Intel Iris 20:16:56 INFO - Type: GPU 20:16:56 INFO - Bus: Built-In 20:16:56 INFO - VRAM (Dynamic, Max): 1536 MB 20:16:56 INFO - Vendor: Intel (0x8086) 20:16:56 INFO - Device ID: 0x0a2e 20:16:56 INFO - Revision ID: 0x0009 20:16:56 INFO - Displays: 20:16:56 INFO - Display: 20:16:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:16:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:16:56 INFO - Display Serial Number: 1600x1200 60 20:16:56 INFO - Main Display: Yes 20:16:56 INFO - Mirror: Off 20:16:56 INFO - Online: Yes 20:16:56 INFO - Rotation: Supported 20:16:56 INFO - Return code: 0 20:16:56 INFO - Running post-action listener: _resource_record_post_action 20:16:56 INFO - ##### 20:16:56 INFO - ##### Finished run-tests step (success) 20:16:56 INFO - ##### 20:16:56 INFO - Running post-run listener: _resource_record_post_run 20:16:56 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 38135296; Write bytes: 701768704; Read time: 379; Write time: 1851 20:16:56 INFO - TinderboxPrint: CPU usage
53.4% 20:16:56 INFO - TinderboxPrint: I/O read bytes / time
38,135,296 / 379 20:16:56 INFO - TinderboxPrint: I/O write bytes / time
701,768,704 / 1,851 20:16:56 INFO - TinderboxPrint: CPU idle
2,257.8 (46.6%) 20:16:56 INFO - TinderboxPrint: CPU system
965.4 (19.9%) 20:16:56 INFO - TinderboxPrint: CPU user
1,618.3 (33.4%) 20:16:56 INFO - TinderboxPrint: Swap in / out
444,821,504 / 0 20:16:56 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402971136; Write bytes: 396502528; Read time: 29507; Write time: 688 20:16:56 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 36025856; Write bytes: 291614208; Read time: 355; Write time: 1127 20:16:56 INFO - Running post-run listener: _upload_blobber_files 20:16:56 INFO - Blob upload gear active. 20:16:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:16:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:16:57 INFO - (blobuploader) - INFO - Open directory for files ... 20:16:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:16:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:16:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:58 INFO - (blobuploader) - INFO - Done attempting. 20:16:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:16:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:16:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:59 INFO - (blobuploader) - INFO - Done attempting. 20:16:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:16:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:17:01 INFO - (blobuploader) - INFO - Done attempting. 20:17:01 INFO - (blobuploader) - INFO - Iteration through files over. 20:17:01 INFO - Return code: 0 20:17:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:17:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:17:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6468ae21d5ef5c9b9cc02f380468d9d402d3dbd018b61021ddfde1c5f41f3a69f0ba84db64a2b6617cf30813164fc365423f41967e2ab2b2b8d1cbca799c81f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bd9befa0a768875b8e17767d2b4be028dfbcd02edc37fe3b4cd0a5c562d195ad429e45c754bc527e1e7484972790ba363db39244cf222414a077fb49bc653c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1064cd124fdab1c4ca8abc0f52ba5609ed54cc5a15c0a73cd971cf2abc817b318adeb2018ff6cb04d17ebdab53fd1812e362a4e717a79621e2085c608a698eef"} 20:17:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:17:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:17:01 INFO - Contents: 20:17:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6468ae21d5ef5c9b9cc02f380468d9d402d3dbd018b61021ddfde1c5f41f3a69f0ba84db64a2b6617cf30813164fc365423f41967e2ab2b2b8d1cbca799c81f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bd9befa0a768875b8e17767d2b4be028dfbcd02edc37fe3b4cd0a5c562d195ad429e45c754bc527e1e7484972790ba363db39244cf222414a077fb49bc653c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1064cd124fdab1c4ca8abc0f52ba5609ed54cc5a15c0a73cd971cf2abc817b318adeb2018ff6cb04d17ebdab53fd1812e362a4e717a79621e2085c608a698eef"} 20:17:01 INFO - Running post-run listener: copy_logs_to_upload_dir 20:17:01 INFO - Copying logs to upload dir... 20:17:01 INFO - mkdir: /builds/slave/test/build/upload/logs 20:17:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.751123 ========= master_lag: 1.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-31 20:17:03.444827) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 20:17:03.448789) ========= 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.khEFlxFL2x/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.B6c2iqKpLp/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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 blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6468ae21d5ef5c9b9cc02f380468d9d402d3dbd018b61021ddfde1c5f41f3a69f0ba84db64a2b6617cf30813164fc365423f41967e2ab2b2b8d1cbca799c81f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bd9befa0a768875b8e17767d2b4be028dfbcd02edc37fe3b4cd0a5c562d195ad429e45c754bc527e1e7484972790ba363db39244cf222414a077fb49bc653c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1064cd124fdab1c4ca8abc0f52ba5609ed54cc5a15c0a73cd971cf2abc817b318adeb2018ff6cb04d17ebdab53fd1812e362a4e717a79621e2085c608a698eef"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011118 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-central-macosx64/1467972121/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6468ae21d5ef5c9b9cc02f380468d9d402d3dbd018b61021ddfde1c5f41f3a69f0ba84db64a2b6617cf30813164fc365423f41967e2ab2b2b8d1cbca799c81f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3bd9befa0a768875b8e17767d2b4be028dfbcd02edc37fe3b4cd0a5c562d195ad429e45c754bc527e1e7484972790ba363db39244cf222414a077fb49bc653c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1064cd124fdab1c4ca8abc0f52ba5609ed54cc5a15c0a73cd971cf2abc817b318adeb2018ff6cb04d17ebdab53fd1812e362a4e717a79621e2085c608a698eef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-31 20:17:03.481802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 20:17:03.482146) ========= 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.khEFlxFL2x/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.B6c2iqKpLp/Listeners TMPDIR=/var/folders/0w/_9q7s0fs5jx2xng3q6l6pqxw00000w/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.005314 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-31 20:17:03.531575) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 20:17:03.531942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-31 20:17:03.532347) ========= ========= Total master_lag: 2.07 =========