builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0316 starttime: 1485313112.03 results: success (0) buildid: 20170117083128 builduid: 766930557a084bc7938a387b284f4528 revision: 6a23526fe5168087d7e4132c0705aefcaed5f571 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.029296) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.029924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.030373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.056685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.057096) ========= 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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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-- 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% 58.7M=0s 2017-01-24 18:58:32 (58.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146026 ========= master_lag: 0.33 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.537156) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.537488) ========= 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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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.021612 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:32.580290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 18:58:32.580632) ========= 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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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,675 truncating revision to first 12 chars 2017-01-24 18:58:32,675 Setting DEBUG logging. 2017-01-24 18:58:32,675 attempt 1/10 2017-01-24 18:58:32,675 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,873 unpacking tar archive at: mozilla-central-6a23526fe516/testing/mozharness/ program finished with exit code 0 elapsedTime=1.453351 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 18:58:34.057277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:34.060674) ========= script_repo_revision: 6a23526fe5168087d7e4132c0705aefcaed5f571 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:34.061104) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:34.061389) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 18:58:34.080864) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-24 18:58:34.081259) ========= /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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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:34 INFO - MultiFileLogger online at 20170124 18:58:34 in /builds/slave/test 18:58:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:58:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:58:34 INFO - {'append_to_log': False, 18:58:34 INFO - 'base_work_dir': '/builds/slave/test', 18:58:34 INFO - 'blob_upload_branch': 'Firefox', 18:58:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:58:34 INFO - 'branch': 'Firefox', 18:58:34 INFO - 'buildbot_json_path': 'buildprops.json', 18:58:34 INFO - 'config_files': ('talos/mac_config.py',), 18:58:34 INFO - 'default_actions': ('clobber', 18:58:34 INFO - 'read-buildbot-config', 18:58:34 INFO - 'download-and-extract', 18:58:34 INFO - 'populate-webroot', 18:58:34 INFO - 'create-virtualenv', 18:58:34 INFO - 'install', 18:58:34 INFO - 'run-tests'), 18:58:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:58:34 INFO - 'download_minidump_stackwalk': True, 18:58:34 INFO - 'download_symbols': 'ondemand', 18:58:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:58:34 INFO - 'tooltool.py': '/tools/tooltool.py', 18:58:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:58:34 INFO - '/tools/misc-python/virtualenv.py')}, 18:58:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:58:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:58:34 INFO - 'installer_path': 'installer.exe', 18:58:34 INFO - 'log_level': 'info', 18:58:34 INFO - 'log_name': 'talos', 18:58:34 INFO - 'log_to_console': True, 18:58:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:58:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:58:34 INFO - 'opt_config_files': (), 18:58:34 INFO - 'pip_index': False, 18:58:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:58:34 INFO - 'cmd': ('bash', 18:58:34 INFO - '-c', 18:58:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:58:34 INFO - 'enabled': True, 18:58:34 INFO - 'halt_on_failure': False, 18:58:34 INFO - 'name': 'check_screen_resolution'},), 18:58:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:58:34 INFO - 'cmd': ('bash', 18:58:34 INFO - '-c', 18:58:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:58:34 INFO - 'enabled': True, 18:58:34 INFO - 'halt_on_failure': False, 18:58:34 INFO - 'name': 'check_screen_resolution'},), 18:58:34 INFO - 'run_cmd_checks_enabled': True, 18:58:34 INFO - 'sps_profile': False, 18:58:34 INFO - 'sps_profile_interval': 0, 18:58:34 INFO - 'suite': 'dromaeojs', 18:58:34 INFO - 'system_bits': '32', 18:58:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:58:34 INFO - 'title': 't-yosemite-r7-0316', 18:58:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:58:34 INFO - 'use_talos_json': True, 18:58:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:58:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:58:34 INFO - 'work_dir': 'build'} 18:58:34 INFO - [mozharness: 2017-01-25 02:58:34.294723Z] Running clobber step. 18:58:34 INFO - Running pre-action listener: _resource_record_pre_action 18:58:34 INFO - Running main action method: clobber 18:58:34 INFO - rmtree: /builds/slave/test/build 18:58:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:58:35 INFO - Running post-action listener: _resource_record_post_action 18:58:35 INFO - [mozharness: 2017-01-25 02:58:35.784173Z] Finished clobber step (success) 18:58:35 INFO - [mozharness: 2017-01-25 02:58:35.784322Z] Running read-buildbot-config step. 18:58:35 INFO - Running pre-action listener: _resource_record_pre_action 18:58:35 INFO - Running main action method: read_buildbot_config 18:58:35 INFO - Using buildbot properties: 18:58:35 INFO - { 18:58:35 INFO - "project": "", 18:58:35 INFO - "product": "firefox", 18:58:35 INFO - "script_repo_revision": "production", 18:58:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:58:35 INFO - "repository": "", 18:58:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:58:35 INFO - "buildid": "20170117083128", 18:58:35 INFO - "pgo_build": "False", 18:58:35 INFO - "basedir": "/builds/slave/test", 18:58:35 INFO - "buildnumber": 23, 18:58:35 INFO - "slavename": "t-yosemite-r7-0316", 18:58:35 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 18:58:35 INFO - "platform": "yosemite_r7", 18:58:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:58:35 INFO - "branch": "mozilla-central", 18:58:35 INFO - "repo_path": "mozilla-central", 18:58:35 INFO - "revision": "6a23526fe5168087d7e4132c0705aefcaed5f571", 18:58:35 INFO - "stage_platform": "macosx64", 18:58:35 INFO - "builduid": "766930557a084bc7938a387b284f4528", 18:58:35 INFO - "slavebuilddir": "test" 18:58:35 INFO - } 18:58:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 18:58:35 INFO - Running post-action listener: _resource_record_post_action 18:58:35 INFO - [mozharness: 2017-01-25 02:58:35.787747Z] Finished read-buildbot-config step (success) 18:58:35 INFO - [mozharness: 2017-01-25 02:58:35.787841Z] Running download-and-extract step. 18:58:35 INFO - Running pre-action listener: _resource_record_pre_action 18:58:35 INFO - Running main action method: download_and_extract 18:58:35 INFO - mkdir: /builds/slave/test/build/tests 18:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:35 INFO - trying https://queue.taskcluster.net/v1/task/GcbUBbm3Q2OUSE5H79AZ6Q/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:35 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:35 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:37 INFO - Downloaded 1199 bytes. 18:58:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 18:58:37 INFO - Using the following test package requirements: 18:58:37 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:58:37 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 18:58:37 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 18:58:37 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'jsshell-mac.zip'], 18:58:37 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 18:58:37 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 18:58:37 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 18:58:37 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 18:58:37 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 18:58:37 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 18:58:37 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 18:58:37 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:58:37 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:37 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:37 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:38 INFO - Expected file size: 16326298 18:58:38 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:52 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:52 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:52 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.960528Z] Finished download-and-extract step (success) 18:58:56 INFO - [mozharness: 2017-01-25 02:58:56.960662Z] 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.979361Z] Finished populate-webroot step (success) 18:58:56 INFO - [mozharness: 2017-01-25 02:58:56.979475Z] 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:01 INFO - Reading from file tmpfile_stdout 18:59:01 INFO - Output received: 18:59:01 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:01 INFO - Installing pip>=1.5 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: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 0x105df2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc998570300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, '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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 18:59:01 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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: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', '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 0x105df2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc998570300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, '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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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', 'psutil>=3.1.1'] 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 psutil>=3.1.1 18:59:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 18:59:01 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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 - Downloading/unpacking psutil>=3.1.1 18:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:59:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:05 INFO - Installing collected packages: psutil 18:59:05 INFO - Running setup.py install for psutil 18:59:05 INFO - building 'psutil._psutil_osx' extension 18:59:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:59:06 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:06 INFO - building 'psutil._psutil_posix' extension 18:59:06 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:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:59:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:59:06 INFO - ^ 18:59:06 INFO - 1 warning generated. 18:59:06 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: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 - Successfully installed psutil 18:59:06 INFO - Cleaning up... 18:59:06 INFO - Return code: 0 18:59:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:06 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 0x105df2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc998570300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, '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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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:06 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:06 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:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.86ma5WXb6M/Render', 18:59:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:06 INFO - 'HOME': '/Users/cltbld', 18:59:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:06 INFO - 'LOGNAME': 'cltbld', 18:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:06 INFO - 'MOZ_NO_REMOTE': '1', 18:59:06 INFO - 'NO_EM_RESTART': '1', 18:59:06 INFO - 'PAGER': '/bin/cat', 18:59:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:06 INFO - 'PWD': '/builds/slave/test', 18:59:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:06 INFO - 'SHELL': '/bin/bash', 18:59:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4t2Tc1CxNQ/Listeners', 18:59:06 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 18:59:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:06 INFO - 'USER': 'cltbld', 18:59:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:06 INFO - 'XPC_FLAGS': '0x0', 18:59:06 INFO - 'XPC_SERVICE_NAME': '0', 18:59:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:59:09 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:09 INFO - Installing collected packages: mozsystemmonitor 18:59:09 INFO - Running setup.py install for mozsystemmonitor 18:59:09 INFO - Successfully installed mozsystemmonitor 18:59:09 INFO - Cleaning up... 18:59:09 INFO - Return code: 0 18:59:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105df2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc998570300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, '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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:59:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.86ma5WXb6M/Render', 18:59:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:09 INFO - 'HOME': '/Users/cltbld', 18:59:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:09 INFO - 'LOGNAME': 'cltbld', 18:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:09 INFO - 'MOZ_NO_REMOTE': '1', 18:59:09 INFO - 'NO_EM_RESTART': '1', 18:59:09 INFO - 'PAGER': '/bin/cat', 18:59:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:09 INFO - 'PWD': '/builds/slave/test', 18:59:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:09 INFO - 'SHELL': '/bin/bash', 18:59:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4t2Tc1CxNQ/Listeners', 18:59:09 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 18:59:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:09 INFO - 'USER': 'cltbld', 18:59:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:09 INFO - 'XPC_FLAGS': '0x0', 18:59:09 INFO - 'XPC_SERVICE_NAME': '0', 18:59:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:09 INFO - Downloading/unpacking jsonschema==2.5.1 18:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:59:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:59:12 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:12 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:12 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:12 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:12 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:12 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:12 INFO - Downloading functools32-3.2.3-2.tar.gz 18:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:59:13 INFO - warning: no files found matching '*.txt' 18:59:13 INFO - no previously-included directories found matching 'build' 18:59:13 INFO - no previously-included directories found matching 'dist' 18:59:13 INFO - no previously-included directories found matching '.git*' 18:59:13 INFO - Installing collected packages: jsonschema, functools32 18:59:13 INFO - Running setup.py install for functools32 18:59:13 INFO - warning: no files found matching '*.txt' 18:59:13 INFO - no previously-included directories found matching 'build' 18:59:13 INFO - no previously-included directories found matching 'dist' 18:59:13 INFO - no previously-included directories found matching '.git*' 18:59:13 INFO - Successfully installed jsonschema functools32 18:59:13 INFO - Cleaning up... 18:59:13 INFO - Return code: 0 18:59:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:13 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 0x105df2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc998570300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, '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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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:13 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:13 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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.86ma5WXb6M/Render', 18:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:13 INFO - 'HOME': '/Users/cltbld', 18:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:13 INFO - 'LOGNAME': 'cltbld', 18:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:13 INFO - 'MOZ_NO_REMOTE': '1', 18:59:13 INFO - 'NO_EM_RESTART': '1', 18:59:13 INFO - 'PAGER': '/bin/cat', 18:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:13 INFO - 'PWD': '/builds/slave/test', 18:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:13 INFO - 'SHELL': '/bin/bash', 18:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4t2Tc1CxNQ/Listeners', 18:59:13 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 18:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:13 INFO - 'USER': 'cltbld', 18:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:13 INFO - 'XPC_FLAGS': '0x0', 18:59:13 INFO - 'XPC_SERVICE_NAME': '0', 18:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:59:13 INFO - Cleaning up... 18:59:13 INFO - Return code: 0 18:59:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:13 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 0x105df2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc998570300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, '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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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:13 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:13 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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.86ma5WXb6M/Render', 18:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:13 INFO - 'HOME': '/Users/cltbld', 18:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:13 INFO - 'LOGNAME': 'cltbld', 18:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:13 INFO - 'MOZ_NO_REMOTE': '1', 18:59:13 INFO - 'NO_EM_RESTART': '1', 18:59:13 INFO - 'PAGER': '/bin/cat', 18:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:13 INFO - 'PWD': '/builds/slave/test', 18:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:13 INFO - 'SHELL': '/bin/bash', 18:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4t2Tc1CxNQ/Listeners', 18:59:13 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 18:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:13 INFO - 'USER': 'cltbld', 18:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:13 INFO - 'XPC_FLAGS': '0x0', 18:59:13 INFO - 'XPC_SERVICE_NAME': '0', 18:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:13 INFO - Downloading/unpacking blobuploader==1.2.4 18:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:16 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:17 INFO - Downloading docopt-0.6.1.tar.gz 18:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:59:17 INFO - Installing collected packages: blobuploader, requests, docopt 18:59:17 INFO - Running setup.py install for blobuploader 18:59:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:59:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:59:17 INFO - Running setup.py install for requests 18:59:18 INFO - Running setup.py install for docopt 18:59:18 INFO - Successfully installed blobuploader requests docopt 18:59:18 INFO - Cleaning up... 18:59:18 INFO - Return code: 0 18:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:18 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:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:18 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:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:18 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 0x105df2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc998570300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, '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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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:18 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:18 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:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.86ma5WXb6M/Render', 18:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:18 INFO - 'HOME': '/Users/cltbld', 18:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:18 INFO - 'LOGNAME': 'cltbld', 18:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:18 INFO - 'MOZ_NO_REMOTE': '1', 18:59:18 INFO - 'NO_EM_RESTART': '1', 18:59:18 INFO - 'PAGER': '/bin/cat', 18:59:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:18 INFO - 'PWD': '/builds/slave/test', 18:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:18 INFO - 'SHELL': '/bin/bash', 18:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4t2Tc1CxNQ/Listeners', 18:59:18 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 18:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:18 INFO - 'USER': 'cltbld', 18:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:18 INFO - 'XPC_FLAGS': '0x0', 18:59:18 INFO - 'XPC_SERVICE_NAME': '0', 18:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:18 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-Q1eW7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:19 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-98RBvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:19 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-0H1v2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:19 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-FxMBBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:19 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-oSpZvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:19 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-PAso4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:19 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-R1D7Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:19 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-cmDJJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:19 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-5vYmoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:19 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-RsxAdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:19 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-_yNWMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:20 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-XR7yIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:20 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-0iBT9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:20 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-i3WEn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:20 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-Zz7Rob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:20 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-GvqmvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:20 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-jOZquF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:59:20 INFO - Running setup.py install for manifestparser 18:59:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:59:20 INFO - Running setup.py install for mozcrash 18:59:20 INFO - Running setup.py install for mozdebug 18:59:21 INFO - Running setup.py install for mozdevice 18:59:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Running setup.py install for mozfile 18:59:21 INFO - Running setup.py install for mozhttpd 18:59:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Running setup.py install for mozinfo 18:59:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Running setup.py install for mozInstall 18:59:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:59:21 INFO - Running setup.py install for mozleak 18:59:22 INFO - Running setup.py install for mozlog 18:59:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Running setup.py install for moznetwork 18:59:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Running setup.py install for mozprocess 18:59:22 INFO - Running setup.py install for mozprofile 18:59:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Running setup.py install for mozrunner 18:59:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:59:22 INFO - Running setup.py install for mozscreenshot 18:59:22 INFO - Running setup.py install for moztest 18:59:23 INFO - Running setup.py install for mozversion 18:59:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:59:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:59:23 INFO - Cleaning up... 18:59:23 INFO - Return code: 0 18:59:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:23 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 0x105df2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc998570300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, '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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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:23 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:23 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:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.86ma5WXb6M/Render', 18:59:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:23 INFO - 'HOME': '/Users/cltbld', 18:59:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:23 INFO - 'LOGNAME': 'cltbld', 18:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:23 INFO - 'MOZ_NO_REMOTE': '1', 18:59:23 INFO - 'NO_EM_RESTART': '1', 18:59:23 INFO - 'PAGER': '/bin/cat', 18:59:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:23 INFO - 'PWD': '/builds/slave/test', 18:59:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:23 INFO - 'SHELL': '/bin/bash', 18:59:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4t2Tc1CxNQ/Listeners', 18:59:23 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 18:59:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:23 INFO - 'USER': 'cltbld', 18:59:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:23 INFO - 'XPC_FLAGS': '0x0', 18:59:23 INFO - 'XPC_SERVICE_NAME': '0', 18:59:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:59:23 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-cAIMrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:59:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:59:23 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-y5JC_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:59:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:59:23 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-bE2bdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:59:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:59:23 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-BGIyuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:59:23 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:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:59:23 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-TZ6cub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:59:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:59:24 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-vKN0q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:59:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:59:24 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-a91wpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:59:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:59:24 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-d0nJEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:59:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:59:24 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-VjfU1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:59:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:59:24 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-oLxMCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:59:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:59:24 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-NGz4Ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:59:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:59:24 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-y4epcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:59:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:59:24 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-CFh1R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:59:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:59:24 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-cogJhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:59:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:25 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-FShzp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:59:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:59:25 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-TDIjS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:59:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:59:25 INFO - Running setup.py (path:/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/pip-ZBdhhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:59:25 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:25 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:25 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:25 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:25 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:25 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:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:59:25 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:25 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:25 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:25 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:25 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:25 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:27 INFO - Downloading blessings-1.6.tar.gz 18:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:59:28 INFO - Installing collected packages: blessings 18:59:28 INFO - Running setup.py install for blessings 18:59:28 INFO - Successfully installed blessings 18:59:28 INFO - Cleaning up... 18:59:28 INFO - Return code: 0 18:59:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:59:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:28 INFO - Reading from file tmpfile_stdout 18:59:28 INFO - Current package versions: 18:59:28 INFO - blessings == 1.6 18:59:28 INFO - blobuploader == 1.2.4 18:59:28 INFO - docopt == 0.6.1 18:59:28 INFO - functools32 == 3.2.3-2 18:59:28 INFO - jsonschema == 2.5.1 18:59:28 INFO - manifestparser == 1.1 18:59:28 INFO - mozInstall == 1.12 18:59:28 INFO - mozcrash == 1.0 18:59:28 INFO - mozdebug == 0.1 18:59:28 INFO - mozdevice == 0.49 18:59:28 INFO - mozfile == 1.2 18:59:28 INFO - mozhttpd == 0.7 18:59:28 INFO - mozinfo == 0.9 18:59:28 INFO - mozleak == 0.1 18:59:28 INFO - mozlog == 3.4 18:59:28 INFO - moznetwork == 0.27 18:59:28 INFO - mozprocess == 0.24 18:59:28 INFO - mozprofile == 0.28 18:59:28 INFO - mozrunner == 6.13 18:59:28 INFO - mozscreenshot == 0.1 18:59:28 INFO - mozsystemmonitor == 0.3 18:59:28 INFO - moztest == 0.8 18:59:28 INFO - mozversion == 1.4 18:59:28 INFO - psutil == 3.1.1 18:59:28 INFO - requests == 1.2.3 18:59:28 INFO - wsgiref == 0.1.2 18:59:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:28 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 0x105df2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc998570300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, '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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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:28 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:28 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:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.86ma5WXb6M/Render', 18:59:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:28 INFO - 'HOME': '/Users/cltbld', 18:59:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:28 INFO - 'LOGNAME': 'cltbld', 18:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:28 INFO - 'MOZ_NO_REMOTE': '1', 18:59:28 INFO - 'NO_EM_RESTART': '1', 18:59:28 INFO - 'PAGER': '/bin/cat', 18:59:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:28 INFO - 'PWD': '/builds/slave/test', 18:59:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:28 INFO - 'SHELL': '/bin/bash', 18:59:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4t2Tc1CxNQ/Listeners', 18:59:28 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 18:59:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:28 INFO - 'USER': 'cltbld', 18:59:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:28 INFO - 'XPC_FLAGS': '0x0', 18:59:28 INFO - 'XPC_SERVICE_NAME': '0', 18:59:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:28 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:28 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:28 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:28 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:28 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:28 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:28 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:28 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:28 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:28 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:28 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:28 INFO - Cleaning up... 18:59:28 INFO - Return code: 0 18:59:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:28 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 0x105df2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105df5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc998570300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, '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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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:28 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:28 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:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.86ma5WXb6M/Render', 18:59:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:28 INFO - 'HOME': '/Users/cltbld', 18:59:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:28 INFO - 'LOGNAME': 'cltbld', 18:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:28 INFO - 'MOZ_NO_REMOTE': '1', 18:59:28 INFO - 'NO_EM_RESTART': '1', 18:59:28 INFO - 'PAGER': '/bin/cat', 18:59:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:28 INFO - 'PWD': '/builds/slave/test', 18:59:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:28 INFO - 'SHELL': '/bin/bash', 18:59:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4t2Tc1CxNQ/Listeners', 18:59:28 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 18:59:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:28 INFO - 'USER': 'cltbld', 18:59:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:28 INFO - 'XPC_FLAGS': '0x0', 18:59:28 INFO - 'XPC_SERVICE_NAME': '0', 18:59:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:59:29 INFO - Cleaning up... 18:59:29 INFO - Return code: 0 18:59:29 INFO - Running post-action listener: _resource_record_post_action 18:59:29 INFO - Running post-action listener: _start_resource_monitoring 18:59:29 INFO - Starting resource monitoring. 18:59:29 INFO - [mozharness: 2017-01-25 02:59:29.189164Z] Finished create-virtualenv step (success) 18:59:29 INFO - [mozharness: 2017-01-25 02:59:29.190160Z] Running install step. 18:59:29 INFO - Running pre-action listener: _resource_record_pre_action 18:59:29 INFO - Running main action method: install 18:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:59:29 INFO - Reading from file tmpfile_stdout 18:59:29 INFO - Detecting whether we're running mozinstall >=1.0... 18:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:59:29 INFO - Reading from file tmpfile_stdout 18:59:29 INFO - Output received: 18:59:29 INFO - Usage: mozinstall [options] installer 18:59:29 INFO - Options: 18:59:29 INFO - -h, --help show this help message and exit 18:59:29 INFO - -d DEST, --destination=DEST 18:59:29 INFO - Directory to install application into. [default: 18:59:29 INFO - "/builds/slave/test"] 18:59:29 INFO - --app=APP Application being installed. [default: firefox] 18:59:29 INFO - mkdir: /builds/slave/test/build/application 18:59:29 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:29 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:51 INFO - Reading from file tmpfile_stdout 18:59:51 INFO - Output received: 18:59:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:59:51 INFO - Running post-action listener: _resource_record_post_action 18:59:51 INFO - [mozharness: 2017-01-25 02:59:51.316232Z] Finished install step (success) 18:59:51 INFO - [mozharness: 2017-01-25 02:59:51.316395Z] Running run-tests step. 18:59:51 INFO - Running pre-action listener: _resource_record_pre_action 18:59:51 INFO - Running main action method: run_tests 18:59:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:59:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:59:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:59:51 INFO - 2017-01-24 18:59:51.330 screenresolution[1887:12741] starting screenresolution argv=screenresolution get 18:59:51 INFO - 2017-01-24 18:59:51.333 screenresolution[1887:12741] Display 0: 1600x1200x32@60 18:59:51 INFO - 2017-01-24 18:59:51.339 screenresolution[1888:12743] starting screenresolution argv=screenresolution list 18:59:51 INFO - Available Modes on Display 0 18:59:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:59:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:59:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:59:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:59:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:59:51 INFO - Intel Iris: 18:59:51 INFO - Chipset Model: Intel Iris 18:59:51 INFO - Type: GPU 18:59:51 INFO - Bus: Built-In 18:59:51 INFO - VRAM (Dynamic, Max): 1536 MB 18:59:51 INFO - Vendor: Intel (0x8086) 18:59:51 INFO - Device ID: 0x0a2e 18:59:51 INFO - Revision ID: 0x0009 18:59:51 INFO - Displays: 18:59:51 INFO - Display: 18:59:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:59:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:59:51 INFO - Display Serial Number: 1600x1200 60 18:59:51 INFO - Main Display: Yes 18:59:51 INFO - Mirror: Off 18:59:51 INFO - Online: Yes 18:59:51 INFO - Rotation: Supported 18:59:51 INFO - Return code: 0 18:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:59:51 INFO - Python 2.7.3 18:59:51 INFO - Return code: 0 18:59:51 INFO - grabbing minidump binary from tooltool 18:59:51 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:51 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 0x105bd0d30>, '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 0x105af7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bc5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:59:51 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:51 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:51 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:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:59:51 INFO - Return code: 0 18:59:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:59:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:59:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:59:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:59:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:59:51 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-0316', '--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:51 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-0316 --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:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.86ma5WXb6M/Render', 18:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:59:51 INFO - 'HOME': '/Users/cltbld', 18:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:59:51 INFO - 'LOGNAME': 'cltbld', 18:59:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:59:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:51 INFO - 'MOZ_NO_REMOTE': '1', 18:59:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:59:51 INFO - 'NO_EM_RESTART': '1', 18:59:51 INFO - 'PAGER': '/bin/cat', 18:59:51 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:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:51 INFO - 'PWD': '/builds/slave/test', 18:59:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:59:51 INFO - 'SHELL': '/bin/bash', 18:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4t2Tc1CxNQ/Listeners', 18:59:51 INFO - 'TMPDIR': '/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/', 18:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:59:51 INFO - 'USER': 'cltbld', 18:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:51 INFO - 'XPC_FLAGS': '0x0', 18:59:51 INFO - 'XPC_SERVICE_NAME': '0', 18:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:59:51 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-0316', '--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:51 INFO - mozversion application_buildid: 20170117083128 18:59:51 INFO - mozversion application_changeset: 6a23526fe5168087d7e4132c0705aefcaed5f571 18:59:51 INFO - mozversion application_display_name: Nightly 18:59:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:59:51 INFO - mozversion application_name: Firefox 18:59:51 INFO - mozversion application_remotingname: firefox 18:59:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:59:51 INFO - mozversion application_vendor: Mozilla 18:59:51 INFO - mozversion application_version: 53.0a1 18:59:51 INFO - mozversion platform_buildid: 20170117083128 18:59:51 INFO - mozversion platform_changeset: 6a23526fe5168087d7e4132c0705aefcaed5f571 18:59:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:59:51 INFO - mozversion platform_version: 53.0a1 18:59:51 INFO - using testdate: 1485313191 18:59:51 INFO - actual date: 1485313191 18:59:51 INFO - starting webserver on 'localhost:51482' 18:59:51 INFO - SUITE-START | Running 2 tests 18:59:51 INFO - TEST-START | dromaeo_css 18:59:51 INFO - operating with platform_type : mac_ 18:59:51 INFO - Initialising browser for dromaeo_css test... 18:59:51 INFO - TEST-INFO | started process 1898 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpFRXNFi/profile http://localhost:51482/getInfo.html) 18:59:54 INFO - PROCESS | 1898 | __metrics Screen width/height:1600/1200 18:59:54 INFO - PROCESS | 1898 | colorDepth:24 18:59:54 INFO - PROCESS | 1898 | Browser inner width/height: 1024/689 18:59:54 INFO - PROCESS | 1898 | __metrics 18:59:54 INFO - PROCESS | 1898 | 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:54 INFO - PROCESS | 1898 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:59:55 INFO - TEST-INFO | 1898: exit 0 18:59:55 INFO - Browser initialized. 18:59:55 INFO - Running cycle 1/1 for dromaeo_css test... 18:59:55 INFO - TEST-INFO | started process 1900 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpFRXNFi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:07 INFO - PROCESS | 1900 | RSS: Main: 235823104 19:00:07 INFO - PROCESS | 1900 | 19:03:10 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:51482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51482/tests/dromaeo/cssquery-ext.html) 19:03:11 INFO - PROCESS | 1900 | RSS: Main: 367124480 19:03:11 INFO - PROCESS | 1900 | 19:04:57 INFO - PROCESS | 1900 | ************************* 19:04:57 INFO - PROCESS | 1900 | A coding exception was thrown and uncaught in a Task. 19:04:57 INFO - PROCESS | 1900 | 19:04:57 ERROR - PROCESS | 1900 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:04:57 INFO - PROCESS | 1900 | Full stack: 19:04:57 INFO - PROCESS | 1900 | ************************* 19:06:14 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:51482/tests/dromaeo/cssquery-ext.html (next: http://localhost:51482/tests/dromaeo/cssquery-jquery.html) 19:06:15 INFO - PROCESS | 1900 | RSS: Main: 377237504 19:06:15 INFO - PROCESS | 1900 | 19:09:17 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:51482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51482/tests/dromaeo/cssquery-mootools.html) 19:09:18 INFO - PROCESS | 1900 | RSS: Main: 342601728 19:09:18 INFO - PROCESS | 1900 | 19:12:21 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:51482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51482/tests/dromaeo/cssquery-prototype.html) 19:12:21 INFO - PROCESS | 1900 | RSS: Main: 341266432 19:12:21 INFO - PROCESS | 1900 | 19:15:25 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:51482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51482/tests/dromaeo/cssquery-yui.html) 19:15:25 INFO - PROCESS | 1900 | RSS: Main: 325615616 19:15:25 INFO - PROCESS | 1900 | 19:18:29 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:51482/tests/dromaeo/cssquery-yui.html (next: http://localhost:51482/tests/dromaeo/cssquery-dojo.html) 19:18:29 INFO - PROCESS | 1900 | RSS: Main: 410914816 19:18:29 INFO - PROCESS | 1900 | 19:18:29 INFO - PROCESS | 1900 | __start_tp_report 19:18:29 INFO - PROCESS | 1900 | _x_x_mozilla_page_load 19:18:29 INFO - PROCESS | 1900 | _x_x_mozilla_page_load_details 19:18:29 INFO - PROCESS | 1900 | |i|pagename|runs| 19:18:29 INFO - PROCESS | 1900 | |0;dojo.html;3225.4033003894283;3295.126791400279;3304.75214358923;3323.302106557626;3362.0250127463037;4208.473940757405;5545.085060964946;5578.553715702744;5614.045612245918;5617.01702202115;5556.944180605682;5560.555155587554;5566.805161819337;5588.804391846286;5605.971970140144;5062.569681577071;5079.2635067915135;5103.974480127613;5145.485451454862;5186.636935414523;5029.06962211992;5032.194848824189;5102.413222479426;5214.556762675177;5225.608079394061;5121.974390128044;5174.353205849269;5213.635045546814;5215.322008138955;5266.710330931797;5208.192730126836;5216.556592689588;5222.112240919053;5225.085610018251;5279.52484276417;4961.5534601886;5111.437741848394;5133.512316329943;5162.5095615916425;5164.819231326923;5497.8075767347955;5644.85887852807;5650.773969041234;5654.9151762723595;5657.20799088128;6160.784372546939;6206.286277078104;6210.875782484371;6213.751449941997;6213.968930155365;5047.419546752134;5395.622306438551;6032.125341825455;6098.4384226431075;6224.159738435299;5652.491275785199;5780;5782.710864456761;5790.015697331463;5805.274340707411;6227.595206311576;6239.438450539473;6245.812625621239;6249.875002499924;6251.624902505864;5718.771249149988;5767.134929760569;6112.51099912006;6134.355892631299;6137.202163718688;6105.217149441772;6116.052011938156;6127.142200091991;6154;6191.659458729813;6128.601640893327;6146.231721034871;6146.78486252979;6148.262208534915;6150.78472253478;6005.039193728982;6159.291681456601;6163.753449862045;6180.072989051679;6183.474404675653;4869.780859861315;4924.975375123101;4946.406431228275;4952.455229924705;5020.297158397827;4416.933745993812;4420.138073075784;4429.291313389842;4429.689921705514;4462.44219472566;5510.476504732044;5541.722913854291;5548.195511650788;5826.242588463558;5842.1236814477315;6112.959454150325;6115.027386288435;6171.012637977902;6206.317305096436;6208.937910620926;5842.853928651818;5845.473907348359;5849.298084229919;5853.882922341614;5886.764529418861;5388.110961691355;5399.271098401744;5405.108157154104;5406.107992181246;5413.242146099549;6150.815475535741;6154.661493617805;6193.938060619336;6244.125822384779;6251.46862516673;6177.876442471035;6196.256449226122;6206.658633775186;6220.564560480723;6267.279262884645;6248.812535623939;6254.749810007549;6284.151639528605;6290.2451705793765;6311.779087731908;5896.6756828374855;5924.170616113662;6053.092036194606;6078;6160.383961603804;6169.290531588925;6182.1345011699295;6204.7828326008375;6212.565120441525;6212.875742485216;6033;6040.063790112539;6055.1220073090035;6058.394160584083;6075.30134034574;5745.971270143623;5860.619059761102;5942.524598032233;5955.434233747787;6000.909986350295;5795.39148389413;5882.705864706833;5886.852828679317;5896.882062358814;5910.674912879833;6002.879942401215;6016.157737916607;6016.217891674054;6016.639001659914;6017.067354559875;4703.670743047954;5656.2929633795775;5832.125181222681;5843.29880414336;5852.3269823969085 19:18:29 INFO - PROCESS | 1900 | |1;ext.html;430.32868724789324;454.2414168338874;509.77569869257525;513.7405610166866;533.1097067896611;32173.51739723903;41530.792346038266;42782.14435711284;42897.57102428975;44981.32528012074;31991.52012719811;44373;44419.77790111045;44478.4432544861;44483.55516444835;7390.40876729863;8367.790805229888;8850.5132217728;9260.490673012982;9375.76560585984;8442.240198382144;8642.135786421339;8644.65421383147;8649.956750216272;11197.832032519478;11219.719507012349;11507.194496385257;11526.423678816067;11527.135464840128;11553.133514986368;11406.201565890391;11464;11483.081353491702;11494.597689080842;11520.135989800798;8398.370122240794;8617;11118.888811111867;11391.658250252505;11452.255603385836;39337;41928.16143677109;41942.370864437056;41981.37027944583;42027;4032.899177520556;4043.8382464701376;4052.0882801369753;4060.913705583746;4127.607877251657;30218.84890575533;31161.688383116107;31424;31530.054098377084;31884.6811531884;3007.3684526249294;3152.4956007038763;3155.984220078885;3180.634227063871;3184.26761844777;491450;492929;496272.9999999964;497010;497197;57820.42179578234;58007.709961449924;60118;64866.35133648697;64996.35003649998;69685.65157174182;69973.65013174902;70014.64992675107;70144;70148;15588.610284742972;15609.687806243812;15623.843761562466;15634.921825391028;15661.60845978837;11806.291622502677;11892.524299027942;11901.821472677917;11906.345151016778;11908.2259653124;14939.17834519112;16836.821422500307;17375.322915641045;18337.816621833877;18724.438266852016;6758.775765146784;6781.898271525931;6831.351021652935;6850.897236541456;6859.17689877208;735.7277807211259;852.7527017164953;854.5342788180457;906.1663269791808;906.7098528470958;28763.2809179768;29989.850050749606;30078.849605752268;30565.498210322356;30911;1044.6813721814767;1081.8093360944151;1085.5223701571442;1088.385062439719;1164.6024770275533;15291.158986255863;15784.60538486547;15788.763168552481;15860.682786344209;16176.514704558647;599362.0031899812;601796;603720;603930;605549;62769.37230627727;62848.37151628425;62897.68551157215;62992.37007629865;63048.68475657592;1371.7530844447895;1409.3094383751888;1434.2613554019688;1439.0933711761522;1440.3302464354126;23921.776321048816;26015.479690406464;26987.05545305905;29750.70249297566;30920.072397828102;52107;53350.4664953361;53728.194077089654;56599.71700141473;56746.14880776874;526496;531990;533904;534061;535120;25321.493570128863;25645.74354256508;25652.743472565035;25682.101126460486;25720.356991074623;35925.820370899026;40966.1806763869;42881.78559107184;44666.55333446624;46267;33838.66161338355;36727.816360919096;37223.441648374755;37740.2451950965;37927.62072379241;36176;36421.907342779756;36470.90587282386;36557.45163822598;37711.68009119778;35711.28577428489;35905.82047089852;36388.454173186896;36431.817840910626;36534.269314613026;29147.854260729408;30535.847320763252;32270.19324516906;32293.677063229068;32938.50592241166;22576.774232257467;23007.53984920326;23821.761782381953;23977;24222.75777242205 19:18:29 INFO - PROCESS | 1900 | |2;jquery.html;369.2688476815903;386.93615553433665;389.63569062926166;396.10480314489257;422.1114553864116;14375.928120359396;15096.245187740624;17401.042942638167;20489.897550512265;20527.589448211027;16389.5902602435;20057.899710501464;20493.692594611093;20500.589988200227;20820;5940.2277703898435;6180.81457556274;6189.535784816134;6193.566450348455;7604.847903041936;7875.724349647763;7986.720464783733;8037.316828069592;8128.30909372704;8131.390145739064;4102.979485102585;4891.1195984722735;4951.628627852908;7999.640016199285;8130.065042520097;7257.092863392076;7605.163432022473;7921.524708517507;8108.189181081874;8153.99999999997;7268.400951790651;7443.069616297963;7449.553026818408;7469.551826890404;7560;25332.873335633387;29021.12936611905;29164.791872893966;29345.266368340748;29681.257968550744;3008.74425673818;3045.741112005482;3054.7708921830954;3092.196029032445;3135.4826453635123;16616.750748738777;16920.98474091546;16954.745678814827;17636.20637071335;17922.372716954844;1894.9052547372576;1933.7030363230658;1985.8014198580172;1996.19154242532;2068.6690129579197;120446.3977680106;140079.29960350235;157314;160628;161902;22895.427614309774;23437.648435273484;23531.529369412518;23645.315302335326;23907.294369372776;41245.79377103155;41333.379999300036;41458;41545.58454415478;41574.96062598459;7916.960415197887;8084.231997960184;8429.789255268544;8589.828203435896;10808.51361688726;7973.800654983672;7979.48133371329;7994.880076798852;8157.75526734199;8170.3872209584515;3967.484227050465;4817.2774083887;4824.131656301829;4840;4894.926576101361;1851.8148185181644;1867.318428773488;1987.7316562264198;2020.8585399022222;2037.8777273363646;865.0052439694401;971.2129681386142;986.2110311750571;1006.3961623026272;1015.5074788727461;19738.40784776459;21042.368728938156;21448.24931127403;21466.463338416663;21472.35582932483;960.846264597675;1013.1337706261188;1022.3252653248969;1037.8754549454113;1048.1457612046158;10461;11171.385573793357;11302.908961842086;11312.547498099984;11563.132765042656;579078;584067.1593284013;590624;718581;719442;111591.42026441371;152438;161397.3860261406;168871;170855.14572427058;1012.336919317848;1050.6427814543244;1071.4803320389606;1074.9193810464246;1078.2991055813784;19568.706469403256;19586.706199406734;20036.499087522927;20057;20150.798492015478;53008;60881.82504487168;61079.69460152671;62524;63118;70766.2308442293;86812.56593716991;91207.54396227976;91444;91821.40892955192;7837.137914829478;8074.3944204183745;8082.474639148437;8507.489550626982;8541.01778295504;9173.495457749888;12237.632871013884;12761.680957976125;12930.612081637566;13034.152780069266;8008.479448835807;10083.747906302402;10919.945400272947;11278;11445.42772861337;7508.887366689613;8541.444806087833;10932;11138.3873886937;11369.54521819118;8549;11131.554737810397;11294.887051129384;11530.76938461243;11548.94225528867;6966.930330696831;8119.066307374727;8288.668453261802;8307.750767476986;8330.083690793886;9018.458892466473;11015.504302306255;11187.72030699239;11267.943660281646;11323 19:18:29 INFO - PROCESS | 1900 | |3;mootools.html;1365.720027394384;1478.3125846481385;1495.4466847266513;1497.15410792902;1502.6243439140208;6514.641694706789;8436.578171091436;8441.198086181803;8454.450460720049;8463.195996380342;7369.852602947938;7641.923580764191;7662.770116896502;8116.5941702914915;8334.124916883731;2293.736220334662;2334.2997100869757;2337.91817286395;2338.754430784769;2340.871252081143;2304.5275718477756;2341.2976107167783;2342.4378149244144;2344.4373350395954;2345.9560495579476;2308.7575804540534;2320.535892821434;2340.7659234076627;2341.4146463384154;2342.016353131689;1959.490532461556;2289.221664634024;2289.427643089228;2301.8158547316175;2324.151684635113;1838.347386677737;2130.3182981445943;2146.8926553672254;2326.6044772388736;2330.778576035274;8264.173582641748;8339.83320333596;8346.207110324509;8372.03721572015;8376.329893608498;4926.2118061110405;5082.1360368737405;5088.414832294259;5096.133657278235;5102.209157580581;3080.9383812323626;3226.58054452922;3352.7150192233444;3415.1291420687567;3417.624061353249;1080.400377790326;1083.8320060390652;1118.9664310070712;1143.9142064345124;1162.3490845126755;10427.478626068667;10716.78566428667;10753.03222709952;10765.892341076567;10786.191035672357;4272.380504826845;4555.248384016666;4619.9076018479445;4629.699069560468;4643.674942753974;9382.765430864283;9395.906040939502;9427.292953028413;9430.3870248435;9433.858492122623;5110.850058736754;5120.513551212629;5124.564412024945;5127.820526281562;5132.3327967364;4193.161367726467;4350.434443522322;4532.546745325507;4616.907661846812;4688.2733176357715;3694.445833124999;3767.472553842464;3792.1278106035766;3834.808259587065;3841.692664586826;1254.2913254011637;1262.7979523276415;1264.20986883198;1276.9680757981125;1282.6216266201493;813.8321508635128;870.7779516223322;895.2166854002747;899.0964081098585;934.7522906429801;5518.779248830002;5604.159376093537;5692.516136128475;5773.393793651606;5892.852678682982;978.7944531648434;980.4901451245313;990.1336330710628;994.472929347447;1019.9235057370727;3601.225736466672;3633.1825339298975;3672.614375490535;3719.9814000929823;3805.0867791729784;9650.420974741539;9888.318985772436;10019.448930308758;10052.447115408722;10059.195264378832;9954.751131221778;9978.600855965826;9981.850272245922;10001.649942252132;10028.047335503115;7642.19756925526;7746.845063098706;7831.647575858986;7842.411819113589;7852.489588176751;5256.421793602777;5439.566753096214;5545.417731138334;5573.829495805926;5660.235868157746;7613.9238607613215;7762;9307.255419566554;9314.25485961108;9330.486823224788;8957.10428957099;9272.258219342571;9373.20327772147;9381.296402769683;9468.621255149717;5280.973595132;6332;7044.6125463100025;7190.029346038218;7199.892001619875;7800.063992320957;7969.760907172794;7970.003749531309;7979.601019948863;7985.401094918021;6964.860702786017;7033.191183014019;7056.1179852518435;7099.36105750485;7203.459740519377;6820.795376138723;6961.37347638715;6970.714836655013;7033.0856988593205;7102.680379383043;6292.716827742855;6341.4292713656;6400.487960963205;6410.1025856381075;6417.684374703082;4929.753512324298;4962.106820772296;4978.726170060537;4984.975075124601;5079.009593129304;4846.200376937766;4882.292067650242;4932.506749325039;4952.678075925053;5020.949790502194 19:18:29 INFO - PROCESS | 1900 | |4;prototype.html;357.58520116664675;365.404390842926;369.1417454418478;381.08539505187565;382.3156549775903;4845.709257444556;5281.339832520935;5291.5076049807085;5352.866178345544;5362.51737343639;4636.791344389502;4694.647901407391;4992;5044.511868998645;5107.719075450848;3901.356276214421;4046.797660116997;4099.323611604082;4132.685696010229;4154.1276331970175;4115.979420102895;4122.484689413824;4135.648469880064;4141.399497072937;4158.792060396983;3446.551948246737;3881.0103423626933;4084.7140700151003;4124.690648201382;4134.793260336971;3815.7328986970924;3861.8841434757;4100.405441211008;4101.835926562934;4128.442660240859;3150.9684903150905;3544.025393016915;3628.600853906068;3636.7454278200535;3639.854405823764;4417.734935903856;4684.742339171345;5081.669691470042;5084.872878178038;5112.003159383921;4474.507804141542;4539.818407263706;4568.223402021665;4569.994601187766;4581.289900065495;4643.770989924821;5483.643563168421;5541.2796336476;5552.278203833516;5615.887682246373;3225.387176436493;3237.514372844092;3780.262848744496;3790.6967442604528;3815.561210460777;4762.357081793948;5395.838124856221;5479.945200547983;5778.855528611776;5870.706464676749;3857.2035274425816;3857.3056849767313;3867.511008261783;3875.9418608720894;3876.3604005339366;3464.566929133858;3614.566252049771;3656.8537258509364;3922.627350401707;3927.7250592458827;3653.5250417446096;3945.881623551298;4265.296226122655;4587.7377379876225;4605.723656580616;4661.370714953506;5358.97320513395;5604.8038318658655;5632.577556683265;5650.74571644277;1169.4971961030035;1205.3189947679532;1276.2215048820212;1279.1643990873126;1281.8397700287464;813.259933460548;832.9671207702405;836.0469065265602;852.7782776478036;861.2679222660813;4384.956150438518;4899.387576552931;4950.6782059166035;4962.330085438492;4967.726775027409;4777.617790576745;5384.40771515133;5423.457654234624;5484.149956756709;5490.835274941758;3923.4899463070187;4234.55537168599;4341.891452713708;4365.8866988917625;4745.217039188564;2433.586290330648;2439.5852705040184;2778.4165325281915;2787.3136752264995;2811.2971757060736;4822;5128.8461346159675;5132.072456312964;5527.972360138174;5530.6128570999645;5155.690658560424;5427.375851777097;5514.443184146203;5540.501354878;5610.707808526399;4705.670603057822;4995.875103122451;5196.246544251062;5549.916751248735;5572.693501857437;4939.258312020357;5280.392754833089;5304.310439642822;5333.573224183065;5343.278657381359;4582.633389328779;4903.77932993009;5263.131588286104;5268.710220937885;5283.339582552181;4595.586397224266;5197.454267301879;5564.271937801764;5572.888542229214;5588.993981083444;3422.691957723817;3586.5696116465147;3598.8020658864016;3604.981975090108;3632.110133017428;4386.956130438783;4585.862424127282;4594.287885377772;5238.292830467838;5348.112019509577;4252.128313695747;4739.431268247832;5073.543381095719;5162.870928226825;5187.636865419536;4457.643388528974;4600.217962946374;4654.743989080498;4749.026449577897;5009.824656137018;4366.497852746975;5002.398752648675;5012.573931215888;5075.619328550448;5173.430922598586;4917.606591472602;5345.732713364238;5450.209719590716;5492.983797997384;5516.703574659871;4394.033312671208;4791.8978634914865;5145.485451454824;5227.215917612237;5418.431064738304 19:18:29 INFO - PROCESS | 1900 | |5;yui.html;730.3463400256767;768.6156921539231;780.996419600813;828.4532208742231;836.8995720513537;14759.48341808037;15593.37626494939;15606;15621.92189039056;15647.687046259069;11776;13954.302284885765;14054.016218864683;14127.223002734845;14141.222232777192;660.4452260101514;680.714100077966;684.6576711644178;686.8660611180821;688.1810645332064;687.8968154776774;833.3749687734199;858.4034096303072;865.1910463716414;867.2108381372952;898.8427025270585;899.8110396816676;903.6114470777563;909.6179604566098;910.6038873090226;898.3846065445125;898.5597057441872;899.9415038022507;901.5041727050096;904.5929331800716;522.1958184396026;642.4635429416443;659.482306389482;674.5682763031664;680.1769858471206;12334.938325308405;14346.56960291193;14821.555353339418;14886.330115144845;15179.316930738032;14401.279936003159;14429.567112986628;14491.927540362336;14501.709965800625;14583.34374953119;9881.16010139139;11808.881911180864;11854.703632409173;11959.162858599902;12118.939405303005;3639.181184233553;3693.2428852085527;3866.5693693333365;3919.157381163035;3924.2543916655745;100101.49137323337;101794.49102754513;101842;102767.97232027659;105206.94793052049;9259;11088.112950963903;11156.553737850558;11240.662780116609;11256.831147532794;22485.662715059287;22981;23003.88498057499;23006;23019.769802302097;6440.677966101676;7721.382289416833;7756.573388463688;7862.174471680506;7983.760487185394;4132.8140233689555;4216.746995180299;4232.195882782262;4255.8084886180195;4333.285007973712;3596.478510615946;3669.6330366963625;3701.592824789271;3702.259548090393;3702.407614781622;593.3828818029288;639.7632875835877;650.9641969691712;656.297761395312;661.441082285468;557.768526061688;575.1372940589116;590.7459792289357;593.5874567175857;603.6408337039454;8801.515916624647;9217.308701847389;10128.189744820544;10299.858543144263;10374.576934703102;583.486531851976;591.4942723971029;601.6029420582395;655.2039272284197;714.3677845107118;4752.144613969519;4927.088488629615;4981.975090124526;5044.798208071709;5045;81091;89696;90082.54958725296;90749.63875541872;91791;39373.2125357497;62736;83399.5830020846;86309;86722;73201;73387.63306183435;73455.61437977121;74284.25715742882;75927;9739.269554783277;9751.463669498246;9754.9024509754;9766.56050477716;9822.803543929223;43949.340759889266;44860.77569612131;45089;45238.321425177994;46066;61375;62236.68881655563;63444;63482.68258658677;65677.34322656904;10062.647807326708;11401.144914131308;11535.423228838692;11650.242734222249;12002.339871307162;10705.785884282426;10961.50673219691;12737.077626023829;13012.349382530647;13452.1256118352;11740.471678774646;11945.820812687643;12112.939435302767;12206.267623942593;12531.87468125307;11868.703282418008;12188.57339993096;12233.816492752438;12372.566960156351;12494.937525312314;11617.593384231512;12017.399130043637;12112.93943530312;12322.815157772462;12420.254784712946;9660.227181825578;9695.418274903246;10081.186441517539;10186.33788803755;10231.777828818098;9814.312998090065;9816.214702823614;9837.360571562825;9846.458444785605;9858.211343092678 19:18:29 INFO - PROCESS | 1900 | __end_tp_report 19:18:29 INFO - PROCESS | 1900 | __start_cc_report 19:18:29 INFO - PROCESS | 1900 | _x_x_mozilla_cycle_collect,1392 19:18:29 INFO - PROCESS | 1900 | __end_cc_report 19:18:29 INFO - PROCESS | 1900 | __startTimestamp1485314309355__endTimestamp 19:18:29 INFO - PROCESS | 1900 | 19:18:29 INFO - PROCESS | 1900 | ------- Summary: start ------- 19:18:29 INFO - PROCESS | 1900 | Number of tests: 6 19:18:29 INFO - PROCESS | 1900 | 19:18:29 INFO - PROCESS | 1900 | [#0] dojo.html Cycles:165 Average:5658.25 Median:5849.30 stddev:639.69 (10.9%) stddev-sans-first:612.52 19:18:29 INFO - PROCESS | 1900 | Values: 3225.4 3295.1 3304.8 3323.3 3362.0 4208.5 5545.1 5578.6 5614.0 5617.0 5556.9 5560.6 5566.8 5588.8 5606.0 5062.6 5079.3 5104.0 5145.5 5186.6 5029.1 5032.2 5102.4 5214.6 5225.6 5122.0 5174.4 5213.6 5215.3 5266.7 5208.2 5216.6 5222.1 5225.1 5279.5 4961.6 5111.4 5133.5 5162.5 5164.8 5497.8 5644.9 5650.8 5654.9 5657.2 6160.8 6206.3 6210.9 6213.8 6214.0 5047.4 5395.6 6032.1 6098.4 6224.2 5652.5 5780.0 5782.7 5790.0 5805.3 6227.6 6239.4 6245.8 6249.9 6251.6 5718.8 5767.1 6112.5 6134.4 6137.2 6105.2 6116.1 6127.1 6154.0 6191.7 6128.6 6146.2 6146.8 6148.3 6150.8 6005.0 6159.3 6163.8 6180.1 6183.5 4869.8 4925.0 4946.4 4952.5 5020.3 4416.9 4420.1 4429.3 4429.7 4462.4 5510.5 5541.7 5548.2 5826.2 5842.1 6113.0 6115.0 6171.0 6206.3 6208.9 5842.9 5845.5 5849.3 5853.9 5886.8 5388.1 5399.3 5405.1 5406.1 5413.2 6150.8 6154.7 6193.9 6244.1 6251.5 6177.9 6196.3 6206.7 6220.6 6267.3 6248.8 6254.7 6284.2 6290.2 6311.8 5896.7 5924.2 6053.1 6078.0 6160.4 6169.3 6182.1 6204.8 6212.6 6212.9 6033.0 6040.1 6055.1 6058.4 6075.3 5746.0 5860.6 5942.5 5955.4 6000.9 5795.4 5882.7 5886.9 5896.9 5910.7 6002.9 6016.2 6016.2 6016.6 6017.1 4703.7 5656.3 5832.1 5843.3 5852.3 19:18:29 INFO - PROCESS | 1900 | 19:18:29 INFO - PROCESS | 1900 | [#1] ext.html Cycles:180 Average:68149.32 Median:36545.86 stddev:145470.16 (398.0%) stddev-sans-first:145789.39 19:18:29 INFO - PROCESS | 1900 | Values: 430.3 454.2 509.8 513.7 533.1 32173.5 41530.8 42782.1 42897.6 44981.3 31991.5 44373.0 44419.8 44478.4 44483.6 7390.4 8367.8 8850.5 9260.5 9375.8 8442.2 8642.1 8644.7 8650.0 11197.8 11219.7 11507.2 11526.4 11527.1 11553.1 11406.2 11464.0 11483.1 11494.6 11520.1 8398.4 8617.0 11118.9 11391.7 11452.3 39337.0 41928.2 41942.4 41981.4 42027.0 4032.9 4043.8 4052.1 4060.9 4127.6 30218.8 31161.7 31424.0 31530.1 31884.7 3007.4 3152.5 3156.0 3180.6 3184.3 491450.0 492929.0 496273.0 497010.0 497197.0 57820.4 58007.7 60118.0 64866.4 64996.4 69685.7 69973.7 70014.6 70144.0 70148.0 15588.6 15609.7 15623.8 15634.9 15661.6 11806.3 11892.5 11901.8 11906.3 11908.2 14939.2 16836.8 17375.3 18337.8 18724.4 6758.8 6781.9 6831.4 6850.9 6859.2 735.7 852.8 854.5 906.2 906.7 28763.3 29989.9 30078.8 30565.5 30911.0 1044.7 1081.8 1085.5 1088.4 1164.6 15291.2 15784.6 15788.8 15860.7 16176.5 599362.0 601796.0 603720.0 603930.0 605549.0 62769.4 62848.4 62897.7 62992.4 63048.7 1371.8 1409.3 1434.3 1439.1 1440.3 23921.8 26015.5 26987.1 29750.7 30920.1 52107.0 53350.5 53728.2 56599.7 56746.1 526496.0 531990.0 533904.0 534061.0 535120.0 25321.5 25645.7 25652.7 25682.1 25720.4 35925.8 40966.2 42881.8 44666.6 46267.0 33838.7 36727.8 37223.4 37740.2 37927.6 36176.0 36421.9 36470.9 36557.5 37711.7 35711.3 35905.8 36388.5 36431.8 36534.3 29147.9 30535.8 32270.2 32293.7 32938.5 22576.8 23007.5 23821.8 23977.0 24222.8 19:18:29 INFO - PROCESS | 1900 | 19:18:29 INFO - PROCESS | 1900 | [#2] jquery.html Cycles:180 Average:39545.32 Median:16345.00 stddev:108184.27 (661.9%) stddev-sans-first:108447.77 19:18:29 INFO - PROCESS | 1900 | Values: 369.3 386.9 389.6 396.1 422.1 14375.9 15096.2 17401.0 20489.9 20527.6 16389.6 20057.9 20493.7 20500.6 20820.0 5940.2 6180.8 6189.5 6193.6 7604.8 7875.7 7986.7 8037.3 8128.3 8131.4 4103.0 4891.1 4951.6 7999.6 8130.1 7257.1 7605.2 7921.5 8108.2 8154.0 7268.4 7443.1 7449.6 7469.6 7560.0 25332.9 29021.1 29164.8 29345.3 29681.3 3008.7 3045.7 3054.8 3092.2 3135.5 16616.8 16921.0 16954.7 17636.2 17922.4 1894.9 1933.7 1985.8 1996.2 2068.7 120446.4 140079.3 157314.0 160628.0 161902.0 22895.4 23437.6 23531.5 23645.3 23907.3 41245.8 41333.4 41458.0 41545.6 41575.0 7917.0 8084.2 8429.8 8589.8 10808.5 7973.8 7979.5 7994.9 8157.8 8170.4 3967.5 4817.3 4824.1 4840.0 4894.9 1851.8 1867.3 1987.7 2020.9 2037.9 865.0 971.2 986.2 1006.4 1015.5 19738.4 21042.4 21448.2 21466.5 21472.4 960.8 1013.1 1022.3 1037.9 1048.1 10461.0 11171.4 11302.9 11312.5 11563.1 579078.0 584067.2 590624.0 718581.0 719442.0 111591.4 152438.0 161397.4 168871.0 170855.1 1012.3 1050.6 1071.5 1074.9 1078.3 19568.7 19586.7 20036.5 20057.0 20150.8 53008.0 60881.8 61079.7 62524.0 63118.0 70766.2 86812.6 91207.5 91444.0 91821.4 7837.1 8074.4 8082.5 8507.5 8541.0 9173.5 12237.6 12761.7 12930.6 13034.2 8008.5 10083.7 10919.9 11278.0 11445.4 7508.9 8541.4 10932.0 11138.4 11369.5 8549.0 11131.6 11294.9 11530.8 11548.9 6966.9 8119.1 8288.7 8307.8 8330.1 9018.5 11015.5 11187.7 11267.9 11323.0 19:18:29 INFO - PROCESS | 1900 | 19:18:29 INFO - PROCESS | 1900 | [#3] mootools.html Cycles:180 Average:5365.46 Median:5106.53 stddev:2927.54 (57.3%) stddev-sans-first:2920.32 19:18:29 INFO - PROCESS | 1900 | Values: 1365.7 1478.3 1495.4 1497.2 1502.6 6514.6 8436.6 8441.2 8454.5 8463.2 7369.9 7641.9 7662.8 8116.6 8334.1 2293.7 2334.3 2337.9 2338.8 2340.9 2304.5 2341.3 2342.4 2344.4 2346.0 2308.8 2320.5 2340.8 2341.4 2342.0 1959.5 2289.2 2289.4 2301.8 2324.2 1838.3 2130.3 2146.9 2326.6 2330.8 8264.2 8339.8 8346.2 8372.0 8376.3 4926.2 5082.1 5088.4 5096.1 5102.2 3080.9 3226.6 3352.7 3415.1 3417.6 1080.4 1083.8 1119.0 1143.9 1162.3 10427.5 10716.8 10753.0 10765.9 10786.2 4272.4 4555.2 4619.9 4629.7 4643.7 9382.8 9395.9 9427.3 9430.4 9433.9 5110.9 5120.5 5124.6 5127.8 5132.3 4193.2 4350.4 4532.5 4616.9 4688.3 3694.4 3767.5 3792.1 3834.8 3841.7 1254.3 1262.8 1264.2 1277.0 1282.6 813.8 870.8 895.2 899.1 934.8 5518.8 5604.2 5692.5 5773.4 5892.9 978.8 980.5 990.1 994.5 1019.9 3601.2 3633.2 3672.6 3720.0 3805.1 9650.4 9888.3 10019.4 10052.4 10059.2 9954.8 9978.6 9981.9 10001.6 10028.0 7642.2 7746.8 7831.6 7842.4 7852.5 5256.4 5439.6 5545.4 5573.8 5660.2 7613.9 7762.0 9307.3 9314.3 9330.5 8957.1 9272.3 9373.2 9381.3 9468.6 5281.0 6332.0 7044.6 7190.0 7199.9 7800.1 7969.8 7970.0 7979.6 7985.4 6964.9 7033.2 7056.1 7099.4 7203.5 6820.8 6961.4 6970.7 7033.1 7102.7 6292.7 6341.4 6400.5 6410.1 6417.7 4929.8 4962.1 4978.7 4985.0 5079.0 4846.2 4882.3 4932.5 4952.7 5020.9 19:18:29 INFO - PROCESS | 1900 | 19:18:29 INFO - PROCESS | 1900 | [#4] prototype.html Cycles:180 Average:4307.63 Median:4689.70 stddev:1283.64 (27.4%) stddev-sans-first:1252.53 19:18:29 INFO - PROCESS | 1900 | Values: 357.6 365.4 369.1 381.1 382.3 4845.7 5281.3 5291.5 5352.9 5362.5 4636.8 4694.6 4992.0 5044.5 5107.7 3901.4 4046.8 4099.3 4132.7 4154.1 4116.0 4122.5 4135.6 4141.4 4158.8 3446.6 3881.0 4084.7 4124.7 4134.8 3815.7 3861.9 4100.4 4101.8 4128.4 3151.0 3544.0 3628.6 3636.7 3639.9 4417.7 4684.7 5081.7 5084.9 5112.0 4474.5 4539.8 4568.2 4570.0 4581.3 4643.8 5483.6 5541.3 5552.3 5615.9 3225.4 3237.5 3780.3 3790.7 3815.6 4762.4 5395.8 5479.9 5778.9 5870.7 3857.2 3857.3 3867.5 3875.9 3876.4 3464.6 3614.6 3656.9 3922.6 3927.7 3653.5 3945.9 4265.3 4587.7 4605.7 4661.4 5359.0 5604.8 5632.6 5650.7 1169.5 1205.3 1276.2 1279.2 1281.8 813.3 833.0 836.0 852.8 861.3 4385.0 4899.4 4950.7 4962.3 4967.7 4777.6 5384.4 5423.5 5484.1 5490.8 3923.5 4234.6 4341.9 4365.9 4745.2 2433.6 2439.6 2778.4 2787.3 2811.3 4822.0 5128.8 5132.1 5528.0 5530.6 5155.7 5427.4 5514.4 5540.5 5610.7 4705.7 4995.9 5196.2 5549.9 5572.7 4939.3 5280.4 5304.3 5333.6 5343.3 4582.6 4903.8 5263.1 5268.7 5283.3 4595.6 5197.5 5564.3 5572.9 5589.0 3422.7 3586.6 3598.8 3605.0 3632.1 4387.0 4585.9 4594.3 5238.3 5348.1 4252.1 4739.4 5073.5 5162.9 5187.6 4457.6 4600.2 4654.7 4749.0 5009.8 4366.5 5002.4 5012.6 5075.6 5173.4 4917.6 5345.7 5450.2 5493.0 5516.7 4394.0 4791.9 5145.5 5227.2 5418.4 19:18:29 INFO - PROCESS | 1900 | 19:18:29 INFO - PROCESS | 1900 | [#5] yui.html Cycles:180 Average:18839.67 Median:4839.62 stddev:26653.79 (550.7%) stddev-sans-first:26693.88 19:18:29 INFO - PROCESS | 1900 | Values: 730.3 768.6 781.0 828.5 836.9 14759.5 15593.4 15606.0 15621.9 15647.7 11776.0 13954.3 14054.0 14127.2 14141.2 660.4 680.7 684.7 686.9 688.2 687.9 833.4 858.4 865.2 867.2 898.8 899.8 903.6 909.6 910.6 898.4 898.6 899.9 901.5 904.6 522.2 642.5 659.5 674.6 680.2 12334.9 14346.6 14821.6 14886.3 15179.3 14401.3 14429.6 14491.9 14501.7 14583.3 9881.2 11808.9 11854.7 11959.2 12118.9 3639.2 3693.2 3866.6 3919.2 3924.3 100101.5 101794.5 101842.0 102768.0 105206.9 9259.0 11088.1 11156.6 11240.7 11256.8 22485.7 22981.0 23003.9 23006.0 23019.8 6440.7 7721.4 7756.6 7862.2 7983.8 4132.8 4216.7 4232.2 4255.8 4333.3 3596.5 3669.6 3701.6 3702.3 3702.4 593.4 639.8 651.0 656.3 661.4 557.8 575.1 590.7 593.6 603.6 8801.5 9217.3 10128.2 10299.9 10374.6 583.5 591.5 601.6 655.2 714.4 4752.1 4927.1 4982.0 5044.8 5045.0 81091.0 89696.0 90082.5 90749.6 91791.0 39373.2 62736.0 83399.6 86309.0 86722.0 73201.0 73387.6 73455.6 74284.3 75927.0 9739.3 9751.5 9754.9 9766.6 9822.8 43949.3 44860.8 45089.0 45238.3 46066.0 61375.0 62236.7 63444.0 63482.7 65677.3 10062.6 11401.1 11535.4 11650.2 12002.3 10705.8 10961.5 12737.1 13012.3 13452.1 11740.5 11945.8 12112.9 12206.3 12531.9 11868.7 12188.6 12233.8 12372.6 12494.9 11617.6 12017.4 12112.9 12322.8 12420.3 9660.2 9695.4 10081.2 10186.3 10231.8 9814.3 9816.2 9837.4 9846.5 9858.2 19:18:29 INFO - PROCESS | 1900 | -------- Summary: end -------- 19:18:29 INFO - PROCESS | 1900 | 19:18:29 INFO - TEST-INFO | 1900: exit 0 19:18:29 INFO - TEST-OK | dromaeo_css | took 1118071ms 19:18:29 INFO - TEST-START | kraken 19:18:29 INFO - operating with platform_type : mac_ 19:18:29 INFO - Initialising browser for kraken test... 19:18:30 INFO - TEST-INFO | started process 1904 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpV2qMg5/profile http://localhost:51482/getInfo.html) 19:18:32 INFO - PROCESS | 1904 | __metrics Screen width/height:1600/1200 19:18:32 INFO - PROCESS | 1904 | colorDepth:24 19:18:32 INFO - PROCESS | 1904 | Browser inner width/height: 1024/689 19:18:32 INFO - PROCESS | 1904 | __metrics 19:18:32 INFO - PROCESS | 1904 | 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:32 INFO - PROCESS | 1904 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:18:33 INFO - TEST-INFO | 1904: exit 0 19:18:33 INFO - Browser initialized. 19:18:33 INFO - Running cycle 1/1 for kraken test... 19:18:33 INFO - TEST-INFO | started process 1905 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/T/tmpV2qMg5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:18:45 INFO - PROCESS | 1905 | RSS: Main: 227266560 19:18:45 INFO - PROCESS | 1905 | 19:18:48 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51482/tests/kraken/driver.html?testName=audio-beat-detection) 19:18:49 INFO - PROCESS | 1905 | RSS: Main: 288047104 19:18:49 INFO - PROCESS | 1905 | 19:18:51 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51482/tests/kraken/driver.html?testName=audio-dft) 19:18:52 INFO - PROCESS | 1905 | RSS: Main: 289193984 19:18:52 INFO - PROCESS | 1905 | 19:18:55 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51482/tests/kraken/driver.html?testName=audio-fft) 19:18:56 INFO - PROCESS | 1905 | RSS: Main: 379408384 19:18:56 INFO - PROCESS | 1905 | 19:18:58 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51482/tests/kraken/driver.html?testName=audio-oscillator) 19:18:59 INFO - PROCESS | 1905 | RSS: Main: 282992640 19:18:59 INFO - PROCESS | 1905 | 19:19:01 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:01 INFO - PROCESS | 1905 | RSS: Main: 286687232 19:19:01 INFO - PROCESS | 1905 | 19:19:04 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51482/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:05 INFO - PROCESS | 1905 | RSS: Main: 329039872 19:19:05 INFO - PROCESS | 1905 | 19:19:08 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51482/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:08 INFO - PROCESS | 1905 | RSS: Main: 330944512 19:19:08 INFO - PROCESS | 1905 | 19:19:11 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51482/tests/kraken/driver.html?testName=json-parse-financial) 19:19:12 INFO - PROCESS | 1905 | RSS: Main: 329109504 19:19:12 INFO - PROCESS | 1905 | 19:19:13 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:14 INFO - PROCESS | 1905 | RSS: Main: 304283648 19:19:14 INFO - PROCESS | 1905 | 19:19:16 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51482/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:19:17 INFO - PROCESS | 1905 | RSS: Main: 307560448 19:19:17 INFO - PROCESS | 1905 | 19:19:19 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:19:20 INFO - PROCESS | 1905 | RSS: Main: 308252672 19:19:20 INFO - PROCESS | 1905 | 19:19:22 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:19:23 INFO - PROCESS | 1905 | RSS: Main: 324124672 19:19:23 INFO - PROCESS | 1905 | 19:19:26 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:19:27 INFO - PROCESS | 1905 | RSS: Main: 318197760 19:19:27 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | Cycle 1(1): loaded http://localhost:51482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51482/tests/kraken/driver.html?testName=ai-astar) 19:19:29 INFO - PROCESS | 1905 | RSS: Main: 362156032 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | __start_tp_report 19:19:29 INFO - PROCESS | 1905 | _x_x_mozilla_page_load 19:19:29 INFO - PROCESS | 1905 | _x_x_mozilla_page_load_details 19:19:29 INFO - PROCESS | 1905 | |i|pagename|runs| 19:19:29 INFO - PROCESS | 1905 | |0;ai-astar;110;111;113;114;112;121;165;114;113;113 19:19:29 INFO - PROCESS | 1905 | |1;audio-beat-detection;148;111;112;150;111;110;110;114;157;135 19:19:29 INFO - PROCESS | 1905 | |2;audio-dft;190;188;185;184;183;194;255;164;262;262 19:19:29 INFO - PROCESS | 1905 | |3;audio-fft;78;57;59;86;59;59;60;75;90;60 19:19:29 INFO - PROCESS | 1905 | |4;audio-oscillator;94;70;84;70;68;69;82;68;69;82 19:19:29 INFO - PROCESS | 1905 | |5;imaging-gaussian-blur;86;84;86;83;87;83;87;83;88;131 19:19:29 INFO - PROCESS | 1905 | |6;imaging-darkroom;93;92;94;93;93;94;94;93;93;93 19:19:29 INFO - PROCESS | 1905 | |7;imaging-desaturate;131;131;94;131;131;86;86;85;85;84 19:19:29 INFO - PROCESS | 1905 | |8;json-parse-financial;57;54;53;55;56;56;54;55;56;56 19:19:29 INFO - PROCESS | 1905 | |9;json-stringify-tinderbox;66;73;70;76;73;70;68;71;70;70 19:19:29 INFO - PROCESS | 1905 | |10;stanford-crypto-aes;90;87;96;106;110;107;92;87;90;90 19:19:29 INFO - PROCESS | 1905 | |11;stanford-crypto-ccm;141;147;149;142;136;140;133;145;200;156 19:19:29 INFO - PROCESS | 1905 | |12;stanford-crypto-pbkdf2;173;172;191;219;172;171;170;172;229;213 19:19:29 INFO - PROCESS | 1905 | |13;stanford-crypto-sha256-iterative;61;82;88;87;66;67;67;65;67;67 19:19:29 INFO - PROCESS | 1905 | __end_tp_report 19:19:29 INFO - PROCESS | 1905 | __start_cc_report 19:19:29 INFO - PROCESS | 1905 | _x_x_mozilla_cycle_collect,1951 19:19:29 INFO - PROCESS | 1905 | __end_cc_report 19:19:29 INFO - PROCESS | 1905 | __startTimestamp1485314369517__endTimestamp 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | ------- Summary: start ------- 19:19:29 INFO - PROCESS | 1905 | Number of tests: 14 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#0] ai-astar Cycles:10 Average:118.60 Median:113.50 stddev:16.57 (14.6%) stddev-sans-first:17.28 19:19:29 INFO - PROCESS | 1905 | Values: 110.0 111.0 113.0 114.0 112.0 121.0 165.0 114.0 113.0 113.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#1] audio-beat-detection Cycles:10 Average:125.80 Median:124.50 stddev:19.45 (15.6%) stddev-sans-first:18.89 19:19:29 INFO - PROCESS | 1905 | Values: 148.0 111.0 112.0 150.0 111.0 110.0 110.0 114.0 157.0 135.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#2] audio-dft Cycles:10 Average:206.70 Median:192.00 stddev:37.43 (19.5%) stddev-sans-first:39.21 19:19:29 INFO - PROCESS | 1905 | Values: 190.0 188.0 185.0 184.0 183.0 194.0 255.0 164.0 262.0 262.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#3] audio-fft Cycles:10 Average:68.30 Median:67.50 stddev:12.68 (18.8%) stddev-sans-first:12.96 19:19:29 INFO - PROCESS | 1905 | Values: 78.0 57.0 59.0 86.0 59.0 59.0 60.0 75.0 90.0 60.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:76.00 stddev:9.17 (12.1%) stddev-sans-first:6.89 19:19:29 INFO - PROCESS | 1905 | Values: 94.0 70.0 84.0 70.0 68.0 69.0 82.0 68.0 69.0 82.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:86.00 stddev:14.60 (17.0%) stddev-sans-first:15.42 19:19:29 INFO - PROCESS | 1905 | Values: 86.0 84.0 86.0 83.0 87.0 83.0 87.0 83.0 88.0 131.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 19:19:29 INFO - PROCESS | 1905 | Values: 93.0 92.0 94.0 93.0 93.0 94.0 94.0 93.0 93.0 93.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#7] imaging-desaturate Cycles:10 Average:104.40 Median:85.00 stddev:23.06 (27.1%) stddev-sans-first:22.36 19:19:29 INFO - PROCESS | 1905 | Values: 131.0 131.0 94.0 131.0 131.0 86.0 86.0 85.0 85.0 84.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.23 (2.2%) stddev-sans-first:1.12 19:19:29 INFO - PROCESS | 1905 | Values: 57.0 54.0 53.0 55.0 56.0 56.0 54.0 55.0 56.0 56.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.50 stddev:2.79 (4.0%) stddev-sans-first:2.39 19:19:29 INFO - PROCESS | 1905 | Values: 66.0 73.0 70.0 76.0 73.0 70.0 68.0 71.0 70.0 70.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#10] stanford-crypto-aes Cycles:10 Average:95.50 Median:90.00 stddev:8.82 (9.8%) stddev-sans-first:9.13 19:19:29 INFO - PROCESS | 1905 | Values: 90.0 87.0 96.0 106.0 110.0 107.0 92.0 87.0 90.0 90.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:146.00 stddev:19.12 (13.1%) stddev-sans-first:20.06 19:19:29 INFO - PROCESS | 1905 | Values: 141.0 147.0 149.0 142.0 136.0 140.0 133.0 145.0 200.0 156.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.20 Median:182.00 stddev:23.29 (12.8%) stddev-sans-first:24.04 19:19:29 INFO - PROCESS | 1905 | Values: 173.0 172.0 191.0 219.0 172.0 171.0 170.0 172.0 229.0 213.0 19:19:29 INFO - PROCESS | 1905 | 19:19:29 INFO - PROCESS | 1905 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:67.00 stddev:9.92 (14.8%) stddev-sans-first:9.74 19:19:29 INFO - PROCESS | 1905 | Values: 61.0 82.0 88.0 87.0 66.0 67.0 67.0 65.0 67.0 67.0 19:19:29 INFO - PROCESS | 1905 | -------- Summary: end -------- 19:19:29 INFO - PROCESS | 1905 | 19:19:30 INFO - TEST-INFO | 1905: exit 0 19:19:30 INFO - TEST-OK | kraken | took 60449ms 19:19:30 INFO - SUITE-END | took 1178s 19:19:30 INFO - Completed test suite (00:19:38) 19:19:30 INFO - javascript benchmark 19:19:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3225.4033003894283, 3295.126791400279, 3304.75214358923, 3323.302106557626, 3362.0250127463037, 4208.473940757405, 5545.085060964946, 5578.553715702744, 5614.045612245918, 5617.01702202115, 5556.944180605682, 5560.555155587554, 5566.805161819337, 5588.804391846286, 5605.971970140144, 5062.569681577071, 5079.2635067915135, 5103.974480127613, 5145.485451454862, 5186.636935414523, 5029.06962211992, 5032.194848824189, 5102.413222479426, 5214.556762675177, 5225.608079394061, 5121.974390128044, 5174.353205849269, 5213.635045546814, 5215.322008138955, 5266.710330931797, 5208.192730126836, 5216.556592689588, 5222.112240919053, 5225.085610018251, 5279.52484276417, 4961.5534601886, 5111.437741848394, 5133.512316329943, 5162.5095615916425, 5164.819231326923, 5497.8075767347955, 5644.85887852807, 5650.773969041234, 5654.9151762723595, 5657.20799088128, 6160.784372546939, 6206.286277078104, 6210.875782484371, 6213.751449941997, 6213.968930155365, 5047.419546752134, 5395.622306438551, 6032.125341825455, 6098.4384226431075, 6224.159738435299, 5652.491275785199, 5780.0, 5782.710864456761, 5790.015697331463, 5805.274340707411, 6227.595206311576, 6239.438450539473, 6245.812625621239, 6249.875002499924, 6251.624902505864, 5718.771249149988, 5767.134929760569, 6112.51099912006, 6134.355892631299, 6137.202163718688, 6105.217149441772, 6116.052011938156, 6127.142200091991, 6154.0, 6191.659458729813, 6128.601640893327, 6146.231721034871, 6146.78486252979, 6148.262208534915, 6150.78472253478, 6005.039193728982, 6159.291681456601, 6163.753449862045, 6180.072989051679, 6183.474404675653, 4869.780859861315, 4924.975375123101, 4946.406431228275, 4952.455229924705, 5020.297158397827, 4416.933745993812, 4420.138073075784, 4429.291313389842, 4429.689921705514, 4462.44219472566, 5510.476504732044, 5541.722913854291, 5548.195511650788, 5826.242588463558, 5842.1236814477315, 6112.959454150325, 6115.027386288435, 6171.012637977902, 6206.317305096436, 6208.937910620926, 5842.853928651818, 5845.473907348359, 5849.298084229919, 5853.882922341614, 5886.764529418861, 5388.110961691355, 5399.271098401744, 5405.108157154104, 5406.107992181246, 5413.242146099549, 6150.815475535741, 6154.661493617805, 6193.938060619336, 6244.125822384779, 6251.46862516673, 6177.876442471035, 6196.256449226122, 6206.658633775186, 6220.564560480723, 6267.279262884645, 6248.812535623939, 6254.749810007549, 6284.151639528605, 6290.2451705793765, 6311.779087731908, 5896.6756828374855, 5924.170616113662, 6053.092036194606, 6078.0, 6160.383961603804, 6169.290531588925, 6182.1345011699295, 6204.7828326008375, 6212.565120441525, 6212.875742485216, 6033.0, 6040.063790112539, 6055.1220073090035, 6058.394160584083, 6075.30134034574, 5745.971270143623, 5860.619059761102, 5942.524598032233, 5955.434233747787, 6000.909986350295, 5795.39148389413, 5882.705864706833, 5886.852828679317, 5896.882062358814, 5910.674912879833, 6002.879942401215, 6016.157737916607, 6016.217891674054, 6016.639001659914, 6017.067354559875, 4703.670743047954, 5656.2929633795775, 5832.125181222681, 5843.29880414336, 5852.3269823969085], "value": 5618.06148661238, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.32868724789324, 454.2414168338874, 509.77569869257525, 513.7405610166866, 533.1097067896611, 32173.51739723903, 41530.792346038266, 42782.14435711284, 42897.57102428975, 44981.32528012074, 31991.52012719811, 44373.0, 44419.77790111045, 44478.4432544861, 44483.55516444835, 7390.40876729863, 8367.790805229888, 8850.5132217728, 9260.490673012982, 9375.76560585984, 8442.240198382144, 8642.135786421339, 8644.65421383147, 8649.956750216272, 11197.832032519478, 11219.719507012349, 11507.194496385257, 11526.423678816067, 11527.135464840128, 11553.133514986368, 11406.201565890391, 11464.0, 11483.081353491702, 11494.597689080842, 11520.135989800798, 8398.370122240794, 8617.0, 11118.888811111867, 11391.658250252505, 11452.255603385836, 39337.0, 41928.16143677109, 41942.370864437056, 41981.37027944583, 42027.0, 4032.899177520556, 4043.8382464701376, 4052.0882801369753, 4060.913705583746, 4127.607877251657, 30218.84890575533, 31161.688383116107, 31424.0, 31530.054098377084, 31884.6811531884, 3007.3684526249294, 3152.4956007038763, 3155.984220078885, 3180.634227063871, 3184.26761844777, 491450.0, 492929.0, 496272.9999999964, 497010.0, 497197.0, 57820.42179578234, 58007.709961449924, 60118.0, 64866.35133648697, 64996.35003649998, 69685.65157174182, 69973.65013174902, 70014.64992675107, 70144.0, 70148.0, 15588.610284742972, 15609.687806243812, 15623.843761562466, 15634.921825391028, 15661.60845978837, 11806.291622502677, 11892.524299027942, 11901.821472677917, 11906.345151016778, 11908.2259653124, 14939.17834519112, 16836.821422500307, 17375.322915641045, 18337.816621833877, 18724.438266852016, 6758.775765146784, 6781.898271525931, 6831.351021652935, 6850.897236541456, 6859.17689877208, 735.7277807211259, 852.7527017164953, 854.5342788180457, 906.1663269791808, 906.7098528470958, 28763.2809179768, 29989.850050749606, 30078.849605752268, 30565.498210322356, 30911.0, 1044.6813721814767, 1081.8093360944151, 1085.5223701571442, 1088.385062439719, 1164.6024770275533, 15291.158986255863, 15784.60538486547, 15788.763168552481, 15860.682786344209, 16176.514704558647, 599362.0031899812, 601796.0, 603720.0, 603930.0, 605549.0, 62769.37230627727, 62848.37151628425, 62897.68551157215, 62992.37007629865, 63048.68475657592, 1371.7530844447895, 1409.3094383751888, 1434.2613554019688, 1439.0933711761522, 1440.3302464354126, 23921.776321048816, 26015.479690406464, 26987.05545305905, 29750.70249297566, 30920.072397828102, 52107.0, 53350.4664953361, 53728.194077089654, 56599.71700141473, 56746.14880776874, 526496.0, 531990.0, 533904.0, 534061.0, 535120.0, 25321.493570128863, 25645.74354256508, 25652.743472565035, 25682.101126460486, 25720.356991074623, 35925.820370899026, 40966.1806763869, 42881.78559107184, 44666.55333446624, 46267.0, 33838.66161338355, 36727.816360919096, 37223.441648374755, 37740.2451950965, 37927.62072379241, 36176.0, 36421.907342779756, 36470.90587282386, 36557.45163822598, 37711.68009119778, 35711.28577428489, 35905.82047089852, 36388.454173186896, 36431.817840910626, 36534.269314613026, 29147.854260729408, 30535.847320763252, 32270.19324516906, 32293.677063229068, 32938.50592241166, 22576.774232257467, 23007.53984920326, 23821.761782381953, 23977.0, 24222.75777242205], "value": 19824.2738989303, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.2688476815903, 386.93615553433665, 389.63569062926166, 396.10480314489257, 422.1114553864116, 14375.928120359396, 15096.245187740624, 17401.042942638167, 20489.897550512265, 20527.589448211027, 16389.5902602435, 20057.899710501464, 20493.692594611093, 20500.589988200227, 20820.0, 5940.2277703898435, 6180.81457556274, 6189.535784816134, 6193.566450348455, 7604.847903041936, 7875.724349647763, 7986.720464783733, 8037.316828069592, 8128.30909372704, 8131.390145739064, 4102.979485102585, 4891.1195984722735, 4951.628627852908, 7999.640016199285, 8130.065042520097, 7257.092863392076, 7605.163432022473, 7921.524708517507, 8108.189181081874, 8153.99999999997, 7268.400951790651, 7443.069616297963, 7449.553026818408, 7469.551826890404, 7560.0, 25332.873335633387, 29021.12936611905, 29164.791872893966, 29345.266368340748, 29681.257968550744, 3008.74425673818, 3045.741112005482, 3054.7708921830954, 3092.196029032445, 3135.4826453635123, 16616.750748738777, 16920.98474091546, 16954.745678814827, 17636.20637071335, 17922.372716954844, 1894.9052547372576, 1933.7030363230658, 1985.8014198580172, 1996.19154242532, 2068.6690129579197, 120446.3977680106, 140079.29960350235, 157314.0, 160628.0, 161902.0, 22895.427614309774, 23437.648435273484, 23531.529369412518, 23645.315302335326, 23907.294369372776, 41245.79377103155, 41333.379999300036, 41458.0, 41545.58454415478, 41574.96062598459, 7916.960415197887, 8084.231997960184, 8429.789255268544, 8589.828203435896, 10808.51361688726, 7973.800654983672, 7979.48133371329, 7994.880076798852, 8157.75526734199, 8170.3872209584515, 3967.484227050465, 4817.2774083887, 4824.131656301829, 4840.0, 4894.926576101361, 1851.8148185181644, 1867.318428773488, 1987.7316562264198, 2020.8585399022222, 2037.8777273363646, 865.0052439694401, 971.2129681386142, 986.2110311750571, 1006.3961623026272, 1015.5074788727461, 19738.40784776459, 21042.368728938156, 21448.24931127403, 21466.463338416663, 21472.35582932483, 960.846264597675, 1013.1337706261188, 1022.3252653248969, 1037.8754549454113, 1048.1457612046158, 10461.0, 11171.385573793357, 11302.908961842086, 11312.547498099984, 11563.132765042656, 579078.0, 584067.1593284013, 590624.0, 718581.0, 719442.0, 111591.42026441371, 152438.0, 161397.3860261406, 168871.0, 170855.14572427058, 1012.336919317848, 1050.6427814543244, 1071.4803320389606, 1074.9193810464246, 1078.2991055813784, 19568.706469403256, 19586.706199406734, 20036.499087522927, 20057.0, 20150.798492015478, 53008.0, 60881.82504487168, 61079.69460152671, 62524.0, 63118.0, 70766.2308442293, 86812.56593716991, 91207.54396227976, 91444.0, 91821.40892955192, 7837.137914829478, 8074.3944204183745, 8082.474639148437, 8507.489550626982, 8541.01778295504, 9173.495457749888, 12237.632871013884, 12761.680957976125, 12930.612081637566, 13034.152780069266, 8008.479448835807, 10083.747906302402, 10919.945400272947, 11278.0, 11445.42772861337, 7508.887366689613, 8541.444806087833, 10932.0, 11138.3873886937, 11369.54521819118, 8549.0, 11131.554737810397, 11294.887051129384, 11530.76938461243, 11548.94225528867, 6966.930330696831, 8119.066307374727, 8288.668453261802, 8307.750767476986, 8330.083690793886, 9018.458892466473, 11015.504302306255, 11187.72030699239, 11267.943660281646, 11323.0], "value": 10796.074681449496, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.720027394384, 1478.3125846481385, 1495.4466847266513, 1497.15410792902, 1502.6243439140208, 6514.641694706789, 8436.578171091436, 8441.198086181803, 8454.450460720049, 8463.195996380342, 7369.852602947938, 7641.923580764191, 7662.770116896502, 8116.5941702914915, 8334.124916883731, 2293.736220334662, 2334.2997100869757, 2337.91817286395, 2338.754430784769, 2340.871252081143, 2304.5275718477756, 2341.2976107167783, 2342.4378149244144, 2344.4373350395954, 2345.9560495579476, 2308.7575804540534, 2320.535892821434, 2340.7659234076627, 2341.4146463384154, 2342.016353131689, 1959.490532461556, 2289.221664634024, 2289.427643089228, 2301.8158547316175, 2324.151684635113, 1838.347386677737, 2130.3182981445943, 2146.8926553672254, 2326.6044772388736, 2330.778576035274, 8264.173582641748, 8339.83320333596, 8346.207110324509, 8372.03721572015, 8376.329893608498, 4926.2118061110405, 5082.1360368737405, 5088.414832294259, 5096.133657278235, 5102.209157580581, 3080.9383812323626, 3226.58054452922, 3352.7150192233444, 3415.1291420687567, 3417.624061353249, 1080.400377790326, 1083.8320060390652, 1118.9664310070712, 1143.9142064345124, 1162.3490845126755, 10427.478626068667, 10716.78566428667, 10753.03222709952, 10765.892341076567, 10786.191035672357, 4272.380504826845, 4555.248384016666, 4619.9076018479445, 4629.699069560468, 4643.674942753974, 9382.765430864283, 9395.906040939502, 9427.292953028413, 9430.3870248435, 9433.858492122623, 5110.850058736754, 5120.513551212629, 5124.564412024945, 5127.820526281562, 5132.3327967364, 4193.161367726467, 4350.434443522322, 4532.546745325507, 4616.907661846812, 4688.2733176357715, 3694.445833124999, 3767.472553842464, 3792.1278106035766, 3834.808259587065, 3841.692664586826, 1254.2913254011637, 1262.7979523276415, 1264.20986883198, 1276.9680757981125, 1282.6216266201493, 813.8321508635128, 870.7779516223322, 895.2166854002747, 899.0964081098585, 934.7522906429801, 5518.779248830002, 5604.159376093537, 5692.516136128475, 5773.393793651606, 5892.852678682982, 978.7944531648434, 980.4901451245313, 990.1336330710628, 994.472929347447, 1019.9235057370727, 3601.225736466672, 3633.1825339298975, 3672.614375490535, 3719.9814000929823, 3805.0867791729784, 9650.420974741539, 9888.318985772436, 10019.448930308758, 10052.447115408722, 10059.195264378832, 9954.751131221778, 9978.600855965826, 9981.850272245922, 10001.649942252132, 10028.047335503115, 7642.19756925526, 7746.845063098706, 7831.647575858986, 7842.411819113589, 7852.489588176751, 5256.421793602777, 5439.566753096214, 5545.417731138334, 5573.829495805926, 5660.235868157746, 7613.9238607613215, 7762.0, 9307.255419566554, 9314.25485961108, 9330.486823224788, 8957.10428957099, 9272.258219342571, 9373.20327772147, 9381.296402769683, 9468.621255149717, 5280.973595132, 6332.0, 7044.6125463100025, 7190.029346038218, 7199.892001619875, 7800.063992320957, 7969.760907172794, 7970.003749531309, 7979.601019948863, 7985.401094918021, 6964.860702786017, 7033.191183014019, 7056.1179852518435, 7099.36105750485, 7203.459740519377, 6820.795376138723, 6961.37347638715, 6970.714836655013, 7033.0856988593205, 7102.680379383043, 6292.716827742855, 6341.4292713656, 6400.487960963205, 6410.1025856381075, 6417.684374703082, 4929.753512324298, 4962.106820772296, 4978.726170060537, 4984.975075124601, 5079.009593129304, 4846.200376937766, 4882.292067650242, 4932.506749325039, 4952.678075925053, 5020.949790502194], "value": 4368.948234621964, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.58520116664675, 365.404390842926, 369.1417454418478, 381.08539505187565, 382.3156549775903, 4845.709257444556, 5281.339832520935, 5291.5076049807085, 5352.866178345544, 5362.51737343639, 4636.791344389502, 4694.647901407391, 4992.0, 5044.511868998645, 5107.719075450848, 3901.356276214421, 4046.797660116997, 4099.323611604082, 4132.685696010229, 4154.1276331970175, 4115.979420102895, 4122.484689413824, 4135.648469880064, 4141.399497072937, 4158.792060396983, 3446.551948246737, 3881.0103423626933, 4084.7140700151003, 4124.690648201382, 4134.793260336971, 3815.7328986970924, 3861.8841434757, 4100.405441211008, 4101.835926562934, 4128.442660240859, 3150.9684903150905, 3544.025393016915, 3628.600853906068, 3636.7454278200535, 3639.854405823764, 4417.734935903856, 4684.742339171345, 5081.669691470042, 5084.872878178038, 5112.003159383921, 4474.507804141542, 4539.818407263706, 4568.223402021665, 4569.994601187766, 4581.289900065495, 4643.770989924821, 5483.643563168421, 5541.2796336476, 5552.278203833516, 5615.887682246373, 3225.387176436493, 3237.514372844092, 3780.262848744496, 3790.6967442604528, 3815.561210460777, 4762.357081793948, 5395.838124856221, 5479.945200547983, 5778.855528611776, 5870.706464676749, 3857.2035274425816, 3857.3056849767313, 3867.511008261783, 3875.9418608720894, 3876.3604005339366, 3464.566929133858, 3614.566252049771, 3656.8537258509364, 3922.627350401707, 3927.7250592458827, 3653.5250417446096, 3945.881623551298, 4265.296226122655, 4587.7377379876225, 4605.723656580616, 4661.370714953506, 5358.97320513395, 5604.8038318658655, 5632.577556683265, 5650.74571644277, 1169.4971961030035, 1205.3189947679532, 1276.2215048820212, 1279.1643990873126, 1281.8397700287464, 813.259933460548, 832.9671207702405, 836.0469065265602, 852.7782776478036, 861.2679222660813, 4384.956150438518, 4899.387576552931, 4950.6782059166035, 4962.330085438492, 4967.726775027409, 4777.617790576745, 5384.40771515133, 5423.457654234624, 5484.149956756709, 5490.835274941758, 3923.4899463070187, 4234.55537168599, 4341.891452713708, 4365.8866988917625, 4745.217039188564, 2433.586290330648, 2439.5852705040184, 2778.4165325281915, 2787.3136752264995, 2811.2971757060736, 4822.0, 5128.8461346159675, 5132.072456312964, 5527.972360138174, 5530.6128570999645, 5155.690658560424, 5427.375851777097, 5514.443184146203, 5540.501354878, 5610.707808526399, 4705.670603057822, 4995.875103122451, 5196.246544251062, 5549.916751248735, 5572.693501857437, 4939.258312020357, 5280.392754833089, 5304.310439642822, 5333.573224183065, 5343.278657381359, 4582.633389328779, 4903.77932993009, 5263.131588286104, 5268.710220937885, 5283.339582552181, 4595.586397224266, 5197.454267301879, 5564.271937801764, 5572.888542229214, 5588.993981083444, 3422.691957723817, 3586.5696116465147, 3598.8020658864016, 3604.981975090108, 3632.110133017428, 4386.956130438783, 4585.862424127282, 4594.287885377772, 5238.292830467838, 5348.112019509577, 4252.128313695747, 4739.431268247832, 5073.543381095719, 5162.870928226825, 5187.636865419536, 4457.643388528974, 4600.217962946374, 4654.743989080498, 4749.026449577897, 5009.824656137018, 4366.497852746975, 5002.398752648675, 5012.573931215888, 5075.619328550448, 5173.430922598586, 4917.606591472602, 5345.732713364238, 5450.209719590716, 5492.983797997384, 5516.703574659871, 4394.033312671208, 4791.8978634914865, 5145.485451454824, 5227.215917612237, 5418.431064738304], "value": 3917.3890994993403, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.3463400256767, 768.6156921539231, 780.996419600813, 828.4532208742231, 836.8995720513537, 14759.48341808037, 15593.37626494939, 15606.0, 15621.92189039056, 15647.687046259069, 11776.0, 13954.302284885765, 14054.016218864683, 14127.223002734845, 14141.222232777192, 660.4452260101514, 680.714100077966, 684.6576711644178, 686.8660611180821, 688.1810645332064, 687.8968154776774, 833.3749687734199, 858.4034096303072, 865.1910463716414, 867.2108381372952, 898.8427025270585, 899.8110396816676, 903.6114470777563, 909.6179604566098, 910.6038873090226, 898.3846065445125, 898.5597057441872, 899.9415038022507, 901.5041727050096, 904.5929331800716, 522.1958184396026, 642.4635429416443, 659.482306389482, 674.5682763031664, 680.1769858471206, 12334.938325308405, 14346.56960291193, 14821.555353339418, 14886.330115144845, 15179.316930738032, 14401.279936003159, 14429.567112986628, 14491.927540362336, 14501.709965800625, 14583.34374953119, 9881.16010139139, 11808.881911180864, 11854.703632409173, 11959.162858599902, 12118.939405303005, 3639.181184233553, 3693.2428852085527, 3866.5693693333365, 3919.157381163035, 3924.2543916655745, 100101.49137323337, 101794.49102754513, 101842.0, 102767.97232027659, 105206.94793052049, 9259.0, 11088.112950963903, 11156.553737850558, 11240.662780116609, 11256.831147532794, 22485.662715059287, 22981.0, 23003.88498057499, 23006.0, 23019.769802302097, 6440.677966101676, 7721.382289416833, 7756.573388463688, 7862.174471680506, 7983.760487185394, 4132.8140233689555, 4216.746995180299, 4232.195882782262, 4255.8084886180195, 4333.285007973712, 3596.478510615946, 3669.6330366963625, 3701.592824789271, 3702.259548090393, 3702.407614781622, 593.3828818029288, 639.7632875835877, 650.9641969691712, 656.297761395312, 661.441082285468, 557.768526061688, 575.1372940589116, 590.7459792289357, 593.5874567175857, 603.6408337039454, 8801.515916624647, 9217.308701847389, 10128.189744820544, 10299.858543144263, 10374.576934703102, 583.486531851976, 591.4942723971029, 601.6029420582395, 655.2039272284197, 714.3677845107118, 4752.144613969519, 4927.088488629615, 4981.975090124526, 5044.798208071709, 5045.0, 81091.0, 89696.0, 90082.54958725296, 90749.63875541872, 91791.0, 39373.2125357497, 62736.0, 83399.5830020846, 86309.0, 86722.0, 73201.0, 73387.63306183435, 73455.61437977121, 74284.25715742882, 75927.0, 9739.269554783277, 9751.463669498246, 9754.9024509754, 9766.56050477716, 9822.803543929223, 43949.340759889266, 44860.77569612131, 45089.0, 45238.321425177994, 46066.0, 61375.0, 62236.68881655563, 63444.0, 63482.68258658677, 65677.34322656904, 10062.647807326708, 11401.144914131308, 11535.423228838692, 11650.242734222249, 12002.339871307162, 10705.785884282426, 10961.50673219691, 12737.077626023829, 13012.349382530647, 13452.1256118352, 11740.471678774646, 11945.820812687643, 12112.939435302767, 12206.267623942593, 12531.87468125307, 11868.703282418008, 12188.57339993096, 12233.816492752438, 12372.566960156351, 12494.937525312314, 11617.593384231512, 12017.399130043637, 12112.93943530312, 12322.815157772462, 12420.254784712946, 9660.227181825578, 9695.418274903246, 10081.186441517539, 10186.33788803755, 10231.777828818098, 9814.312998090065, 9816.214702823614, 9837.360571562825, 9846.458444785605, 9858.211343092678], "value": 7114.060300775274, "unit": "score"}], "name": "dromaeo_css", "value": 7259.924492764822, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 113.0, 114.0, 112.0, 121.0, 165.0, 114.0, 113.0, 113.0], "value": 118.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 112.0, 150.0, 111.0, 110.0, 110.0, 114.0, 157.0, 135.0], "value": 125.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 188.0, 185.0, 184.0, 183.0, 194.0, 255.0, 164.0, 262.0, 262.0], "value": 206.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 57.0, 59.0, 86.0, 59.0, 59.0, 60.0, 75.0, 90.0, 60.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 70.0, 84.0, 70.0, 68.0, 69.0, 82.0, 68.0, 69.0, 82.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 83.0, 87.0, 83.0, 87.0, 83.0, 88.0, 131.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 94.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 131.0, 94.0, 131.0, 131.0, 86.0, 86.0, 85.0, 85.0, 84.0], "value": 104.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 55.0, 56.0, 56.0, 54.0, 55.0, 56.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 70.0, 76.0, 73.0, 70.0, 68.0, 71.0, 70.0, 70.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 96.0, 106.0, 110.0, 107.0, 92.0, 87.0, 90.0, 90.0], "value": 95.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 147.0, 149.0, 142.0, 136.0, 140.0, 133.0, 145.0, 200.0, 156.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 191.0, 219.0, 172.0, 171.0, 170.0, 172.0, 229.0, 213.0], "value": 188.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 82.0, 88.0, 87.0, 66.0, 67.0, 67.0, 65.0, 67.0, 67.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1512.6000000000004, "alertThreshold": 2.0}]} 19:19:30 INFO - Return code: 0 19:19:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:19:30 ERROR - # TBPL SUCCESS # 19:19:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:19:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:19:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:19:30 INFO - 2017-01-24 19:19:30.820 screenresolution[1909:14762] starting screenresolution argv=screenresolution get 19:19:30 INFO - 2017-01-24 19:19:30.823 screenresolution[1909:14762] Display 0: 1600x1200x32@60 19:19:30 INFO - 2017-01-24 19:19:30.830 screenresolution[1910:14765] starting screenresolution argv=screenresolution list 19:19:30 INFO - Available Modes on Display 0 19:19:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:19:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:19:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:19:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:19:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:19:31 INFO - Intel Iris: 19:19:31 INFO - Chipset Model: Intel Iris 19:19:31 INFO - Type: GPU 19:19:31 INFO - Bus: Built-In 19:19:31 INFO - VRAM (Dynamic, Max): 1536 MB 19:19:31 INFO - Vendor: Intel (0x8086) 19:19:31 INFO - Device ID: 0x0a2e 19:19:31 INFO - Revision ID: 0x0009 19:19:31 INFO - Displays: 19:19:31 INFO - Display: 19:19:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:19:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:19:31 INFO - Display Serial Number: 1600x1200 60 19:19:31 INFO - Main Display: Yes 19:19:31 INFO - Mirror: Off 19:19:31 INFO - Online: Yes 19:19:31 INFO - Rotation: Supported 19:19:31 INFO - Return code: 0 19:19:31 INFO - Running post-action listener: _resource_record_post_action 19:19:31 INFO - [mozharness: 2017-01-25 03:19:31.066833Z] Finished run-tests step (success) 19:19:31 INFO - Running post-run listener: _resource_record_post_run 19:19:31 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 1716224; Write bytes: 553554944; Read time: 14; Write time: 1691 19:19:31 INFO - TinderboxPrint: CPU usage
53.7% 19:19:31 INFO - TinderboxPrint: I/O read bytes / time
1,716,224 / 14 19:19:31 INFO - TinderboxPrint: I/O write bytes / time
553,554,944 / 1,691 19:19:31 INFO - TinderboxPrint: CPU idle
2,227.0 (46.3%) 19:19:31 INFO - TinderboxPrint: CPU system
960.3 (20.0%) 19:19:31 INFO - TinderboxPrint: CPU user
1,618.2 (33.7%) 19:19:31 INFO - TinderboxPrint: Swap in / out
253,726,720 / 0 19:19:31 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252543488; Write bytes: 254351360; Read time: 18223; Write time: 563 19:19:31 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 716800; Write bytes: 297774080; Read time: 9; Write time: 1119 19:19:31 INFO - Running post-run listener: _upload_blobber_files 19:19:31 INFO - Blob upload gear active. 19:19:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:19:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:19:31 INFO - (blobuploader) - INFO - Open directory for files ... 19:19:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:19:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:32 INFO - (blobuploader) - INFO - Done attempting. 19:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:19:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:33 INFO - (blobuploader) - INFO - Done attempting. 19:19:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:19:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:19:34 INFO - (blobuploader) - INFO - Done attempting. 19:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:19:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.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 - Iteration through files over. 19:19:37 INFO - Return code: 0 19:19:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:19:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:19:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b43cfda65e37bc923d68e4fb9c4c498fe67e19a4934ed5e2cd1489fe36b008069ac6a09ee59ccbe30d904d9ecdb780c36f69e1f8aa76bf2e0294406c273cac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9289812572aabf8dc378b3925d3695371ce0afbdd7f18fa7f48596910d2bb073db632c458e197ae9d4f37fb05d217487f5cfda095d0978772a82890b38c982e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5fa954878e290b474d57b5877fc739b9956beaa721fc1246efbf74489225bca7f9dd0b38b326fa834beb1df0a87545c2ba97d49ab6778d9839758e491dcea5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df1c8e28881a4569df94649fad18622d032a894ae7d53d14bdb13c3ee65af505194ca145f27c8717a0bbb8617317c7b57806a20e6531cb6c1b72d1cd44ca0ba0"} 19:19:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:19:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:19:37 INFO - Contents: 19:19:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b43cfda65e37bc923d68e4fb9c4c498fe67e19a4934ed5e2cd1489fe36b008069ac6a09ee59ccbe30d904d9ecdb780c36f69e1f8aa76bf2e0294406c273cac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9289812572aabf8dc378b3925d3695371ce0afbdd7f18fa7f48596910d2bb073db632c458e197ae9d4f37fb05d217487f5cfda095d0978772a82890b38c982e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5fa954878e290b474d57b5877fc739b9956beaa721fc1246efbf74489225bca7f9dd0b38b326fa834beb1df0a87545c2ba97d49ab6778d9839758e491dcea5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df1c8e28881a4569df94649fad18622d032a894ae7d53d14bdb13c3ee65af505194ca145f27c8717a0bbb8617317c7b57806a20e6531cb6c1b72d1cd44ca0ba0"} 19:19:37 INFO - Running post-run listener: copy_logs_to_upload_dir 19:19:37 INFO - Copying logs to upload dir... 19:19:37 INFO - mkdir: /builds/slave/test/build/upload/logs 19:19:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.245111 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-24 19:19:37.377560) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:37.381705) ========= 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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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/3b43cfda65e37bc923d68e4fb9c4c498fe67e19a4934ed5e2cd1489fe36b008069ac6a09ee59ccbe30d904d9ecdb780c36f69e1f8aa76bf2e0294406c273cac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9289812572aabf8dc378b3925d3695371ce0afbdd7f18fa7f48596910d2bb073db632c458e197ae9d4f37fb05d217487f5cfda095d0978772a82890b38c982e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5fa954878e290b474d57b5877fc739b9956beaa721fc1246efbf74489225bca7f9dd0b38b326fa834beb1df0a87545c2ba97d49ab6778d9839758e491dcea5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df1c8e28881a4569df94649fad18622d032a894ae7d53d14bdb13c3ee65af505194ca145f27c8717a0bbb8617317c7b57806a20e6531cb6c1b72d1cd44ca0ba0"} 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.011280 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/3b43cfda65e37bc923d68e4fb9c4c498fe67e19a4934ed5e2cd1489fe36b008069ac6a09ee59ccbe30d904d9ecdb780c36f69e1f8aa76bf2e0294406c273cac4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9289812572aabf8dc378b3925d3695371ce0afbdd7f18fa7f48596910d2bb073db632c458e197ae9d4f37fb05d217487f5cfda095d0978772a82890b38c982e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc5fa954878e290b474d57b5877fc739b9956beaa721fc1246efbf74489225bca7f9dd0b38b326fa834beb1df0a87545c2ba97d49ab6778d9839758e491dcea5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df1c8e28881a4569df94649fad18622d032a894ae7d53d14bdb13c3ee65af505194ca145f27c8717a0bbb8617317c7b57806a20e6531cb6c1b72d1cd44ca0ba0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:37.416352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:37.416667) ========= 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.86ma5WXb6M/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.4t2Tc1CxNQ/Listeners TMPDIR=/var/folders/0_/xnyh15dn6zsfksvc2py1fy8w00000w/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.005299 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 19:19:37.464863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 19:19:37.465154) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 19:19:37.465475) ========= ========= Total master_lag: 0.50 =========