builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0050 starttime: 1487072360.84 results: success (0) buildid: 20170214014944 builduid: 9d072265c08f46a9a93291ed74fed2d3 revision: 2476b831a480c8ab160281f8fb11e9cdc298ad26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:20.836532) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:20.837047) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:20.837441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:20.864383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:20.864768) ========= 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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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-02-14 03:39:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.9M=0.001s 2017-02-14 03:39:20 (11.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132664 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:21.023162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:21.023538) ========= 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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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.026342 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:21.072756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 03:39:21.073095) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2476b831a480c8ab160281f8fb11e9cdc298ad26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2476b831a480c8ab160281f8fb11e9cdc298ad26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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-02-14 03:39:21,150 truncating revision to first 12 chars 2017-02-14 03:39:21,150 Setting DEBUG logging. 2017-02-14 03:39:21,150 attempt 1/10 2017-02-14 03:39:21,150 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2476b831a480?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 03:39:22,683 unpacking tar archive at: mozilla-aurora-2476b831a480/testing/mozharness/ program finished with exit code 0 elapsedTime=1.808534 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 03:39:22.907191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:22.907761) ========= script_repo_revision: 2476b831a480c8ab160281f8fb11e9cdc298ad26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:22.908522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:22.908895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 03:39:22.928919) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-14 03:39:22.929284) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:39:23 INFO - MultiFileLogger online at 20170214 03:39:23 in /builds/slave/test 03:39:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:39:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:39:23 INFO - {'append_to_log': False, 03:39:23 INFO - 'base_work_dir': '/builds/slave/test', 03:39:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:39:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:39:23 INFO - 'branch': 'Mozilla-Aurora', 03:39:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:39:23 INFO - 'config_files': ('talos/mac_config.py',), 03:39:23 INFO - 'default_actions': ('clobber', 03:39:23 INFO - 'read-buildbot-config', 03:39:23 INFO - 'download-and-extract', 03:39:23 INFO - 'populate-webroot', 03:39:23 INFO - 'create-virtualenv', 03:39:23 INFO - 'install', 03:39:23 INFO - 'run-tests'), 03:39:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:39:23 INFO - 'download_minidump_stackwalk': True, 03:39:23 INFO - 'download_symbols': 'ondemand', 03:39:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:39:23 INFO - 'tooltool.py': '/tools/tooltool.py', 03:39:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:39:23 INFO - '/tools/misc-python/virtualenv.py')}, 03:39:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:39:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:39:23 INFO - 'installer_path': 'installer.exe', 03:39:23 INFO - 'log_level': 'info', 03:39:23 INFO - 'log_name': 'talos', 03:39:23 INFO - 'log_to_console': True, 03:39:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:39:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:39:23 INFO - 'opt_config_files': (), 03:39:23 INFO - 'pip_index': False, 03:39:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:39:23 INFO - 'cmd': ('bash', 03:39:23 INFO - '-c', 03:39:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:39:23 INFO - 'enabled': True, 03:39:23 INFO - 'halt_on_failure': False, 03:39:23 INFO - 'name': 'check_screen_resolution'},), 03:39:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:39:23 INFO - 'cmd': ('bash', 03:39:23 INFO - '-c', 03:39:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:39:23 INFO - 'enabled': True, 03:39:23 INFO - 'halt_on_failure': False, 03:39:23 INFO - 'name': 'check_screen_resolution'},), 03:39:23 INFO - 'run_cmd_checks_enabled': True, 03:39:23 INFO - 'sps_profile': False, 03:39:23 INFO - 'sps_profile_interval': 0, 03:39:23 INFO - 'suite': 'dromaeojs', 03:39:23 INFO - 'system_bits': '32', 03:39:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:39:23 INFO - 'title': 't-yosemite-r7-0050', 03:39:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:39:23 INFO - 'use_talos_json': True, 03:39:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:39:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:39:23 INFO - 'work_dir': 'build'} 03:39:23 INFO - [mozharness: 2017-02-14 11:39:23.113249Z] Running clobber step. 03:39:23 INFO - Running pre-action listener: _resource_record_pre_action 03:39:23 INFO - Running main action method: clobber 03:39:23 INFO - rmtree: /builds/slave/test/build 03:39:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:39:25 INFO - Running post-action listener: _resource_record_post_action 03:39:25 INFO - [mozharness: 2017-02-14 11:39:25.393600Z] Finished clobber step (success) 03:39:25 INFO - [mozharness: 2017-02-14 11:39:25.393746Z] Running read-buildbot-config step. 03:39:25 INFO - Running pre-action listener: _resource_record_pre_action 03:39:25 INFO - Running main action method: read_buildbot_config 03:39:25 INFO - Using buildbot properties: 03:39:25 INFO - { 03:39:25 INFO - "project": "", 03:39:25 INFO - "product": "firefox", 03:39:25 INFO - "script_repo_revision": "production", 03:39:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:39:25 INFO - "repository": "", 03:39:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:39:25 INFO - "buildid": "20170214014944", 03:39:25 INFO - "pgo_build": "False", 03:39:25 INFO - "basedir": "/builds/slave/test", 03:39:25 INFO - "buildnumber": 46, 03:39:25 INFO - "slavename": "t-yosemite-r7-0050", 03:39:25 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 03:39:25 INFO - "platform": "yosemite_r7", 03:39:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:39:25 INFO - "branch": "mozilla-aurora", 03:39:25 INFO - "repo_path": "releases/mozilla-aurora", 03:39:25 INFO - "revision": "2476b831a480c8ab160281f8fb11e9cdc298ad26", 03:39:25 INFO - "stage_platform": "macosx64", 03:39:25 INFO - "builduid": "9d072265c08f46a9a93291ed74fed2d3", 03:39:25 INFO - "slavebuilddir": "test" 03:39:25 INFO - } 03:39:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 03:39:25 INFO - Running post-action listener: _resource_record_post_action 03:39:25 INFO - [mozharness: 2017-02-14 11:39:25.397234Z] Finished read-buildbot-config step (success) 03:39:25 INFO - [mozharness: 2017-02-14 11:39:25.397326Z] Running download-and-extract step. 03:39:25 INFO - Running pre-action listener: _resource_record_pre_action 03:39:25 INFO - Running main action method: download_and_extract 03:39:25 INFO - mkdir: /builds/slave/test/build/tests 03:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:25 INFO - trying https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 03:39:25 INFO - Downloading https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 03:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 03:39:26 INFO - Downloaded 1199 bytes. 03:39:26 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 03:39:26 INFO - Using the following test package requirements: 03:39:26 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 03:39:26 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 03:39:26 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 03:39:26 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:39:26 INFO - u'jsshell-mac.zip'], 03:39:26 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 03:39:26 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 03:39:26 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 03:39:26 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 03:39:26 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 03:39:26 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:39:26 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 03:39:26 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:39:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 03:39:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:39:26 INFO - Fetch https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 03:39:27 INFO - Expected file size: 16358348 03:39:27 INFO - Obtained file size: 16358348 03:39:34 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:39:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 03:39:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:39:34 INFO - Fetch https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 03:39:35 INFO - Expected file size: 16358348 03:39:35 INFO - Obtained file size: 16358348 03:39:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 03:39:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:39:41 INFO - Fetch https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 03:39:42 INFO - Expected file size: 14403485 03:39:42 INFO - Obtained file size: 14403485 03:39:43 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')]} 03:39:43 INFO - trying https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 03:39:43 INFO - Downloading https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 03:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 03:39:45 INFO - Downloaded 73959750 bytes. 03:39:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 03:39:45 INFO - mkdir: /builds/slave/test/properties 03:39:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:39:45 INFO - Writing to file /builds/slave/test/properties/build_url 03:39:45 INFO - Contents: 03:39:45 INFO - build_url:https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 03:39:45 INFO - Running post-action listener: _resource_record_post_action 03:39:45 INFO - Running post-action listener: set_extra_try_arguments 03:39:45 INFO - [mozharness: 2017-02-14 11:39:45.914222Z] Finished download-and-extract step (success) 03:39:45 INFO - [mozharness: 2017-02-14 11:39:45.914352Z] Running populate-webroot step. 03:39:45 INFO - Running pre-action listener: _resource_record_pre_action 03:39:45 INFO - Running main action method: populate_webroot 03:39:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:39:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:39:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:39:45 INFO - '--tppagecycles', 03:39:45 INFO - '7'], 03:39:45 INFO - 'tests': ['tsvgm']}}, 03:39:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:39:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:39:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:39:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:39:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:39:45 INFO - 'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:39:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:39:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:39:45 INFO - 'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['damp', 'tps']}, 03:39:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:39:45 INFO - 'tests': ['damp', 'tps']}, 03:39:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['dromaeo_dom']}, 03:39:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:39:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['basic_compositor_video']}, 03:39:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:39:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['a11yr', 03:39:45 INFO - 'ts_paint', 03:39:45 INFO - 'tpaint', 03:39:45 INFO - 'sessionrestore', 03:39:45 INFO - 'sessionrestore_no_auto_restore', 03:39:45 INFO - 'tabpaint']}, 03:39:45 INFO - 'other-e10s': {'tests': ['a11yr', 03:39:45 INFO - 'ts_paint', 03:39:45 INFO - 'tpaint', 03:39:45 INFO - 'sessionrestore', 03:39:45 INFO - 'sessionrestore_no_auto_restore', 03:39:45 INFO - 'tabpaint']}, 03:39:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:39:45 INFO - 'ts_paint', 03:39:45 INFO - 'tpaint', 03:39:45 INFO - 'sessionrestore', 03:39:45 INFO - 'sessionrestore_no_auto_restore', 03:39:45 INFO - 'tabpaint']}, 03:39:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:39:45 INFO - 'ts_paint', 03:39:45 INFO - 'tpaint', 03:39:45 INFO - 'sessionrestore', 03:39:45 INFO - 'sessionrestore_no_auto_restore', 03:39:45 INFO - 'tabpaint']}, 03:39:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['a11yr', 03:39:45 INFO - 'ts_paint', 03:39:45 INFO - 'tpaint', 03:39:45 INFO - 'sessionrestore', 03:39:45 INFO - 'sessionrestore_no_auto_restore', 03:39:45 INFO - 'tabpaint']}, 03:39:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['a11yr', 03:39:45 INFO - 'ts_paint', 03:39:45 INFO - 'tpaint', 03:39:45 INFO - 'sessionrestore', 03:39:45 INFO - 'sessionrestore_no_auto_restore', 03:39:45 INFO - 'tabpaint']}, 03:39:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['tsvgx', 03:39:45 INFO - 'tsvgr_opacity', 03:39:45 INFO - 'tart', 03:39:45 INFO - 'tscrollx', 03:39:45 INFO - 'cart', 03:39:45 INFO - 'tsvg_static']}, 03:39:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:39:45 INFO - 'tsvgr_opacity', 03:39:45 INFO - 'tart', 03:39:45 INFO - 'tscrollx', 03:39:45 INFO - 'cart', 03:39:45 INFO - 'tsvg_static']}, 03:39:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:39:45 INFO - 'talos_options': ['--disable-e10s'], 03:39:45 INFO - 'tests': ['tp5o']}, 03:39:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:39:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:39:45 INFO - 'talos_options': ['--disable-e10s', 03:39:45 INFO - '--xperf_path', 03:39:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:45 INFO - 'tests': ['tp5n']}, 03:39:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:39:45 INFO - 'talos_options': ['--xperf_path', 03:39:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:39:45 INFO - 'tests': ['tp5n']}}, 03:39:45 INFO - 'talos.zip': {'path': '', 03:39:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:39:45 INFO - Running post-action listener: _resource_record_post_action 03:39:45 INFO - [mozharness: 2017-02-14 11:39:45.933034Z] Finished populate-webroot step (success) 03:39:45 INFO - [mozharness: 2017-02-14 11:39:45.933147Z] Running create-virtualenv step. 03:39:45 INFO - Running pre-action listener: _resource_record_pre_action 03:39:45 INFO - Running main action method: create_virtualenv 03:39:45 INFO - Creating virtualenv /builds/slave/test/build/venv 03:39:45 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 03:39:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:39:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:39:46 INFO - Using real prefix '/tools/python27' 03:39:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:39:46 INFO - Installing distribute.............................................................................................................................................................................................done. 03:39:49 INFO - Installing pip.................done. 03:39:49 INFO - Return code: 0 03:39:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:39:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:39:49 INFO - Reading from file tmpfile_stdout 03:39:49 INFO - Output received: 03:39:49 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) 03:39:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:39:49 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')]} 03:39:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:49 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')]} 03:39:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:49 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 0x10f46fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f472768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a2dcfe50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, '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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:39:49 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 03:39:49 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 03:39:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:39:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:49 INFO - 'HOME': '/Users/cltbld', 03:39:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:49 INFO - 'LOGNAME': 'cltbld', 03:39:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:49 INFO - 'MOZ_NO_REMOTE': '1', 03:39:49 INFO - 'NO_EM_RESTART': '1', 03:39:49 INFO - 'PAGER': '/bin/cat', 03:39:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:49 INFO - 'PWD': '/builds/slave/test', 03:39:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:49 INFO - 'SHELL': '/bin/bash', 03:39:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:39:49 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:39:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:49 INFO - 'USER': 'cltbld', 03:39:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:49 INFO - 'XPC_FLAGS': '0x0', 03:39:49 INFO - 'XPC_SERVICE_NAME': '0', 03:39:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:50 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 03:39:50 INFO - Cleaning up... 03:39:50 INFO - Return code: 0 03:39:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:50 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 0x10f46fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f472768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a2dcfe50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, '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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:39:50 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 03:39:50 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 03:39:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:39:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:50 INFO - 'HOME': '/Users/cltbld', 03:39:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:50 INFO - 'LOGNAME': 'cltbld', 03:39:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:50 INFO - 'MOZ_NO_REMOTE': '1', 03:39:50 INFO - 'NO_EM_RESTART': '1', 03:39:50 INFO - 'PAGER': '/bin/cat', 03:39:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:50 INFO - 'PWD': '/builds/slave/test', 03:39:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:50 INFO - 'SHELL': '/bin/bash', 03:39:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:39:50 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:39:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:50 INFO - 'USER': 'cltbld', 03:39:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:50 INFO - 'XPC_FLAGS': '0x0', 03:39:50 INFO - 'XPC_SERVICE_NAME': '0', 03:39:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:50 INFO - Downloading/unpacking psutil>=3.1.1 03:39:50 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 03:39:50 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 03:39:50 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 03:39:50 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 03:39:50 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 03:39:50 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 03:39:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:39:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:54 INFO - Installing collected packages: psutil 03:39:54 INFO - Running setup.py install for psutil 03:39:54 INFO - building 'psutil._psutil_osx' extension 03:39:54 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 03:39:54 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 03:39:54 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 03:39:54 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 03:39:54 INFO - building 'psutil._psutil_posix' extension 03:39:54 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 03:39:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:39:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:39:55 INFO - ^ 03:39:55 INFO - 1 warning generated. 03:39:55 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 03:39:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:55 INFO - Successfully installed psutil 03:39:55 INFO - Cleaning up... 03:39:55 INFO - Return code: 0 03:39:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f46fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f472768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a2dcfe50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, '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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:39:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:39:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:39:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:39:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:55 INFO - 'HOME': '/Users/cltbld', 03:39:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:55 INFO - 'LOGNAME': 'cltbld', 03:39:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:55 INFO - 'MOZ_NO_REMOTE': '1', 03:39:55 INFO - 'NO_EM_RESTART': '1', 03:39:55 INFO - 'PAGER': '/bin/cat', 03:39:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:55 INFO - 'PWD': '/builds/slave/test', 03:39:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:55 INFO - 'SHELL': '/bin/bash', 03:39:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:39:55 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:39:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:55 INFO - 'USER': 'cltbld', 03:39:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:55 INFO - 'XPC_FLAGS': '0x0', 03:39:55 INFO - 'XPC_SERVICE_NAME': '0', 03:39:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:39:55 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 03:39:55 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 03:39:55 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 03:39:55 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 03:39:55 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 03:39:55 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 03:39:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:39:58 INFO - Installing collected packages: mozsystemmonitor 03:39:58 INFO - Running setup.py install for mozsystemmonitor 03:39:58 INFO - Successfully installed mozsystemmonitor 03:39:58 INFO - Cleaning up... 03:39:58 INFO - Return code: 0 03:39:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:39:58 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')]} 03:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:58 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')]} 03:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:58 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 0x10f46fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f472768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a2dcfe50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, '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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:39:58 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 03:39:58 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 03:39:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:39:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:58 INFO - 'HOME': '/Users/cltbld', 03:39:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:58 INFO - 'LOGNAME': 'cltbld', 03:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:58 INFO - 'MOZ_NO_REMOTE': '1', 03:39:58 INFO - 'NO_EM_RESTART': '1', 03:39:58 INFO - 'PAGER': '/bin/cat', 03:39:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:58 INFO - 'PWD': '/builds/slave/test', 03:39:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:58 INFO - 'SHELL': '/bin/bash', 03:39:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:39:58 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:39:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:58 INFO - 'USER': 'cltbld', 03:39:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:58 INFO - 'XPC_FLAGS': '0x0', 03:39:58 INFO - 'XPC_SERVICE_NAME': '0', 03:39:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:58 INFO - Downloading/unpacking jsonschema==2.5.1 03:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:40:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:40:01 INFO - warning: no files found matching '*.txt' 03:40:01 INFO - no previously-included directories found matching 'build' 03:40:01 INFO - no previously-included directories found matching 'dist' 03:40:01 INFO - no previously-included directories found matching '.git*' 03:40:01 INFO - Installing collected packages: jsonschema, functools32 03:40:01 INFO - Running setup.py install for functools32 03:40:02 INFO - warning: no files found matching '*.txt' 03:40:02 INFO - no previously-included directories found matching 'build' 03:40:02 INFO - no previously-included directories found matching 'dist' 03:40:02 INFO - no previously-included directories found matching '.git*' 03:40:02 INFO - Successfully installed jsonschema functools32 03:40:02 INFO - Cleaning up... 03:40:02 INFO - Return code: 0 03:40:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f46fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f472768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a2dcfe50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, '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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:40:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:40:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:02 INFO - 'HOME': '/Users/cltbld', 03:40:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:02 INFO - 'LOGNAME': 'cltbld', 03:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:02 INFO - 'MOZ_NO_REMOTE': '1', 03:40:02 INFO - 'NO_EM_RESTART': '1', 03:40:02 INFO - 'PAGER': '/bin/cat', 03:40:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:02 INFO - 'PWD': '/builds/slave/test', 03:40:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:02 INFO - 'SHELL': '/bin/bash', 03:40:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:40:02 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:40:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:02 INFO - 'USER': 'cltbld', 03:40:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:02 INFO - 'XPC_FLAGS': '0x0', 03:40:02 INFO - 'XPC_SERVICE_NAME': '0', 03:40:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:40:02 INFO - Cleaning up... 03:40:02 INFO - Return code: 0 03:40:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f46fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f472768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a2dcfe50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, '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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:40:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:40:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:02 INFO - 'HOME': '/Users/cltbld', 03:40:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:02 INFO - 'LOGNAME': 'cltbld', 03:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:02 INFO - 'MOZ_NO_REMOTE': '1', 03:40:02 INFO - 'NO_EM_RESTART': '1', 03:40:02 INFO - 'PAGER': '/bin/cat', 03:40:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:02 INFO - 'PWD': '/builds/slave/test', 03:40:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:02 INFO - 'SHELL': '/bin/bash', 03:40:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:40:02 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:40:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:02 INFO - 'USER': 'cltbld', 03:40:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:02 INFO - 'XPC_FLAGS': '0x0', 03:40:02 INFO - 'XPC_SERVICE_NAME': '0', 03:40:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:02 INFO - Downloading/unpacking blobuploader==1.2.4 03:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:05 INFO - Downloading blobuploader-1.2.4.tar.gz 03:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:40:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:40:05 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 03:40:05 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 03:40:05 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 03:40:05 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 03:40:05 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 03:40:05 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 03:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:40:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40: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 03:40:06 INFO - Downloading docopt-0.6.1.tar.gz 03:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:40:06 INFO - Installing collected packages: blobuploader, requests, docopt 03:40:06 INFO - Running setup.py install for blobuploader 03:40:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:40:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:40:06 INFO - Running setup.py install for requests 03:40:07 INFO - Running setup.py install for docopt 03:40:07 INFO - Successfully installed blobuploader requests docopt 03:40:07 INFO - Cleaning up... 03:40:07 INFO - Return code: 0 03:40:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:07 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 0x10f46fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f472768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a2dcfe50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, '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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:40:07 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 03:40:07 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 03:40:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:40:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:07 INFO - 'HOME': '/Users/cltbld', 03:40:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:07 INFO - 'LOGNAME': 'cltbld', 03:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:07 INFO - 'MOZ_NO_REMOTE': '1', 03:40:07 INFO - 'NO_EM_RESTART': '1', 03:40:07 INFO - 'PAGER': '/bin/cat', 03:40:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:07 INFO - 'PWD': '/builds/slave/test', 03:40:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:07 INFO - 'SHELL': '/bin/bash', 03:40:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:40:07 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:40:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:07 INFO - 'USER': 'cltbld', 03:40:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:07 INFO - 'XPC_FLAGS': '0x0', 03:40:07 INFO - 'XPC_SERVICE_NAME': '0', 03:40:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-KLwsdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-4j2GD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:07 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-ztInCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:08 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-iZsGBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:08 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-z5uTBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:08 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-xQmCXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:08 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-urCt9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:08 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-A_xSZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:08 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-AURUon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:08 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-5oRkE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:08 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-YlVTUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:08 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-3N6QR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:08 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-5qDIWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:09 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-1NB0xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:09 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-NRBq4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:09 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-kR514U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:09 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-8q699B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:40:09 INFO - Running setup.py install for manifestparser 03:40:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:40:09 INFO - Running setup.py install for mozcrash 03:40:09 INFO - Running setup.py install for mozdebug 03:40:09 INFO - Running setup.py install for mozdevice 03:40:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Running setup.py install for mozfile 03:40:10 INFO - Running setup.py install for mozhttpd 03:40:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Running setup.py install for mozinfo 03:40:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Running setup.py install for mozInstall 03:40:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:40:10 INFO - Running setup.py install for mozleak 03:40:10 INFO - Running setup.py install for mozlog 03:40:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:40:11 INFO - Running setup.py install for moznetwork 03:40:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:40:11 INFO - Running setup.py install for mozprocess 03:40:11 INFO - Running setup.py install for mozprofile 03:40:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:40:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:40:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:40:11 INFO - Running setup.py install for mozrunner 03:40:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:40:11 INFO - Running setup.py install for mozscreenshot 03:40:11 INFO - Running setup.py install for moztest 03:40:11 INFO - Running setup.py install for mozversion 03:40:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:40:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:40:12 INFO - Cleaning up... 03:40:12 INFO - Return code: 0 03:40:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:12 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 0x10f46fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f472768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a2dcfe50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, '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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:40:12 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 03:40:12 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 03:40:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:40:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:12 INFO - 'HOME': '/Users/cltbld', 03:40:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:12 INFO - 'LOGNAME': 'cltbld', 03:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:12 INFO - 'MOZ_NO_REMOTE': '1', 03:40:12 INFO - 'NO_EM_RESTART': '1', 03:40:12 INFO - 'PAGER': '/bin/cat', 03:40:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:12 INFO - 'PWD': '/builds/slave/test', 03:40:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:12 INFO - 'SHELL': '/bin/bash', 03:40:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:40:12 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:40:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:12 INFO - 'USER': 'cltbld', 03:40:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:12 INFO - 'XPC_FLAGS': '0x0', 03:40:12 INFO - 'XPC_SERVICE_NAME': '0', 03:40:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:40:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-kFTCkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:40:12 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)) 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:40:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-koGGat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:40:12 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)) 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:40:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-qxYKND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:40:12 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)) 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:40:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-j9NveW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:40:12 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)) 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:40:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-hxZ5fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:40:12 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)) 03:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:40:12 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-rS9EI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:40:13 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)) 03:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:40:13 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-bpRxUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:40:13 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)) 03:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:40:13 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-H5ccyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:40:13 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)) 03:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:40:13 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-IJKRCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:40:13 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)) 03:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:40:13 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-DxB_Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:40:13 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)) 03:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:40:13 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-flxek2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:40:13 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)) 03:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:40:13 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-mg9yoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:40:13 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)) 03:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:40:13 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-KFNQN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:40:13 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)) 03:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:40:13 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-dVMCMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:40:13 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)) 03:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:13 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-xoEMfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:40:14 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-pS7ERu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:40:14 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)) 03:40:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:40:14 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-lbRpPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:40:14 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)) 03:40:14 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)) 03:40:14 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)) 03:40:14 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)) 03:40:14 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)) 03:40:14 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)) 03:40:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:40:16 INFO - Downloading blessings-1.6.tar.gz 03:40:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:40:16 INFO - Installing collected packages: blessings 03:40:16 INFO - Running setup.py install for blessings 03:40:17 INFO - Successfully installed blessings 03:40:17 INFO - Cleaning up... 03:40:17 INFO - Return code: 0 03:40:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:40:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:17 INFO - Reading from file tmpfile_stdout 03:40:17 INFO - Current package versions: 03:40:17 INFO - blessings == 1.6 03:40:17 INFO - blobuploader == 1.2.4 03:40:17 INFO - docopt == 0.6.1 03:40:17 INFO - functools32 == 3.2.3-2 03:40:17 INFO - jsonschema == 2.5.1 03:40:17 INFO - manifestparser == 1.1 03:40:17 INFO - mozInstall == 1.12 03:40:17 INFO - mozcrash == 1.0 03:40:17 INFO - mozdebug == 0.1 03:40:17 INFO - mozdevice == 0.49 03:40:17 INFO - mozfile == 1.2 03:40:17 INFO - mozhttpd == 0.7 03:40:17 INFO - mozinfo == 0.9 03:40:17 INFO - mozleak == 0.1 03:40:17 INFO - mozlog == 3.4 03:40:17 INFO - moznetwork == 0.27 03:40:17 INFO - mozprocess == 0.24 03:40:17 INFO - mozprofile == 0.28 03:40:17 INFO - mozrunner == 6.13 03:40:17 INFO - mozscreenshot == 0.1 03:40:17 INFO - mozsystemmonitor == 0.3 03:40:17 INFO - moztest == 0.8 03:40:17 INFO - mozversion == 1.4 03:40:17 INFO - psutil == 3.1.1 03:40:17 INFO - requests == 1.2.3 03:40:17 INFO - wsgiref == 0.1.2 03:40:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:18 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 0x10f46fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f472768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a2dcfe50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, '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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:40:18 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 03:40:18 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 03:40:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:40:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:18 INFO - 'HOME': '/Users/cltbld', 03:40:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:18 INFO - 'LOGNAME': 'cltbld', 03:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:18 INFO - 'MOZ_NO_REMOTE': '1', 03:40:18 INFO - 'NO_EM_RESTART': '1', 03:40:18 INFO - 'PAGER': '/bin/cat', 03:40:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:18 INFO - 'PWD': '/builds/slave/test', 03:40:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:18 INFO - 'SHELL': '/bin/bash', 03:40:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:40:18 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:40:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:18 INFO - 'USER': 'cltbld', 03:40:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:18 INFO - 'XPC_FLAGS': '0x0', 03:40:18 INFO - 'XPC_SERVICE_NAME': '0', 03:40:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 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)) 03:40:18 INFO - Cleaning up... 03:40:18 INFO - Return code: 0 03:40:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:40: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')]} 03:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40: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')]} 03:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:40:18 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 0x10f46fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f472768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2a2dcfe50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, '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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 03:40:18 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 03:40:18 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 03:40:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:40:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:18 INFO - 'HOME': '/Users/cltbld', 03:40:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:18 INFO - 'LOGNAME': 'cltbld', 03:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:18 INFO - 'MOZ_NO_REMOTE': '1', 03:40:18 INFO - 'NO_EM_RESTART': '1', 03:40:18 INFO - 'PAGER': '/bin/cat', 03:40:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:18 INFO - 'PWD': '/builds/slave/test', 03:40:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:18 INFO - 'SHELL': '/bin/bash', 03:40:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:40:18 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:40:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:18 INFO - 'USER': 'cltbld', 03:40:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:18 INFO - 'XPC_FLAGS': '0x0', 03:40:18 INFO - 'XPC_SERVICE_NAME': '0', 03:40:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:40:19 INFO - Cleaning up... 03:40:19 INFO - Return code: 0 03:40:19 INFO - Running post-action listener: _resource_record_post_action 03:40:19 INFO - Running post-action listener: _start_resource_monitoring 03:40:19 INFO - Starting resource monitoring. 03:40:19 INFO - [mozharness: 2017-02-14 11:40:19.098600Z] Finished create-virtualenv step (success) 03:40:19 INFO - [mozharness: 2017-02-14 11:40:19.099554Z] Running install step. 03:40:19 INFO - Running pre-action listener: _resource_record_pre_action 03:40:19 INFO - Running main action method: install 03:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:40:19 INFO - Reading from file tmpfile_stdout 03:40:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:40:19 INFO - Reading from file tmpfile_stdout 03:40:19 INFO - Output received: 03:40:19 INFO - Usage: mozinstall [options] installer 03:40:19 INFO - Options: 03:40:19 INFO - -h, --help show this help message and exit 03:40:19 INFO - -d DEST, --destination=DEST 03:40:19 INFO - Directory to install application into. [default: 03:40:19 INFO - "/builds/slave/test"] 03:40:19 INFO - --app=APP Application being installed. [default: firefox] 03:40:19 INFO - mkdir: /builds/slave/test/build/application 03:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:40:39 INFO - Reading from file tmpfile_stdout 03:40:39 INFO - Output received: 03:40:39 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:40:39 INFO - Running post-action listener: _resource_record_post_action 03:40:39 INFO - [mozharness: 2017-02-14 11:40:39.386196Z] Finished install step (success) 03:40:39 INFO - [mozharness: 2017-02-14 11:40:39.386347Z] Running run-tests step. 03:40:39 INFO - Running pre-action listener: _resource_record_pre_action 03:40:39 INFO - Running main action method: run_tests 03:40:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:40:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:40:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:40:39 INFO - 2017-02-14 03:40:39.401 screenresolution[1622:7415] starting screenresolution argv=screenresolution get 03:40:39 INFO - 2017-02-14 03:40:39.403 screenresolution[1622:7415] Display 0: 1600x1200x32@60 03:40:39 INFO - 2017-02-14 03:40:39.409 screenresolution[1623:7418] starting screenresolution argv=screenresolution list 03:40:39 INFO - Available Modes on Display 0 03:40:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:40:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:40:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:40:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:40:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:40:39 INFO - Intel Iris: 03:40:39 INFO - Chipset Model: Intel Iris 03:40:39 INFO - Type: GPU 03:40:39 INFO - Bus: Built-In 03:40:39 INFO - VRAM (Dynamic, Max): 1536 MB 03:40:39 INFO - Vendor: Intel (0x8086) 03:40:39 INFO - Device ID: 0x0a2e 03:40:39 INFO - Revision ID: 0x0009 03:40:39 INFO - Displays: 03:40:39 INFO - Display: 03:40:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:40:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:40:39 INFO - Display Serial Number: 1600x1200 60 03:40:39 INFO - Main Display: Yes 03:40:39 INFO - Mirror: Off 03:40:39 INFO - Online: Yes 03:40:39 INFO - Rotation: Supported 03:40:39 INFO - Return code: 0 03:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:40:39 INFO - Python 2.7.3 03:40:39 INFO - Return code: 0 03:40:39 INFO - grabbing minidump binary from tooltool 03:40:39 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')]} 03:40:39 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 0x10f24dd30>, '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 0x10f174db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f242be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:40:39 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 03:40:39 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 03:40:39 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 03:40:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:40:39 INFO - Return code: 0 03:40:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:40:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:40:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:40:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:40:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:40:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 03:40:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0050 --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 03:40:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ne6eWgKMS2/Render', 03:40:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:40:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:40:39 INFO - 'HOME': '/Users/cltbld', 03:40:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:40:39 INFO - 'LOGNAME': 'cltbld', 03:40:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:40:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:40:39 INFO - 'MOZ_NO_REMOTE': '1', 03:40:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:40:39 INFO - 'NO_EM_RESTART': '1', 03:40:39 INFO - 'PAGER': '/bin/cat', 03:40:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:40:39 INFO - 'PWD': '/builds/slave/test', 03:40:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:40:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:40:39 INFO - 'SHELL': '/bin/bash', 03:40:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fk2MqD2aIS/Listeners', 03:40:39 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 03:40:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:40:39 INFO - 'USER': 'cltbld', 03:40:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:40:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:40:39 INFO - 'XPC_FLAGS': '0x0', 03:40:39 INFO - 'XPC_SERVICE_NAME': '0', 03:40:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:40:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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 03:40:39 INFO - mozversion application_buildid: 20170214014944 03:40:39 INFO - mozversion application_changeset: 2476b831a480c8ab160281f8fb11e9cdc298ad26 03:40:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:40:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:40:39 INFO - mozversion application_name: Firefox 03:40:39 INFO - mozversion application_remotingname: firefox-dev 03:40:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:39 INFO - mozversion application_vendor: Mozilla 03:40:39 INFO - mozversion application_version: 53.0a2 03:40:39 INFO - mozversion platform_buildid: 20170214014944 03:40:39 INFO - mozversion platform_changeset: 2476b831a480c8ab160281f8fb11e9cdc298ad26 03:40:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:40:39 INFO - mozversion platform_version: 53.0a2 03:40:39 INFO - using testdate: 1487072439 03:40:39 INFO - actual date: 1487072439 03:40:39 INFO - starting webserver on 'localhost:49240' 03:40:39 INFO - SUITE-START | Running 2 tests 03:40:39 INFO - TEST-START | dromaeo_css 03:40:39 INFO - operating with platform_type : mac_ 03:40:39 INFO - Initialising browser for dromaeo_css test... 03:40:40 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmpYitT3j/profile http://localhost:49240/getInfo.html) 03:40:42 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 03:40:42 INFO - PROCESS | 1633 | colorDepth:24 03:40:42 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 03:40:42 INFO - PROCESS | 1633 | __metrics 03:40:42 INFO - PROCESS | 1633 | 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" 03:40:42 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:40:43 INFO - TEST-INFO | 1633: exit 0 03:40:43 INFO - Browser initialized. 03:40:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:40:43 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmpYitT3j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:55 INFO - PROCESS | 1634 | RSS: Main: 232271872 03:40:55 INFO - PROCESS | 1634 | 03:43:59 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 03:44:01 INFO - PROCESS | 1634 | RSS: Main: 335413248 03:44:01 INFO - PROCESS | 1634 | 03:45:45 INFO - PROCESS | 1634 | ************************* 03:45:45 INFO - PROCESS | 1634 | A coding exception was thrown and uncaught in a Task. 03:45:45 INFO - PROCESS | 1634 | 03:45:45 ERROR - PROCESS | 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:45:45 INFO - PROCESS | 1634 | Full stack: 03:45:45 INFO - PROCESS | 1634 | ************************* 03:47:03 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 03:47:04 INFO - PROCESS | 1634 | RSS: Main: 361512960 03:47:04 INFO - PROCESS | 1634 | 03:50:06 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 03:50:07 INFO - PROCESS | 1634 | RSS: Main: 322572288 03:50:07 INFO - PROCESS | 1634 | 03:53:10 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 03:53:10 INFO - PROCESS | 1634 | RSS: Main: 332627968 03:53:10 INFO - PROCESS | 1634 | 03:56:14 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 03:56:14 INFO - PROCESS | 1634 | RSS: Main: 329158656 03:56:14 INFO - PROCESS | 1634 | 03:59:18 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 03:59:18 INFO - PROCESS | 1634 | RSS: Main: 440246272 03:59:18 INFO - PROCESS | 1634 | 03:59:18 INFO - PROCESS | 1634 | __start_tp_report 03:59:18 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 03:59:18 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 03:59:18 INFO - PROCESS | 1634 | |i|pagename|runs| 03:59:18 INFO - PROCESS | 1634 | |0;dojo.html;3268.2646404558977;3270.672932706729;3289.736821054316;3319.933601327975;3349.933001339973;5604.495595396414;5620.353659329178;5637.267155269819;5644.435556444353;5684.2326285951385;5600.4959553640165;5670.858228544278;5700.7719691212305;5705.714714264281;5720.0561907285355;5138.768755406007;5190.92213616796;5207.791688332462;5209.86975325618;5269.657472264291;5096.3884333879805;5096.872578185538;5257.447967963366;5281.206111946484;5324.307839980797;5127.230915362707;5169.147090730025;5187.0922588546855;5198.45416231296;5205.27126202332;5229.633925625208;5233.424323324451;5235.685858848481;5238.52853243208;5250.68495890244;4547.977260113711;5045.293658887758;5182.896342073175;5232.555232805216;5236.659617124875;5489.862753431156;5525.889482210333;5542.196381524696;5642.463965923231;5671.404502527258;6120.418560236771;6130.080487926802;6132;6133.754649814002;6135.355787642323;6185.628862268233;6214.036824292242;6242;6245.0320200369015;6255.343188965184;5714.371419143891;5766.106253530709;5772.624779389326;5786.537077033827;5811.4479124483105;6129.970128114947;6237.656928868956;6240.469560087444;6243.625382477066;6264.624122552661;5893.469587737124;6041.818745437644;6125.081237814364;6128.080787881853;6137.144455097482;6136.815895523141;6175.073738939105;6187.690615469209;6197.5351848610635;6202.596831205957;5962.791302304486;6144.5084393248435;6147.231596050494;6163.876722465526;6166.475849552839;6032.939670603326;6113.816585502442;6122.755089796358;6128.972736294558;6136.702895113906;4965.776540055706;4971.229459433794;4972.453030166679;4987.501249874984;5008.599312055099;4406.162829062468;4408.515063343029;4412.3160910059;4421.38100665907;4439.66702497314;5480.123180291134;5485.341758988947;5536.944630553643;5709.000924838137;5716.885662286731;5091;5472.863178420572;5620.85947851307;6123.908141377883;6132.569672417391;5498.532624726863;5564.081926482166;5641.012822756002;5647.322321321386;5664.20701101846;5313.495217954288;5338.839834804962;5360.490753378423;5363.061464243741;5374.301340825746;6187.783427580013;6301.6534090625455;6304.085907543472;6304.495640348761;6306.180196574416;5969.403059693996;6023.819285421444;6025.78909738157;6136.693165341804;6140.048292514667;6216.906746398718;6230.906536401867;6231.906521402092;6254.312025677263;6262.968685156545;6125.387461254018;6149.877002459836;6154.446099851035;6158.353372895782;6160.199174107337;5946.07835785454;6040.214772079602;6244.094606282155;6249.687515624291;6254.124422580751;5974.6713930732485;6006.189164462741;6027.969860150672;6064.787732429344;6122.602030867979;5958.463738263577;6039;6044.848878778066;6050.546209034252;6066.545009124245;5673.971630141823;5874.618149820248;5880.117982302689;5897.410258974069;5898.233229680114;5609.242752228397;5830.096335068071;5939.643621382731;5950.613210141327;5953.642781433128;5840.123981402823;5848.736806843787;5849.356570777296;5850.210221620197;5865.824025279248 03:59:18 INFO - PROCESS | 1634 | |1;ext.html;439.2203838187218;478.89224924391993;503.36073187052443;505.77745791851606;542.1163503489311;25732.74267257327;32826.17934551634;35235.82382088086;39961.400578991335;42558.57441425585;43747.56252437475;44116.3382549262;44137;44187.337189942176;44417.77791111048;9218.170364667196;9441.433513989183;9445.244380449547;9446.102620251066;9467.431954082742;8429.157084291583;8604.010538788025;9304.11610896967;11104.500297486593;11390.316581005125;11431.256968297075;11437.542498300058;11442.256253343507;11470.311781293107;11472.598459053936;11216.775664486746;11296.887031129665;11398.772024559463;11404.885951140548;11410.42947852604;8302.750917472486;8517.23344898962;10943.398113103776;11200.103991680646;11235.382053987027;40658.186836263405;40729;41677.1664566707;42062.158756824996;42124.368134478005;3926.960730392688;3998.3402738548107;4000.119973605831;4023.7384570002855;4097.358426534492;29375.853120734475;29436;29490.557641635394;29828.70171298281;30517.542236866466;3040.5895204147378;3270.035339574831;3298.538204651351;3298.950515742266;3300.6864347886913;482642;483913.2239049251;484710;485717.5714121442;486866;63963.36036639667;64283.35716642774;64300;64446;64484;67321;67459.66270168716;67549.64900701959;67559.64880702457;67617.66191169112;16773.832261677228;16950.660986780196;17031.14844257782;17061.232244549024;17068.48794536166;11681.123915706356;12971.740565188833;13081.542146024844;13098.738025239441;13104.017198710135;14876.925615371854;15313.846861531465;19003.29968944083;21550.676739848914;22192;7262.782116536512;8680.696175633822;8687.435316704394;8705.782355441164;8711.433756805787;847.6268445118947;848.3298194426334;849.7790574450687;870.3907264914585;875.4528419737663;25880.48239035209;30504.84747576248;30558.97537728365;30562.388752225277;30920;1062.4315990944808;1075.9139268858473;1088.1131877519797;1102.3551222534907;1173.559915031863;14897.255137243312;15540;15552.455664051704;15604.164695689202;15645;650878;653998;654391;655373;655966;62562.68718656377;63431;63503;63659.04511432332;63667.68166159232;1411.5483045425572;1429.4925301517812;1448.4785477227979;1450.1951416963475;1455.4251070827177;28771.424571508873;29614.851925740233;29812.552811708276;30462.23844403819;30577.54133688041;52375.47624523706;52663.21005184849;54040.18939715829;54076.648083798216;57147.42852571588;586771;593131;593244;594506;594860;32560;40483.79758101191;40912;41010.794946026275;41087.794561027;41040.384394233515;41968.79015604902;43301.35047974346;43617.90955226018;43833;35262.294754105285;35959.82020089883;36134.819325903205;36149.91550253497;36241;29493;30126.397472050874;36078.45882311715;36086.09784755402;37103.81448092742;34970.601175952674;35032.82483587566;35347.64652353546;35543.289134216655;35800.82099589486;30009.699903000692;32178.678213218504;32287;32334.83832580822;32359.676403236608;23462.882685586465;23508.52982940366;23944.281671549186;24009.759902400754;24082 03:59:18 INFO - PROCESS | 1634 | |2;jquery.html;358.1887025886368;360.8971443138705;363.61093629816077;388.80365415465167;400.1816285695752;12183.878161218385;15125.243737813107;16042.197890105477;20626.38120856373;21210.787892121076;18055.81944180558;20948.952552372397;21391.251306204285;22353.664695029587;22511.54976900461;4698.459677137139;5641.6897070661;5880.8235752927485;5882.3529411764675;5895.380984996578;5746.051901436258;5829.650220986733;5875.059990401536;5879.823605291826;5900.262467191601;5598.832035038955;5700.686462244575;5855.414458554132;5861.7948371807;5868.295804503444;5751;5815.505682017034;5821.621594596338;5825.155352473867;5829.9708501457435;4848.272759086165;5020.548150666421;5060.721660308682;5124.795008199668;5149.227615857614;25054.997800088157;25334.746652533424;25923;26456.86771566149;26783.732162678512;2440.694913135858;2464.827462077655;2473.319837044827;2481.8262721609494;2491.987540062288;9801.117899389017;9823.656172034016;9918.206543476577;9985.635742235829;10158.390496570155;1669.9248533816008;1722.9138543072922;1726.0765490462668;1752.956176095595;1753.3863147898262;121133;135983.32008339994;136332;138439;140216.09120100853;11716.824247636292;11727.179097463266;11810.114241431927;11897.524099036114;11960.820587691192;15819.288132034086;15890;15894;15911.602209944613;15920.920395397949;7371.520851144658;8495.405321627426;8794.692185773467;8802.119788021148;8899.555022248862;8561.015483219386;8574.213380651314;8576.914230857612;8706.869396959051;8735.51954642488;4680.882977925579;4812.470628230892;4816.20532612115;4826.276058591169;4885.95114048855;1778.5020194345605;1958.5005823515198;1961.6469035573734;2020.5857799151138;2023.5143565544458;390.3792969179019;401.3197630017151;405.4911086586315;419.45261433828534;946.5409276500892;11434.885651143382;11536;11656.70858228534;11731;11740.354280514483;437.6936144698724;439.9098184872158;442.3961292835321;447.64188649080603;448.3946671992784;5559.972200138974;5831.562632802556;5870.501007414332;6037.758489660452;6045.274567051982;707487.3844616538;714460;739905;749903;756468;91813;124919;129599;155885;167466;442.3961292835257;459.8160735705745;460.5233583241396;460.5831722291332;460.9723416595015;11417.942910285396;11479.713007174887;11666.841634297682;11751.00116490108;11855;58424;59642.70178649079;60680;60722;61191.38808611857;62049.689751550955;84547.5772621133;86866.56566717126;88744.55627722078;96853;7924.366050715814;8129.715459958873;8430;8530.488170709777;8662.870056949278;9145.496997665192;13255.270960097287;13335.599932002055;13550.86449135496;13831.585052448443;11182;11249.38128402913;11718.062554995751;11748.941255293668;11948.223365481215;11327.716807079889;11371.31772093677;11508.136889733136;11694.239874408137;11835.993940515153;11692.590759323382;11919.642410727693;11965.940170299093;12082.275063496218;12102.152849300464;7362.7423040193335;8417.116202798617;8499.957500212708;8642.135786421308;8659.004214515411;10808.513616887101;11257.71855703614;11337.489812958273;11410;11847.822282665595 03:59:18 INFO - PROCESS | 1634 | |3;mootools.html;1423.3025817349496;1431.8926080543959;1448.6740483391245;1456.1263242054763;1458.5478501664481;7971.282584567388;8262.876056859152;8407.20131587499;8412.116727743583;8427;7375.88936165958;7629.122650895149;7634.389248860091;7882.566458844762;8029;2249.910003599858;2284.2690339091496;2285.942851428711;2290.3815969688176;2296.9540609187807;2260.152442833937;2292.277932451281;2296.701428814252;2306.2850516339904;2308.0306271366067;1984.0873198328786;2070.1926248762993;2206.735191776989;2255.650374192003;2290.576243394969;2041.5406533529838;2270.080617349976;2280.7719228077226;2281.646344816556;2285.1544928376525;2145.249162793026;2194;2299.678045073691;2306.031466783955;2308.203669733939;7129.287071292881;8142.145074767123;8246.876296855551;8252.876206856901;8263.173682631748;5042.596592272609;5201.219817027439;5201.609879259033;5202.505761952646;5205.583553315763;2891.8843246270335;3262.939544647999;3429.5884493860895;3498.912527186815;3504.123969007748;1127.3743072594707;1173.278433763238;1215.544170935899;1219.920705154162;1222.5171057432353;8891.510966896818;10415.947920260425;10722.624708135256;10804.13566914645;10895.346279223351;4330.956690433055;4382.715123516961;4537.478190008125;4553.681242313072;4554.7039442436135;8431.95784021076;8554;8565.700200492953;8580.069484365968;8596.441231319945;5080;5125.410577783528;5125.820596279113;5132.178851383761;5144.279800827887;4255.276602977501;4269.295566231599;4439.200943830077;4715.316279139505;4822.890735130869;3849.3840985442193;3866.38137897935;3973.2252210818615;3978.960210397859;3993.960060399359;1267.15100882409;1285.6014635463036;1289.6324547503916;1292.4507084489055;1296.027979015738;875.8029443375317;883.2227639677171;883.7967267528376;891.7146513115871;897.8967418746797;5429.864253393618;5536.695481748542;5640.464155905182;5641.668906609377;5756.942430575725;957.6887511558771;979.2508730820928;981.5779214937645;988.8318985772436;1020.5815615597569;3540.91147721309;3584.5160903277724;3678.779273243614;3760.304343696425;3785.8674946377296;9599.184069354184;9796.216302695768;9895.653652122284;9911.256655750847;9913.405195688138;9249.676261330822;9686.903130968742;9770.75573110678;9792.412455252565;9801.264905132144;7616;7785.221477852169;7850.254225848649;7852.254035866584;7932.603369831485;5174.948250517597;5379.569634429315;5419.295491586068;5468.5351745100525;5743.224664670383;8539.103394143525;9298.349115561845;9300.906990930274;9328.486933218737;9330.206932410822;8020.839583208186;9228.769280767767;9282.35023548345;9385.718428447157;9411.576479058596;6507.349265073455;6720.059191713066;6885.4835887309655;7047.612381319077;7186.7125314986815;7682.078150621737;7853.842923141619;7854.1360450349275;7861.2531809478005;7867.84264314722;6909.550879192836;7020.473464490082;7053.541519801196;7059.364657180879;7169.7849064528145;6894.448444124358;6901.413379862567;6914.896276555755;6921.550099243533;6961.930380696128;6202.193714817045;6338.587991780704;6435.774747883802;6435.839104022437;6477.704459108103;4857.149998750134;4868.9756551217015;4924.532169443897;4947.282644016525;4981.676191047571;4448.844290449819;4733.952660473351;4915.410150781929;4988.750562471934;5081.644284900021 03:59:18 INFO - PROCESS | 1634 | |4;prototype.html;349.7342020064751;355.3124703698344;358.27985748645216;367.560764885961;371.1500663480628;4353.477582690074;5243.580513558915;5265.9473405265935;5306.867328316794;5339.385970613381;3947.82234799434;4354.216241076605;4598.655100867431;4973.303737476756;5166.328377310953;3334.832808517012;3804.695624350059;4002.8799136025964;4031.596840315967;4075.205334959684;4030.1335212929216;4065.2113070249143;4065.79671016448;4099.180163967204;4119.40268661044;3233.369492948876;3752.6059763724825;3820.36963900956;4057;4093.9181216375655;3469.826508674556;3702.3705969985167;3714.2571485702697;4007.7394969327047;4031.737937034083;3182;3565.180008598011;3587.703869523507;3610.223801882608;3619.1314084619767;3911.413288006793;5046.142155833517;5049.4950504949575;5056.497033968172;5085.389753229636;4492.865214043584;4517.232423320271;4518.841840535565;4572.88567785808;4643.953560464386;4279.582036149565;5178.844634660966;5366.2436294593945;5380.300560927094;5414.91877621836;3567.375709250871;3980.3083689431874;3980.5223373195404;3983.601639836022;3996.86010989614;4289;5255.76349064293;5465.812664397885;5503.889922201533;5594.804181853657;3296.3077753671996;3547.94678079829;3690.723195760275;4024.0945787197647;4044.15072834708;3673.265346930571;3758;4089.89775255621;4099.8975025624595;4117.300058989979;3937.783421911765;4378.408914796461;4411.867643970686;4659.743714095757;4668.626509879202;5217.991073436754;5421.593380496479;5448.809291674773;5464.196815051024;5470.425605311465;1248.3383806582526;1320.2870449956915;1334.658668038615;1340.2829486224823;1355.752707509094;760.5094713909498;879.3844308983737;908.336914052732;924.8855129568853;955.7562821480478;4886.193778026657;5041.6722913010535;5056.317397151411;5072.949270507322;5073.873153171126;5511.283533140666;5540.030494663418;5576.079946808813;5576.247206627054;5653.660780353192;4340.934885976713;4481.327800829901;4852.369192005087;5013.323201367842;5108.386993560796;2436.4639779248537;2480.5535003699506;2514.4719608882338;2565.6279839423178;2772.334639686461;4811.542903424169;4917.631177661689;4934.5805606523845;5504.889902201933;5559.080848002149;4512.616427603625;5099.87250318745;5189.299444575009;5476.534494567926;5487.670739755627;4868.853934381974;5328.866778330495;5451.073317535949;5513.5037846594;5546.889062218814;4484.9103017940115;4721.568392278048;5262.578993680573;5270.55059858542;5276.604254680838;4460.1202718084905;4854.90290194187;5029.547340739351;5112.977404519037;5201.76592053366;4832.565069143794;4932.7286999215385;5400.487863398254;5486.162135684591;5514.834554963358;3325.5177999190464;3328.833558322123;3391.8134502601606;3404.4212483877304;3901.921961560696;4558.5897269245925;4640.512746161605;4911.656184067081;4917.778699958439;5310.336207974004;4416.536263692395;4466;4666.463356714022;5077.984403119464;5161.380634323905;4526.637868970541;5129.051125541787;5135.35808023997;5151.459096794782;5191.636585439134;4228.9788551057045;4431.401760762255;4495.730256184639;4630.58324750774;5028.974855125701;5034.773435195351;5196.7401629917595;5248.58011359098;5262.9210561842365;5321.494458026481;4574.313852922089;5068;5127.820526281562;5150.278960945546;5258.027264955996 03:59:18 INFO - PROCESS | 1634 | |5;yui.html;703.7607213547399;711.8002988171409;752.6462562595578;815.7756616930345;847.5719761520431;14114;14729.189894555822;15092.320845561948;15148.394064237445;15312.081275123486;12977.610671679864;14050.578482645511;14215.431382744679;14229.71540569188;14232.501862434818;676.2459857259146;680.1226417920876;700.3031983176721;854.0477367734993;858.9656413743443;695.4158506854242;834.3033566971556;863.9827203455927;865.6061492021115;871.4596949891045;874.5015341255487;875.3259989807844;910.008091180613;913.0914739833875;917.1378903830412;706.9611171385571;729.9890501642479;870.1602953150241;904.0101089307198;911.6307895302413;657.763205246111;673.8147009572358;677.857649893518;680.8195828105556;683.3576438148175;14740.336684849208;14766.557003289918;14777.187254700988;14799.482018129422;14820.777688334683;11982;12081.275123492618;12123.515059397614;12417.689557761038;13150.802737958938;12275.422161346129;12495.205837670945;12910.031747618872;13028.80456793149;13118.081734278605;4490.59584637381;4506.369108324837;4671.182543054952;4672.229082201433;4677.321788340706;106321.46839265754;107365.02127361775;107843;109332.4533377328;112261.43869280683;10170.914962432684;10328.380297182193;10619.36283822973;10698.465076746132;10822.621208257673;20725.378238652866;20895.37313880586;21133.577328453346;21200;21203.833789141438;7698.692052317844;7700.537967721954;7815.843683126305;7851;7872.134065252818;4247.851325203603;4267.445232119804;4286.5284818669925;4299.419578356944;4318.265894797892;3514.894553163358;3579.6599323064265;3588.3002814450933;3622.2574372253625;3647.85408583659;587.5534593708812;654.228010947087;656.6735194906263;665.1652176518438;672.8082496488576;660.8281846719791;667.4860357524678;687.9690413931385;707.3669066185838;709.9737467925054;9616.471094089753;9915;9943.772396998624;10024;10087.243456740774;644.1497223664811;647.2200997797643;682.9385355318045;721.4949535325293;726.5604309392847;4730.668853180245;4944.851654450372;4956.975215123901;4957.256411538298;4968.205087186033;105261;107422.46288768506;107624.8475030495;108994;109440.35839462414;96291;96666.51666741622;97886.02113978911;98207.61650492695;99638.5018074905;78496.60751696205;78935.60532197302;79371;81603.36793264102;81941.77087343695;8032.437729358889;9606.231501480004;9642.758931026781;9648.131668149901;9657.855132173163;52837.20744188917;53626.463735362144;53665.926681465375;54785.72607136939;56122;70290;71339.64330178316;71394.28605713876;73221;74909;11141.832872506757;11481.425928703698;11823.763524729286;11857.5849845255;11859;12359.38203089824;12403.44140572346;12593.103586175048;12672.87327126717;12979.935100324437;10948.56205751761;11022.151187473339;11212.04697600713;11407.828882566933;11539.480723367637;11617.941910290394;12105.757884842078;12524.749505009666;12835.42240599194;14037.649058773204;12830.807537887125;13327.200367977952;13383.53157639478;13610.727785444433;13724.313784310943;10521.4739263035;11266.94366528195;11635.243709158878;12022.75954480888;12085.951206345973;10647.201459890694;11403.942980285377;11468.82796758066;11537.07703383744;11558.884411155781 03:59:18 INFO - PROCESS | 1634 | __end_tp_report 03:59:18 INFO - PROCESS | 1634 | __start_cc_report 03:59:18 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1615 03:59:18 INFO - PROCESS | 1634 | __end_cc_report 03:59:18 INFO - PROCESS | 1634 | __startTimestamp1487073558277__endTimestamp 03:59:18 INFO - PROCESS | 1634 | 03:59:18 INFO - PROCESS | 1634 | ------- Summary: start ------- 03:59:18 INFO - PROCESS | 1634 | Number of tests: 6 03:59:18 INFO - PROCESS | 1634 | 03:59:18 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5667.18 Median:5848.74 stddev:621.84 (10.6%) stddev-sans-first:594.59 03:59:18 INFO - PROCESS | 1634 | Values: 3268.3 3270.7 3289.7 3319.9 3349.9 5604.5 5620.4 5637.3 5644.4 5684.2 5600.5 5670.9 5700.8 5705.7 5720.1 5138.8 5190.9 5207.8 5209.9 5269.7 5096.4 5096.9 5257.4 5281.2 5324.3 5127.2 5169.1 5187.1 5198.5 5205.3 5229.6 5233.4 5235.7 5238.5 5250.7 4548.0 5045.3 5182.9 5232.6 5236.7 5489.9 5525.9 5542.2 5642.5 5671.4 6120.4 6130.1 6132.0 6133.8 6135.4 6185.6 6214.0 6242.0 6245.0 6255.3 5714.4 5766.1 5772.6 5786.5 5811.4 6130.0 6237.7 6240.5 6243.6 6264.6 5893.5 6041.8 6125.1 6128.1 6137.1 6136.8 6175.1 6187.7 6197.5 6202.6 5962.8 6144.5 6147.2 6163.9 6166.5 6032.9 6113.8 6122.8 6129.0 6136.7 4965.8 4971.2 4972.5 4987.5 5008.6 4406.2 4408.5 4412.3 4421.4 4439.7 5480.1 5485.3 5536.9 5709.0 5716.9 5091.0 5472.9 5620.9 6123.9 6132.6 5498.5 5564.1 5641.0 5647.3 5664.2 5313.5 5338.8 5360.5 5363.1 5374.3 6187.8 6301.7 6304.1 6304.5 6306.2 5969.4 6023.8 6025.8 6136.7 6140.0 6216.9 6230.9 6231.9 6254.3 6263.0 6125.4 6149.9 6154.4 6158.4 6160.2 5946.1 6040.2 6244.1 6249.7 6254.1 5974.7 6006.2 6028.0 6064.8 6122.6 5958.5 6039.0 6044.8 6050.5 6066.5 5674.0 5874.6 5880.1 5897.4 5898.2 5609.2 5830.1 5939.6 5950.6 5953.6 5840.1 5848.7 5849.4 5850.2 5865.8 03:59:18 INFO - PROCESS | 1634 | 03:59:18 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:71353.77 Median:36142.37 stddev:155373.16 (429.9%) stddev-sans-first:155717.80 03:59:18 INFO - PROCESS | 1634 | Values: 439.2 478.9 503.4 505.8 542.1 25732.7 32826.2 35235.8 39961.4 42558.6 43747.6 44116.3 44137.0 44187.3 44417.8 9218.2 9441.4 9445.2 9446.1 9467.4 8429.2 8604.0 9304.1 11104.5 11390.3 11431.3 11437.5 11442.3 11470.3 11472.6 11216.8 11296.9 11398.8 11404.9 11410.4 8302.8 8517.2 10943.4 11200.1 11235.4 40658.2 40729.0 41677.2 42062.2 42124.4 3927.0 3998.3 4000.1 4023.7 4097.4 29375.9 29436.0 29490.6 29828.7 30517.5 3040.6 3270.0 3298.5 3299.0 3300.7 482642.0 483913.2 484710.0 485717.6 486866.0 63963.4 64283.4 64300.0 64446.0 64484.0 67321.0 67459.7 67549.6 67559.6 67617.7 16773.8 16950.7 17031.1 17061.2 17068.5 11681.1 12971.7 13081.5 13098.7 13104.0 14876.9 15313.8 19003.3 21550.7 22192.0 7262.8 8680.7 8687.4 8705.8 8711.4 847.6 848.3 849.8 870.4 875.5 25880.5 30504.8 30559.0 30562.4 30920.0 1062.4 1075.9 1088.1 1102.4 1173.6 14897.3 15540.0 15552.5 15604.2 15645.0 650878.0 653998.0 654391.0 655373.0 655966.0 62562.7 63431.0 63503.0 63659.0 63667.7 1411.5 1429.5 1448.5 1450.2 1455.4 28771.4 29614.9 29812.6 30462.2 30577.5 52375.5 52663.2 54040.2 54076.6 57147.4 586771.0 593131.0 593244.0 594506.0 594860.0 32560.0 40483.8 40912.0 41010.8 41087.8 41040.4 41968.8 43301.4 43617.9 43833.0 35262.3 35959.8 36134.8 36149.9 36241.0 29493.0 30126.4 36078.5 36086.1 37103.8 34970.6 35032.8 35347.6 35543.3 35800.8 30009.7 32178.7 32287.0 32334.8 32359.7 23462.9 23508.5 23944.3 24009.8 24082.0 03:59:18 INFO - PROCESS | 1634 | 03:59:18 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:39175.14 Median:403.41 stddev:122164.55 (30283.3%) stddev-sans-first:122472.48 03:59:18 INFO - PROCESS | 1634 | Values: 358.2 360.9 363.6 388.8 400.2 12183.9 15125.2 16042.2 20626.4 21210.8 18055.8 20949.0 21391.3 22353.7 22511.5 4698.5 5641.7 5880.8 5882.4 5895.4 5746.1 5829.7 5875.1 5879.8 5900.3 5598.8 5700.7 5855.4 5861.8 5868.3 5751.0 5815.5 5821.6 5825.2 5830.0 4848.3 5020.5 5060.7 5124.8 5149.2 25055.0 25334.7 25923.0 26456.9 26783.7 2440.7 2464.8 2473.3 2481.8 2492.0 9801.1 9823.7 9918.2 9985.6 10158.4 1669.9 1722.9 1726.1 1753.0 1753.4 121133.0 135983.3 136332.0 138439.0 140216.1 11716.8 11727.2 11810.1 11897.5 11960.8 15819.3 15890.0 15894.0 15911.6 15920.9 7371.5 8495.4 8794.7 8802.1 8899.6 8561.0 8574.2 8576.9 8706.9 8735.5 4680.9 4812.5 4816.2 4826.3 4886.0 1778.5 1958.5 1961.6 2020.6 2023.5 390.4 401.3 405.5 419.5 946.5 11434.9 11536.0 11656.7 11731.0 11740.4 437.7 439.9 442.4 447.6 448.4 5560.0 5831.6 5870.5 6037.8 6045.3 707487.4 714460.0 739905.0 749903.0 756468.0 91813.0 124919.0 129599.0 155885.0 167466.0 442.4 459.8 460.5 460.6 461.0 11417.9 11479.7 11666.8 11751.0 11855.0 58424.0 59642.7 60680.0 60722.0 61191.4 62049.7 84547.6 86866.6 88744.6 96853.0 7924.4 8129.7 8430.0 8530.5 8662.9 9145.5 13255.3 13335.6 13550.9 13831.6 11182.0 11249.4 11718.1 11748.9 11948.2 11327.7 11371.3 11508.1 11694.2 11836.0 11692.6 11919.6 11965.9 12082.3 12102.2 7362.7 8417.1 8500.0 8642.1 8659.0 10808.5 11257.7 11337.5 11410.0 11847.8 03:59:18 INFO - PROCESS | 1634 | 03:59:18 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5317.71 Median:5292.58 stddev:2861.69 (54.1%) stddev-sans-first:2854.75 03:59:18 INFO - PROCESS | 1634 | Values: 1423.3 1431.9 1448.7 1456.1 1458.5 7971.3 8262.9 8407.2 8412.1 8427.0 7375.9 7629.1 7634.4 7882.6 8029.0 2249.9 2284.3 2285.9 2290.4 2297.0 2260.2 2292.3 2296.7 2306.3 2308.0 1984.1 2070.2 2206.7 2255.7 2290.6 2041.5 2270.1 2280.8 2281.6 2285.2 2145.2 2194.0 2299.7 2306.0 2308.2 7129.3 8142.1 8246.9 8252.9 8263.2 5042.6 5201.2 5201.6 5202.5 5205.6 2891.9 3262.9 3429.6 3498.9 3504.1 1127.4 1173.3 1215.5 1219.9 1222.5 8891.5 10415.9 10722.6 10804.1 10895.3 4331.0 4382.7 4537.5 4553.7 4554.7 8432.0 8554.0 8565.7 8580.1 8596.4 5080.0 5125.4 5125.8 5132.2 5144.3 4255.3 4269.3 4439.2 4715.3 4822.9 3849.4 3866.4 3973.2 3979.0 3994.0 1267.2 1285.6 1289.6 1292.5 1296.0 875.8 883.2 883.8 891.7 897.9 5429.9 5536.7 5640.5 5641.7 5756.9 957.7 979.3 981.6 988.8 1020.6 3540.9 3584.5 3678.8 3760.3 3785.9 9599.2 9796.2 9895.7 9911.3 9913.4 9249.7 9686.9 9770.8 9792.4 9801.3 7616.0 7785.2 7850.3 7852.3 7932.6 5174.9 5379.6 5419.3 5468.5 5743.2 8539.1 9298.3 9300.9 9328.5 9330.2 8020.8 9228.8 9282.4 9385.7 9411.6 6507.3 6720.1 6885.5 7047.6 7186.7 7682.1 7853.8 7854.1 7861.3 7867.8 6909.6 7020.5 7053.5 7059.4 7169.8 6894.4 6901.4 6914.9 6921.6 6961.9 6202.2 6338.6 6435.8 6435.8 6477.7 4857.1 4869.0 4924.5 4947.3 4981.7 4448.8 4734.0 4915.4 4988.8 5081.6 03:59:18 INFO - PROCESS | 1634 | 03:59:18 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4279.34 Median:4663.10 stddev:1265.14 (27.1%) stddev-sans-first:1233.83 03:59:18 INFO - PROCESS | 1634 | Values: 349.7 355.3 358.3 367.6 371.2 4353.5 5243.6 5265.9 5306.9 5339.4 3947.8 4354.2 4598.7 4973.3 5166.3 3334.8 3804.7 4002.9 4031.6 4075.2 4030.1 4065.2 4065.8 4099.2 4119.4 3233.4 3752.6 3820.4 4057.0 4093.9 3469.8 3702.4 3714.3 4007.7 4031.7 3182.0 3565.2 3587.7 3610.2 3619.1 3911.4 5046.1 5049.5 5056.5 5085.4 4492.9 4517.2 4518.8 4572.9 4644.0 4279.6 5178.8 5366.2 5380.3 5414.9 3567.4 3980.3 3980.5 3983.6 3996.9 4289.0 5255.8 5465.8 5503.9 5594.8 3296.3 3547.9 3690.7 4024.1 4044.2 3673.3 3758.0 4089.9 4099.9 4117.3 3937.8 4378.4 4411.9 4659.7 4668.6 5218.0 5421.6 5448.8 5464.2 5470.4 1248.3 1320.3 1334.7 1340.3 1355.8 760.5 879.4 908.3 924.9 955.8 4886.2 5041.7 5056.3 5072.9 5073.9 5511.3 5540.0 5576.1 5576.2 5653.7 4340.9 4481.3 4852.4 5013.3 5108.4 2436.5 2480.6 2514.5 2565.6 2772.3 4811.5 4917.6 4934.6 5504.9 5559.1 4512.6 5099.9 5189.3 5476.5 5487.7 4868.9 5328.9 5451.1 5513.5 5546.9 4484.9 4721.6 5262.6 5270.6 5276.6 4460.1 4854.9 5029.5 5113.0 5201.8 4832.6 4932.7 5400.5 5486.2 5514.8 3325.5 3328.8 3391.8 3404.4 3901.9 4558.6 4640.5 4911.7 4917.8 5310.3 4416.5 4466.0 4666.5 5078.0 5161.4 4526.6 5129.1 5135.4 5151.5 5191.6 4229.0 4431.4 4495.7 4630.6 5029.0 5034.8 5196.7 5248.6 5262.9 5321.5 4574.3 5068.0 5127.8 5150.3 5258.0 03:59:18 INFO - PROCESS | 1634 | 03:59:18 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:21010.01 Median:4308.84 stddev:31044.86 (720.5%) stddev-sans-first:31094.51 03:59:18 INFO - PROCESS | 1634 | Values: 703.8 711.8 752.6 815.8 847.6 14114.0 14729.2 15092.3 15148.4 15312.1 12977.6 14050.6 14215.4 14229.7 14232.5 676.2 680.1 700.3 854.0 859.0 695.4 834.3 864.0 865.6 871.5 874.5 875.3 910.0 913.1 917.1 707.0 730.0 870.2 904.0 911.6 657.8 673.8 677.9 680.8 683.4 14740.3 14766.6 14777.2 14799.5 14820.8 11982.0 12081.3 12123.5 12417.7 13150.8 12275.4 12495.2 12910.0 13028.8 13118.1 4490.6 4506.4 4671.2 4672.2 4677.3 106321.5 107365.0 107843.0 109332.5 112261.4 10170.9 10328.4 10619.4 10698.5 10822.6 20725.4 20895.4 21133.6 21200.0 21203.8 7698.7 7700.5 7815.8 7851.0 7872.1 4247.9 4267.4 4286.5 4299.4 4318.3 3514.9 3579.7 3588.3 3622.3 3647.9 587.6 654.2 656.7 665.2 672.8 660.8 667.5 688.0 707.4 710.0 9616.5 9915.0 9943.8 10024.0 10087.2 644.1 647.2 682.9 721.5 726.6 4730.7 4944.9 4957.0 4957.3 4968.2 105261.0 107422.5 107624.8 108994.0 109440.4 96291.0 96666.5 97886.0 98207.6 99638.5 78496.6 78935.6 79371.0 81603.4 81941.8 8032.4 9606.2 9642.8 9648.1 9657.9 52837.2 53626.5 53665.9 54785.7 56122.0 70290.0 71339.6 71394.3 73221.0 74909.0 11141.8 11481.4 11823.8 11857.6 11859.0 12359.4 12403.4 12593.1 12672.9 12979.9 10948.6 11022.2 11212.0 11407.8 11539.5 11617.9 12105.8 12524.7 12835.4 14037.6 12830.8 13327.2 13383.5 13610.7 13724.3 10521.5 11266.9 11635.2 12022.8 12086.0 10647.2 11403.9 11468.8 11537.1 11558.9 03:59:18 INFO - PROCESS | 1634 | -------- Summary: end -------- 03:59:18 INFO - PROCESS | 1634 | 03:59:18 INFO - TEST-INFO | 1634: exit 0 03:59:18 INFO - TEST-OK | dromaeo_css | took 1118906ms 03:59:18 INFO - TEST-START | kraken 03:59:18 INFO - operating with platform_type : mac_ 03:59:18 INFO - Initialising browser for kraken test... 03:59:18 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmp05RgCC/profile http://localhost:49240/getInfo.html) 03:59:21 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 03:59:21 INFO - PROCESS | 1647 | colorDepth:24 03:59:21 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 03:59:21 INFO - PROCESS | 1647 | __metrics 03:59:21 INFO - PROCESS | 1647 | 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" 03:59:21 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:22 INFO - TEST-INFO | 1647: exit 0 03:59:22 INFO - Browser initialized. 03:59:22 INFO - Running cycle 1/1 for kraken test... 03:59:22 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmp05RgCC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:34 INFO - PROCESS | 1648 | RSS: Main: 229998592 03:59:34 INFO - PROCESS | 1648 | 03:59:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 03:59:37 INFO - PROCESS | 1648 | RSS: Main: 279683072 03:59:37 INFO - PROCESS | 1648 | 03:59:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 03:59:40 INFO - PROCESS | 1648 | RSS: Main: 290430976 03:59:40 INFO - PROCESS | 1648 | 03:59:44 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 03:59:44 INFO - PROCESS | 1648 | RSS: Main: 383901696 03:59:44 INFO - PROCESS | 1648 | 03:59:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 03:59:47 INFO - PROCESS | 1648 | RSS: Main: 288432128 03:59:47 INFO - PROCESS | 1648 | 03:59:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:50 INFO - PROCESS | 1648 | RSS: Main: 289341440 03:59:50 INFO - PROCESS | 1648 | 03:59:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 03:59:53 INFO - PROCESS | 1648 | RSS: Main: 330952704 03:59:53 INFO - PROCESS | 1648 | 03:59:56 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 03:59:56 INFO - PROCESS | 1648 | RSS: Main: 330452992 03:59:56 INFO - PROCESS | 1648 | 03:59:59 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 04:00:00 INFO - PROCESS | 1648 | RSS: Main: 327426048 04:00:00 INFO - PROCESS | 1648 | 04:00:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:00:02 INFO - PROCESS | 1648 | RSS: Main: 303550464 04:00:02 INFO - PROCESS | 1648 | 04:00:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:00:05 INFO - PROCESS | 1648 | RSS: Main: 306462720 04:00:05 INFO - PROCESS | 1648 | 04:00:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:00:08 INFO - PROCESS | 1648 | RSS: Main: 309284864 04:00:08 INFO - PROCESS | 1648 | 04:00:10 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:00:11 INFO - PROCESS | 1648 | RSS: Main: 327446528 04:00:11 INFO - PROCESS | 1648 | 04:00:14 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:00:15 INFO - PROCESS | 1648 | RSS: Main: 321351680 04:00:15 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 04:00:17 INFO - PROCESS | 1648 | RSS: Main: 366333952 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | __start_tp_report 04:00:17 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 04:00:17 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 04:00:17 INFO - PROCESS | 1648 | |i|pagename|runs| 04:00:17 INFO - PROCESS | 1648 | |0;ai-astar;115;115;114;114;114;114;114;115;114;115 04:00:17 INFO - PROCESS | 1648 | |1;audio-beat-detection;143;111;110;143;112;110;110;110;129;110 04:00:17 INFO - PROCESS | 1648 | |2;audio-dft;184;184;185;184;183;184;183;185;183;184 04:00:17 INFO - PROCESS | 1648 | |3;audio-fft;77;74;82;112;74;58;58;58;74;57 04:00:17 INFO - PROCESS | 1648 | |4;audio-oscillator;84;72;86;71;68;55;77;75;99;111 04:00:17 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;88;85;88;85;87;85;88;85;88;84 04:00:17 INFO - PROCESS | 1648 | |6;imaging-darkroom;94;93;94;94;94;93;94;94;93;94 04:00:17 INFO - PROCESS | 1648 | |7;imaging-desaturate;124;96;91;85;86;86;87;85;106;129 04:00:17 INFO - PROCESS | 1648 | |8;json-parse-financial;57;55;54;54;55;56;57;56;56;56 04:00:17 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;68;73;74;73;71;70;66;69;69;69 04:00:17 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;80;86;81;84;83;81;86;84;85;84 04:00:17 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;138;137;139;139;145;146;129;142;197;168 04:00:17 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;169;167;167;171;165;167;166;168;167;168 04:00:17 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;68;67;68;76;81;80;84;82;81;72 04:00:17 INFO - PROCESS | 1648 | __end_tp_report 04:00:17 INFO - PROCESS | 1648 | __start_cc_report 04:00:17 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1982 04:00:17 INFO - PROCESS | 1648 | __end_cc_report 04:00:17 INFO - PROCESS | 1648 | __startTimestamp1487073617302__endTimestamp 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | ------- Summary: start ------- 04:00:17 INFO - PROCESS | 1648 | Number of tests: 14 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:00:17 INFO - PROCESS | 1648 | Values: 115.0 115.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 115.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:118.80 Median:111.50 stddev:14.02 (12.6%) stddev-sans-first:11.83 04:00:17 INFO - PROCESS | 1648 | Values: 143.0 111.0 110.0 143.0 112.0 110.0 110.0 110.0 129.0 110.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:0.74 (0.4%) stddev-sans-first:0.78 04:00:17 INFO - PROCESS | 1648 | Values: 184.0 184.0 185.0 184.0 183.0 184.0 183.0 185.0 183.0 184.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:72.40 Median:74.00 stddev:16.83 (22.7%) stddev-sans-first:17.77 04:00:17 INFO - PROCESS | 1648 | Values: 77.0 74.0 82.0 112.0 74.0 58.0 58.0 58.0 74.0 57.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:79.80 Median:76.00 stddev:16.06 (21.1%) stddev-sans-first:16.96 04:00:17 INFO - PROCESS | 1648 | Values: 84.0 72.0 86.0 71.0 68.0 55.0 77.0 75.0 99.0 111.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:1.64 (1.9%) stddev-sans-first:1.62 04:00:17 INFO - PROCESS | 1648 | Values: 88.0 85.0 88.0 85.0 87.0 85.0 88.0 85.0 88.0 84.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:00:17 INFO - PROCESS | 1648 | Values: 94.0 93.0 94.0 94.0 94.0 93.0 94.0 94.0 93.0 94.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:97.50 Median:86.00 stddev:16.66 (19.4%) stddev-sans-first:14.66 04:00:17 INFO - PROCESS | 1648 | Values: 124.0 96.0 91.0 85.0 86.0 86.0 87.0 85.0 106.0 129.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.07 (1.9%) stddev-sans-first:1.01 04:00:17 INFO - PROCESS | 1648 | Values: 57.0 55.0 54.0 54.0 55.0 56.0 57.0 56.0 56.0 56.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.50 stddev:2.53 (3.6%) stddev-sans-first:2.55 04:00:17 INFO - PROCESS | 1648 | Values: 68.0 73.0 74.0 73.0 71.0 70.0 66.0 69.0 69.0 69.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:2.12 (2.5%) stddev-sans-first:1.86 04:00:17 INFO - PROCESS | 1648 | Values: 80.0 86.0 81.0 84.0 83.0 81.0 86.0 84.0 85.0 84.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:143.50 stddev:19.98 (13.9%) stddev-sans-first:20.87 04:00:17 INFO - PROCESS | 1648 | Values: 138.0 137.0 139.0 139.0 145.0 146.0 129.0 142.0 197.0 168.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.50 stddev:1.65 (1.0%) stddev-sans-first:1.66 04:00:17 INFO - PROCESS | 1648 | Values: 169.0 167.0 167.0 171.0 165.0 167.0 166.0 168.0 167.0 168.0 04:00:17 INFO - PROCESS | 1648 | 04:00:17 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:80.50 stddev:6.59 (8.2%) stddev-sans-first:6.34 04:00:17 INFO - PROCESS | 1648 | Values: 68.0 67.0 68.0 76.0 81.0 80.0 84.0 82.0 81.0 72.0 04:00:17 INFO - PROCESS | 1648 | -------- Summary: end -------- 04:00:17 INFO - PROCESS | 1648 | 04:00:18 INFO - TEST-INFO | 1648: exit 0 04:00:18 INFO - TEST-OK | kraken | took 59280ms 04:00:18 INFO - SUITE-END | took 1178s 04:00:18 INFO - Completed test suite (00:19:38) 04:00:18 INFO - javascript benchmark 04:00:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3268.2646404558977, 3270.672932706729, 3289.736821054316, 3319.933601327975, 3349.933001339973, 5604.495595396414, 5620.353659329178, 5637.267155269819, 5644.435556444353, 5684.2326285951385, 5600.4959553640165, 5670.858228544278, 5700.7719691212305, 5705.714714264281, 5720.0561907285355, 5138.768755406007, 5190.92213616796, 5207.791688332462, 5209.86975325618, 5269.657472264291, 5096.3884333879805, 5096.872578185538, 5257.447967963366, 5281.206111946484, 5324.307839980797, 5127.230915362707, 5169.147090730025, 5187.0922588546855, 5198.45416231296, 5205.27126202332, 5229.633925625208, 5233.424323324451, 5235.685858848481, 5238.52853243208, 5250.68495890244, 4547.977260113711, 5045.293658887758, 5182.896342073175, 5232.555232805216, 5236.659617124875, 5489.862753431156, 5525.889482210333, 5542.196381524696, 5642.463965923231, 5671.404502527258, 6120.418560236771, 6130.080487926802, 6132.0, 6133.754649814002, 6135.355787642323, 6185.628862268233, 6214.036824292242, 6242.0, 6245.0320200369015, 6255.343188965184, 5714.371419143891, 5766.106253530709, 5772.624779389326, 5786.537077033827, 5811.4479124483105, 6129.970128114947, 6237.656928868956, 6240.469560087444, 6243.625382477066, 6264.624122552661, 5893.469587737124, 6041.818745437644, 6125.081237814364, 6128.080787881853, 6137.144455097482, 6136.815895523141, 6175.073738939105, 6187.690615469209, 6197.5351848610635, 6202.596831205957, 5962.791302304486, 6144.5084393248435, 6147.231596050494, 6163.876722465526, 6166.475849552839, 6032.939670603326, 6113.816585502442, 6122.755089796358, 6128.972736294558, 6136.702895113906, 4965.776540055706, 4971.229459433794, 4972.453030166679, 4987.501249874984, 5008.599312055099, 4406.162829062468, 4408.515063343029, 4412.3160910059, 4421.38100665907, 4439.66702497314, 5480.123180291134, 5485.341758988947, 5536.944630553643, 5709.000924838137, 5716.885662286731, 5091.0, 5472.863178420572, 5620.85947851307, 6123.908141377883, 6132.569672417391, 5498.532624726863, 5564.081926482166, 5641.012822756002, 5647.322321321386, 5664.20701101846, 5313.495217954288, 5338.839834804962, 5360.490753378423, 5363.061464243741, 5374.301340825746, 6187.783427580013, 6301.6534090625455, 6304.085907543472, 6304.495640348761, 6306.180196574416, 5969.403059693996, 6023.819285421444, 6025.78909738157, 6136.693165341804, 6140.048292514667, 6216.906746398718, 6230.906536401867, 6231.906521402092, 6254.312025677263, 6262.968685156545, 6125.387461254018, 6149.877002459836, 6154.446099851035, 6158.353372895782, 6160.199174107337, 5946.07835785454, 6040.214772079602, 6244.094606282155, 6249.687515624291, 6254.124422580751, 5974.6713930732485, 6006.189164462741, 6027.969860150672, 6064.787732429344, 6122.602030867979, 5958.463738263577, 6039.0, 6044.848878778066, 6050.546209034252, 6066.545009124245, 5673.971630141823, 5874.618149820248, 5880.117982302689, 5897.410258974069, 5898.233229680114, 5609.242752228397, 5830.096335068071, 5939.643621382731, 5950.613210141327, 5953.642781433128, 5840.123981402823, 5848.736806843787, 5849.356570777296, 5850.210221620197, 5865.824025279248], "value": 5627.571930694432, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.2203838187218, 478.89224924391993, 503.36073187052443, 505.77745791851606, 542.1163503489311, 25732.74267257327, 32826.17934551634, 35235.82382088086, 39961.400578991335, 42558.57441425585, 43747.56252437475, 44116.3382549262, 44137.0, 44187.337189942176, 44417.77791111048, 9218.170364667196, 9441.433513989183, 9445.244380449547, 9446.102620251066, 9467.431954082742, 8429.157084291583, 8604.010538788025, 9304.11610896967, 11104.500297486593, 11390.316581005125, 11431.256968297075, 11437.542498300058, 11442.256253343507, 11470.311781293107, 11472.598459053936, 11216.775664486746, 11296.887031129665, 11398.772024559463, 11404.885951140548, 11410.42947852604, 8302.750917472486, 8517.23344898962, 10943.398113103776, 11200.103991680646, 11235.382053987027, 40658.186836263405, 40729.0, 41677.1664566707, 42062.158756824996, 42124.368134478005, 3926.960730392688, 3998.3402738548107, 4000.119973605831, 4023.7384570002855, 4097.358426534492, 29375.853120734475, 29436.0, 29490.557641635394, 29828.70171298281, 30517.542236866466, 3040.5895204147378, 3270.035339574831, 3298.538204651351, 3298.950515742266, 3300.6864347886913, 482642.0, 483913.2239049251, 484710.0, 485717.5714121442, 486866.0, 63963.36036639667, 64283.35716642774, 64300.0, 64446.0, 64484.0, 67321.0, 67459.66270168716, 67549.64900701959, 67559.64880702457, 67617.66191169112, 16773.832261677228, 16950.660986780196, 17031.14844257782, 17061.232244549024, 17068.48794536166, 11681.123915706356, 12971.740565188833, 13081.542146024844, 13098.738025239441, 13104.017198710135, 14876.925615371854, 15313.846861531465, 19003.29968944083, 21550.676739848914, 22192.0, 7262.782116536512, 8680.696175633822, 8687.435316704394, 8705.782355441164, 8711.433756805787, 847.6268445118947, 848.3298194426334, 849.7790574450687, 870.3907264914585, 875.4528419737663, 25880.48239035209, 30504.84747576248, 30558.97537728365, 30562.388752225277, 30920.0, 1062.4315990944808, 1075.9139268858473, 1088.1131877519797, 1102.3551222534907, 1173.559915031863, 14897.255137243312, 15540.0, 15552.455664051704, 15604.164695689202, 15645.0, 650878.0, 653998.0, 654391.0, 655373.0, 655966.0, 62562.68718656377, 63431.0, 63503.0, 63659.04511432332, 63667.68166159232, 1411.5483045425572, 1429.4925301517812, 1448.4785477227979, 1450.1951416963475, 1455.4251070827177, 28771.424571508873, 29614.851925740233, 29812.552811708276, 30462.23844403819, 30577.54133688041, 52375.47624523706, 52663.21005184849, 54040.18939715829, 54076.648083798216, 57147.42852571588, 586771.0, 593131.0, 593244.0, 594506.0, 594860.0, 32560.0, 40483.79758101191, 40912.0, 41010.794946026275, 41087.794561027, 41040.384394233515, 41968.79015604902, 43301.35047974346, 43617.90955226018, 43833.0, 35262.294754105285, 35959.82020089883, 36134.819325903205, 36149.91550253497, 36241.0, 29493.0, 30126.397472050874, 36078.45882311715, 36086.09784755402, 37103.81448092742, 34970.601175952674, 35032.82483587566, 35347.64652353546, 35543.289134216655, 35800.82099589486, 30009.699903000692, 32178.678213218504, 32287.0, 32334.83832580822, 32359.676403236608, 23462.882685586465, 23508.52982940366, 23944.281671549186, 24009.759902400754, 24082.0], "value": 20408.882076717084, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.1887025886368, 360.8971443138705, 363.61093629816077, 388.80365415465167, 400.1816285695752, 12183.878161218385, 15125.243737813107, 16042.197890105477, 20626.38120856373, 21210.787892121076, 18055.81944180558, 20948.952552372397, 21391.251306204285, 22353.664695029587, 22511.54976900461, 4698.459677137139, 5641.6897070661, 5880.8235752927485, 5882.3529411764675, 5895.380984996578, 5746.051901436258, 5829.650220986733, 5875.059990401536, 5879.823605291826, 5900.262467191601, 5598.832035038955, 5700.686462244575, 5855.414458554132, 5861.7948371807, 5868.295804503444, 5751.0, 5815.505682017034, 5821.621594596338, 5825.155352473867, 5829.9708501457435, 4848.272759086165, 5020.548150666421, 5060.721660308682, 5124.795008199668, 5149.227615857614, 25054.997800088157, 25334.746652533424, 25923.0, 26456.86771566149, 26783.732162678512, 2440.694913135858, 2464.827462077655, 2473.319837044827, 2481.8262721609494, 2491.987540062288, 9801.117899389017, 9823.656172034016, 9918.206543476577, 9985.635742235829, 10158.390496570155, 1669.9248533816008, 1722.9138543072922, 1726.0765490462668, 1752.956176095595, 1753.3863147898262, 121133.0, 135983.32008339994, 136332.0, 138439.0, 140216.09120100853, 11716.824247636292, 11727.179097463266, 11810.114241431927, 11897.524099036114, 11960.820587691192, 15819.288132034086, 15890.0, 15894.0, 15911.602209944613, 15920.920395397949, 7371.520851144658, 8495.405321627426, 8794.692185773467, 8802.119788021148, 8899.555022248862, 8561.015483219386, 8574.213380651314, 8576.914230857612, 8706.869396959051, 8735.51954642488, 4680.882977925579, 4812.470628230892, 4816.20532612115, 4826.276058591169, 4885.95114048855, 1778.5020194345605, 1958.5005823515198, 1961.6469035573734, 2020.5857799151138, 2023.5143565544458, 390.3792969179019, 401.3197630017151, 405.4911086586315, 419.45261433828534, 946.5409276500892, 11434.885651143382, 11536.0, 11656.70858228534, 11731.0, 11740.354280514483, 437.6936144698724, 439.9098184872158, 442.3961292835321, 447.64188649080603, 448.3946671992784, 5559.972200138974, 5831.562632802556, 5870.501007414332, 6037.758489660452, 6045.274567051982, 707487.3844616538, 714460.0, 739905.0, 749903.0, 756468.0, 91813.0, 124919.0, 129599.0, 155885.0, 167466.0, 442.3961292835257, 459.8160735705745, 460.5233583241396, 460.5831722291332, 460.9723416595015, 11417.942910285396, 11479.713007174887, 11666.841634297682, 11751.00116490108, 11855.0, 58424.0, 59642.70178649079, 60680.0, 60722.0, 61191.38808611857, 62049.689751550955, 84547.5772621133, 86866.56566717126, 88744.55627722078, 96853.0, 7924.366050715814, 8129.715459958873, 8430.0, 8530.488170709777, 8662.870056949278, 9145.496997665192, 13255.270960097287, 13335.599932002055, 13550.86449135496, 13831.585052448443, 11182.0, 11249.38128402913, 11718.062554995751, 11748.941255293668, 11948.223365481215, 11327.716807079889, 11371.31772093677, 11508.136889733136, 11694.239874408137, 11835.993940515153, 11692.590759323382, 11919.642410727693, 11965.940170299093, 12082.275063496218, 12102.152849300464, 7362.7423040193335, 8417.116202798617, 8499.957500212708, 8642.135786421308, 8659.004214515411, 10808.513616887101, 11257.71855703614, 11337.489812958273, 11410.0, 11847.822282665595], "value": 8778.64435661416, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.3025817349496, 1431.8926080543959, 1448.6740483391245, 1456.1263242054763, 1458.5478501664481, 7971.282584567388, 8262.876056859152, 8407.20131587499, 8412.116727743583, 8427.0, 7375.88936165958, 7629.122650895149, 7634.389248860091, 7882.566458844762, 8029.0, 2249.910003599858, 2284.2690339091496, 2285.942851428711, 2290.3815969688176, 2296.9540609187807, 2260.152442833937, 2292.277932451281, 2296.701428814252, 2306.2850516339904, 2308.0306271366067, 1984.0873198328786, 2070.1926248762993, 2206.735191776989, 2255.650374192003, 2290.576243394969, 2041.5406533529838, 2270.080617349976, 2280.7719228077226, 2281.646344816556, 2285.1544928376525, 2145.249162793026, 2194.0, 2299.678045073691, 2306.031466783955, 2308.203669733939, 7129.287071292881, 8142.145074767123, 8246.876296855551, 8252.876206856901, 8263.173682631748, 5042.596592272609, 5201.219817027439, 5201.609879259033, 5202.505761952646, 5205.583553315763, 2891.8843246270335, 3262.939544647999, 3429.5884493860895, 3498.912527186815, 3504.123969007748, 1127.3743072594707, 1173.278433763238, 1215.544170935899, 1219.920705154162, 1222.5171057432353, 8891.510966896818, 10415.947920260425, 10722.624708135256, 10804.13566914645, 10895.346279223351, 4330.956690433055, 4382.715123516961, 4537.478190008125, 4553.681242313072, 4554.7039442436135, 8431.95784021076, 8554.0, 8565.700200492953, 8580.069484365968, 8596.441231319945, 5080.0, 5125.410577783528, 5125.820596279113, 5132.178851383761, 5144.279800827887, 4255.276602977501, 4269.295566231599, 4439.200943830077, 4715.316279139505, 4822.890735130869, 3849.3840985442193, 3866.38137897935, 3973.2252210818615, 3978.960210397859, 3993.960060399359, 1267.15100882409, 1285.6014635463036, 1289.6324547503916, 1292.4507084489055, 1296.027979015738, 875.8029443375317, 883.2227639677171, 883.7967267528376, 891.7146513115871, 897.8967418746797, 5429.864253393618, 5536.695481748542, 5640.464155905182, 5641.668906609377, 5756.942430575725, 957.6887511558771, 979.2508730820928, 981.5779214937645, 988.8318985772436, 1020.5815615597569, 3540.91147721309, 3584.5160903277724, 3678.779273243614, 3760.304343696425, 3785.8674946377296, 9599.184069354184, 9796.216302695768, 9895.653652122284, 9911.256655750847, 9913.405195688138, 9249.676261330822, 9686.903130968742, 9770.75573110678, 9792.412455252565, 9801.264905132144, 7616.0, 7785.221477852169, 7850.254225848649, 7852.254035866584, 7932.603369831485, 5174.948250517597, 5379.569634429315, 5419.295491586068, 5468.5351745100525, 5743.224664670383, 8539.103394143525, 9298.349115561845, 9300.906990930274, 9328.486933218737, 9330.206932410822, 8020.839583208186, 9228.769280767767, 9282.35023548345, 9385.718428447157, 9411.576479058596, 6507.349265073455, 6720.059191713066, 6885.4835887309655, 7047.612381319077, 7186.7125314986815, 7682.078150621737, 7853.842923141619, 7854.1360450349275, 7861.2531809478005, 7867.84264314722, 6909.550879192836, 7020.473464490082, 7053.541519801196, 7059.364657180879, 7169.7849064528145, 6894.448444124358, 6901.413379862567, 6914.896276555755, 6921.550099243533, 6961.930380696128, 6202.193714817045, 6338.587991780704, 6435.774747883802, 6435.839104022437, 6477.704459108103, 4857.149998750134, 4868.9756551217015, 4924.532169443897, 4947.282644016525, 4981.676191047571, 4448.844290449819, 4733.952660473351, 4915.410150781929, 4988.750562471934, 5081.644284900021], "value": 4347.284267901551, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.7342020064751, 355.3124703698344, 358.27985748645216, 367.560764885961, 371.1500663480628, 4353.477582690074, 5243.580513558915, 5265.9473405265935, 5306.867328316794, 5339.385970613381, 3947.82234799434, 4354.216241076605, 4598.655100867431, 4973.303737476756, 5166.328377310953, 3334.832808517012, 3804.695624350059, 4002.8799136025964, 4031.596840315967, 4075.205334959684, 4030.1335212929216, 4065.2113070249143, 4065.79671016448, 4099.180163967204, 4119.40268661044, 3233.369492948876, 3752.6059763724825, 3820.36963900956, 4057.0, 4093.9181216375655, 3469.826508674556, 3702.3705969985167, 3714.2571485702697, 4007.7394969327047, 4031.737937034083, 3182.0, 3565.180008598011, 3587.703869523507, 3610.223801882608, 3619.1314084619767, 3911.413288006793, 5046.142155833517, 5049.4950504949575, 5056.497033968172, 5085.389753229636, 4492.865214043584, 4517.232423320271, 4518.841840535565, 4572.88567785808, 4643.953560464386, 4279.582036149565, 5178.844634660966, 5366.2436294593945, 5380.300560927094, 5414.91877621836, 3567.375709250871, 3980.3083689431874, 3980.5223373195404, 3983.601639836022, 3996.86010989614, 4289.0, 5255.76349064293, 5465.812664397885, 5503.889922201533, 5594.804181853657, 3296.3077753671996, 3547.94678079829, 3690.723195760275, 4024.0945787197647, 4044.15072834708, 3673.265346930571, 3758.0, 4089.89775255621, 4099.8975025624595, 4117.300058989979, 3937.783421911765, 4378.408914796461, 4411.867643970686, 4659.743714095757, 4668.626509879202, 5217.991073436754, 5421.593380496479, 5448.809291674773, 5464.196815051024, 5470.425605311465, 1248.3383806582526, 1320.2870449956915, 1334.658668038615, 1340.2829486224823, 1355.752707509094, 760.5094713909498, 879.3844308983737, 908.336914052732, 924.8855129568853, 955.7562821480478, 4886.193778026657, 5041.6722913010535, 5056.317397151411, 5072.949270507322, 5073.873153171126, 5511.283533140666, 5540.030494663418, 5576.079946808813, 5576.247206627054, 5653.660780353192, 4340.934885976713, 4481.327800829901, 4852.369192005087, 5013.323201367842, 5108.386993560796, 2436.4639779248537, 2480.5535003699506, 2514.4719608882338, 2565.6279839423178, 2772.334639686461, 4811.542903424169, 4917.631177661689, 4934.5805606523845, 5504.889902201933, 5559.080848002149, 4512.616427603625, 5099.87250318745, 5189.299444575009, 5476.534494567926, 5487.670739755627, 4868.853934381974, 5328.866778330495, 5451.073317535949, 5513.5037846594, 5546.889062218814, 4484.9103017940115, 4721.568392278048, 5262.578993680573, 5270.55059858542, 5276.604254680838, 4460.1202718084905, 4854.90290194187, 5029.547340739351, 5112.977404519037, 5201.76592053366, 4832.565069143794, 4932.7286999215385, 5400.487863398254, 5486.162135684591, 5514.834554963358, 3325.5177999190464, 3328.833558322123, 3391.8134502601606, 3404.4212483877304, 3901.921961560696, 4558.5897269245925, 4640.512746161605, 4911.656184067081, 4917.778699958439, 5310.336207974004, 4416.536263692395, 4466.0, 4666.463356714022, 5077.984403119464, 5161.380634323905, 4526.637868970541, 5129.051125541787, 5135.35808023997, 5151.459096794782, 5191.636585439134, 4228.9788551057045, 4431.401760762255, 4495.730256184639, 4630.58324750774, 5028.974855125701, 5034.773435195351, 5196.7401629917595, 5248.58011359098, 5262.9210561842365, 5321.494458026481, 4574.313852922089, 5068.0, 5127.820526281562, 5150.278960945546, 5258.027264955996], "value": 3900.214229210214, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.7607213547399, 711.8002988171409, 752.6462562595578, 815.7756616930345, 847.5719761520431, 14114.0, 14729.189894555822, 15092.320845561948, 15148.394064237445, 15312.081275123486, 12977.610671679864, 14050.578482645511, 14215.431382744679, 14229.71540569188, 14232.501862434818, 676.2459857259146, 680.1226417920876, 700.3031983176721, 854.0477367734993, 858.9656413743443, 695.4158506854242, 834.3033566971556, 863.9827203455927, 865.6061492021115, 871.4596949891045, 874.5015341255487, 875.3259989807844, 910.008091180613, 913.0914739833875, 917.1378903830412, 706.9611171385571, 729.9890501642479, 870.1602953150241, 904.0101089307198, 911.6307895302413, 657.763205246111, 673.8147009572358, 677.857649893518, 680.8195828105556, 683.3576438148175, 14740.336684849208, 14766.557003289918, 14777.187254700988, 14799.482018129422, 14820.777688334683, 11982.0, 12081.275123492618, 12123.515059397614, 12417.689557761038, 13150.802737958938, 12275.422161346129, 12495.205837670945, 12910.031747618872, 13028.80456793149, 13118.081734278605, 4490.59584637381, 4506.369108324837, 4671.182543054952, 4672.229082201433, 4677.321788340706, 106321.46839265754, 107365.02127361775, 107843.0, 109332.4533377328, 112261.43869280683, 10170.914962432684, 10328.380297182193, 10619.36283822973, 10698.465076746132, 10822.621208257673, 20725.378238652866, 20895.37313880586, 21133.577328453346, 21200.0, 21203.833789141438, 7698.692052317844, 7700.537967721954, 7815.843683126305, 7851.0, 7872.134065252818, 4247.851325203603, 4267.445232119804, 4286.5284818669925, 4299.419578356944, 4318.265894797892, 3514.894553163358, 3579.6599323064265, 3588.3002814450933, 3622.2574372253625, 3647.85408583659, 587.5534593708812, 654.228010947087, 656.6735194906263, 665.1652176518438, 672.8082496488576, 660.8281846719791, 667.4860357524678, 687.9690413931385, 707.3669066185838, 709.9737467925054, 9616.471094089753, 9915.0, 9943.772396998624, 10024.0, 10087.243456740774, 644.1497223664811, 647.2200997797643, 682.9385355318045, 721.4949535325293, 726.5604309392847, 4730.668853180245, 4944.851654450372, 4956.975215123901, 4957.256411538298, 4968.205087186033, 105261.0, 107422.46288768506, 107624.8475030495, 108994.0, 109440.35839462414, 96291.0, 96666.51666741622, 97886.02113978911, 98207.61650492695, 99638.5018074905, 78496.60751696205, 78935.60532197302, 79371.0, 81603.36793264102, 81941.77087343695, 8032.437729358889, 9606.231501480004, 9642.758931026781, 9648.131668149901, 9657.855132173163, 52837.20744188917, 53626.463735362144, 53665.926681465375, 54785.72607136939, 56122.0, 70290.0, 71339.64330178316, 71394.28605713876, 73221.0, 74909.0, 11141.832872506757, 11481.425928703698, 11823.763524729286, 11857.5849845255, 11859.0, 12359.38203089824, 12403.44140572346, 12593.103586175048, 12672.87327126717, 12979.935100324437, 10948.56205751761, 11022.151187473339, 11212.04697600713, 11407.828882566933, 11539.480723367637, 11617.941910290394, 12105.757884842078, 12524.749505009666, 12835.42240599194, 14037.649058773204, 12830.807537887125, 13327.200367977952, 13383.53157639478, 13610.727785444433, 13724.313784310943, 10521.4739263035, 11266.94366528195, 11635.243709158878, 12022.75954480888, 12085.951206345973, 10647.201459890694, 11403.942980285377, 11468.82796758066, 11537.07703383744, 11558.884411155781], "value": 7454.108489605513, "unit": "score"}], "name": "dromaeo_css", "value": 7093.926312836084, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 110.0, 143.0, 112.0, 110.0, 110.0, 110.0, 129.0, 110.0], "value": 118.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 185.0, 184.0, 183.0, 184.0, 183.0, 185.0, 183.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 82.0, 112.0, 74.0, 58.0, 58.0, 58.0, 74.0, 57.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 86.0, 71.0, 68.0, 55.0, 77.0, 75.0, 99.0, 111.0], "value": 79.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 87.0, 85.0, 88.0, 85.0, 88.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 96.0, 91.0, 85.0, 86.0, 86.0, 87.0, 85.0, 106.0, 129.0], "value": 97.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 54.0, 55.0, 56.0, 57.0, 56.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 74.0, 73.0, 71.0, 70.0, 66.0, 69.0, 69.0, 69.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 81.0, 84.0, 83.0, 81.0, 86.0, 84.0, 85.0, 84.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 139.0, 139.0, 145.0, 146.0, 129.0, 142.0, 197.0, 168.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 167.0, 171.0, 165.0, 167.0, 166.0, 168.0, 167.0, 168.0], "value": 167.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 76.0, 81.0, 80.0, 84.0, 82.0, 81.0, 72.0], "value": 75.9, "unit": "score"}], "name": "kraken", "value": 1447.4, "alertThreshold": 2.0}]} 04:00:18 INFO - Return code: 0 04:00:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:00:18 ERROR - # TBPL SUCCESS # 04:00:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:00:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:00:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:00:18 INFO - 2017-02-14 04:00:18.623 screenresolution[1652:9734] starting screenresolution argv=screenresolution get 04:00:18 INFO - 2017-02-14 04:00:18.626 screenresolution[1652:9734] Display 0: 1600x1200x32@60 04:00:18 INFO - 2017-02-14 04:00:18.633 screenresolution[1653:9737] starting screenresolution argv=screenresolution list 04:00:18 INFO - Available Modes on Display 0 04:00:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:00:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:00:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:00:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:00:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:00:18 INFO - Intel Iris: 04:00:18 INFO - Chipset Model: Intel Iris 04:00:18 INFO - Type: GPU 04:00:18 INFO - Bus: Built-In 04:00:18 INFO - VRAM (Dynamic, Max): 1536 MB 04:00:18 INFO - Vendor: Intel (0x8086) 04:00:18 INFO - Device ID: 0x0a2e 04:00:18 INFO - Revision ID: 0x0009 04:00:18 INFO - Displays: 04:00:18 INFO - Display: 04:00:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:00:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:00:18 INFO - Display Serial Number: 1600x1200 60 04:00:18 INFO - Main Display: Yes 04:00:18 INFO - Mirror: Off 04:00:18 INFO - Online: Yes 04:00:18 INFO - Rotation: Supported 04:00:18 INFO - Return code: 0 04:00:18 INFO - Running post-action listener: _resource_record_post_action 04:00:18 INFO - [mozharness: 2017-02-14 12:00:18.871099Z] Finished run-tests step (success) 04:00:18 INFO - Running post-run listener: _resource_record_post_run 04:00:18 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 36738048; Write bytes: 508732416; Read time: 391; Write time: 1908 04:00:18 INFO - TinderboxPrint: CPU usage
53.7% 04:00:18 INFO - TinderboxPrint: I/O read bytes / time
36,738,048 / 391 04:00:18 INFO - TinderboxPrint: I/O write bytes / time
508,732,416 / 1,908 04:00:18 INFO - TinderboxPrint: CPU idle
2,222.2 (46.3%) 04:00:18 INFO - TinderboxPrint: CPU system
958.1 (20.0%) 04:00:18 INFO - TinderboxPrint: CPU user
1,617.4 (33.7%) 04:00:18 INFO - TinderboxPrint: Swap in / out
244,137,984 / 0 04:00:18 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205564416; Write bytes: 198914048; Read time: 15886; Write time: 364 04:00:18 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34554880; Write bytes: 294329344; Read time: 364; Write time: 1398 04:00:19 INFO - Running post-run listener: _upload_blobber_files 04:00:19 INFO - Blob upload gear active. 04:00:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:00:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:00:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:20 INFO - (blobuploader) - INFO - Done attempting. 04:00:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:00:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:00:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:21 INFO - (blobuploader) - INFO - Done attempting. 04:00:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:00:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:00:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:22 INFO - (blobuploader) - INFO - Done attempting. 04:00:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:00:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:00:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:00:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:00:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:00:24 INFO - (blobuploader) - INFO - Done attempting. 04:00:24 INFO - (blobuploader) - INFO - Iteration through files over. 04:00:24 INFO - Return code: 0 04:00:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:00:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:00:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2357e3c682d21a41535e4fe5ac5a40889e1e3593aa1540810d514d1ef1006647bc645735530a3ad60b4507e998ea910a18cd892365ce983743a3876bb549e427", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2c75cedfd628b56fdbc7a9b6ad9962cacb527f3fbc5ad8b78be15da0173474912ed5ca4f3e2915eb2e377abbbf623ff4dcc55a81545350802370ed0a3ea8735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fbfd87eccfc4e616bae644c7d59ac9f5a30e38c193e248fe8b2546dd86af3edc95b1b34d077ec09a008e9b423915b136022c9744ce73901e378f602fc52363d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fe91d979e94e86829c0763a287d518f6e4fd5959ed1b820bd4b70b16de5c83e402cd40641e76fab5626c22b0d16d36b4dc83db717f39e583e7bc3ea516c8b9e"} 04:00:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:00:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:00:24 INFO - Contents: 04:00:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2357e3c682d21a41535e4fe5ac5a40889e1e3593aa1540810d514d1ef1006647bc645735530a3ad60b4507e998ea910a18cd892365ce983743a3876bb549e427", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2c75cedfd628b56fdbc7a9b6ad9962cacb527f3fbc5ad8b78be15da0173474912ed5ca4f3e2915eb2e377abbbf623ff4dcc55a81545350802370ed0a3ea8735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fbfd87eccfc4e616bae644c7d59ac9f5a30e38c193e248fe8b2546dd86af3edc95b1b34d077ec09a008e9b423915b136022c9744ce73901e378f602fc52363d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fe91d979e94e86829c0763a287d518f6e4fd5959ed1b820bd4b70b16de5c83e402cd40641e76fab5626c22b0d16d36b4dc83db717f39e583e7bc3ea516c8b9e"} 04:00:24 INFO - Running post-run listener: copy_logs_to_upload_dir 04:00:24 INFO - Copying logs to upload dir... 04:00:24 INFO - mkdir: /builds/slave/test/build/upload/logs 04:00:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.846787 ========= master_lag: 0.62 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-14 04:00:25.399295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 04:00:25.405888) ========= 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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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/Mozilla-Aurora/sha512/2357e3c682d21a41535e4fe5ac5a40889e1e3593aa1540810d514d1ef1006647bc645735530a3ad60b4507e998ea910a18cd892365ce983743a3876bb549e427", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2c75cedfd628b56fdbc7a9b6ad9962cacb527f3fbc5ad8b78be15da0173474912ed5ca4f3e2915eb2e377abbbf623ff4dcc55a81545350802370ed0a3ea8735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fbfd87eccfc4e616bae644c7d59ac9f5a30e38c193e248fe8b2546dd86af3edc95b1b34d077ec09a008e9b423915b136022c9744ce73901e378f602fc52363d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fe91d979e94e86829c0763a287d518f6e4fd5959ed1b820bd4b70b16de5c83e402cd40641e76fab5626c22b0d16d36b4dc83db717f39e583e7bc3ea516c8b9e"} build_url:https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010787 build_url: 'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2357e3c682d21a41535e4fe5ac5a40889e1e3593aa1540810d514d1ef1006647bc645735530a3ad60b4507e998ea910a18cd892365ce983743a3876bb549e427", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d2c75cedfd628b56fdbc7a9b6ad9962cacb527f3fbc5ad8b78be15da0173474912ed5ca4f3e2915eb2e377abbbf623ff4dcc55a81545350802370ed0a3ea8735", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1fbfd87eccfc4e616bae644c7d59ac9f5a30e38c193e248fe8b2546dd86af3edc95b1b34d077ec09a008e9b423915b136022c9744ce73901e378f602fc52363d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fe91d979e94e86829c0763a287d518f6e4fd5959ed1b820bd4b70b16de5c83e402cd40641e76fab5626c22b0d16d36b4dc83db717f39e583e7bc3ea516c8b9e"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 04:00:25.455649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 04:00:25.455975) ========= 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.ne6eWgKMS2/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.Fk2MqD2aIS/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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.005064 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 04:00:25.507512) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 04:00:25.507839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 04:00:25.508151) ========= ========= Total master_lag: 0.78 =========