builder: date_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0289 starttime: 1474911991.45 results: success (0) buildid: 20160926083452 builduid: 668c641badcb42c299dc0fb43c863c4a revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:31.455071) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:31.455432) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:31.455697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:31.560217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:31.560748) ========= 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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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-09-26 10:46:31-- 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% 18.8M=0.001s 2016-09-26 10:46:32 (18.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.498661 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:32.083720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:32.084041) ========= 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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.025605 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:32.132324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 10:46:32.132663) ========= bash -c 'python archiver_client.py mozharness --repo projects/date --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/date --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oX4KPzfxC9/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.TWUCiGQfdM/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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-09-26 10:46:32,217 truncating revision to first 12 chars 2016-09-26 10:46:32,217 Setting DEBUG logging. 2016-09-26 10:46:32,217 attempt 1/10 2016-09-26 10:46:32,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/date/c55bcb7c777e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 10:46:33,339 unpacking tar archive at: date-c55bcb7c777e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.390612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-26 10:46:33.543046) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:33.543377) ========= script_repo_revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:33.543794) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:33.544118) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 10:46:33.562915) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-09-26 10:46:33.563253) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Date', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Date'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oX4KPzfxC9/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.TWUCiGQfdM/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:46:33 INFO - MultiFileLogger online at 20160926 10:46:33 in /builds/slave/test 10:46:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Date --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Date 10:46:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:46:33 INFO - {'append_to_log': False, 10:46:33 INFO - 'base_work_dir': '/builds/slave/test', 10:46:33 INFO - 'blob_upload_branch': 'Date', 10:46:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:46:33 INFO - 'branch': 'Date', 10:46:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:46:33 INFO - 'config_files': ('talos/mac_config.py',), 10:46:33 INFO - 'default_actions': ('clobber', 10:46:33 INFO - 'read-buildbot-config', 10:46:33 INFO - 'download-and-extract', 10:46:33 INFO - 'populate-webroot', 10:46:33 INFO - 'create-virtualenv', 10:46:33 INFO - 'install', 10:46:33 INFO - 'run-tests'), 10:46:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:46:33 INFO - 'download_minidump_stackwalk': True, 10:46:33 INFO - 'download_symbols': 'ondemand', 10:46:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:46:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:46:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:46:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:46:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:46:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:46:33 INFO - 'installer_path': 'installer.exe', 10:46:33 INFO - 'log_level': 'info', 10:46:33 INFO - 'log_name': 'talos', 10:46:33 INFO - 'log_to_console': True, 10:46:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:46:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:46:33 INFO - 'opt_config_files': (), 10:46:33 INFO - 'pip_index': False, 10:46:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:46:33 INFO - 'cmd': ('bash', 10:46:33 INFO - '-c', 10:46:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:46:33 INFO - 'enabled': True, 10:46:33 INFO - 'halt_on_failure': False, 10:46:33 INFO - 'name': 'check_screen_resolution'},), 10:46:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:46:33 INFO - 'cmd': ('bash', 10:46:33 INFO - '-c', 10:46:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:46:33 INFO - 'enabled': True, 10:46:33 INFO - 'halt_on_failure': False, 10:46:33 INFO - 'name': 'check_screen_resolution'},), 10:46:33 INFO - 'run_cmd_checks_enabled': True, 10:46:33 INFO - 'sps_profile': False, 10:46:33 INFO - 'sps_profile_interval': 0, 10:46:33 INFO - 'suite': 'dromaeojs', 10:46:33 INFO - 'system_bits': '32', 10:46:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:46:33 INFO - 'title': 't-yosemite-r7-0289', 10:46:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:46:33 INFO - 'use_talos_json': True, 10:46:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:46:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:46:33 INFO - 'work_dir': 'build'} 10:46:33 INFO - [mozharness: 2016-09-26 17:46:33.772272Z] Running clobber step. 10:46:33 INFO - Running pre-action listener: _resource_record_pre_action 10:46:33 INFO - Running main action method: clobber 10:46:33 INFO - rmtree: /builds/slave/test/build 10:46:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:46:35 INFO - Running post-action listener: _resource_record_post_action 10:46:35 INFO - [mozharness: 2016-09-26 17:46:35.940290Z] Finished clobber step (success) 10:46:35 INFO - [mozharness: 2016-09-26 17:46:35.940423Z] Running read-buildbot-config step. 10:46:35 INFO - Running pre-action listener: _resource_record_pre_action 10:46:35 INFO - Running main action method: read_buildbot_config 10:46:35 INFO - Using buildbot properties: 10:46:35 INFO - { 10:46:35 INFO - "project": "", 10:46:35 INFO - "product": "firefox", 10:46:35 INFO - "script_repo_revision": "production", 10:46:35 INFO - "builddir": "date_yosemite_r7_test-dromaeojs", 10:46:35 INFO - "repository": "", 10:46:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 date talos dromaeojs", 10:46:35 INFO - "buildid": "20160926083452", 10:46:35 INFO - "pgo_build": "False", 10:46:35 INFO - "basedir": "/builds/slave/test", 10:46:35 INFO - "buildnumber": 0, 10:46:35 INFO - "slavename": "t-yosemite-r7-0289", 10:46:35 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:46:35 INFO - "platform": "yosemite_r7", 10:46:35 INFO - "scheduler": "tests-date-macosx64-talos", 10:46:35 INFO - "branch": "date", 10:46:35 INFO - "repo_path": "projects/date", 10:46:35 INFO - "revision": "c55bcb7c777ea09431b4d16903ed079ae5632648", 10:46:35 INFO - "stage_platform": "macosx64", 10:46:35 INFO - "builduid": "668c641badcb42c299dc0fb43c863c4a", 10:46:35 INFO - "slavebuilddir": "test" 10:46:35 INFO - } 10:46:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:46:35 INFO - Running post-action listener: _resource_record_post_action 10:46:35 INFO - [mozharness: 2016-09-26 17:46:35.943732Z] Finished read-buildbot-config step (success) 10:46:35 INFO - [mozharness: 2016-09-26 17:46:35.943844Z] Running download-and-extract step. 10:46:35 INFO - Running pre-action listener: _resource_record_pre_action 10:46:35 INFO - Running main action method: download_and_extract 10:46:35 INFO - mkdir: /builds/slave/test/build/tests 10:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:35 INFO - trying https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:46:35 INFO - Downloading https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 10:46:36 INFO - Downloaded 1199 bytes. 10:46:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:46:36 INFO - Using the following test package requirements: 10:46:36 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:46:36 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:46:36 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:46:36 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:46:36 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:46:36 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:46:36 INFO - u'jsshell-mac.zip'], 10:46:36 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:46:36 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:46:36 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:46:36 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:46:36 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:46:36 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:46:36 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:46:36 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:46:36 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:46:36 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:46:36 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:46:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:46:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:46:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:46:36 INFO - Fetch https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:46:37 INFO - Expected file size: 16275599 10:46:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:46:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:46:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:46:44 INFO - Fetch https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:46:44 INFO - Expected file size: 16275599 10:46:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:46:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:46:51 INFO - Fetch https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:46:52 INFO - Expected file size: 14414057 10:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:46:52 INFO - trying https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:46:52 INFO - Downloading https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 10:46:55 INFO - Downloaded 83297226 bytes. 10:46:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:46:55 INFO - mkdir: /builds/slave/test/properties 10:46:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:46:55 INFO - Writing to file /builds/slave/test/properties/build_url 10:46:55 INFO - Contents: 10:46:55 INFO - build_url:https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:46:55 INFO - Running post-action listener: _resource_record_post_action 10:46:55 INFO - Running post-action listener: set_extra_try_arguments 10:46:55 INFO - [mozharness: 2016-09-26 17:46:55.871517Z] Finished download-and-extract step (success) 10:46:55 INFO - [mozharness: 2016-09-26 17:46:55.871662Z] Running populate-webroot step. 10:46:55 INFO - Running pre-action listener: _resource_record_pre_action 10:46:55 INFO - Running main action method: populate_webroot 10:46:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:46:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:46:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:46:55 INFO - '--tppagecycles', 10:46:55 INFO - '7'], 10:46:55 INFO - 'tests': ['tsvgm']}}, 10:46:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:46:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:46:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:46:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:46:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:55 INFO - 'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:46:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:46:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:55 INFO - 'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['damp', 'tps']}, 10:46:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:55 INFO - 'tests': ['damp', 'tps']}, 10:46:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['dromaeo_dom']}, 10:46:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:46:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['basic_compositor_video']}, 10:46:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:46:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['a11yr', 10:46:55 INFO - 'ts_paint', 10:46:55 INFO - 'tpaint', 10:46:55 INFO - 'sessionrestore', 10:46:55 INFO - 'sessionrestore_no_auto_restore', 10:46:55 INFO - 'tabpaint']}, 10:46:55 INFO - 'other-e10s': {'tests': ['a11yr', 10:46:55 INFO - 'ts_paint', 10:46:55 INFO - 'tpaint', 10:46:55 INFO - 'sessionrestore', 10:46:55 INFO - 'sessionrestore_no_auto_restore', 10:46:55 INFO - 'tabpaint']}, 10:46:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:46:55 INFO - 'ts_paint', 10:46:55 INFO - 'tpaint', 10:46:55 INFO - 'sessionrestore', 10:46:55 INFO - 'sessionrestore_no_auto_restore', 10:46:55 INFO - 'tabpaint']}, 10:46:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:46:55 INFO - 'ts_paint', 10:46:55 INFO - 'tpaint', 10:46:55 INFO - 'sessionrestore', 10:46:55 INFO - 'sessionrestore_no_auto_restore', 10:46:55 INFO - 'tabpaint']}, 10:46:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['a11yr', 10:46:55 INFO - 'ts_paint', 10:46:55 INFO - 'tpaint', 10:46:55 INFO - 'sessionrestore', 10:46:55 INFO - 'sessionrestore_no_auto_restore', 10:46:55 INFO - 'tabpaint']}, 10:46:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['a11yr', 10:46:55 INFO - 'ts_paint', 10:46:55 INFO - 'tpaint', 10:46:55 INFO - 'sessionrestore', 10:46:55 INFO - 'sessionrestore_no_auto_restore', 10:46:55 INFO - 'tabpaint']}, 10:46:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['tsvgx', 10:46:55 INFO - 'tsvgr_opacity', 10:46:55 INFO - 'tart', 10:46:55 INFO - 'tscrollx', 10:46:55 INFO - 'cart']}, 10:46:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:46:55 INFO - 'tsvgr_opacity', 10:46:55 INFO - 'tart', 10:46:55 INFO - 'tscrollx', 10:46:55 INFO - 'cart']}, 10:46:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:55 INFO - 'talos_options': ['--disable-e10s'], 10:46:55 INFO - 'tests': ['tp5o']}, 10:46:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:55 INFO - 'tests': ['tp5o']}, 10:46:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:55 INFO - 'talos_options': ['--disable-e10s', 10:46:55 INFO - '--xperf_path', 10:46:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:46:55 INFO - 'tests': ['tp5n']}, 10:46:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:46:55 INFO - 'talos_options': ['--xperf_path', 10:46:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:46:55 INFO - 'tests': ['tp5n']}}, 10:46:55 INFO - 'talos.zip': {'path': '', 10:46:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:46:55 INFO - Running post-action listener: _resource_record_post_action 10:46:55 INFO - [mozharness: 2016-09-26 17:46:55.890350Z] Finished populate-webroot step (success) 10:46:55 INFO - [mozharness: 2016-09-26 17:46:55.890465Z] Running create-virtualenv step. 10:46:55 INFO - Running pre-action listener: _resource_record_pre_action 10:46:55 INFO - Running main action method: create_virtualenv 10:46:55 INFO - Creating virtualenv /builds/slave/test/build/venv 10:46:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:46:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:46:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:46:56 INFO - Using real prefix '/tools/python27' 10:46:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:46:56 INFO - Installing distribute.............................................................................................................................................................................................done. 10:46:59 INFO - Installing pip.................done. 10:46:59 INFO - Return code: 0 10:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:47:00 INFO - Reading from file tmpfile_stdout 10:47:00 INFO - Output received: 10:47:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:47:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:47:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:00 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 0x10c737490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa800d9b550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, '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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:47:00 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 10:47:00 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 10:47:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:00 INFO - 'HOME': '/Users/cltbld', 10:47:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:00 INFO - 'LOGNAME': 'cltbld', 10:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:00 INFO - 'MOZ_NO_REMOTE': '1', 10:47:00 INFO - 'NO_EM_RESTART': '1', 10:47:00 INFO - 'PAGER': '/bin/cat', 10:47:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:00 INFO - 'PWD': '/builds/slave/test', 10:47:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:00 INFO - 'SHELL': '/bin/bash', 10:47:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:00 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:00 INFO - 'USER': 'cltbld', 10:47:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:00 INFO - 'XPC_FLAGS': '0x0', 10:47:00 INFO - 'XPC_SERVICE_NAME': '0', 10:47:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:47:00 INFO - Cleaning up... 10:47:00 INFO - Return code: 0 10:47:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:47:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:00 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c737490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa800d9b550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, '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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:47:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:00 INFO - 'HOME': '/Users/cltbld', 10:47:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:00 INFO - 'LOGNAME': 'cltbld', 10:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:00 INFO - 'MOZ_NO_REMOTE': '1', 10:47:00 INFO - 'NO_EM_RESTART': '1', 10:47:00 INFO - 'PAGER': '/bin/cat', 10:47:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:00 INFO - 'PWD': '/builds/slave/test', 10:47:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:00 INFO - 'SHELL': '/bin/bash', 10:47:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:00 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:00 INFO - 'USER': 'cltbld', 10:47:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:00 INFO - 'XPC_FLAGS': '0x0', 10:47:00 INFO - 'XPC_SERVICE_NAME': '0', 10:47:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:00 INFO - Downloading/unpacking psutil>=3.1.1 10:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:47:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:04 INFO - Installing collected packages: psutil 10:47:04 INFO - Running setup.py install for psutil 10:47:04 INFO - building 'psutil._psutil_osx' extension 10:47:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:47:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:47:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:47:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:47:05 INFO - building 'psutil._psutil_posix' extension 10:47:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:47:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:47:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:47:05 INFO - ^ 10:47:05 INFO - 1 warning generated. 10:47:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:05 INFO - Successfully installed psutil 10:47:05 INFO - Cleaning up... 10:47:05 INFO - Return code: 0 10:47:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:47:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c737490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa800d9b550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, '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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:47:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:05 INFO - 'HOME': '/Users/cltbld', 10:47:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:05 INFO - 'LOGNAME': 'cltbld', 10:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:05 INFO - 'MOZ_NO_REMOTE': '1', 10:47:05 INFO - 'NO_EM_RESTART': '1', 10:47:05 INFO - 'PAGER': '/bin/cat', 10:47:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:05 INFO - 'PWD': '/builds/slave/test', 10:47:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:05 INFO - 'SHELL': '/bin/bash', 10:47:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:05 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:05 INFO - 'USER': 'cltbld', 10:47:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:05 INFO - 'XPC_FLAGS': '0x0', 10:47:05 INFO - 'XPC_SERVICE_NAME': '0', 10:47:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:47:08 INFO - Installing collected packages: mozsystemmonitor 10:47:08 INFO - Running setup.py install for mozsystemmonitor 10:47:08 INFO - Successfully installed mozsystemmonitor 10:47:08 INFO - Cleaning up... 10:47:09 INFO - Return code: 0 10:47:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:47:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:09 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c737490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa800d9b550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, '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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:47:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:47:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:47:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:09 INFO - 'HOME': '/Users/cltbld', 10:47:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:09 INFO - 'LOGNAME': 'cltbld', 10:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:09 INFO - 'MOZ_NO_REMOTE': '1', 10:47:09 INFO - 'NO_EM_RESTART': '1', 10:47:09 INFO - 'PAGER': '/bin/cat', 10:47:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:09 INFO - 'PWD': '/builds/slave/test', 10:47:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:09 INFO - 'SHELL': '/bin/bash', 10:47:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:09 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:09 INFO - 'USER': 'cltbld', 10:47:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:09 INFO - 'XPC_FLAGS': '0x0', 10:47:09 INFO - 'XPC_SERVICE_NAME': '0', 10:47:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:09 INFO - Downloading/unpacking jsonschema==2.5.1 10:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:47:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:12 INFO - Downloading functools32-3.2.3-2.tar.gz 10:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:47:12 INFO - warning: no files found matching '*.txt' 10:47:12 INFO - no previously-included directories found matching 'build' 10:47:12 INFO - no previously-included directories found matching 'dist' 10:47:12 INFO - no previously-included directories found matching '.git*' 10:47:12 INFO - Installing collected packages: jsonschema, functools32 10:47:12 INFO - Running setup.py install for functools32 10:47:12 INFO - warning: no files found matching '*.txt' 10:47:12 INFO - no previously-included directories found matching 'build' 10:47:12 INFO - no previously-included directories found matching 'dist' 10:47:12 INFO - no previously-included directories found matching '.git*' 10:47:12 INFO - Successfully installed jsonschema functools32 10:47:12 INFO - Cleaning up... 10:47:12 INFO - Return code: 0 10:47:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:12 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c737490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa800d9b550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, '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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:47:12 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:47:12 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 functools32==3.2.3-2 10:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:12 INFO - 'HOME': '/Users/cltbld', 10:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:12 INFO - 'LOGNAME': 'cltbld', 10:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:12 INFO - 'MOZ_NO_REMOTE': '1', 10:47:12 INFO - 'NO_EM_RESTART': '1', 10:47:12 INFO - 'PAGER': '/bin/cat', 10:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:12 INFO - 'PWD': '/builds/slave/test', 10:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:12 INFO - 'SHELL': '/bin/bash', 10:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:12 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:12 INFO - 'USER': 'cltbld', 10:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:12 INFO - 'XPC_FLAGS': '0x0', 10:47:12 INFO - 'XPC_SERVICE_NAME': '0', 10:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:47:12 INFO - Cleaning up... 10:47:12 INFO - Return code: 0 10:47:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:12 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 0x10c737490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa800d9b550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, '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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:47:12 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 10:47:12 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 10:47:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:12 INFO - 'HOME': '/Users/cltbld', 10:47:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:12 INFO - 'LOGNAME': 'cltbld', 10:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:12 INFO - 'MOZ_NO_REMOTE': '1', 10:47:12 INFO - 'NO_EM_RESTART': '1', 10:47:12 INFO - 'PAGER': '/bin/cat', 10:47:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:12 INFO - 'PWD': '/builds/slave/test', 10:47:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:12 INFO - 'SHELL': '/bin/bash', 10:47:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:12 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:12 INFO - 'USER': 'cltbld', 10:47:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:12 INFO - 'XPC_FLAGS': '0x0', 10:47:12 INFO - 'XPC_SERVICE_NAME': '0', 10:47:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:13 INFO - Downloading/unpacking blobuploader==1.2.4 10:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:15 INFO - Downloading blobuploader-1.2.4.tar.gz 10:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:47:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:47:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:16 INFO - Downloading docopt-0.6.1.tar.gz 10:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:47:16 INFO - Installing collected packages: blobuploader, requests, docopt 10:47:16 INFO - Running setup.py install for blobuploader 10:47:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:47:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:47:16 INFO - Running setup.py install for requests 10:47:17 INFO - Running setup.py install for docopt 10:47:17 INFO - Successfully installed blobuploader requests docopt 10:47:17 INFO - Cleaning up... 10:47:17 INFO - Return code: 0 10:47:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:17 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 0x10c737490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa800d9b550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, '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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:47:17 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 10:47:17 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 10:47:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:17 INFO - 'HOME': '/Users/cltbld', 10:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:17 INFO - 'LOGNAME': 'cltbld', 10:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:17 INFO - 'MOZ_NO_REMOTE': '1', 10:47:17 INFO - 'NO_EM_RESTART': '1', 10:47:17 INFO - 'PAGER': '/bin/cat', 10:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:17 INFO - 'PWD': '/builds/slave/test', 10:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:17 INFO - 'SHELL': '/bin/bash', 10:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:17 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:17 INFO - 'USER': 'cltbld', 10:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:17 INFO - 'XPC_FLAGS': '0x0', 10:47:17 INFO - 'XPC_SERVICE_NAME': '0', 10:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:17 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-PMMhOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:17 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-0B08xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-BtULwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Blq0tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-KjyxtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-vMPn0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-EpOrgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-JcwFCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-VnfoKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Grr3dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-0dQ1sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:18 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ZQoZnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:19 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-KqNQQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:19 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-0sIoTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:19 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Tl27aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:19 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-VmL5IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:19 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-SAAb1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:47:19 INFO - Running setup.py install for manifestparser 10:47:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:47:19 INFO - Running setup.py install for mozcrash 10:47:19 INFO - Running setup.py install for mozdebug 10:47:20 INFO - Running setup.py install for mozdevice 10:47:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Running setup.py install for mozfile 10:47:20 INFO - Running setup.py install for mozhttpd 10:47:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Running setup.py install for mozinfo 10:47:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Running setup.py install for mozInstall 10:47:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:47:20 INFO - Running setup.py install for mozleak 10:47:20 INFO - Running setup.py install for mozlog 10:47:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Running setup.py install for moznetwork 10:47:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Running setup.py install for mozprocess 10:47:21 INFO - Running setup.py install for mozprofile 10:47:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Running setup.py install for mozrunner 10:47:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:47:21 INFO - Running setup.py install for mozscreenshot 10:47:21 INFO - Running setup.py install for moztest 10:47:22 INFO - Running setup.py install for mozversion 10:47:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:47:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:47:22 INFO - Cleaning up... 10:47:22 INFO - Return code: 0 10:47:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:22 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 0x10c737490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa800d9b550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, '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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:47:22 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 10:47:22 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 10:47:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:22 INFO - 'HOME': '/Users/cltbld', 10:47:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:22 INFO - 'LOGNAME': 'cltbld', 10:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:22 INFO - 'MOZ_NO_REMOTE': '1', 10:47:22 INFO - 'NO_EM_RESTART': '1', 10:47:22 INFO - 'PAGER': '/bin/cat', 10:47:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:22 INFO - 'PWD': '/builds/slave/test', 10:47:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:22 INFO - 'SHELL': '/bin/bash', 10:47:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:22 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:22 INFO - 'USER': 'cltbld', 10:47:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:22 INFO - 'XPC_FLAGS': '0x0', 10:47:22 INFO - 'XPC_SERVICE_NAME': '0', 10:47:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-sFqwIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-pNaVq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-uBZRi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-lLqnYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:22 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)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:22 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-u1gpIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-G2EqHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-DRN3nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-4MNG0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-YVbvic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ukyEmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-pPoq62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-jHj8VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-WCMRO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:23 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)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-PZidOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:23 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-I3rdUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:24 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-QWNeup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:24 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-4vHD6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:47:24 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)) 10:47:24 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)) 10:47:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:47:24 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)) 10:47:24 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)) 10:47:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:26 INFO - Downloading blessings-1.6.tar.gz 10:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:47:26 INFO - Installing collected packages: blessings 10:47:26 INFO - Running setup.py install for blessings 10:47:27 INFO - Successfully installed blessings 10:47:27 INFO - Cleaning up... 10:47:27 INFO - Return code: 0 10:47:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:47:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:27 INFO - Reading from file tmpfile_stdout 10:47:27 INFO - Current package versions: 10:47:27 INFO - blessings == 1.6 10:47:27 INFO - blobuploader == 1.2.4 10:47:27 INFO - docopt == 0.6.1 10:47:27 INFO - functools32 == 3.2.3-2 10:47:27 INFO - jsonschema == 2.5.1 10:47:27 INFO - manifestparser == 1.1 10:47:27 INFO - mozInstall == 1.12 10:47:27 INFO - mozcrash == 0.17 10:47:27 INFO - mozdebug == 0.1 10:47:27 INFO - mozdevice == 0.48 10:47:27 INFO - mozfile == 1.2 10:47:27 INFO - mozhttpd == 0.7 10:47:27 INFO - mozinfo == 0.9 10:47:27 INFO - mozleak == 0.1 10:47:27 INFO - mozlog == 3.4 10:47:27 INFO - moznetwork == 0.27 10:47:27 INFO - mozprocess == 0.23 10:47:27 INFO - mozprofile == 0.28 10:47:27 INFO - mozrunner == 6.12 10:47:27 INFO - mozscreenshot == 0.1 10:47:27 INFO - mozsystemmonitor == 0.3 10:47:27 INFO - moztest == 0.7 10:47:27 INFO - mozversion == 1.4 10:47:27 INFO - psutil == 3.1.1 10:47:27 INFO - requests == 1.2.3 10:47:27 INFO - wsgiref == 0.1.2 10:47:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:27 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 0x10c737490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa800d9b550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, '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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:47:27 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 10:47:27 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 10:47:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:27 INFO - 'HOME': '/Users/cltbld', 10:47:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:27 INFO - 'LOGNAME': 'cltbld', 10:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:27 INFO - 'MOZ_NO_REMOTE': '1', 10:47:27 INFO - 'NO_EM_RESTART': '1', 10:47:27 INFO - 'PAGER': '/bin/cat', 10:47:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:27 INFO - 'PWD': '/builds/slave/test', 10:47:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:27 INFO - 'SHELL': '/bin/bash', 10:47:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:27 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:27 INFO - 'USER': 'cltbld', 10:47:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:27 INFO - 'XPC_FLAGS': '0x0', 10:47:27 INFO - 'XPC_SERVICE_NAME': '0', 10:47:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:27 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)) 10:47:27 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)) 10:47:27 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)) 10:47:27 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)) 10:47:27 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)) 10:47:27 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)) 10:47:27 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)) 10:47:27 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)) 10:47:27 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)) 10:47:27 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)) 10:47:27 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)) 10:47:27 INFO - Cleaning up... 10:47:27 INFO - Return code: 0 10:47:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:47:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:27 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 0x10c737490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c6ad570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa800d9b550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, '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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:47:27 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 10:47:27 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 10:47:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:27 INFO - 'HOME': '/Users/cltbld', 10:47:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:27 INFO - 'LOGNAME': 'cltbld', 10:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:27 INFO - 'MOZ_NO_REMOTE': '1', 10:47:27 INFO - 'NO_EM_RESTART': '1', 10:47:27 INFO - 'PAGER': '/bin/cat', 10:47:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:27 INFO - 'PWD': '/builds/slave/test', 10:47:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:27 INFO - 'SHELL': '/bin/bash', 10:47:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:27 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:27 INFO - 'USER': 'cltbld', 10:47:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:27 INFO - 'XPC_FLAGS': '0x0', 10:47:27 INFO - 'XPC_SERVICE_NAME': '0', 10:47:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:47:27 INFO - Cleaning up... 10:47:27 INFO - Return code: 0 10:47:27 INFO - Running post-action listener: _resource_record_post_action 10:47:27 INFO - Running post-action listener: _start_resource_monitoring 10:47:27 INFO - Starting resource monitoring. 10:47:27 INFO - [mozharness: 2016-09-26 17:47:27.985206Z] Finished create-virtualenv step (success) 10:47:27 INFO - [mozharness: 2016-09-26 17:47:27.986203Z] Running install step. 10:47:27 INFO - Running pre-action listener: _resource_record_pre_action 10:47:27 INFO - Running main action method: install 10:47:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:28 INFO - Reading from file tmpfile_stdout 10:47:28 INFO - Detecting whether we're running mozinstall >=1.0... 10:47:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:47:28 INFO - Reading from file tmpfile_stdout 10:47:28 INFO - Output received: 10:47:28 INFO - Usage: mozinstall [options] installer 10:47:28 INFO - Options: 10:47:28 INFO - -h, --help show this help message and exit 10:47:28 INFO - -d DEST, --destination=DEST 10:47:28 INFO - Directory to install application into. [default: 10:47:28 INFO - "/builds/slave/test"] 10:47:28 INFO - --app=APP Application being installed. [default: firefox] 10:47:28 INFO - mkdir: /builds/slave/test/build/application 10:47:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:47:52 INFO - Reading from file tmpfile_stdout 10:47:52 INFO - Output received: 10:47:52 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:47:52 INFO - Running post-action listener: _resource_record_post_action 10:47:52 INFO - [mozharness: 2016-09-26 17:47:52.774136Z] Finished install step (success) 10:47:52 INFO - [mozharness: 2016-09-26 17:47:52.774257Z] Running run-tests step. 10:47:52 INFO - Running pre-action listener: _resource_record_pre_action 10:47:52 INFO - Running main action method: run_tests 10:47:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:47:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:47:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:47:52 INFO - 2016-09-26 10:47:52.788 screenresolution[2551:10468] starting screenresolution argv=screenresolution get 10:47:52 INFO - 2016-09-26 10:47:52.791 screenresolution[2551:10468] Display 0: 1600x1200x32@60 10:47:52 INFO - 2016-09-26 10:47:52.797 screenresolution[2552:10470] starting screenresolution argv=screenresolution list 10:47:52 INFO - Available Modes on Display 0 10:47:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:47:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:47:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:47:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:47:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:47:53 INFO - Intel Iris: 10:47:53 INFO - Chipset Model: Intel Iris 10:47:53 INFO - Type: GPU 10:47:53 INFO - Bus: Built-In 10:47:53 INFO - VRAM (Dynamic, Max): 1536 MB 10:47:53 INFO - Vendor: Intel (0x8086) 10:47:53 INFO - Device ID: 0x0a2e 10:47:53 INFO - Revision ID: 0x0009 10:47:53 INFO - Displays: 10:47:53 INFO - Display: 10:47:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:47:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:47:53 INFO - Display Serial Number: 1600x1200 60 10:47:53 INFO - Main Display: Yes 10:47:53 INFO - Mirror: Off 10:47:53 INFO - Online: Yes 10:47:53 INFO - Rotation: Supported 10:47:53 INFO - Return code: 0 10:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:47:53 INFO - Python 2.7.3 10:47:53 INFO - Return code: 0 10:47:53 INFO - grabbing minidump binary from tooltool 10:47:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:47:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c54bd30>, '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 0x10c371db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c543b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:47:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:47:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:47:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:47:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:47:53 INFO - Return code: 0 10:47:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:47:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:47:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:47:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:47:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:47:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Date --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0289 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:47:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oX4KPzfxC9/Render', 10:47:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:47:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:47:53 INFO - 'HOME': '/Users/cltbld', 10:47:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:47:53 INFO - 'LOGNAME': 'cltbld', 10:47:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:47:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:53 INFO - 'MOZ_NO_REMOTE': '1', 10:47:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:47:53 INFO - 'NO_EM_RESTART': '1', 10:47:53 INFO - 'PAGER': '/bin/cat', 10:47:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:53 INFO - 'PWD': '/builds/slave/test', 10:47:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:47:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:47:53 INFO - 'SHELL': '/bin/bash', 10:47:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWUCiGQfdM/Listeners', 10:47:53 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:47:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:47:53 INFO - 'USER': 'cltbld', 10:47:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:47:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:53 INFO - 'XPC_FLAGS': '0x0', 10:47:53 INFO - 'XPC_SERVICE_NAME': '0', 10:47:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:47:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Date', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:47:53 INFO - mozversion application_buildid: 20160926083452 10:47:53 INFO - mozversion application_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 10:47:53 INFO - mozversion application_display_name: Firefox 10:47:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:47:53 INFO - mozversion application_name: Firefox 10:47:53 INFO - mozversion application_remotingname: firefox 10:47:53 INFO - mozversion application_repository: https://hg.mozilla.org/projects/date 10:47:53 INFO - mozversion application_vendor: Mozilla 10:47:53 INFO - mozversion application_version: 52.0a1 10:47:53 INFO - mozversion platform_buildid: 20160926083452 10:47:53 INFO - mozversion platform_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 10:47:53 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/date 10:47:53 INFO - mozversion platform_version: 52.0a1 10:47:53 INFO - using testdate: 1474912073 10:47:53 INFO - actual date: 1474912073 10:47:53 INFO - starting webserver on 'localhost:49295' 10:47:53 INFO - SUITE-START | Running 2 tests 10:47:53 INFO - TEST-START | dromaeo_css 10:47:53 INFO - operating with platform_type : mac_ 10:47:53 INFO - Initialising browser for dromaeo_css test... 10:47:53 INFO - TEST-INFO | started process 2562 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpW38Mhr/profile http://localhost:49295/getInfo.html) 10:47:55 INFO - PROCESS | 2562 | __metrics Screen width/height:1600/1200 10:47:55 INFO - PROCESS | 2562 | colorDepth:24 10:47:55 INFO - PROCESS | 2562 | Browser inner width/height: 1024/689 10:47:55 INFO - PROCESS | 2562 | __metrics 10:47:55 INFO - PROCESS | 2562 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:47:55 INFO - PROCESS | 2562 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:47:56 INFO - TEST-INFO | 2562: exit 0 10:47:56 INFO - Browser initialized. 10:47:56 INFO - Running cycle 1/1 for dromaeo_css test... 10:47:56 INFO - TEST-INFO | started process 2565 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpW38Mhr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:48:08 INFO - PROCESS | 2565 | RSS: Main: 207077376 10:48:08 INFO - PROCESS | 2565 | 10:49:00 INFO - PROCESS | 2565 | 1474912140064 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:51:12 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:49295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49295/tests/dromaeo/cssquery-ext.html) 10:51:13 INFO - PROCESS | 2565 | RSS: Main: 334200832 10:51:13 INFO - PROCESS | 2565 | 10:54:16 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:49295/tests/dromaeo/cssquery-ext.html (next: http://localhost:49295/tests/dromaeo/cssquery-jquery.html) 10:54:17 INFO - PROCESS | 2565 | RSS: Main: 342933504 10:54:17 INFO - PROCESS | 2565 | 10:57:19 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:49295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49295/tests/dromaeo/cssquery-mootools.html) 10:57:19 INFO - PROCESS | 2565 | RSS: Main: 302837760 10:57:19 INFO - PROCESS | 2565 | 11:00:22 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:49295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49295/tests/dromaeo/cssquery-prototype.html) 11:00:22 INFO - PROCESS | 2565 | RSS: Main: 314355712 11:00:22 INFO - PROCESS | 2565 | 11:03:26 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:49295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49295/tests/dromaeo/cssquery-yui.html) 11:03:26 INFO - PROCESS | 2565 | RSS: Main: 297611264 11:03:26 INFO - PROCESS | 2565 | 11:06:30 INFO - PROCESS | 2565 | Cycle 1(1): loaded http://localhost:49295/tests/dromaeo/cssquery-yui.html (next: http://localhost:49295/tests/dromaeo/cssquery-dojo.html) 11:06:30 INFO - PROCESS | 2565 | RSS: Main: 356265984 11:06:30 INFO - PROCESS | 2565 | 11:06:30 INFO - PROCESS | 2565 | __start_tp_report 11:06:30 INFO - PROCESS | 2565 | _x_x_mozilla_page_load 11:06:30 INFO - PROCESS | 2565 | _x_x_mozilla_page_load_details 11:06:30 INFO - PROCESS | 2565 | |i|pagename|runs| 11:06:30 INFO - PROCESS | 2565 | |0;dojo.html;2699.689535703394;3222.8227447490385;3237.0774329316137;3254.170186602416;3283.6552162022986;5924.200232968548;5995.820125396234;6009.759609615616;6119.08213767935;6135.386461353863;6066.7573297068175;6082.787102451415;6117.66352850593;6118.235220597426;6119.602225855328;5356.276902618155;5389.757460914248;5404.216388623648;5446.836594902159;5471.097268950638;5478.479544443271;5500.257465242201;5507.0637991541535;5509.724513774296;5517.806876759314;5381.192821076831;5427.1316589345715;5457.672539647634;5471.288732464774;5481;4522.751248681321;5483.479069488392;5494.066008778517;5508.614396992212;5560.6941618210985;5246.291750613656;5365.409804921455;5378.596605254622;5420.512153906128;5423;6042.425969532887;6106.72519736613;6113.306720555889;6133.938660613426;6162.815115546496;6279.748810047593;6284.057391391282;6286.9056964145575;6290.905636415458;6296.6536840473755;6192.164057852222;6237.844053898689;6313.87372252557;6375.968120159416;6385.201849768779;6092.969535152296;6094.410812472398;6108.6759897029115;6160.44555989963;6161.815145545551;6444.162258906406;6452.193475815523;6460.45086167681;6464.838379040468;6468.870622587522;6109.602875813058;6246;6246.406591373812;6256.624602523863;6263.937360626335;6197.225346831646;6236.75052997875;6246.219222597176;6250.4374606285655;6287.371262873768;6254.405831446005;6261.96869015652;6266.530010249249;6278.340774218733;6293.213348331458;6237.251529816361;6242.032484964838;6275.529335299871;6279.434850863444;6279.434850863444;4378.605925466723;5032.7735251913755;5078.136716758087;5080.77136528857;5193.013327467769;4547.886302842456;4608.262677971508;4611.538846115429;4672.696274742131;4707.105649926503;6110.236220472441;6116.541259405562;6119.326874043852;6125.571210015256;6136.447719705248;5349.545288650508;6137.131844484766;6232.937670623236;6301.432871041537;6303.621782693053;6064.75740970365;6103.572749907464;6106.358832322631;6110.224634763485;6140.811014692577;5685.175649530877;5694.231278777394;5694.686792226467;5708.315002199763;5722.313322401338;6422.165118534561;6650.800475985729;6655.301193374819;6663.600183988976;6667;6193.597416168115;6229.221347331583;6245.250569931637;6266.404691554295;6338.334474880071;5579.776808927598;5618.859528511656;6576.671166441754;6615.4376877965915;6638.50211234169;6199.721012554356;6257.09272155544;6257.5932564383165;6271.216097987752;6273.65494897785;6186.319504854552;6210.596311239755;6227.595206311576;6230.096635987847;6252.343503932022;5080.822171223989;6247.625142491465;6259.2488901332135;6262.029385445263;6268.529860260407;6044.848878778066;6232.657203853832;6232.968835155795;6240.313565507881;6242.469390101711;6072.939270607414;6126.08108783686;6137.438273608381;6147.754089836357;6194.349593292639;6191.226096737908;6234.064890266496;6246.875062498815;6250.031245157008;6265.8746825062335;6129.877402452015;6257.030160325156;6266.467350275096;6270.9372906270355;6280.623162610258 11:06:30 INFO - PROCESS | 2565 | |1;ext.html;480.872568769276;483.20753963499857;533.5678100738401;537.2854104041625;539.1831375466166;31766.68233317666;41740.79129604355;42571.14857702844;42804;45431;44472.555274447244;44847.77576112115;44861.7756911215;44950.32574511385;44987;9461.47961862099;9631.373960692532;9631.614735410576;9632.229421646252;9640.469774162419;9513.524323783819;9630.711078667617;9644.662436814713;9657.275704322168;9657.5171241438;9611.327207095506;9622.085901839315;9657.46883921384;9663.985281545441;9682.564284607175;9557.713268601918;9638.614455421775;9638.710838674851;9639.18066964302;9646.469444180531;9425.19885809707;9508.763860698135;9515.57179926898;9526.142647161789;9528.094830991045;40454;40803.7959810202;40816.79591602053;40837.38743918844;40851;3013.7136971987848;3512.8067956262394;3774.339490589136;4097.692673049503;4257.148570285955;30709.078727638207;30738.692613073807;31990;32172.517412238834;32334.838325808454;3285.227971426713;3312.734981201498;3319.452290372086;3435.7766745161484;3452.3440546296374;359193;363204;363692;363885;365025;33123.3375332492;33892.32215355679;60667.69666151641;60898.78202436015;61055;34748.9575312741;34764.783232586735;35446.64553354485;35597.93206203818;35606.46590301148;14422.495212667716;14580.781288280685;14582.979191456709;14588.927055364868;14662.266886655838;12277.815832762515;12409;12409.689757755948;12410.441530131166;12437.564685235973;7894.842103158019;7902.4863383879865;7913.287804097658;7986.68053277874;8021.27808497238;3283.9835800820842;3307.503874418808;3308.8345582720767;3310.4537751270773;3347.8828241011447;958.5351104714208;966.970990870275;992.5434300221979;1017.4963393120305;1025.0620682075967;28068.43863122767;30153.849230753705;30204.84897575498;30822.075337739905;30986;905.3798148268457;1055.9102476289602;1081.7782354617284;1082.6697857153645;1142.9371384573762;12249.816252756216;15322.540323790305;15853.762193567105;15878.841211587967;16164.595885102732;684148;687731;688163;689246;692358;58209.70895145497;58548.82902342015;58677;58799.70600146972;58802;1259.5150866916304;1303.0683061611182;1347.649611101101;1373.0594542738256;1380.2615600653603;25415.87292063528;29054;29695.554566681087;32662.51006234956;33025.844095456545;49951.25073123833;56169;56846;56941.71529142328;60614.696926515084;659339;663028.8062551838;664073;667451;668641;36077;36629.63370366369;36681.79909205456;38647.806760966014;43424.56575434205;46813.53186468092;47246.52753472559;47262.52737472581;47554;48638.513614864816;39438;39454.210915782096;39705.40441893316;40926.59073409347;41209.58790412178;31244.843775780977;38676;39164.804175980076;39537.209255814145;40678.59321406748;37725.245495090494;38594;38649.6135038646;39248.80375598104;39324.623638172525;30418;31648.5252721214;31773.9346942448;34236.657633424344;34530;24726.88729007163;25247.62128568036;25316.620250696622;25758.227253182435;25806.870965645052 11:06:30 INFO - PROCESS | 2565 | |2;jquery.html;376.0917384516393;378.8636091007237;390.3188935307887;398.1517172732464;411.83114922881623;14344.71310573788;20761;21246.362609121712;21400.464988375297;21446.927653617317;16024.839751602509;17341.566460838487;19442.319518816843;20161.596768064668;20221.393358199242;5648;5937.990541607937;5943.791967281146;5946.345901950804;5957.136215248786;5938.079597662369;5970.940290597082;6006.159137720722;7514.211007844179;7877.0547534295965;7796.922030779676;7912.723054693087;7970.880436793453;7973;7979.680812767482;7768.922310776877;7913.723019694312;7953.323967462773;7986.7603971880935;7991.360691144723;7353.926460735431;7607.277308655669;7698.1916898725385;7711.460197786158;7749.49628274166;24067.39831504209;29302.85348573265;29490;30057;30379.240518986982;2572.871356432171;2640.537905866485;2646.7088620251757;2781.6105745195687;2992.5959995400776;13639.659008524766;13933.3526629941;17418.912905435518;17534.649307013915;18429.262829486805;2045.1308194017483;2087.1859974609915;2165.8808765517892;2194;2216;120737.99999999913;139040.30479847637;155653.44346556615;156245;157905;21028.474288142614;21550;21720.34838954834;21940;21972.230971916226;35980.64019359773;36034.73878414243;36155;36161.37273822684;36408;9532.285078619132;9901.05939935705;10071.798564028824;10073.395596264247;10562.894371056345;7153.320434558708;8319.875201871977;8349.29031032357;8490.490570565786;8592.140785921358;8029.839403211903;9961.302708810459;10057.446840423847;10083.394996300245;10099.646512372032;3148.401803657298;3256.9837150814096;3772.302124107049;3861.7489863158803;3871;869.699953516036;915.0666320353203;932.9020452852488;941.7833898203452;977.9022097790306;20979.580408391746;21572.56854862894;21590.676139857915;21603.459913502287;21660.700357978258;905.6965916418073;907.3693782820876;942.5381563034201;988.9653862114935;992.965246216379;10185;11240.943795280971;11268.492917818718;11289.49197286124;11296;539592;580261;593864;611421;618360;126968;130399;130888.3455582735;135119;141222.587774123;977.8044391121804;1004.5178314408978;1024.882138554061;1025.1644909398817;1028.6965345223327;15228.847711523185;18295.54261143482;18573.814261857748;19546.82719036862;19570.706439403704;56137;57575.42424575701;57691.711541442026;58047;59056;85874;86323;87207;87659.56170219109;89019.55490222508;8133;8146.4297499176855;8257.463264887763;8266.669333226604;8292.502449853027;11064.391458469861;12832.165909215872;13168.802467962796;13241.867581324064;13532.458701651824;9825;10261.127804136433;10551.314164579278;11059.944700276446;11517.152834326866;10290.845637315597;11612.187146899974;11967.688730799135;11997.340146291688;12001.1599188056;11009.229353945148;11546.19176657626;11572;11627.069834413058;11938.462769175581;7217.159624295771;7451.7391891285715;7537.2085930976455;7815.062192536932;8522.70170544028;9448.236575688687;10091.949540252252;11615.825762613737;11946.104042196695;11982.460789264329 11:06:30 INFO - PROCESS | 2565 | |3;mootools.html;1350.6420798488402;1547.7772559677855;1711.2727090986327;1913.0912816412215;1913.6842421000536;8695.304375649948;9282.39664421813;9292.256619470443;9298.86051709225;9318.114779095991;8224.83550328993;8429.072801991791;8433;8738.038815730264;9030.548472576362;2436.135172013932;2478.467129567143;2480.169143336975;2480.7643273889043;2485.8135639827087;2411.5297516984197;2450.571150048743;2468.5803413419762;2475.133703203873;2476.368526025861;2151.2040544998295;2423;2460.618604116356;2466.7779899809016;2472.9752702473015;2409.132712223598;2421.685180926486;2425.4300239443714;2427.672264244322;2428.259380888828;2399.3761621978238;2426.793722533587;2434.20888211332;2438.0491608272787;2438.2685194441597;8952.955235223848;9009.279257659371;9078.319126065571;9085.273178145733;9091.81816363669;4504.6396288296855;5450.100733378988;5450.373207081197;5453.345598528163;5468.589855760794;3383.8477268522975;3459.238967427162;3598.3702852000797;3599.280143971216;3601.2797440512004;882.9337799665051;1028.5320179318392;1038.3043360948184;1048.6801525534709;1048.916086713061;9942.254330925138;11948.880511194864;11970;11973.82039269403;12032.939835300855;4495.460544734653;4812.951870481321;4838.419389673261;4842.564169224786;4849.321095046696;10127.392356458637;10186.847197292047;10203.132733717717;10215.642452514126;10216.948915255525;5416.295881535375;5425.565954723613;5427.48438898304;5445.918311225335;5447.809326673548;4869.780859861315;4904.754762261872;4949.975250123726;4983.90032199354;4998.9500104999215;3932.7640341579595;3994.9201015979515;4029.3351596986167;4087.9386809197886;4095.89760255996;1296.4101333893057;1313.6059182245288;1318.0905175428923;1329.528017553774;1336.4921329894578;835.6949713354703;836.6281591687513;888.5201990924958;899.8740176375181;932.7854593443546;5713.371529131792;5776.42235776419;5896.528277737771;6012.338642749294;6042.882066817653;896.9955150224207;937.8745505393555;942.9575669094908;944.7779771753633;993.6671215142864;3896.59085795993;4006.59934006597;4007.919841603152;4100.528439229467;4120.340745480708;8148.837023259502;9478;11171.38557379352;11179.552817887194;11186.552537898393;10570.471476426148;11060.944695276472;11176.664700059011;11178.441077946232;11181.217314787888;6770.916653335443;8323.500589964622;8437.325013998989;8455.873161902577;8467.745967620982;4819.7108173509705;5777.8555536111935;5805.245318108618;5833.883322333614;5835.79574714883;9863.802723945337;10197.74505637365;10231.59073637076;10383.376997380181;10411.635592754217;9478.682381863344;9945;10327;10484.213683973885;10518.526666299882;6826.692798823966;6832.863342733217;7580.393568514616;7587.734429295169;7722.613869306625;8333.83332333362;8342.666293348198;8379.664813407639;8408.873866892123;8465.322774178174;6647.60114393138;7550.924490755022;7664.31021208094;7666.923330766621;7696.345810605937;7095.476185733426;7114.893276600958;7255.56466612005;7375.54576446904;7731.845363092819;6697.129373181455;7088.539244949062;7211.567305961659;7215.891761623475;7218.639068046682;4819.204831202953;4867.488913664014;4917.213245880642;4964.379452568429;5097.8215762448135;4794.352762377034;4946.727929963743;5030.346055012825;5110.134800797757;5116.334876466036 11:06:30 INFO - PROCESS | 2565 | |4;prototype.html;259.6326198429222;303.8086005816337;312.7966821565982;317.21172885379826;320.25860133790286;4641.883952901179;5334.813281535147;5449.174526533606;5476;5502.477264659856;4281.7002809803325;4428.933565996513;5109.540141387274;5246.422893481714;5330.253764472977;3874.922501549974;4130.731502452331;4143.917121657565;4183.5398106208295;4208.516020657617;4143.461350024508;4146.460960075186;4179.414881916519;4183.247015537202;4191.811368488426;3864.1692036212207;4117.938230926538;4143.937840932388;4184.602462766047;4192.308269135604;4149.107941792499;4151.920500669832;4163.854265100707;4165.8541951031875;4171.582841715835;3322.684344987222;3393.6776006279365;3624.3113808376324;3649.7627654202392;3690.704743620504;4369.60673539383;5161.974190129063;5303.575713942875;5405.648632838853;5450.084204950373;3992.740471869319;4793.496682848286;4801.615870730368;4827.879303017417;4895.853124406273;4721.409823772028;4996.4254110777;5727.281815455389;5742.2247996520355;5763.971180144073;3382.813945233011;3909.4331321958157;4041.4948131483566;4057.7971101445105;4058.431819545266;5399.2980912481125;5868.532866783305;5947.22686050815;5951.155141906023;6148.631082135042;4062.4921884764403;4070.8371665133654;4089.427480152781;4122.505299364096;4149.668026557868;3588.946165807463;3906.257811015898;4158.2307273154565;4169.498980367065;4176.853810116631;3576.266865292661;4209.5579964103945;4265.87202383929;4703.365045718852;4820.108279968147;4473.150101480708;4528.841490547881;4688.718676879398;5675;5741.282339707536;1264.525802823941;1333.0668532027425;1388.7430825297351;1423.2456797896923;1440.683049729058;923.8383282925461;957.7126861941529;987.8518222266574;993.0615568287899;996.9551370188359;4493.528179541101;5357.866053348697;5398.325209348832;5434.456554344534;5446.809361672323;4309.913801723948;5832.8541786454825;5837.737301821428;5861.20873682056;5969.731362088716;5423.376311724202;5435.728213589305;5477.315335583052;5496.729445979636;5511.181310167635;2982.940341193164;3065.310305181361;3130.4208721386162;3133.9529907051415;3151.9212019699235;6026.5178785697035;6061.36355682647;6063.848403789941;6253.96873015632;6317;4870.634702397334;5670.461306175906;5912.9113063304085;5962.731677074542;6015.6691381974415;5422.864428389243;5938.168656388196;6086.60437071589;6161.599496032743;6183.5671502994355;5352.678839269501;5750.338711048283;5864.354920958605;5864.560157988082;5878.853028674317;4445.688801783974;5134.612405231585;5880.500157486662;5974;6000.249968753906;5830.970845145747;6115.969420152871;6150.538709596887;6182.258129024546;6263.4362907338555;3909.784961827013;3928.7053470989217;3947.2500224957166;3984.2230765000545;3997.1006523531973;5882.176495290577;5944.454441845065;5949.66132620157;5967.850803729942;5988.790392336247;4742.66801323904;5473.343198816167;5738.655680659173;5743.971280143573;5772.163036359789;5704.686242256716;5739.9139012915675;5748;5749.91375129365;5796.768129274782;5144.331236939174;5338.3060202173465;5554.2779438672715;5607.5513958882375;5704.600677952503;5194.792208311776;5680.40355762639;5733.2260144881575;5749.562609347663;5753.367129615823;4726.858194254178;5200.323957885451;5257.921131183112;5647.378788333198;5711.5145212655725 11:06:30 INFO - PROCESS | 2565 | |5;yui.html;618.9040698691703;738.0810890441398;773.6209257463844;792.90485141783;857.8884744983153;15810.683786324282;16545.586360340996;16704.164791760424;16720.247588858485;17723.379681711143;16955.237014334354;17056.317747290126;17064.914675426637;17068.231929563168;17090.48728538146;869.8303830753006;893.8569828827357;894.6555576103215;896.1397058823537;896.1441823058963;714.0681410758957;735.3418690272204;867.7657032601194;886.6763631274603;902.1204325782343;908.5230254116609;911.8085202107566;912.0742446416859;912.6531917871199;923.1414784250678;777.4635501503973;904.7783293093169;904.9502277374742;905.1536813079725;905.8550631898897;555.8804856955734;570.9086546152637;669.1969636436296;689.689639662154;695.7182341151791;15847.286872090783;15886.36454541817;15891.284892179765;15896.125713085892;15899;13636;14018.92990535051;14100.660437258546;14110.153390796586;14234;13448.327583620878;13568.660783480393;13639.795403068962;13793.034487585874;13933.164010159322;4152.563980782034;4671.743054132022;4759.4764575896625;4790.784414701347;4850.951490485085;110714.44642776734;112219.43890280496;112290.43854780756;112814.23294804015;114665.28002079975;11063.502142403611;11096.223264371416;11205.327680339044;11217.607383741693;11241.60654377093;17793.822061779218;21412.143514259566;21414.822184779987;21439.46401339979;21517.03173357203;7615.695372185161;7630.8092297693;7663.693452261847;7703.2967032967035;7741.032370953631;4510.143072816154;4526.705764125321;4591.79336929839;4711.010687755541;4715.080559290974;3174.873005079817;3249;3250.821204833757;3269.85285662141;3293.374258890803;534.4228233507803;643.2056410333234;645.4223469994329;648.0506058624138;649.3701109923461;613.355976224962;614.6865098799644;620.4756980351596;627.7520379450092;651.7523341130435;7896.815477678394;8511.914880851236;8898.806269816847;8905.243054340324;9028.63885444588;586.7095787585173;620.3703241210176;623.1494010675486;630.3822254190827;634.2832599163008;4122.443470131554;4363.738175709467;4374.387585737999;4450.732956022584;4482.618977386894;162180.56729149073;162980;163330;164017;165977.1701141511;57015;80239.59880200561;105687;112116;149465;71512.64243678749;86287.56856215678;98112.50943745379;110237;111863.57637083602;9156.866157786068;9820.165285950774;10176.084152426318;10276;10395.532201051123;48311.5168848307;57697.84604307806;58236.83526329535;60802;62472.37527624847;51824;83822.16177838387;88924;91970.54014729883;92386.53806730923;13013.705467213582;13749.450021999008;13823.308834558433;13897.722045559234;14256.863490032176;15271.165134073228;15389.076655400711;15633.921830390775;15642.765358519404;16177.919110404373;14077.859221407654;14104.929475352557;14395.352209150404;14420.423183072979;14695.265236738334;14018.29908504591;14055.359058935885;14359.138451692932;14417.567472975827;14994.550163495112;12654.240745555297;13375.331233438095;14001.789973150615;14038.508652197124;14269.571912842632;11404.691558763183;11570.826437603275;11595.362255076052;11650.30098194111;11992.220505667105;11432.485538150637;11555.4800033997;11706.297622142698;11792.76414471723;11802 11:06:30 INFO - PROCESS | 2565 | __end_tp_report 11:06:30 INFO - PROCESS | 2565 | __start_cc_report 11:06:30 INFO - PROCESS | 2565 | _x_x_mozilla_cycle_collect,1230 11:06:30 INFO - PROCESS | 2565 | __end_cc_report 11:06:30 INFO - PROCESS | 2565 | __startTimestamp1474913190351__endTimestamp 11:06:30 INFO - PROCESS | 2565 | 11:06:30 INFO - PROCESS | 2565 | ------- Summary: start ------- 11:06:30 INFO - PROCESS | 2565 | Number of tests: 6 11:06:30 INFO - PROCESS | 2565 | 11:06:30 INFO - PROCESS | 2565 | [#0] dojo.html Cycles:165 Average:5895.72 Median:6140.81 stddev:678.01 (11.0%) stddev-sans-first:632.04 11:06:30 INFO - PROCESS | 2565 | Values: 2699.7 3222.8 3237.1 3254.2 3283.7 5924.2 5995.8 6009.8 6119.1 6135.4 6066.8 6082.8 6117.7 6118.2 6119.6 5356.3 5389.8 5404.2 5446.8 5471.1 5478.5 5500.3 5507.1 5509.7 5517.8 5381.2 5427.1 5457.7 5471.3 5481.0 4522.8 5483.5 5494.1 5508.6 5560.7 5246.3 5365.4 5378.6 5420.5 5423.0 6042.4 6106.7 6113.3 6133.9 6162.8 6279.7 6284.1 6286.9 6290.9 6296.7 6192.2 6237.8 6313.9 6376.0 6385.2 6093.0 6094.4 6108.7 6160.4 6161.8 6444.2 6452.2 6460.5 6464.8 6468.9 6109.6 6246.0 6246.4 6256.6 6263.9 6197.2 6236.8 6246.2 6250.4 6287.4 6254.4 6262.0 6266.5 6278.3 6293.2 6237.3 6242.0 6275.5 6279.4 6279.4 4378.6 5032.8 5078.1 5080.8 5193.0 4547.9 4608.3 4611.5 4672.7 4707.1 6110.2 6116.5 6119.3 6125.6 6136.4 5349.5 6137.1 6232.9 6301.4 6303.6 6064.8 6103.6 6106.4 6110.2 6140.8 5685.2 5694.2 5694.7 5708.3 5722.3 6422.2 6650.8 6655.3 6663.6 6667.0 6193.6 6229.2 6245.3 6266.4 6338.3 5579.8 5618.9 6576.7 6615.4 6638.5 6199.7 6257.1 6257.6 6271.2 6273.7 6186.3 6210.6 6227.6 6230.1 6252.3 5080.8 6247.6 6259.2 6262.0 6268.5 6044.8 6232.7 6233.0 6240.3 6242.5 6072.9 6126.1 6137.4 6147.8 6194.3 6191.2 6234.1 6246.9 6250.0 6265.9 6129.9 6257.0 6266.5 6270.9 6280.6 11:06:30 INFO - PROCESS | 2565 | 11:06:30 INFO - PROCESS | 2565 | [#1] ext.html Cycles:180 Average:69623.37 Median:39495.71 stddev:158773.15 (402.0%) stddev-sans-first:159133.68 11:06:30 INFO - PROCESS | 2565 | Values: 480.9 483.2 533.6 537.3 539.2 31766.7 41740.8 42571.1 42804.0 45431.0 44472.6 44847.8 44861.8 44950.3 44987.0 9461.5 9631.4 9631.6 9632.2 9640.5 9513.5 9630.7 9644.7 9657.3 9657.5 9611.3 9622.1 9657.5 9664.0 9682.6 9557.7 9638.6 9638.7 9639.2 9646.5 9425.2 9508.8 9515.6 9526.1 9528.1 40454.0 40803.8 40816.8 40837.4 40851.0 3013.7 3512.8 3774.3 4097.7 4257.1 30709.1 30738.7 31990.0 32172.5 32334.8 3285.2 3312.7 3319.5 3435.8 3452.3 359193.0 363204.0 363692.0 363885.0 365025.0 33123.3 33892.3 60667.7 60898.8 61055.0 34749.0 34764.8 35446.6 35597.9 35606.5 14422.5 14580.8 14583.0 14588.9 14662.3 12277.8 12409.0 12409.7 12410.4 12437.6 7894.8 7902.5 7913.3 7986.7 8021.3 3284.0 3307.5 3308.8 3310.5 3347.9 958.5 967.0 992.5 1017.5 1025.1 28068.4 30153.8 30204.8 30822.1 30986.0 905.4 1055.9 1081.8 1082.7 1142.9 12249.8 15322.5 15853.8 15878.8 16164.6 684148.0 687731.0 688163.0 689246.0 692358.0 58209.7 58548.8 58677.0 58799.7 58802.0 1259.5 1303.1 1347.6 1373.1 1380.3 25415.9 29054.0 29695.6 32662.5 33025.8 49951.3 56169.0 56846.0 56941.7 60614.7 659339.0 663028.8 664073.0 667451.0 668641.0 36077.0 36629.6 36681.8 38647.8 43424.6 46813.5 47246.5 47262.5 47554.0 48638.5 39438.0 39454.2 39705.4 40926.6 41209.6 31244.8 38676.0 39164.8 39537.2 40678.6 37725.2 38594.0 38649.6 39248.8 39324.6 30418.0 31648.5 31773.9 34236.7 34530.0 24726.9 25247.6 25316.6 25758.2 25806.9 11:06:30 INFO - PROCESS | 2565 | 11:06:30 INFO - PROCESS | 2565 | [#2] jquery.html Cycles:180 Average:37595.19 Median:16524.80 stddev:99225.94 (600.5%) stddev-sans-first:99464.94 11:06:30 INFO - PROCESS | 2565 | Values: 376.1 378.9 390.3 398.2 411.8 14344.7 20761.0 21246.4 21400.5 21446.9 16024.8 17341.6 19442.3 20161.6 20221.4 5648.0 5938.0 5943.8 5946.3 5957.1 5938.1 5970.9 6006.2 7514.2 7877.1 7796.9 7912.7 7970.9 7973.0 7979.7 7768.9 7913.7 7953.3 7986.8 7991.4 7353.9 7607.3 7698.2 7711.5 7749.5 24067.4 29302.9 29490.0 30057.0 30379.2 2572.9 2640.5 2646.7 2781.6 2992.6 13639.7 13933.4 17418.9 17534.6 18429.3 2045.1 2087.2 2165.9 2194.0 2216.0 120738.0 139040.3 155653.4 156245.0 157905.0 21028.5 21550.0 21720.3 21940.0 21972.2 35980.6 36034.7 36155.0 36161.4 36408.0 9532.3 9901.1 10071.8 10073.4 10562.9 7153.3 8319.9 8349.3 8490.5 8592.1 8029.8 9961.3 10057.4 10083.4 10099.6 3148.4 3257.0 3772.3 3861.7 3871.0 869.7 915.1 932.9 941.8 977.9 20979.6 21572.6 21590.7 21603.5 21660.7 905.7 907.4 942.5 989.0 993.0 10185.0 11240.9 11268.5 11289.5 11296.0 539592.0 580261.0 593864.0 611421.0 618360.0 126968.0 130399.0 130888.3 135119.0 141222.6 977.8 1004.5 1024.9 1025.2 1028.7 15228.8 18295.5 18573.8 19546.8 19570.7 56137.0 57575.4 57691.7 58047.0 59056.0 85874.0 86323.0 87207.0 87659.6 89019.6 8133.0 8146.4 8257.5 8266.7 8292.5 11064.4 12832.2 13168.8 13241.9 13532.5 9825.0 10261.1 10551.3 11059.9 11517.2 10290.8 11612.2 11967.7 11997.3 12001.2 11009.2 11546.2 11572.0 11627.1 11938.5 7217.2 7451.7 7537.2 7815.1 8522.7 9448.2 10091.9 11615.8 11946.1 11982.5 11:06:30 INFO - PROCESS | 2565 | 11:06:30 INFO - PROCESS | 2565 | [#3] mootools.html Cycles:180 Average:5757.24 Median:4931.97 stddev:3222.95 (65.3%) stddev-sans-first:3214.98 11:06:30 INFO - PROCESS | 2565 | Values: 1350.6 1547.8 1711.3 1913.1 1913.7 8695.3 9282.4 9292.3 9298.9 9318.1 8224.8 8429.1 8433.0 8738.0 9030.5 2436.1 2478.5 2480.2 2480.8 2485.8 2411.5 2450.6 2468.6 2475.1 2476.4 2151.2 2423.0 2460.6 2466.8 2473.0 2409.1 2421.7 2425.4 2427.7 2428.3 2399.4 2426.8 2434.2 2438.0 2438.3 8953.0 9009.3 9078.3 9085.3 9091.8 4504.6 5450.1 5450.4 5453.3 5468.6 3383.8 3459.2 3598.4 3599.3 3601.3 882.9 1028.5 1038.3 1048.7 1048.9 9942.3 11948.9 11970.0 11973.8 12032.9 4495.5 4813.0 4838.4 4842.6 4849.3 10127.4 10186.8 10203.1 10215.6 10216.9 5416.3 5425.6 5427.5 5445.9 5447.8 4869.8 4904.8 4950.0 4983.9 4999.0 3932.8 3994.9 4029.3 4087.9 4095.9 1296.4 1313.6 1318.1 1329.5 1336.5 835.7 836.6 888.5 899.9 932.8 5713.4 5776.4 5896.5 6012.3 6042.9 897.0 937.9 943.0 944.8 993.7 3896.6 4006.6 4007.9 4100.5 4120.3 8148.8 9478.0 11171.4 11179.6 11186.6 10570.5 11060.9 11176.7 11178.4 11181.2 6770.9 8323.5 8437.3 8455.9 8467.7 4819.7 5777.9 5805.2 5833.9 5835.8 9863.8 10197.7 10231.6 10383.4 10411.6 9478.7 9945.0 10327.0 10484.2 10518.5 6826.7 6832.9 7580.4 7587.7 7722.6 8333.8 8342.7 8379.7 8408.9 8465.3 6647.6 7550.9 7664.3 7666.9 7696.3 7095.5 7114.9 7255.6 7375.5 7731.8 6697.1 7088.5 7211.6 7215.9 7218.6 4819.2 4867.5 4917.2 4964.4 5097.8 4794.4 4946.7 5030.3 5110.1 5116.3 11:06:30 INFO - PROCESS | 2565 | 11:06:30 INFO - PROCESS | 2565 | [#4] prototype.html Cycles:180 Average:4646.64 Median:5223.37 stddev:1421.29 (27.2%) stddev-sans-first:1386.61 11:06:30 INFO - PROCESS | 2565 | Values: 259.6 303.8 312.8 317.2 320.3 4641.9 5334.8 5449.2 5476.0 5502.5 4281.7 4428.9 5109.5 5246.4 5330.3 3874.9 4130.7 4143.9 4183.5 4208.5 4143.5 4146.5 4179.4 4183.2 4191.8 3864.2 4117.9 4143.9 4184.6 4192.3 4149.1 4151.9 4163.9 4165.9 4171.6 3322.7 3393.7 3624.3 3649.8 3690.7 4369.6 5162.0 5303.6 5405.6 5450.1 3992.7 4793.5 4801.6 4827.9 4895.9 4721.4 4996.4 5727.3 5742.2 5764.0 3382.8 3909.4 4041.5 4057.8 4058.4 5399.3 5868.5 5947.2 5951.2 6148.6 4062.5 4070.8 4089.4 4122.5 4149.7 3588.9 3906.3 4158.2 4169.5 4176.9 3576.3 4209.6 4265.9 4703.4 4820.1 4473.2 4528.8 4688.7 5675.0 5741.3 1264.5 1333.1 1388.7 1423.2 1440.7 923.8 957.7 987.9 993.1 997.0 4493.5 5357.9 5398.3 5434.5 5446.8 4309.9 5832.9 5837.7 5861.2 5969.7 5423.4 5435.7 5477.3 5496.7 5511.2 2982.9 3065.3 3130.4 3134.0 3151.9 6026.5 6061.4 6063.8 6254.0 6317.0 4870.6 5670.5 5912.9 5962.7 6015.7 5422.9 5938.2 6086.6 6161.6 6183.6 5352.7 5750.3 5864.4 5864.6 5878.9 4445.7 5134.6 5880.5 5974.0 6000.2 5831.0 6116.0 6150.5 6182.3 6263.4 3909.8 3928.7 3947.3 3984.2 3997.1 5882.2 5944.5 5949.7 5967.9 5988.8 4742.7 5473.3 5738.7 5744.0 5772.2 5704.7 5739.9 5748.0 5749.9 5796.8 5144.3 5338.3 5554.3 5607.6 5704.6 5194.8 5680.4 5733.2 5749.6 5753.4 4726.9 5200.3 5257.9 5647.4 5711.5 11:06:30 INFO - PROCESS | 2565 | 11:06:30 INFO - PROCESS | 2565 | [#5] yui.html Cycles:180 Average:24061.19 Median:3260.34 stddev:38395.94 (1177.7%) stddev-sans-first:38463.30 11:06:30 INFO - PROCESS | 2565 | Values: 618.9 738.1 773.6 792.9 857.9 15810.7 16545.6 16704.2 16720.2 17723.4 16955.2 17056.3 17064.9 17068.2 17090.5 869.8 893.9 894.7 896.1 896.1 714.1 735.3 867.8 886.7 902.1 908.5 911.8 912.1 912.7 923.1 777.5 904.8 905.0 905.2 905.9 555.9 570.9 669.2 689.7 695.7 15847.3 15886.4 15891.3 15896.1 15899.0 13636.0 14018.9 14100.7 14110.2 14234.0 13448.3 13568.7 13639.8 13793.0 13933.2 4152.6 4671.7 4759.5 4790.8 4851.0 110714.4 112219.4 112290.4 112814.2 114665.3 11063.5 11096.2 11205.3 11217.6 11241.6 17793.8 21412.1 21414.8 21439.5 21517.0 7615.7 7630.8 7663.7 7703.3 7741.0 4510.1 4526.7 4591.8 4711.0 4715.1 3174.9 3249.0 3250.8 3269.9 3293.4 534.4 643.2 645.4 648.1 649.4 613.4 614.7 620.5 627.8 651.8 7896.8 8511.9 8898.8 8905.2 9028.6 586.7 620.4 623.1 630.4 634.3 4122.4 4363.7 4374.4 4450.7 4482.6 162180.6 162980.0 163330.0 164017.0 165977.2 57015.0 80239.6 105687.0 112116.0 149465.0 71512.6 86287.6 98112.5 110237.0 111863.6 9156.9 9820.2 10176.1 10276.0 10395.5 48311.5 57697.8 58236.8 60802.0 62472.4 51824.0 83822.2 88924.0 91970.5 92386.5 13013.7 13749.5 13823.3 13897.7 14256.9 15271.2 15389.1 15633.9 15642.8 16177.9 14077.9 14104.9 14395.4 14420.4 14695.3 14018.3 14055.4 14359.1 14417.6 14994.6 12654.2 13375.3 14001.8 14038.5 14269.6 11404.7 11570.8 11595.4 11650.3 11992.2 11432.5 11555.5 11706.3 11792.8 11802.0 11:06:30 INFO - PROCESS | 2565 | -------- Summary: end -------- 11:06:30 INFO - PROCESS | 2565 | 11:06:30 INFO - TEST-INFO | 2565: exit 0 11:06:30 INFO - TEST-OK | dromaeo_css | took 1117612ms 11:06:30 INFO - TEST-START | kraken 11:06:30 INFO - operating with platform_type : mac_ 11:06:30 INFO - Initialising browser for kraken test... 11:06:31 INFO - TEST-INFO | started process 2573 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpMhBFLR/profile http://localhost:49295/getInfo.html) 11:06:33 INFO - PROCESS | 2573 | __metrics Screen width/height:1600/1200 11:06:33 INFO - PROCESS | 2573 | colorDepth:24 11:06:33 INFO - PROCESS | 2573 | Browser inner width/height: 1024/689 11:06:33 INFO - PROCESS | 2573 | __metrics 11:06:33 INFO - PROCESS | 2573 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:06:33 INFO - PROCESS | 2573 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:34 INFO - TEST-INFO | 2573: exit 0 11:06:34 INFO - Browser initialized. 11:06:34 INFO - Running cycle 1/1 for kraken test... 11:06:34 INFO - TEST-INFO | started process 2574 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpMhBFLR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:46 INFO - PROCESS | 2574 | RSS: Main: 207081472 11:06:46 INFO - PROCESS | 2574 | 11:06:48 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49295/tests/kraken/driver.html?testName=audio-beat-detection) 11:06:49 INFO - PROCESS | 2574 | RSS: Main: 266559488 11:06:49 INFO - PROCESS | 2574 | 11:06:52 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49295/tests/kraken/driver.html?testName=audio-dft) 11:06:53 INFO - PROCESS | 2574 | RSS: Main: 268181504 11:06:53 INFO - PROCESS | 2574 | 11:06:56 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49295/tests/kraken/driver.html?testName=audio-fft) 11:06:57 INFO - PROCESS | 2574 | RSS: Main: 355885056 11:06:57 INFO - PROCESS | 2574 | 11:06:59 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49295/tests/kraken/driver.html?testName=audio-oscillator) 11:06:59 INFO - PROCESS | 2574 | RSS: Main: 256684032 11:06:59 INFO - PROCESS | 2574 | 11:07:01 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:07:02 INFO - PROCESS | 2574 | RSS: Main: 260952064 11:07:02 INFO - PROCESS | 2574 | 11:07:05 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49295/tests/kraken/driver.html?testName=imaging-darkroom) 11:07:05 INFO - PROCESS | 2574 | RSS: Main: 298491904 11:07:05 INFO - PROCESS | 2574 | 11:07:08 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49295/tests/kraken/driver.html?testName=imaging-desaturate) 11:07:09 INFO - PROCESS | 2574 | RSS: Main: 299618304 11:07:09 INFO - PROCESS | 2574 | 11:07:12 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49295/tests/kraken/driver.html?testName=json-parse-financial) 11:07:12 INFO - PROCESS | 2574 | RSS: Main: 297828352 11:07:12 INFO - PROCESS | 2574 | 11:07:14 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:07:14 INFO - PROCESS | 2574 | RSS: Main: 275349504 11:07:14 INFO - PROCESS | 2574 | 11:07:16 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49295/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:07:17 INFO - PROCESS | 2574 | RSS: Main: 278536192 11:07:17 INFO - PROCESS | 2574 | 11:07:19 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:07:20 INFO - PROCESS | 2574 | RSS: Main: 282345472 11:07:20 INFO - PROCESS | 2574 | 11:07:23 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:07:23 INFO - PROCESS | 2574 | RSS: Main: 286699520 11:07:23 INFO - PROCESS | 2574 | 11:07:26 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:07:27 INFO - PROCESS | 2574 | RSS: Main: 289316864 11:07:27 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | Cycle 1(1): loaded http://localhost:49295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49295/tests/kraken/driver.html?testName=ai-astar) 11:07:29 INFO - PROCESS | 2574 | RSS: Main: 332288000 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | __start_tp_report 11:07:29 INFO - PROCESS | 2574 | _x_x_mozilla_page_load 11:07:29 INFO - PROCESS | 2574 | _x_x_mozilla_page_load_details 11:07:29 INFO - PROCESS | 2574 | |i|pagename|runs| 11:07:29 INFO - PROCESS | 2574 | |0;ai-astar;115;163;166;113;112;113;112;113;111;111 11:07:29 INFO - PROCESS | 2574 | |1;audio-beat-detection;153;107;110;145;115;109;111;132;164;130 11:07:29 INFO - PROCESS | 2574 | |2;audio-dft;186;183;183;183;184;182;198;183;182;182 11:07:29 INFO - PROCESS | 2574 | |3;audio-fft;78;59;59;92;74;59;59;58;81;75 11:07:29 INFO - PROCESS | 2574 | |4;audio-oscillator;89;71;91;91;67;69;92;67;69;91 11:07:29 INFO - PROCESS | 2574 | |5;imaging-gaussian-blur;87;84;87;85;88;83;86;83;86;83 11:07:29 INFO - PROCESS | 2574 | |6;imaging-darkroom;93;94;94;94;92;93;106;149;123;92 11:07:29 INFO - PROCESS | 2574 | |7;imaging-desaturate;87;87;86;86;84;83;84;84;84;84 11:07:29 INFO - PROCESS | 2574 | |8;json-parse-financial;52;52;54;52;53;56;56;54;54;54 11:07:29 INFO - PROCESS | 2574 | |9;json-stringify-tinderbox;64;70;67;78;71;71;69;69;68;70 11:07:29 INFO - PROCESS | 2574 | |10;stanford-crypto-aes;87;86;84;85;82;86;82;87;85;84 11:07:29 INFO - PROCESS | 2574 | |11;stanford-crypto-ccm;135;131;133;136;134;136;136;138;200;152 11:07:29 INFO - PROCESS | 2574 | |12;stanford-crypto-pbkdf2;169;165;167;165;163;166;166;165;170;167 11:07:29 INFO - PROCESS | 2574 | |13;stanford-crypto-sha256-iterative;70;62;56;69;82;83;82;82;66;66 11:07:29 INFO - PROCESS | 2574 | __end_tp_report 11:07:29 INFO - PROCESS | 2574 | __start_cc_report 11:07:29 INFO - PROCESS | 2574 | _x_x_mozilla_cycle_collect,1950 11:07:29 INFO - PROCESS | 2574 | __end_cc_report 11:07:29 INFO - PROCESS | 2574 | __startTimestamp1474913249363__endTimestamp 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | ------- Summary: start ------- 11:07:29 INFO - PROCESS | 2574 | Number of tests: 14 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#0] ai-astar Cycles:10 Average:122.90 Median:113.00 stddev:21.97 (19.4%) stddev-sans-first:23.11 11:07:29 INFO - PROCESS | 2574 | Values: 115.0 163.0 166.0 113.0 112.0 113.0 112.0 113.0 111.0 111.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#1] audio-beat-detection Cycles:10 Average:127.60 Median:131.00 stddev:20.58 (15.7%) stddev-sans-first:19.67 11:07:29 INFO - PROCESS | 2574 | Values: 153.0 107.0 110.0 145.0 115.0 109.0 111.0 132.0 164.0 130.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#2] audio-dft Cycles:10 Average:184.60 Median:183.00 stddev:4.86 (2.7%) stddev-sans-first:5.13 11:07:29 INFO - PROCESS | 2574 | Values: 186.0 183.0 183.0 183.0 184.0 182.0 198.0 183.0 182.0 182.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#3] audio-fft Cycles:10 Average:69.40 Median:74.50 stddev:12.18 (16.3%) stddev-sans-first:12.51 11:07:29 INFO - PROCESS | 2574 | Values: 78.0 59.0 59.0 92.0 74.0 59.0 59.0 58.0 81.0 75.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#4] audio-oscillator Cycles:10 Average:79.70 Median:90.00 stddev:11.78 (13.1%) stddev-sans-first:12.00 11:07:29 INFO - PROCESS | 2574 | Values: 89.0 71.0 91.0 91.0 67.0 69.0 92.0 67.0 69.0 91.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.87 (2.2%) stddev-sans-first:1.87 11:07:29 INFO - PROCESS | 2574 | Values: 87.0 84.0 87.0 85.0 88.0 83.0 86.0 83.0 86.0 83.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:93.00 stddev:18.89 (20.3%) stddev-sans-first:19.68 11:07:29 INFO - PROCESS | 2574 | Values: 93.0 94.0 94.0 94.0 92.0 93.0 106.0 149.0 123.0 92.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.45 (1.7%) stddev-sans-first:1.32 11:07:29 INFO - PROCESS | 2574 | Values: 87.0 87.0 86.0 86.0 84.0 83.0 84.0 84.0 84.0 84.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.49 (2.8%) stddev-sans-first:1.45 11:07:29 INFO - PROCESS | 2574 | Values: 52.0 52.0 54.0 52.0 53.0 56.0 56.0 54.0 54.0 54.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:3.59 (5.1%) stddev-sans-first:3.16 11:07:29 INFO - PROCESS | 2574 | Values: 64.0 70.0 67.0 78.0 71.0 71.0 69.0 69.0 68.0 70.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.50 stddev:1.81 (2.1%) stddev-sans-first:1.74 11:07:29 INFO - PROCESS | 2574 | Values: 87.0 86.0 84.0 85.0 82.0 86.0 82.0 87.0 85.0 84.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:136.00 stddev:20.79 (15.3%) stddev-sans-first:21.85 11:07:29 INFO - PROCESS | 2574 | Values: 135.0 131.0 133.0 136.0 134.0 136.0 136.0 138.0 200.0 152.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.50 stddev:2.06 (1.2%) stddev-sans-first:1.94 11:07:29 INFO - PROCESS | 2574 | Values: 169.0 165.0 167.0 165.0 163.0 166.0 166.0 165.0 170.0 167.0 11:07:29 INFO - PROCESS | 2574 | 11:07:29 INFO - PROCESS | 2574 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:76.00 stddev:9.78 (12.9%) stddev-sans-first:10.36 11:07:29 INFO - PROCESS | 2574 | Values: 70.0 62.0 56.0 69.0 82.0 83.0 82.0 82.0 66.0 66.0 11:07:29 INFO - PROCESS | 2574 | -------- Summary: end -------- 11:07:29 INFO - PROCESS | 2574 | 11:07:30 INFO - TEST-INFO | 2574: exit 0 11:07:30 INFO - TEST-OK | kraken | took 59390ms 11:07:30 INFO - SUITE-END | took 1177s 11:07:30 INFO - Completed test suite (00:19:37) 11:07:30 INFO - javascript benchmark 11:07:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2699.689535703394, 3222.8227447490385, 3237.0774329316137, 3254.170186602416, 3283.6552162022986, 5924.200232968548, 5995.820125396234, 6009.759609615616, 6119.08213767935, 6135.386461353863, 6066.7573297068175, 6082.787102451415, 6117.66352850593, 6118.235220597426, 6119.602225855328, 5356.276902618155, 5389.757460914248, 5404.216388623648, 5446.836594902159, 5471.097268950638, 5478.479544443271, 5500.257465242201, 5507.0637991541535, 5509.724513774296, 5517.806876759314, 5381.192821076831, 5427.1316589345715, 5457.672539647634, 5471.288732464774, 5481.0, 4522.751248681321, 5483.479069488392, 5494.066008778517, 5508.614396992212, 5560.6941618210985, 5246.291750613656, 5365.409804921455, 5378.596605254622, 5420.512153906128, 5423.0, 6042.425969532887, 6106.72519736613, 6113.306720555889, 6133.938660613426, 6162.815115546496, 6279.748810047593, 6284.057391391282, 6286.9056964145575, 6290.905636415458, 6296.6536840473755, 6192.164057852222, 6237.844053898689, 6313.87372252557, 6375.968120159416, 6385.201849768779, 6092.969535152296, 6094.410812472398, 6108.6759897029115, 6160.44555989963, 6161.815145545551, 6444.162258906406, 6452.193475815523, 6460.45086167681, 6464.838379040468, 6468.870622587522, 6109.602875813058, 6246.0, 6246.406591373812, 6256.624602523863, 6263.937360626335, 6197.225346831646, 6236.75052997875, 6246.219222597176, 6250.4374606285655, 6287.371262873768, 6254.405831446005, 6261.96869015652, 6266.530010249249, 6278.340774218733, 6293.213348331458, 6237.251529816361, 6242.032484964838, 6275.529335299871, 6279.434850863444, 6279.434850863444, 4378.605925466723, 5032.7735251913755, 5078.136716758087, 5080.77136528857, 5193.013327467769, 4547.886302842456, 4608.262677971508, 4611.538846115429, 4672.696274742131, 4707.105649926503, 6110.236220472441, 6116.541259405562, 6119.326874043852, 6125.571210015256, 6136.447719705248, 5349.545288650508, 6137.131844484766, 6232.937670623236, 6301.432871041537, 6303.621782693053, 6064.75740970365, 6103.572749907464, 6106.358832322631, 6110.224634763485, 6140.811014692577, 5685.175649530877, 5694.231278777394, 5694.686792226467, 5708.315002199763, 5722.313322401338, 6422.165118534561, 6650.800475985729, 6655.301193374819, 6663.600183988976, 6667.0, 6193.597416168115, 6229.221347331583, 6245.250569931637, 6266.404691554295, 6338.334474880071, 5579.776808927598, 5618.859528511656, 6576.671166441754, 6615.4376877965915, 6638.50211234169, 6199.721012554356, 6257.09272155544, 6257.5932564383165, 6271.216097987752, 6273.65494897785, 6186.319504854552, 6210.596311239755, 6227.595206311576, 6230.096635987847, 6252.343503932022, 5080.822171223989, 6247.625142491465, 6259.2488901332135, 6262.029385445263, 6268.529860260407, 6044.848878778066, 6232.657203853832, 6232.968835155795, 6240.313565507881, 6242.469390101711, 6072.939270607414, 6126.08108783686, 6137.438273608381, 6147.754089836357, 6194.349593292639, 6191.226096737908, 6234.064890266496, 6246.875062498815, 6250.031245157008, 6265.8746825062335, 6129.877402452015, 6257.030160325156, 6266.467350275096, 6270.9372906270355, 6280.623162610258], "value": 5849.2116752566435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.872568769276, 483.20753963499857, 533.5678100738401, 537.2854104041625, 539.1831375466166, 31766.68233317666, 41740.79129604355, 42571.14857702844, 42804.0, 45431.0, 44472.555274447244, 44847.77576112115, 44861.7756911215, 44950.32574511385, 44987.0, 9461.47961862099, 9631.373960692532, 9631.614735410576, 9632.229421646252, 9640.469774162419, 9513.524323783819, 9630.711078667617, 9644.662436814713, 9657.275704322168, 9657.5171241438, 9611.327207095506, 9622.085901839315, 9657.46883921384, 9663.985281545441, 9682.564284607175, 9557.713268601918, 9638.614455421775, 9638.710838674851, 9639.18066964302, 9646.469444180531, 9425.19885809707, 9508.763860698135, 9515.57179926898, 9526.142647161789, 9528.094830991045, 40454.0, 40803.7959810202, 40816.79591602053, 40837.38743918844, 40851.0, 3013.7136971987848, 3512.8067956262394, 3774.339490589136, 4097.692673049503, 4257.148570285955, 30709.078727638207, 30738.692613073807, 31990.0, 32172.517412238834, 32334.838325808454, 3285.227971426713, 3312.734981201498, 3319.452290372086, 3435.7766745161484, 3452.3440546296374, 359193.0, 363204.0, 363692.0, 363885.0, 365025.0, 33123.3375332492, 33892.32215355679, 60667.69666151641, 60898.78202436015, 61055.0, 34748.9575312741, 34764.783232586735, 35446.64553354485, 35597.93206203818, 35606.46590301148, 14422.495212667716, 14580.781288280685, 14582.979191456709, 14588.927055364868, 14662.266886655838, 12277.815832762515, 12409.0, 12409.689757755948, 12410.441530131166, 12437.564685235973, 7894.842103158019, 7902.4863383879865, 7913.287804097658, 7986.68053277874, 8021.27808497238, 3283.9835800820842, 3307.503874418808, 3308.8345582720767, 3310.4537751270773, 3347.8828241011447, 958.5351104714208, 966.970990870275, 992.5434300221979, 1017.4963393120305, 1025.0620682075967, 28068.43863122767, 30153.849230753705, 30204.84897575498, 30822.075337739905, 30986.0, 905.3798148268457, 1055.9102476289602, 1081.7782354617284, 1082.6697857153645, 1142.9371384573762, 12249.816252756216, 15322.540323790305, 15853.762193567105, 15878.841211587967, 16164.595885102732, 684148.0, 687731.0, 688163.0, 689246.0, 692358.0, 58209.70895145497, 58548.82902342015, 58677.0, 58799.70600146972, 58802.0, 1259.5150866916304, 1303.0683061611182, 1347.649611101101, 1373.0594542738256, 1380.2615600653603, 25415.87292063528, 29054.0, 29695.554566681087, 32662.51006234956, 33025.844095456545, 49951.25073123833, 56169.0, 56846.0, 56941.71529142328, 60614.696926515084, 659339.0, 663028.8062551838, 664073.0, 667451.0, 668641.0, 36077.0, 36629.63370366369, 36681.79909205456, 38647.806760966014, 43424.56575434205, 46813.53186468092, 47246.52753472559, 47262.52737472581, 47554.0, 48638.513614864816, 39438.0, 39454.210915782096, 39705.40441893316, 40926.59073409347, 41209.58790412178, 31244.843775780977, 38676.0, 39164.804175980076, 39537.209255814145, 40678.59321406748, 37725.245495090494, 38594.0, 38649.6135038646, 39248.80375598104, 39324.623638172525, 30418.0, 31648.5252721214, 31773.9346942448, 34236.657633424344, 34530.0, 24726.88729007163, 25247.62128568036, 25316.620250696622, 25758.227253182435, 25806.870965645052], "value": 18930.56909177503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.0917384516393, 378.8636091007237, 390.3188935307887, 398.1517172732464, 411.83114922881623, 14344.71310573788, 20761.0, 21246.362609121712, 21400.464988375297, 21446.927653617317, 16024.839751602509, 17341.566460838487, 19442.319518816843, 20161.596768064668, 20221.393358199242, 5648.0, 5937.990541607937, 5943.791967281146, 5946.345901950804, 5957.136215248786, 5938.079597662369, 5970.940290597082, 6006.159137720722, 7514.211007844179, 7877.0547534295965, 7796.922030779676, 7912.723054693087, 7970.880436793453, 7973.0, 7979.680812767482, 7768.922310776877, 7913.723019694312, 7953.323967462773, 7986.7603971880935, 7991.360691144723, 7353.926460735431, 7607.277308655669, 7698.1916898725385, 7711.460197786158, 7749.49628274166, 24067.39831504209, 29302.85348573265, 29490.0, 30057.0, 30379.240518986982, 2572.871356432171, 2640.537905866485, 2646.7088620251757, 2781.6105745195687, 2992.5959995400776, 13639.659008524766, 13933.3526629941, 17418.912905435518, 17534.649307013915, 18429.262829486805, 2045.1308194017483, 2087.1859974609915, 2165.8808765517892, 2194.0, 2216.0, 120737.99999999913, 139040.30479847637, 155653.44346556615, 156245.0, 157905.0, 21028.474288142614, 21550.0, 21720.34838954834, 21940.0, 21972.230971916226, 35980.64019359773, 36034.73878414243, 36155.0, 36161.37273822684, 36408.0, 9532.285078619132, 9901.05939935705, 10071.798564028824, 10073.395596264247, 10562.894371056345, 7153.320434558708, 8319.875201871977, 8349.29031032357, 8490.490570565786, 8592.140785921358, 8029.839403211903, 9961.302708810459, 10057.446840423847, 10083.394996300245, 10099.646512372032, 3148.401803657298, 3256.9837150814096, 3772.302124107049, 3861.7489863158803, 3871.0, 869.699953516036, 915.0666320353203, 932.9020452852488, 941.7833898203452, 977.9022097790306, 20979.580408391746, 21572.56854862894, 21590.676139857915, 21603.459913502287, 21660.700357978258, 905.6965916418073, 907.3693782820876, 942.5381563034201, 988.9653862114935, 992.965246216379, 10185.0, 11240.943795280971, 11268.492917818718, 11289.49197286124, 11296.0, 539592.0, 580261.0, 593864.0, 611421.0, 618360.0, 126968.0, 130399.0, 130888.3455582735, 135119.0, 141222.587774123, 977.8044391121804, 1004.5178314408978, 1024.882138554061, 1025.1644909398817, 1028.6965345223327, 15228.847711523185, 18295.54261143482, 18573.814261857748, 19546.82719036862, 19570.706439403704, 56137.0, 57575.42424575701, 57691.711541442026, 58047.0, 59056.0, 85874.0, 86323.0, 87207.0, 87659.56170219109, 89019.55490222508, 8133.0, 8146.4297499176855, 8257.463264887763, 8266.669333226604, 8292.502449853027, 11064.391458469861, 12832.165909215872, 13168.802467962796, 13241.867581324064, 13532.458701651824, 9825.0, 10261.127804136433, 10551.314164579278, 11059.944700276446, 11517.152834326866, 10290.845637315597, 11612.187146899974, 11967.688730799135, 11997.340146291688, 12001.1599188056, 11009.229353945148, 11546.19176657626, 11572.0, 11627.069834413058, 11938.462769175581, 7217.159624295771, 7451.7391891285715, 7537.2085930976455, 7815.062192536932, 8522.70170544028, 9448.236575688687, 10091.949540252252, 11615.825762613737, 11946.104042196695, 11982.460789264329], "value": 11122.379109268279, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.6420798488402, 1547.7772559677855, 1711.2727090986327, 1913.0912816412215, 1913.6842421000536, 8695.304375649948, 9282.39664421813, 9292.256619470443, 9298.86051709225, 9318.114779095991, 8224.83550328993, 8429.072801991791, 8433.0, 8738.038815730264, 9030.548472576362, 2436.135172013932, 2478.467129567143, 2480.169143336975, 2480.7643273889043, 2485.8135639827087, 2411.5297516984197, 2450.571150048743, 2468.5803413419762, 2475.133703203873, 2476.368526025861, 2151.2040544998295, 2423.0, 2460.618604116356, 2466.7779899809016, 2472.9752702473015, 2409.132712223598, 2421.685180926486, 2425.4300239443714, 2427.672264244322, 2428.259380888828, 2399.3761621978238, 2426.793722533587, 2434.20888211332, 2438.0491608272787, 2438.2685194441597, 8952.955235223848, 9009.279257659371, 9078.319126065571, 9085.273178145733, 9091.81816363669, 4504.6396288296855, 5450.100733378988, 5450.373207081197, 5453.345598528163, 5468.589855760794, 3383.8477268522975, 3459.238967427162, 3598.3702852000797, 3599.280143971216, 3601.2797440512004, 882.9337799665051, 1028.5320179318392, 1038.3043360948184, 1048.6801525534709, 1048.916086713061, 9942.254330925138, 11948.880511194864, 11970.0, 11973.82039269403, 12032.939835300855, 4495.460544734653, 4812.951870481321, 4838.419389673261, 4842.564169224786, 4849.321095046696, 10127.392356458637, 10186.847197292047, 10203.132733717717, 10215.642452514126, 10216.948915255525, 5416.295881535375, 5425.565954723613, 5427.48438898304, 5445.918311225335, 5447.809326673548, 4869.780859861315, 4904.754762261872, 4949.975250123726, 4983.90032199354, 4998.9500104999215, 3932.7640341579595, 3994.9201015979515, 4029.3351596986167, 4087.9386809197886, 4095.89760255996, 1296.4101333893057, 1313.6059182245288, 1318.0905175428923, 1329.528017553774, 1336.4921329894578, 835.6949713354703, 836.6281591687513, 888.5201990924958, 899.8740176375181, 932.7854593443546, 5713.371529131792, 5776.42235776419, 5896.528277737771, 6012.338642749294, 6042.882066817653, 896.9955150224207, 937.8745505393555, 942.9575669094908, 944.7779771753633, 993.6671215142864, 3896.59085795993, 4006.59934006597, 4007.919841603152, 4100.528439229467, 4120.340745480708, 8148.837023259502, 9478.0, 11171.38557379352, 11179.552817887194, 11186.552537898393, 10570.471476426148, 11060.944695276472, 11176.664700059011, 11178.441077946232, 11181.217314787888, 6770.916653335443, 8323.500589964622, 8437.325013998989, 8455.873161902577, 8467.745967620982, 4819.7108173509705, 5777.8555536111935, 5805.245318108618, 5833.883322333614, 5835.79574714883, 9863.802723945337, 10197.74505637365, 10231.59073637076, 10383.376997380181, 10411.635592754217, 9478.682381863344, 9945.0, 10327.0, 10484.213683973885, 10518.526666299882, 6826.692798823966, 6832.863342733217, 7580.393568514616, 7587.734429295169, 7722.613869306625, 8333.83332333362, 8342.666293348198, 8379.664813407639, 8408.873866892123, 8465.322774178174, 6647.60114393138, 7550.924490755022, 7664.31021208094, 7666.923330766621, 7696.345810605937, 7095.476185733426, 7114.893276600958, 7255.56466612005, 7375.54576446904, 7731.845363092819, 6697.129373181455, 7088.539244949062, 7211.567305961659, 7215.891761623475, 7218.639068046682, 4819.204831202953, 4867.488913664014, 4917.213245880642, 4964.379452568429, 5097.8215762448135, 4794.352762377034, 4946.727929963743, 5030.346055012825, 5110.134800797757, 5116.334876466036], "value": 4634.202751753721, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.6326198429222, 303.8086005816337, 312.7966821565982, 317.21172885379826, 320.25860133790286, 4641.883952901179, 5334.813281535147, 5449.174526533606, 5476.0, 5502.477264659856, 4281.7002809803325, 4428.933565996513, 5109.540141387274, 5246.422893481714, 5330.253764472977, 3874.922501549974, 4130.731502452331, 4143.917121657565, 4183.5398106208295, 4208.516020657617, 4143.461350024508, 4146.460960075186, 4179.414881916519, 4183.247015537202, 4191.811368488426, 3864.1692036212207, 4117.938230926538, 4143.937840932388, 4184.602462766047, 4192.308269135604, 4149.107941792499, 4151.920500669832, 4163.854265100707, 4165.8541951031875, 4171.582841715835, 3322.684344987222, 3393.6776006279365, 3624.3113808376324, 3649.7627654202392, 3690.704743620504, 4369.60673539383, 5161.974190129063, 5303.575713942875, 5405.648632838853, 5450.084204950373, 3992.740471869319, 4793.496682848286, 4801.615870730368, 4827.879303017417, 4895.853124406273, 4721.409823772028, 4996.4254110777, 5727.281815455389, 5742.2247996520355, 5763.971180144073, 3382.813945233011, 3909.4331321958157, 4041.4948131483566, 4057.7971101445105, 4058.431819545266, 5399.2980912481125, 5868.532866783305, 5947.22686050815, 5951.155141906023, 6148.631082135042, 4062.4921884764403, 4070.8371665133654, 4089.427480152781, 4122.505299364096, 4149.668026557868, 3588.946165807463, 3906.257811015898, 4158.2307273154565, 4169.498980367065, 4176.853810116631, 3576.266865292661, 4209.5579964103945, 4265.87202383929, 4703.365045718852, 4820.108279968147, 4473.150101480708, 4528.841490547881, 4688.718676879398, 5675.0, 5741.282339707536, 1264.525802823941, 1333.0668532027425, 1388.7430825297351, 1423.2456797896923, 1440.683049729058, 923.8383282925461, 957.7126861941529, 987.8518222266574, 993.0615568287899, 996.9551370188359, 4493.528179541101, 5357.866053348697, 5398.325209348832, 5434.456554344534, 5446.809361672323, 4309.913801723948, 5832.8541786454825, 5837.737301821428, 5861.20873682056, 5969.731362088716, 5423.376311724202, 5435.728213589305, 5477.315335583052, 5496.729445979636, 5511.181310167635, 2982.940341193164, 3065.310305181361, 3130.4208721386162, 3133.9529907051415, 3151.9212019699235, 6026.5178785697035, 6061.36355682647, 6063.848403789941, 6253.96873015632, 6317.0, 4870.634702397334, 5670.461306175906, 5912.9113063304085, 5962.731677074542, 6015.6691381974415, 5422.864428389243, 5938.168656388196, 6086.60437071589, 6161.599496032743, 6183.5671502994355, 5352.678839269501, 5750.338711048283, 5864.354920958605, 5864.560157988082, 5878.853028674317, 4445.688801783974, 5134.612405231585, 5880.500157486662, 5974.0, 6000.249968753906, 5830.970845145747, 6115.969420152871, 6150.538709596887, 6182.258129024546, 6263.4362907338555, 3909.784961827013, 3928.7053470989217, 3947.2500224957166, 3984.2230765000545, 3997.1006523531973, 5882.176495290577, 5944.454441845065, 5949.66132620157, 5967.850803729942, 5988.790392336247, 4742.66801323904, 5473.343198816167, 5738.655680659173, 5743.971280143573, 5772.163036359789, 5704.686242256716, 5739.9139012915675, 5748.0, 5749.91375129365, 5796.768129274782, 5144.331236939174, 5338.3060202173465, 5554.2779438672715, 5607.5513958882375, 5704.600677952503, 5194.792208311776, 5680.40355762639, 5733.2260144881575, 5749.562609347663, 5753.367129615823, 4726.858194254178, 5200.323957885451, 5257.921131183112, 5647.378788333198, 5711.5145212655725], "value": 4198.080911836683, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.9040698691703, 738.0810890441398, 773.6209257463844, 792.90485141783, 857.8884744983153, 15810.683786324282, 16545.586360340996, 16704.164791760424, 16720.247588858485, 17723.379681711143, 16955.237014334354, 17056.317747290126, 17064.914675426637, 17068.231929563168, 17090.48728538146, 869.8303830753006, 893.8569828827357, 894.6555576103215, 896.1397058823537, 896.1441823058963, 714.0681410758957, 735.3418690272204, 867.7657032601194, 886.6763631274603, 902.1204325782343, 908.5230254116609, 911.8085202107566, 912.0742446416859, 912.6531917871199, 923.1414784250678, 777.4635501503973, 904.7783293093169, 904.9502277374742, 905.1536813079725, 905.8550631898897, 555.8804856955734, 570.9086546152637, 669.1969636436296, 689.689639662154, 695.7182341151791, 15847.286872090783, 15886.36454541817, 15891.284892179765, 15896.125713085892, 15899.0, 13636.0, 14018.92990535051, 14100.660437258546, 14110.153390796586, 14234.0, 13448.327583620878, 13568.660783480393, 13639.795403068962, 13793.034487585874, 13933.164010159322, 4152.563980782034, 4671.743054132022, 4759.4764575896625, 4790.784414701347, 4850.951490485085, 110714.44642776734, 112219.43890280496, 112290.43854780756, 112814.23294804015, 114665.28002079975, 11063.502142403611, 11096.223264371416, 11205.327680339044, 11217.607383741693, 11241.60654377093, 17793.822061779218, 21412.143514259566, 21414.822184779987, 21439.46401339979, 21517.03173357203, 7615.695372185161, 7630.8092297693, 7663.693452261847, 7703.2967032967035, 7741.032370953631, 4510.143072816154, 4526.705764125321, 4591.79336929839, 4711.010687755541, 4715.080559290974, 3174.873005079817, 3249.0, 3250.821204833757, 3269.85285662141, 3293.374258890803, 534.4228233507803, 643.2056410333234, 645.4223469994329, 648.0506058624138, 649.3701109923461, 613.355976224962, 614.6865098799644, 620.4756980351596, 627.7520379450092, 651.7523341130435, 7896.815477678394, 8511.914880851236, 8898.806269816847, 8905.243054340324, 9028.63885444588, 586.7095787585173, 620.3703241210176, 623.1494010675486, 630.3822254190827, 634.2832599163008, 4122.443470131554, 4363.738175709467, 4374.387585737999, 4450.732956022584, 4482.618977386894, 162180.56729149073, 162980.0, 163330.0, 164017.0, 165977.1701141511, 57015.0, 80239.59880200561, 105687.0, 112116.0, 149465.0, 71512.64243678749, 86287.56856215678, 98112.50943745379, 110237.0, 111863.57637083602, 9156.866157786068, 9820.165285950774, 10176.084152426318, 10276.0, 10395.532201051123, 48311.5168848307, 57697.84604307806, 58236.83526329535, 60802.0, 62472.37527624847, 51824.0, 83822.16177838387, 88924.0, 91970.54014729883, 92386.53806730923, 13013.705467213582, 13749.450021999008, 13823.308834558433, 13897.722045559234, 14256.863490032176, 15271.165134073228, 15389.076655400711, 15633.921830390775, 15642.765358519404, 16177.919110404373, 14077.859221407654, 14104.929475352557, 14395.352209150404, 14420.423183072979, 14695.265236738334, 14018.29908504591, 14055.359058935885, 14359.138451692932, 14417.567472975827, 14994.550163495112, 12654.240745555297, 13375.331233438095, 14001.789973150615, 14038.508652197124, 14269.571912842632, 11404.691558763183, 11570.826437603275, 11595.362255076052, 11650.30098194111, 11992.220505667105, 11432.485538150637, 11555.4800033997, 11706.297622142698, 11792.76414471723, 11802.0], "value": 7882.3034877800255, "unit": "score"}], "name": "dromaeo_css", "value": 7574.669608136981, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 163.0, 166.0, 113.0, 112.0, 113.0, 112.0, 113.0, 111.0, 111.0], "value": 122.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 107.0, 110.0, 145.0, 115.0, 109.0, 111.0, 132.0, 164.0, 130.0], "value": 127.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 183.0, 183.0, 184.0, 182.0, 198.0, 183.0, 182.0, 182.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 59.0, 92.0, 74.0, 59.0, 59.0, 58.0, 81.0, 75.0], "value": 69.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 91.0, 91.0, 67.0, 69.0, 92.0, 67.0, 69.0, 91.0], "value": 79.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 88.0, 83.0, 86.0, 83.0, 86.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 92.0, 93.0, 106.0, 149.0, 123.0, 92.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 84.0, 83.0, 84.0, 84.0, 84.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 52.0, 53.0, 56.0, 56.0, 54.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 67.0, 78.0, 71.0, 71.0, 69.0, 69.0, 68.0, 70.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 85.0, 82.0, 86.0, 82.0, 87.0, 85.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 133.0, 136.0, 134.0, 136.0, 136.0, 138.0, 200.0, 152.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 167.0, 165.0, 163.0, 166.0, 166.0, 165.0, 170.0, 167.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 62.0, 56.0, 69.0, 82.0, 83.0, 82.0, 82.0, 66.0, 66.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1446.7, "alertThreshold": 2.0}]} 11:07:30 INFO - Return code: 0 11:07:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:07:30 INFO - # TBPL SUCCESS # 11:07:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:07:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:07:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:07:30 INFO - 2016-09-26 11:07:30.685 screenresolution[2578:12837] starting screenresolution argv=screenresolution get 11:07:30 INFO - 2016-09-26 11:07:30.689 screenresolution[2578:12837] Display 0: 1600x1200x32@60 11:07:30 INFO - 2016-09-26 11:07:30.695 screenresolution[2579:12840] starting screenresolution argv=screenresolution list 11:07:30 INFO - Available Modes on Display 0 11:07:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:07:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:07:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:07:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:07:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:07:30 INFO - Intel Iris: 11:07:30 INFO - Chipset Model: Intel Iris 11:07:30 INFO - Type: GPU 11:07:30 INFO - Bus: Built-In 11:07:30 INFO - VRAM (Dynamic, Max): 1536 MB 11:07:30 INFO - Vendor: Intel (0x8086) 11:07:30 INFO - Device ID: 0x0a2e 11:07:30 INFO - Revision ID: 0x0009 11:07:30 INFO - Displays: 11:07:30 INFO - Display: 11:07:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:07:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:07:30 INFO - Display Serial Number: 1600x1200 60 11:07:30 INFO - Main Display: Yes 11:07:30 INFO - Mirror: Off 11:07:30 INFO - Online: Yes 11:07:30 INFO - Rotation: Supported 11:07:30 INFO - Return code: 0 11:07:30 INFO - Running post-action listener: _resource_record_post_action 11:07:30 INFO - [mozharness: 2016-09-26 18:07:30.940771Z] Finished run-tests step (success) 11:07:30 INFO - Running post-run listener: _resource_record_post_run 11:07:31 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32267264; Write bytes: 543725568; Read time: 197; Write time: 1655 11:07:31 INFO - TinderboxPrint: CPU usage
53.6% 11:07:31 INFO - TinderboxPrint: I/O read bytes / time
32,267,264 / 197 11:07:31 INFO - TinderboxPrint: I/O write bytes / time
543,725,568 / 1,655 11:07:31 INFO - TinderboxPrint: CPU idle
2,230.3 (46.4%) 11:07:31 INFO - TinderboxPrint: CPU system
966.8 (20.1%) 11:07:31 INFO - TinderboxPrint: CPU user
1,612.5 (33.5%) 11:07:31 INFO - TinderboxPrint: Swap in / out
269,373,440 / 0 11:07:31 INFO - install - Wall time: 25s; CPU: 55.0%; Read bytes: 224952832; Write bytes: 219809280; Read time: 19239; Write time: 448 11:07:31 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31345664; Write bytes: 299672064; Read time: 186; Write time: 1150 11:07:31 INFO - Running post-run listener: _upload_blobber_files 11:07:31 INFO - Blob upload gear active. 11:07:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:07:31 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 11:07:31 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', 'Date', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:07:31 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 Date -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:07:31 INFO - (blobuploader) - INFO - Open directory for files ... 11:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:07:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:32 INFO - (blobuploader) - INFO - Done attempting. 11:07:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:07:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:07:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:34 INFO - (blobuploader) - INFO - Done attempting. 11:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:07:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:07:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:07:36 INFO - (blobuploader) - INFO - Done attempting. 11:07:36 INFO - (blobuploader) - INFO - Iteration through files over. 11:07:36 INFO - Return code: 0 11:07:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:07:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:07:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/12ebb68b80213e7fbe8e7763be5c9e435700e2456556278058aa444277ef7ec2613d2bb60f5e4fa5a46d39b538da4a4752e4259850c2068f0fb1febd8c12d6f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/2f041c2dd793668dfeb2973732505c66b80f77333191c7b3fba339d4c197f0f9c10f1be53429d454a578aa34a139b506e4a889eb1211731b66d3da26be23b22b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/f6bb72ce2a09e4263ca5b950fec48894e15b1cf21ab7fb32d5d9acc6e91f5e540091c792b332150e44b499d2170f7c79f916b42588d27293fd17b4daa81ff959"} 11:07:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:07:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:07:36 INFO - Contents: 11:07:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/12ebb68b80213e7fbe8e7763be5c9e435700e2456556278058aa444277ef7ec2613d2bb60f5e4fa5a46d39b538da4a4752e4259850c2068f0fb1febd8c12d6f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/2f041c2dd793668dfeb2973732505c66b80f77333191c7b3fba339d4c197f0f9c10f1be53429d454a578aa34a139b506e4a889eb1211731b66d3da26be23b22b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/f6bb72ce2a09e4263ca5b950fec48894e15b1cf21ab7fb32d5d9acc6e91f5e540091c792b332150e44b499d2170f7c79f916b42588d27293fd17b4daa81ff959"} 11:07:36 INFO - Running post-run listener: copy_logs_to_upload_dir 11:07:36 INFO - Copying logs to upload dir... 11:07:36 INFO - mkdir: /builds/slave/test/build/upload/logs 11:07:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.169379 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-09-26 11:07:36.786534) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 11:07:36.794443) ========= 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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/12ebb68b80213e7fbe8e7763be5c9e435700e2456556278058aa444277ef7ec2613d2bb60f5e4fa5a46d39b538da4a4752e4259850c2068f0fb1febd8c12d6f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/2f041c2dd793668dfeb2973732505c66b80f77333191c7b3fba339d4c197f0f9c10f1be53429d454a578aa34a139b506e4a889eb1211731b66d3da26be23b22b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/f6bb72ce2a09e4263ca5b950fec48894e15b1cf21ab7fb32d5d9acc6e91f5e540091c792b332150e44b499d2170f7c79f916b42588d27293fd17b4daa81ff959"} build_url:https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010981 build_url: 'https://queue.taskcluster.net/v1/task/d12NBfBcSxalGMgu7vh1hw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/12ebb68b80213e7fbe8e7763be5c9e435700e2456556278058aa444277ef7ec2613d2bb60f5e4fa5a46d39b538da4a4752e4259850c2068f0fb1febd8c12d6f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/2f041c2dd793668dfeb2973732505c66b80f77333191c7b3fba339d4c197f0f9c10f1be53429d454a578aa34a139b506e4a889eb1211731b66d3da26be23b22b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Date/sha512/f6bb72ce2a09e4263ca5b950fec48894e15b1cf21ab7fb32d5d9acc6e91f5e540091c792b332150e44b499d2170f7c79f916b42588d27293fd17b4daa81ff959"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 11:07:36.830181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 11:07:36.830936) ========= 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.oX4KPzfxC9/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.TWUCiGQfdM/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.005154 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 11:07:36.885382) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 11:07:36.885713) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 11:07:36.886043) ========= ========= Total master_lag: 0.19 =========