builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0289 starttime: 1493919033.38 results: success (0) buildid: 20170504084920 builduid: 8bdc4c055b114e9fa3fcb2455753206a revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.376667) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.377233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.377518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.405056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.405466) ========= 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.QdZkBL7n59/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.xIT1Zx2mPn/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 --2017-05-04 10:30:33-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2017-05-04 10:30:33 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109303 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.539878) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.540323) ========= 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.QdZkBL7n59/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.xIT1Zx2mPn/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.037248 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.600466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.600828) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b255199db9d6a6f189b89b7906f99155bde3726 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0b255199db9d6a6f189b89b7906f99155bde3726 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QdZkBL7n59/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.xIT1Zx2mPn/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 2017-05-04 10:30:33,699 truncating revision to first 12 chars 2017-05-04 10:30:33,699 Setting DEBUG logging. 2017-05-04 10:30:33,700 attempt 1/10 2017-05-04 10:30:33,700 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b255199db9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 10:30:34,018 unpacking tar archive at: mozilla-central-0b255199db9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.596744 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:34.224961) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:34.225372) ========= script_repo_revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:34.225817) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:34.226156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:34.247137) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-05-04 10:30:34.247625) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QdZkBL7n59/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.xIT1Zx2mPn/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:30:34 INFO - MultiFileLogger online at 20170504 10:30:34 in /builds/slave/test 10:30:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:30:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:30:34 INFO - {'append_to_log': False, 10:30:34 INFO - 'base_work_dir': '/builds/slave/test', 10:30:34 INFO - 'blob_upload_branch': 'Firefox', 10:30:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:30:34 INFO - 'branch': 'Firefox', 10:30:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:30:34 INFO - 'config_files': ('talos/mac_config.py',), 10:30:34 INFO - 'default_actions': ('clobber', 10:30:34 INFO - 'read-buildbot-config', 10:30:34 INFO - 'download-and-extract', 10:30:34 INFO - 'populate-webroot', 10:30:34 INFO - 'create-virtualenv', 10:30:34 INFO - 'install', 10:30:34 INFO - 'run-tests'), 10:30:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:30:34 INFO - 'download_minidump_stackwalk': True, 10:30:34 INFO - 'download_symbols': 'ondemand', 10:30:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:30:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:30:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:30:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:30:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:30:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:30:34 INFO - 'gecko_profile': False, 10:30:34 INFO - 'gecko_profile_interval': 0, 10:30:34 INFO - 'installer_path': 'installer.exe', 10:30:34 INFO - 'log_level': 'info', 10:30:34 INFO - 'log_name': 'talos', 10:30:34 INFO - 'log_to_console': True, 10:30:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:30:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:30:34 INFO - 'opt_config_files': (), 10:30:34 INFO - 'pip_index': False, 10:30:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:30:34 INFO - 'cmd': ('bash', 10:30:34 INFO - '-c', 10:30:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:30:34 INFO - 'enabled': True, 10:30:34 INFO - 'halt_on_failure': False, 10:30:34 INFO - 'name': 'check_screen_resolution'},), 10:30:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:30:34 INFO - 'cmd': ('bash', 10:30:34 INFO - '-c', 10:30:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:30:34 INFO - 'enabled': True, 10:30:34 INFO - 'halt_on_failure': False, 10:30:34 INFO - 'name': 'check_screen_resolution'},), 10:30:34 INFO - 'run_cmd_checks_enabled': True, 10:30:34 INFO - 'suite': 'dromaeojs', 10:30:34 INFO - 'system_bits': '32', 10:30:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:30:34 INFO - 'title': 't-yosemite-r7-0289', 10:30:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:30:34 INFO - 'use_talos_json': True, 10:30:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:30:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:30:34 INFO - 'work_dir': 'build'} 10:30:34 INFO - [mozharness: 2017-05-04 17:30:34.453798Z] Running clobber step. 10:30:34 INFO - Running pre-action listener: _resource_record_pre_action 10:30:34 INFO - Running main action method: clobber 10:30:34 INFO - rmtree: /builds/slave/test/build 10:30:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:30:36 INFO - Running post-action listener: _resource_record_post_action 10:30:36 INFO - [mozharness: 2017-05-04 17:30:36.928721Z] Finished clobber step (success) 10:30:36 INFO - [mozharness: 2017-05-04 17:30:36.928968Z] Running read-buildbot-config step. 10:30:36 INFO - Running pre-action listener: _resource_record_pre_action 10:30:36 INFO - Running main action method: read_buildbot_config 10:30:36 INFO - Using buildbot properties: 10:30:36 INFO - { 10:30:36 INFO - "project": "", 10:30:36 INFO - "product": "firefox", 10:30:36 INFO - "script_repo_revision": "production", 10:30:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:30:36 INFO - "repository": "", 10:30:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:30:36 INFO - "buildid": "20170504084920", 10:30:36 INFO - "pgo_build": "False", 10:30:36 INFO - "basedir": "/builds/slave/test", 10:30:36 INFO - "buildnumber": 114, 10:30:36 INFO - "slavename": "t-yosemite-r7-0289", 10:30:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:30:36 INFO - "platform": "yosemite_r7", 10:30:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:30:36 INFO - "branch": "mozilla-central", 10:30:36 INFO - "repo_path": "mozilla-central", 10:30:36 INFO - "revision": "0b255199db9d6a6f189b89b7906f99155bde3726", 10:30:36 INFO - "stage_platform": "macosx64", 10:30:36 INFO - "builduid": "8bdc4c055b114e9fa3fcb2455753206a", 10:30:36 INFO - "slavebuilddir": "test" 10:30:36 INFO - } 10:30:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:30:36 INFO - Running post-action listener: _resource_record_post_action 10:30:36 INFO - [mozharness: 2017-05-04 17:30:36.934516Z] Finished read-buildbot-config step (success) 10:30:36 INFO - [mozharness: 2017-05-04 17:30:36.934739Z] Running download-and-extract step. 10:30:36 INFO - Running pre-action listener: _resource_record_pre_action 10:30:36 INFO - Running main action method: download_and_extract 10:30:36 INFO - mkdir: /builds/slave/test/build/tests 10:30:36 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:30:36 INFO - trying https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:30:36 INFO - Downloading https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:30:38 INFO - Downloaded 1325 bytes. 10:30:38 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:30:38 INFO - Using the following test package requirements: 10:30:38 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:30:38 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:30:38 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:30:38 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:30:38 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'jsshell-mac.zip'], 10:30:38 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:30:38 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:30:38 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:30:38 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:30:38 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:30:38 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:30:38 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:30:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:30:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:30:38 INFO - Fetch https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:30:39 INFO - Content-Length response header: 52700729 10:30:39 INFO - Bytes received: 52700729 10:30:56 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:30:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:30:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:30:56 INFO - Fetch https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:30:58 INFO - Content-Length response header: 52700729 10:30:58 INFO - Bytes received: 52700729 10:31:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:31:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:31:13 INFO - Fetch https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:31:14 INFO - Content-Length response header: 14408809 10:31:14 INFO - Bytes received: 14408809 10:31:14 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:31:14 INFO - trying https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:31:14 INFO - Downloading https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:31:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:31:17 INFO - Downloaded 70877244 bytes. 10:31:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:31:17 INFO - mkdir: /builds/slave/test/properties 10:31:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:31:17 INFO - Writing to file /builds/slave/test/properties/build_url 10:31:17 INFO - Contents: 10:31:17 INFO - build_url:https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:31:18 INFO - Running post-action listener: _resource_record_post_action 10:31:18 INFO - Running post-action listener: set_extra_try_arguments 10:31:18 INFO - [mozharness: 2017-05-04 17:31:18.616897Z] Finished download-and-extract step (success) 10:31:18 INFO - [mozharness: 2017-05-04 17:31:18.617008Z] Running populate-webroot step. 10:31:18 INFO - Running pre-action listener: _resource_record_pre_action 10:31:18 INFO - Running main action method: populate_webroot 10:31:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:31:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:31:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:31:18 INFO - '--tppagecycles', 10:31:18 INFO - '7'], 10:31:18 INFO - 'tests': ['tsvgm']}}, 10:31:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:31:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:31:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:31:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:31:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:31:18 INFO - 'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:31:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:31:18 INFO - 'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['damp', 'tps']}, 10:31:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:31:18 INFO - 'tests': ['damp', 'tps']}, 10:31:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['dromaeo_dom']}, 10:31:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:31:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:31:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:31:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['a11yr', 10:31:18 INFO - 'ts_paint', 10:31:18 INFO - 'tpaint', 10:31:18 INFO - 'sessionrestore', 10:31:18 INFO - 'sessionrestore_no_auto_restore', 10:31:18 INFO - 'tabpaint']}, 10:31:18 INFO - 'other-e10s': {'tests': ['a11yr', 10:31:18 INFO - 'ts_paint', 10:31:18 INFO - 'tpaint', 10:31:18 INFO - 'sessionrestore', 10:31:18 INFO - 'sessionrestore_no_auto_restore', 10:31:18 INFO - 'tabpaint']}, 10:31:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:31:18 INFO - 'ts_paint', 10:31:18 INFO - 'tpaint', 10:31:18 INFO - 'sessionrestore', 10:31:18 INFO - 'sessionrestore_no_auto_restore', 10:31:18 INFO - 'tabpaint']}, 10:31:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:31:18 INFO - 'ts_paint', 10:31:18 INFO - 'tpaint', 10:31:18 INFO - 'sessionrestore', 10:31:18 INFO - 'sessionrestore_no_auto_restore', 10:31:18 INFO - 'tabpaint']}, 10:31:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['a11yr', 10:31:18 INFO - 'ts_paint', 10:31:18 INFO - 'tpaint', 10:31:18 INFO - 'sessionrestore', 10:31:18 INFO - 'sessionrestore_no_auto_restore', 10:31:18 INFO - 'tabpaint']}, 10:31:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['a11yr', 10:31:18 INFO - 'ts_paint', 10:31:18 INFO - 'tpaint', 10:31:18 INFO - 'sessionrestore', 10:31:18 INFO - 'sessionrestore_no_auto_restore', 10:31:18 INFO - 'tabpaint']}, 10:31:18 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:31:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:31:18 INFO - 'bloom_basic_ref']}, 10:31:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['tsvgx', 10:31:18 INFO - 'tsvgr_opacity', 10:31:18 INFO - 'tart', 10:31:18 INFO - 'tscrollx', 10:31:18 INFO - 'cart', 10:31:18 INFO - 'tsvg_static']}, 10:31:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:31:18 INFO - 'tsvgr_opacity', 10:31:18 INFO - 'tart', 10:31:18 INFO - 'tscrollx', 10:31:18 INFO - 'cart', 10:31:18 INFO - 'tsvg_static']}, 10:31:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:31:18 INFO - 'talos_options': ['--disable-e10s'], 10:31:18 INFO - 'tests': ['tp5o']}, 10:31:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:31:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:31:18 INFO - 'talos_options': ['--disable-e10s', 10:31:18 INFO - '--xperf_path', 10:31:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:18 INFO - 'tests': ['tp5n']}, 10:31:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:31:18 INFO - 'talos_options': ['--xperf_path', 10:31:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:18 INFO - 'tests': ['tp5n']}}, 10:31:18 INFO - 'talos.zip': {'path': '', 10:31:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:31:18 INFO - Running post-action listener: _resource_record_post_action 10:31:18 INFO - [mozharness: 2017-05-04 17:31:18.636262Z] Finished populate-webroot step (success) 10:31:18 INFO - [mozharness: 2017-05-04 17:31:18.636367Z] Running create-virtualenv step. 10:31:18 INFO - Running pre-action listener: _resource_record_pre_action 10:31:18 INFO - Running main action method: create_virtualenv 10:31:18 INFO - Creating virtualenv /builds/slave/test/build/venv 10:31:18 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:31:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:31:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:31:18 INFO - Using real prefix '/tools/python27' 10:31:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:31:19 INFO - Installing distribute.............................................................................................................................................................................................done. 10:31:22 INFO - Installing pip.................done. 10:31:22 INFO - Return code: 0 10:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:31:22 INFO - Reading from file tmpfile_stdout 10:31:22 INFO - Output received: 10:31:22 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:31:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:31: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:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:22 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 0x1074c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe014dfd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, '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.QdZkBL7n59/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.xIT1Zx2mPn/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:31:22 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:31:22 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:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:22 INFO - 'HOME': '/Users/cltbld', 10:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:22 INFO - 'LOGNAME': 'cltbld', 10:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:22 INFO - 'MOZ_NO_REMOTE': '1', 10:31:22 INFO - 'NO_EM_RESTART': '1', 10:31:22 INFO - 'PAGER': '/bin/cat', 10:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:22 INFO - 'PWD': '/builds/slave/test', 10:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:22 INFO - 'SHELL': '/bin/bash', 10:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:31:22 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:22 INFO - 'USER': 'cltbld', 10:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:22 INFO - 'XPC_FLAGS': '0x0', 10:31:22 INFO - 'XPC_SERVICE_NAME': '0', 10:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:22 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:31:22 INFO - Cleaning up... 10:31:22 INFO - Return code: 0 10:31:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:31: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:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:22 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 0x1074c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe014dfd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, '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.QdZkBL7n59/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.xIT1Zx2mPn/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:31:22 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:31:22 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:31:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:31:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:22 INFO - 'HOME': '/Users/cltbld', 10:31:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:22 INFO - 'LOGNAME': 'cltbld', 10:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:22 INFO - 'MOZ_NO_REMOTE': '1', 10:31:22 INFO - 'NO_EM_RESTART': '1', 10:31:22 INFO - 'PAGER': '/bin/cat', 10:31:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:22 INFO - 'PWD': '/builds/slave/test', 10:31:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:22 INFO - 'SHELL': '/bin/bash', 10:31:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:31:22 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:31:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:22 INFO - 'USER': 'cltbld', 10:31:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:22 INFO - 'XPC_FLAGS': '0x0', 10:31:22 INFO - 'XPC_SERVICE_NAME': '0', 10:31:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:23 INFO - Downloading/unpacking psutil>=3.1.1 10:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:31:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:25 INFO - Installing collected packages: psutil 10:31:25 INFO - Running setup.py install for psutil 10:31:25 INFO - building 'psutil._psutil_osx' extension 10:31:25 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:31:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:31:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:31:26 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:31:26 INFO - building 'psutil._psutil_posix' extension 10:31:26 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:31:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:31:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:31:26 INFO - ^ 10:31:26 INFO - 1 warning generated. 10:31:26 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:31:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:26 INFO - Successfully installed psutil 10:31:26 INFO - Cleaning up... 10:31:26 INFO - Return code: 0 10:31:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe014dfd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, '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.QdZkBL7n59/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.xIT1Zx2mPn/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:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:26 INFO - 'HOME': '/Users/cltbld', 10:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:26 INFO - 'LOGNAME': 'cltbld', 10:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:26 INFO - 'MOZ_NO_REMOTE': '1', 10:31:26 INFO - 'NO_EM_RESTART': '1', 10:31:26 INFO - 'PAGER': '/bin/cat', 10:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:26 INFO - 'PWD': '/builds/slave/test', 10:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:26 INFO - 'SHELL': '/bin/bash', 10:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:31:26 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:26 INFO - 'USER': 'cltbld', 10:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:26 INFO - 'XPC_FLAGS': '0x0', 10:31:26 INFO - 'XPC_SERVICE_NAME': '0', 10:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:31:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:31:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:31:28 INFO - Installing collected packages: mozsystemmonitor 10:31:28 INFO - Running setup.py install for mozsystemmonitor 10:31:28 INFO - Successfully installed mozsystemmonitor 10:31:28 INFO - Cleaning up... 10:31:28 INFO - Return code: 0 10:31:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe014dfd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, '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.QdZkBL7n59/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.xIT1Zx2mPn/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:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:31:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:31:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:29 INFO - 'HOME': '/Users/cltbld', 10:31:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:29 INFO - 'LOGNAME': 'cltbld', 10:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:29 INFO - 'MOZ_NO_REMOTE': '1', 10:31:29 INFO - 'NO_EM_RESTART': '1', 10:31:29 INFO - 'PAGER': '/bin/cat', 10:31:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:29 INFO - 'PWD': '/builds/slave/test', 10:31:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:29 INFO - 'SHELL': '/bin/bash', 10:31:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:31:29 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:31:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:29 INFO - 'USER': 'cltbld', 10:31:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:29 INFO - 'XPC_FLAGS': '0x0', 10:31:29 INFO - 'XPC_SERVICE_NAME': '0', 10:31:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:29 INFO - Downloading/unpacking jsonschema==2.5.1 10:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:31:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:31 INFO - Downloading functools32-3.2.3-2.tar.gz 10:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:31:31 INFO - warning: no files found matching '*.txt' 10:31:31 INFO - no previously-included directories found matching 'build' 10:31:31 INFO - no previously-included directories found matching 'dist' 10:31:31 INFO - no previously-included directories found matching '.git*' 10:31:31 INFO - Installing collected packages: jsonschema, functools32 10:31:31 INFO - Running setup.py install for functools32 10:31:31 INFO - warning: no files found matching '*.txt' 10:31:31 INFO - no previously-included directories found matching 'build' 10:31:31 INFO - no previously-included directories found matching 'dist' 10:31:31 INFO - no previously-included directories found matching '.git*' 10:31:31 INFO - Successfully installed jsonschema functools32 10:31:31 INFO - Cleaning up... 10:31:31 INFO - Return code: 0 10:31:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe014dfd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, '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.QdZkBL7n59/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.xIT1Zx2mPn/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:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:32 INFO - 'HOME': '/Users/cltbld', 10:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:32 INFO - 'LOGNAME': 'cltbld', 10:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:32 INFO - 'MOZ_NO_REMOTE': '1', 10:31:32 INFO - 'NO_EM_RESTART': '1', 10:31:32 INFO - 'PAGER': '/bin/cat', 10:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:32 INFO - 'PWD': '/builds/slave/test', 10:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:32 INFO - 'SHELL': '/bin/bash', 10:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:31:32 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:32 INFO - 'USER': 'cltbld', 10:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:32 INFO - 'XPC_FLAGS': '0x0', 10:31:32 INFO - 'XPC_SERVICE_NAME': '0', 10:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:31:32 INFO - Cleaning up... 10:31:32 INFO - Return code: 0 10:31:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe014dfd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, '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.QdZkBL7n59/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.xIT1Zx2mPn/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:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:31:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:31:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:32 INFO - 'HOME': '/Users/cltbld', 10:31:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:32 INFO - 'LOGNAME': 'cltbld', 10:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:32 INFO - 'MOZ_NO_REMOTE': '1', 10:31:32 INFO - 'NO_EM_RESTART': '1', 10:31:32 INFO - 'PAGER': '/bin/cat', 10:31:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:32 INFO - 'PWD': '/builds/slave/test', 10:31:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:32 INFO - 'SHELL': '/bin/bash', 10:31:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:31:32 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:31:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:32 INFO - 'USER': 'cltbld', 10:31:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:32 INFO - 'XPC_FLAGS': '0x0', 10:31:32 INFO - 'XPC_SERVICE_NAME': '0', 10:31:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:32 INFO - Downloading/unpacking blobuploader==1.2.4 10:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:33 INFO - Downloading blobuploader-1.2.4.tar.gz 10:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:31:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:31:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:34 INFO - Downloading docopt-0.6.1.tar.gz 10:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:31:34 INFO - Installing collected packages: blobuploader, requests, docopt 10:31:34 INFO - Running setup.py install for blobuploader 10:31:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:31:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:31:35 INFO - Running setup.py install for requests 10:31:35 INFO - Running setup.py install for docopt 10:31:35 INFO - Successfully installed blobuploader requests docopt 10:31:35 INFO - Cleaning up... 10:31:35 INFO - Return code: 0 10:31:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:35 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 0x1074c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe014dfd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, '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.QdZkBL7n59/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.xIT1Zx2mPn/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:31:35 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:31:35 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:31:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:31:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:35 INFO - 'HOME': '/Users/cltbld', 10:31:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:35 INFO - 'LOGNAME': 'cltbld', 10:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:35 INFO - 'MOZ_NO_REMOTE': '1', 10:31:35 INFO - 'NO_EM_RESTART': '1', 10:31:35 INFO - 'PAGER': '/bin/cat', 10:31:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:35 INFO - 'PWD': '/builds/slave/test', 10:31:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:35 INFO - 'SHELL': '/bin/bash', 10:31:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:31:35 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:31:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:35 INFO - 'USER': 'cltbld', 10:31:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:35 INFO - 'XPC_FLAGS': '0x0', 10:31:35 INFO - 'XPC_SERVICE_NAME': '0', 10:31:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-TMqlbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Ef1tjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-k9YFxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-iohzsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-icjFna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Xcozd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-oJqoxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-1FL7EE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-m0hIWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:36 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-O8odPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:37 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-EMxyvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:37 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-0AG8M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:37 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-flk59k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:37 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-B7UGB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:37 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-W4ve54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:37 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-HDxoY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:37 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-UDbGHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:31:37 INFO - Running setup.py install for manifestparser 10:31:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:31:37 INFO - Running setup.py install for mozcrash 10:31:38 INFO - Running setup.py install for mozdebug 10:31:38 INFO - Running setup.py install for mozdevice 10:31:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Running setup.py install for mozfile 10:31:38 INFO - Running setup.py install for mozhttpd 10:31:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Running setup.py install for mozinfo 10:31:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Running setup.py install for mozInstall 10:31:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Running setup.py install for mozleak 10:31:39 INFO - Running setup.py install for mozlog 10:31:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:31:39 INFO - Running setup.py install for moznetwork 10:31:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:31:39 INFO - Running setup.py install for mozprocess 10:31:39 INFO - Running setup.py install for mozprofile 10:31:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:31:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:31:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:31:39 INFO - Running setup.py install for mozrunner 10:31:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:31:39 INFO - Running setup.py install for mozscreenshot 10:31:39 INFO - Running setup.py install for moztest 10:31:40 INFO - Running setup.py install for mozversion 10:31:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:31:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:31:40 INFO - Cleaning up... 10:31:40 INFO - Return code: 0 10:31:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:40 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 0x1074c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe014dfd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, '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.QdZkBL7n59/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.xIT1Zx2mPn/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:31:40 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:31:40 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:31:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:31:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:40 INFO - 'HOME': '/Users/cltbld', 10:31:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:40 INFO - 'LOGNAME': 'cltbld', 10:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:40 INFO - 'MOZ_NO_REMOTE': '1', 10:31:40 INFO - 'NO_EM_RESTART': '1', 10:31:40 INFO - 'PAGER': '/bin/cat', 10:31:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:40 INFO - 'PWD': '/builds/slave/test', 10:31:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:40 INFO - 'SHELL': '/bin/bash', 10:31:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:31:40 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:31:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:40 INFO - 'USER': 'cltbld', 10:31:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:40 INFO - 'XPC_FLAGS': '0x0', 10:31:40 INFO - 'XPC_SERVICE_NAME': '0', 10:31:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-JiaNWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-CxkfLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-HYgaWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:40 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-gLb9ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:40 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-sv2RcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:41 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:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-v3WuKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:41 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:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-OTF9bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:41 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:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-IOtt7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:41 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:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-62xzQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:41 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:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-HVICFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:41 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:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-IFQn5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:41 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:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-FBSy2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-T_lK1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:41 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:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:41 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-UOr3nG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:42 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-SsUwwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:42 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:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:42 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-8qz1wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:42 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-rsBM4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:42 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:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:31:42 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:31:42 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:31:42 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:31:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:31:42 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:31:42 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:31:42 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:31:42 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:31:42 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:31:42 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:31:43 INFO - Downloading blessings-1.6.tar.gz 10:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:31:43 INFO - Installing collected packages: blessings 10:31:43 INFO - Running setup.py install for blessings 10:31:43 INFO - Successfully installed blessings 10:31:43 INFO - Cleaning up... 10:31:44 INFO - Return code: 0 10:31:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:44 INFO - Reading from file tmpfile_stdout 10:31:44 INFO - Current package versions: 10:31:44 INFO - blessings == 1.6 10:31:44 INFO - blobuploader == 1.2.4 10:31:44 INFO - docopt == 0.6.1 10:31:44 INFO - functools32 == 3.2.3-2 10:31:44 INFO - jsonschema == 2.5.1 10:31:44 INFO - manifestparser == 1.1 10:31:44 INFO - mozInstall == 1.12 10:31:44 INFO - mozcrash == 1.0 10:31:44 INFO - mozdebug == 0.1 10:31:44 INFO - mozdevice == 0.50 10:31:44 INFO - mozfile == 1.2 10:31:44 INFO - mozhttpd == 0.7 10:31:44 INFO - mozinfo == 0.9 10:31:44 INFO - mozleak == 0.1 10:31:44 INFO - mozlog == 3.4 10:31:44 INFO - moznetwork == 0.27 10:31:44 INFO - mozprocess == 0.25 10:31:44 INFO - mozprofile == 0.28 10:31:44 INFO - mozrunner == 6.13 10:31:44 INFO - mozscreenshot == 0.1 10:31:44 INFO - mozsystemmonitor == 0.3 10:31:44 INFO - moztest == 0.8 10:31:44 INFO - mozversion == 1.4 10:31:44 INFO - psutil == 3.1.1 10:31:44 INFO - requests == 1.2.3 10:31:44 INFO - wsgiref == 0.1.2 10:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe014dfd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, '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.QdZkBL7n59/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.xIT1Zx2mPn/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:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:31:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:31:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:44 INFO - 'HOME': '/Users/cltbld', 10:31:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:44 INFO - 'LOGNAME': 'cltbld', 10:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:44 INFO - 'MOZ_NO_REMOTE': '1', 10:31:44 INFO - 'NO_EM_RESTART': '1', 10:31:44 INFO - 'PAGER': '/bin/cat', 10:31:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:44 INFO - 'PWD': '/builds/slave/test', 10:31:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:44 INFO - 'SHELL': '/bin/bash', 10:31:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:31:44 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:31:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:44 INFO - 'USER': 'cltbld', 10:31:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:44 INFO - 'XPC_FLAGS': '0x0', 10:31:44 INFO - 'XPC_SERVICE_NAME': '0', 10:31:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:31:44 INFO - Cleaning up... 10:31:44 INFO - Return code: 0 10:31:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074c2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074c5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe014dfd20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, '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.QdZkBL7n59/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.xIT1Zx2mPn/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:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:31:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:31:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:44 INFO - 'HOME': '/Users/cltbld', 10:31:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:44 INFO - 'LOGNAME': 'cltbld', 10:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:44 INFO - 'MOZ_NO_REMOTE': '1', 10:31:44 INFO - 'NO_EM_RESTART': '1', 10:31:44 INFO - 'PAGER': '/bin/cat', 10:31:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:44 INFO - 'PWD': '/builds/slave/test', 10:31:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:44 INFO - 'SHELL': '/bin/bash', 10:31:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:31:44 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:31:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:44 INFO - 'USER': 'cltbld', 10:31:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:44 INFO - 'XPC_FLAGS': '0x0', 10:31:44 INFO - 'XPC_SERVICE_NAME': '0', 10:31:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:31:44 INFO - Cleaning up... 10:31:44 INFO - Return code: 0 10:31:44 INFO - Running post-action listener: _resource_record_post_action 10:31:44 INFO - Running post-action listener: _start_resource_monitoring 10:31:44 INFO - Starting resource monitoring. 10:31:44 INFO - [mozharness: 2017-05-04 17:31:44.856176Z] Finished create-virtualenv step (success) 10:31:44 INFO - [mozharness: 2017-05-04 17:31:44.857194Z] Running install step. 10:31:44 INFO - Running pre-action listener: _resource_record_pre_action 10:31:44 INFO - Running main action method: install 10:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:45 INFO - Reading from file tmpfile_stdout 10:31:45 INFO - Detecting whether we're running mozinstall >=1.0... 10:31:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:31:45 INFO - Reading from file tmpfile_stdout 10:31:45 INFO - Output received: 10:31:45 INFO - Usage: mozinstall [options] installer 10:31:45 INFO - Options: 10:31:45 INFO - -h, --help show this help message and exit 10:31:45 INFO - -d DEST, --destination=DEST 10:31:45 INFO - Directory to install application into. [default: 10:31:45 INFO - "/builds/slave/test"] 10:31:45 INFO - --app=APP Application being installed. [default: firefox] 10:31:45 INFO - mkdir: /builds/slave/test/build/application 10:31:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:32:04 INFO - Reading from file tmpfile_stdout 10:32:04 INFO - Output received: 10:32:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:32:04 INFO - Running post-action listener: _resource_record_post_action 10:32:04 INFO - [mozharness: 2017-05-04 17:32:04.670094Z] Finished install step (success) 10:32:04 INFO - [mozharness: 2017-05-04 17:32:04.670273Z] Running run-tests step. 10:32:04 INFO - Running pre-action listener: _resource_record_pre_action 10:32:04 INFO - Running main action method: run_tests 10:32:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:32:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:32:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:32:04 INFO - 2017-05-04 10:32:04.684 screenresolution[1618:7423] starting screenresolution argv=screenresolution get 10:32:04 INFO - 2017-05-04 10:32:04.687 screenresolution[1618:7423] Display 0: 1600x1200x32@60 10:32:04 INFO - 2017-05-04 10:32:04.693 screenresolution[1619:7425] starting screenresolution argv=screenresolution list 10:32:04 INFO - Available Modes on Display 0 10:32:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:32:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:32:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:32:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:32:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:32:04 INFO - Intel Iris: 10:32:04 INFO - Chipset Model: Intel Iris 10:32:04 INFO - Type: GPU 10:32:04 INFO - Bus: Built-In 10:32:04 INFO - VRAM (Dynamic, Max): 1536 MB 10:32:04 INFO - Vendor: Intel (0x8086) 10:32:04 INFO - Device ID: 0x0a2e 10:32:04 INFO - Revision ID: 0x0009 10:32:04 INFO - Displays: 10:32:04 INFO - Display: 10:32:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:32:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:32:04 INFO - Display Serial Number: 1600x1200 60 10:32:04 INFO - Main Display: Yes 10:32:04 INFO - Mirror: Off 10:32:04 INFO - Online: Yes 10:32:04 INFO - Rotation: Supported 10:32:04 INFO - Return code: 0 10:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:32:04 INFO - Python 2.7.3 10:32:04 INFO - Return code: 0 10:32:04 INFO - grabbing minidump binary from tooltool 10:32:04 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:32:04 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 0x1072a0d30>, '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 0x1071c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107295be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:32:04 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:32:04 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:32:04 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:32:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:32:05 INFO - Return code: 0 10:32:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:32:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:32:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:32:05 INFO - ENV: RUST_BACKTRACE is now 1 10:32:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:32:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.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:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.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:32:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QdZkBL7n59/Render', 10:32:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:05 INFO - 'HOME': '/Users/cltbld', 10:32:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:05 INFO - 'LOGNAME': 'cltbld', 10:32:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:32:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:05 INFO - 'MOZ_NO_REMOTE': '1', 10:32:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:32:05 INFO - 'NO_EM_RESTART': '1', 10:32:05 INFO - 'PAGER': '/bin/cat', 10:32:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:05 INFO - 'PWD': '/builds/slave/test', 10:32:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:32:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:05 INFO - 'RUST_BACKTRACE': '1', 10:32:05 INFO - 'SHELL': '/bin/bash', 10:32:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xIT1Zx2mPn/Listeners', 10:32:05 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 10:32:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:05 INFO - 'USER': 'cltbld', 10:32:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:05 INFO - 'XPC_FLAGS': '0x0', 10:32:05 INFO - 'XPC_SERVICE_NAME': '0', 10:32:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.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:32:05 INFO - mozversion application_buildid: 20170504084920 10:32:05 INFO - mozversion application_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:32:05 INFO - mozversion application_display_name: Nightly 10:32:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:32:05 INFO - mozversion application_name: Firefox 10:32:05 INFO - mozversion application_remotingname: firefox 10:32:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:32:05 INFO - mozversion application_vendor: Mozilla 10:32:05 INFO - mozversion application_version: 55.0a1 10:32:05 INFO - mozversion platform_buildid: 20170504084920 10:32:05 INFO - mozversion platform_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:32:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:32:05 INFO - mozversion platform_version: 55.0a1 10:32:05 INFO - using testdate: 1493919125 10:32:05 INFO - actual date: 1493919125 10:32:05 INFO - starting webserver on 'localhost:49239' 10:32:05 INFO - SUITE-START | Running 2 tests 10:32:05 INFO - TEST-START | dromaeo_css 10:32:05 INFO - operating with platform_type : mac_ 10:32:05 INFO - Initialising browser for dromaeo_css test... 10:32:05 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpLtqAEn/profile http://localhost:49239/getInfo.html) 10:32:07 INFO - PID 1629 | __metrics Screen width/height:1600/1200 10:32:07 INFO - PID 1629 | colorDepth:24 10:32:07 INFO - PID 1629 | Browser inner width/height: 1024/691 10:32:07 INFO - PID 1629 | __metrics 10:32:08 INFO - PID 1629 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:32:08 INFO - PID 1629 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:32:08 INFO - TEST-INFO | 1629: exit 0 10:32:08 INFO - Browser initialized. 10:32:08 INFO - Running cycle 1/1 for dromaeo_css test... 10:32:08 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpLtqAEn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:21 INFO - PID 1631 | RSS: Main: 240377856 10:32:21 INFO - PID 1631 | 10:35:26 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 10:35:28 INFO - PID 1631 | RSS: Main: 371318784 10:35:28 INFO - PID 1631 | 10:38:30 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 10:38:31 INFO - PID 1631 | RSS: Main: 361693184 10:38:31 INFO - PID 1631 | 10:41:33 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 10:41:33 INFO - PID 1631 | RSS: Main: 323686400 10:41:33 INFO - PID 1631 | 10:44:36 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 10:44:36 INFO - PID 1631 | RSS: Main: 319811584 10:44:36 INFO - PID 1631 | 10:47:40 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 10:47:41 INFO - PID 1631 | RSS: Main: 320827392 10:47:41 INFO - PID 1631 | 10:50:43 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 10:50:43 INFO - PID 1631 | RSS: Main: 374964224 10:50:43 INFO - PID 1631 | 10:50:43 INFO - PID 1631 | __start_tp_report 10:50:43 INFO - PID 1631 | _x_x_mozilla_page_load 10:50:43 INFO - PID 1631 | _x_x_mozilla_page_load_details 10:50:43 INFO - PID 1631 | |i|pagename|runs| 10:50:43 INFO - PID 1631 | |0;dojo.html;3475.9304813903736;3504.842282097307;3555.75109742318;3556.7332450066247;3573.803440810754;5753.395893431192;6082.72627731752;6110.511159107272;6122.326544080153;6134.957077260935;6130.7650488535955;6187.0719392091205;6196.256449226099;6226.750929962807;6249.406306400896;4906;5202.895942081156;5332.413434522199;5390.3262092238565;5430.615193125747;5416.51251387375;5420.24116623671;5491.121420572709;5505.532029777453;5533.612647114704;4515.61617262533;5305.602079844008;5368.812091576776;5377.7311134443125;5402.054640437947;5370.43610420904;5420.078586640241;5437.265969094161;5470;5490.368607610136;5362.892742145174;5384.380796208407;5391.973040134813;5393.83818485446;5400.135978243462;6103.35914728956;6138.2964379703635;6198.721057552421;6243.65659888706;6247.344028876948;5494.945050549483;6554.377334153295;6621.304762999912;6634.402903738638;6636.435902948255;6705.463562915004;6707.1616047994;6710.496712746514;6732.4950628703045;6740.460763138986;6166.753329866755;6288.434040936338;6293.748250069946;6309.652969086745;6322.4942004639515;6648.734050638017;6715.294894036056;6802.387785099365;6868.793936181823;6919.308069193141;6474.546781725328;6513.576617519846;6528.151340325822;6528.836779080466;6533.281339052701;5572.749226284827;6629.535932484776;6642;6645.966770166118;6691.7323307068145;6378.617282963037;6408.935910640834;6502.089707440962;6576.76981305652;6596.80209593713;6590.2421221560135;6601.141851559362;6610.867782644416;6613.702383392759;6626.900596491057;5303.310569626001;5304.124819404832;5305.018571564273;5305.071612467803;5339.973300133474;4626.190416677068;4646.5349982587795;4691.81232750693;4704.811807527661;4732;6255.155554000243;6265.185525881698;6274.152989346471;6314.652694101868;6342;5589.469000444951;6707.027481015225;6713.530052896251;6732.225794033651;6732.293109223461;6262.75497506241;6297.149884765589;6326;6342.619442833445;6360.681965901686;5703;5774.191613174159;5780.104083867007;5852.356240813507;5879.735411906389;6886.070380498569;6903.1716194057035;6918.446524278146;6929.93070069313;6934;5563.833085007456;6481.319461456479;6567.9014814776865;6570.704318305783;6631.502637302126;6867.141607299088;6927.376536111774;6937.583744975318;6941.132358455193;6948.652567371712;6332.30344662096;6609.173853268341;6613.437857782143;6613.801585952429;6616.900746488903;6515.934840651533;6640.90038649411;6663.13379260693;6704.061431399706;6733.326667333227;6440.710168042356;6461.483081353575;6474.4820414365795;6474.611523308617;6475.805725828232;6280.591761535486;6411.647359395091;6414.61512309263;6447;6466.127072845105;5314.707691077027;6250;6313.873722525615;6325.493960483058;6344.68276586178;6448.871022579616;6477.902831457626;6487.124238227779;6490.221173459026;6491.578047426902;6229.065640154013;6328.841778955379;6332.588381755171;6343.714532846126;6346.397092276226 10:50:43 INFO - PID 1631 | |1;ext.html;778.2140038561051;795.3915254830055;805.750217432596;1120.3837889160964;1123.8876112388757;26125.608115878276;36339;36714.26571468569;36720.449193262124;36786.448203276974;38085.61914380855;38370.42444363337;38446;38453.80773096131;38453.80773096131;5886.293644762613;6009.819705408845;8159.673613055471;8338.332933365316;8358.958205208966;5021.246812978046;6019.7893073742425;6028.939710602904;7342.706291748324;8247.010358756928;8274.586270686472;8328.042275138376;8340.708075217368;8346.41575089744;8420.200080992327;8227.218414250636;8285.54429506377;8299.211574900375;8325.542095184763;8327.916720832805;8150.38872084596;8215.178482151798;8220.301274391684;8224.136465671078;8230.670773169066;36629;36784.89645310645;36788.816055919815;36814.8159259202;36861.631383686356;3617.7467577269604;3649.434337677664;3654.0682126057686;3656.232191239843;3658;29517.11448656544;29580.8520957396;29598.70401295981;29627.111186664435;29631;3121.1416860363356;3163.636181839072;3187.569678093474;3198.3763166182603;3202.8558714857886;224872;294942.52528737433;295056.52471737505;296239;296495;48272.7586362073;48324.7583762086;48350;48366.75816620894;48367.51632483701;50464.74767626138;50489.242661360106;50567;50590.747046264536;50718.985620287385;11249.775004499865;13513.459461621622;13565.389557469938;13575.932120339532;13584.728305433837;9621.567029483691;10985.39580323074;11000.174986876016;11007.61473348429;11015.173861960386;10825.404602746767;10872.728181795519;10873.945630271955;10881.12950963921;10884.40135792539;4641.828398734514;5071.884185479189;5776.768929242868;5824.650520968756;5831.358550559435;991.2367477042637;1029.5572903651353;1030.8917563655857;1068.71144790906;1070.8982646648556;23073.88463057674;23206.883965580066;24175.032998679857;24239;24258.51482970331;1127.5997021057572;1133.5975728616388;1133.7732453509166;1169.818678104895;1184.496588949693;12301.815472767916;12383.62849114528;12413.317267550372;12419.75160496803;12421.627351179479;305965;306027;306342;306942;307003;51629.741851291255;51662.22506662403;51684.741576291875;51791.48208517942;51835.704107396865;1514.8182218134116;1515.9696806064037;1558.6570954390243;1563.679445713626;1567.2477210938814;23628;23766.287011389686;23778.167764128866;23834.761652383255;23845.403864902823;38593.63205071132;38737.031574209745;38777.4183387255;38789.03027424337;38837.6116238834;263984;264436;264806;264990;265568;30954.845225773726;31684.5247321295;32199.51700724444;32337.676623233467;32386.35227295488;34962.776302829276;35117.29765404729;35915.46126808048;43175.9206019852;43181.56818431775;26953.191404257905;27180;28451.28871778222;29712;29780.851095744383;29250;29371.265718357212;29428.852855735586;29692.81228750912;29703.40593188081;34149.82925085359;34453.48319775155;35688.286234275685;35926.92219233427;35954.10114747152;28745.281367965967;29081;29448.558271625516;29557.408851822413;29718.55049006343;21997;22296.88851555732;22482.550348993256;23532.647010294517;24594.75405245996 10:50:43 INFO - PID 1631 | |2;jquery.html;416.8700576003125;421.38477822379326;438.5723919178801;440.6937178660832;443.62513675943825;18668.813311866896;20452.590948181027;21159.942002899832;21349.146034158653;21366.03852826623;20984;22081.895905204714;22373.44066398341;22691.319260422213;22799.43001424965;5805.767769289223;6078.604890682113;6079.4528492435675;6079.939200608003;6086.208792856923;5714.628549144313;5885.4114588541015;5947.732352044147;5955.464008239258;5958.672273024982;5920.703964801743;5920.993431116721;5926.436988486109;5931.258592675916;5932.11018347247;5845.123231515286;5864.648121112726;5881.647101173943;6000.399960003964;6013.037913933749;4436.290193569013;5260.92108618371;5318.707471089088;5333.2266821310695;5334.866628334284;21687.24094656695;27039.594406083925;27174.728252717417;27966.385546384823;28200.589970501394;2168.0785666091847;2202.5264568117773;2247.5954328220914;2284.8400611957168;2284.954300913989;17518.562035949075;17922.641547169114;18037;18190.908545487313;18264.90867545667;1861.7579714637145;2083.9687404688943;2147.4201965469238;2158.4280165756086;2174.4563859035243;146405;156771;162335;166473;169429.45855812295;11721.88278117225;11724.179307448567;12075.698107547381;12092;12263.816042759367;16163.515094547183;16232.431864884673;16258.268377923021;16261.674766504604;16289.104099274653;7601.923980760122;7749.41879359039;8512.319014478951;8768;8903.599338029675;8001;8280.213379729037;8287.12985136564;8299.170082991652;8444.788880278042;7536.924630753732;7695.807604809925;7712.113106992655;7713.807154821175;7733.7679869604;2066.8036536529007;2074.2429013409997;2078.4180429479466;2085.5411809401908;2249.752527222004;952.5046975572664;955.9245848420527;960.13108137136;977.5307852230969;999.415342024909;20135.597288054156;20530.281440149523;20599.485012874797;20692.275770347966;20860.763007614227;956.8947415784259;981.4454833019464;1002.2182697495965;1002.6340385759291;1007.677543186188;10257.58969641221;10517.737056573647;10588;10624.946875265729;10688.814929276145;568515;573933;580722;582812;584355;128083;130582;135144;138221;138875.30562347124;1086.7065892209218;1116.9776604468027;1186.1815347410432;1238.7274799544086;1241.9565315214104;20809.37571872846;21489.03299351564;21527.46181345479;21783.564328713655;21905.67141492847;50887.74556127344;53823.03973281507;53876.73061634667;54401.95442987454;54890;70841;71498.64250678713;71543;72294;73549.26450735424;8442.704505342284;8466.534340611326;8529.14708529142;8919.10808919103;8929.508877011827;11836.697963224211;12741.299228542519;13333.466661333827;13576.253306068262;14026;11589.24669896454;11744.94127529357;11777.291223018925;11868.82196767032;12051.57819476314;9572.473513956798;10609.416482093251;10758.70895492546;11007.229493935347;11173.217874748689;11492.94253528727;11785.469653865768;12008.519659213534;12033.819492707791;12080.93959530232;8267.83464330722;8504.702335418231;8553.786155346166;8715.91284087151;8762.561871906506;9803.901960980298;11234.382108984084;11491.138164637518;11799;11845.76308473843 10:50:43 INFO - PID 1631 | |3;mootools.html;1230.3356187658665;1448.3627204030226;1485.688005518841;1501.6020754500053;1505.9096454212752;9634;10057.698269051922;11428.771424571514;11712.7657446851;11714.121440891924;11267;11404.657860264184;11405.600803971862;11408.20142590019;11433.942830285858;2085.3326935380683;2444.865532395722;2488.552060629095;2489.9377515562073;2501.4246723253664;2044.815966563009;2343.8945247463903;2504.3864253257975;2512.6356678281636;2520.0675749972534;2183.967240491394;2371.2293504610984;2472.777450029506;2481.404462928902;2487.813413993949;2404.759524047599;2437.585610446228;2439.8166889058793;2440.8169387296025;2448.179859746987;2394.2761211927386;2408.747081556429;2422.176460003607;2424.7211570669424;2438.073532057824;11430.599929002445;11539.884601153964;11565.94217028918;11567.479463424166;11577.247478913843;6300.653464059475;6546.509011824132;6549.1158693576235;6552.672366381662;6553.541252112354;3962.6631736302447;4075.673946084306;4163.895902602429;4236.428082208893;4245.448091748053;1255.8430196225472;1259.9559015434506;1288.5747703257903;1292.7349893271858;1305.882470577643;16487.093209873452;16550.586235344093;16553.83446165547;16568.254428550623;16588.170591470378;4649.604783593432;5687.744051517691;5813.09896965971;5849.883002340014;5857.7949771757785;13729.038967272196;13738.038337316491;13743.175409475463;13749.381277842522;13758.93120534411;6606.8017959461295;6607.2071351438135;6608.339166083353;6614.371634694792;6623.105880706139;5067.265246539231;5964.373740757244;6014.51883849291;6073;6089.695515224221;4049.6962727795535;4135.276326642826;4152.460180176618;4153.397757325171;4155.854545090907;1258.8615252322238;1346.9191848488927;1375.3604573873197;1385.3696568061507;1390.7496650602989;790.2887401338726;800.4676889868173;817.207308910356;818.975430737067;844.1980118887082;6018.307894592091;6020.982970704776;6226.283977342664;6258.217722784652;6275.843103922439;868.8305780372766;905.8912930448388;947.5499137909576;949.5299826585884;952.0479520479521;3934.409838524244;4097.627294856197;4099.959000410017;4138.606832350922;4267.637250833652;12220.877791222152;14655.633609159642;15075.472358467401;15232.695346093016;15245.23773811305;14516.274186290642;15163.241837908061;15167.848321516864;15192.46826361072;15302.387904483918;8452;8648.783780405414;8656.480611163224;8665.13348665141;8666.306695464347;5841.912371314349;6714.664266786739;6878.8624227516175;7033.402160816183;7063.788086357417;13191.472341106248;13367.131136476099;13603.115797473132;13625.318734063456;13783.37974791157;13495.39270732839;13744.381502832597;13765.38055787512;13966.224558887976;14016.509422170175;9200.447973121634;9300.628339773584;9365.672201472917;9432.858507122535;9486.193673537551;10454.215933804842;10713.94643026811;10715.35707857531;10723.624673136403;10726.088282496075;8909.643614255358;9147.725568232963;9226.492542910204;9275.304352173749;9392.295577831554;8950.418222815497;8973.685920992733;9064.954675226581;9107.08929107084;9127;7973.083095444098;8235.752927412188;8350.916490835258;8357.414980951275;8358.373122015752;5855.970720146372;5938.554608404301;5960.582759206987;6066.181065556093;6088.391160883876;5944.048952167633;5996.280446346466;6070.3019152798;6084.6349219047;6098.146259523759 10:50:43 INFO - PID 1631 | |4;prototype.html;378.2397381263659;391.3581725969411;395.6162522353316;397.4614397491401;403.036742186175;5773.220615216945;5796.536277097833;5798.535622360501;5833.620814647045;5849.766009359626;5418.512333889949;5586.748596313166;5671.901396483307;5697.829065128053;5707.115397113444;4247.044415006614;4254.638355739766;4263.80613428239;4279.122779830135;4303.720258183208;3902.2780785554623;4264.658827293809;4269.594388533084;4273.551277115905;4294.785260736966;3842.558105817825;3848.3073046851555;4178.791060446981;4239.3852891330735;4273.636740877014;3475.7219422446396;4225.112726327475;4234.491860976703;4271.159678813585;4272.807723652428;3041.832699201543;3648.233870887117;3658.487811706363;3668.3580373434543;3683.778973261613;4977.253411988195;5269.288646032813;5490.670559766427;5589.888202235973;5598.020346439397;4374.518802931675;4602.872296287431;4619.953800461986;4998.600111991068;5036.622253330978;5085.220172939478;5332.573394128461;6059.606125601866;6131.846703832395;6177.938220617782;4008.3386241270155;4138.52406973199;4142.834286628531;4152.833886644561;4211.368294755781;5285.682859028432;6225.657588832567;6338.626347820035;6366.707985125351;6428.71070801815;3764.153065560282;4123.670106391482;4177.289860723684;4183.309753890635;4235.174141042467;4288.957110428918;4291.50647675515;4308.827646894089;4311.547287534827;4313.719608225455;4356.847510337123;4444;4652.651051171176;4875.756682046126;4915.26271059344;5368;6018.668973206428;6096.75612975476;6154.415330543591;6225.719842607094;1337.7592033434075;1451.4629587052857;1456.7960485532035;1461.8099647045815;1472.9263536823116;832.6419639554929;902.0348227396622;930.3534043839602;979.0601023017982;987.8814542254976;5781.508571771446;5792.391798861143;5831.88336233273;5833.270841144857;5859.912101318484;6078.45293923549;6174.9073763893575;6320.304766475684;6364.7135878885565;6380;5696.943030569724;5723.484886360247;5797.536197104221;5803.883922321615;5827.650340979555;2730.866690323533;3286.194882253863;3308.619508756524;3325.5011748237475;3338.1139656094715;4946.530079642428;6327.778527751599;6598.637074960923;6653.833654158685;6657.037618259925;5522.944770552243;5622.775088996476;6162.753489860445;6543.822112019787;6642.86714265712;5631.746571404296;6543.70553325092;6578.039882053;6619.172603424572;6676.933230667728;6387.648679322682;6404;6404.1674582304;6424.678766061772;6434.710438030394;5084.6440749147205;6221.178671097395;6273.435390814849;6279.874402511833;6331.9050214247745;6345.96827015862;6369.777057802955;6386.425221730066;6403.935960640334;6528.902066469102;3568.4290513517712;3731.936398126521;4214.388913607571;4231.5556866529805;4259.722083374913;5068.417132029864;5101.9489805101475;5555.388907220284;6383.489320854228;6386.201724784402;5811.883762324815;6103.572749907464;6142.570020098729;6150.2927163375;6150.692465376803;5345.492178243061;6109;6109.236345456818;6124.479419249414;6128.387161283836;4742.834000809955;5508.55931525485;5767;5808.9958964157295;6034.2155519782145;6112.205413296421;6143.784967526115;6155.0759392486725;6158.507319414346;6187.752489900354;5780.913286300793;6006.468350570576;6010.838890137469;6037.305709843425;6052.100605309863 10:50:43 INFO - PID 1631 | |5;yui.html;838.0822998816294;847.8897743293371;856.6915910272301;856.8200677857645;867.5185272173941;16357.345706171755;16584.502464926056;16895.91552042238;16896.83103168968;16900.577485562866;15348.002379845302;16889.662206755856;18092.909535452338;18290;18291.268349266014;1002.0430488883118;1023.145673362743;1025.0467065628961;1027.712240572641;1029.521272608237;1001.7896241789233;1004.1765752083295;1006.2402885821232;1007.0584003956287;1008.6520150548085;1018.3228153278061;1030.7062487191151;1034.824079906414;1035.4253389368898;1067.6156583629886;1011.3577878047493;1017.5319353097584;1020.9489525523694;1022.1311884897815;1040.2614143957799;776.2431629161579;776.2664282253273;778.6846327237478;778.9727359542445;779.8440311937635;16727.832721672872;16837.747433788503;16927.238274277686;16961.915190424093;17023.574410639834;16830.747538786927;17201.913990430094;17315.567110822205;17353.04558249296;17607.207675654627;13933.860661393357;14105.153690778587;14199;14298.856091512655;14318.212498312589;3484.564429446319;3503.1242189452637;3504.56192975878;3508.8947331580093;3513.472979053137;102514.48742756313;125174.87062823412;129372.35313823464;130801;133383;13049.934750326187;13192.802107968388;13275.406951165922;13419.194848309133;13455.192688438725;25550.361240968752;25600.359991;25845.612315815277;26108.60837087445;26193.95224191049;7506.3244308012545;7687.577183254863;7727.1886451922865;7796.805079873048;7819.100803407568;3916.686665066788;3972.781497017634;3998.660113890352;4000.119973605802;4000.259951908848;4192.371144328315;4247.97876010618;4248.957510424918;4612.838550650711;4701.8354357598;923.3628796130782;936.2697096264924;938.666773295484;948.3882895532342;948.6395169835556;553.7895599672099;653.7548419342746;667.1260648550415;676.2831398717375;706.4666177036305;11186;11689.649310520697;11901.821472677917;12482.43829027696;13255.734885302432;663.2174034639172;663.7709990053423;667.5060455263167;667.829703425633;692.2869444472202;5225.738713064332;5506.559475241971;5520.641158324696;5563.276774019351;5690.5163061140265;94459;97594.02405975992;99670;99699.50150249347;101826.98173018324;85688.01654957337;87374.56312718395;87575;88768.5561572188;89096;78428;79269.60365198253;81714.59142704248;82087.58956205181;82433.58783206045;9552.474613896302;9669.70990870275;9753.122219000325;9782.364146330467;10066;37808;39141.41287880627;39378.60621393749;39421;39520;49952;50741.23888141755;51148.74425627848;51237;51710;11378.43107844588;14213.857861421668;14520.419183232552;14520.709585808436;14560.781588276397;14739.631509212355;14876.776848347066;15022.849771502146;15066.698666026838;15148;14176.929115354356;14426.927865360605;14576.344064517334;14599.708005840037;14683.632909177357;14187.935904806975;14400.783988240395;14794.704105917606;14800.407983680532;14835;14222.644433888821;14277.500287489887;14364.640883977983;14428.42286308536;14535.055221410574;10599.311044782064;11384.544618215179;11577.189596728149;11810.350430726392;12326.876731232573;12996.740065198454;13871.583852484442;13892.652683682989;13903.582892513241;13935.790963135358 10:50:43 INFO - PID 1631 | __end_tp_report 10:50:43 INFO - PID 1631 | __start_cc_report 10:50:43 INFO - PID 1631 | _x_x_mozilla_cycle_collect,1405 10:50:43 INFO - PID 1631 | __end_cc_report 10:50:43 INFO - PID 1631 | __startTimestamp1493920243517__endTimestamp 10:50:43 INFO - PID 1631 | 10:50:43 INFO - PID 1631 | ------- Summary: start ------- 10:50:43 INFO - PID 1631 | Number of tests: 6 10:50:43 INFO - PID 1631 | 10:50:43 INFO - PID 1631 | [#0] dojo.html Cycles:165 Average:6091.15 Median:6328.84 stddev:732.94 (11.6%) stddev-sans-first:705.89 10:50:43 INFO - PID 1631 | Values: 3475.9 3504.8 3555.8 3556.7 3573.8 5753.4 6082.7 6110.5 6122.3 6135.0 6130.8 6187.1 6196.3 6226.8 6249.4 4906.0 5202.9 5332.4 5390.3 5430.6 5416.5 5420.2 5491.1 5505.5 5533.6 4515.6 5305.6 5368.8 5377.7 5402.1 5370.4 5420.1 5437.3 5470.0 5490.4 5362.9 5384.4 5392.0 5393.8 5400.1 6103.4 6138.3 6198.7 6243.7 6247.3 5494.9 6554.4 6621.3 6634.4 6636.4 6705.5 6707.2 6710.5 6732.5 6740.5 6166.8 6288.4 6293.7 6309.7 6322.5 6648.7 6715.3 6802.4 6868.8 6919.3 6474.5 6513.6 6528.2 6528.8 6533.3 5572.7 6629.5 6642.0 6646.0 6691.7 6378.6 6408.9 6502.1 6576.8 6596.8 6590.2 6601.1 6610.9 6613.7 6626.9 5303.3 5304.1 5305.0 5305.1 5340.0 4626.2 4646.5 4691.8 4704.8 4732.0 6255.2 6265.2 6274.2 6314.7 6342.0 5589.5 6707.0 6713.5 6732.2 6732.3 6262.8 6297.1 6326.0 6342.6 6360.7 5703.0 5774.2 5780.1 5852.4 5879.7 6886.1 6903.2 6918.4 6929.9 6934.0 5563.8 6481.3 6567.9 6570.7 6631.5 6867.1 6927.4 6937.6 6941.1 6948.7 6332.3 6609.2 6613.4 6613.8 6616.9 6515.9 6640.9 6663.1 6704.1 6733.3 6440.7 6461.5 6474.5 6474.6 6475.8 6280.6 6411.6 6414.6 6447.0 6466.1 5314.7 6250.0 6313.9 6325.5 6344.7 6448.9 6477.9 6487.1 6490.2 6491.6 6229.1 6328.8 6332.6 6343.7 6346.4 10:50:43 INFO - PID 1631 | 10:50:43 INFO - PID 1631 | [#1] ext.html Cycles:180 Average:42984.93 Median:3192.97 stddev:74819.72 (2343.3%) stddev-sans-first:74962.50 10:50:43 INFO - PID 1631 | Values: 778.2 795.4 805.8 1120.4 1123.9 26125.6 36339.0 36714.3 36720.4 36786.4 38085.6 38370.4 38446.0 38453.8 38453.8 5886.3 6009.8 8159.7 8338.3 8359.0 5021.2 6019.8 6028.9 7342.7 8247.0 8274.6 8328.0 8340.7 8346.4 8420.2 8227.2 8285.5 8299.2 8325.5 8327.9 8150.4 8215.2 8220.3 8224.1 8230.7 36629.0 36784.9 36788.8 36814.8 36861.6 3617.7 3649.4 3654.1 3656.2 3658.0 29517.1 29580.9 29598.7 29627.1 29631.0 3121.1 3163.6 3187.6 3198.4 3202.9 224872.0 294942.5 295056.5 296239.0 296495.0 48272.8 48324.8 48350.0 48366.8 48367.5 50464.7 50489.2 50567.0 50590.7 50719.0 11249.8 13513.5 13565.4 13575.9 13584.7 9621.6 10985.4 11000.2 11007.6 11015.2 10825.4 10872.7 10873.9 10881.1 10884.4 4641.8 5071.9 5776.8 5824.7 5831.4 991.2 1029.6 1030.9 1068.7 1070.9 23073.9 23206.9 24175.0 24239.0 24258.5 1127.6 1133.6 1133.8 1169.8 1184.5 12301.8 12383.6 12413.3 12419.8 12421.6 305965.0 306027.0 306342.0 306942.0 307003.0 51629.7 51662.2 51684.7 51791.5 51835.7 1514.8 1516.0 1558.7 1563.7 1567.2 23628.0 23766.3 23778.2 23834.8 23845.4 38593.6 38737.0 38777.4 38789.0 38837.6 263984.0 264436.0 264806.0 264990.0 265568.0 30954.8 31684.5 32199.5 32337.7 32386.4 34962.8 35117.3 35915.5 43175.9 43181.6 26953.2 27180.0 28451.3 29712.0 29780.9 29250.0 29371.3 29428.9 29692.8 29703.4 34149.8 34453.5 35688.3 35926.9 35954.1 28745.3 29081.0 29448.6 29557.4 29718.6 21997.0 22296.9 22482.6 23532.6 24594.8 10:50:43 INFO - PID 1631 | 10:50:43 INFO - PID 1631 | [#2] jquery.html Cycles:180 Average:36252.04 Median:12310.52 stddev:97923.39 (795.4%) stddev-sans-first:98161.13 10:50:43 INFO - PID 1631 | Values: 416.9 421.4 438.6 440.7 443.6 18668.8 20452.6 21159.9 21349.1 21366.0 20984.0 22081.9 22373.4 22691.3 22799.4 5805.8 6078.6 6079.5 6079.9 6086.2 5714.6 5885.4 5947.7 5955.5 5958.7 5920.7 5921.0 5926.4 5931.3 5932.1 5845.1 5864.6 5881.6 6000.4 6013.0 4436.3 5260.9 5318.7 5333.2 5334.9 21687.2 27039.6 27174.7 27966.4 28200.6 2168.1 2202.5 2247.6 2284.8 2285.0 17518.6 17922.6 18037.0 18190.9 18264.9 1861.8 2084.0 2147.4 2158.4 2174.5 146405.0 156771.0 162335.0 166473.0 169429.5 11721.9 11724.2 12075.7 12092.0 12263.8 16163.5 16232.4 16258.3 16261.7 16289.1 7601.9 7749.4 8512.3 8768.0 8903.6 8001.0 8280.2 8287.1 8299.2 8444.8 7536.9 7695.8 7712.1 7713.8 7733.8 2066.8 2074.2 2078.4 2085.5 2249.8 952.5 955.9 960.1 977.5 999.4 20135.6 20530.3 20599.5 20692.3 20860.8 956.9 981.4 1002.2 1002.6 1007.7 10257.6 10517.7 10588.0 10624.9 10688.8 568515.0 573933.0 580722.0 582812.0 584355.0 128083.0 130582.0 135144.0 138221.0 138875.3 1086.7 1117.0 1186.2 1238.7 1242.0 20809.4 21489.0 21527.5 21783.6 21905.7 50887.7 53823.0 53876.7 54402.0 54890.0 70841.0 71498.6 71543.0 72294.0 73549.3 8442.7 8466.5 8529.1 8919.1 8929.5 11836.7 12741.3 13333.5 13576.3 14026.0 11589.2 11744.9 11777.3 11868.8 12051.6 9572.5 10609.4 10758.7 11007.2 11173.2 11492.9 11785.5 12008.5 12033.8 12080.9 8267.8 8504.7 8553.8 8715.9 8762.6 9803.9 11234.4 11491.1 11799.0 11845.8 10:50:43 INFO - PID 1631 | 10:50:43 INFO - PID 1631 | [#3] mootools.html Cycles:180 Average:7104.20 Median:4006.18 stddev:4558.55 (113.8%) stddev-sans-first:4549.97 10:50:43 INFO - PID 1631 | Values: 1230.3 1448.4 1485.7 1501.6 1505.9 9634.0 10057.7 11428.8 11712.8 11714.1 11267.0 11404.7 11405.6 11408.2 11433.9 2085.3 2444.9 2488.6 2489.9 2501.4 2044.8 2343.9 2504.4 2512.6 2520.1 2184.0 2371.2 2472.8 2481.4 2487.8 2404.8 2437.6 2439.8 2440.8 2448.2 2394.3 2408.7 2422.2 2424.7 2438.1 11430.6 11539.9 11565.9 11567.5 11577.2 6300.7 6546.5 6549.1 6552.7 6553.5 3962.7 4075.7 4163.9 4236.4 4245.4 1255.8 1260.0 1288.6 1292.7 1305.9 16487.1 16550.6 16553.8 16568.3 16588.2 4649.6 5687.7 5813.1 5849.9 5857.8 13729.0 13738.0 13743.2 13749.4 13758.9 6606.8 6607.2 6608.3 6614.4 6623.1 5067.3 5964.4 6014.5 6073.0 6089.7 4049.7 4135.3 4152.5 4153.4 4155.9 1258.9 1346.9 1375.4 1385.4 1390.7 790.3 800.5 817.2 819.0 844.2 6018.3 6021.0 6226.3 6258.2 6275.8 868.8 905.9 947.5 949.5 952.0 3934.4 4097.6 4100.0 4138.6 4267.6 12220.9 14655.6 15075.5 15232.7 15245.2 14516.3 15163.2 15167.8 15192.5 15302.4 8452.0 8648.8 8656.5 8665.1 8666.3 5841.9 6714.7 6878.9 7033.4 7063.8 13191.5 13367.1 13603.1 13625.3 13783.4 13495.4 13744.4 13765.4 13966.2 14016.5 9200.4 9300.6 9365.7 9432.9 9486.2 10454.2 10713.9 10715.4 10723.6 10726.1 8909.6 9147.7 9226.5 9275.3 9392.3 8950.4 8973.7 9065.0 9107.1 9127.0 7973.1 8235.8 8350.9 8357.4 8358.4 5856.0 5938.6 5960.6 6066.2 6088.4 5944.0 5996.3 6070.3 6084.6 6098.1 10:50:43 INFO - PID 1631 | 10:50:43 INFO - PID 1631 | [#4] prototype.html Cycles:180 Average:4933.49 Median:5627.26 stddev:1553.52 (27.6%) stddev-sans-first:1519.78 10:50:43 INFO - PID 1631 | Values: 378.2 391.4 395.6 397.5 403.0 5773.2 5796.5 5798.5 5833.6 5849.8 5418.5 5586.7 5671.9 5697.8 5707.1 4247.0 4254.6 4263.8 4279.1 4303.7 3902.3 4264.7 4269.6 4273.6 4294.8 3842.6 3848.3 4178.8 4239.4 4273.6 3475.7 4225.1 4234.5 4271.2 4272.8 3041.8 3648.2 3658.5 3668.4 3683.8 4977.3 5269.3 5490.7 5589.9 5598.0 4374.5 4602.9 4620.0 4998.6 5036.6 5085.2 5332.6 6059.6 6131.8 6177.9 4008.3 4138.5 4142.8 4152.8 4211.4 5285.7 6225.7 6338.6 6366.7 6428.7 3764.2 4123.7 4177.3 4183.3 4235.2 4289.0 4291.5 4308.8 4311.5 4313.7 4356.8 4444.0 4652.7 4875.8 4915.3 5368.0 6018.7 6096.8 6154.4 6225.7 1337.8 1451.5 1456.8 1461.8 1472.9 832.6 902.0 930.4 979.1 987.9 5781.5 5792.4 5831.9 5833.3 5859.9 6078.5 6174.9 6320.3 6364.7 6380.0 5696.9 5723.5 5797.5 5803.9 5827.7 2730.9 3286.2 3308.6 3325.5 3338.1 4946.5 6327.8 6598.6 6653.8 6657.0 5522.9 5622.8 6162.8 6543.8 6642.9 5631.7 6543.7 6578.0 6619.2 6676.9 6387.6 6404.0 6404.2 6424.7 6434.7 5084.6 6221.2 6273.4 6279.9 6331.9 6346.0 6369.8 6386.4 6403.9 6528.9 3568.4 3731.9 4214.4 4231.6 4259.7 5068.4 5101.9 5555.4 6383.5 6386.2 5811.9 6103.6 6142.6 6150.3 6150.7 5345.5 6109.0 6109.2 6124.5 6128.4 4742.8 5508.6 5767.0 5809.0 6034.2 6112.2 6143.8 6155.1 6158.5 6187.8 5780.9 6006.5 6010.8 6037.3 6052.1 10:50:43 INFO - PID 1631 | 10:50:43 INFO - PID 1631 | [#5] yui.html Cycles:180 Average:20984.53 Median:17258.74 stddev:29785.75 (172.6%) stddev-sans-first:29830.89 10:50:43 INFO - PID 1631 | Values: 838.1 847.9 856.7 856.8 867.5 16357.3 16584.5 16895.9 16896.8 16900.6 15348.0 16889.7 18092.9 18290.0 18291.3 1002.0 1023.1 1025.0 1027.7 1029.5 1001.8 1004.2 1006.2 1007.1 1008.7 1018.3 1030.7 1034.8 1035.4 1067.6 1011.4 1017.5 1020.9 1022.1 1040.3 776.2 776.3 778.7 779.0 779.8 16727.8 16837.7 16927.2 16961.9 17023.6 16830.7 17201.9 17315.6 17353.0 17607.2 13933.9 14105.2 14199.0 14298.9 14318.2 3484.6 3503.1 3504.6 3508.9 3513.5 102514.5 125174.9 129372.4 130801.0 133383.0 13049.9 13192.8 13275.4 13419.2 13455.2 25550.4 25600.4 25845.6 26108.6 26194.0 7506.3 7687.6 7727.2 7796.8 7819.1 3916.7 3972.8 3998.7 4000.1 4000.3 4192.4 4248.0 4249.0 4612.8 4701.8 923.4 936.3 938.7 948.4 948.6 553.8 653.8 667.1 676.3 706.5 11186.0 11689.6 11901.8 12482.4 13255.7 663.2 663.8 667.5 667.8 692.3 5225.7 5506.6 5520.6 5563.3 5690.5 94459.0 97594.0 99670.0 99699.5 101827.0 85688.0 87374.6 87575.0 88768.6 89096.0 78428.0 79269.6 81714.6 82087.6 82433.6 9552.5 9669.7 9753.1 9782.4 10066.0 37808.0 39141.4 39378.6 39421.0 39520.0 49952.0 50741.2 51148.7 51237.0 51710.0 11378.4 14213.9 14520.4 14520.7 14560.8 14739.6 14876.8 15022.8 15066.7 15148.0 14176.9 14426.9 14576.3 14599.7 14683.6 14187.9 14400.8 14794.7 14800.4 14835.0 14222.6 14277.5 14364.6 14428.4 14535.1 10599.3 11384.5 11577.2 11810.4 12326.9 12996.7 13871.6 13892.7 13903.6 13935.8 10:50:43 INFO - PID 1631 | -------- Summary: end -------- 10:50:43 INFO - PID 1631 | 10:50:44 INFO - TEST-INFO | 1631: exit 0 10:50:44 INFO - TEST-OK | dromaeo_css | took 1118903ms 10:50:44 INFO - TEST-START | kraken 10:50:44 INFO - operating with platform_type : mac_ 10:50:44 INFO - Initialising browser for kraken test... 10:50:44 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmps_wVx7/profile http://localhost:49239/getInfo.html) 10:50:46 INFO - PID 1641 | __metrics Screen width/height:1600/1200 10:50:46 INFO - PID 1641 | colorDepth:24 10:50:46 INFO - PID 1641 | Browser inner width/height: 1024/691 10:50:46 INFO - PID 1641 | __metrics 10:50:46 INFO - PID 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:50:46 INFO - PID 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:50:47 INFO - TEST-INFO | 1641: exit 0 10:50:47 INFO - Browser initialized. 10:50:47 INFO - Running cycle 1/1 for kraken test... 10:50:47 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmps_wVx7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:59 INFO - PID 1642 | RSS: Main: 240680960 10:50:59 INFO - PID 1642 | 10:51:02 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 10:51:03 INFO - PID 1642 | RSS: Main: 308875264 10:51:03 INFO - PID 1642 | 10:51:05 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 10:51:06 INFO - PID 1642 | RSS: Main: 290123776 10:51:06 INFO - PID 1642 | 10:51:09 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 10:51:10 INFO - PID 1642 | RSS: Main: 380674048 10:51:10 INFO - PID 1642 | 10:51:12 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 10:51:13 INFO - PID 1642 | RSS: Main: 285519872 10:51:13 INFO - PID 1642 | 10:51:15 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:51:15 INFO - PID 1642 | RSS: Main: 289243136 10:51:15 INFO - PID 1642 | 10:51:18 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 10:51:19 INFO - PID 1642 | RSS: Main: 351559680 10:51:19 INFO - PID 1642 | 10:51:21 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 10:51:22 INFO - PID 1642 | RSS: Main: 374423552 10:51:22 INFO - PID 1642 | 10:51:25 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 10:51:26 INFO - PID 1642 | RSS: Main: 388354048 10:51:26 INFO - PID 1642 | 10:51:27 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:51:28 INFO - PID 1642 | RSS: Main: 329949184 10:51:28 INFO - PID 1642 | 10:51:29 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:51:30 INFO - PID 1642 | RSS: Main: 333471744 10:51:30 INFO - PID 1642 | 10:51:32 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:51:33 INFO - PID 1642 | RSS: Main: 334843904 10:51:33 INFO - PID 1642 | 10:51:36 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:51:37 INFO - PID 1642 | RSS: Main: 347787264 10:51:37 INFO - PID 1642 | 10:51:40 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:51:40 INFO - PID 1642 | RSS: Main: 344821760 10:51:40 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 10:51:42 INFO - PID 1642 | RSS: Main: 387526656 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | __start_tp_report 10:51:42 INFO - PID 1642 | _x_x_mozilla_page_load 10:51:42 INFO - PID 1642 | _x_x_mozilla_page_load_details 10:51:42 INFO - PID 1642 | |i|pagename|runs| 10:51:42 INFO - PID 1642 | |0;ai-astar;111;111;111;111;109;110;110;109;110;110 10:51:42 INFO - PID 1642 | |1;audio-beat-detection;151;141;137;149;109;108;107;104;136;109 10:51:42 INFO - PID 1642 | |2;audio-dft;185;184;181;187;183;183;182;184;184;182 10:51:42 INFO - PID 1642 | |3;audio-fft;83;61;56;87;58;71;87;86;88;58 10:51:42 INFO - PID 1642 | |4;audio-oscillator;87;72;84;69;67;67;89;69;67;88 10:51:42 INFO - PID 1642 | |5;imaging-gaussian-blur;87;87;87;86;86;85;87;87;87;87 10:51:42 INFO - PID 1642 | |6;imaging-darkroom;94;94;94;94;94;93;94;93;94;93 10:51:42 INFO - PID 1642 | |7;imaging-desaturate;85;85;85;83;84;84;95;127;99;84 10:51:42 INFO - PID 1642 | |8;json-parse-financial;48;48;48;47;49;47;48;48;49;48 10:51:42 INFO - PID 1642 | |9;json-stringify-tinderbox;52;59;56;61;64;59;56;56;54;54 10:51:42 INFO - PID 1642 | |10;stanford-crypto-aes;94;97;82;81;81;82;82;81;81;80 10:51:42 INFO - PID 1642 | |11;stanford-crypto-ccm;139;136;124;143;151;133;138;127;256;158 10:51:42 INFO - PID 1642 | |12;stanford-crypto-pbkdf2;189;233;204;193;181;182;184;184;184;183 10:51:42 INFO - PID 1642 | |13;stanford-crypto-sha256-iterative;66;67;67;66;65;63;67;69;69;67 10:51:42 INFO - PID 1642 | __end_tp_report 10:51:42 INFO - PID 1642 | __start_cc_report 10:51:42 INFO - PID 1642 | _x_x_mozilla_cycle_collect,2142 10:51:42 INFO - PID 1642 | __end_cc_report 10:51:42 INFO - PID 1642 | __startTimestamp1493920302762__endTimestamp 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | ------- Summary: start ------- 10:51:42 INFO - PID 1642 | Number of tests: 14 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 10:51:42 INFO - PID 1642 | Values: 111.0 111.0 111.0 111.0 109.0 110.0 110.0 109.0 110.0 110.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:136.50 stddev:19.26 (14.1%) stddev-sans-first:18.01 10:51:42 INFO - PID 1642 | Values: 151.0 141.0 137.0 149.0 109.0 108.0 107.0 104.0 136.0 109.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.72 (0.9%) stddev-sans-first:1.73 10:51:42 INFO - PID 1642 | Values: 185.0 184.0 181.0 187.0 183.0 183.0 182.0 184.0 184.0 182.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#3] audio-fft Cycles:10 Average:73.50 Median:84.50 stddev:14.03 (16.6%) stddev-sans-first:14.45 10:51:42 INFO - PID 1642 | Values: 83.0 61.0 56.0 87.0 58.0 71.0 87.0 86.0 88.0 58.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:78.00 stddev:9.75 (12.5%) stddev-sans-first:9.47 10:51:42 INFO - PID 1642 | Values: 87.0 72.0 84.0 69.0 67.0 67.0 89.0 69.0 67.0 88.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 10:51:42 INFO - PID 1642 | Values: 87.0 87.0 87.0 86.0 86.0 85.0 87.0 87.0 87.0 87.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:51:42 INFO - PID 1642 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 93.0 94.0 93.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#7] imaging-desaturate Cycles:10 Average:91.10 Median:85.00 stddev:13.72 (16.1%) stddev-sans-first:14.38 10:51:42 INFO - PID 1642 | Values: 85.0 85.0 85.0 83.0 84.0 84.0 95.0 127.0 99.0 84.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#8] json-parse-financial Cycles:10 Average:48.00 Median:48.00 stddev:0.67 (1.4%) stddev-sans-first:0.71 10:51:42 INFO - PID 1642 | Values: 48.0 48.0 48.0 47.0 49.0 47.0 48.0 48.0 49.0 48.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.50 stddev:3.63 (6.3%) stddev-sans-first:3.35 10:51:42 INFO - PID 1642 | Values: 52.0 59.0 56.0 61.0 64.0 59.0 56.0 56.0 54.0 54.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:82.00 stddev:6.08 (7.4%) stddev-sans-first:5.29 10:51:42 INFO - PID 1642 | Values: 94.0 97.0 82.0 81.0 81.0 82.0 82.0 81.0 81.0 80.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:141.00 stddev:38.45 (27.3%) stddev-sans-first:40.55 10:51:42 INFO - PID 1642 | Values: 139.0 136.0 124.0 143.0 151.0 133.0 138.0 127.0 256.0 158.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.70 Median:186.50 stddev:16.08 (8.6%) stddev-sans-first:17.03 10:51:42 INFO - PID 1642 | Values: 189.0 233.0 204.0 193.0 181.0 182.0 184.0 184.0 184.0 183.0 10:51:42 INFO - PID 1642 | 10:51:42 INFO - PID 1642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.78 (2.7%) stddev-sans-first:1.87 10:51:42 INFO - PID 1642 | Values: 66.0 67.0 67.0 66.0 65.0 63.0 67.0 69.0 69.0 67.0 10:51:42 INFO - PID 1642 | -------- Summary: end -------- 10:51:42 INFO - PID 1642 | 10:51:43 INFO - TEST-INFO | 1642: exit 0 10:51:43 INFO - TEST-OK | kraken | took 59660ms 10:51:43 INFO - SUITE-END | took 1178s 10:51:43 INFO - Completed test suite (00:19:38) 10:51:43 INFO - javascript benchmark 10:51:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7662.626633975693, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3475.9304813903736, 3504.842282097307, 3555.75109742318, 3556.7332450066247, 3573.803440810754, 5753.395893431192, 6082.72627731752, 6110.511159107272, 6122.326544080153, 6134.957077260935, 6130.7650488535955, 6187.0719392091205, 6196.256449226099, 6226.750929962807, 6249.406306400896, 4906.0, 5202.895942081156, 5332.413434522199, 5390.3262092238565, 5430.615193125747, 5416.51251387375, 5420.24116623671, 5491.121420572709, 5505.532029777453, 5533.612647114704, 4515.61617262533, 5305.602079844008, 5368.812091576776, 5377.7311134443125, 5402.054640437947, 5370.43610420904, 5420.078586640241, 5437.265969094161, 5470.0, 5490.368607610136, 5362.892742145174, 5384.380796208407, 5391.973040134813, 5393.83818485446, 5400.135978243462, 6103.35914728956, 6138.2964379703635, 6198.721057552421, 6243.65659888706, 6247.344028876948, 5494.945050549483, 6554.377334153295, 6621.304762999912, 6634.402903738638, 6636.435902948255, 6705.463562915004, 6707.1616047994, 6710.496712746514, 6732.4950628703045, 6740.460763138986, 6166.753329866755, 6288.434040936338, 6293.748250069946, 6309.652969086745, 6322.4942004639515, 6648.734050638017, 6715.294894036056, 6802.387785099365, 6868.793936181823, 6919.308069193141, 6474.546781725328, 6513.576617519846, 6528.151340325822, 6528.836779080466, 6533.281339052701, 5572.749226284827, 6629.535932484776, 6642.0, 6645.966770166118, 6691.7323307068145, 6378.617282963037, 6408.935910640834, 6502.089707440962, 6576.76981305652, 6596.80209593713, 6590.2421221560135, 6601.141851559362, 6610.867782644416, 6613.702383392759, 6626.900596491057, 5303.310569626001, 5304.124819404832, 5305.018571564273, 5305.071612467803, 5339.973300133474, 4626.190416677068, 4646.5349982587795, 4691.81232750693, 4704.811807527661, 4732.0, 6255.155554000243, 6265.185525881698, 6274.152989346471, 6314.652694101868, 6342.0, 5589.469000444951, 6707.027481015225, 6713.530052896251, 6732.225794033651, 6732.293109223461, 6262.75497506241, 6297.149884765589, 6326.0, 6342.619442833445, 6360.681965901686, 5703.0, 5774.191613174159, 5780.104083867007, 5852.356240813507, 5879.735411906389, 6886.070380498569, 6903.1716194057035, 6918.446524278146, 6929.93070069313, 6934.0, 5563.833085007456, 6481.319461456479, 6567.9014814776865, 6570.704318305783, 6631.502637302126, 6867.141607299088, 6927.376536111774, 6937.583744975318, 6941.132358455193, 6948.652567371712, 6332.30344662096, 6609.173853268341, 6613.437857782143, 6613.801585952429, 6616.900746488903, 6515.934840651533, 6640.90038649411, 6663.13379260693, 6704.061431399706, 6733.326667333227, 6440.710168042356, 6461.483081353575, 6474.4820414365795, 6474.611523308617, 6475.805725828232, 6280.591761535486, 6411.647359395091, 6414.61512309263, 6447.0, 6466.127072845105, 5314.707691077027, 6250.0, 6313.873722525615, 6325.493960483058, 6344.68276586178, 6448.871022579616, 6477.902831457626, 6487.124238227779, 6490.221173459026, 6491.578047426902, 6229.065640154013, 6328.841778955379, 6332.588381755171, 6343.714532846126, 6346.397092276226], "value": 6042.577366334596, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.2140038561051, 795.3915254830055, 805.750217432596, 1120.3837889160964, 1123.8876112388757, 26125.608115878276, 36339.0, 36714.26571468569, 36720.449193262124, 36786.448203276974, 38085.61914380855, 38370.42444363337, 38446.0, 38453.80773096131, 38453.80773096131, 5886.293644762613, 6009.819705408845, 8159.673613055471, 8338.332933365316, 8358.958205208966, 5021.246812978046, 6019.7893073742425, 6028.939710602904, 7342.706291748324, 8247.010358756928, 8274.586270686472, 8328.042275138376, 8340.708075217368, 8346.41575089744, 8420.200080992327, 8227.218414250636, 8285.54429506377, 8299.211574900375, 8325.542095184763, 8327.916720832805, 8150.38872084596, 8215.178482151798, 8220.301274391684, 8224.136465671078, 8230.670773169066, 36629.0, 36784.89645310645, 36788.816055919815, 36814.8159259202, 36861.631383686356, 3617.7467577269604, 3649.434337677664, 3654.0682126057686, 3656.232191239843, 3658.0, 29517.11448656544, 29580.8520957396, 29598.70401295981, 29627.111186664435, 29631.0, 3121.1416860363356, 3163.636181839072, 3187.569678093474, 3198.3763166182603, 3202.8558714857886, 224872.0, 294942.52528737433, 295056.52471737505, 296239.0, 296495.0, 48272.7586362073, 48324.7583762086, 48350.0, 48366.75816620894, 48367.51632483701, 50464.74767626138, 50489.242661360106, 50567.0, 50590.747046264536, 50718.985620287385, 11249.775004499865, 13513.459461621622, 13565.389557469938, 13575.932120339532, 13584.728305433837, 9621.567029483691, 10985.39580323074, 11000.174986876016, 11007.61473348429, 11015.173861960386, 10825.404602746767, 10872.728181795519, 10873.945630271955, 10881.12950963921, 10884.40135792539, 4641.828398734514, 5071.884185479189, 5776.768929242868, 5824.650520968756, 5831.358550559435, 991.2367477042637, 1029.5572903651353, 1030.8917563655857, 1068.71144790906, 1070.8982646648556, 23073.88463057674, 23206.883965580066, 24175.032998679857, 24239.0, 24258.51482970331, 1127.5997021057572, 1133.5975728616388, 1133.7732453509166, 1169.818678104895, 1184.496588949693, 12301.815472767916, 12383.62849114528, 12413.317267550372, 12419.75160496803, 12421.627351179479, 305965.0, 306027.0, 306342.0, 306942.0, 307003.0, 51629.741851291255, 51662.22506662403, 51684.741576291875, 51791.48208517942, 51835.704107396865, 1514.8182218134116, 1515.9696806064037, 1558.6570954390243, 1563.679445713626, 1567.2477210938814, 23628.0, 23766.287011389686, 23778.167764128866, 23834.761652383255, 23845.403864902823, 38593.63205071132, 38737.031574209745, 38777.4183387255, 38789.03027424337, 38837.6116238834, 263984.0, 264436.0, 264806.0, 264990.0, 265568.0, 30954.845225773726, 31684.5247321295, 32199.51700724444, 32337.676623233467, 32386.35227295488, 34962.776302829276, 35117.29765404729, 35915.46126808048, 43175.9206019852, 43181.56818431775, 26953.191404257905, 27180.0, 28451.28871778222, 29712.0, 29780.851095744383, 29250.0, 29371.265718357212, 29428.852855735586, 29692.81228750912, 29703.40593188081, 34149.82925085359, 34453.48319775155, 35688.286234275685, 35926.92219233427, 35954.10114747152, 28745.281367965967, 29081.0, 29448.558271625516, 29557.408851822413, 29718.55049006343, 21997.0, 22296.88851555732, 22482.550348993256, 23532.647010294517, 24594.75405245996], "value": 16779.217167883216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.8700576003125, 421.38477822379326, 438.5723919178801, 440.6937178660832, 443.62513675943825, 18668.813311866896, 20452.590948181027, 21159.942002899832, 21349.146034158653, 21366.03852826623, 20984.0, 22081.895905204714, 22373.44066398341, 22691.319260422213, 22799.43001424965, 5805.767769289223, 6078.604890682113, 6079.4528492435675, 6079.939200608003, 6086.208792856923, 5714.628549144313, 5885.4114588541015, 5947.732352044147, 5955.464008239258, 5958.672273024982, 5920.703964801743, 5920.993431116721, 5926.436988486109, 5931.258592675916, 5932.11018347247, 5845.123231515286, 5864.648121112726, 5881.647101173943, 6000.399960003964, 6013.037913933749, 4436.290193569013, 5260.92108618371, 5318.707471089088, 5333.2266821310695, 5334.866628334284, 21687.24094656695, 27039.594406083925, 27174.728252717417, 27966.385546384823, 28200.589970501394, 2168.0785666091847, 2202.5264568117773, 2247.5954328220914, 2284.8400611957168, 2284.954300913989, 17518.562035949075, 17922.641547169114, 18037.0, 18190.908545487313, 18264.90867545667, 1861.7579714637145, 2083.9687404688943, 2147.4201965469238, 2158.4280165756086, 2174.4563859035243, 146405.0, 156771.0, 162335.0, 166473.0, 169429.45855812295, 11721.88278117225, 11724.179307448567, 12075.698107547381, 12092.0, 12263.816042759367, 16163.515094547183, 16232.431864884673, 16258.268377923021, 16261.674766504604, 16289.104099274653, 7601.923980760122, 7749.41879359039, 8512.319014478951, 8768.0, 8903.599338029675, 8001.0, 8280.213379729037, 8287.12985136564, 8299.170082991652, 8444.788880278042, 7536.924630753732, 7695.807604809925, 7712.113106992655, 7713.807154821175, 7733.7679869604, 2066.8036536529007, 2074.2429013409997, 2078.4180429479466, 2085.5411809401908, 2249.752527222004, 952.5046975572664, 955.9245848420527, 960.13108137136, 977.5307852230969, 999.415342024909, 20135.597288054156, 20530.281440149523, 20599.485012874797, 20692.275770347966, 20860.763007614227, 956.8947415784259, 981.4454833019464, 1002.2182697495965, 1002.6340385759291, 1007.677543186188, 10257.58969641221, 10517.737056573647, 10588.0, 10624.946875265729, 10688.814929276145, 568515.0, 573933.0, 580722.0, 582812.0, 584355.0, 128083.0, 130582.0, 135144.0, 138221.0, 138875.30562347124, 1086.7065892209218, 1116.9776604468027, 1186.1815347410432, 1238.7274799544086, 1241.9565315214104, 20809.37571872846, 21489.03299351564, 21527.46181345479, 21783.564328713655, 21905.67141492847, 50887.74556127344, 53823.03973281507, 53876.73061634667, 54401.95442987454, 54890.0, 70841.0, 71498.64250678713, 71543.0, 72294.0, 73549.26450735424, 8442.704505342284, 8466.534340611326, 8529.14708529142, 8919.10808919103, 8929.508877011827, 11836.697963224211, 12741.299228542519, 13333.466661333827, 13576.253306068262, 14026.0, 11589.24669896454, 11744.94127529357, 11777.291223018925, 11868.82196767032, 12051.57819476314, 9572.473513956798, 10609.416482093251, 10758.70895492546, 11007.229493935347, 11173.217874748689, 11492.94253528727, 11785.469653865768, 12008.519659213534, 12033.819492707791, 12080.93959530232, 8267.83464330722, 8504.702335418231, 8553.786155346166, 8715.91284087151, 8762.561871906506, 9803.901960980298, 11234.382108984084, 11491.138164637518, 11799.0, 11845.76308473843], "value": 10257.065825905676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.3356187658665, 1448.3627204030226, 1485.688005518841, 1501.6020754500053, 1505.9096454212752, 9634.0, 10057.698269051922, 11428.771424571514, 11712.7657446851, 11714.121440891924, 11267.0, 11404.657860264184, 11405.600803971862, 11408.20142590019, 11433.942830285858, 2085.3326935380683, 2444.865532395722, 2488.552060629095, 2489.9377515562073, 2501.4246723253664, 2044.815966563009, 2343.8945247463903, 2504.3864253257975, 2512.6356678281636, 2520.0675749972534, 2183.967240491394, 2371.2293504610984, 2472.777450029506, 2481.404462928902, 2487.813413993949, 2404.759524047599, 2437.585610446228, 2439.8166889058793, 2440.8169387296025, 2448.179859746987, 2394.2761211927386, 2408.747081556429, 2422.176460003607, 2424.7211570669424, 2438.073532057824, 11430.599929002445, 11539.884601153964, 11565.94217028918, 11567.479463424166, 11577.247478913843, 6300.653464059475, 6546.509011824132, 6549.1158693576235, 6552.672366381662, 6553.541252112354, 3962.6631736302447, 4075.673946084306, 4163.895902602429, 4236.428082208893, 4245.448091748053, 1255.8430196225472, 1259.9559015434506, 1288.5747703257903, 1292.7349893271858, 1305.882470577643, 16487.093209873452, 16550.586235344093, 16553.83446165547, 16568.254428550623, 16588.170591470378, 4649.604783593432, 5687.744051517691, 5813.09896965971, 5849.883002340014, 5857.7949771757785, 13729.038967272196, 13738.038337316491, 13743.175409475463, 13749.381277842522, 13758.93120534411, 6606.8017959461295, 6607.2071351438135, 6608.339166083353, 6614.371634694792, 6623.105880706139, 5067.265246539231, 5964.373740757244, 6014.51883849291, 6073.0, 6089.695515224221, 4049.6962727795535, 4135.276326642826, 4152.460180176618, 4153.397757325171, 4155.854545090907, 1258.8615252322238, 1346.9191848488927, 1375.3604573873197, 1385.3696568061507, 1390.7496650602989, 790.2887401338726, 800.4676889868173, 817.207308910356, 818.975430737067, 844.1980118887082, 6018.307894592091, 6020.982970704776, 6226.283977342664, 6258.217722784652, 6275.843103922439, 868.8305780372766, 905.8912930448388, 947.5499137909576, 949.5299826585884, 952.0479520479521, 3934.409838524244, 4097.627294856197, 4099.959000410017, 4138.606832350922, 4267.637250833652, 12220.877791222152, 14655.633609159642, 15075.472358467401, 15232.695346093016, 15245.23773811305, 14516.274186290642, 15163.241837908061, 15167.848321516864, 15192.46826361072, 15302.387904483918, 8452.0, 8648.783780405414, 8656.480611163224, 8665.13348665141, 8666.306695464347, 5841.912371314349, 6714.664266786739, 6878.8624227516175, 7033.402160816183, 7063.788086357417, 13191.472341106248, 13367.131136476099, 13603.115797473132, 13625.318734063456, 13783.37974791157, 13495.39270732839, 13744.381502832597, 13765.38055787512, 13966.224558887976, 14016.509422170175, 9200.447973121634, 9300.628339773584, 9365.672201472917, 9432.858507122535, 9486.193673537551, 10454.215933804842, 10713.94643026811, 10715.35707857531, 10723.624673136403, 10726.088282496075, 8909.643614255358, 9147.725568232963, 9226.492542910204, 9275.304352173749, 9392.295577831554, 8950.418222815497, 8973.685920992733, 9064.954675226581, 9107.08929107084, 9127.0, 7973.083095444098, 8235.752927412188, 8350.916490835258, 8357.414980951275, 8358.373122015752, 5855.970720146372, 5938.554608404301, 5960.582759206987, 6066.181065556093, 6088.391160883876, 5944.048952167633, 5996.280446346466, 6070.3019152798, 6084.6349219047, 6098.146259523759], "value": 5356.761168855505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.2397381263659, 391.3581725969411, 395.6162522353316, 397.4614397491401, 403.036742186175, 5773.220615216945, 5796.536277097833, 5798.535622360501, 5833.620814647045, 5849.766009359626, 5418.512333889949, 5586.748596313166, 5671.901396483307, 5697.829065128053, 5707.115397113444, 4247.044415006614, 4254.638355739766, 4263.80613428239, 4279.122779830135, 4303.720258183208, 3902.2780785554623, 4264.658827293809, 4269.594388533084, 4273.551277115905, 4294.785260736966, 3842.558105817825, 3848.3073046851555, 4178.791060446981, 4239.3852891330735, 4273.636740877014, 3475.7219422446396, 4225.112726327475, 4234.491860976703, 4271.159678813585, 4272.807723652428, 3041.832699201543, 3648.233870887117, 3658.487811706363, 3668.3580373434543, 3683.778973261613, 4977.253411988195, 5269.288646032813, 5490.670559766427, 5589.888202235973, 5598.020346439397, 4374.518802931675, 4602.872296287431, 4619.953800461986, 4998.600111991068, 5036.622253330978, 5085.220172939478, 5332.573394128461, 6059.606125601866, 6131.846703832395, 6177.938220617782, 4008.3386241270155, 4138.52406973199, 4142.834286628531, 4152.833886644561, 4211.368294755781, 5285.682859028432, 6225.657588832567, 6338.626347820035, 6366.707985125351, 6428.71070801815, 3764.153065560282, 4123.670106391482, 4177.289860723684, 4183.309753890635, 4235.174141042467, 4288.957110428918, 4291.50647675515, 4308.827646894089, 4311.547287534827, 4313.719608225455, 4356.847510337123, 4444.0, 4652.651051171176, 4875.756682046126, 4915.26271059344, 5368.0, 6018.668973206428, 6096.75612975476, 6154.415330543591, 6225.719842607094, 1337.7592033434075, 1451.4629587052857, 1456.7960485532035, 1461.8099647045815, 1472.9263536823116, 832.6419639554929, 902.0348227396622, 930.3534043839602, 979.0601023017982, 987.8814542254976, 5781.508571771446, 5792.391798861143, 5831.88336233273, 5833.270841144857, 5859.912101318484, 6078.45293923549, 6174.9073763893575, 6320.304766475684, 6364.7135878885565, 6380.0, 5696.943030569724, 5723.484886360247, 5797.536197104221, 5803.883922321615, 5827.650340979555, 2730.866690323533, 3286.194882253863, 3308.619508756524, 3325.5011748237475, 3338.1139656094715, 4946.530079642428, 6327.778527751599, 6598.637074960923, 6653.833654158685, 6657.037618259925, 5522.944770552243, 5622.775088996476, 6162.753489860445, 6543.822112019787, 6642.86714265712, 5631.746571404296, 6543.70553325092, 6578.039882053, 6619.172603424572, 6676.933230667728, 6387.648679322682, 6404.0, 6404.1674582304, 6424.678766061772, 6434.710438030394, 5084.6440749147205, 6221.178671097395, 6273.435390814849, 6279.874402511833, 6331.9050214247745, 6345.96827015862, 6369.777057802955, 6386.425221730066, 6403.935960640334, 6528.902066469102, 3568.4290513517712, 3731.936398126521, 4214.388913607571, 4231.5556866529805, 4259.722083374913, 5068.417132029864, 5101.9489805101475, 5555.388907220284, 6383.489320854228, 6386.201724784402, 5811.883762324815, 6103.572749907464, 6142.570020098729, 6150.2927163375, 6150.692465376803, 5345.492178243061, 6109.0, 6109.236345456818, 6124.479419249414, 6128.387161283836, 4742.834000809955, 5508.55931525485, 5767.0, 5808.9958964157295, 6034.2155519782145, 6112.205413296421, 6143.784967526115, 6155.0759392486725, 6158.507319414346, 6187.752489900354, 5780.913286300793, 6006.468350570576, 6010.838890137469, 6037.305709843425, 6052.100605309863], "value": 4454.155826440005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.0822998816294, 847.8897743293371, 856.6915910272301, 856.8200677857645, 867.5185272173941, 16357.345706171755, 16584.502464926056, 16895.91552042238, 16896.83103168968, 16900.577485562866, 15348.002379845302, 16889.662206755856, 18092.909535452338, 18290.0, 18291.268349266014, 1002.0430488883118, 1023.145673362743, 1025.0467065628961, 1027.712240572641, 1029.521272608237, 1001.7896241789233, 1004.1765752083295, 1006.2402885821232, 1007.0584003956287, 1008.6520150548085, 1018.3228153278061, 1030.7062487191151, 1034.824079906414, 1035.4253389368898, 1067.6156583629886, 1011.3577878047493, 1017.5319353097584, 1020.9489525523694, 1022.1311884897815, 1040.2614143957799, 776.2431629161579, 776.2664282253273, 778.6846327237478, 778.9727359542445, 779.8440311937635, 16727.832721672872, 16837.747433788503, 16927.238274277686, 16961.915190424093, 17023.574410639834, 16830.747538786927, 17201.913990430094, 17315.567110822205, 17353.04558249296, 17607.207675654627, 13933.860661393357, 14105.153690778587, 14199.0, 14298.856091512655, 14318.212498312589, 3484.564429446319, 3503.1242189452637, 3504.56192975878, 3508.8947331580093, 3513.472979053137, 102514.48742756313, 125174.87062823412, 129372.35313823464, 130801.0, 133383.0, 13049.934750326187, 13192.802107968388, 13275.406951165922, 13419.194848309133, 13455.192688438725, 25550.361240968752, 25600.359991, 25845.612315815277, 26108.60837087445, 26193.95224191049, 7506.3244308012545, 7687.577183254863, 7727.1886451922865, 7796.805079873048, 7819.100803407568, 3916.686665066788, 3972.781497017634, 3998.660113890352, 4000.119973605802, 4000.259951908848, 4192.371144328315, 4247.97876010618, 4248.957510424918, 4612.838550650711, 4701.8354357598, 923.3628796130782, 936.2697096264924, 938.666773295484, 948.3882895532342, 948.6395169835556, 553.7895599672099, 653.7548419342746, 667.1260648550415, 676.2831398717375, 706.4666177036305, 11186.0, 11689.649310520697, 11901.821472677917, 12482.43829027696, 13255.734885302432, 663.2174034639172, 663.7709990053423, 667.5060455263167, 667.829703425633, 692.2869444472202, 5225.738713064332, 5506.559475241971, 5520.641158324696, 5563.276774019351, 5690.5163061140265, 94459.0, 97594.02405975992, 99670.0, 99699.50150249347, 101826.98173018324, 85688.01654957337, 87374.56312718395, 87575.0, 88768.5561572188, 89096.0, 78428.0, 79269.60365198253, 81714.59142704248, 82087.58956205181, 82433.58783206045, 9552.474613896302, 9669.70990870275, 9753.122219000325, 9782.364146330467, 10066.0, 37808.0, 39141.41287880627, 39378.60621393749, 39421.0, 39520.0, 49952.0, 50741.23888141755, 51148.74425627848, 51237.0, 51710.0, 11378.43107844588, 14213.857861421668, 14520.419183232552, 14520.709585808436, 14560.781588276397, 14739.631509212355, 14876.776848347066, 15022.849771502146, 15066.698666026838, 15148.0, 14176.929115354356, 14426.927865360605, 14576.344064517334, 14599.708005840037, 14683.632909177357, 14187.935904806975, 14400.783988240395, 14794.704105917606, 14800.407983680532, 14835.0, 14222.644433888821, 14277.500287489887, 14364.640883977983, 14428.42286308536, 14535.055221410574, 10599.311044782064, 11384.544618215179, 11577.189596728149, 11810.350430726392, 12326.876731232573, 12996.740065198454, 13871.583852484442, 13892.652683682989, 13903.582892513241, 13935.790963135358], "value": 8157.355667026218, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1437.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 111.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 141.0, 137.0, 149.0, 109.0, 108.0, 107.0, 104.0, 136.0, 109.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 181.0, 187.0, 183.0, 183.0, 182.0, 184.0, 184.0, 182.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 56.0, 87.0, 58.0, 71.0, 87.0, 86.0, 88.0, 58.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 84.0, 69.0, 67.0, 67.0, 89.0, 69.0, 67.0, 88.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 86.0, 86.0, 85.0, 87.0, 87.0, 87.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 83.0, 84.0, 84.0, 95.0, 127.0, 99.0, 84.0], "value": 91.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 48.0, 47.0, 49.0, 47.0, 48.0, 48.0, 49.0, 48.0], "value": 48.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 59.0, 56.0, 61.0, 64.0, 59.0, 56.0, 56.0, 54.0, 54.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 82.0, 81.0, 81.0, 82.0, 82.0, 81.0, 81.0, 80.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 136.0, 124.0, 143.0, 151.0, 133.0, 138.0, 127.0, 256.0, 158.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 233.0, 204.0, 193.0, 181.0, 182.0, 184.0, 184.0, 184.0, 183.0], "value": 191.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 65.0, 63.0, 67.0, 69.0, 69.0, 67.0], "value": 66.6, "unit": "score"}]}]} 10:51:43 INFO - Return code: 0 10:51:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:51:44 INFO - # TBPL SUCCESS # 10:51:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:51:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:51:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:51:44 INFO - 2017-05-04 10:51:44.085 screenresolution[1647:9939] starting screenresolution argv=screenresolution get 10:51:44 INFO - 2017-05-04 10:51:44.087 screenresolution[1647:9939] Display 0: 1600x1200x32@60 10:51:44 INFO - 2017-05-04 10:51:44.094 screenresolution[1648:9942] starting screenresolution argv=screenresolution list 10:51:44 INFO - Available Modes on Display 0 10:51:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:51:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:51:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:51:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:51:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:51:44 INFO - Intel Iris: 10:51:44 INFO - Chipset Model: Intel Iris 10:51:44 INFO - Type: GPU 10:51:44 INFO - Bus: Built-In 10:51:44 INFO - VRAM (Dynamic, Max): 1536 MB 10:51:44 INFO - Vendor: Intel (0x8086) 10:51:44 INFO - Device ID: 0x0a2e 10:51:44 INFO - Revision ID: 0x0009 10:51:44 INFO - Displays: 10:51:44 INFO - Display: 10:51:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:51:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:51:44 INFO - Display Serial Number: 1600x1200 60 10:51:44 INFO - Main Display: Yes 10:51:44 INFO - Mirror: Off 10:51:44 INFO - Online: Yes 10:51:44 INFO - Rotation: Supported 10:51:44 INFO - Return code: 0 10:51:44 INFO - Running post-action listener: _resource_record_post_action 10:51:44 INFO - [mozharness: 2017-05-04 17:51:44.338129Z] Finished run-tests step (success) 10:51:44 INFO - Running post-run listener: _resource_record_post_run 10:51:44 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 38901248; Write bytes: 510068224; Read time: 260; Write time: 1576 10:51:44 INFO - TinderboxPrint: CPU usage
53.2% 10:51:44 INFO - TinderboxPrint: I/O read bytes / time
38,901,248 / 260 10:51:44 INFO - TinderboxPrint: I/O write bytes / time
510,068,224 / 1,576 10:51:44 INFO - TinderboxPrint: CPU idle
2,244.1 (46.8%) 10:51:44 INFO - TinderboxPrint: CPU system
951.1 (19.8%) 10:51:44 INFO - TinderboxPrint: CPU user
1,602.3 (33.4%) 10:51:44 INFO - TinderboxPrint: Swap in / out
246,333,440 / 0 10:51:44 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 196950528; Write bytes: 195241984; Read time: 15087; Write time: 403 10:51:44 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 37893632; Write bytes: 297930240; Read time: 248; Write time: 1119 10:51:44 INFO - Running post-run listener: _upload_blobber_files 10:51:44 INFO - Blob upload gear active. 10:51:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:51:44 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 10:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:51:45 INFO - (blobuploader) - INFO - Open directory for files ... 10:51:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:51:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:51:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:46 INFO - (blobuploader) - INFO - Done attempting. 10:51:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:51:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:51:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:47 INFO - (blobuploader) - INFO - Done attempting. 10:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:51:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:48 INFO - (blobuploader) - INFO - Done attempting. 10:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:50 INFO - (blobuploader) - INFO - Done attempting. 10:51:50 INFO - (blobuploader) - INFO - Iteration through files over. 10:51:50 INFO - Return code: 0 10:51:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:51:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:51:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4137fad50c1d73da561da4f773f6da98689baae31b32dc785356892da0bf499384140749532a9076ce3a6de5f3f0a8d0ecf8852d334967d400870f77bdde0433", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/567977ddf349470ef15848e8d0a1196c79b5b3db30164512893e8abb4e9b11f68b56a05bbee46a11129a8875bb3007fcd5f3eab80a86218dfb7bc3be9f643c1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee0edc8603ea355cb7089659ffda575a1e3ae89df524b4d97af00e44a9709339804dda70275ec659bd5aabe3db19f8e4bafcd343b97666441ea7829b99c245d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bbde9df2c37d0f6ef86c7f70d732419c769b77da15eeb9f1f1872fdeff400cf3f786c6ee6f3d6b4c8d333fc414115ce91d08012e9c8e83aee25c9332748dd9b"} 10:51:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:51:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:51:50 INFO - Contents: 10:51:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4137fad50c1d73da561da4f773f6da98689baae31b32dc785356892da0bf499384140749532a9076ce3a6de5f3f0a8d0ecf8852d334967d400870f77bdde0433", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/567977ddf349470ef15848e8d0a1196c79b5b3db30164512893e8abb4e9b11f68b56a05bbee46a11129a8875bb3007fcd5f3eab80a86218dfb7bc3be9f643c1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee0edc8603ea355cb7089659ffda575a1e3ae89df524b4d97af00e44a9709339804dda70275ec659bd5aabe3db19f8e4bafcd343b97666441ea7829b99c245d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bbde9df2c37d0f6ef86c7f70d732419c769b77da15eeb9f1f1872fdeff400cf3f786c6ee6f3d6b4c8d333fc414115ce91d08012e9c8e83aee25c9332748dd9b"} 10:51:50 INFO - Running post-run listener: copy_logs_to_upload_dir 10:51:50 INFO - Copying logs to upload dir... 10:51:50 INFO - mkdir: /builds/slave/test/build/upload/logs 10:51:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.979678 ========= master_lag: 2.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-05-04 10:51:52.322180) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:51:52.329712) ========= 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.QdZkBL7n59/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.xIT1Zx2mPn/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/Firefox/sha512/4137fad50c1d73da561da4f773f6da98689baae31b32dc785356892da0bf499384140749532a9076ce3a6de5f3f0a8d0ecf8852d334967d400870f77bdde0433", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/567977ddf349470ef15848e8d0a1196c79b5b3db30164512893e8abb4e9b11f68b56a05bbee46a11129a8875bb3007fcd5f3eab80a86218dfb7bc3be9f643c1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee0edc8603ea355cb7089659ffda575a1e3ae89df524b4d97af00e44a9709339804dda70275ec659bd5aabe3db19f8e4bafcd343b97666441ea7829b99c245d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bbde9df2c37d0f6ef86c7f70d732419c769b77da15eeb9f1f1872fdeff400cf3f786c6ee6f3d6b4c8d333fc414115ce91d08012e9c8e83aee25c9332748dd9b"} build_url:https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4137fad50c1d73da561da4f773f6da98689baae31b32dc785356892da0bf499384140749532a9076ce3a6de5f3f0a8d0ecf8852d334967d400870f77bdde0433", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/567977ddf349470ef15848e8d0a1196c79b5b3db30164512893e8abb4e9b11f68b56a05bbee46a11129a8875bb3007fcd5f3eab80a86218dfb7bc3be9f643c1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee0edc8603ea355cb7089659ffda575a1e3ae89df524b4d97af00e44a9709339804dda70275ec659bd5aabe3db19f8e4bafcd343b97666441ea7829b99c245d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9bbde9df2c37d0f6ef86c7f70d732419c769b77da15eeb9f1f1872fdeff400cf3f786c6ee6f3d6b4c8d333fc414115ce91d08012e9c8e83aee25c9332748dd9b"}' ========= master_lag: 0.65 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:51:52.994228) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:51:52.994574) ========= 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.QdZkBL7n59/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.xIT1Zx2mPn/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.005140 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:51:53.023025) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:51:53.023350) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:51:53.023798) ========= ========= Total master_lag: 2.85 =========