builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0054 starttime: 1467544084.01 results: success (0) buildid: 20160703011557 builduid: 4397c447e0f64c5aa455d05e22a107e4 revision: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.013492) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.014074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.014412) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.245128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.245710) ========= 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.VJe3Q89J2O/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.PC4OxFI8op/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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-03 04:08:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.0M=0.001s 2016-07-03 04:08:04 (20.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.574027 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.895644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.896163) ========= 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.VJe3Q89J2O/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.PC4OxFI8op/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.028503 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.959853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:04.960277) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VJe3Q89J2O/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.PC4OxFI8op/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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-03 04:08:05,048 truncating revision to first 12 chars 2016-07-03 04:08:05,048 Setting DEBUG logging. 2016-07-03 04:08:05,048 attempt 1/10 2016-07-03 04:08:05,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/13ce99eb20be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 04:08:05,363 unpacking tar archive at: mozilla-beta-13ce99eb20be/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573274 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:05.585038) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:05.585339) ========= script_repo_revision: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:05.585735) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:05.586509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 04:08:05.727678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-03 04:08:05.727950) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VJe3Q89J2O/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.PC4OxFI8op/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:08:05 INFO - MultiFileLogger online at 20160703 04:08:05 in /builds/slave/test 04:08:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:08:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:05 INFO - {'append_to_log': False, 04:08:05 INFO - 'base_work_dir': '/builds/slave/test', 04:08:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:08:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:05 INFO - 'branch': 'Mozilla-Beta', 04:08:05 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:05 INFO - 'config_files': ('talos/mac_config.py',), 04:08:05 INFO - 'default_actions': ('clobber', 04:08:05 INFO - 'read-buildbot-config', 04:08:05 INFO - 'download-and-extract', 04:08:05 INFO - 'populate-webroot', 04:08:05 INFO - 'create-virtualenv', 04:08:05 INFO - 'install', 04:08:05 INFO - 'run-tests'), 04:08:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:05 INFO - 'download_minidump_stackwalk': True, 04:08:05 INFO - 'download_symbols': 'ondemand', 04:08:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:05 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:05 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:05 INFO - 'installer_path': 'installer.exe', 04:08:05 INFO - 'log_level': 'info', 04:08:05 INFO - 'log_name': 'talos', 04:08:05 INFO - 'log_to_console': True, 04:08:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:08:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:08:05 INFO - 'opt_config_files': (), 04:08:05 INFO - 'pip_index': False, 04:08:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:08:05 INFO - 'cmd': ('bash', 04:08:05 INFO - '-c', 04:08:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:08:05 INFO - 'enabled': True, 04:08:05 INFO - 'halt_on_failure': False, 04:08:05 INFO - 'name': 'check_screen_resolution'},), 04:08:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:08:05 INFO - 'cmd': ('bash', 04:08:05 INFO - '-c', 04:08:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:08:05 INFO - 'enabled': True, 04:08:05 INFO - 'halt_on_failure': False, 04:08:05 INFO - 'name': 'check_screen_resolution'},), 04:08:05 INFO - 'run_cmd_checks_enabled': True, 04:08:05 INFO - 'sps_profile': False, 04:08:05 INFO - 'sps_profile_interval': 0, 04:08:05 INFO - 'suite': 'dromaeojs-e10s', 04:08:05 INFO - 'system_bits': '32', 04:08:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:05 INFO - 'title': 't-yosemite-r7-0054', 04:08:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:05 INFO - 'use_talos_json': True, 04:08:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:05 INFO - 'work_dir': 'build'} 04:08:05 INFO - ##### 04:08:05 INFO - ##### Running clobber step. 04:08:05 INFO - ##### 04:08:05 INFO - Running pre-action listener: _resource_record_pre_action 04:08:05 INFO - Running main action method: clobber 04:08:05 INFO - rmtree: /builds/slave/test/build 04:08:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:07 INFO - Running post-action listener: _resource_record_post_action 04:08:07 INFO - ##### 04:08:07 INFO - ##### Running read-buildbot-config step. 04:08:07 INFO - ##### 04:08:07 INFO - Running pre-action listener: _resource_record_pre_action 04:08:07 INFO - Running main action method: read_buildbot_config 04:08:07 INFO - Using buildbot properties: 04:08:07 INFO - { 04:08:07 INFO - "project": "", 04:08:07 INFO - "product": "firefox", 04:08:07 INFO - "script_repo_revision": "production", 04:08:07 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:08:07 INFO - "repository": "", 04:08:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:08:07 INFO - "buildid": "20160703011557", 04:08:07 INFO - "pgo_build": "False", 04:08:07 INFO - "basedir": "/builds/slave/test", 04:08:07 INFO - "buildnumber": 21, 04:08:07 INFO - "slavename": "t-yosemite-r7-0054", 04:08:07 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:08:07 INFO - "platform": "yosemite_r7", 04:08:07 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:08:07 INFO - "branch": "mozilla-beta", 04:08:07 INFO - "repo_path": "releases/mozilla-beta", 04:08:07 INFO - "revision": "13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67", 04:08:07 INFO - "stage_platform": "macosx64", 04:08:07 INFO - "builduid": "4397c447e0f64c5aa455d05e22a107e4", 04:08:07 INFO - "slavebuilddir": "test" 04:08:07 INFO - } 04:08:07 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg. 04:08:07 INFO - Running post-action listener: _resource_record_post_action 04:08:07 INFO - ##### 04:08:07 INFO - ##### Running download-and-extract step. 04:08:07 INFO - ##### 04:08:07 INFO - Running pre-action listener: _resource_record_pre_action 04:08:07 INFO - Running main action method: download_and_extract 04:08:07 INFO - mkdir: /builds/slave/test/build/tests 04:08:07 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')]} 04:08:07 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.test_packages.json 04:08:07 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 04:08:07 INFO - Downloaded 1165 bytes. 04:08:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:08:07 INFO - Using the following test package requirements: 04:08:07 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:08:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:07 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:08:07 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:07 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:08:07 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:08:07 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:07 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:08:07 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:08:07 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:07 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:08:07 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:07 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:08:07 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:07 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:08:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:08:07 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:08:07 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:08:07 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')]} 04:08:07 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip 04:08:07 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:08:10 INFO - Downloaded 18351375 bytes. 04:08:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:08:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:08:13 INFO - Return code: 0 04:08:13 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:08:13 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')]} 04:08:13 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip 04:08:13 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:08:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:08:14 INFO - Downloaded 18351375 bytes. 04:08:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:08:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:08:17 INFO - Return code: 0 04:08: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')]} 04:08:17 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.talos.tests.zip 04:08:17 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 04:08:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 04:08:22 INFO - Downloaded 10840145 bytes. 04:08:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:08:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:08:22 INFO - Return code: 0 04:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:22 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg 04:08:22 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 04:08:28 INFO - Downloaded 86196308 bytes. 04:08:28 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg 04:08:28 INFO - mkdir: /builds/slave/test/properties 04:08:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:28 INFO - Contents: 04:08:28 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg 04:08:28 INFO - Running post-action listener: _resource_record_post_action 04:08:28 INFO - Running post-action listener: set_extra_try_arguments 04:08:28 INFO - ##### 04:08:28 INFO - ##### Running populate-webroot step. 04:08:28 INFO - ##### 04:08:28 INFO - Running pre-action listener: _resource_record_pre_action 04:08:28 INFO - Running main action method: populate_webroot 04:08:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:28 INFO - '--tppagecycles', 04:08:28 INFO - '7'], 04:08:28 INFO - 'tests': ['tsvgm']}}, 04:08:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:08:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:08:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:08:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:08:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:08:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:28 INFO - 'talos_options': ['--disable-e10s'], 04:08:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:28 INFO - 'talos_options': ['--disable-e10s'], 04:08:28 INFO - 'tests': ['damp', 'tps']}, 04:08:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:28 INFO - 'tests': ['damp', 'tps']}, 04:08:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:08:28 INFO - 'tests': ['dromaeo_dom']}, 04:08:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:08:28 INFO - 'tests': ['a11yr', 04:08:28 INFO - 'ts_paint', 04:08:28 INFO - 'tpaint', 04:08:28 INFO - 'sessionrestore', 04:08:28 INFO - 'sessionrestore_no_auto_restore', 04:08:28 INFO - 'tabpaint']}, 04:08:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:08:28 INFO - 'ts_paint', 04:08:28 INFO - 'tpaint', 04:08:28 INFO - 'sessionrestore', 04:08:28 INFO - 'sessionrestore_no_auto_restore', 04:08:28 INFO - 'tabpaint']}, 04:08:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:08:28 INFO - 'ts_paint', 04:08:28 INFO - 'tpaint', 04:08:28 INFO - 'sessionrestore', 04:08:28 INFO - 'sessionrestore_no_auto_restore', 04:08:28 INFO - 'tabpaint']}, 04:08:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:08:28 INFO - 'ts_paint', 04:08:28 INFO - 'tpaint', 04:08:28 INFO - 'sessionrestore', 04:08:28 INFO - 'sessionrestore_no_auto_restore', 04:08:28 INFO - 'tabpaint']}, 04:08:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:08:28 INFO - 'tests': ['a11yr', 04:08:28 INFO - 'ts_paint', 04:08:28 INFO - 'tpaint', 04:08:28 INFO - 'sessionrestore', 04:08:28 INFO - 'sessionrestore_no_auto_restore', 04:08:28 INFO - 'tabpaint']}, 04:08:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:08:28 INFO - 'tests': ['a11yr', 04:08:28 INFO - 'ts_paint', 04:08:28 INFO - 'tpaint', 04:08:28 INFO - 'sessionrestore', 04:08:28 INFO - 'sessionrestore_no_auto_restore', 04:08:28 INFO - 'tabpaint']}, 04:08:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:08:28 INFO - 'tests': ['tsvgx', 04:08:28 INFO - 'tsvgr_opacity', 04:08:28 INFO - 'tart', 04:08:28 INFO - 'tscrollx', 04:08:28 INFO - 'cart']}, 04:08:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:08:28 INFO - 'tsvgr_opacity', 04:08:28 INFO - 'tart', 04:08:28 INFO - 'tscrollx', 04:08:28 INFO - 'cart']}, 04:08:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:28 INFO - 'talos_options': ['--disable-e10s'], 04:08:28 INFO - 'tests': ['tp5o']}, 04:08:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:28 INFO - 'tests': ['tp5o']}, 04:08:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:28 INFO - 'talos_options': ['--disable-e10s', 04:08:28 INFO - '--xperf_path', 04:08:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:28 INFO - 'tests': ['tp5n']}, 04:08:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:28 INFO - 'talos_options': ['--xperf_path', 04:08:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:28 INFO - 'tests': ['tp5n']}}, 04:08:28 INFO - 'talos.zip': {'path': '', 04:08:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:28 INFO - Running post-action listener: _resource_record_post_action 04:08:28 INFO - ##### 04:08:28 INFO - ##### Running create-virtualenv step. 04:08:28 INFO - ##### 04:08:28 INFO - Running pre-action listener: _resource_record_pre_action 04:08:28 INFO - Running main action method: create_virtualenv 04:08:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:08:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:28 INFO - Using real prefix '/tools/python27' 04:08:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:32 INFO - Installing pip.................done. 04:08:32 INFO - Return code: 0 04:08:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:32 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 0x107c38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c48420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ff8cbbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad7e00>, '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 0x107940db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ad2b20>, '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.VJe3Q89J2O/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.PC4OxFI8op/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:08:32 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 04:08:32 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 04:08:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VJe3Q89J2O/Render', 04:08:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:32 INFO - 'HOME': '/Users/cltbld', 04:08:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:32 INFO - 'LOGNAME': 'cltbld', 04:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:32 INFO - 'MOZ_NO_REMOTE': '1', 04:08:32 INFO - 'NO_EM_RESTART': '1', 04:08:32 INFO - 'PAGER': '/bin/cat', 04:08:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:32 INFO - 'PWD': '/builds/slave/test', 04:08:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:32 INFO - 'SHELL': '/bin/bash', 04:08:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PC4OxFI8op/Listeners', 04:08:32 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:08:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:32 INFO - 'USER': 'cltbld', 04:08:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:32 INFO - 'XPC_FLAGS': '0x0', 04:08:32 INFO - 'XPC_SERVICE_NAME': '0', 04:08:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:08:32 INFO - Cleaning up... 04:08:32 INFO - Return code: 0 04:08:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:32 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107c38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c48420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ff8cbbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad7e00>, '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 0x107940db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ad2b20>, '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.VJe3Q89J2O/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.PC4OxFI8op/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:08:32 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>=0.7.1'] in /builds/slave/test/build 04:08:32 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>=0.7.1 04:08:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VJe3Q89J2O/Render', 04:08:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:32 INFO - 'HOME': '/Users/cltbld', 04:08:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:32 INFO - 'LOGNAME': 'cltbld', 04:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:32 INFO - 'MOZ_NO_REMOTE': '1', 04:08:32 INFO - 'NO_EM_RESTART': '1', 04:08:32 INFO - 'PAGER': '/bin/cat', 04:08:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:32 INFO - 'PWD': '/builds/slave/test', 04:08:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:32 INFO - 'SHELL': '/bin/bash', 04:08:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PC4OxFI8op/Listeners', 04:08:32 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:08:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:32 INFO - 'USER': 'cltbld', 04:08:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:32 INFO - 'XPC_FLAGS': '0x0', 04:08:32 INFO - 'XPC_SERVICE_NAME': '0', 04:08:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:32 INFO - Downloading/unpacking psutil>=0.7.1 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:36 INFO - Installing collected packages: psutil 04:08:36 INFO - Running setup.py install for psutil 04:08:36 INFO - building 'psutil._psutil_osx' extension 04:08:36 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 04:08:37 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 04:08:37 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 04:08:37 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 04:08:37 INFO - building 'psutil._psutil_posix' extension 04:08:37 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 04:08:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:08:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:08:37 INFO - ^ 04:08:37 INFO - 1 warning generated. 04:08:37 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 04:08:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:37 INFO - Successfully installed psutil 04:08:37 INFO - Cleaning up... 04:08:37 INFO - Return code: 0 04:08:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:08:37 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')]} 04:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 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')]} 04:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107c38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c48420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ff8cbbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad7e00>, '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 0x107940db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ad2b20>, '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.VJe3Q89J2O/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.PC4OxFI8op/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:08:37 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.0.0'] in /builds/slave/test/build 04:08:37 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.0.0 04:08:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VJe3Q89J2O/Render', 04:08:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:37 INFO - 'HOME': '/Users/cltbld', 04:08:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:37 INFO - 'LOGNAME': 'cltbld', 04:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:37 INFO - 'MOZ_NO_REMOTE': '1', 04:08:37 INFO - 'NO_EM_RESTART': '1', 04:08:37 INFO - 'PAGER': '/bin/cat', 04:08:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:37 INFO - 'PWD': '/builds/slave/test', 04:08:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:37 INFO - 'SHELL': '/bin/bash', 04:08:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PC4OxFI8op/Listeners', 04:08:37 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:08:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:37 INFO - 'USER': 'cltbld', 04:08:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:37 INFO - 'XPC_FLAGS': '0x0', 04:08:37 INFO - 'XPC_SERVICE_NAME': '0', 04:08:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:38 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 04:08:38 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 04:08:38 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 04:08:38 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 04:08:38 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 04:08:38 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 04:08:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:08:40 INFO - Installing collected packages: mozsystemmonitor 04:08:40 INFO - Running setup.py install for mozsystemmonitor 04:08:40 INFO - Successfully installed mozsystemmonitor 04:08:40 INFO - Cleaning up... 04:08:40 INFO - Return code: 0 04:08:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:40 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 0x107c38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c48420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ff8cbbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad7e00>, '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 0x107940db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ad2b20>, '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.VJe3Q89J2O/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.PC4OxFI8op/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:08:40 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 04:08:40 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 04:08:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VJe3Q89J2O/Render', 04:08:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:40 INFO - 'HOME': '/Users/cltbld', 04:08:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:40 INFO - 'LOGNAME': 'cltbld', 04:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:40 INFO - 'MOZ_NO_REMOTE': '1', 04:08:40 INFO - 'NO_EM_RESTART': '1', 04:08:40 INFO - 'PAGER': '/bin/cat', 04:08:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:40 INFO - 'PWD': '/builds/slave/test', 04:08:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:40 INFO - 'SHELL': '/bin/bash', 04:08:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PC4OxFI8op/Listeners', 04:08:40 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:08:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:40 INFO - 'USER': 'cltbld', 04:08:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:40 INFO - 'XPC_FLAGS': '0x0', 04:08:40 INFO - 'XPC_SERVICE_NAME': '0', 04:08:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:08:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:44 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 04:08:44 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 04:08:44 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 04:08:44 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 04:08:44 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 04:08:44 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 04:08:44 INFO - Downloading docopt-0.6.1.tar.gz 04:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:44 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:44 INFO - Running setup.py install for blobuploader 04:08:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:08:44 INFO - Running setup.py install for requests 04:08:45 INFO - Running setup.py install for docopt 04:08:45 INFO - Successfully installed blobuploader requests docopt 04:08:45 INFO - Cleaning up... 04:08:45 INFO - Return code: 0 04:08:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:45 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')]} 04:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:45 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')]} 04:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:45 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 0x107c38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c48420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ff8cbbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad7e00>, '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 0x107940db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ad2b20>, '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.VJe3Q89J2O/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.PC4OxFI8op/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:08:45 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 04:08:45 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 04:08:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VJe3Q89J2O/Render', 04:08:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:45 INFO - 'HOME': '/Users/cltbld', 04:08:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:45 INFO - 'LOGNAME': 'cltbld', 04:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:45 INFO - 'MOZ_NO_REMOTE': '1', 04:08:45 INFO - 'NO_EM_RESTART': '1', 04:08:45 INFO - 'PAGER': '/bin/cat', 04:08:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:45 INFO - 'PWD': '/builds/slave/test', 04:08:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:45 INFO - 'SHELL': '/bin/bash', 04:08:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PC4OxFI8op/Listeners', 04:08:45 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:08:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:45 INFO - 'USER': 'cltbld', 04:08:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:45 INFO - 'XPC_FLAGS': '0x0', 04:08:45 INFO - 'XPC_SERVICE_NAME': '0', 04:08:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:45 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-02XAGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:46 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-SojCKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:46 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-PmQ0i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:46 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-qzBdFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:46 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-92O6zT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:46 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-Uksgmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:46 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-pKoDKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:46 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-5qRmIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:46 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-uJuS0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:46 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-dHO0t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:46 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-UhE8PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:47 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-5fumLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:47 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-68r4D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:47 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-4rfWF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:47 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-s6OAl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:47 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-h30IK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:47 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-EhqVFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:47 INFO - Running setup.py install for manifestparser 04:08:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:47 INFO - Running setup.py install for mozcrash 04:08:48 INFO - Running setup.py install for mozdebug 04:08:48 INFO - Running setup.py install for mozdevice 04:08:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:08:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:48 INFO - Running setup.py install for mozfile 04:08:48 INFO - Running setup.py install for mozhttpd 04:08:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:48 INFO - Running setup.py install for mozinfo 04:08:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:48 INFO - Running setup.py install for mozInstall 04:08:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:48 INFO - Running setup.py install for mozleak 04:08:49 INFO - Running setup.py install for mozlog 04:08:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:49 INFO - Running setup.py install for moznetwork 04:08:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:49 INFO - Running setup.py install for mozprocess 04:08:49 INFO - Running setup.py install for mozprofile 04:08:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:49 INFO - Running setup.py install for mozrunner 04:08:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:49 INFO - Running setup.py install for mozscreenshot 04:08:49 INFO - Running setup.py install for moztest 04:08:50 INFO - Running setup.py install for mozversion 04:08:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:50 INFO - Cleaning up... 04:08:50 INFO - Return code: 0 04:08:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:50 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')]} 04:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:50 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')]} 04:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:50 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 0x107c38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c48420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ff8cbbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad7e00>, '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 0x107940db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ad2b20>, '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.VJe3Q89J2O/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.PC4OxFI8op/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:08:50 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 04:08:50 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 04:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VJe3Q89J2O/Render', 04:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:50 INFO - 'HOME': '/Users/cltbld', 04:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:50 INFO - 'LOGNAME': 'cltbld', 04:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:50 INFO - 'MOZ_NO_REMOTE': '1', 04:08:50 INFO - 'NO_EM_RESTART': '1', 04:08:50 INFO - 'PAGER': '/bin/cat', 04:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:50 INFO - 'PWD': '/builds/slave/test', 04:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:50 INFO - 'SHELL': '/bin/bash', 04:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PC4OxFI8op/Listeners', 04:08:50 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:50 INFO - 'USER': 'cltbld', 04:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:50 INFO - 'XPC_FLAGS': '0x0', 04:08:50 INFO - 'XPC_SERVICE_NAME': '0', 04:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:50 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-8fKoJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:50 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)) 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:50 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-4LzF5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:50 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)) 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:50 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-vsZQ65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:50 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)) 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:50 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-QUFNsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:51 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-kZnKr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:51 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-adLw7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:51 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-MDzw4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:51 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-vCwJx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:51 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-8oXX54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:51 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-nX90Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:51 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-QFSo8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:51 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-6W6URK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:51 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-ZbFulF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:51 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)) 04:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:51 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-dYAHzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:52 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-lAVGUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:52 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-y5iz6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:52 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)) 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:52 INFO - Running setup.py (path:/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/pip-1SdMyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:52 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)) 04:08:52 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)) 04:08:52 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)) 04:08:52 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)) 04:08:52 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)) 04:08:52 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)) 04:08:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:52 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 04:08:52 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 04:08:52 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 04:08:52 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 04:08:52 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 04:08:52 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 04:08:54 INFO - Downloading blessings-1.6.tar.gz 04:08:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:54 INFO - Installing collected packages: blessings 04:08:54 INFO - Running setup.py install for blessings 04:08:55 INFO - Successfully installed blessings 04:08:55 INFO - Cleaning up... 04:08:55 INFO - Return code: 0 04:08:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:08:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:55 INFO - Reading from file tmpfile_stdout 04:08:55 INFO - Current package versions: 04:08:55 INFO - blessings == 1.6 04:08:55 INFO - blobuploader == 1.2.4 04:08:55 INFO - docopt == 0.6.1 04:08:55 INFO - manifestparser == 1.1 04:08:55 INFO - mozInstall == 1.12 04:08:55 INFO - mozcrash == 0.17 04:08:55 INFO - mozdebug == 0.1 04:08:55 INFO - mozdevice == 0.48 04:08:55 INFO - mozfile == 1.2 04:08:55 INFO - mozhttpd == 0.7 04:08:55 INFO - mozinfo == 0.9 04:08:55 INFO - mozleak == 0.1 04:08:55 INFO - mozlog == 3.1 04:08:55 INFO - moznetwork == 0.27 04:08:55 INFO - mozprocess == 0.22 04:08:55 INFO - mozprofile == 0.28 04:08:55 INFO - mozrunner == 6.11 04:08:55 INFO - mozscreenshot == 0.1 04:08:55 INFO - mozsystemmonitor == 0.0 04:08:55 INFO - moztest == 0.7 04:08:55 INFO - mozversion == 1.4 04:08:55 INFO - psutil == 3.1.1 04:08:55 INFO - requests == 1.2.3 04:08:55 INFO - wsgiref == 0.1.2 04:08:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:55 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 0x107c38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c48420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ff8cbbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad7e00>, '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 0x107940db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ad2b20>, '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.VJe3Q89J2O/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.PC4OxFI8op/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:08:55 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 04:08:55 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 04:08:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VJe3Q89J2O/Render', 04:08:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:55 INFO - 'HOME': '/Users/cltbld', 04:08:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:55 INFO - 'LOGNAME': 'cltbld', 04:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:55 INFO - 'MOZ_NO_REMOTE': '1', 04:08:55 INFO - 'NO_EM_RESTART': '1', 04:08:55 INFO - 'PAGER': '/bin/cat', 04:08:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:55 INFO - 'PWD': '/builds/slave/test', 04:08:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:55 INFO - 'SHELL': '/bin/bash', 04:08:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PC4OxFI8op/Listeners', 04:08:55 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:08:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:55 INFO - 'USER': 'cltbld', 04:08:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:55 INFO - 'XPC_FLAGS': '0x0', 04:08:55 INFO - 'XPC_SERVICE_NAME': '0', 04:08:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 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)) 04:08:55 INFO - Cleaning up... 04:08:55 INFO - Return code: 0 04:08:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:55 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 0x107c38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c48420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ff8cbbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad7e00>, '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 0x107940db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ad2b20>, '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.VJe3Q89J2O/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.PC4OxFI8op/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:08:55 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 04:08:55 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 04:08:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VJe3Q89J2O/Render', 04:08:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:55 INFO - 'HOME': '/Users/cltbld', 04:08:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:55 INFO - 'LOGNAME': 'cltbld', 04:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:55 INFO - 'MOZ_NO_REMOTE': '1', 04:08:55 INFO - 'NO_EM_RESTART': '1', 04:08:55 INFO - 'PAGER': '/bin/cat', 04:08:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:55 INFO - 'PWD': '/builds/slave/test', 04:08:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:55 INFO - 'SHELL': '/bin/bash', 04:08:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PC4OxFI8op/Listeners', 04:08:55 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:08:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:55 INFO - 'USER': 'cltbld', 04:08:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:55 INFO - 'XPC_FLAGS': '0x0', 04:08:55 INFO - 'XPC_SERVICE_NAME': '0', 04:08:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:56 INFO - Downloading/unpacking jsonschema 04:08:56 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 04:08:56 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 04:08:56 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 04:08:56 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 04:08:56 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 04:08:56 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 04:08:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:58 INFO - Downloading/unpacking functools32 (from jsonschema) 04:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:58 INFO - warning: no files found matching '*.txt' 04:08:58 INFO - no previously-included directories found matching 'build' 04:08:58 INFO - no previously-included directories found matching 'dist' 04:08:58 INFO - no previously-included directories found matching '.git*' 04:08:58 INFO - Installing collected packages: jsonschema, functools32 04:08:58 INFO - Running setup.py install for functools32 04:08:59 INFO - warning: no files found matching '*.txt' 04:08:59 INFO - no previously-included directories found matching 'build' 04:08:59 INFO - no previously-included directories found matching 'dist' 04:08:59 INFO - no previously-included directories found matching '.git*' 04:08:59 INFO - Successfully installed jsonschema functools32 04:08:59 INFO - Cleaning up... 04:08:59 INFO - Return code: 0 04:08:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:08:59 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')]} 04:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:59 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')]} 04:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:59 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107c38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c48420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ff8cbbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad7e00>, '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 0x107940db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ad2b20>, '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.VJe3Q89J2O/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.PC4OxFI8op/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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 04:08:59 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', 'flake8'] in /builds/slave/test/build 04:08:59 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 flake8 04:08:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VJe3Q89J2O/Render', 04:08:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:08:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:08:59 INFO - 'HOME': '/Users/cltbld', 04:08:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:08:59 INFO - 'LOGNAME': 'cltbld', 04:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:59 INFO - 'MOZ_NO_REMOTE': '1', 04:08:59 INFO - 'NO_EM_RESTART': '1', 04:08:59 INFO - 'PAGER': '/bin/cat', 04:08:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:59 INFO - 'PWD': '/builds/slave/test', 04:08:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:08:59 INFO - 'SHELL': '/bin/bash', 04:08:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PC4OxFI8op/Listeners', 04:08:59 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:08:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:08:59 INFO - 'USER': 'cltbld', 04:08:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:08:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:59 INFO - 'XPC_FLAGS': '0x0', 04:08:59 INFO - 'XPC_SERVICE_NAME': '0', 04:08:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:59 INFO - Downloading/unpacking flake8 04:08:59 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 04:08:59 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 04:08:59 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 04:08:59 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 04:08:59 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 04:08:59 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 04:09:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:09:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:09:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:03 INFO - no previously-included directories found matching 'docs/_build' 04:09:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:03 INFO - Running setup.py install for pep8 04:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:03 INFO - no previously-included directories found matching 'docs/_build' 04:09:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:09:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:03 INFO - Cleaning up... 04:09:03 INFO - Return code: 0 04:09:03 INFO - Running post-action listener: _resource_record_post_action 04:09:03 INFO - Running post-action listener: _start_resource_monitoring 04:09:03 INFO - Starting resource monitoring. 04:09:03 INFO - ##### 04:09:03 INFO - ##### Running install step. 04:09:03 INFO - ##### 04:09:03 INFO - Running pre-action listener: _resource_record_pre_action 04:09:03 INFO - Running main action method: install 04:09:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:03 INFO - Reading from file tmpfile_stdout 04:09:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:03 INFO - Reading from file tmpfile_stdout 04:09:03 INFO - Output received: 04:09:03 INFO - Usage: mozinstall [options] installer 04:09:03 INFO - Options: 04:09:03 INFO - -h, --help show this help message and exit 04:09:03 INFO - -d DEST, --destination=DEST 04:09:03 INFO - Directory to install application into. [default: 04:09:03 INFO - "/builds/slave/test"] 04:09:03 INFO - --app=APP Application being installed. [default: firefox] 04:09:03 INFO - mkdir: /builds/slave/test/build/application 04:09:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:09:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:09:25 INFO - Reading from file tmpfile_stdout 04:09:25 INFO - Output received: 04:09:25 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:09:25 INFO - Running post-action listener: _resource_record_post_action 04:09:25 INFO - ##### 04:09:25 INFO - ##### Running run-tests step. 04:09:25 INFO - ##### 04:09:25 INFO - Running pre-action listener: _resource_record_pre_action 04:09:25 INFO - Running main action method: run_tests 04:09:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:09:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:09:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:09:25 INFO - 2016-07-03 04:09:25.678 screenresolution[1651:8650] starting screenresolution argv=screenresolution get 04:09:25 INFO - 2016-07-03 04:09:25.680 screenresolution[1651:8650] Display 0: 1600x1200x32@60 04:09:25 INFO - 2016-07-03 04:09:25.686 screenresolution[1652:8652] starting screenresolution argv=screenresolution list 04:09:25 INFO - Available Modes on Display 0 04:09:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:09:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:09:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:09:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:09:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:09:25 INFO - Intel Iris: 04:09:25 INFO - Chipset Model: Intel Iris 04:09:25 INFO - Type: GPU 04:09:25 INFO - Bus: Built-In 04:09:25 INFO - VRAM (Dynamic, Max): 1536 MB 04:09:25 INFO - Vendor: Intel (0x8086) 04:09:25 INFO - Device ID: 0x0a2e 04:09:25 INFO - Revision ID: 0x0009 04:09:25 INFO - Displays: 04:09:25 INFO - Display: 04:09:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:09:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:09:25 INFO - Display Serial Number: 1600x1200 60 04:09:25 INFO - Main Display: Yes 04:09:25 INFO - Mirror: Off 04:09:25 INFO - Online: Yes 04:09:25 INFO - Rotation: Supported 04:09:25 INFO - Return code: 0 04:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:25 INFO - Python 2.7.3 04:09:25 INFO - Return code: 0 04:09:25 INFO - grabbing minidump binary from tooltool 04:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ad7e00>, '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 0x107940db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ad2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:25 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 04:09:25 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 04:09:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:26 INFO - Return code: 0 04:09:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:09:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:09:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:09:27 INFO - Return code: 0 04:09:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VJe3Q89J2O/Render', 04:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:27 INFO - 'HOME': '/Users/cltbld', 04:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:27 INFO - 'LOGNAME': 'cltbld', 04:09:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:27 INFO - 'MOZ_NO_REMOTE': '1', 04:09:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:27 INFO - 'NO_EM_RESTART': '1', 04:09:27 INFO - 'PAGER': '/bin/cat', 04:09:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:27 INFO - 'PWD': '/builds/slave/test', 04:09:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:27 INFO - 'SHELL': '/bin/bash', 04:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PC4OxFI8op/Listeners', 04:09:27 INFO - 'TMPDIR': '/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/', 04:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:27 INFO - 'USER': 'cltbld', 04:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:27 INFO - 'XPC_FLAGS': '0x0', 04:09:27 INFO - 'XPC_SERVICE_NAME': '0', 04:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:09:27 INFO - mozversion application_buildid: 20160703011557 04:09:27 INFO - mozversion application_changeset: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 04:09:27 INFO - mozversion application_display_name: Firefox 04:09:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:27 INFO - mozversion application_name: Firefox 04:09:27 INFO - mozversion application_remotingname: firefox 04:09:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:27 INFO - mozversion application_vendor: Mozilla 04:09:27 INFO - mozversion application_version: 48.0 04:09:27 INFO - mozversion platform_buildid: 20160703011557 04:09:27 INFO - mozversion platform_changeset: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 04:09:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:09:27 INFO - mozversion platform_version: 48.0 04:09:27 INFO - using testdate: 1467544167 04:09:27 INFO - actual date: 1467544167 04:09:27 INFO - starting webserver on 'localhost:49264' 04:09:27 INFO - SUITE-START | Running 2 tests 04:09:27 INFO - TEST-START | dromaeo_css 04:09:27 INFO - operating with platform_type : mac_ 04:09:27 INFO - Initialising browser for dromaeo_css test... 04:09:27 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmp_ZCZQU/profile http://localhost:49264/getInfo.html) 04:09:30 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 04:09:30 INFO - PROCESS | 1670 | colorDepth:24 04:09:30 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 04:09:30 INFO - PROCESS | 1670 | __metrics 04:09:30 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:09:30 INFO - TEST-INFO | 1670: exit 0 04:09:30 INFO - Browser initialized. 04:09:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:30 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmp_ZCZQU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:42 INFO - PROCESS | 1676 | RSS: Main: 170983424 04:09:42 INFO - PROCESS | 1676 | 04:10:32 INFO - PROCESS | 1676 | 1467544232542 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] 04:12:42 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 04:12:43 INFO - PROCESS | 1676 | RSS: Main: 183746560 04:12:43 INFO - PROCESS | 1676 | 04:15:45 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 04:15:46 INFO - PROCESS | 1676 | RSS: Main: 194539520 04:15:46 INFO - PROCESS | 1676 | 04:18:47 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 04:18:48 INFO - PROCESS | 1676 | RSS: Main: 196603904 04:18:48 INFO - PROCESS | 1676 | 04:21:49 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 04:21:50 INFO - PROCESS | 1676 | RSS: Main: 200359936 04:21:50 INFO - PROCESS | 1676 | 04:24:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 04:24:53 INFO - PROCESS | 1676 | RSS: Main: 199507968 04:24:53 INFO - PROCESS | 1676 | 04:27:55 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 04:27:56 INFO - PROCESS | 1676 | RSS: Main: 204386304 04:27:56 INFO - PROCESS | 1676 | 04:27:56 INFO - PROCESS | 1676 | __start_tp_report 04:27:56 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 04:27:56 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 04:27:56 INFO - PROCESS | 1676 | |i|pagename|runs| 04:27:56 INFO - PROCESS | 1676 | |0;dojo.html;3036.7266945974866;3690.3910854708975;3702.296563652904;3719.423489359149;3738.1028553147235;5900.9999999999945;5986.281646202451;5987.371326010761;6019.428154325337;6055.666938318391;5964.761409543624;5992.640441573509;6014.218151640281;6019;6042.728077236524;5245.213218017299;5295.099833028395;5339.385970613391;5378.327709036371;5464.453554644524;5340.54605358545;5394.406615272317;5473.8357849264585;5506.091494903336;5508.03609368361;5398.784048638069;5458.536024437908;5465;5466.835994920159;5487.972560137214;5426.077566813651;5444.3194600674915;5462.4978131013895;5464.9453505464835;5494.478024587658;5265.052290587692;5349.839504814861;5358.517733404013;5361.98122356751;5407.459254074601;4691.7888695008805;5835.649861008353;5869.706514674249;5922.940770592282;5960.850978725523;6236.812895613093;6285.748570057192;6321.1150438938585;6328.462080723144;6333.176687030703;6198.411150940653;6366.108744775735;6387.489000879965;6394.872102557969;6414.294427612959;6055.788047418363;6124.319907527392;6139.74593465464;6139.8294713812775;6140.289530736413;6512.837179070561;6548.246951600531;6555.508336874658;6568.113304703804;6616.86766264672;4852.417709874767;5070.188769796889;6301.52738544611;6323.20959880015;6325.873482530324;5605.32736071674;6314.71583778731;6398.616083035033;6423.068655044993;6446.935530644727;6224.533160013018;6291.571093753915;6302.1492098566105;6309.589876658002;6328.493720502349;6185.072239164161;6253.062040693932;6276.340984196685;6278.623282603058;6369.49044076482;4362.192994296065;5066.341375621219;5073.315102461121;5075.593952483792;5089.694618322913;4616.515265897033;4621;4628.69913455631;4640.350350950869;4657.278121891112;5994.550408719363;6036.0644100164545;6111.379037751179;6143.96928015366;6177.444030037318;6358.618482890949;6378.936210637927;6398.776042838478;6407.167068281094;6410.903836442457;5073.518015788494;6199.132121502993;6204.038374052029;6227.097070924781;6232.407921247474;5507.256520369699;5561.805336813192;5635.774569017275;5639.689817060101;5685.005124103265;5498.890022199534;6544.7382104716235;6552.50856185788;6593.3736295051895;6609.140811694545;5179.404368497671;6361.904571431525;6391.58454700443;6394.936050639621;6395.072714456471;5546.473085056913;6563.7702680405955;6613.735450581923;6683.164604424447;6696.029075784081;6323.557350985571;6342.556021078481;6343.841403964753;6350.968245158745;6362.713677884599;6268.153799237227;6338.334474880071;6390.297067322684;6457.4511166551365;6468.417842394207;6093.025115981422;6213;6277.497800176066;6281.905771413341;6352.36476352361;6244.157038799885;6250.312465628868;6256.749730010749;6266.905996409966;6275.843103922256;6116.235470566179;6135.753292002278;6144;6151.907721384094;6228.283747369111;5938.287405511366;6197.349278325711;6215.9378406215355;6281;6282.937170628235;6270.7805226816845;6314.084457753508;6339.96830015847;6342.429181373698;6356.68216589178 04:27:56 INFO - PROCESS | 1676 | |1;ext.html;520.2690220240561;560.3108176942361;567.7331654122561;588.4380416702048;613.2977740487139;38363;39254;39719.2056158877;39823;39871.40192897109;41442.37836432448;42018.36972445408;42069.94825129373;42168.36747448791;42208.57791422085;9618.711438656834;9817;9847.70456886291;9868.161206297473;9886.357386769872;9667.323287369887;9807.460589667566;9869.90130098697;9875.555599998017;9931.851022234672;9852.162566181883;9923.851142232836;9934.950325248363;9951.800963980717;9954.601815927354;9843.507824608776;9868.90131098687;9900.811902571737;9915.405075695446;9922.057404546556;9790.804183916282;9847.90152098477;9882.11061004513;9882.11061004513;9932.851007234898;33613;39968;40286.79856600727;40348.596514035075;40396.394054089214;3083.8920637777796;3212.2611799286296;3403.3363494118657;3529.8588056477965;3916.5104361954754;26488.337791555172;26957.191284261502;27419.31451713703;27607.86196069007;27705.584416233774;2708.79684023699;2712.1050053482304;2721.3468767495856;2746.244782684758;2785.1226863537922;373404;380579.58261252206;383307;384652.07673961733;384962.07518962224;36193.63806361955;36249.27501449956;36441.453378199345;37452.812735936146;38464.807675962;36340.636593634255;36822.63177368192;37061.8881433552;37090.814545927635;37158.628413715516;13670.589882303548;15836.841631583768;15966.36134554628;16002.519924402286;16032.919835400748;13644.590662280147;13815.930920345534;14022.948278879125;14044.648883777987;14069.577912662637;8428.199321064489;8486.490810551386;8494.787630309293;8591.3556483264;8623.741287761377;3061.3112049789065;3544.5746510418917;3596.352656521799;3615.7649752765988;3629.8003609801713;1053.847192157133;1057.931234469757;1121.770037142384;1210.691273725212;1229.6679896427913;28497.00260490873;30844.69155308463;30889.382212355627;30990.535141972887;31318.903838365546;1132.473399869065;1173.184636677501;1263.77252094622;1281.9038572106942;1311.8819306262483;13166.802497962539;14365.425382984564;15865;15948.086229652516;16182.514524564282;600361;603204;604881.975590128;608640;610096;51692;58600.706996464745;60917.69541152266;60966.78066438646;61777;1427.4076258352668;1532.9422698338335;1548.7289724298203;1574.4491675699428;1580.8498192671677;29444.705552944197;30287;30629.846850766495;30816;30972.380552388375;52972.73513632562;54018.729906350214;54279.72860135674;54470;54527.18209226785;516904;517218;521317;523677;526040;27257.182284531496;27599.448011039265;28172.295692607848;43916.56083439253;44856.775716121214;45011;45374.092518150115;45600.543994560954;46072.53927460816;46123.07753844837;36900.446493302086;37862.24275514529;38883;39401.60598393979;39889.2022159561;38522.6147738519;38669.61330386773;38694.61305387023;38917.14372701065;38986;38847.80576097214;38951.220975580894;39187.804060980656;40010.599894001854;40869.1826163481;32830.67169328276;33747.493787593696;33788.924053792165;34141.317173656884;34299.657003429646;25717.485650287264;25769.098081567055;25977.74022259753;26081.73918260793;26090 04:27:56 INFO - PROCESS | 1676 | |2;jquery.html;421.57210431412125;424.8194517330134;428.21208975485104;431.5296327003566;434.3896824960929;20812;20849.06179221935;21562.676559851614;22190.667139992915;22278.331650050484;21211.893940530277;21218.681719774217;21271.893640531776;21372.89313553434;21583.136674533038;6054.303755068157;6333.05004249364;6401.615903045809;6407.423331900128;6417.133686952272;4650.883727906812;5339.546138578206;6395.232572091332;6735.8316042099095;7046.013558101869;6993.545419547739;7002.264762199972;7010.088688470517;7017.8596428071405;7032.261612530688;5714.942735593908;6742.8314292142595;6879.105716256905;6901.275366086589;6904.516683832134;5868.618539794899;6081.756729730805;6085.786997455112;6091.817245482643;6095.359987201368;27183.86408067967;27266.591001135;27775.722242777516;27872.721272787214;28185.295367615974;2382.4758553118286;2450.2649205238536;2692.2865440658243;2768.44631073784;3040.148758347666;15437.459688910834;15575.321163617626;15983.520494385188;16010.359585616561;16030.519084427486;1504.8495150484973;1741.4253296412153;1786.499780061585;1849.537615596101;1893.2710906301172;81634.77547836787;83496.58251708763;107058.3941240882;107910;108062.3790643141;11688.88311116878;11894.167408281337;11960.983316418027;11987.100967427303;12316.384180790925;13082.345882706017;14251.00242983002;15111.31999060045;15118.924405378122;15168.924155379373;8356.498610083414;8804.767332573445;9152.954235228914;9410.623575057058;9512.714618561455;9596.568154433067;9648.421094734338;9813;9934.900650993397;9953.85992011721;6329.208848893888;7080.937859321143;7225.638718064076;7325.560466371928;7326.96336518314;1948.2499237793552;2005.2580545198077;2074.3984244568906;2147.6778483227326;2147.860389074705;948.7628092976756;1008.742770593494;1039.1946241662772;1049.228816819637;1108.8503052087865;18698.34555790541;20806.687899681518;21313.25403610897;21433.571328573653;22392.440188995406;1031.7317497450567;1046.4976811130548;1081.5727787523883;1087.3910610058392;1088.2382332367374;11483.196176267582;11831.408429578487;11982.700432489084;11987.22083064598;12012;599957;608260;611101;646346;672559;130120;130464;133683.33158334147;136371.99999999802;136927;1073.0825144501496;1079.5357996061612;1088.9346639201674;1102.944852757375;1108.2630051016145;18969.43091707251;19423.417297480533;19606.215751370357;19718.924927547785;19865.205391784166;37941.62058379492;49192.26211606757;51794.48205518047;52914.94170116653;55882.44117558772;58314.54213644693;73869.26130738624;77873.4425311502;78496;78802;8234.382421318305;8489.533075680896;8594.312455003459;8669.306455483673;8755.430896991675;11006.779864402828;12417.006639469002;13572.457101716216;13772.586822395344;13850.376733047238;11751.17741758103;11784.76430471403;11828.585999489977;11889.692133865095;11889.702757431134;10457.633982810565;10932.94533527359;11173.497192626513;11618.94190529042;11682.47428865686;11575.88424115748;11773.411329433322;11809.527618895148;11890;12128.332941688292;8143.837123257384;8412.242898138951;8664.133586641285;8708.129187081242;8955.104489550993;9601.231901447727;10262.58949642006;11663.65009049696;11755.47100380502;11806.822897656713 04:27:56 INFO - PROCESS | 1676 | |3;mootools.html;1450.209635748517;1628.8208297087322;1875.7186422036693;2011.4166891601428;2064.4916426541768;8331.500109993405;9034.954825225865;9086.86369704454;9278.02580729023;9298.302627302954;9078.682246121387;9105.499197544132;9175.944766351871;9199.816003679922;9223.400478968862;2538.6445897574354;2541.9491610167784;2566.242958327298;2566.6278389633585;2569.627404026415;2155;2495.2264797912703;2561.6669832921693;2564.3076369380256;2575.6780402449695;2135.306025541697;2527.292358139724;2549.528337257604;2577.2783620586265;2591.598302263152;2534.176392672389;2543.071778800743;2555.2589748972778;2572.996531352774;2573.9318182954053;2096.3501314592527;2564.192279431973;2569.8072644551735;2570.9485810283877;2574.0604679291923;9276.860847087299;9299.48852813095;9315.161635452841;9325.44047357154;9326.114019168168;4684.672072954894;5042.520960508746;5604.355499117612;5798.7100644968;5845.85385365365;3611.5305010348748;3711.832967516468;3727.5154229949935;3777.471154038437;3786.6024067473068;939.417561112108;1074.1031238915516;1096.3476731344838;1096.4901320885826;1098.9780204395947;12173.634790956285;12385.566505172275;12400.937995309965;12401.503939842396;12425.502979880794;5014.172661510883;5044.965782014679;5051.292819005343;5080.59355251579;5102.08162530748;10537.578496860193;10551.050405463546;10557.577696892193;10573.9471302643;10590.046895779416;5619.887602247933;5629.7185140742795;5684.488396044293;5733.741981610838;5741.45456181662;4625.976870115628;5028.044671512401;5074.797008119708;5077;5235.267062611238;3935.8389275163895;4180.080382315886;4187.895302617459;4281.828726850891;4312.202242585132;1304.6412236634812;1401.2293238718867;1402.4320150339129;1415.469199050356;1424.5156646739952;852.9019162796234;985.3545927417553;986.6349450703286;1001.839705647093;1007.6019972110975;6016.217891674054;6096.969515152396;6166.784162554289;6262.874742505124;6336.334684858116;953.512520468072;980.122790102854;1024.71820249432;1039.8405777558119;1080.524569189554;4055.9797201013807;4067.633912947849;4153.813078411479;4207.453031105937;4220.282551966173;10884.07485363753;10976.615818446317;11052.226344155832;11188.384638844778;11203.775924481464;10609.893901061045;10670.679879603624;10692.465376731132;10815.297005694605;10978.670639880816;8557.229849313591;8624.482531048283;8722.127787221227;8846.867296990551;8869.911300887037;6020.548458865515;6073.939260607514;6075.2405949256345;6092.634441933498;6191.659458729813;9898.356606820533;9966.152877005536;10022.498875056364;10081;10113.29206955506;10112.646057387956;10296.433696146783;10348.53431595595;10391.896081039093;10663.200259980378;6655.600663960178;7079.610621415872;7302.160251571137;7304.452166087671;7424.851502969802;8590.379934120154;8596.226339629464;8669.133086691532;8674.826503469769;8681.479111253346;7487.737929172453;7680.500767450098;7751.069871615442;7756.767296981099;7841.490303130278;7508.136564295176;7597.696092156252;7612.7716168515035;7617.238276172338;7692.115406728074;6085.9695701521205;6251.437370636664;7312.780616581511;7373.668184931584;7377.077865266841;5052.343195384724;5067.315912351933;5152.381714194321;5182.559482444034;5212.739363031909;5184.533391994739;5194.8961020780125;5268.57851371897;5301.310829592128;5391.676499410048 04:27:56 INFO - PROCESS | 1676 | |4;prototype.html;341.5883859948762;346.28319378885703;347.555129434324;348.06197298281126;357.871166380103;7128.251533588977;7136.500444968854;7149.606771627558;7156.177039640443;7160.785176444709;7041.823954401142;7082.752103676372;7133.89299160513;7153.499255052148;7163.426925845933;4908.7300198489065;4949.331840201581;5119.7696103675235;5120.411152717429;5121.641485096045;4597.379353787246;4689.3669354637195;5091.618128640348;5124.359455068116;5125.641205115643;4130.648894843942;4506.031203291292;5048.495150484959;5093.745312734367;5134.614903882205;5107.999999999982;5114.897702045957;5119.462456442076;5158.845234642967;5182.870428239286;4392.099619577979;4394.934075988863;4405.9118817623785;4412.499750084987;4420.690551661385;5277.683338999673;5858.443447872445;6620.205575330991;6807.421369183626;6852.45180385573;5986.461218490357;6023.036314189709;6042.697865106771;6048.69756512177;6073.331933487313;7591.3926885849;7613.733519326797;7616.352610028154;7620.390368770485;7813.765587032398;4953.281774142765;4972.657382506739;4979.278004689336;4984.152694041985;4990.525900039491;7905.407094467938;8046.879296810611;8104.878426823602;8105.148959359241;8149.022117345897;5032.874178145576;5079.873003174876;5084.8220312288895;5085.64400491962;5105.2342148678;5179.896402071938;5188.610854185876;5193.221016847503;5201.401838788512;5207.479252074762;6016.608920420159;6018.608790428696;6026.487748541423;6033.939660603338;6038.818835434944;6242.968785156045;7668.539887606761;7696.576688282198;7718.691252349955;7727.111382191008;1650.6616143690514;1731.714267145932;1781.1361489677497;1812.984728552015;1813.4650278167971;1075.5482697267166;1075.6880504653564;1102.2614848051824;1102.8290614954694;1102.972425689348;7140.892886606705;7198.460115491359;7222.241664625244;7227.89158162628;7248.275172482709;7692.423068269902;7896.091949425775;7916;7928.6828526859435;7942.166072562413;6986.091808065021;7149.392301654418;7227.566346019255;7301.415886729049;7348.191698913115;4214.578542145761;4264.424302719155;4274.7435153890865;4276.123394704078;4295.8496452624;8434.62044208012;8439.409241353169;8450.619722112397;8454.535000575028;8504.44721093127;6719.798406047728;7502.612016776805;7653.770386888402;8263.462874913112;8326.83346333082;8350.498970061815;8404.957975210085;8405.075441701409;8419.07390187079;8419.368547358972;6564.606123632598;7242.275772422716;8016;8045.9597702011115;8057.637406316612;7654.578998155155;7888.7633370998965;7901.367890568626;7917.722879699183;7921.841563168589;8270.751877443687;8380.916190838014;8387.119352467904;8443.577821108796;8464.195901389357;4826.975865120652;4929.507049295042;4929.5809856161195;4953.851384458472;4972.129877271391;7971.521708697497;7981.521108733495;7992.400569957393;7996;8036.316913062456;7402.851942961003;7705.42209334291;7757.418193635387;7778.222177782177;7812.257835505618;6471.4822814175695;7459.918311844861;7699.538027718355;7713.382929365749;7728.188540203422;7513.774586762187;7527.322540971339;7536.472446928662;7557.433192510473;7561;7739.458237923292;7741.458097933316;7749.690012399441;7764.145943946274;7765.145833958373;7310.890336645061;7582.886256706043;7591.506552074097;7605.277498637621;7615.010048693634 04:27:56 INFO - PROCESS | 1676 | |5;yui.html;718.6658203935173;749.1759065028468;752.2214507984233;772.7681695491351;789.8183417813901;15179.544613661594;15475.922620386911;15498.07011579306;15504.457343992963;15521.379144834207;14160.57518274451;14179.078359906598;14216.92891535541;14225.71548569028;14241.715165696705;783.6943591999125;942.2226663003015;955.4458414119794;981.8576306435563;987.7579992901714;944.4474982135459;953.4708236928502;961.9903800961971;964.7588102974256;965.946872921989;980.3235767320562;1013.4020927652683;1037.424229552598;1039.9844002339971;1040.3705758016404;974.3812678948848;974.4543055888724;981.2101258486915;1034.3328553083295;1035.2908257843364;726.3644311227675;726.625787719325;775.5618075787162;781.620913856779;782.5109306683323;15203.923980380026;15238.771418428732;15269.541913742605;15322.693546129127;15342.693146137015;13446.596602101952;13459.259740714257;13478.932605337008;13648.044636875422;13652.795208071886;10302.948485257526;10333.58665653373;10403.5838566458;10470.47647617616;10641.414722190277;3226.3063441359986;3503.562054743157;3551.5027896094566;3699.352613292663;3879.709021823346;81991.18008819895;82129;82310.94222644423;83277.16722832754;83579;9883.604655813688;9892.01079892005;9909;10047.949760251298;10135.594576217016;23021.07915683354;23278.53442931132;23387.649185262235;23720.762792371854;23723.1696890608;7657.961710191414;7833.412494062854;7919.881201781978;8175.509469431853;8247.463914845515;4212.178625168062;4227.957720422818;4256.2551553478015;4286.2284788738325;4405.229084910128;3725.869594564177;3748.194138260287;3769.7361184716806;3786.924261514754;3811.5235595550557;673.8045966669611;713.53263612334;718.2530168624572;740.1488288468305;748.5209465941801;601.7983975368213;614.4576516383055;617.3178637605381;619.5260625621403;627.5920651576512;8373.204545568162;8400.747977560683;8448.831023379498;8464.32285417165;8495.872561911576;573.4036601934025;589.6344266554763;610.1001023490405;638.3488841381765;641.1024565608093;3453.5855697316483;3803.410471376941;3919.9216015679526;3950.6049395060263;4082.6529744971417;96633;97730;99050.5047474758;99054.5047274759;99195.50402248088;80409.3918121646;80427;80818.59590702009;82699.5865020671;82832;67376.98934515986;69876.6506167476;72484.63757681283;73509;78594.60702696565;8491.880500805752;8854.734357969272;8898.332625053017;8901.821963560822;8903.465792052497;48498.545043648744;48703.5129648699;51888.22167667563;53201.46798531965;53295.73352133214;69552.9134125977;71822;73856.63071684608;74332.25667743254;74824.62587687027;10993.230473866752;11208.831867522156;11230.21388502797;11278.266912650652;11375.374354410587;12364.876351236373;12466.626001219978;12506.499740010298;12537.310447925453;12875.227486350848;11384.772304554028;11597;11597.130215233723;11795.646130616095;11937.820932685843;11687.824682629938;11706.590269340531;11803.291802491878;11944.462499187384;12052.638420847388;11383.829242561535;11385.829212561985;11448.141389395661;11463.828042579202;12057.336846473178;8036.598170091589;8123.025236971601;8198.672053118047;8217.83564328698;8279.668813247403;6917.757878474229;7888.881666775118;8112.22933821286;8332.583370831555;8356.247937685637 04:27:56 INFO - PROCESS | 1676 | __end_tp_report 04:27:56 INFO - PROCESS | 1676 | __start_cc_report 04:27:56 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,390 04:27:56 INFO - PROCESS | 1676 | __end_cc_report 04:27:56 INFO - PROCESS | 1676 | __startTimestamp1467545276167__endTimestamp 04:27:56 INFO - PROCESS | 1676 | 04:27:56 INFO - PROCESS | 1676 | ------- Summary: start ------- 04:27:56 INFO - PROCESS | 1676 | Number of tests: 6 04:27:56 INFO - PROCESS | 1676 | 04:27:56 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5898.61 Median:6177.44 stddev:659.08 (10.7%) stddev-sans-first:621.69 04:27:56 INFO - PROCESS | 1676 | Values: 3036.7 3690.4 3702.3 3719.4 3738.1 5901.0 5986.3 5987.4 6019.4 6055.7 5964.8 5992.6 6014.2 6019.0 6042.7 5245.2 5295.1 5339.4 5378.3 5464.5 5340.5 5394.4 5473.8 5506.1 5508.0 5398.8 5458.5 5465.0 5466.8 5488.0 5426.1 5444.3 5462.5 5464.9 5494.5 5265.1 5349.8 5358.5 5362.0 5407.5 4691.8 5835.6 5869.7 5922.9 5960.9 6236.8 6285.7 6321.1 6328.5 6333.2 6198.4 6366.1 6387.5 6394.9 6414.3 6055.8 6124.3 6139.7 6139.8 6140.3 6512.8 6548.2 6555.5 6568.1 6616.9 4852.4 5070.2 6301.5 6323.2 6325.9 5605.3 6314.7 6398.6 6423.1 6446.9 6224.5 6291.6 6302.1 6309.6 6328.5 6185.1 6253.1 6276.3 6278.6 6369.5 4362.2 5066.3 5073.3 5075.6 5089.7 4616.5 4621.0 4628.7 4640.4 4657.3 5994.6 6036.1 6111.4 6144.0 6177.4 6358.6 6378.9 6398.8 6407.2 6410.9 5073.5 6199.1 6204.0 6227.1 6232.4 5507.3 5561.8 5635.8 5639.7 5685.0 5498.9 6544.7 6552.5 6593.4 6609.1 5179.4 6361.9 6391.6 6394.9 6395.1 5546.5 6563.8 6613.7 6683.2 6696.0 6323.6 6342.6 6343.8 6351.0 6362.7 6268.2 6338.3 6390.3 6457.5 6468.4 6093.0 6213.0 6277.5 6281.9 6352.4 6244.2 6250.3 6256.7 6266.9 6275.8 6116.2 6135.8 6144.0 6151.9 6228.3 5938.3 6197.3 6215.9 6281.0 6282.9 6270.8 6314.1 6340.0 6342.4 6356.7 04:27:56 INFO - PROCESS | 1676 | 04:27:56 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:63225.86 Median:211742.34 stddev:136510.03 (64.5%) stddev-sans-first:136811.79 04:27:56 INFO - PROCESS | 1676 | Values: 520.3 560.3 567.7 588.4 613.3 38363.0 39254.0 39719.2 39823.0 39871.4 41442.4 42018.4 42069.9 42168.4 42208.6 9618.7 9817.0 9847.7 9868.2 9886.4 9667.3 9807.5 9869.9 9875.6 9931.9 9852.2 9923.9 9935.0 9951.8 9954.6 9843.5 9868.9 9900.8 9915.4 9922.1 9790.8 9847.9 9882.1 9882.1 9932.9 33613.0 39968.0 40286.8 40348.6 40396.4 3083.9 3212.3 3403.3 3529.9 3916.5 26488.3 26957.2 27419.3 27607.9 27705.6 2708.8 2712.1 2721.3 2746.2 2785.1 373404.0 380579.6 383307.0 384652.1 384962.1 36193.6 36249.3 36441.5 37452.8 38464.8 36340.6 36822.6 37061.9 37090.8 37158.6 13670.6 15836.8 15966.4 16002.5 16032.9 13644.6 13815.9 14022.9 14044.6 14069.6 8428.2 8486.5 8494.8 8591.4 8623.7 3061.3 3544.6 3596.4 3615.8 3629.8 1053.8 1057.9 1121.8 1210.7 1229.7 28497.0 30844.7 30889.4 30990.5 31318.9 1132.5 1173.2 1263.8 1281.9 1311.9 13166.8 14365.4 15865.0 15948.1 16182.5 600361.0 603204.0 604882.0 608640.0 610096.0 51692.0 58600.7 60917.7 60966.8 61777.0 1427.4 1532.9 1548.7 1574.4 1580.8 29444.7 30287.0 30629.8 30816.0 30972.4 52972.7 54018.7 54279.7 54470.0 54527.2 516904.0 517218.0 521317.0 523677.0 526040.0 27257.2 27599.4 28172.3 43916.6 44856.8 45011.0 45374.1 45600.5 46072.5 46123.1 36900.4 37862.2 38883.0 39401.6 39889.2 38522.6 38669.6 38694.6 38917.1 38986.0 38847.8 38951.2 39187.8 40010.6 40869.2 32830.7 33747.5 33788.9 34141.3 34299.7 25717.5 25769.1 25977.7 26081.7 26090.0 04:27:56 INFO - PROCESS | 1676 | 04:27:56 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:35858.46 Median:11855.27 stddev:104162.03 (878.6%) stddev-sans-first:104420.25 04:27:56 INFO - PROCESS | 1676 | Values: 421.6 424.8 428.2 431.5 434.4 20812.0 20849.1 21562.7 22190.7 22278.3 21211.9 21218.7 21271.9 21372.9 21583.1 6054.3 6333.1 6401.6 6407.4 6417.1 4650.9 5339.5 6395.2 6735.8 7046.0 6993.5 7002.3 7010.1 7017.9 7032.3 5714.9 6742.8 6879.1 6901.3 6904.5 5868.6 6081.8 6085.8 6091.8 6095.4 27183.9 27266.6 27775.7 27872.7 28185.3 2382.5 2450.3 2692.3 2768.4 3040.1 15437.5 15575.3 15983.5 16010.4 16030.5 1504.8 1741.4 1786.5 1849.5 1893.3 81634.8 83496.6 107058.4 107910.0 108062.4 11688.9 11894.2 11961.0 11987.1 12316.4 13082.3 14251.0 15111.3 15118.9 15168.9 8356.5 8804.8 9153.0 9410.6 9512.7 9596.6 9648.4 9813.0 9934.9 9953.9 6329.2 7080.9 7225.6 7325.6 7327.0 1948.2 2005.3 2074.4 2147.7 2147.9 948.8 1008.7 1039.2 1049.2 1108.9 18698.3 20806.7 21313.3 21433.6 22392.4 1031.7 1046.5 1081.6 1087.4 1088.2 11483.2 11831.4 11982.7 11987.2 12012.0 599957.0 608260.0 611101.0 646346.0 672559.0 130120.0 130464.0 133683.3 136372.0 136927.0 1073.1 1079.5 1088.9 1102.9 1108.3 18969.4 19423.4 19606.2 19718.9 19865.2 37941.6 49192.3 51794.5 52914.9 55882.4 58314.5 73869.3 77873.4 78496.0 78802.0 8234.4 8489.5 8594.3 8669.3 8755.4 11006.8 12417.0 13572.5 13772.6 13850.4 11751.2 11784.8 11828.6 11889.7 11889.7 10457.6 10932.9 11173.5 11618.9 11682.5 11575.9 11773.4 11809.5 11890.0 12128.3 8143.8 8412.2 8664.1 8708.1 8955.1 9601.2 10262.6 11663.7 11755.5 11806.8 04:27:56 INFO - PROCESS | 1676 | 04:27:56 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:5942.29 Median:5035.28 stddev:3290.33 (65.3%) stddev-sans-first:3282.24 04:27:56 INFO - PROCESS | 1676 | Values: 1450.2 1628.8 1875.7 2011.4 2064.5 8331.5 9035.0 9086.9 9278.0 9298.3 9078.7 9105.5 9175.9 9199.8 9223.4 2538.6 2541.9 2566.2 2566.6 2569.6 2155.0 2495.2 2561.7 2564.3 2575.7 2135.3 2527.3 2549.5 2577.3 2591.6 2534.2 2543.1 2555.3 2573.0 2573.9 2096.4 2564.2 2569.8 2570.9 2574.1 9276.9 9299.5 9315.2 9325.4 9326.1 4684.7 5042.5 5604.4 5798.7 5845.9 3611.5 3711.8 3727.5 3777.5 3786.6 939.4 1074.1 1096.3 1096.5 1099.0 12173.6 12385.6 12400.9 12401.5 12425.5 5014.2 5045.0 5051.3 5080.6 5102.1 10537.6 10551.1 10557.6 10573.9 10590.0 5619.9 5629.7 5684.5 5733.7 5741.5 4626.0 5028.0 5074.8 5077.0 5235.3 3935.8 4180.1 4187.9 4281.8 4312.2 1304.6 1401.2 1402.4 1415.5 1424.5 852.9 985.4 986.6 1001.8 1007.6 6016.2 6097.0 6166.8 6262.9 6336.3 953.5 980.1 1024.7 1039.8 1080.5 4056.0 4067.6 4153.8 4207.5 4220.3 10884.1 10976.6 11052.2 11188.4 11203.8 10609.9 10670.7 10692.5 10815.3 10978.7 8557.2 8624.5 8722.1 8846.9 8869.9 6020.5 6073.9 6075.2 6092.6 6191.7 9898.4 9966.2 10022.5 10081.0 10113.3 10112.6 10296.4 10348.5 10391.9 10663.2 6655.6 7079.6 7302.2 7304.5 7424.9 8590.4 8596.2 8669.1 8674.8 8681.5 7487.7 7680.5 7751.1 7756.8 7841.5 7508.1 7597.7 7612.8 7617.2 7692.1 6086.0 6251.4 7312.8 7373.7 7377.1 5052.3 5067.3 5152.4 5182.6 5212.7 5184.5 5194.9 5268.6 5301.3 5391.7 04:27:56 INFO - PROCESS | 1676 | 04:27:56 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:6229.40 Median:7145.14 stddev:2037.96 (28.5%) stddev-sans-first:1995.18 04:27:56 INFO - PROCESS | 1676 | Values: 341.6 346.3 347.6 348.1 357.9 7128.3 7136.5 7149.6 7156.2 7160.8 7041.8 7082.8 7133.9 7153.5 7163.4 4908.7 4949.3 5119.8 5120.4 5121.6 4597.4 4689.4 5091.6 5124.4 5125.6 4130.6 4506.0 5048.5 5093.7 5134.6 5108.0 5114.9 5119.5 5158.8 5182.9 4392.1 4394.9 4405.9 4412.5 4420.7 5277.7 5858.4 6620.2 6807.4 6852.5 5986.5 6023.0 6042.7 6048.7 6073.3 7591.4 7613.7 7616.4 7620.4 7813.8 4953.3 4972.7 4979.3 4984.2 4990.5 7905.4 8046.9 8104.9 8105.1 8149.0 5032.9 5079.9 5084.8 5085.6 5105.2 5179.9 5188.6 5193.2 5201.4 5207.5 6016.6 6018.6 6026.5 6033.9 6038.8 6243.0 7668.5 7696.6 7718.7 7727.1 1650.7 1731.7 1781.1 1813.0 1813.5 1075.5 1075.7 1102.3 1102.8 1103.0 7140.9 7198.5 7222.2 7227.9 7248.3 7692.4 7896.1 7916.0 7928.7 7942.2 6986.1 7149.4 7227.6 7301.4 7348.2 4214.6 4264.4 4274.7 4276.1 4295.8 8434.6 8439.4 8450.6 8454.5 8504.4 6719.8 7502.6 7653.8 8263.5 8326.8 8350.5 8405.0 8405.1 8419.1 8419.4 6564.6 7242.3 8016.0 8046.0 8057.6 7654.6 7888.8 7901.4 7917.7 7921.8 8270.8 8380.9 8387.1 8443.6 8464.2 4827.0 4929.5 4929.6 4953.9 4972.1 7971.5 7981.5 7992.4 7996.0 8036.3 7402.9 7705.4 7757.4 7778.2 7812.3 6471.5 7459.9 7699.5 7713.4 7728.2 7513.8 7527.3 7536.5 7557.4 7561.0 7739.5 7741.5 7749.7 7764.1 7765.1 7310.9 7582.9 7591.5 7605.3 7615.0 04:27:56 INFO - PROCESS | 1676 | 04:27:56 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:19000.79 Median:605.95 stddev:26969.03 (4450.7%) stddev-sans-first:27009.75 04:27:56 INFO - PROCESS | 1676 | Values: 718.7 749.2 752.2 772.8 789.8 15179.5 15475.9 15498.1 15504.5 15521.4 14160.6 14179.1 14216.9 14225.7 14241.7 783.7 942.2 955.4 981.9 987.8 944.4 953.5 962.0 964.8 965.9 980.3 1013.4 1037.4 1040.0 1040.4 974.4 974.5 981.2 1034.3 1035.3 726.4 726.6 775.6 781.6 782.5 15203.9 15238.8 15269.5 15322.7 15342.7 13446.6 13459.3 13478.9 13648.0 13652.8 10302.9 10333.6 10403.6 10470.5 10641.4 3226.3 3503.6 3551.5 3699.4 3879.7 81991.2 82129.0 82310.9 83277.2 83579.0 9883.6 9892.0 9909.0 10047.9 10135.6 23021.1 23278.5 23387.6 23720.8 23723.2 7658.0 7833.4 7919.9 8175.5 8247.5 4212.2 4228.0 4256.3 4286.2 4405.2 3725.9 3748.2 3769.7 3786.9 3811.5 673.8 713.5 718.3 740.1 748.5 601.8 614.5 617.3 619.5 627.6 8373.2 8400.7 8448.8 8464.3 8495.9 573.4 589.6 610.1 638.3 641.1 3453.6 3803.4 3919.9 3950.6 4082.7 96633.0 97730.0 99050.5 99054.5 99195.5 80409.4 80427.0 80818.6 82699.6 82832.0 67377.0 69876.7 72484.6 73509.0 78594.6 8491.9 8854.7 8898.3 8901.8 8903.5 48498.5 48703.5 51888.2 53201.5 53295.7 69552.9 71822.0 73856.6 74332.3 74824.6 10993.2 11208.8 11230.2 11278.3 11375.4 12364.9 12466.6 12506.5 12537.3 12875.2 11384.8 11597.0 11597.1 11795.6 11937.8 11687.8 11706.6 11803.3 11944.5 12052.6 11383.8 11385.8 11448.1 11463.8 12057.3 8036.6 8123.0 8198.7 8217.8 8279.7 6917.8 7888.9 8112.2 8332.6 8356.2 04:27:56 INFO - PROCESS | 1676 | -------- Summary: end -------- 04:27:56 INFO - PROCESS | 1676 | 04:27:56 INFO - TEST-INFO | 1676: exit 0 04:27:56 INFO - TEST-OK | dromaeo_css | took 1109322ms 04:27:56 INFO - TEST-START | kraken 04:27:56 INFO - operating with platform_type : mac_ 04:27:56 INFO - Initialising browser for kraken test... 04:27:56 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpDg8id6/profile http://localhost:49264/getInfo.html) 04:27:59 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 04:27:59 INFO - PROCESS | 1684 | colorDepth:24 04:27:59 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 04:27:59 INFO - PROCESS | 1684 | __metrics 04:27:59 ERROR - PROCESS | 1684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:28:00 INFO - TEST-INFO | 1684: exit 0 04:28:00 INFO - Browser initialized. 04:28:00 INFO - Running cycle 1/1 for kraken test... 04:28:00 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/T/tmpDg8id6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:12 INFO - PROCESS | 1688 | RSS: Main: 171003904 04:28:12 INFO - PROCESS | 1688 | 04:28:14 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:15 INFO - PROCESS | 1688 | RSS: Main: 184102912 04:28:15 INFO - PROCESS | 1688 | 04:28:18 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 04:28:18 INFO - PROCESS | 1688 | RSS: Main: 193126400 04:28:18 INFO - PROCESS | 1688 | 04:28:22 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 04:28:22 INFO - PROCESS | 1688 | RSS: Main: 196722688 04:28:22 INFO - PROCESS | 1688 | 04:28:24 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 04:28:25 INFO - PROCESS | 1688 | RSS: Main: 198037504 04:28:25 INFO - PROCESS | 1688 | 04:28:27 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:28 INFO - PROCESS | 1688 | RSS: Main: 198492160 04:28:28 INFO - PROCESS | 1688 | 04:28:31 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:31 INFO - PROCESS | 1688 | RSS: Main: 198897664 04:28:31 INFO - PROCESS | 1688 | 04:28:34 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:35 INFO - PROCESS | 1688 | RSS: Main: 198864896 04:28:35 INFO - PROCESS | 1688 | 04:28:38 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 04:28:38 INFO - PROCESS | 1688 | RSS: Main: 198934528 04:28:38 INFO - PROCESS | 1688 | 04:28:40 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:40 INFO - PROCESS | 1688 | RSS: Main: 198127616 04:28:40 INFO - PROCESS | 1688 | 04:28:42 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:43 INFO - PROCESS | 1688 | RSS: Main: 198115328 04:28:43 INFO - PROCESS | 1688 | 04:28:45 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:46 INFO - PROCESS | 1688 | RSS: Main: 198557696 04:28:46 INFO - PROCESS | 1688 | 04:28:48 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:49 INFO - PROCESS | 1688 | RSS: Main: 198676480 04:28:49 INFO - PROCESS | 1688 | 04:28:52 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:53 INFO - PROCESS | 1688 | RSS: Main: 198483968 04:28:53 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 04:28:54 INFO - PROCESS | 1688 | RSS: Main: 200253440 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | __start_tp_report 04:28:54 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 04:28:54 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 04:28:54 INFO - PROCESS | 1688 | |i|pagename|runs| 04:28:54 INFO - PROCESS | 1688 | |0;ai-astar;120;149;117;116;117;132;114;115;116;117 04:28:54 INFO - PROCESS | 1688 | |1;audio-beat-detection;168;152;142;164;121;139;122;157;156;118 04:28:54 INFO - PROCESS | 1688 | |2;audio-dft;178;255;270;209;193;195;200;219;178;259 04:28:54 INFO - PROCESS | 1688 | |3;audio-fft;65;71;79;148;77;82;85;85;129;58 04:28:54 INFO - PROCESS | 1688 | |4;audio-oscillator;77;80;124;77;81;96;119;79;79;119 04:28:54 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;137;132;88;85;89;85;89;87;89;89 04:28:54 INFO - PROCESS | 1688 | |6;imaging-darkroom;151;149;95;94;96;95;95;95;94;94 04:28:54 INFO - PROCESS | 1688 | |7;imaging-desaturate;101;142;96;103;99;99;96;99;97;89 04:28:54 INFO - PROCESS | 1688 | |8;json-parse-financial;59;66;65;66;66;65;64;78;63;61 04:28:54 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;66;63;70;65;70;72;68;66;66;67 04:28:54 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;86;108;107;77;83;79;79;82;83;85 04:28:54 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;112;141;150;143;124;124;124;135;174;150 04:28:54 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;148;221;214;162;168;171;193;212;210;163 04:28:54 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;72;68;65;70;68;68;67;68;68;66 04:28:54 INFO - PROCESS | 1688 | __end_tp_report 04:28:54 INFO - PROCESS | 1688 | __start_cc_report 04:28:54 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,1031 04:28:54 INFO - PROCESS | 1688 | __end_cc_report 04:28:54 INFO - PROCESS | 1688 | __startTimestamp1467545334981__endTimestamp 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | ------- Summary: start ------- 04:28:54 INFO - PROCESS | 1688 | Number of tests: 14 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:121.30 Median:117.00 stddev:11.00 (9.4%) stddev-sans-first:11.65 04:28:54 INFO - PROCESS | 1688 | Values: 120.0 149.0 117.0 116.0 117.0 132.0 114.0 115.0 116.0 117.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:154.00 stddev:18.47 (12.0%) stddev-sans-first:17.41 04:28:54 INFO - PROCESS | 1688 | Values: 168.0 152.0 142.0 164.0 121.0 139.0 122.0 157.0 156.0 118.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:215.60 Median:214.00 stddev:34.09 (15.9%) stddev-sans-first:33.33 04:28:54 INFO - PROCESS | 1688 | Values: 178.0 255.0 270.0 209.0 193.0 195.0 200.0 219.0 178.0 259.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:87.90 Median:78.00 stddev:28.39 (36.4%) stddev-sans-first:28.88 04:28:54 INFO - PROCESS | 1688 | Values: 65.0 71.0 79.0 148.0 77.0 82.0 85.0 85.0 129.0 58.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:79.00 stddev:19.83 (25.1%) stddev-sans-first:20.16 04:28:54 INFO - PROCESS | 1688 | Values: 77.0 80.0 124.0 77.0 81.0 96.0 119.0 79.0 79.0 119.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:88.50 stddev:19.86 (22.4%) stddev-sans-first:14.88 04:28:54 INFO - PROCESS | 1688 | Values: 137.0 132.0 88.0 85.0 89.0 85.0 89.0 87.0 89.0 89.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:105.80 Median:95.00 stddev:23.31 (24.5%) stddev-sans-first:18.10 04:28:54 INFO - PROCESS | 1688 | Values: 151.0 149.0 95.0 94.0 96.0 95.0 95.0 95.0 94.0 94.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:102.10 Median:96.50 stddev:14.51 (15.0%) stddev-sans-first:15.38 04:28:54 INFO - PROCESS | 1688 | Values: 101.0 142.0 96.0 103.0 99.0 99.0 96.0 99.0 97.0 89.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.50 stddev:5.03 (7.7%) stddev-sans-first:4.80 04:28:54 INFO - PROCESS | 1688 | Values: 59.0 66.0 65.0 66.0 66.0 65.0 64.0 78.0 63.0 61.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:2.71 (4.0%) stddev-sans-first:2.83 04:28:54 INFO - PROCESS | 1688 | Values: 66.0 63.0 70.0 65.0 70.0 72.0 68.0 66.0 66.0 67.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:82.50 stddev:11.21 (13.6%) stddev-sans-first:11.88 04:28:54 INFO - PROCESS | 1688 | Values: 86.0 108.0 107.0 77.0 83.0 79.0 79.0 82.0 83.0 85.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:142.00 stddev:17.92 (12.6%) stddev-sans-first:16.42 04:28:54 INFO - PROCESS | 1688 | Values: 112.0 141.0 150.0 143.0 124.0 124.0 124.0 135.0 174.0 150.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.20 Median:201.50 stddev:26.68 (13.2%) stddev-sans-first:24.46 04:28:54 INFO - PROCESS | 1688 | Values: 148.0 221.0 214.0 162.0 168.0 171.0 193.0 212.0 210.0 163.0 04:28:54 INFO - PROCESS | 1688 | 04:28:54 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.94 (2.9%) stddev-sans-first:1.42 04:28:54 INFO - PROCESS | 1688 | Values: 72.0 68.0 65.0 70.0 68.0 68.0 67.0 68.0 68.0 66.0 04:28:54 INFO - PROCESS | 1688 | -------- Summary: end -------- 04:28:54 INFO - PROCESS | 1688 | 04:28:55 INFO - TEST-INFO | 1688: exit 0 04:28:55 INFO - TEST-OK | kraken | took 59276ms 04:28:55 INFO - SUITE-END | took 1168s 04:28:56 INFO - Completed test suite (00:19:28) 04:28:56 INFO - javascript benchmark 04:28:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3036.7266945974866, 3690.3910854708975, 3702.296563652904, 3719.423489359149, 3738.1028553147235, 5900.9999999999945, 5986.281646202451, 5987.371326010761, 6019.428154325337, 6055.666938318391, 5964.761409543624, 5992.640441573509, 6014.218151640281, 6019.0, 6042.728077236524, 5245.213218017299, 5295.099833028395, 5339.385970613391, 5378.327709036371, 5464.453554644524, 5340.54605358545, 5394.406615272317, 5473.8357849264585, 5506.091494903336, 5508.03609368361, 5398.784048638069, 5458.536024437908, 5465.0, 5466.835994920159, 5487.972560137214, 5426.077566813651, 5444.3194600674915, 5462.4978131013895, 5464.9453505464835, 5494.478024587658, 5265.052290587692, 5349.839504814861, 5358.517733404013, 5361.98122356751, 5407.459254074601, 4691.7888695008805, 5835.649861008353, 5869.706514674249, 5922.940770592282, 5960.850978725523, 6236.812895613093, 6285.748570057192, 6321.1150438938585, 6328.462080723144, 6333.176687030703, 6198.411150940653, 6366.108744775735, 6387.489000879965, 6394.872102557969, 6414.294427612959, 6055.788047418363, 6124.319907527392, 6139.74593465464, 6139.8294713812775, 6140.289530736413, 6512.837179070561, 6548.246951600531, 6555.508336874658, 6568.113304703804, 6616.86766264672, 4852.417709874767, 5070.188769796889, 6301.52738544611, 6323.20959880015, 6325.873482530324, 5605.32736071674, 6314.71583778731, 6398.616083035033, 6423.068655044993, 6446.935530644727, 6224.533160013018, 6291.571093753915, 6302.1492098566105, 6309.589876658002, 6328.493720502349, 6185.072239164161, 6253.062040693932, 6276.340984196685, 6278.623282603058, 6369.49044076482, 4362.192994296065, 5066.341375621219, 5073.315102461121, 5075.593952483792, 5089.694618322913, 4616.515265897033, 4621.0, 4628.69913455631, 4640.350350950869, 4657.278121891112, 5994.550408719363, 6036.0644100164545, 6111.379037751179, 6143.96928015366, 6177.444030037318, 6358.618482890949, 6378.936210637927, 6398.776042838478, 6407.167068281094, 6410.903836442457, 5073.518015788494, 6199.132121502993, 6204.038374052029, 6227.097070924781, 6232.407921247474, 5507.256520369699, 5561.805336813192, 5635.774569017275, 5639.689817060101, 5685.005124103265, 5498.890022199534, 6544.7382104716235, 6552.50856185788, 6593.3736295051895, 6609.140811694545, 5179.404368497671, 6361.904571431525, 6391.58454700443, 6394.936050639621, 6395.072714456471, 5546.473085056913, 6563.7702680405955, 6613.735450581923, 6683.164604424447, 6696.029075784081, 6323.557350985571, 6342.556021078481, 6343.841403964753, 6350.968245158745, 6362.713677884599, 6268.153799237227, 6338.334474880071, 6390.297067322684, 6457.4511166551365, 6468.417842394207, 6093.025115981422, 6213.0, 6277.497800176066, 6281.905771413341, 6352.36476352361, 6244.157038799885, 6250.312465628868, 6256.749730010749, 6266.905996409966, 6275.843103922256, 6116.235470566179, 6135.753292002278, 6144.0, 6151.907721384094, 6228.283747369111, 5938.287405511366, 6197.349278325711, 6215.9378406215355, 6281.0, 6282.937170628235, 6270.7805226816845, 6314.084457753508, 6339.96830015847, 6342.429181373698, 6356.68216589178], "value": 5860.818862649753, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.2690220240561, 560.3108176942361, 567.7331654122561, 588.4380416702048, 613.2977740487139, 38363.0, 39254.0, 39719.2056158877, 39823.0, 39871.40192897109, 41442.37836432448, 42018.36972445408, 42069.94825129373, 42168.36747448791, 42208.57791422085, 9618.711438656834, 9817.0, 9847.70456886291, 9868.161206297473, 9886.357386769872, 9667.323287369887, 9807.460589667566, 9869.90130098697, 9875.555599998017, 9931.851022234672, 9852.162566181883, 9923.851142232836, 9934.950325248363, 9951.800963980717, 9954.601815927354, 9843.507824608776, 9868.90131098687, 9900.811902571737, 9915.405075695446, 9922.057404546556, 9790.804183916282, 9847.90152098477, 9882.11061004513, 9882.11061004513, 9932.851007234898, 33613.0, 39968.0, 40286.79856600727, 40348.596514035075, 40396.394054089214, 3083.8920637777796, 3212.2611799286296, 3403.3363494118657, 3529.8588056477965, 3916.5104361954754, 26488.337791555172, 26957.191284261502, 27419.31451713703, 27607.86196069007, 27705.584416233774, 2708.79684023699, 2712.1050053482304, 2721.3468767495856, 2746.244782684758, 2785.1226863537922, 373404.0, 380579.58261252206, 383307.0, 384652.07673961733, 384962.07518962224, 36193.63806361955, 36249.27501449956, 36441.453378199345, 37452.812735936146, 38464.807675962, 36340.636593634255, 36822.63177368192, 37061.8881433552, 37090.814545927635, 37158.628413715516, 13670.589882303548, 15836.841631583768, 15966.36134554628, 16002.519924402286, 16032.919835400748, 13644.590662280147, 13815.930920345534, 14022.948278879125, 14044.648883777987, 14069.577912662637, 8428.199321064489, 8486.490810551386, 8494.787630309293, 8591.3556483264, 8623.741287761377, 3061.3112049789065, 3544.5746510418917, 3596.352656521799, 3615.7649752765988, 3629.8003609801713, 1053.847192157133, 1057.931234469757, 1121.770037142384, 1210.691273725212, 1229.6679896427913, 28497.00260490873, 30844.69155308463, 30889.382212355627, 30990.535141972887, 31318.903838365546, 1132.473399869065, 1173.184636677501, 1263.77252094622, 1281.9038572106942, 1311.8819306262483, 13166.802497962539, 14365.425382984564, 15865.0, 15948.086229652516, 16182.514524564282, 600361.0, 603204.0, 604881.975590128, 608640.0, 610096.0, 51692.0, 58600.706996464745, 60917.69541152266, 60966.78066438646, 61777.0, 1427.4076258352668, 1532.9422698338335, 1548.7289724298203, 1574.4491675699428, 1580.8498192671677, 29444.705552944197, 30287.0, 30629.846850766495, 30816.0, 30972.380552388375, 52972.73513632562, 54018.729906350214, 54279.72860135674, 54470.0, 54527.18209226785, 516904.0, 517218.0, 521317.0, 523677.0, 526040.0, 27257.182284531496, 27599.448011039265, 28172.295692607848, 43916.56083439253, 44856.775716121214, 45011.0, 45374.092518150115, 45600.543994560954, 46072.53927460816, 46123.07753844837, 36900.446493302086, 37862.24275514529, 38883.0, 39401.60598393979, 39889.2022159561, 38522.6147738519, 38669.61330386773, 38694.61305387023, 38917.14372701065, 38986.0, 38847.80576097214, 38951.220975580894, 39187.804060980656, 40010.599894001854, 40869.1826163481, 32830.67169328276, 33747.493787593696, 33788.924053792165, 34141.317173656884, 34299.657003429646, 25717.485650287264, 25769.098081567055, 25977.74022259753, 26081.73918260793, 26090.0], "value": 18784.182804474643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.57210431412125, 424.8194517330134, 428.21208975485104, 431.5296327003566, 434.3896824960929, 20812.0, 20849.06179221935, 21562.676559851614, 22190.667139992915, 22278.331650050484, 21211.893940530277, 21218.681719774217, 21271.893640531776, 21372.89313553434, 21583.136674533038, 6054.303755068157, 6333.05004249364, 6401.615903045809, 6407.423331900128, 6417.133686952272, 4650.883727906812, 5339.546138578206, 6395.232572091332, 6735.8316042099095, 7046.013558101869, 6993.545419547739, 7002.264762199972, 7010.088688470517, 7017.8596428071405, 7032.261612530688, 5714.942735593908, 6742.8314292142595, 6879.105716256905, 6901.275366086589, 6904.516683832134, 5868.618539794899, 6081.756729730805, 6085.786997455112, 6091.817245482643, 6095.359987201368, 27183.86408067967, 27266.591001135, 27775.722242777516, 27872.721272787214, 28185.295367615974, 2382.4758553118286, 2450.2649205238536, 2692.2865440658243, 2768.44631073784, 3040.148758347666, 15437.459688910834, 15575.321163617626, 15983.520494385188, 16010.359585616561, 16030.519084427486, 1504.8495150484973, 1741.4253296412153, 1786.499780061585, 1849.537615596101, 1893.2710906301172, 81634.77547836787, 83496.58251708763, 107058.3941240882, 107910.0, 108062.3790643141, 11688.88311116878, 11894.167408281337, 11960.983316418027, 11987.100967427303, 12316.384180790925, 13082.345882706017, 14251.00242983002, 15111.31999060045, 15118.924405378122, 15168.924155379373, 8356.498610083414, 8804.767332573445, 9152.954235228914, 9410.623575057058, 9512.714618561455, 9596.568154433067, 9648.421094734338, 9813.0, 9934.900650993397, 9953.85992011721, 6329.208848893888, 7080.937859321143, 7225.638718064076, 7325.560466371928, 7326.96336518314, 1948.2499237793552, 2005.2580545198077, 2074.3984244568906, 2147.6778483227326, 2147.860389074705, 948.7628092976756, 1008.742770593494, 1039.1946241662772, 1049.228816819637, 1108.8503052087865, 18698.34555790541, 20806.687899681518, 21313.25403610897, 21433.571328573653, 22392.440188995406, 1031.7317497450567, 1046.4976811130548, 1081.5727787523883, 1087.3910610058392, 1088.2382332367374, 11483.196176267582, 11831.408429578487, 11982.700432489084, 11987.22083064598, 12012.0, 599957.0, 608260.0, 611101.0, 646346.0, 672559.0, 130120.0, 130464.0, 133683.33158334147, 136371.99999999802, 136927.0, 1073.0825144501496, 1079.5357996061612, 1088.9346639201674, 1102.944852757375, 1108.2630051016145, 18969.43091707251, 19423.417297480533, 19606.215751370357, 19718.924927547785, 19865.205391784166, 37941.62058379492, 49192.26211606757, 51794.48205518047, 52914.94170116653, 55882.44117558772, 58314.54213644693, 73869.26130738624, 77873.4425311502, 78496.0, 78802.0, 8234.382421318305, 8489.533075680896, 8594.312455003459, 8669.306455483673, 8755.430896991675, 11006.779864402828, 12417.006639469002, 13572.457101716216, 13772.586822395344, 13850.376733047238, 11751.17741758103, 11784.76430471403, 11828.585999489977, 11889.692133865095, 11889.702757431134, 10457.633982810565, 10932.94533527359, 11173.497192626513, 11618.94190529042, 11682.47428865686, 11575.88424115748, 11773.411329433322, 11809.527618895148, 11890.0, 12128.332941688292, 8143.837123257384, 8412.242898138951, 8664.133586641285, 8708.129187081242, 8955.104489550993, 9601.231901447727, 10262.58949642006, 11663.65009049696, 11755.47100380502, 11806.822897656713], "value": 10285.458158927511, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.209635748517, 1628.8208297087322, 1875.7186422036693, 2011.4166891601428, 2064.4916426541768, 8331.500109993405, 9034.954825225865, 9086.86369704454, 9278.02580729023, 9298.302627302954, 9078.682246121387, 9105.499197544132, 9175.944766351871, 9199.816003679922, 9223.400478968862, 2538.6445897574354, 2541.9491610167784, 2566.242958327298, 2566.6278389633585, 2569.627404026415, 2155.0, 2495.2264797912703, 2561.6669832921693, 2564.3076369380256, 2575.6780402449695, 2135.306025541697, 2527.292358139724, 2549.528337257604, 2577.2783620586265, 2591.598302263152, 2534.176392672389, 2543.071778800743, 2555.2589748972778, 2572.996531352774, 2573.9318182954053, 2096.3501314592527, 2564.192279431973, 2569.8072644551735, 2570.9485810283877, 2574.0604679291923, 9276.860847087299, 9299.48852813095, 9315.161635452841, 9325.44047357154, 9326.114019168168, 4684.672072954894, 5042.520960508746, 5604.355499117612, 5798.7100644968, 5845.85385365365, 3611.5305010348748, 3711.832967516468, 3727.5154229949935, 3777.471154038437, 3786.6024067473068, 939.417561112108, 1074.1031238915516, 1096.3476731344838, 1096.4901320885826, 1098.9780204395947, 12173.634790956285, 12385.566505172275, 12400.937995309965, 12401.503939842396, 12425.502979880794, 5014.172661510883, 5044.965782014679, 5051.292819005343, 5080.59355251579, 5102.08162530748, 10537.578496860193, 10551.050405463546, 10557.577696892193, 10573.9471302643, 10590.046895779416, 5619.887602247933, 5629.7185140742795, 5684.488396044293, 5733.741981610838, 5741.45456181662, 4625.976870115628, 5028.044671512401, 5074.797008119708, 5077.0, 5235.267062611238, 3935.8389275163895, 4180.080382315886, 4187.895302617459, 4281.828726850891, 4312.202242585132, 1304.6412236634812, 1401.2293238718867, 1402.4320150339129, 1415.469199050356, 1424.5156646739952, 852.9019162796234, 985.3545927417553, 986.6349450703286, 1001.839705647093, 1007.6019972110975, 6016.217891674054, 6096.969515152396, 6166.784162554289, 6262.874742505124, 6336.334684858116, 953.512520468072, 980.122790102854, 1024.71820249432, 1039.8405777558119, 1080.524569189554, 4055.9797201013807, 4067.633912947849, 4153.813078411479, 4207.453031105937, 4220.282551966173, 10884.07485363753, 10976.615818446317, 11052.226344155832, 11188.384638844778, 11203.775924481464, 10609.893901061045, 10670.679879603624, 10692.465376731132, 10815.297005694605, 10978.670639880816, 8557.229849313591, 8624.482531048283, 8722.127787221227, 8846.867296990551, 8869.911300887037, 6020.548458865515, 6073.939260607514, 6075.2405949256345, 6092.634441933498, 6191.659458729813, 9898.356606820533, 9966.152877005536, 10022.498875056364, 10081.0, 10113.29206955506, 10112.646057387956, 10296.433696146783, 10348.53431595595, 10391.896081039093, 10663.200259980378, 6655.600663960178, 7079.610621415872, 7302.160251571137, 7304.452166087671, 7424.851502969802, 8590.379934120154, 8596.226339629464, 8669.133086691532, 8674.826503469769, 8681.479111253346, 7487.737929172453, 7680.500767450098, 7751.069871615442, 7756.767296981099, 7841.490303130278, 7508.136564295176, 7597.696092156252, 7612.7716168515035, 7617.238276172338, 7692.115406728074, 6085.9695701521205, 6251.437370636664, 7312.780616581511, 7373.668184931584, 7377.077865266841, 5052.343195384724, 5067.315912351933, 5152.381714194321, 5182.559482444034, 5212.739363031909, 5184.533391994739, 5194.8961020780125, 5268.57851371897, 5301.310829592128, 5391.676499410048], "value": 4807.916762789936, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.5883859948762, 346.28319378885703, 347.555129434324, 348.06197298281126, 357.871166380103, 7128.251533588977, 7136.500444968854, 7149.606771627558, 7156.177039640443, 7160.785176444709, 7041.823954401142, 7082.752103676372, 7133.89299160513, 7153.499255052148, 7163.426925845933, 4908.7300198489065, 4949.331840201581, 5119.7696103675235, 5120.411152717429, 5121.641485096045, 4597.379353787246, 4689.3669354637195, 5091.618128640348, 5124.359455068116, 5125.641205115643, 4130.648894843942, 4506.031203291292, 5048.495150484959, 5093.745312734367, 5134.614903882205, 5107.999999999982, 5114.897702045957, 5119.462456442076, 5158.845234642967, 5182.870428239286, 4392.099619577979, 4394.934075988863, 4405.9118817623785, 4412.499750084987, 4420.690551661385, 5277.683338999673, 5858.443447872445, 6620.205575330991, 6807.421369183626, 6852.45180385573, 5986.461218490357, 6023.036314189709, 6042.697865106771, 6048.69756512177, 6073.331933487313, 7591.3926885849, 7613.733519326797, 7616.352610028154, 7620.390368770485, 7813.765587032398, 4953.281774142765, 4972.657382506739, 4979.278004689336, 4984.152694041985, 4990.525900039491, 7905.407094467938, 8046.879296810611, 8104.878426823602, 8105.148959359241, 8149.022117345897, 5032.874178145576, 5079.873003174876, 5084.8220312288895, 5085.64400491962, 5105.2342148678, 5179.896402071938, 5188.610854185876, 5193.221016847503, 5201.401838788512, 5207.479252074762, 6016.608920420159, 6018.608790428696, 6026.487748541423, 6033.939660603338, 6038.818835434944, 6242.968785156045, 7668.539887606761, 7696.576688282198, 7718.691252349955, 7727.111382191008, 1650.6616143690514, 1731.714267145932, 1781.1361489677497, 1812.984728552015, 1813.4650278167971, 1075.5482697267166, 1075.6880504653564, 1102.2614848051824, 1102.8290614954694, 1102.972425689348, 7140.892886606705, 7198.460115491359, 7222.241664625244, 7227.89158162628, 7248.275172482709, 7692.423068269902, 7896.091949425775, 7916.0, 7928.6828526859435, 7942.166072562413, 6986.091808065021, 7149.392301654418, 7227.566346019255, 7301.415886729049, 7348.191698913115, 4214.578542145761, 4264.424302719155, 4274.7435153890865, 4276.123394704078, 4295.8496452624, 8434.62044208012, 8439.409241353169, 8450.619722112397, 8454.535000575028, 8504.44721093127, 6719.798406047728, 7502.612016776805, 7653.770386888402, 8263.462874913112, 8326.83346333082, 8350.498970061815, 8404.957975210085, 8405.075441701409, 8419.07390187079, 8419.368547358972, 6564.606123632598, 7242.275772422716, 8016.0, 8045.9597702011115, 8057.637406316612, 7654.578998155155, 7888.7633370998965, 7901.367890568626, 7917.722879699183, 7921.841563168589, 8270.751877443687, 8380.916190838014, 8387.119352467904, 8443.577821108796, 8464.195901389357, 4826.975865120652, 4929.507049295042, 4929.5809856161195, 4953.851384458472, 4972.129877271391, 7971.521708697497, 7981.521108733495, 7992.400569957393, 7996.0, 8036.316913062456, 7402.851942961003, 7705.42209334291, 7757.418193635387, 7778.222177782177, 7812.257835505618, 6471.4822814175695, 7459.918311844861, 7699.538027718355, 7713.382929365749, 7728.188540203422, 7513.774586762187, 7527.322540971339, 7536.472446928662, 7557.433192510473, 7561.0, 7739.458237923292, 7741.458097933316, 7749.690012399441, 7764.145943946274, 7765.145833958373, 7310.890336645061, 7582.886256706043, 7591.506552074097, 7605.277498637621, 7615.010048693634], "value": 5542.20036836969, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.6658203935173, 749.1759065028468, 752.2214507984233, 772.7681695491351, 789.8183417813901, 15179.544613661594, 15475.922620386911, 15498.07011579306, 15504.457343992963, 15521.379144834207, 14160.57518274451, 14179.078359906598, 14216.92891535541, 14225.71548569028, 14241.715165696705, 783.6943591999125, 942.2226663003015, 955.4458414119794, 981.8576306435563, 987.7579992901714, 944.4474982135459, 953.4708236928502, 961.9903800961971, 964.7588102974256, 965.946872921989, 980.3235767320562, 1013.4020927652683, 1037.424229552598, 1039.9844002339971, 1040.3705758016404, 974.3812678948848, 974.4543055888724, 981.2101258486915, 1034.3328553083295, 1035.2908257843364, 726.3644311227675, 726.625787719325, 775.5618075787162, 781.620913856779, 782.5109306683323, 15203.923980380026, 15238.771418428732, 15269.541913742605, 15322.693546129127, 15342.693146137015, 13446.596602101952, 13459.259740714257, 13478.932605337008, 13648.044636875422, 13652.795208071886, 10302.948485257526, 10333.58665653373, 10403.5838566458, 10470.47647617616, 10641.414722190277, 3226.3063441359986, 3503.562054743157, 3551.5027896094566, 3699.352613292663, 3879.709021823346, 81991.18008819895, 82129.0, 82310.94222644423, 83277.16722832754, 83579.0, 9883.604655813688, 9892.01079892005, 9909.0, 10047.949760251298, 10135.594576217016, 23021.07915683354, 23278.53442931132, 23387.649185262235, 23720.762792371854, 23723.1696890608, 7657.961710191414, 7833.412494062854, 7919.881201781978, 8175.509469431853, 8247.463914845515, 4212.178625168062, 4227.957720422818, 4256.2551553478015, 4286.2284788738325, 4405.229084910128, 3725.869594564177, 3748.194138260287, 3769.7361184716806, 3786.924261514754, 3811.5235595550557, 673.8045966669611, 713.53263612334, 718.2530168624572, 740.1488288468305, 748.5209465941801, 601.7983975368213, 614.4576516383055, 617.3178637605381, 619.5260625621403, 627.5920651576512, 8373.204545568162, 8400.747977560683, 8448.831023379498, 8464.32285417165, 8495.872561911576, 573.4036601934025, 589.6344266554763, 610.1001023490405, 638.3488841381765, 641.1024565608093, 3453.5855697316483, 3803.410471376941, 3919.9216015679526, 3950.6049395060263, 4082.6529744971417, 96633.0, 97730.0, 99050.5047474758, 99054.5047274759, 99195.50402248088, 80409.3918121646, 80427.0, 80818.59590702009, 82699.5865020671, 82832.0, 67376.98934515986, 69876.6506167476, 72484.63757681283, 73509.0, 78594.60702696565, 8491.880500805752, 8854.734357969272, 8898.332625053017, 8901.821963560822, 8903.465792052497, 48498.545043648744, 48703.5129648699, 51888.22167667563, 53201.46798531965, 53295.73352133214, 69552.9134125977, 71822.0, 73856.63071684608, 74332.25667743254, 74824.62587687027, 10993.230473866752, 11208.831867522156, 11230.21388502797, 11278.266912650652, 11375.374354410587, 12364.876351236373, 12466.626001219978, 12506.499740010298, 12537.310447925453, 12875.227486350848, 11384.772304554028, 11597.0, 11597.130215233723, 11795.646130616095, 11937.820932685843, 11687.824682629938, 11706.590269340531, 11803.291802491878, 11944.462499187384, 12052.638420847388, 11383.829242561535, 11385.829212561985, 11448.141389395661, 11463.828042579202, 12057.336846473178, 8036.598170091589, 8123.025236971601, 8198.672053118047, 8217.83564328698, 8279.668813247403, 6917.757878474229, 7888.881666775118, 8112.22933821286, 8332.583370831555, 8356.247937685637], "value": 7137.9474814606165, "unit": "score"}], "name": "dromaeo_css", "value": 7742.2976067390855, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 149.0, 117.0, 116.0, 117.0, 132.0, 114.0, 115.0, 116.0, 117.0], "value": 121.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 152.0, 142.0, 164.0, 121.0, 139.0, 122.0, 157.0, 156.0, 118.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 255.0, 270.0, 209.0, 193.0, 195.0, 200.0, 219.0, 178.0, 259.0], "value": 215.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 79.0, 148.0, 77.0, 82.0, 85.0, 85.0, 129.0, 58.0], "value": 87.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 124.0, 77.0, 81.0, 96.0, 119.0, 79.0, 79.0, 119.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 88.0, 85.0, 89.0, 85.0, 89.0, 87.0, 89.0, 89.0], "value": 97.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 105.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 142.0, 96.0, 103.0, 99.0, 99.0, 96.0, 99.0, 97.0, 89.0], "value": 102.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 66.0, 65.0, 66.0, 66.0, 65.0, 64.0, 78.0, 63.0, 61.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 70.0, 65.0, 70.0, 72.0, 68.0, 66.0, 66.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 108.0, 107.0, 77.0, 83.0, 79.0, 79.0, 82.0, 83.0, 85.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 141.0, 150.0, 143.0, 124.0, 124.0, 124.0, 135.0, 174.0, 150.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 221.0, 214.0, 162.0, 168.0, 171.0, 193.0, 212.0, 210.0, 163.0], "value": 186.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 65.0, 70.0, 68.0, 68.0, 67.0, 68.0, 68.0, 66.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1578.1000000000001, "alertThreshold": 2.0}]} 04:28:56 INFO - Return code: 0 04:28:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:28:56 ERROR - # TBPL SUCCESS # 04:28:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:28:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:28:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:28:56 INFO - 2016-07-03 04:28:56.312 screenresolution[1693:11460] starting screenresolution argv=screenresolution get 04:28:56 INFO - 2016-07-03 04:28:56.315 screenresolution[1693:11460] Display 0: 1600x1200x32@60 04:28:56 INFO - 2016-07-03 04:28:56.321 screenresolution[1694:11463] starting screenresolution argv=screenresolution list 04:28:56 INFO - Available Modes on Display 0 04:28:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:28:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:28:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:28:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:28:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:28:56 INFO - Intel Iris: 04:28:56 INFO - Chipset Model: Intel Iris 04:28:56 INFO - Type: GPU 04:28:56 INFO - Bus: Built-In 04:28:56 INFO - VRAM (Dynamic, Max): 1536 MB 04:28:56 INFO - Vendor: Intel (0x8086) 04:28:56 INFO - Device ID: 0x0a2e 04:28:56 INFO - Revision ID: 0x0009 04:28:56 INFO - Displays: 04:28:56 INFO - Display: 04:28:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:28:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:28:56 INFO - Display Serial Number: 1600x1200 60 04:28:56 INFO - Main Display: Yes 04:28:56 INFO - Mirror: Off 04:28:56 INFO - Online: Yes 04:28:56 INFO - Rotation: Supported 04:28:56 INFO - Return code: 0 04:28:56 INFO - Running post-action listener: _resource_record_post_action 04:28:56 INFO - Running post-run listener: _resource_record_post_run 04:28:57 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 32542208; Write bytes: 497571840; Read time: 321; Write time: 1795 04:28:57 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194810368; Write bytes: 195913216; Read time: 17914; Write time: 419 04:28:57 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 30760448; Write bytes: 300651008; Read time: 303; Write time: 1372 04:28:57 INFO - Running post-run listener: _upload_blobber_files 04:28:57 INFO - Blob upload gear active. 04:28:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:28:57 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 04:28:57 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:28:57 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:28:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:28:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:28:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:28:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:58 INFO - (blobuploader) - INFO - Done attempting. 04:28:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:28:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:59 INFO - (blobuploader) - INFO - Done attempting. 04:28:59 INFO - (blobuploader) - INFO - Iteration through files over. 04:28:59 INFO - Return code: 0 04:28:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:28:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:28:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f44330f598251fb2d186b0c5746719635652ee8c0dea7bbbce1e2de94da7d38f90f1ac399eed22d6628e2de0ec92536ec9939b69eed9e8bba60e6c76eb3ab1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b98fa7d6486b5dc4f1ca7f911f74ebde3a91149aafc170052a582f346476825599fe1b4f206200472323ecf62dcb948e499175ad2ec007baa8c0986f3c291545"} 04:28:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:28:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:28:59 INFO - Contents: 04:28:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f44330f598251fb2d186b0c5746719635652ee8c0dea7bbbce1e2de94da7d38f90f1ac399eed22d6628e2de0ec92536ec9939b69eed9e8bba60e6c76eb3ab1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b98fa7d6486b5dc4f1ca7f911f74ebde3a91149aafc170052a582f346476825599fe1b4f206200472323ecf62dcb948e499175ad2ec007baa8c0986f3c291545"} 04:28:59 INFO - Running post-run listener: copy_logs_to_upload_dir 04:28:59 INFO - Copying logs to upload dir... 04:28:59 INFO - mkdir: /builds/slave/test/build/upload/logs 04:28:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.898920 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-07-03 04:28:59.681603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 04:28:59.685442) ========= 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.VJe3Q89J2O/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.PC4OxFI8op/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f44330f598251fb2d186b0c5746719635652ee8c0dea7bbbce1e2de94da7d38f90f1ac399eed22d6628e2de0ec92536ec9939b69eed9e8bba60e6c76eb3ab1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b98fa7d6486b5dc4f1ca7f911f74ebde3a91149aafc170052a582f346476825599fe1b4f206200472323ecf62dcb948e499175ad2ec007baa8c0986f3c291545"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011067 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467533757/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f44330f598251fb2d186b0c5746719635652ee8c0dea7bbbce1e2de94da7d38f90f1ac399eed22d6628e2de0ec92536ec9939b69eed9e8bba60e6c76eb3ab1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b98fa7d6486b5dc4f1ca7f911f74ebde3a91149aafc170052a582f346476825599fe1b4f206200472323ecf62dcb948e499175ad2ec007baa8c0986f3c291545"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 04:28:59.718221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:28:59.718551) ========= 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.VJe3Q89J2O/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.PC4OxFI8op/Listeners TMPDIR=/var/folders/83/drrqg_ss7sldg8ggnl_73bbm00000w/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.005142 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 04:28:59.767753) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 04:28:59.768088) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 04:28:59.768439) ========= ========= Total master_lag: 0.28 =========