builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0329 starttime: 1485313111.88 results: success (0) buildid: 20170117083128 builduid: 766930557a084bc7938a387b284f4528 revision: 6a23526fe5168087d7e4132c0705aefcaed5f571 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:31.878669) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:31.879018) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:31.879284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:31.925931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:31.926189) ========= 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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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-01-24 18:58:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2017-01-24 18:58:32 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144937 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.096596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.096964) ========= 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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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.025074 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.145803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 18:58:32.146167) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6a23526fe5168087d7e4132c0705aefcaed5f571 --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 6a23526fe5168087d7e4132c0705aefcaed5f571 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.y2fdNSUFoO/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.dbHAwlJvAX/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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-01-24 18:58:32,256 truncating revision to first 12 chars 2017-01-24 18:58:32,256 Setting DEBUG logging. 2017-01-24 18:58:32,256 attempt 1/10 2017-01-24 18:58:32,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6a23526fe516?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 18:58:33,461 unpacking tar archive at: mozilla-central-6a23526fe516/testing/mozharness/ program finished with exit code 0 elapsedTime=1.464424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 18:58:33.634477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:33.634828) ========= script_repo_revision: 6a23526fe5168087d7e4132c0705aefcaed5f571 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:33.635219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:33.635480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:33.656279) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-01-24 18:58:33.656723) ========= /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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:58:33 INFO - MultiFileLogger online at 20170124 18:58:33 in /builds/slave/test 18:58:33 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 18:58:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:58:33 INFO - {'append_to_log': False, 18:58:33 INFO - 'base_work_dir': '/builds/slave/test', 18:58:33 INFO - 'blob_upload_branch': 'Firefox', 18:58:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:58:33 INFO - 'branch': 'Firefox', 18:58:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:58:33 INFO - 'config_files': ('talos/mac_config.py',), 18:58:33 INFO - 'default_actions': ('clobber', 18:58:33 INFO - 'read-buildbot-config', 18:58:33 INFO - 'download-and-extract', 18:58:33 INFO - 'populate-webroot', 18:58:33 INFO - 'create-virtualenv', 18:58:33 INFO - 'install', 18:58:33 INFO - 'run-tests'), 18:58:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:58:33 INFO - 'download_minidump_stackwalk': True, 18:58:33 INFO - 'download_symbols': 'ondemand', 18:58:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:58:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:58:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:58:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:58:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:58:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:58:33 INFO - 'installer_path': 'installer.exe', 18:58:33 INFO - 'log_level': 'info', 18:58:33 INFO - 'log_name': 'talos', 18:58:33 INFO - 'log_to_console': True, 18:58:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:58:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:58:33 INFO - 'opt_config_files': (), 18:58:33 INFO - 'pip_index': False, 18:58:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:58:33 INFO - 'cmd': ('bash', 18:58:33 INFO - '-c', 18:58:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:58:33 INFO - 'enabled': True, 18:58:33 INFO - 'halt_on_failure': False, 18:58:33 INFO - 'name': 'check_screen_resolution'},), 18:58:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:58:33 INFO - 'cmd': ('bash', 18:58:33 INFO - '-c', 18:58:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:58:33 INFO - 'enabled': True, 18:58:33 INFO - 'halt_on_failure': False, 18:58:33 INFO - 'name': 'check_screen_resolution'},), 18:58:33 INFO - 'run_cmd_checks_enabled': True, 18:58:33 INFO - 'sps_profile': False, 18:58:33 INFO - 'sps_profile_interval': 0, 18:58:33 INFO - 'suite': 'dromaeojs', 18:58:33 INFO - 'system_bits': '32', 18:58:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:58:33 INFO - 'title': 't-yosemite-r7-0329', 18:58:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:58:33 INFO - 'use_talos_json': True, 18:58:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:58:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:58:33 INFO - 'work_dir': 'build'} 18:58:33 INFO - [mozharness: 2017-01-25 02:58:33.875330Z] Running clobber step. 18:58:33 INFO - Running pre-action listener: _resource_record_pre_action 18:58:33 INFO - Running main action method: clobber 18:58:33 INFO - rmtree: /builds/slave/test/build 18:58:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:58:36 INFO - Running post-action listener: _resource_record_post_action 18:58:36 INFO - [mozharness: 2017-01-25 02:58:36.343036Z] Finished clobber step (success) 18:58:36 INFO - [mozharness: 2017-01-25 02:58:36.343161Z] Running read-buildbot-config step. 18:58:36 INFO - Running pre-action listener: _resource_record_pre_action 18:58:36 INFO - Running main action method: read_buildbot_config 18:58:36 INFO - Using buildbot properties: 18:58:36 INFO - { 18:58:36 INFO - "project": "", 18:58:36 INFO - "product": "firefox", 18:58:36 INFO - "script_repo_revision": "production", 18:58:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:58:36 INFO - "repository": "", 18:58:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:58:36 INFO - "buildid": "20170117083128", 18:58:36 INFO - "pgo_build": "False", 18:58:36 INFO - "basedir": "/builds/slave/test", 18:58:36 INFO - "buildnumber": 29, 18:58:36 INFO - "slavename": "t-yosemite-r7-0329", 18:58:36 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 18:58:36 INFO - "platform": "yosemite_r7", 18:58:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:58:36 INFO - "branch": "mozilla-central", 18:58:36 INFO - "repo_path": "mozilla-central", 18:58:36 INFO - "revision": "6a23526fe5168087d7e4132c0705aefcaed5f571", 18:58:36 INFO - "stage_platform": "macosx64", 18:58:36 INFO - "builduid": "766930557a084bc7938a387b284f4528", 18:58:36 INFO - "slavebuilddir": "test" 18:58:36 INFO - } 18:58:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 18:58:36 INFO - Running post-action listener: _resource_record_post_action 18:58:36 INFO - [mozharness: 2017-01-25 02:58:36.346693Z] Finished read-buildbot-config step (success) 18:58:36 INFO - [mozharness: 2017-01-25 02:58:36.346811Z] Running download-and-extract step. 18:58:36 INFO - Running pre-action listener: _resource_record_pre_action 18:58:36 INFO - Running main action method: download_and_extract 18:58:36 INFO - mkdir: /builds/slave/test/build/tests 18:58: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')]} 18:58:36 INFO - trying https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:36 INFO - Downloading https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 18:58:36 INFO - Downloaded 1199 bytes. 18:58:36 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:36 INFO - Using the following test package requirements: 18:58:36 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:58:36 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:36 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 18:58:36 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:36 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 18:58:36 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:36 INFO - u'jsshell-mac.zip'], 18:58:36 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:36 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 18:58:36 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:58:36 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:36 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 18:58:36 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:36 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 18:58:36 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:36 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 18:58:36 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:36 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 18:58:36 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:58:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:58:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:58:36 INFO - Fetch https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:58:37 INFO - Expected file size: 16326298 18:58:37 INFO - Obtained file size: 16326298 18:58:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:58:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 18:58:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:58:44 INFO - Fetch https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 18:58:45 INFO - Expected file size: 16326298 18:58:45 INFO - Obtained file size: 16326298 18:58:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 18:58:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:58:51 INFO - Fetch https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 18:58:53 INFO - Expected file size: 14403463 18:58:53 INFO - Obtained file size: 14403463 18:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:53 INFO - trying https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:58:53 INFO - Downloading https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 18:58:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 18:58:56 INFO - Downloaded 70132302 bytes. 18:58:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:58:56 INFO - mkdir: /builds/slave/test/properties 18:58:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:58:56 INFO - Writing to file /builds/slave/test/properties/build_url 18:58:56 INFO - Contents: 18:58:56 INFO - build_url:https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 18:58:56 INFO - Running post-action listener: _resource_record_post_action 18:58:56 INFO - Running post-action listener: set_extra_try_arguments 18:58:56 INFO - [mozharness: 2017-01-25 02:58:56.962443Z] Finished download-and-extract step (success) 18:58:56 INFO - [mozharness: 2017-01-25 02:58:56.962615Z] Running populate-webroot step. 18:58:56 INFO - Running pre-action listener: _resource_record_pre_action 18:58:56 INFO - Running main action method: populate_webroot 18:58:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:58:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:58:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:58:56 INFO - '--tppagecycles', 18:58:56 INFO - '7'], 18:58:56 INFO - 'tests': ['tsvgm']}}, 18:58:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:58:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:58:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:58:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:58:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['damp', 'tps']}, 18:58:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'tests': ['damp', 'tps']}, 18:58:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['dromaeo_dom']}, 18:58:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:58:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['basic_compositor_video']}, 18:58:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:58:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'other-e10s': {'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['a11yr', 18:58:56 INFO - 'ts_paint', 18:58:56 INFO - 'tpaint', 18:58:56 INFO - 'sessionrestore', 18:58:56 INFO - 'sessionrestore_no_auto_restore', 18:58:56 INFO - 'tabpaint']}, 18:58:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['tsvgx', 18:58:56 INFO - 'tsvgr_opacity', 18:58:56 INFO - 'tart', 18:58:56 INFO - 'tscrollx', 18:58:56 INFO - 'cart', 18:58:56 INFO - 'tsvg_static']}, 18:58:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:58:56 INFO - 'tsvgr_opacity', 18:58:56 INFO - 'tart', 18:58:56 INFO - 'tscrollx', 18:58:56 INFO - 'cart', 18:58:56 INFO - 'tsvg_static']}, 18:58:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'talos_options': ['--disable-e10s'], 18:58:56 INFO - 'tests': ['tp5o']}, 18:58:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:58:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'talos_options': ['--disable-e10s', 18:58:56 INFO - '--xperf_path', 18:58:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:56 INFO - 'tests': ['tp5n']}, 18:58:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:58:56 INFO - 'talos_options': ['--xperf_path', 18:58:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:56 INFO - 'tests': ['tp5n']}}, 18:58:56 INFO - 'talos.zip': {'path': '', 18:58:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:58:56 INFO - Running post-action listener: _resource_record_post_action 18:58:56 INFO - [mozharness: 2017-01-25 02:58:56.981297Z] Finished populate-webroot step (success) 18:58:56 INFO - [mozharness: 2017-01-25 02:58:56.981399Z] Running create-virtualenv step. 18:58:56 INFO - Running pre-action listener: _resource_record_pre_action 18:58:56 INFO - Running main action method: create_virtualenv 18:58:56 INFO - Creating virtualenv /builds/slave/test/build/venv 18:58:56 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 18:58:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:58:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:58:57 INFO - Using real prefix '/tools/python27' 18:58:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:58:57 INFO - Installing distribute.............................................................................................................................................................................................done. 18:59:00 INFO - Installing pip.................done. 18:59:00 INFO - Return code: 0 18:59:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:59:00 INFO - Reading from file tmpfile_stdout 18:59:00 INFO - Output received: 18:59:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:59:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:01 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')]} 18:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:01 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 0x102970b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102973768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ab57c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, '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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:59:01 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 18:59:01 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 18:59:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:01 INFO - 'HOME': '/Users/cltbld', 18:59:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:01 INFO - 'LOGNAME': 'cltbld', 18:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:01 INFO - 'MOZ_NO_REMOTE': '1', 18:59:01 INFO - 'NO_EM_RESTART': '1', 18:59:01 INFO - 'PAGER': '/bin/cat', 18:59:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:01 INFO - 'PWD': '/builds/slave/test', 18:59:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:01 INFO - 'SHELL': '/bin/bash', 18:59:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:01 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:01 INFO - 'USER': 'cltbld', 18:59:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:01 INFO - 'XPC_FLAGS': '0x0', 18:59:01 INFO - 'XPC_SERVICE_NAME': '0', 18:59:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:01 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 18:59:01 INFO - Cleaning up... 18:59:01 INFO - Return code: 0 18:59:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:59:01 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')]} 18:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:02 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 0x102970b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102973768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ab57c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, '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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:59:02 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 18:59:02 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 18:59:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:02 INFO - 'HOME': '/Users/cltbld', 18:59:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:02 INFO - 'LOGNAME': 'cltbld', 18:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:02 INFO - 'MOZ_NO_REMOTE': '1', 18:59:02 INFO - 'NO_EM_RESTART': '1', 18:59:02 INFO - 'PAGER': '/bin/cat', 18:59:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:02 INFO - 'PWD': '/builds/slave/test', 18:59:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:02 INFO - 'SHELL': '/bin/bash', 18:59:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:02 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:02 INFO - 'USER': 'cltbld', 18:59:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:02 INFO - 'XPC_FLAGS': '0x0', 18:59:02 INFO - 'XPC_SERVICE_NAME': '0', 18:59:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:02 INFO - Downloading/unpacking psutil>=3.1.1 18:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:59:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:06 INFO - Installing collected packages: psutil 18:59:06 INFO - Running setup.py install for psutil 18:59:06 INFO - building 'psutil._psutil_osx' extension 18:59:06 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 18:59:07 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 18:59:07 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 18:59:07 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 18:59:07 INFO - building 'psutil._psutil_posix' extension 18:59:07 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 18:59:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:59:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:59:07 INFO - ^ 18:59:07 INFO - 1 warning generated. 18:59:07 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 18:59:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:08 INFO - Successfully installed psutil 18:59:08 INFO - Cleaning up... 18:59:08 INFO - Return code: 0 18:59:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:59:08 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')]} 18:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:08 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')]} 18:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:08 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 0x102970b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102973768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ab57c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, '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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:59:08 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 18:59:08 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 18:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:08 INFO - 'HOME': '/Users/cltbld', 18:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:08 INFO - 'LOGNAME': 'cltbld', 18:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:08 INFO - 'MOZ_NO_REMOTE': '1', 18:59:08 INFO - 'NO_EM_RESTART': '1', 18:59:08 INFO - 'PAGER': '/bin/cat', 18:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:08 INFO - 'PWD': '/builds/slave/test', 18:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:08 INFO - 'SHELL': '/bin/bash', 18:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:08 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:08 INFO - 'USER': 'cltbld', 18:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:08 INFO - 'XPC_FLAGS': '0x0', 18:59:08 INFO - 'XPC_SERVICE_NAME': '0', 18:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:59:08 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 18:59:08 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 18:59:08 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 18:59:08 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 18:59:08 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 18:59:08 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 18:59:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:59:11 INFO - Installing collected packages: mozsystemmonitor 18:59:11 INFO - Running setup.py install for mozsystemmonitor 18:59:11 INFO - Successfully installed mozsystemmonitor 18:59:11 INFO - Cleaning up... 18:59:11 INFO - Return code: 0 18:59:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:59:11 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')]} 18:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:11 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')]} 18:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:11 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 0x102970b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102973768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ab57c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, '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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:59:11 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 18:59:11 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 18:59:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:11 INFO - 'HOME': '/Users/cltbld', 18:59:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:11 INFO - 'LOGNAME': 'cltbld', 18:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:11 INFO - 'MOZ_NO_REMOTE': '1', 18:59:11 INFO - 'NO_EM_RESTART': '1', 18:59:11 INFO - 'PAGER': '/bin/cat', 18:59:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:11 INFO - 'PWD': '/builds/slave/test', 18:59:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:11 INFO - 'SHELL': '/bin/bash', 18:59:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:11 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:11 INFO - 'USER': 'cltbld', 18:59:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:11 INFO - 'XPC_FLAGS': '0x0', 18:59:11 INFO - 'XPC_SERVICE_NAME': '0', 18:59:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:11 INFO - Downloading/unpacking jsonschema==2.5.1 18:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:59:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:59:14 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 18:59:14 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 18:59:14 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 18:59:14 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 18:59:14 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 18:59:14 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 18:59:14 INFO - Downloading functools32-3.2.3-2.tar.gz 18:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:59:14 INFO - warning: no files found matching '*.txt' 18:59:14 INFO - no previously-included directories found matching 'build' 18:59:14 INFO - no previously-included directories found matching 'dist' 18:59:14 INFO - no previously-included directories found matching '.git*' 18:59:14 INFO - Installing collected packages: jsonschema, functools32 18:59:14 INFO - Running setup.py install for functools32 18:59:14 INFO - warning: no files found matching '*.txt' 18:59:14 INFO - no previously-included directories found matching 'build' 18:59:14 INFO - no previously-included directories found matching 'dist' 18:59:14 INFO - no previously-included directories found matching '.git*' 18:59:14 INFO - Successfully installed jsonschema functools32 18:59:14 INFO - Cleaning up... 18:59:14 INFO - Return code: 0 18:59:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:14 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 0x102970b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102973768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ab57c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, '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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:59:14 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 18:59:14 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 18:59:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:14 INFO - 'HOME': '/Users/cltbld', 18:59:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:14 INFO - 'LOGNAME': 'cltbld', 18:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:14 INFO - 'MOZ_NO_REMOTE': '1', 18:59:14 INFO - 'NO_EM_RESTART': '1', 18:59:14 INFO - 'PAGER': '/bin/cat', 18:59:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:14 INFO - 'PWD': '/builds/slave/test', 18:59:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:14 INFO - 'SHELL': '/bin/bash', 18:59:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:14 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:14 INFO - 'USER': 'cltbld', 18:59:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:14 INFO - 'XPC_FLAGS': '0x0', 18:59:14 INFO - 'XPC_SERVICE_NAME': '0', 18:59:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:59:15 INFO - Cleaning up... 18:59:15 INFO - Return code: 0 18:59:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59:15 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')]} 18:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:15 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')]} 18:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:15 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 0x102970b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102973768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ab57c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, '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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:59:15 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 18:59:15 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 18:59:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:15 INFO - 'HOME': '/Users/cltbld', 18:59:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:15 INFO - 'LOGNAME': 'cltbld', 18:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:15 INFO - 'MOZ_NO_REMOTE': '1', 18:59:15 INFO - 'NO_EM_RESTART': '1', 18:59:15 INFO - 'PAGER': '/bin/cat', 18:59:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:15 INFO - 'PWD': '/builds/slave/test', 18:59:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:15 INFO - 'SHELL': '/bin/bash', 18:59:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:15 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:15 INFO - 'USER': 'cltbld', 18:59:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:15 INFO - 'XPC_FLAGS': '0x0', 18:59:15 INFO - 'XPC_SERVICE_NAME': '0', 18:59:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:15 INFO - Downloading/unpacking blobuploader==1.2.4 18:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:18 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 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 18:59:18 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 18:59:19 INFO - Downloading docopt-0.6.1.tar.gz 18:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:59:19 INFO - Installing collected packages: blobuploader, requests, docopt 18:59:19 INFO - Running setup.py install for blobuploader 18:59:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:59:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:59:19 INFO - Running setup.py install for requests 18:59:20 INFO - Running setup.py install for docopt 18:59:20 INFO - Successfully installed blobuploader requests docopt 18:59:20 INFO - Cleaning up... 18:59:20 INFO - Return code: 0 18:59:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:20 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')]} 18:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:20 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')]} 18:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:20 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 0x102970b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102973768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ab57c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, '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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:59:20 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 18:59:20 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 18:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:20 INFO - 'HOME': '/Users/cltbld', 18:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:20 INFO - 'LOGNAME': 'cltbld', 18:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:20 INFO - 'MOZ_NO_REMOTE': '1', 18:59:20 INFO - 'NO_EM_RESTART': '1', 18:59:20 INFO - 'PAGER': '/bin/cat', 18:59:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:20 INFO - 'PWD': '/builds/slave/test', 18:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:20 INFO - 'SHELL': '/bin/bash', 18:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:20 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:20 INFO - 'USER': 'cltbld', 18:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:20 INFO - 'XPC_FLAGS': '0x0', 18:59:20 INFO - 'XPC_SERVICE_NAME': '0', 18:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:20 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-LS2hdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:20 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-78NOq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:20 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-yzQEZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:20 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-obbtGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:20 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-C9UjiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:21 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-cseVsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:21 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-sfot_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:21 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Rwucnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:21 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-OlsEMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:21 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-qu6NBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:21 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Hczxrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:21 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-0dqefv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:21 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-vy43Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:21 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-mzoWdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:22 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-bpxNtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:22 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-xuGqjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:22 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Qprezn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:59:22 INFO - Running setup.py install for manifestparser 18:59:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Running setup.py install for mozcrash 18:59:22 INFO - Running setup.py install for mozdebug 18:59:22 INFO - Running setup.py install for mozdevice 18:59:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Running setup.py install for mozfile 18:59:23 INFO - Running setup.py install for mozhttpd 18:59:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:59:23 INFO - Running setup.py install for mozinfo 18:59:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:59:23 INFO - Running setup.py install for mozInstall 18:59:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:59:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:59:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:59:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:59:23 INFO - Running setup.py install for mozleak 18:59:23 INFO - Running setup.py install for mozlog 18:59:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:59:23 INFO - Running setup.py install for moznetwork 18:59:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:59:23 INFO - Running setup.py install for mozprocess 18:59:24 INFO - Running setup.py install for mozprofile 18:59:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Running setup.py install for mozrunner 18:59:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Running setup.py install for mozscreenshot 18:59:24 INFO - Running setup.py install for moztest 18:59:24 INFO - Running setup.py install for mozversion 18:59:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:59:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:59:24 INFO - Cleaning up... 18:59:24 INFO - Return code: 0 18:59:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:24 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 0x102970b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102973768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ab57c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, '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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:59:24 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 18:59:24 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 18:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:24 INFO - 'HOME': '/Users/cltbld', 18:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:24 INFO - 'LOGNAME': 'cltbld', 18:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:24 INFO - 'MOZ_NO_REMOTE': '1', 18:59:24 INFO - 'NO_EM_RESTART': '1', 18:59:24 INFO - 'PAGER': '/bin/cat', 18:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:24 INFO - 'PWD': '/builds/slave/test', 18:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:24 INFO - 'SHELL': '/bin/bash', 18:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:24 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:24 INFO - 'USER': 'cltbld', 18:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:24 INFO - 'XPC_FLAGS': '0x0', 18:59:24 INFO - 'XPC_SERVICE_NAME': '0', 18:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:25 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-NOKv8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:25 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)) 18:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:25 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-bbB2PO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:25 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)) 18:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:25 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-SXUTHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:25 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)) 18:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:25 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-FpT2NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 18:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:25 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-3meUZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:25 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)) 18:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:25 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-G_p99z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:25 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)) 18:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:25 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-tGCX2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:25 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)) 18:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:25 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-cI2pZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:25 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)) 18:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:25 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-bcrO6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:26 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-TrPwLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:26 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-Rhr461-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:26 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-MhBZyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:26 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-jVHC6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:26 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-sN2IEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:26 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-DuFMgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:26 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-4DUJyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:26 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)) 18:59:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:26 INFO - Running setup.py (path:/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/pip-7TaM5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:26 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)) 18:59:26 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)) 18:59:26 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)) 18:59:26 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)) 18:59:26 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:59:26 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:59:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:29 INFO - Downloading blessings-1.6.tar.gz 18:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:59:29 INFO - Installing collected packages: blessings 18:59:29 INFO - Running setup.py install for blessings 18:59:29 INFO - Successfully installed blessings 18:59:29 INFO - Cleaning up... 18:59:30 INFO - Return code: 0 18:59:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:59:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:30 INFO - Reading from file tmpfile_stdout 18:59:30 INFO - Current package versions: 18:59:30 INFO - blessings == 1.6 18:59:30 INFO - blobuploader == 1.2.4 18:59:30 INFO - docopt == 0.6.1 18:59:30 INFO - functools32 == 3.2.3-2 18:59:30 INFO - jsonschema == 2.5.1 18:59:30 INFO - manifestparser == 1.1 18:59:30 INFO - mozInstall == 1.12 18:59:30 INFO - mozcrash == 1.0 18:59:30 INFO - mozdebug == 0.1 18:59:30 INFO - mozdevice == 0.49 18:59:30 INFO - mozfile == 1.2 18:59:30 INFO - mozhttpd == 0.7 18:59:30 INFO - mozinfo == 0.9 18:59:30 INFO - mozleak == 0.1 18:59:30 INFO - mozlog == 3.4 18:59:30 INFO - moznetwork == 0.27 18:59:30 INFO - mozprocess == 0.24 18:59:30 INFO - mozprofile == 0.28 18:59:30 INFO - mozrunner == 6.13 18:59:30 INFO - mozscreenshot == 0.1 18:59:30 INFO - mozsystemmonitor == 0.3 18:59:30 INFO - moztest == 0.8 18:59:30 INFO - mozversion == 1.4 18:59:30 INFO - psutil == 3.1.1 18:59:30 INFO - requests == 1.2.3 18:59:30 INFO - wsgiref == 0.1.2 18:59:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:30 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')]} 18:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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')]} 18:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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 0x102970b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102973768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ab57c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, '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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:59:30 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 18:59:30 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 18:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:30 INFO - 'HOME': '/Users/cltbld', 18:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:30 INFO - 'LOGNAME': 'cltbld', 18:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:30 INFO - 'MOZ_NO_REMOTE': '1', 18:59:30 INFO - 'NO_EM_RESTART': '1', 18:59:30 INFO - 'PAGER': '/bin/cat', 18:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:30 INFO - 'PWD': '/builds/slave/test', 18:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:30 INFO - 'SHELL': '/bin/bash', 18:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:30 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:30 INFO - 'USER': 'cltbld', 18:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:30 INFO - 'XPC_FLAGS': '0x0', 18:59:30 INFO - 'XPC_SERVICE_NAME': '0', 18:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:30 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)) 18:59:30 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)) 18:59:30 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)) 18:59:30 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)) 18:59:30 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)) 18:59:30 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)) 18:59:30 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)) 18:59:30 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)) 18:59:30 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)) 18:59:30 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)) 18:59:30 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)) 18:59:30 INFO - Cleaning up... 18:59:30 INFO - Return code: 0 18:59:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:59:30 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')]} 18:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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')]} 18:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:30 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 0x102970b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102973768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86ab57c3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, '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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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 18:59:30 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 18:59:30 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 18:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:30 INFO - 'HOME': '/Users/cltbld', 18:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:30 INFO - 'LOGNAME': 'cltbld', 18:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:30 INFO - 'MOZ_NO_REMOTE': '1', 18:59:30 INFO - 'NO_EM_RESTART': '1', 18:59:30 INFO - 'PAGER': '/bin/cat', 18:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:30 INFO - 'PWD': '/builds/slave/test', 18:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:30 INFO - 'SHELL': '/bin/bash', 18:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:30 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:30 INFO - 'USER': 'cltbld', 18:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:30 INFO - 'XPC_FLAGS': '0x0', 18:59:30 INFO - 'XPC_SERVICE_NAME': '0', 18:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:59:30 INFO - Cleaning up... 18:59:30 INFO - Return code: 0 18:59:30 INFO - Running post-action listener: _resource_record_post_action 18:59:30 INFO - Running post-action listener: _start_resource_monitoring 18:59:30 INFO - Starting resource monitoring. 18:59:30 INFO - [mozharness: 2017-01-25 02:59:30.851155Z] Finished create-virtualenv step (success) 18:59:30 INFO - [mozharness: 2017-01-25 02:59:30.852130Z] Running install step. 18:59:30 INFO - Running pre-action listener: _resource_record_pre_action 18:59:30 INFO - Running main action method: install 18:59:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:31 INFO - Reading from file tmpfile_stdout 18:59:31 INFO - Detecting whether we're running mozinstall >=1.0... 18:59:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:59:31 INFO - Reading from file tmpfile_stdout 18:59:31 INFO - Output received: 18:59:31 INFO - Usage: mozinstall [options] installer 18:59:31 INFO - Options: 18:59:31 INFO - -h, --help show this help message and exit 18:59:31 INFO - -d DEST, --destination=DEST 18:59:31 INFO - Directory to install application into. [default: 18:59:31 INFO - "/builds/slave/test"] 18:59:31 INFO - --app=APP Application being installed. [default: firefox] 18:59:31 INFO - mkdir: /builds/slave/test/build/application 18:59:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:59:53 INFO - Reading from file tmpfile_stdout 18:59:53 INFO - Output received: 18:59:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:59:53 INFO - Running post-action listener: _resource_record_post_action 18:59:53 INFO - [mozharness: 2017-01-25 02:59:53.288696Z] Finished install step (success) 18:59:53 INFO - [mozharness: 2017-01-25 02:59:53.288839Z] Running run-tests step. 18:59:53 INFO - Running pre-action listener: _resource_record_pre_action 18:59:53 INFO - Running main action method: run_tests 18:59:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:59:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:59:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:59:53 INFO - 2017-01-24 18:59:53.303 screenresolution[1632:7472] starting screenresolution argv=screenresolution get 18:59:53 INFO - 2017-01-24 18:59:53.306 screenresolution[1632:7472] Display 0: 1600x1200x32@60 18:59:53 INFO - 2017-01-24 18:59:53.311 screenresolution[1633:7474] starting screenresolution argv=screenresolution list 18:59:53 INFO - Available Modes on Display 0 18:59:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:59:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:59:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:59:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:59:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:59:53 INFO - Intel Iris: 18:59:53 INFO - Chipset Model: Intel Iris 18:59:53 INFO - Type: GPU 18:59:53 INFO - Bus: Built-In 18:59:53 INFO - VRAM (Dynamic, Max): 1536 MB 18:59:53 INFO - Vendor: Intel (0x8086) 18:59:53 INFO - Device ID: 0x0a2e 18:59:53 INFO - Revision ID: 0x0009 18:59:53 INFO - Displays: 18:59:53 INFO - Display: 18:59:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:59:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:59:53 INFO - Display Serial Number: 1600x1200 60 18:59:53 INFO - Main Display: Yes 18:59:53 INFO - Mirror: Off 18:59:53 INFO - Online: Yes 18:59:53 INFO - Rotation: Supported 18:59:53 INFO - Return code: 0 18:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:59:53 INFO - Python 2.7.3 18:59:53 INFO - Return code: 0 18:59:53 INFO - grabbing minidump binary from tooltool 18:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10274ed30>, '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 0x102675db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102743be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:59:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:59:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:59:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:59:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:59:53 INFO - Return code: 0 18:59:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:59:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:59:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:59:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:59:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:59:53 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/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0329', '--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 18:59:53 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/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0329 --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 18:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.y2fdNSUFoO/Render', 18:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:53 INFO - 'HOME': '/Users/cltbld', 18:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:53 INFO - 'LOGNAME': 'cltbld', 18:59:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:59:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:53 INFO - 'MOZ_NO_REMOTE': '1', 18:59:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:59:53 INFO - 'NO_EM_RESTART': '1', 18:59:53 INFO - 'PAGER': '/bin/cat', 18:59:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:53 INFO - 'PWD': '/builds/slave/test', 18:59:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:53 INFO - 'SHELL': '/bin/bash', 18:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dbHAwlJvAX/Listeners', 18:59:53 INFO - 'TMPDIR': '/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/', 18:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:53 INFO - 'USER': 'cltbld', 18:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:53 INFO - 'XPC_FLAGS': '0x0', 18:59:53 INFO - 'XPC_SERVICE_NAME': '0', 18:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:53 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/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0329', '--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 18:59:53 INFO - mozversion application_buildid: 20170117083128 18:59:53 INFO - mozversion application_changeset: 6a23526fe5168087d7e4132c0705aefcaed5f571 18:59:53 INFO - mozversion application_display_name: Nightly 18:59:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:59:53 INFO - mozversion application_name: Firefox 18:59:53 INFO - mozversion application_remotingname: firefox 18:59:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:59:53 INFO - mozversion application_vendor: Mozilla 18:59:53 INFO - mozversion application_version: 53.0a1 18:59:53 INFO - mozversion platform_buildid: 20170117083128 18:59:53 INFO - mozversion platform_changeset: 6a23526fe5168087d7e4132c0705aefcaed5f571 18:59:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:59:53 INFO - mozversion platform_version: 53.0a1 18:59:53 INFO - using testdate: 1485313193 18:59:53 INFO - actual date: 1485313193 18:59:53 INFO - starting webserver on 'localhost:49245' 18:59:53 INFO - SUITE-START | Running 2 tests 18:59:53 INFO - TEST-START | dromaeo_css 18:59:53 INFO - operating with platform_type : mac_ 18:59:53 INFO - Initialising browser for dromaeo_css test... 18:59:53 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmpjHh8vc/profile http://localhost:49245/getInfo.html) 18:59:56 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 18:59:56 INFO - PROCESS | 1643 | colorDepth:24 18:59:56 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 18:59:56 INFO - PROCESS | 1643 | __metrics 18:59:56 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:59:56 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:59:57 INFO - TEST-INFO | 1643: exit 0 18:59:57 INFO - Browser initialized. 18:59:57 INFO - Running cycle 1/1 for dromaeo_css test... 18:59:57 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmpjHh8vc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:09 INFO - PROCESS | 1645 | RSS: Main: 235638784 19:00:09 INFO - PROCESS | 1645 | 19:03:13 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 19:03:15 INFO - PROCESS | 1645 | RSS: Main: 341745664 19:03:15 INFO - PROCESS | 1645 | 19:04:59 INFO - PROCESS | 1645 | ************************* 19:04:59 INFO - PROCESS | 1645 | A coding exception was thrown and uncaught in a Task. 19:04:59 INFO - PROCESS | 1645 | 19:04:59 ERROR - PROCESS | 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:04:59 INFO - PROCESS | 1645 | Full stack: 19:04:59 INFO - PROCESS | 1645 | ************************* 19:06:18 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 19:06:19 INFO - PROCESS | 1645 | RSS: Main: 370720768 19:06:19 INFO - PROCESS | 1645 | 19:09:21 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 19:09:22 INFO - PROCESS | 1645 | RSS: Main: 342343680 19:09:22 INFO - PROCESS | 1645 | 19:12:24 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 19:12:25 INFO - PROCESS | 1645 | RSS: Main: 350523392 19:12:25 INFO - PROCESS | 1645 | 19:15:28 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 19:15:29 INFO - PROCESS | 1645 | RSS: Main: 323366912 19:15:29 INFO - PROCESS | 1645 | 19:18:32 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 19:18:33 INFO - PROCESS | 1645 | RSS: Main: 389210112 19:18:33 INFO - PROCESS | 1645 | 19:18:33 INFO - PROCESS | 1645 | __start_tp_report 19:18:33 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 19:18:33 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 19:18:33 INFO - PROCESS | 1645 | |i|pagename|runs| 19:18:33 INFO - PROCESS | 1645 | |0;dojo.html;3282.885099021534;3302.504624306354;3302.917427064323;3322.651121632227;3346.782459140156;5488.835334939949;5545.916811247835;5578.8605284867845;5588.105903055512;5605.187247849065;5580.804671836477;5585.1063829787245;5599.524040456556;5601;5603.355614104379;5052.595792336613;5081.644284900059;5100.795968161269;5159.509846564571;5180.2229665550285;5151.845444636649;5176.990486855065;5183.948160518403;5185.818496352628;5191.818286359978;5174.793008279665;5182.196759502283;5184.740762961856;5186.014657215117;5194.065068287726;5121.359830021247;5128.179491281415;5135.537801597874;5140.023395554833;5143.12566863634;4919.655624106314;5091.669041512327;5096.235564665293;5099.464556221617;5115.360579927509;4575.4738205106505;5615.971920140414;5660.518855897254;5666.093425051972;5730.598858079936;6041.395860413967;6071.2714474263375;6073.271207455089;6085.026395776698;6110.511159107261;6078.787242446538;6090.056041313604;6104.0418789919695;6142.744345496849;6145.647957449354;5745.741441635137;5749.223854779635;5751.108578170307;5751.712414379264;5756.971215143897;6369.681515924185;6393.136926514954;6401.583897046677;6403.519736019817;6406.263279722798;5864.736086876101;5903.35063143054;5914.9112763308585;6042.6978651067275;6048.818535443944;6056.424639659225;6124.969375153185;6143.232095988002;6165.691715414211;6170.660613666291;4810.621471168997;6046.304674962347;6064.79455868891;6087.1173679816175;6098.512119030467;5084.3898732152375;6046.697665116727;6097;6130.448259656652;6149.169862068564;4949.430815456197;4960.379952505937;4975.129352363394;4990.076835785391;5010.048090862724;4415.84544540946;4418.558144185556;4421.712588681726;4432.401625780479;4454.131444368382;5758.992176369119;5762.135679648002;5771.394003629643;5777.24895763548;5783.421657834183;6122.908156377658;6126.356732543019;6146.832101900624;6167.136600875881;6222.81331560054;4784.736839473862;5776.480116789509;5782.826515204551;5806.2451881255165;5822.446867547576;5282.392524859613;5329.200619906967;5332.33345831771;5340.599455040888;5389.461053894657;6249.625022498664;6276.184096067574;6294.339094395205;6311.2426508819235;6314.463270622048;6111.804454079419;6119.9596068669325;6256.687165641609;6268.216472940882;6273.247210334789;6165.075238714228;6245.406686364788;6259.436650701458;6313.747450101944;6331.2085989251345;6118.785842495491;6151.108089327112;6152.107944348134;6175.042868355412;6188.102725104744;6133.487685122301;6139.140520327069;6273.874522509615;6281.528885333527;6288.182536270256;5754.68349240779;6013.6692481913915;6039;6077.665728384981;6139.3553676863285;6058.666773327333;6058.697065146813;6063.454289114001;6066.545009124245;6077.179580756541;5740.799072032626;5750.453706897838;5848.152017957457;5882.264716910387;5888.028475301699;5934.584579079423;6024.638521688713;6033.366496517802;6035.698215089315;6103.186149163709;5874.265716785402;5881.97065513542;5892.587518873637;5895.41045895407;5916.940830591639 19:18:33 INFO - PROCESS | 1645 | |1;ext.html;451.214886098189;457.32544496867126;482.22361997184527;486.7298649249665;518.6006774783417;31063;35325.82337088314;41849.581504184986;43361.56638433615;43384;42988.57011429885;43528.12943741123;43920;44314.556854431445;44317.55682443175;9290.814183716322;9489.478078705668;9493.52532373382;9506.47714375709;9510.00144984777;8383.455075420108;8592.097829727882;11247.156463265288;11481.483333250024;11499.367534785584;11491.597794077208;11553.191276610598;11557.364344961024;11585.652430427059;11587.015103716194;11425.485853136628;11491.827622585668;11505.137114716346;11519.48162332697;11520.711982200428;8344.499330040217;8568.357373197035;9282.628694852197;11396.94301528487;11438.19932604718;41612.37581436281;42034.369484457755;42068.78965605152;42143;42217.94455138616;4048.433219349264;4058.147788964321;4086.223617512663;4098.036961314089;4117.773522456264;31310;31360.529592056137;31363.843180784177;31385.686143138504;31470.527942080887;3150.558921750957;3243.2378391078078;3285.0801775502896;3297.5713157289397;3355.312161007012;493348;495006;495531;495763.9999999964;496736;61865.38134618596;64178.67910660417;64518;64612;64614.676926615066;65211.021834672516;65231;68124.6593767028;68282;68433;15873.841261587468;16082.919585401998;16090.034597924163;16099.195040247942;16118.597035073983;10985.505652245669;12272.877271227351;12285.38573071343;12402.81395779064;12420.565280215149;15300.311485983157;15801.446949356718;17771.933683979;18147.00191489481;18189;6714.966425167843;7083.929160708327;7126.287371262936;7132.679029443584;7190.604516751629;749.0786332810674;837.3970741066422;896.6189369517929;899.7030979776658;919.6827094652334;29321.12036638904;30171.09486715358;30423.391532169677;30661.540076898866;31394;925.8287216864767;1051.5636011055478;1087.4888802262924;1103.2608152537819;1174.9941250293864;12149.5140194393;15711.764323535157;15775.368985240691;16011.119388433515;16271.918640406722;594143;598507.1194304446;599195;599294;599775;61663;62103.44741381502;62138.37861621416;62309;62384;1405.845357010728;1449.6883170118474;1468.2511918921427;1473.1897456398938;1474.0345073976562;28705.28236794097;29717.554236686898;29968.400631986802;30725;30854.691453085183;51989.48010519846;52493.63778629895;52594;52957;56824.715876420356;575447;580183;580721;580739;581034.0948295231;24753.009879605335;25045.624315635643;25063.373415664755;25123.623145653197;25124;43063.354049688656;43474.69575912728;44423.33364999463;44746.3288050686;46492;27339.726602734514;34490.96527104191;35565.755198567924;36036.81981590075;36819.63180368162;35668.92993210208;36150.27699446049;36360.818195908854;36791.63208367882;37135.628643713215;35085.64914350926;35699.929002129975;35923.640763592026;36274.63725362712;36600.63399365972;31346.843265783526;32489.350212995134;32573.674263257064;32862.83568582142;32939.17652058718;19958.800411995693;22076;23857.045718171077;24127.758722412553;24441.26676199717 19:18:33 INFO - PROCESS | 1645 | |2;jquery.html;330.7238455889332;367.23798118903284;388.1848118950203;392.9960700392995;415.6383945967009;15791.447299344525;15973.840261597381;19679.114439850204;20488.28291009815;20829.791702082974;20432.591348173064;20968;21373.57252854942;21386.25148119816;21402.46493837655;5230.816921407752;5493.011257973563;5498.835034948938;5499.972500137494;5501.0648189807625;4928.260760885878;5391.245225668409;5421.186821976716;5486.972565137169;5490.560755139599;5766.279215098113;5842.795502157425;5925.585209035347;5964.687768690881;5985.820425387224;5617.634853734494;5859.824205273806;5910.8817823643285;5931.317898441648;5967.850803729898;5273.288106105665;5284.233786101032;5294.894102117974;5295.179247216687;5296.020236256267;13418.731625367438;13593.388297526635;13624.931875340659;13627.04610677253;14243.501477448239;2616.7644911958014;2648.708642049373;2654.5487267164626;2663.760261576448;2664.5869890167055;9992.45041522716;10044.849327260097;10503.159747220205;12599.496020159182;14338.068025578305;1415.695625440525;1840.7054871220673;1957.363856746563;1962.0876292524044;1963.7839837617994;119618.40190799077;124529;130295.34852325772;134541;136202.3189884054;10901.890981090246;11318.207725459304;11475.31148131098;11804.17370784054;12029.458674359676;14417.855821441652;14799.260036998106;14815.777763333559;15543.689126217412;15596.298166582532;7033.788986330418;8507.65969361231;8662.220400164015;8762.605682744292;8787.989381221114;8280.668773249003;8291.792705182297;8457.281131103802;8461.40770146084;8477.95761021191;4651.279051746985;4758.666893317434;4760.09558183944;4765.309030190603;4894.681845680019;2010.879347239141;2028.7869773673847;2033.1562401603464;2033.7356143701224;2040.9693854592192;1011.246621267146;1015.3501758874327;1025.8666373371414;1037.8287582548946;1065.6110519660424;16622.75065874013;20099;20566;20929.47676308074;21198.04608792608;820.7168526858225;829.9832704936405;881.5239770523973;960.2510042167121;963.2582911158369;10174.898251017396;10435.269531132748;10801.83797243042;10855.837162442569;10874.293170943864;714900;718158;740944;743938;748632;137016;153642;155464.22267888588;155735.6639650406;158167;1088.1186239146316;1102.5699977008974;1116.4752566293828;1116.8492253545667;1118.3401792942202;17814.821851781315;18427.078646067912;18492.35276765307;18513.814861851748;18598.628027439645;54491.91016179575;54497.18254226111;55513.444865550824;55671.16493252685;55781.44218557762;78233.60883195775;78565;79156;80853;81543;7991.600419979094;8222.794430139294;8586.828263434822;8780.121987801169;8800.207981281459;12891.613251602466;12987.740245194855;13012.414441349973;13494.797578036141;13495.190288582717;9168.495732734764;11527.538898443969;11635.069194464591;11787.469563869476;11835;11030.44847757625;11215.71960700989;11382.772344553228;11436.542538298374;11766.176367654525;11471.02496287825;11542.769144617228;11874.109441791727;11941.283522988648;11997.580084696994;8467.449615774955;8485;8488.278496327881;8495.532745699045;8515.48907065578;9762;11181.161412893904;11579.305241685526;11624.6512604622;11638.359890205782 19:18:33 INFO - PROCESS | 1645 | |3;mootools.html;1466.633341664584;1472.227080782589;1474.9483768068117;1491.015929486539;1493.805805245318;8067.152948940365;8493.362997775175;8501.957490212548;8506.234438900505;8507.78730531737;7464.626768661572;7692.0769507659015;7697.692092316301;7994.760157195279;8279.710210142646;2278.1798552521077;2325.6511523271474;2327.6392159215347;2329.2662811214414;2338.0414030247516;2310.353101131686;2341.6136337504377;2349.8942547585316;2350.753170917046;2351.7295511016196;2277.5900337939165;2279.977200227993;2291.8854057297153;2326.5928462519078;2329.2080692564523;2280.9771902281013;2305.4927915858484;2306.3772781349107;2307.1348244408346;2307.573098976695;2255.560165767676;2328.9650655240184;2330.0679728108894;2332.988335058331;2341.672165896776;8350.582470876492;8427.70503032397;8435.283000944926;8444.493330400195;8450.661973521052;4632.726000349897;5004.599632029465;5110.156824124015;5177.404598471187;5186.896262074737;2920.9630581143815;3206.246532064963;3515.2090779574646;3562.608113107556;3569.803660798655;1203.5787474383983;1216.8843959823803;1221.9633410997596;1266.366816591704;1269.2891980490954;10619.469026548719;10629.468526573717;10735.62425315118;10743.62397316098;10752.838707419394;4359.498657654347;4594.839180628729;4681.625469962395;4686.95313046872;4691.085238378483;9440.24478041755;9465;9468.14786669203;9471.052894710612;9490.430574165572;5215.400228973716;5219.321488206585;5232.39827419844;5233.607479439057;5233.633645644844;4216.114615930627;4486.663500237495;4686.5782079613;4712.95287047132;4798.4001999750035;3627.111357717376;3647.8905632831056;3713.424419215026;3734.514513113332;3774.226283611853;1261.873812618749;1261.924284542912;1263.1284413754663;1272.6627443727234;1287.4013583683632;680.3094858718405;855.8331125430606;869.599984007351;877.2236570634907;878.3939082033377;4557.567031132037;5318.7074710891275;5366.812161574326;5432.864178395493;5451.863703407367;970.84466485362;987.819555631014;991.2169386184977;993.8707967964118;1008.5511947183579;3229.6770322967513;3449.6205417404067;3634.8546058157376;3637.454381842692;3802.16352402471;9753.853692194623;9841;9973.700788976343;10078.496075196357;10101.14140298083;9921.156701680293;9995.050470205319;10013.349132306377;10033.949830250947;10040.548175332127;7304.306090921354;7609.619519024027;7658.157602663702;7703;7709.190534993745;5451.509364157245;5481.287432633732;5528.336599608073;5580.637258578179;5645.802396916089;8858.247049000649;8879.644814207359;9135.77160570991;9237.630494780402;9347;9102.908970910206;9106;9316.068393160629;9326.207272381924;9348;7089.397401220954;7340.1191856975365;7362.7054917804835;7614.619269036415;7861.685532578633;7536.547807131589;7829.217078292125;7838.3337416320255;7927.722529711433;7937.8412431752195;6976.337247961435;7061.2232654409;7095.538789978635;7127.928720712726;7261.6006119663925;6816.318368163343;6981.813126523754;7049.118860142482;7066.399356054793;7143.285671432815;6338.144350512622;6370.458511026614;6449.806505804833;6461.773837915651;6463.515236357386;4905.288733133747;4931.3835770528685;4993.201087825931;5064.72144032067;5082.847514574569;4852.8348909657325;4880.292357608056;4989.600831933364;5129.358830146231;5154.407243167084 19:18:33 INFO - PROCESS | 1645 | |4;prototype.html;342.3409935873444;349.6713089695686;358.6700235783079;367.6158414456892;370.79606216580856;4436.511983681792;4899.412070551539;5065.240213967907;5077.822276220333;5151.871203219916;4923.9753801230945;4958.752062396884;5027.698338099716;5083.186690129571;5093.516115968977;3368.292658541709;4039.252738243427;4055.858044968427;4062.309407400749;4078.7552746835136;3350.5979282486014;3701.3541661463437;4078.796060196993;4088.8773336799945;4096.426500289962;3997.34043882759;4040.717149799515;4041.2725709372303;4057.2088442753675;4079.8164082616204;3312.585926759155;3999.70002249831;4030.717849750519;4035.16400037982;4062.531215662777;3003.6695963444004;3557.008075477741;3601.1537288737127;3601.819909004539;3610.9097272568397;4170.249355116078;4447.866564003085;4748.592196173945;4968.7826482511655;5074.441811400743;4046.332355161395;4334.219840428722;4349.412464450453;4641.628669706415;4671.299305104228;4535.342375355588;4603.746793926332;5400.756965936543;5412.9458705412835;5416.214648875891;3498.2478767065204;3593.9936817691087;3718.2563487302377;3897.824597893102;3900.765954042738;4882.0959825668015;5185.870353241162;5402.459754024605;5687.175359572839;5691.743871525791;3707.8516859325864;3924.9018774530864;4002.3196056670436;4035.092104276573;4050.7569545827346;3948.269570129535;4110;4111.9177616447505;4117.3206420940205;4131.97934010328;4582.24392975162;4604.700694454849;4623.289382928271;4633.814647414066;4638.443386793607;4626.2011483052265;5250.789968401297;5462.9726851365485;5482.396936337;5483.424240454775;1258.9496420143091;1295.8121072444442;1302.5021225590458;1308.188922867828;1335.0041687676985;791.3392317415023;860.6600392844916;885.6059053721161;952.8142012307673;963;4482.081173359454;4528.139653465831;4617.6536759742485;4875.5124487551675;4890.486498917634;4936.456989731127;4964.840294471916;5230.450802665741;5393.649412788156;5402.837914862561;4432.160653328897;4618.907621847544;4888.975555122272;4905.264210368473;4934.851954441372;2505.5991041433285;2798;2805.312698388908;2805.438912217565;2819.4079243358715;4643.976780116078;5326.46735326472;5420.403755586883;5565.721713914288;5568;5484.341878974548;5507.449255074461;5533.6797921247735;5535.833924982257;5567.162836264023;5111.795528178831;5431.53831924283;5561.916571251434;5571.832845014656;5610.551155907436;4675.412881606448;5081.288619593334;5100.795968161232;5369.57043436532;5381.515663590296;4770.1565582161575;4875.341828853059;5042.520960508746;5245.3214971208845;5259.21186796491;4596.4024676791805;5070.822521211888;5490.91763623538;5495.945040549704;5536.090048933112;3211.9122570329473;3377.6622337766025;3721.330160571123;3851.785223496445;3854.5567259765485;4356.736546401635;4624.577812418853;4718.631596836879;5130.97434512825;5157.871053223549;4618.792154353129;4948.406191257072;5164.896702066013;5197.506236907488;5225.171190083441;4519.028408892104;4943.604511639132;5112.667676601009;5141.640085194001;5188.948110518997;4176.832926682899;4615.284630882219;4656.043412433197;4795.520447955177;5236.502532259429;4535.31970204472;5359.775693087325;5390.245365648734;5399.892002160013;5422.755975981169;4241.724287921399;5238.319018527567;5329.813456529003;5341.370881881064;5341.946580534301 19:18:33 INFO - PROCESS | 1645 | |5;yui.html;629.2386212682651;727.7271023366237;779.699815571005;794.1105961323317;819.5697258939058;14778.113313201202;15690.607734806636;15744;15761.763573546392;15816.762748558767;13979.720405591908;14378.712425751479;14395.496157634485;14579.92710036451;14599.635009124777;674.6491824251386;693.8577591593736;696;851.0213254757017;861.6811779641525;852.9872051919226;854.2824027816632;864.9697260595881;867.1371984875058;867.600903584352;872.084311472954;873.462820365477;906.0260220263243;910.6038873090193;913.9314551408638;708.4084789201023;731.8316787138934;907.8093600343935;910.4400793512009;910.6038873090193;544.23806670661;545.6480570032307;547.9971651877095;676.8984652302145;693.0505207865207;12590;15165.24173791306;15187;15221.31504082319;15242.085474871543;13441.395137218751;13478.460861565525;13510.32448377587;13534.864651353557;13656.522021729292;12478.251304921734;12534.498620055187;12564.81152782709;12622.684432889251;12666.176698514659;4289.142171565668;4308.482982042144;4327.697061205717;4327.913441731148;4493.146302202571;99013.50493247488;102552;102939.97060029379;103634.48182759038;104001;8485.32117430604;10291.279610427348;10763.300385474919;10800.973907478778;10975.615853445252;20539.897300513403;20566;21337.46656333573;21422.357329279836;21429.03569339352;6597.967010164918;7401.185869554345;7406.296401841816;7441.925580744231;7726.150123486412;3655.8720444784835;3665.450182472597;3753.680937120321;3754.630065800254;3767.2088861339425;3367.663233676613;3391.8304084795664;3427.6915077642634;3459.7924124552605;3466.376052310558;633.5786701843223;637.4995628431659;641.9325970773095;646.9708863101172;649.162580271454;555.8799019974754;620.6679426506887;634.2515831319088;641.5284765697209;672.4049216443483;7610.543367397974;9665.468399238109;9673.333763789093;9676.612935482643;9818.607255709834;602.3524710935761;657.2015001772869;661.8577005943745;668.1180841289452;668.3383450384084;4553.6357091433265;4711.340412342275;4817.421909370898;4903.436104847988;5318.22885681574;96302;99214;100472.99527004636;100550;101716;66371.6725665484;74184.62907685534;82622.58688706518;83047;84072;61537.384626153165;75154;79062.20937790663;79524.20475795283;80228;10610.946945265225;10735.624253151102;10827.296225745302;10873.565057397616;10903.454827258447;50106;50199.74900125476;50709.23936140887;51075.723106922625;52179.73910130425;67429.66285168739;68458.65770671115;68537.62924741577;69767.30232697607;69817;12846.678833028875;12921.806172907225;12927.030472714772;13330.733385332433;13389.263590502616;14524.49164279245;14542.127472351693;14696.926515367355;15093.47172848945;15119.244037798286;13396.732065358834;13538.390772415461;13632;13778;13847.930760346537;13565.118267312593;13597.320133993459;13746.450141994608;14049.367778450198;14178;13130.409131589293;13536.932315338361;13642;13792.586222413343;13917.860821391656;9636.22910167171;11239.213255072067;11512.013832303237;11595.710107247387;11979.640610781691;10426.061654451136;10804.297720648132;11085.778284434427;11107.777844442904;11135.610253641084 19:18:33 INFO - PROCESS | 1645 | __end_tp_report 19:18:33 INFO - PROCESS | 1645 | __start_cc_report 19:18:33 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1756 19:18:33 INFO - PROCESS | 1645 | __end_cc_report 19:18:33 INFO - PROCESS | 1645 | __startTimestamp1485314313048__endTimestamp 19:18:33 INFO - PROCESS | 1645 | 19:18:33 INFO - PROCESS | 1645 | ------- Summary: start ------- 19:18:33 INFO - PROCESS | 1645 | Number of tests: 6 19:18:33 INFO - PROCESS | 1645 | 19:18:33 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5665.09 Median:5874.27 stddev:643.79 (11.0%) stddev-sans-first:618.05 19:18:33 INFO - PROCESS | 1645 | Values: 3282.9 3302.5 3302.9 3322.7 3346.8 5488.8 5545.9 5578.9 5588.1 5605.2 5580.8 5585.1 5599.5 5601.0 5603.4 5052.6 5081.6 5100.8 5159.5 5180.2 5151.8 5177.0 5183.9 5185.8 5191.8 5174.8 5182.2 5184.7 5186.0 5194.1 5121.4 5128.2 5135.5 5140.0 5143.1 4919.7 5091.7 5096.2 5099.5 5115.4 4575.5 5616.0 5660.5 5666.1 5730.6 6041.4 6071.3 6073.3 6085.0 6110.5 6078.8 6090.1 6104.0 6142.7 6145.6 5745.7 5749.2 5751.1 5751.7 5757.0 6369.7 6393.1 6401.6 6403.5 6406.3 5864.7 5903.4 5914.9 6042.7 6048.8 6056.4 6125.0 6143.2 6165.7 6170.7 4810.6 6046.3 6064.8 6087.1 6098.5 5084.4 6046.7 6097.0 6130.4 6149.2 4949.4 4960.4 4975.1 4990.1 5010.0 4415.8 4418.6 4421.7 4432.4 4454.1 5759.0 5762.1 5771.4 5777.2 5783.4 6122.9 6126.4 6146.8 6167.1 6222.8 4784.7 5776.5 5782.8 5806.2 5822.4 5282.4 5329.2 5332.3 5340.6 5389.5 6249.6 6276.2 6294.3 6311.2 6314.5 6111.8 6120.0 6256.7 6268.2 6273.2 6165.1 6245.4 6259.4 6313.7 6331.2 6118.8 6151.1 6152.1 6175.0 6188.1 6133.5 6139.1 6273.9 6281.5 6288.2 5754.7 6013.7 6039.0 6077.7 6139.4 6058.7 6058.7 6063.5 6066.5 6077.2 5740.8 5750.5 5848.2 5882.3 5888.0 5934.6 6024.6 6033.4 6035.7 6103.2 5874.3 5882.0 5892.6 5895.4 5916.9 19:18:33 INFO - PROCESS | 1645 | 19:18:33 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:69403.69 Median:36317.73 stddev:149353.41 (411.2%) stddev-sans-first:149682.66 19:18:33 INFO - PROCESS | 1645 | Values: 451.2 457.3 482.2 486.7 518.6 31063.0 35325.8 41849.6 43361.6 43384.0 42988.6 43528.1 43920.0 44314.6 44317.6 9290.8 9489.5 9493.5 9506.5 9510.0 8383.5 8592.1 11247.2 11481.5 11499.4 11491.6 11553.2 11557.4 11585.7 11587.0 11425.5 11491.8 11505.1 11519.5 11520.7 8344.5 8568.4 9282.6 11396.9 11438.2 41612.4 42034.4 42068.8 42143.0 42217.9 4048.4 4058.1 4086.2 4098.0 4117.8 31310.0 31360.5 31363.8 31385.7 31470.5 3150.6 3243.2 3285.1 3297.6 3355.3 493348.0 495006.0 495531.0 495764.0 496736.0 61865.4 64178.7 64518.0 64612.0 64614.7 65211.0 65231.0 68124.7 68282.0 68433.0 15873.8 16082.9 16090.0 16099.2 16118.6 10985.5 12272.9 12285.4 12402.8 12420.6 15300.3 15801.4 17771.9 18147.0 18189.0 6715.0 7083.9 7126.3 7132.7 7190.6 749.1 837.4 896.6 899.7 919.7 29321.1 30171.1 30423.4 30661.5 31394.0 925.8 1051.6 1087.5 1103.3 1175.0 12149.5 15711.8 15775.4 16011.1 16271.9 594143.0 598507.1 599195.0 599294.0 599775.0 61663.0 62103.4 62138.4 62309.0 62384.0 1405.8 1449.7 1468.3 1473.2 1474.0 28705.3 29717.6 29968.4 30725.0 30854.7 51989.5 52493.6 52594.0 52957.0 56824.7 575447.0 580183.0 580721.0 580739.0 581034.1 24753.0 25045.6 25063.4 25123.6 25124.0 43063.4 43474.7 44423.3 44746.3 46492.0 27339.7 34491.0 35565.8 36036.8 36819.6 35668.9 36150.3 36360.8 36791.6 37135.6 35085.6 35699.9 35923.6 36274.6 36600.6 31346.8 32489.4 32573.7 32862.8 32939.2 19958.8 22076.0 23857.0 24127.8 24441.3 19:18:33 INFO - PROCESS | 1645 | 19:18:33 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:39566.19 Median:20879.63 stddev:122170.11 (585.1%) stddev-sans-first:122477.31 19:18:33 INFO - PROCESS | 1645 | Values: 330.7 367.2 388.2 393.0 415.6 15791.4 15973.8 19679.1 20488.3 20829.8 20432.6 20968.0 21373.6 21386.3 21402.5 5230.8 5493.0 5498.8 5500.0 5501.1 4928.3 5391.2 5421.2 5487.0 5490.6 5766.3 5842.8 5925.6 5964.7 5985.8 5617.6 5859.8 5910.9 5931.3 5967.9 5273.3 5284.2 5294.9 5295.2 5296.0 13418.7 13593.4 13624.9 13627.0 14243.5 2616.8 2648.7 2654.5 2663.8 2664.6 9992.5 10044.8 10503.2 12599.5 14338.1 1415.7 1840.7 1957.4 1962.1 1963.8 119618.4 124529.0 130295.3 134541.0 136202.3 10901.9 11318.2 11475.3 11804.2 12029.5 14417.9 14799.3 14815.8 15543.7 15596.3 7033.8 8507.7 8662.2 8762.6 8788.0 8280.7 8291.8 8457.3 8461.4 8478.0 4651.3 4758.7 4760.1 4765.3 4894.7 2010.9 2028.8 2033.2 2033.7 2041.0 1011.2 1015.4 1025.9 1037.8 1065.6 16622.8 20099.0 20566.0 20929.5 21198.0 820.7 830.0 881.5 960.3 963.3 10174.9 10435.3 10801.8 10855.8 10874.3 714900.0 718158.0 740944.0 743938.0 748632.0 137016.0 153642.0 155464.2 155735.7 158167.0 1088.1 1102.6 1116.5 1116.8 1118.3 17814.8 18427.1 18492.4 18513.8 18598.6 54491.9 54497.2 55513.4 55671.2 55781.4 78233.6 78565.0 79156.0 80853.0 81543.0 7991.6 8222.8 8586.8 8780.1 8800.2 12891.6 12987.7 13012.4 13494.8 13495.2 9168.5 11527.5 11635.1 11787.5 11835.0 11030.4 11215.7 11382.8 11436.5 11766.2 11471.0 11542.8 11874.1 11941.3 11997.6 8467.4 8485.0 8488.3 8495.5 8515.5 9762.0 11181.2 11579.3 11624.7 11638.4 19:18:33 INFO - PROCESS | 1645 | 19:18:33 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5408.08 Median:5182.15 stddev:2947.38 (56.9%) stddev-sans-first:2940.76 19:18:33 INFO - PROCESS | 1645 | Values: 1466.6 1472.2 1474.9 1491.0 1493.8 8067.2 8493.4 8502.0 8506.2 8507.8 7464.6 7692.1 7697.7 7994.8 8279.7 2278.2 2325.7 2327.6 2329.3 2338.0 2310.4 2341.6 2349.9 2350.8 2351.7 2277.6 2280.0 2291.9 2326.6 2329.2 2281.0 2305.5 2306.4 2307.1 2307.6 2255.6 2329.0 2330.1 2333.0 2341.7 8350.6 8427.7 8435.3 8444.5 8450.7 4632.7 5004.6 5110.2 5177.4 5186.9 2921.0 3206.2 3515.2 3562.6 3569.8 1203.6 1216.9 1222.0 1266.4 1269.3 10619.5 10629.5 10735.6 10743.6 10752.8 4359.5 4594.8 4681.6 4687.0 4691.1 9440.2 9465.0 9468.1 9471.1 9490.4 5215.4 5219.3 5232.4 5233.6 5233.6 4216.1 4486.7 4686.6 4713.0 4798.4 3627.1 3647.9 3713.4 3734.5 3774.2 1261.9 1261.9 1263.1 1272.7 1287.4 680.3 855.8 869.6 877.2 878.4 4557.6 5318.7 5366.8 5432.9 5451.9 970.8 987.8 991.2 993.9 1008.6 3229.7 3449.6 3634.9 3637.5 3802.2 9753.9 9841.0 9973.7 10078.5 10101.1 9921.2 9995.1 10013.3 10033.9 10040.5 7304.3 7609.6 7658.2 7703.0 7709.2 5451.5 5481.3 5528.3 5580.6 5645.8 8858.2 8879.6 9135.8 9237.6 9347.0 9102.9 9106.0 9316.1 9326.2 9348.0 7089.4 7340.1 7362.7 7614.6 7861.7 7536.5 7829.2 7838.3 7927.7 7937.8 6976.3 7061.2 7095.5 7127.9 7261.6 6816.3 6981.8 7049.1 7066.4 7143.3 6338.1 6370.5 6449.8 6461.8 6463.5 4905.3 4931.4 4993.2 5064.7 5082.8 4852.8 4880.3 4989.6 5129.4 5154.4 19:18:33 INFO - PROCESS | 1645 | 19:18:33 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4314.66 Median:4663.67 stddev:1259.53 (27.0%) stddev-sans-first:1227.27 19:18:33 INFO - PROCESS | 1645 | Values: 342.3 349.7 358.7 367.6 370.8 4436.5 4899.4 5065.2 5077.8 5151.9 4924.0 4958.8 5027.7 5083.2 5093.5 3368.3 4039.3 4055.9 4062.3 4078.8 3350.6 3701.4 4078.8 4088.9 4096.4 3997.3 4040.7 4041.3 4057.2 4079.8 3312.6 3999.7 4030.7 4035.2 4062.5 3003.7 3557.0 3601.2 3601.8 3610.9 4170.2 4447.9 4748.6 4968.8 5074.4 4046.3 4334.2 4349.4 4641.6 4671.3 4535.3 4603.7 5400.8 5412.9 5416.2 3498.2 3594.0 3718.3 3897.8 3900.8 4882.1 5185.9 5402.5 5687.2 5691.7 3707.9 3924.9 4002.3 4035.1 4050.8 3948.3 4110.0 4111.9 4117.3 4132.0 4582.2 4604.7 4623.3 4633.8 4638.4 4626.2 5250.8 5463.0 5482.4 5483.4 1258.9 1295.8 1302.5 1308.2 1335.0 791.3 860.7 885.6 952.8 963.0 4482.1 4528.1 4617.7 4875.5 4890.5 4936.5 4964.8 5230.5 5393.6 5402.8 4432.2 4618.9 4889.0 4905.3 4934.9 2505.6 2798.0 2805.3 2805.4 2819.4 4644.0 5326.5 5420.4 5565.7 5568.0 5484.3 5507.4 5533.7 5535.8 5567.2 5111.8 5431.5 5561.9 5571.8 5610.6 4675.4 5081.3 5100.8 5369.6 5381.5 4770.2 4875.3 5042.5 5245.3 5259.2 4596.4 5070.8 5490.9 5495.9 5536.1 3211.9 3377.7 3721.3 3851.8 3854.6 4356.7 4624.6 4718.6 5131.0 5157.9 4618.8 4948.4 5164.9 5197.5 5225.2 4519.0 4943.6 5112.7 5141.6 5188.9 4176.8 4615.3 4656.0 4795.5 5236.5 4535.3 5359.8 5390.2 5399.9 5422.8 4241.7 5238.3 5329.8 5341.4 5341.9 19:18:33 INFO - PROCESS | 1645 | 19:18:33 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:19954.34 Median:4298.81 stddev:28130.42 (654.4%) stddev-sans-first:28171.90 19:18:33 INFO - PROCESS | 1645 | Values: 629.2 727.7 779.7 794.1 819.6 14778.1 15690.6 15744.0 15761.8 15816.8 13979.7 14378.7 14395.5 14579.9 14599.6 674.6 693.9 696.0 851.0 861.7 853.0 854.3 865.0 867.1 867.6 872.1 873.5 906.0 910.6 913.9 708.4 731.8 907.8 910.4 910.6 544.2 545.6 548.0 676.9 693.1 12590.0 15165.2 15187.0 15221.3 15242.1 13441.4 13478.5 13510.3 13534.9 13656.5 12478.3 12534.5 12564.8 12622.7 12666.2 4289.1 4308.5 4327.7 4327.9 4493.1 99013.5 102552.0 102940.0 103634.5 104001.0 8485.3 10291.3 10763.3 10801.0 10975.6 20539.9 20566.0 21337.5 21422.4 21429.0 6598.0 7401.2 7406.3 7441.9 7726.2 3655.9 3665.5 3753.7 3754.6 3767.2 3367.7 3391.8 3427.7 3459.8 3466.4 633.6 637.5 641.9 647.0 649.2 555.9 620.7 634.3 641.5 672.4 7610.5 9665.5 9673.3 9676.6 9818.6 602.4 657.2 661.9 668.1 668.3 4553.6 4711.3 4817.4 4903.4 5318.2 96302.0 99214.0 100473.0 100550.0 101716.0 66371.7 74184.6 82622.6 83047.0 84072.0 61537.4 75154.0 79062.2 79524.2 80228.0 10610.9 10735.6 10827.3 10873.6 10903.5 50106.0 50199.7 50709.2 51075.7 52179.7 67429.7 68458.7 68537.6 69767.3 69817.0 12846.7 12921.8 12927.0 13330.7 13389.3 14524.5 14542.1 14696.9 15093.5 15119.2 13396.7 13538.4 13632.0 13778.0 13847.9 13565.1 13597.3 13746.5 14049.4 14178.0 13130.4 13536.9 13642.0 13792.6 13917.9 9636.2 11239.2 11512.0 11595.7 11979.6 10426.1 10804.3 11085.8 11107.8 11135.6 19:18:33 INFO - PROCESS | 1645 | -------- Summary: end -------- 19:18:33 INFO - PROCESS | 1645 | 19:18:33 INFO - TEST-INFO | 1645: exit 0 19:18:33 INFO - TEST-OK | dromaeo_css | took 1119925ms 19:18:33 INFO - TEST-START | kraken 19:18:33 INFO - operating with platform_type : mac_ 19:18:33 INFO - Initialising browser for kraken test... 19:18:33 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmpqupcZU/profile http://localhost:49245/getInfo.html) 19:18:36 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 19:18:36 INFO - PROCESS | 1655 | colorDepth:24 19:18:36 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 19:18:36 INFO - PROCESS | 1655 | __metrics 19:18:36 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:18:36 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:18:37 INFO - TEST-INFO | 1655: exit 0 19:18:37 INFO - Browser initialized. 19:18:37 INFO - Running cycle 1/1 for kraken test... 19:18:37 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/T/tmpqupcZU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:49 INFO - PROCESS | 1656 | RSS: Main: 236183552 19:18:49 INFO - PROCESS | 1656 | 19:18:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 19:18:52 INFO - PROCESS | 1656 | RSS: Main: 288141312 19:18:52 INFO - PROCESS | 1656 | 19:18:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 19:18:56 INFO - PROCESS | 1656 | RSS: Main: 287248384 19:18:56 INFO - PROCESS | 1656 | 19:18:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 19:18:59 INFO - PROCESS | 1656 | RSS: Main: 379523072 19:18:59 INFO - PROCESS | 1656 | 19:19:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 19:19:02 INFO - PROCESS | 1656 | RSS: Main: 282439680 19:19:02 INFO - PROCESS | 1656 | 19:19:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:05 INFO - PROCESS | 1656 | RSS: Main: 285896704 19:19:05 INFO - PROCESS | 1656 | 19:19:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:08 INFO - PROCESS | 1656 | RSS: Main: 327249920 19:19:08 INFO - PROCESS | 1656 | 19:19:11 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:12 INFO - PROCESS | 1656 | RSS: Main: 331313152 19:19:12 INFO - PROCESS | 1656 | 19:19:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 19:19:15 INFO - PROCESS | 1656 | RSS: Main: 329019392 19:19:15 INFO - PROCESS | 1656 | 19:19:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:17 INFO - PROCESS | 1656 | RSS: Main: 304369664 19:19:17 INFO - PROCESS | 1656 | 19:19:19 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:19:20 INFO - PROCESS | 1656 | RSS: Main: 305033216 19:19:20 INFO - PROCESS | 1656 | 19:19:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:19:23 INFO - PROCESS | 1656 | RSS: Main: 306147328 19:19:23 INFO - PROCESS | 1656 | 19:19:26 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:19:26 INFO - PROCESS | 1656 | RSS: Main: 325812224 19:19:26 INFO - PROCESS | 1656 | 19:19:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:19:30 INFO - PROCESS | 1656 | RSS: Main: 320266240 19:19:30 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 19:19:32 INFO - PROCESS | 1656 | RSS: Main: 364109824 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | __start_tp_report 19:19:32 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 19:19:32 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 19:19:32 INFO - PROCESS | 1656 | |i|pagename|runs| 19:19:32 INFO - PROCESS | 1656 | |0;ai-astar;113;117;112;150;160;168;114;113;113;113 19:19:32 INFO - PROCESS | 1656 | |1;audio-beat-detection;146;110;110;144;109;110;110;111;158;140 19:19:32 INFO - PROCESS | 1656 | |2;audio-dft;184;184;184;184;185;183;181;181;183;183 19:19:32 INFO - PROCESS | 1656 | |3;audio-fft;84;60;60;89;60;61;48;62;87;82 19:19:32 INFO - PROCESS | 1656 | |4;audio-oscillator;90;71;86;69;68;69;82;69;69;83 19:19:32 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;88;85;88;86;89;85;90;85;92;85 19:19:32 INFO - PROCESS | 1656 | |6;imaging-darkroom;93;94;94;95;93;95;94;94;93;102 19:19:32 INFO - PROCESS | 1656 | |7;imaging-desaturate;87;86;84;87;84;87;86;86;87;85 19:19:32 INFO - PROCESS | 1656 | |8;json-parse-financial;57;56;56;55;57;55;56;55;56;55 19:19:32 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;67;66;77;78;74;71;71;71;72;75 19:19:32 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;87;88;88;89;87;86;89;85;100;108 19:19:32 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;141;146;127;127;142;148;151;147;179;151 19:19:32 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;172;173;173;173;172;175;172;206;171;166 19:19:32 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;67;68;67;65;66;66;66;66;67;65 19:19:32 INFO - PROCESS | 1656 | __end_tp_report 19:19:32 INFO - PROCESS | 1656 | __start_cc_report 19:19:32 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1978 19:19:32 INFO - PROCESS | 1656 | __end_cc_report 19:19:32 INFO - PROCESS | 1656 | __startTimestamp1485314372365__endTimestamp 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | ------- Summary: start ------- 19:19:32 INFO - PROCESS | 1656 | Number of tests: 14 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:127.30 Median:115.50 stddev:22.55 (19.5%) stddev-sans-first:23.32 19:19:32 INFO - PROCESS | 1656 | Values: 113.0 117.0 112.0 150.0 160.0 168.0 114.0 113.0 113.0 113.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:125.50 stddev:19.63 (15.6%) stddev-sans-first:19.26 19:19:32 INFO - PROCESS | 1656 | Values: 146.0 110.0 110.0 144.0 109.0 110.0 110.0 111.0 158.0 140.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:1.32 (0.7%) stddev-sans-first:1.36 19:19:32 INFO - PROCESS | 1656 | Values: 184.0 184.0 184.0 184.0 185.0 183.0 181.0 181.0 183.0 183.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:69.30 Median:72.00 stddev:14.58 (20.3%) stddev-sans-first:14.47 19:19:32 INFO - PROCESS | 1656 | Values: 84.0 60.0 60.0 89.0 60.0 61.0 48.0 62.0 87.0 82.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.50 stddev:8.59 (11.2%) stddev-sans-first:7.37 19:19:32 INFO - PROCESS | 1656 | Values: 90.0 71.0 86.0 69.0 68.0 69.0 82.0 69.0 69.0 83.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.00 stddev:2.50 (2.8%) stddev-sans-first:2.64 19:19:32 INFO - PROCESS | 1656 | Values: 88.0 85.0 88.0 86.0 89.0 85.0 90.0 85.0 92.0 85.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:94.00 stddev:2.67 (2.8%) stddev-sans-first:2.76 19:19:32 INFO - PROCESS | 1656 | Values: 93.0 94.0 94.0 95.0 93.0 95.0 94.0 94.0 93.0 102.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.50 stddev:1.20 (1.4%) stddev-sans-first:1.20 19:19:32 INFO - PROCESS | 1656 | Values: 87.0 86.0 84.0 87.0 84.0 87.0 86.0 86.0 87.0 85.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:0.79 (1.4%) stddev-sans-first:0.71 19:19:32 INFO - PROCESS | 1656 | Values: 57.0 56.0 56.0 55.0 57.0 55.0 56.0 55.0 56.0 55.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:73.00 stddev:3.91 (5.4%) stddev-sans-first:3.67 19:19:32 INFO - PROCESS | 1656 | Values: 67.0 66.0 77.0 78.0 74.0 71.0 71.0 71.0 72.0 75.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:87.50 stddev:7.36 (8.4%) stddev-sans-first:7.69 19:19:32 INFO - PROCESS | 1656 | Values: 87.0 88.0 88.0 89.0 87.0 86.0 89.0 85.0 100.0 108.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:147.50 stddev:14.56 (9.9%) stddev-sans-first:15.33 19:19:32 INFO - PROCESS | 1656 | Values: 141.0 146.0 127.0 127.0 142.0 148.0 151.0 147.0 179.0 151.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:173.00 stddev:11.04 (6.4%) stddev-sans-first:11.64 19:19:32 INFO - PROCESS | 1656 | Values: 172.0 173.0 173.0 173.0 172.0 175.0 172.0 206.0 171.0 166.0 19:19:32 INFO - PROCESS | 1656 | 19:19:32 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 19:19:32 INFO - PROCESS | 1656 | Values: 67.0 68.0 67.0 65.0 66.0 66.0 66.0 66.0 67.0 65.0 19:19:32 INFO - PROCESS | 1656 | -------- Summary: end -------- 19:19:32 INFO - PROCESS | 1656 | 19:19:33 INFO - TEST-INFO | 1656: exit 0 19:19:33 INFO - TEST-OK | kraken | took 59442ms 19:19:33 INFO - SUITE-END | took 1179s 19:19:33 INFO - Completed test suite (00:19:39) 19:19:33 INFO - javascript benchmark 19:19:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.885099021534, 3302.504624306354, 3302.917427064323, 3322.651121632227, 3346.782459140156, 5488.835334939949, 5545.916811247835, 5578.8605284867845, 5588.105903055512, 5605.187247849065, 5580.804671836477, 5585.1063829787245, 5599.524040456556, 5601.0, 5603.355614104379, 5052.595792336613, 5081.644284900059, 5100.795968161269, 5159.509846564571, 5180.2229665550285, 5151.845444636649, 5176.990486855065, 5183.948160518403, 5185.818496352628, 5191.818286359978, 5174.793008279665, 5182.196759502283, 5184.740762961856, 5186.014657215117, 5194.065068287726, 5121.359830021247, 5128.179491281415, 5135.537801597874, 5140.023395554833, 5143.12566863634, 4919.655624106314, 5091.669041512327, 5096.235564665293, 5099.464556221617, 5115.360579927509, 4575.4738205106505, 5615.971920140414, 5660.518855897254, 5666.093425051972, 5730.598858079936, 6041.395860413967, 6071.2714474263375, 6073.271207455089, 6085.026395776698, 6110.511159107261, 6078.787242446538, 6090.056041313604, 6104.0418789919695, 6142.744345496849, 6145.647957449354, 5745.741441635137, 5749.223854779635, 5751.108578170307, 5751.712414379264, 5756.971215143897, 6369.681515924185, 6393.136926514954, 6401.583897046677, 6403.519736019817, 6406.263279722798, 5864.736086876101, 5903.35063143054, 5914.9112763308585, 6042.6978651067275, 6048.818535443944, 6056.424639659225, 6124.969375153185, 6143.232095988002, 6165.691715414211, 6170.660613666291, 4810.621471168997, 6046.304674962347, 6064.79455868891, 6087.1173679816175, 6098.512119030467, 5084.3898732152375, 6046.697665116727, 6097.0, 6130.448259656652, 6149.169862068564, 4949.430815456197, 4960.379952505937, 4975.129352363394, 4990.076835785391, 5010.048090862724, 4415.84544540946, 4418.558144185556, 4421.712588681726, 4432.401625780479, 4454.131444368382, 5758.992176369119, 5762.135679648002, 5771.394003629643, 5777.24895763548, 5783.421657834183, 6122.908156377658, 6126.356732543019, 6146.832101900624, 6167.136600875881, 6222.81331560054, 4784.736839473862, 5776.480116789509, 5782.826515204551, 5806.2451881255165, 5822.446867547576, 5282.392524859613, 5329.200619906967, 5332.33345831771, 5340.599455040888, 5389.461053894657, 6249.625022498664, 6276.184096067574, 6294.339094395205, 6311.2426508819235, 6314.463270622048, 6111.804454079419, 6119.9596068669325, 6256.687165641609, 6268.216472940882, 6273.247210334789, 6165.075238714228, 6245.406686364788, 6259.436650701458, 6313.747450101944, 6331.2085989251345, 6118.785842495491, 6151.108089327112, 6152.107944348134, 6175.042868355412, 6188.102725104744, 6133.487685122301, 6139.140520327069, 6273.874522509615, 6281.528885333527, 6288.182536270256, 5754.68349240779, 6013.6692481913915, 6039.0, 6077.665728384981, 6139.3553676863285, 6058.666773327333, 6058.697065146813, 6063.454289114001, 6066.545009124245, 6077.179580756541, 5740.799072032626, 5750.453706897838, 5848.152017957457, 5882.264716910387, 5888.028475301699, 5934.584579079423, 6024.638521688713, 6033.366496517802, 6035.698215089315, 6103.186149163709, 5874.265716785402, 5881.97065513542, 5892.587518873637, 5895.41045895407, 5916.940830591639], "value": 5624.556524137613, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [451.214886098189, 457.32544496867126, 482.22361997184527, 486.7298649249665, 518.6006774783417, 31063.0, 35325.82337088314, 41849.581504184986, 43361.56638433615, 43384.0, 42988.57011429885, 43528.12943741123, 43920.0, 44314.556854431445, 44317.55682443175, 9290.814183716322, 9489.478078705668, 9493.52532373382, 9506.47714375709, 9510.00144984777, 8383.455075420108, 8592.097829727882, 11247.156463265288, 11481.483333250024, 11499.367534785584, 11491.597794077208, 11553.191276610598, 11557.364344961024, 11585.652430427059, 11587.015103716194, 11425.485853136628, 11491.827622585668, 11505.137114716346, 11519.48162332697, 11520.711982200428, 8344.499330040217, 8568.357373197035, 9282.628694852197, 11396.94301528487, 11438.19932604718, 41612.37581436281, 42034.369484457755, 42068.78965605152, 42143.0, 42217.94455138616, 4048.433219349264, 4058.147788964321, 4086.223617512663, 4098.036961314089, 4117.773522456264, 31310.0, 31360.529592056137, 31363.843180784177, 31385.686143138504, 31470.527942080887, 3150.558921750957, 3243.2378391078078, 3285.0801775502896, 3297.5713157289397, 3355.312161007012, 493348.0, 495006.0, 495531.0, 495763.9999999964, 496736.0, 61865.38134618596, 64178.67910660417, 64518.0, 64612.0, 64614.676926615066, 65211.021834672516, 65231.0, 68124.6593767028, 68282.0, 68433.0, 15873.841261587468, 16082.919585401998, 16090.034597924163, 16099.195040247942, 16118.597035073983, 10985.505652245669, 12272.877271227351, 12285.38573071343, 12402.81395779064, 12420.565280215149, 15300.311485983157, 15801.446949356718, 17771.933683979, 18147.00191489481, 18189.0, 6714.966425167843, 7083.929160708327, 7126.287371262936, 7132.679029443584, 7190.604516751629, 749.0786332810674, 837.3970741066422, 896.6189369517929, 899.7030979776658, 919.6827094652334, 29321.12036638904, 30171.09486715358, 30423.391532169677, 30661.540076898866, 31394.0, 925.8287216864767, 1051.5636011055478, 1087.4888802262924, 1103.2608152537819, 1174.9941250293864, 12149.5140194393, 15711.764323535157, 15775.368985240691, 16011.119388433515, 16271.918640406722, 594143.0, 598507.1194304446, 599195.0, 599294.0, 599775.0, 61663.0, 62103.44741381502, 62138.37861621416, 62309.0, 62384.0, 1405.845357010728, 1449.6883170118474, 1468.2511918921427, 1473.1897456398938, 1474.0345073976562, 28705.28236794097, 29717.554236686898, 29968.400631986802, 30725.0, 30854.691453085183, 51989.48010519846, 52493.63778629895, 52594.0, 52957.0, 56824.715876420356, 575447.0, 580183.0, 580721.0, 580739.0, 581034.0948295231, 24753.009879605335, 25045.624315635643, 25063.373415664755, 25123.623145653197, 25124.0, 43063.354049688656, 43474.69575912728, 44423.33364999463, 44746.3288050686, 46492.0, 27339.726602734514, 34490.96527104191, 35565.755198567924, 36036.81981590075, 36819.63180368162, 35668.92993210208, 36150.27699446049, 36360.818195908854, 36791.63208367882, 37135.628643713215, 35085.64914350926, 35699.929002129975, 35923.640763592026, 36274.63725362712, 36600.63399365972, 31346.843265783526, 32489.350212995134, 32573.674263257064, 32862.83568582142, 32939.17652058718, 19958.800411995693, 22076.0, 23857.045718171077, 24127.758722412553, 24441.26676199717], "value": 20015.191948055864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.7238455889332, 367.23798118903284, 388.1848118950203, 392.9960700392995, 415.6383945967009, 15791.447299344525, 15973.840261597381, 19679.114439850204, 20488.28291009815, 20829.791702082974, 20432.591348173064, 20968.0, 21373.57252854942, 21386.25148119816, 21402.46493837655, 5230.816921407752, 5493.011257973563, 5498.835034948938, 5499.972500137494, 5501.0648189807625, 4928.260760885878, 5391.245225668409, 5421.186821976716, 5486.972565137169, 5490.560755139599, 5766.279215098113, 5842.795502157425, 5925.585209035347, 5964.687768690881, 5985.820425387224, 5617.634853734494, 5859.824205273806, 5910.8817823643285, 5931.317898441648, 5967.850803729898, 5273.288106105665, 5284.233786101032, 5294.894102117974, 5295.179247216687, 5296.020236256267, 13418.731625367438, 13593.388297526635, 13624.931875340659, 13627.04610677253, 14243.501477448239, 2616.7644911958014, 2648.708642049373, 2654.5487267164626, 2663.760261576448, 2664.5869890167055, 9992.45041522716, 10044.849327260097, 10503.159747220205, 12599.496020159182, 14338.068025578305, 1415.695625440525, 1840.7054871220673, 1957.363856746563, 1962.0876292524044, 1963.7839837617994, 119618.40190799077, 124529.0, 130295.34852325772, 134541.0, 136202.3189884054, 10901.890981090246, 11318.207725459304, 11475.31148131098, 11804.17370784054, 12029.458674359676, 14417.855821441652, 14799.260036998106, 14815.777763333559, 15543.689126217412, 15596.298166582532, 7033.788986330418, 8507.65969361231, 8662.220400164015, 8762.605682744292, 8787.989381221114, 8280.668773249003, 8291.792705182297, 8457.281131103802, 8461.40770146084, 8477.95761021191, 4651.279051746985, 4758.666893317434, 4760.09558183944, 4765.309030190603, 4894.681845680019, 2010.879347239141, 2028.7869773673847, 2033.1562401603464, 2033.7356143701224, 2040.9693854592192, 1011.246621267146, 1015.3501758874327, 1025.8666373371414, 1037.8287582548946, 1065.6110519660424, 16622.75065874013, 20099.0, 20566.0, 20929.47676308074, 21198.04608792608, 820.7168526858225, 829.9832704936405, 881.5239770523973, 960.2510042167121, 963.2582911158369, 10174.898251017396, 10435.269531132748, 10801.83797243042, 10855.837162442569, 10874.293170943864, 714900.0, 718158.0, 740944.0, 743938.0, 748632.0, 137016.0, 153642.0, 155464.22267888588, 155735.6639650406, 158167.0, 1088.1186239146316, 1102.5699977008974, 1116.4752566293828, 1116.8492253545667, 1118.3401792942202, 17814.821851781315, 18427.078646067912, 18492.35276765307, 18513.814861851748, 18598.628027439645, 54491.91016179575, 54497.18254226111, 55513.444865550824, 55671.16493252685, 55781.44218557762, 78233.60883195775, 78565.0, 79156.0, 80853.0, 81543.0, 7991.600419979094, 8222.794430139294, 8586.828263434822, 8780.121987801169, 8800.207981281459, 12891.613251602466, 12987.740245194855, 13012.414441349973, 13494.797578036141, 13495.190288582717, 9168.495732734764, 11527.538898443969, 11635.069194464591, 11787.469563869476, 11835.0, 11030.44847757625, 11215.71960700989, 11382.772344553228, 11436.542538298374, 11766.176367654525, 11471.02496287825, 11542.769144617228, 11874.109441791727, 11941.283522988648, 11997.580084696994, 8467.449615774955, 8485.0, 8488.278496327881, 8495.532745699045, 8515.48907065578, 9762.0, 11181.161412893904, 11579.305241685526, 11624.6512604622, 11638.359890205782], "value": 9653.70393907823, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.633341664584, 1472.227080782589, 1474.9483768068117, 1491.015929486539, 1493.805805245318, 8067.152948940365, 8493.362997775175, 8501.957490212548, 8506.234438900505, 8507.78730531737, 7464.626768661572, 7692.0769507659015, 7697.692092316301, 7994.760157195279, 8279.710210142646, 2278.1798552521077, 2325.6511523271474, 2327.6392159215347, 2329.2662811214414, 2338.0414030247516, 2310.353101131686, 2341.6136337504377, 2349.8942547585316, 2350.753170917046, 2351.7295511016196, 2277.5900337939165, 2279.977200227993, 2291.8854057297153, 2326.5928462519078, 2329.2080692564523, 2280.9771902281013, 2305.4927915858484, 2306.3772781349107, 2307.1348244408346, 2307.573098976695, 2255.560165767676, 2328.9650655240184, 2330.0679728108894, 2332.988335058331, 2341.672165896776, 8350.582470876492, 8427.70503032397, 8435.283000944926, 8444.493330400195, 8450.661973521052, 4632.726000349897, 5004.599632029465, 5110.156824124015, 5177.404598471187, 5186.896262074737, 2920.9630581143815, 3206.246532064963, 3515.2090779574646, 3562.608113107556, 3569.803660798655, 1203.5787474383983, 1216.8843959823803, 1221.9633410997596, 1266.366816591704, 1269.2891980490954, 10619.469026548719, 10629.468526573717, 10735.62425315118, 10743.62397316098, 10752.838707419394, 4359.498657654347, 4594.839180628729, 4681.625469962395, 4686.95313046872, 4691.085238378483, 9440.24478041755, 9465.0, 9468.14786669203, 9471.052894710612, 9490.430574165572, 5215.400228973716, 5219.321488206585, 5232.39827419844, 5233.607479439057, 5233.633645644844, 4216.114615930627, 4486.663500237495, 4686.5782079613, 4712.95287047132, 4798.4001999750035, 3627.111357717376, 3647.8905632831056, 3713.424419215026, 3734.514513113332, 3774.226283611853, 1261.873812618749, 1261.924284542912, 1263.1284413754663, 1272.6627443727234, 1287.4013583683632, 680.3094858718405, 855.8331125430606, 869.599984007351, 877.2236570634907, 878.3939082033377, 4557.567031132037, 5318.7074710891275, 5366.812161574326, 5432.864178395493, 5451.863703407367, 970.84466485362, 987.819555631014, 991.2169386184977, 993.8707967964118, 1008.5511947183579, 3229.6770322967513, 3449.6205417404067, 3634.8546058157376, 3637.454381842692, 3802.16352402471, 9753.853692194623, 9841.0, 9973.700788976343, 10078.496075196357, 10101.14140298083, 9921.156701680293, 9995.050470205319, 10013.349132306377, 10033.949830250947, 10040.548175332127, 7304.306090921354, 7609.619519024027, 7658.157602663702, 7703.0, 7709.190534993745, 5451.509364157245, 5481.287432633732, 5528.336599608073, 5580.637258578179, 5645.802396916089, 8858.247049000649, 8879.644814207359, 9135.77160570991, 9237.630494780402, 9347.0, 9102.908970910206, 9106.0, 9316.068393160629, 9326.207272381924, 9348.0, 7089.397401220954, 7340.1191856975365, 7362.7054917804835, 7614.619269036415, 7861.685532578633, 7536.547807131589, 7829.217078292125, 7838.3337416320255, 7927.722529711433, 7937.8412431752195, 6976.337247961435, 7061.2232654409, 7095.538789978635, 7127.928720712726, 7261.6006119663925, 6816.318368163343, 6981.813126523754, 7049.118860142482, 7066.399356054793, 7143.285671432815, 6338.144350512622, 6370.458511026614, 6449.806505804833, 6461.773837915651, 6463.515236357386, 4905.288733133747, 4931.3835770528685, 4993.201087825931, 5064.72144032067, 5082.847514574569, 4852.8348909657325, 4880.292357608056, 4989.600831933364, 5129.358830146231, 5154.407243167084], "value": 4403.074365871925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.3409935873444, 349.6713089695686, 358.6700235783079, 367.6158414456892, 370.79606216580856, 4436.511983681792, 4899.412070551539, 5065.240213967907, 5077.822276220333, 5151.871203219916, 4923.9753801230945, 4958.752062396884, 5027.698338099716, 5083.186690129571, 5093.516115968977, 3368.292658541709, 4039.252738243427, 4055.858044968427, 4062.309407400749, 4078.7552746835136, 3350.5979282486014, 3701.3541661463437, 4078.796060196993, 4088.8773336799945, 4096.426500289962, 3997.34043882759, 4040.717149799515, 4041.2725709372303, 4057.2088442753675, 4079.8164082616204, 3312.585926759155, 3999.70002249831, 4030.717849750519, 4035.16400037982, 4062.531215662777, 3003.6695963444004, 3557.008075477741, 3601.1537288737127, 3601.819909004539, 3610.9097272568397, 4170.249355116078, 4447.866564003085, 4748.592196173945, 4968.7826482511655, 5074.441811400743, 4046.332355161395, 4334.219840428722, 4349.412464450453, 4641.628669706415, 4671.299305104228, 4535.342375355588, 4603.746793926332, 5400.756965936543, 5412.9458705412835, 5416.214648875891, 3498.2478767065204, 3593.9936817691087, 3718.2563487302377, 3897.824597893102, 3900.765954042738, 4882.0959825668015, 5185.870353241162, 5402.459754024605, 5687.175359572839, 5691.743871525791, 3707.8516859325864, 3924.9018774530864, 4002.3196056670436, 4035.092104276573, 4050.7569545827346, 3948.269570129535, 4110.0, 4111.9177616447505, 4117.3206420940205, 4131.97934010328, 4582.24392975162, 4604.700694454849, 4623.289382928271, 4633.814647414066, 4638.443386793607, 4626.2011483052265, 5250.789968401297, 5462.9726851365485, 5482.396936337, 5483.424240454775, 1258.9496420143091, 1295.8121072444442, 1302.5021225590458, 1308.188922867828, 1335.0041687676985, 791.3392317415023, 860.6600392844916, 885.6059053721161, 952.8142012307673, 963.0, 4482.081173359454, 4528.139653465831, 4617.6536759742485, 4875.5124487551675, 4890.486498917634, 4936.456989731127, 4964.840294471916, 5230.450802665741, 5393.649412788156, 5402.837914862561, 4432.160653328897, 4618.907621847544, 4888.975555122272, 4905.264210368473, 4934.851954441372, 2505.5991041433285, 2798.0, 2805.312698388908, 2805.438912217565, 2819.4079243358715, 4643.976780116078, 5326.46735326472, 5420.403755586883, 5565.721713914288, 5568.0, 5484.341878974548, 5507.449255074461, 5533.6797921247735, 5535.833924982257, 5567.162836264023, 5111.795528178831, 5431.53831924283, 5561.916571251434, 5571.832845014656, 5610.551155907436, 4675.412881606448, 5081.288619593334, 5100.795968161232, 5369.57043436532, 5381.515663590296, 4770.1565582161575, 4875.341828853059, 5042.520960508746, 5245.3214971208845, 5259.21186796491, 4596.4024676791805, 5070.822521211888, 5490.91763623538, 5495.945040549704, 5536.090048933112, 3211.9122570329473, 3377.6622337766025, 3721.330160571123, 3851.785223496445, 3854.5567259765485, 4356.736546401635, 4624.577812418853, 4718.631596836879, 5130.97434512825, 5157.871053223549, 4618.792154353129, 4948.406191257072, 5164.896702066013, 5197.506236907488, 5225.171190083441, 4519.028408892104, 4943.604511639132, 5112.667676601009, 5141.640085194001, 5188.948110518997, 4176.832926682899, 4615.284630882219, 4656.043412433197, 4795.520447955177, 5236.502532259429, 4535.31970204472, 5359.775693087325, 5390.245365648734, 5399.892002160013, 5422.755975981169, 4241.724287921399, 5238.319018527567, 5329.813456529003, 5341.370881881064, 5341.946580534301], "value": 3933.5424198570727, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.2386212682651, 727.7271023366237, 779.699815571005, 794.1105961323317, 819.5697258939058, 14778.113313201202, 15690.607734806636, 15744.0, 15761.763573546392, 15816.762748558767, 13979.720405591908, 14378.712425751479, 14395.496157634485, 14579.92710036451, 14599.635009124777, 674.6491824251386, 693.8577591593736, 696.0, 851.0213254757017, 861.6811779641525, 852.9872051919226, 854.2824027816632, 864.9697260595881, 867.1371984875058, 867.600903584352, 872.084311472954, 873.462820365477, 906.0260220263243, 910.6038873090193, 913.9314551408638, 708.4084789201023, 731.8316787138934, 907.8093600343935, 910.4400793512009, 910.6038873090193, 544.23806670661, 545.6480570032307, 547.9971651877095, 676.8984652302145, 693.0505207865207, 12590.0, 15165.24173791306, 15187.0, 15221.31504082319, 15242.085474871543, 13441.395137218751, 13478.460861565525, 13510.32448377587, 13534.864651353557, 13656.522021729292, 12478.251304921734, 12534.498620055187, 12564.81152782709, 12622.684432889251, 12666.176698514659, 4289.142171565668, 4308.482982042144, 4327.697061205717, 4327.913441731148, 4493.146302202571, 99013.50493247488, 102552.0, 102939.97060029379, 103634.48182759038, 104001.0, 8485.32117430604, 10291.279610427348, 10763.300385474919, 10800.973907478778, 10975.615853445252, 20539.897300513403, 20566.0, 21337.46656333573, 21422.357329279836, 21429.03569339352, 6597.967010164918, 7401.185869554345, 7406.296401841816, 7441.925580744231, 7726.150123486412, 3655.8720444784835, 3665.450182472597, 3753.680937120321, 3754.630065800254, 3767.2088861339425, 3367.663233676613, 3391.8304084795664, 3427.6915077642634, 3459.7924124552605, 3466.376052310558, 633.5786701843223, 637.4995628431659, 641.9325970773095, 646.9708863101172, 649.162580271454, 555.8799019974754, 620.6679426506887, 634.2515831319088, 641.5284765697209, 672.4049216443483, 7610.543367397974, 9665.468399238109, 9673.333763789093, 9676.612935482643, 9818.607255709834, 602.3524710935761, 657.2015001772869, 661.8577005943745, 668.1180841289452, 668.3383450384084, 4553.6357091433265, 4711.340412342275, 4817.421909370898, 4903.436104847988, 5318.22885681574, 96302.0, 99214.0, 100472.99527004636, 100550.0, 101716.0, 66371.6725665484, 74184.62907685534, 82622.58688706518, 83047.0, 84072.0, 61537.384626153165, 75154.0, 79062.20937790663, 79524.20475795283, 80228.0, 10610.946945265225, 10735.624253151102, 10827.296225745302, 10873.565057397616, 10903.454827258447, 50106.0, 50199.74900125476, 50709.23936140887, 51075.723106922625, 52179.73910130425, 67429.66285168739, 68458.65770671115, 68537.62924741577, 69767.30232697607, 69817.0, 12846.678833028875, 12921.806172907225, 12927.030472714772, 13330.733385332433, 13389.263590502616, 14524.49164279245, 14542.127472351693, 14696.926515367355, 15093.47172848945, 15119.244037798286, 13396.732065358834, 13538.390772415461, 13632.0, 13778.0, 13847.930760346537, 13565.118267312593, 13597.320133993459, 13746.450141994608, 14049.367778450198, 14178.0, 13130.409131589293, 13536.932315338361, 13642.0, 13792.586222413343, 13917.860821391656, 9636.22910167171, 11239.213255072067, 11512.013832303237, 11595.710107247387, 11979.640610781691, 10426.061654451136, 10804.297720648132, 11085.778284434427, 11107.777844442904, 11135.610253641084], "value": 7376.796141856658, "unit": "score"}], "name": "dromaeo_css", "value": 7196.1447857659405, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 112.0, 150.0, 160.0, 168.0, 114.0, 113.0, 113.0, 113.0], "value": 127.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 110.0, 144.0, 109.0, 110.0, 110.0, 111.0, 158.0, 140.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 184.0, 184.0, 185.0, 183.0, 181.0, 181.0, 183.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 60.0, 60.0, 89.0, 60.0, 61.0, 48.0, 62.0, 87.0, 82.0], "value": 69.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 86.0, 69.0, 68.0, 69.0, 82.0, 69.0, 69.0, 83.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 89.0, 85.0, 90.0, 85.0, 92.0, 85.0], "value": 87.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 93.0, 95.0, 94.0, 94.0, 93.0, 102.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 84.0, 87.0, 84.0, 87.0, 86.0, 86.0, 87.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 55.0, 57.0, 55.0, 56.0, 55.0, 56.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 77.0, 78.0, 74.0, 71.0, 71.0, 71.0, 72.0, 75.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 89.0, 87.0, 86.0, 89.0, 85.0, 100.0, 108.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 146.0, 127.0, 127.0, 142.0, 148.0, 151.0, 147.0, 179.0, 151.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 173.0, 173.0, 173.0, 172.0, 175.0, 172.0, 206.0, 171.0, 166.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1454.3, "alertThreshold": 2.0}]} 19:19:33 INFO - Return code: 0 19:19:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:19:33 ERROR - # TBPL SUCCESS # 19:19:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:19:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:19:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:19:33 INFO - 2017-01-24 19:19:33.687 screenresolution[1660:9768] starting screenresolution argv=screenresolution get 19:19:33 INFO - 2017-01-24 19:19:33.690 screenresolution[1660:9768] Display 0: 1600x1200x32@60 19:19:33 INFO - 2017-01-24 19:19:33.696 screenresolution[1661:9771] starting screenresolution argv=screenresolution list 19:19:33 INFO - Available Modes on Display 0 19:19:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:19:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:19:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:19:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:19:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:19:33 INFO - Intel Iris: 19:19:33 INFO - Chipset Model: Intel Iris 19:19:33 INFO - Type: GPU 19:19:33 INFO - Bus: Built-In 19:19:33 INFO - VRAM (Dynamic, Max): 1536 MB 19:19:33 INFO - Vendor: Intel (0x8086) 19:19:33 INFO - Device ID: 0x0a2e 19:19:33 INFO - Revision ID: 0x0009 19:19:33 INFO - Displays: 19:19:33 INFO - Display: 19:19:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:19:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:19:33 INFO - Display Serial Number: 1600x1200 60 19:19:33 INFO - Main Display: Yes 19:19:33 INFO - Mirror: Off 19:19:33 INFO - Online: Yes 19:19:33 INFO - Rotation: Supported 19:19:33 INFO - Return code: 0 19:19:33 INFO - Running post-action listener: _resource_record_post_action 19:19:33 INFO - [mozharness: 2017-01-25 03:19:33.932245Z] Finished run-tests step (success) 19:19:33 INFO - Running post-run listener: _resource_record_post_run 19:19:33 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37377024; Write bytes: 551920640; Read time: 235; Write time: 1649 19:19:33 INFO - TinderboxPrint: CPU usage
53.7% 19:19:33 INFO - TinderboxPrint: I/O read bytes / time
37,377,024 / 235 19:19:33 INFO - TinderboxPrint: I/O write bytes / time
551,920,640 / 1,649 19:19:33 INFO - TinderboxPrint: CPU idle
2,226.9 (46.3%) 19:19:33 INFO - TinderboxPrint: CPU system
963.7 (20.0%) 19:19:33 INFO - TinderboxPrint: CPU user
1,619.0 (33.7%) 19:19:33 INFO - TinderboxPrint: Swap in / out
289,296,384 / 0 19:19:33 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243636736; Write bytes: 237585920; Read time: 17793; Write time: 515 19:19:34 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35316736; Write bytes: 296648192; Read time: 214; Write time: 1094 19:19:34 INFO - Running post-run listener: _upload_blobber_files 19:19:34 INFO - Blob upload gear active. 19:19:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:19:34 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 19:19:34 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'] 19:19:34 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 19:19:34 INFO - (blobuploader) - INFO - Open directory for files ... 19:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:19:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:35 INFO - (blobuploader) - INFO - Done attempting. 19:19:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:19:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:19:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:36 INFO - (blobuploader) - INFO - Done attempting. 19:19:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:19:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:19:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:37 INFO - (blobuploader) - INFO - Done attempting. 19:19:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:19:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:19:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:40 INFO - (blobuploader) - INFO - Done attempting. 19:19:40 INFO - (blobuploader) - INFO - Iteration through files over. 19:19:40 INFO - Return code: 0 19:19:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:19:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:19:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7ae5a3a99e3ba308a820bacdf557cb13724094c17bc8f6fff50d9ec8bae3cbc28c7a54688d77152fe625c7239f14bb3dac48000de33721ad7b1c66d423a440c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8f88adc56db9890c28063a140641ec47f6ce41b7b661b80c0f73b1a542e5d9f5e203ef3b1f0676ecc9504403a1f6cf7c2920f09aa9ba957b83b77be1c0f989", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0bdfce4d09d3b610d03f484a9e12c9670a2907cb85c37dd52736578db345a87e3f05f4b8859ef49bb0f22a999598f415eca1a709a33ebb6bd7a35bd4bd3ff36", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a223bf356b07ed06277038c8dcd0a111ff7b02f447f6b397f6608d087e1760b71220dcbb1bfb0bc92306f4007a38c656dc375c27112eb0e750b37b1ee97dda7"} 19:19:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:19:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:19:40 INFO - Contents: 19:19:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7ae5a3a99e3ba308a820bacdf557cb13724094c17bc8f6fff50d9ec8bae3cbc28c7a54688d77152fe625c7239f14bb3dac48000de33721ad7b1c66d423a440c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8f88adc56db9890c28063a140641ec47f6ce41b7b661b80c0f73b1a542e5d9f5e203ef3b1f0676ecc9504403a1f6cf7c2920f09aa9ba957b83b77be1c0f989", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0bdfce4d09d3b610d03f484a9e12c9670a2907cb85c37dd52736578db345a87e3f05f4b8859ef49bb0f22a999598f415eca1a709a33ebb6bd7a35bd4bd3ff36", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a223bf356b07ed06277038c8dcd0a111ff7b02f447f6b397f6608d087e1760b71220dcbb1bfb0bc92306f4007a38c656dc375c27112eb0e750b37b1ee97dda7"} 19:19:40 INFO - Running post-run listener: copy_logs_to_upload_dir 19:19:40 INFO - Copying logs to upload dir... 19:19:40 INFO - mkdir: /builds/slave/test/build/upload/logs 19:19:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.555783 ========= master_lag: 4.01 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-01-24 19:19:44.221696) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:44.225123) ========= 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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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/e7ae5a3a99e3ba308a820bacdf557cb13724094c17bc8f6fff50d9ec8bae3cbc28c7a54688d77152fe625c7239f14bb3dac48000de33721ad7b1c66d423a440c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8f88adc56db9890c28063a140641ec47f6ce41b7b661b80c0f73b1a542e5d9f5e203ef3b1f0676ecc9504403a1f6cf7c2920f09aa9ba957b83b77be1c0f989", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0bdfce4d09d3b610d03f484a9e12c9670a2907cb85c37dd52736578db345a87e3f05f4b8859ef49bb0f22a999598f415eca1a709a33ebb6bd7a35bd4bd3ff36", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a223bf356b07ed06277038c8dcd0a111ff7b02f447f6b397f6608d087e1760b71220dcbb1bfb0bc92306f4007a38c656dc375c27112eb0e750b37b1ee97dda7"} build_url:https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010859 build_url: 'https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7ae5a3a99e3ba308a820bacdf557cb13724094c17bc8f6fff50d9ec8bae3cbc28c7a54688d77152fe625c7239f14bb3dac48000de33721ad7b1c66d423a440c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a8f88adc56db9890c28063a140641ec47f6ce41b7b661b80c0f73b1a542e5d9f5e203ef3b1f0676ecc9504403a1f6cf7c2920f09aa9ba957b83b77be1c0f989", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0bdfce4d09d3b610d03f484a9e12c9670a2907cb85c37dd52736578db345a87e3f05f4b8859ef49bb0f22a999598f415eca1a709a33ebb6bd7a35bd4bd3ff36", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3a223bf356b07ed06277038c8dcd0a111ff7b02f447f6b397f6608d087e1760b71220dcbb1bfb0bc92306f4007a38c656dc375c27112eb0e750b37b1ee97dda7"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:44.274466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:44.274820) ========= 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.y2fdNSUFoO/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.dbHAwlJvAX/Listeners TMPDIR=/var/folders/qj/gk52w8cx1cd0gbstqffnnfqm00000w/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.005123 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:44.327165) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 19:19:44.330077) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 19:19:44.330428) ========= ========= Total master_lag: 4.17 =========