builder: larch_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0151 starttime: 1474521788.48 results: success (0) buildid: 20160921173859 builduid: ee6c993604504537a011b94dcfbaba06 revision: 3b8cf1e729ef97ed49808f980bed542b81a3631e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:08.476066) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:08.476498) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:08.476772) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:08.503035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:08.503313) ========= 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.s9x7sejPqR/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.BVI3EYcPuk/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-21 22:23:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.62M=0.001s 2016-09-21 22:23:08 (9.62 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080543 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:08.607026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:08.607326) ========= 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.s9x7sejPqR/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.BVI3EYcPuk/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.028950 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:08.656736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 22:23:08.657061) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 3b8cf1e729ef97ed49808f980bed542b81a3631e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 3b8cf1e729ef97ed49808f980bed542b81a3631e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s9x7sejPqR/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.BVI3EYcPuk/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-21 22:23:08,744 truncating revision to first 12 chars 2016-09-21 22:23:08,744 Setting DEBUG logging. 2016-09-21 22:23:08,744 attempt 1/10 2016-09-21 22:23:08,745 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/3b8cf1e729ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 22:23:10,092 unpacking tar archive at: larch-3b8cf1e729ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.608353 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-21 22:23:10.287970) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:10.288319) ========= script_repo_revision: 3b8cf1e729ef97ed49808f980bed542b81a3631e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:10.288766) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:10.289086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 22:23:10.307941) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-21 22:23:10.308351) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s9x7sejPqR/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.BVI3EYcPuk/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:23:10 INFO - MultiFileLogger online at 20160921 22:23:10 in /builds/slave/test 22:23:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 22:23:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:23:10 INFO - {'append_to_log': False, 22:23:10 INFO - 'base_work_dir': '/builds/slave/test', 22:23:10 INFO - 'blob_upload_branch': 'Larch', 22:23:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:23:10 INFO - 'branch': 'Larch', 22:23:10 INFO - 'buildbot_json_path': 'buildprops.json', 22:23:10 INFO - 'config_files': ('talos/mac_config.py',), 22:23:10 INFO - 'default_actions': ('clobber', 22:23:10 INFO - 'read-buildbot-config', 22:23:10 INFO - 'download-and-extract', 22:23:10 INFO - 'populate-webroot', 22:23:10 INFO - 'create-virtualenv', 22:23:10 INFO - 'install', 22:23:10 INFO - 'run-tests'), 22:23:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:23:10 INFO - 'download_minidump_stackwalk': True, 22:23:10 INFO - 'download_symbols': 'ondemand', 22:23:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:23:10 INFO - 'tooltool.py': '/tools/tooltool.py', 22:23:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:23:10 INFO - '/tools/misc-python/virtualenv.py')}, 22:23:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:23:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:23:10 INFO - 'installer_path': 'installer.exe', 22:23:10 INFO - 'log_level': 'info', 22:23:10 INFO - 'log_name': 'talos', 22:23:10 INFO - 'log_to_console': True, 22:23:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:23:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:23:10 INFO - 'opt_config_files': (), 22:23:10 INFO - 'pip_index': False, 22:23:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:23:10 INFO - 'cmd': ('bash', 22:23:10 INFO - '-c', 22:23:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:23:10 INFO - 'enabled': True, 22:23:10 INFO - 'halt_on_failure': False, 22:23:10 INFO - 'name': 'check_screen_resolution'},), 22:23:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:23:10 INFO - 'cmd': ('bash', 22:23:10 INFO - '-c', 22:23:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:23:10 INFO - 'enabled': True, 22:23:10 INFO - 'halt_on_failure': False, 22:23:10 INFO - 'name': 'check_screen_resolution'},), 22:23:10 INFO - 'run_cmd_checks_enabled': True, 22:23:10 INFO - 'sps_profile': False, 22:23:10 INFO - 'sps_profile_interval': 0, 22:23:10 INFO - 'suite': 'dromaeojs-e10s', 22:23:10 INFO - 'system_bits': '32', 22:23:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:23:10 INFO - 'title': 't-yosemite-r7-0151', 22:23:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:23:10 INFO - 'use_talos_json': True, 22:23:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:23:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:23:10 INFO - 'work_dir': 'build'} 22:23:10 INFO - [mozharness: 2016-09-22 05:23:10.518026Z] Running clobber step. 22:23:10 INFO - Running pre-action listener: _resource_record_pre_action 22:23:10 INFO - Running main action method: clobber 22:23:10 INFO - rmtree: /builds/slave/test/build 22:23:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:23:12 INFO - Running post-action listener: _resource_record_post_action 22:23:12 INFO - [mozharness: 2016-09-22 05:23:12.700024Z] Finished clobber step (success) 22:23:12 INFO - [mozharness: 2016-09-22 05:23:12.700208Z] Running read-buildbot-config step. 22:23:12 INFO - Running pre-action listener: _resource_record_pre_action 22:23:12 INFO - Running main action method: read_buildbot_config 22:23:12 INFO - Using buildbot properties: 22:23:12 INFO - { 22:23:12 INFO - "project": "", 22:23:12 INFO - "product": "firefox", 22:23:12 INFO - "script_repo_revision": "production", 22:23:12 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs-e10s", 22:23:12 INFO - "repository": "", 22:23:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs-e10s", 22:23:12 INFO - "buildid": "20160921173859", 22:23:12 INFO - "pgo_build": "False", 22:23:12 INFO - "basedir": "/builds/slave/test", 22:23:12 INFO - "buildnumber": 5, 22:23:12 INFO - "slavename": "t-yosemite-r7-0151", 22:23:12 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:23:12 INFO - "platform": "yosemite_r7", 22:23:12 INFO - "scheduler": "tests-larch-macosx64-talos", 22:23:12 INFO - "branch": "larch", 22:23:12 INFO - "repo_path": "projects/larch", 22:23:12 INFO - "revision": "3b8cf1e729ef97ed49808f980bed542b81a3631e", 22:23:12 INFO - "stage_platform": "macosx64", 22:23:12 INFO - "builduid": "ee6c993604504537a011b94dcfbaba06", 22:23:12 INFO - "slavebuilddir": "test" 22:23:12 INFO - } 22:23:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 22:23:12 INFO - Running post-action listener: _resource_record_post_action 22:23:12 INFO - [mozharness: 2016-09-22 05:23:12.704281Z] Finished read-buildbot-config step (success) 22:23:12 INFO - [mozharness: 2016-09-22 05:23:12.704452Z] Running download-and-extract step. 22:23:12 INFO - Running pre-action listener: _resource_record_pre_action 22:23:12 INFO - Running main action method: download_and_extract 22:23:12 INFO - mkdir: /builds/slave/test/build/tests 22:23: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')]} 22:23:12 INFO - trying https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 22:23:12 INFO - Downloading https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 22:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 22:23:14 INFO - Downloaded 1199 bytes. 22:23:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 22:23:14 INFO - Using the following test package requirements: 22:23:14 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 22:23:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:23:14 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 22:23:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:23:14 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 22:23:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:23:14 INFO - u'jsshell-mac.zip'], 22:23:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:23:14 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 22:23:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 22:23:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:23:14 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 22:23:14 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:23:14 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 22:23:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:23:14 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 22:23:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 22:23:14 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 22:23:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:23:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 22:23:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:23:14 INFO - Fetch https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 22:23:14 INFO - Expected file size: 16432476 22:23:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:23:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 22:23:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:23:21 INFO - Fetch https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 22:23:22 INFO - Expected file size: 16432476 22:23:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 22:23:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:23:29 INFO - Fetch https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 22:23:30 INFO - Expected file size: 14414059 22:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:23:31 INFO - trying https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:23:31 INFO - Downloading https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 22:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 22:23:34 INFO - Downloaded 111340073 bytes. 22:23:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:23:34 INFO - mkdir: /builds/slave/test/properties 22:23:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:23:34 INFO - Writing to file /builds/slave/test/properties/build_url 22:23:34 INFO - Contents: 22:23:34 INFO - build_url:https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 22:23:35 INFO - Running post-action listener: _resource_record_post_action 22:23:35 INFO - Running post-action listener: set_extra_try_arguments 22:23:35 INFO - [mozharness: 2016-09-22 05:23:35.244115Z] Finished download-and-extract step (success) 22:23:35 INFO - [mozharness: 2016-09-22 05:23:35.244233Z] Running populate-webroot step. 22:23:35 INFO - Running pre-action listener: _resource_record_pre_action 22:23:35 INFO - Running main action method: populate_webroot 22:23:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:23:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:23:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:23:35 INFO - '--tppagecycles', 22:23:35 INFO - '7'], 22:23:35 INFO - 'tests': ['tsvgm']}}, 22:23:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:23:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:23:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:23:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:23:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:35 INFO - 'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:23:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:23:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:35 INFO - 'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['damp', 'tps']}, 22:23:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:35 INFO - 'tests': ['damp', 'tps']}, 22:23:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['dromaeo_dom']}, 22:23:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:23:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['basic_compositor_video']}, 22:23:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:23:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['a11yr', 22:23:35 INFO - 'ts_paint', 22:23:35 INFO - 'tpaint', 22:23:35 INFO - 'sessionrestore', 22:23:35 INFO - 'sessionrestore_no_auto_restore', 22:23:35 INFO - 'tabpaint']}, 22:23:35 INFO - 'other-e10s': {'tests': ['a11yr', 22:23:35 INFO - 'ts_paint', 22:23:35 INFO - 'tpaint', 22:23:35 INFO - 'sessionrestore', 22:23:35 INFO - 'sessionrestore_no_auto_restore', 22:23:35 INFO - 'tabpaint']}, 22:23:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:23:35 INFO - 'ts_paint', 22:23:35 INFO - 'tpaint', 22:23:35 INFO - 'sessionrestore', 22:23:35 INFO - 'sessionrestore_no_auto_restore', 22:23:35 INFO - 'tabpaint']}, 22:23:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:23:35 INFO - 'ts_paint', 22:23:35 INFO - 'tpaint', 22:23:35 INFO - 'sessionrestore', 22:23:35 INFO - 'sessionrestore_no_auto_restore', 22:23:35 INFO - 'tabpaint']}, 22:23:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['a11yr', 22:23:35 INFO - 'ts_paint', 22:23:35 INFO - 'tpaint', 22:23:35 INFO - 'sessionrestore', 22:23:35 INFO - 'sessionrestore_no_auto_restore', 22:23:35 INFO - 'tabpaint']}, 22:23:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['a11yr', 22:23:35 INFO - 'ts_paint', 22:23:35 INFO - 'tpaint', 22:23:35 INFO - 'sessionrestore', 22:23:35 INFO - 'sessionrestore_no_auto_restore', 22:23:35 INFO - 'tabpaint']}, 22:23:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['tsvgx', 22:23:35 INFO - 'tsvgr_opacity', 22:23:35 INFO - 'tart', 22:23:35 INFO - 'tscrollx', 22:23:35 INFO - 'cart']}, 22:23:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:23:35 INFO - 'tsvgr_opacity', 22:23:35 INFO - 'tart', 22:23:35 INFO - 'tscrollx', 22:23:35 INFO - 'cart']}, 22:23:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:35 INFO - 'talos_options': ['--disable-e10s'], 22:23:35 INFO - 'tests': ['tp5o']}, 22:23:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:35 INFO - 'tests': ['tp5o']}, 22:23:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:35 INFO - 'talos_options': ['--disable-e10s', 22:23:35 INFO - '--xperf_path', 22:23:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:23:35 INFO - 'tests': ['tp5n']}, 22:23:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:23:35 INFO - 'talos_options': ['--xperf_path', 22:23:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:23:35 INFO - 'tests': ['tp5n']}}, 22:23:35 INFO - 'talos.zip': {'path': '', 22:23:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:23:35 INFO - Running post-action listener: _resource_record_post_action 22:23:35 INFO - [mozharness: 2016-09-22 05:23:35.263299Z] Finished populate-webroot step (success) 22:23:35 INFO - [mozharness: 2016-09-22 05:23:35.263432Z] Running create-virtualenv step. 22:23:35 INFO - Running pre-action listener: _resource_record_pre_action 22:23:35 INFO - Running main action method: create_virtualenv 22:23:35 INFO - Creating virtualenv /builds/slave/test/build/venv 22:23:35 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 22:23:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:23:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:23:35 INFO - Using real prefix '/tools/python27' 22:23:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:23:36 INFO - Installing distribute.............................................................................................................................................................................................done. 22:23:39 INFO - Installing pip.................done. 22:23:39 INFO - Return code: 0 22:23:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:23: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')]} 22:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23: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')]} 22:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:39 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 0x104911490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104887570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be05b91a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, '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.s9x7sejPqR/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.BVI3EYcPuk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:23:39 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 22:23:39 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 22:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:23:39 INFO - 'HOME': '/Users/cltbld', 22:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:23:39 INFO - 'LOGNAME': 'cltbld', 22:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:39 INFO - 'MOZ_NO_REMOTE': '1', 22:23:39 INFO - 'NO_EM_RESTART': '1', 22:23:39 INFO - 'PAGER': '/bin/cat', 22:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:39 INFO - 'PWD': '/builds/slave/test', 22:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:23:39 INFO - 'SHELL': '/bin/bash', 22:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:23:39 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:23:39 INFO - 'USER': 'cltbld', 22:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:39 INFO - 'XPC_FLAGS': '0x0', 22:23:39 INFO - 'XPC_SERVICE_NAME': '0', 22:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:39 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 22:23:39 INFO - Cleaning up... 22:23:39 INFO - Return code: 0 22:23:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:23: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')]} 22:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23: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')]} 22:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:39 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 0x104911490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104887570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be05b91a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, '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.s9x7sejPqR/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.BVI3EYcPuk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:23:39 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 22:23:39 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 22:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:23:39 INFO - 'HOME': '/Users/cltbld', 22:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:23:39 INFO - 'LOGNAME': 'cltbld', 22:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:39 INFO - 'MOZ_NO_REMOTE': '1', 22:23:39 INFO - 'NO_EM_RESTART': '1', 22:23:39 INFO - 'PAGER': '/bin/cat', 22:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:39 INFO - 'PWD': '/builds/slave/test', 22:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:23:39 INFO - 'SHELL': '/bin/bash', 22:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:23:39 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:23:39 INFO - 'USER': 'cltbld', 22:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:39 INFO - 'XPC_FLAGS': '0x0', 22:23:39 INFO - 'XPC_SERVICE_NAME': '0', 22:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:39 INFO - Downloading/unpacking psutil>=3.1.1 22:23:39 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 22:23:39 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 22:23:39 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 22:23:39 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 22:23:39 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 22:23:39 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 22:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:23:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:23:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:23:42 INFO - Installing collected packages: psutil 22:23:42 INFO - Running setup.py install for psutil 22:23:43 INFO - building 'psutil._psutil_osx' extension 22:23:43 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 22:23:43 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 22:23:43 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 22:23:43 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 22:23:43 INFO - building 'psutil._psutil_posix' extension 22:23:43 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 22:23:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:23:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:23:43 INFO - ^ 22:23:43 INFO - 1 warning generated. 22:23:43 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 22:23:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:23:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:23:44 INFO - Successfully installed psutil 22:23:44 INFO - Cleaning up... 22:23:44 INFO - Return code: 0 22:23:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104911490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104887570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be05b91a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, '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.s9x7sejPqR/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.BVI3EYcPuk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:23:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:23:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:23:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:23:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:23:44 INFO - 'HOME': '/Users/cltbld', 22:23:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:23:44 INFO - 'LOGNAME': 'cltbld', 22:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:44 INFO - 'MOZ_NO_REMOTE': '1', 22:23:44 INFO - 'NO_EM_RESTART': '1', 22:23:44 INFO - 'PAGER': '/bin/cat', 22:23:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:44 INFO - 'PWD': '/builds/slave/test', 22:23:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:23:44 INFO - 'SHELL': '/bin/bash', 22:23:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:23:44 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:23:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:23:44 INFO - 'USER': 'cltbld', 22:23:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:23:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:44 INFO - 'XPC_FLAGS': '0x0', 22:23:44 INFO - 'XPC_SERVICE_NAME': '0', 22:23:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:23:44 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 22:23:44 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 22:23:44 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 22:23:44 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 22:23:44 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 22:23:44 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 22:23:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:23:47 INFO - Installing collected packages: mozsystemmonitor 22:23:47 INFO - Running setup.py install for mozsystemmonitor 22:23:47 INFO - Successfully installed mozsystemmonitor 22:23:47 INFO - Cleaning up... 22:23:47 INFO - Return code: 0 22:23:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:23:47 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')]} 22:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:47 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')]} 22:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:47 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 0x104911490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104887570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be05b91a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, '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.s9x7sejPqR/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.BVI3EYcPuk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:23:47 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 22:23:47 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 22:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:23:47 INFO - 'HOME': '/Users/cltbld', 22:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:23:47 INFO - 'LOGNAME': 'cltbld', 22:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:47 INFO - 'MOZ_NO_REMOTE': '1', 22:23:47 INFO - 'NO_EM_RESTART': '1', 22:23:47 INFO - 'PAGER': '/bin/cat', 22:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:47 INFO - 'PWD': '/builds/slave/test', 22:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:23:47 INFO - 'SHELL': '/bin/bash', 22:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:23:47 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:23:47 INFO - 'USER': 'cltbld', 22:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:47 INFO - 'XPC_FLAGS': '0x0', 22:23:47 INFO - 'XPC_SERVICE_NAME': '0', 22:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:47 INFO - Downloading/unpacking jsonschema==2.5.1 22:23:47 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 22:23:47 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 22:23:47 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 22:23:47 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 22:23:47 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 22:23:47 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 22:23:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:23:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:23: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 22:23: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 22:23: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 22:23: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 22:23: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 22:23: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 22:23:50 INFO - Downloading functools32-3.2.3-2.tar.gz 22:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:23:50 INFO - warning: no files found matching '*.txt' 22:23:50 INFO - no previously-included directories found matching 'build' 22:23:50 INFO - no previously-included directories found matching 'dist' 22:23:50 INFO - no previously-included directories found matching '.git*' 22:23:50 INFO - Installing collected packages: jsonschema, functools32 22:23:50 INFO - Running setup.py install for functools32 22:23:50 INFO - warning: no files found matching '*.txt' 22:23:50 INFO - no previously-included directories found matching 'build' 22:23:50 INFO - no previously-included directories found matching 'dist' 22:23:50 INFO - no previously-included directories found matching '.git*' 22:23:50 INFO - Successfully installed jsonschema functools32 22:23:50 INFO - Cleaning up... 22:23:50 INFO - Return code: 0 22:23:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:23: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')]} 22:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23: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')]} 22:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23: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', '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 0x104911490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104887570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be05b91a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, '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.s9x7sejPqR/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.BVI3EYcPuk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:23: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:23: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 functools32==3.2.3-2 22:23:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:23:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:23:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:23:50 INFO - 'HOME': '/Users/cltbld', 22:23:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:23:50 INFO - 'LOGNAME': 'cltbld', 22:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:50 INFO - 'MOZ_NO_REMOTE': '1', 22:23:50 INFO - 'NO_EM_RESTART': '1', 22:23:50 INFO - 'PAGER': '/bin/cat', 22:23:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:50 INFO - 'PWD': '/builds/slave/test', 22:23:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:23:50 INFO - 'SHELL': '/bin/bash', 22:23:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:23:50 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:23:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:23:50 INFO - 'USER': 'cltbld', 22:23:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:23:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:50 INFO - 'XPC_FLAGS': '0x0', 22:23:50 INFO - 'XPC_SERVICE_NAME': '0', 22:23:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:23:51 INFO - Cleaning up... 22:23:51 INFO - Return code: 0 22:23:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:51 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 0x104911490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104887570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be05b91a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, '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.s9x7sejPqR/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.BVI3EYcPuk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:23:51 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 22:23:51 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 22:23:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:23:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:23:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:23:51 INFO - 'HOME': '/Users/cltbld', 22:23:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:23:51 INFO - 'LOGNAME': 'cltbld', 22:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:51 INFO - 'MOZ_NO_REMOTE': '1', 22:23:51 INFO - 'NO_EM_RESTART': '1', 22:23:51 INFO - 'PAGER': '/bin/cat', 22:23:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:51 INFO - 'PWD': '/builds/slave/test', 22:23:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:23:51 INFO - 'SHELL': '/bin/bash', 22:23:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:23:51 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:23:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:23:51 INFO - 'USER': 'cltbld', 22:23:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:23:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:51 INFO - 'XPC_FLAGS': '0x0', 22:23:51 INFO - 'XPC_SERVICE_NAME': '0', 22:23:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:51 INFO - Downloading/unpacking blobuploader==1.2.4 22:23:51 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 22:23:51 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 22:23:51 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 22:23:51 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 22:23:51 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 22:23:51 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 22:23:54 INFO - Downloading blobuploader-1.2.4.tar.gz 22:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:23:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:23:54 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 22:23:54 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 22:23:54 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 22:23:54 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 22:23:54 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 22:23:54 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 22:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:23:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:23:54 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 22:23:54 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 22:23:54 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 22:23:54 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 22:23:54 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 22:23:54 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 22:23:55 INFO - Downloading docopt-0.6.1.tar.gz 22:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:23:55 INFO - Installing collected packages: blobuploader, requests, docopt 22:23:55 INFO - Running setup.py install for blobuploader 22:23:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:23:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:23:55 INFO - Running setup.py install for requests 22:23:56 INFO - Running setup.py install for docopt 22:23:56 INFO - Successfully installed blobuploader requests docopt 22:23:56 INFO - Cleaning up... 22:23:56 INFO - Return code: 0 22:23:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:23:56 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')]} 22:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:56 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')]} 22:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:56 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 0x104911490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104887570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be05b91a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, '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.s9x7sejPqR/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.BVI3EYcPuk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:23:56 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 22:23:56 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 22:23:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:23:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:23:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:23:56 INFO - 'HOME': '/Users/cltbld', 22:23:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:23:56 INFO - 'LOGNAME': 'cltbld', 22:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:56 INFO - 'MOZ_NO_REMOTE': '1', 22:23:56 INFO - 'NO_EM_RESTART': '1', 22:23:56 INFO - 'PAGER': '/bin/cat', 22:23:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:56 INFO - 'PWD': '/builds/slave/test', 22:23:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:23:56 INFO - 'SHELL': '/bin/bash', 22:23:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:23:56 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:23:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:23:56 INFO - 'USER': 'cltbld', 22:23:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:23:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:56 INFO - 'XPC_FLAGS': '0x0', 22:23:56 INFO - 'XPC_SERVICE_NAME': '0', 22:23:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:23:56 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-koU4qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:23:56 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-fBT2zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:23:56 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-1Z7JIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:23:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:23:56 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-4ktYtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:23:57 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-ohEFmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:23:57 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-NnPI3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:23:57 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-uucm5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:23:57 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-FRtwxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:23:57 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Y0gLiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:23:57 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-U3IseB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:23:57 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-3Exb8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:23:57 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-9ZDCXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:23:57 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-uXzrIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:23:57 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-hNAANK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:58 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-dT1zah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:23:58 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-lzblEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:23:58 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-te0AVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:23:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:23:58 INFO - Running setup.py install for manifestparser 22:23:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:23:58 INFO - Running setup.py install for mozcrash 22:23:58 INFO - Running setup.py install for mozdebug 22:23:58 INFO - Running setup.py install for mozdevice 22:23:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:23:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:23:58 INFO - Running setup.py install for mozfile 22:23:59 INFO - Running setup.py install for mozhttpd 22:23:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:23:59 INFO - Running setup.py install for mozinfo 22:23:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:23:59 INFO - Running setup.py install for mozInstall 22:23:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:23:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:23:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:23:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:23:59 INFO - Running setup.py install for mozleak 22:23:59 INFO - Running setup.py install for mozlog 22:23:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:23:59 INFO - Running setup.py install for moznetwork 22:24:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:24:00 INFO - Running setup.py install for mozprocess 22:24:00 INFO - Running setup.py install for mozprofile 22:24:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:24:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:24:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:24:00 INFO - Running setup.py install for mozrunner 22:24:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:24:00 INFO - Running setup.py install for mozscreenshot 22:24:00 INFO - Running setup.py install for moztest 22:24:00 INFO - Running setup.py install for mozversion 22:24:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:24:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:24:00 INFO - Cleaning up... 22:24:00 INFO - Return code: 0 22:24:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:01 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 0x104911490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104887570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be05b91a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, '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.s9x7sejPqR/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.BVI3EYcPuk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:24:01 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 22:24:01 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 22:24:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:24:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:01 INFO - 'HOME': '/Users/cltbld', 22:24:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:01 INFO - 'LOGNAME': 'cltbld', 22:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:01 INFO - 'MOZ_NO_REMOTE': '1', 22:24:01 INFO - 'NO_EM_RESTART': '1', 22:24:01 INFO - 'PAGER': '/bin/cat', 22:24:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:01 INFO - 'PWD': '/builds/slave/test', 22:24:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:01 INFO - 'SHELL': '/bin/bash', 22:24:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:24:01 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:24:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:01 INFO - 'USER': 'cltbld', 22:24:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:01 INFO - 'XPC_FLAGS': '0x0', 22:24:01 INFO - 'XPC_SERVICE_NAME': '0', 22:24:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:01 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-O61D9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:01 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)) 22:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:01 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-VykX4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:01 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-cVkQy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:01 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)) 22:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:01 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-In881F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:01 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-439XLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:01 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)) 22:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:01 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-t9CwaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:01 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)) 22:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:01 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-bf5aW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:02 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Yiz6lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:02 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-4MEKCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:02 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-A2VVF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:02 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-wlmno4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:02 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-DO_cCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:02 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-9ACB1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:02 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-WY36K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:02 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Dwif8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:02 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)) 22:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:02 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-iwuE_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:03 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-0OfHYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:03 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)) 22:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:24:03 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)) 22:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:24:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:24:03 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 22:24:03 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 22:24:03 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 22:24:03 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 22:24:03 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 22:24:03 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 22:24:05 INFO - Downloading blessings-1.6.tar.gz 22:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:24:05 INFO - Installing collected packages: blessings 22:24:05 INFO - Running setup.py install for blessings 22:24:05 INFO - Successfully installed blessings 22:24:05 INFO - Cleaning up... 22:24:06 INFO - Return code: 0 22:24:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:06 INFO - Reading from file tmpfile_stdout 22:24:06 INFO - Current package versions: 22:24:06 INFO - blessings == 1.6 22:24:06 INFO - blobuploader == 1.2.4 22:24:06 INFO - docopt == 0.6.1 22:24:06 INFO - functools32 == 3.2.3-2 22:24:06 INFO - jsonschema == 2.5.1 22:24:06 INFO - manifestparser == 1.1 22:24:06 INFO - mozInstall == 1.12 22:24:06 INFO - mozcrash == 0.17 22:24:06 INFO - mozdebug == 0.1 22:24:06 INFO - mozdevice == 0.48 22:24:06 INFO - mozfile == 1.2 22:24:06 INFO - mozhttpd == 0.7 22:24:06 INFO - mozinfo == 0.9 22:24:06 INFO - mozleak == 0.1 22:24:06 INFO - mozlog == 3.4 22:24:06 INFO - moznetwork == 0.27 22:24:06 INFO - mozprocess == 0.23 22:24:06 INFO - mozprofile == 0.28 22:24:06 INFO - mozrunner == 6.12 22:24:06 INFO - mozscreenshot == 0.1 22:24:06 INFO - mozsystemmonitor == 0.3 22:24:06 INFO - moztest == 0.7 22:24:06 INFO - mozversion == 1.4 22:24:06 INFO - psutil == 3.1.1 22:24:06 INFO - requests == 1.2.3 22:24:06 INFO - wsgiref == 0.1.2 22:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:06 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 0x104911490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104887570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be05b91a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, '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.s9x7sejPqR/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.BVI3EYcPuk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:24:06 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 22:24:06 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 22:24:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:24:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:06 INFO - 'HOME': '/Users/cltbld', 22:24:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:06 INFO - 'LOGNAME': 'cltbld', 22:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:06 INFO - 'MOZ_NO_REMOTE': '1', 22:24:06 INFO - 'NO_EM_RESTART': '1', 22:24:06 INFO - 'PAGER': '/bin/cat', 22:24:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:06 INFO - 'PWD': '/builds/slave/test', 22:24:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:06 INFO - 'SHELL': '/bin/bash', 22:24:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:24:06 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:24:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:06 INFO - 'USER': 'cltbld', 22:24:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:06 INFO - 'XPC_FLAGS': '0x0', 22:24:06 INFO - 'XPC_SERVICE_NAME': '0', 22:24:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 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)) 22:24:06 INFO - Cleaning up... 22:24:06 INFO - Return code: 0 22:24:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104911490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104887570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9be05b91a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, '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.s9x7sejPqR/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.BVI3EYcPuk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 22:24:07 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 22:24:07 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 22:24:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:24:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:07 INFO - 'HOME': '/Users/cltbld', 22:24:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:07 INFO - 'LOGNAME': 'cltbld', 22:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:07 INFO - 'MOZ_NO_REMOTE': '1', 22:24:07 INFO - 'NO_EM_RESTART': '1', 22:24:07 INFO - 'PAGER': '/bin/cat', 22:24:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:07 INFO - 'PWD': '/builds/slave/test', 22:24:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:07 INFO - 'SHELL': '/bin/bash', 22:24:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:24:07 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:24:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:07 INFO - 'USER': 'cltbld', 22:24:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:07 INFO - 'XPC_FLAGS': '0x0', 22:24:07 INFO - 'XPC_SERVICE_NAME': '0', 22:24:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:24:07 INFO - Cleaning up... 22:24:07 INFO - Return code: 0 22:24:07 INFO - Running post-action listener: _resource_record_post_action 22:24:07 INFO - Running post-action listener: _start_resource_monitoring 22:24:07 INFO - Starting resource monitoring. 22:24:07 INFO - [mozharness: 2016-09-22 05:24:07.290643Z] Finished create-virtualenv step (success) 22:24:07 INFO - [mozharness: 2016-09-22 05:24:07.291637Z] Running install step. 22:24:07 INFO - Running pre-action listener: _resource_record_pre_action 22:24:07 INFO - Running main action method: install 22:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:07 INFO - Reading from file tmpfile_stdout 22:24:07 INFO - Detecting whether we're running mozinstall >=1.0... 22:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:24:07 INFO - Reading from file tmpfile_stdout 22:24:07 INFO - Output received: 22:24:07 INFO - Usage: mozinstall [options] installer 22:24:07 INFO - Options: 22:24:07 INFO - -h, --help show this help message and exit 22:24:07 INFO - -d DEST, --destination=DEST 22:24:07 INFO - Directory to install application into. [default: 22:24:07 INFO - "/builds/slave/test"] 22:24:07 INFO - --app=APP Application being installed. [default: firefox] 22:24:07 INFO - mkdir: /builds/slave/test/build/application 22:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:24:41 INFO - Reading from file tmpfile_stdout 22:24:41 INFO - Output received: 22:24:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:24:41 INFO - Running post-action listener: _resource_record_post_action 22:24:41 INFO - [mozharness: 2016-09-22 05:24:41.347046Z] Finished install step (success) 22:24:41 INFO - [mozharness: 2016-09-22 05:24:41.347196Z] Running run-tests step. 22:24:41 INFO - Running pre-action listener: _resource_record_pre_action 22:24:41 INFO - Running main action method: run_tests 22:24:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:24:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:24:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:24:41 INFO - 2016-09-21 22:24:41.361 screenresolution[1646:7837] starting screenresolution argv=screenresolution get 22:24:41 INFO - 2016-09-21 22:24:41.364 screenresolution[1646:7837] Display 0: 1600x1200x32@60 22:24:41 INFO - 2016-09-21 22:24:41.370 screenresolution[1647:7839] starting screenresolution argv=screenresolution list 22:24:41 INFO - Available Modes on Display 0 22:24:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:24:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:24:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:24:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:24:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:24:41 INFO - Intel Iris: 22:24:41 INFO - Chipset Model: Intel Iris 22:24:41 INFO - Type: GPU 22:24:41 INFO - Bus: Built-In 22:24:41 INFO - VRAM (Dynamic, Max): 1536 MB 22:24:41 INFO - Vendor: Intel (0x8086) 22:24:41 INFO - Device ID: 0x0a2e 22:24:41 INFO - Revision ID: 0x0009 22:24:41 INFO - Displays: 22:24:41 INFO - Display: 22:24:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:24:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:24:41 INFO - Display Serial Number: 1600x1200 60 22:24:41 INFO - Main Display: Yes 22:24:41 INFO - Mirror: Off 22:24:41 INFO - Online: Yes 22:24:41 INFO - Rotation: Supported 22:24:41 INFO - Return code: 0 22:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:24:41 INFO - Python 2.7.3 22:24:41 INFO - Return code: 0 22:24:41 INFO - grabbing minidump binary from tooltool 22:24:41 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')]} 22:24:41 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 0x104725d30>, '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 0x10454bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10471db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:24:41 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 22:24:41 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 22:24:41 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 22:24:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:24:41 INFO - Return code: 0 22:24:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:24:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:24:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:24:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:24:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0151 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s9x7sejPqR/Render', 22:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:24:41 INFO - 'HOME': '/Users/cltbld', 22:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:24:41 INFO - 'LOGNAME': 'cltbld', 22:24:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:24:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:41 INFO - 'MOZ_NO_REMOTE': '1', 22:24:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:24:41 INFO - 'NO_EM_RESTART': '1', 22:24:41 INFO - 'PAGER': '/bin/cat', 22:24:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:41 INFO - 'PWD': '/builds/slave/test', 22:24:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:24:41 INFO - 'SHELL': '/bin/bash', 22:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BVI3EYcPuk/Listeners', 22:24:41 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 22:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:24:41 INFO - 'USER': 'cltbld', 22:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:41 INFO - 'XPC_FLAGS': '0x0', 22:24:41 INFO - 'XPC_SERVICE_NAME': '0', 22:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:24:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:24:41 INFO - mozversion application_buildid: 20160921173859 22:24:41 INFO - mozversion application_changeset: 3b8cf1e729ef97ed49808f980bed542b81a3631e 22:24:41 INFO - mozversion application_display_name: Nightly 22:24:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:24:41 INFO - mozversion application_name: Firefox 22:24:41 INFO - mozversion application_remotingname: firefox 22:24:41 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 22:24:41 INFO - mozversion application_vendor: Mozilla 22:24:41 INFO - mozversion application_version: 52.0a1 22:24:41 INFO - mozversion platform_buildid: 20160921173859 22:24:41 INFO - mozversion platform_changeset: 3b8cf1e729ef97ed49808f980bed542b81a3631e 22:24:41 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 22:24:41 INFO - mozversion platform_version: 52.0a1 22:24:41 INFO - using testdate: 1474521881 22:24:41 INFO - actual date: 1474521881 22:24:41 INFO - starting webserver on 'localhost:49269' 22:24:41 INFO - SUITE-START | Running 2 tests 22:24:41 INFO - TEST-START | dromaeo_css 22:24:41 INFO - operating with platform_type : mac_ 22:24:41 INFO - Initialising browser for dromaeo_css test... 22:24:41 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp3CuQPD/profile http://localhost:49269/getInfo.html) 22:24:45 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 22:24:45 INFO - PROCESS | 1657 | colorDepth:24 22:24:45 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 22:24:45 INFO - PROCESS | 1657 | __metrics 22:24:45 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 22:24:45 INFO - TEST-INFO | 1657: exit 0 22:24:45 INFO - Browser initialized. 22:24:45 INFO - Running cycle 1/1 for dromaeo_css test... 22:24:45 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp3CuQPD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:24:58 INFO - PROCESS | 1660 | RSS: Main: 244068352 22:24:58 INFO - PROCESS | 1660 | 22:25:47 INFO - PROCESS | 1660 | 1474521947781 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:27:59 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 22:28:00 INFO - PROCESS | 1660 | RSS: Main: 257052672 22:28:00 INFO - PROCESS | 1660 | 22:31:03 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 22:31:03 INFO - PROCESS | 1660 | RSS: Main: 267538432 22:31:03 INFO - PROCESS | 1660 | 22:34:05 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 22:34:06 INFO - PROCESS | 1660 | RSS: Main: 272232448 22:34:06 INFO - PROCESS | 1660 | 22:37:08 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 22:37:08 INFO - PROCESS | 1660 | RSS: Main: 271654912 22:37:08 INFO - PROCESS | 1660 | 22:40:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 22:40:12 INFO - PROCESS | 1660 | RSS: Main: 276836352 22:40:12 INFO - PROCESS | 1660 | 22:43:15 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 22:43:15 INFO - PROCESS | 1660 | RSS: Main: 279949312 22:43:15 INFO - PROCESS | 1660 | 22:43:15 INFO - PROCESS | 1660 | __start_tp_report 22:43:15 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 22:43:15 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 22:43:15 INFO - PROCESS | 1660 | |i|pagename|runs| 22:43:15 INFO - PROCESS | 1660 | |0;dojo.html;3115.8909438169667;3233.900473838896;3332.3002169544393;3336.5662463879694;3380.5436266104084;4635.420572428447;5551.639143455683;5592;5636.971815140929;5672.546196304291;5606.971965140168;5668.971655141719;5674.205611214434;5762.366139724627;5807.941920580793;5083.618728595352;5151.639385243035;5178.611604129686;5221.71280579568;5270.578353731711;5181.145111056671;5284.339457567804;5286;5295.152775555912;5343.946560534403;5063.367079115111;5088.643794934356;5115.258287548322;5186.948130518703;5218.42597314297;5165.405978312467;5174.818881339173;5214.32213812202;5245.659032162897;5262.578993680497;4237.80929858154;5123.410807757118;5157.742112894378;5192.506711862367;5204.505571970657;4855.660103792736;5509.393966663663;5558.86102847428;5610.877824435089;5642.294713160855;6084.634921904656;6098.371716891094;6125.479334256594;6201.906971395388;6223.626582405071;6160.5071594272795;6170.352113028157;6171.13604095427;6188.690565471708;6191.752329906798;5586.55307575393;5735.111057786008;5741.684207368593;5746.741396637161;5770.798022069207;6139.492138333381;6144.986077297285;6150.753969841246;6171.444569988723;6231.875362492725;5944.7027648617395;6007.189029481052;6026.367231440723;6071.362506936796;6079.756809727562;6101.60339577926;6176.505879529627;6199.597026193283;6208.658523781145;6217.720202590895;6073.39266073398;6098.583513185022;6112.74665817949;6117.462039585284;6191.721372538246;6196.0705894115345;6205.503559715212;6221.595596286227;6226.346233645492;6260;4872.926906096412;4902.975485122623;4911.607071434277;4918.434380046269;4920.21276595743;4348.173846969065;4349.978250108729;4387.495438024668;4396.560343965642;4411.625011873963;5664.376918538957;5687.971560142256;5739.598228123991;5787.913181302284;5818.21454103699;6151.292601350902;6170.074488826712;6194.690265486708;6221.844453888599;6247.312795592481;5649.350324712711;5715.199872017921;5724.885502289931;5751.8562035949435;5798.88402231953;5326;5332.173513105475;5335.466453354634;5379.058664733734;5402.189671549299;6218.720157592919;6225.595336303126;6244.906326405016;6252.468540174045;6260.906086408708;6113.689152827286;6124.908126378197;6128.258691089182;6242.937570624417;6251.843703907257;6146.862830376394;6209.06719339988;6247.219097612799;6268.122462855113;6278.843028924313;5102.4897510248675;5557.138643510262;6096.177016102947;6109.236345456818;6186.041163619646;4843.418789745253;5034.370703662043;5467.917981230205;5907.818436312668;6088.756449741961;6070.514358851193;6113.816585502442;6138.987067134051;6169.383061693795;6175.505959523317;5467;5750;6090.086487026982;6105.694715264308;6135.202423684892;5168.3539557555305;5788.623739456922;5806.941930580809;5831.154482599914;5947.256592925884;6066.393360663898;6101;6116.548817443993;6128.594790794166;6141.263048434216;4996.2505624156665;5911.083782013795;5957.3744756799915;5983.640981541122;6003.939960600513 22:43:15 INFO - PROCESS | 1660 | |1;ext.html;460.3417113527655;488.7727206848817;493.9753012349384;522.6367674466247;548.3940246028137;34954.65045349549;40545.18909621809;42316.73049808507;44429.7778511107;44440.111587725325;43016.35475467863;43499.130017399635;43578;43612.56387436132;43743.56256437435;8340.74977750667;9967.700968970907;9969.00309969001;10005.149562287177;10030.247731420173;9807.509624518781;9882.407055576652;9902.405855648649;9902.405855648649;9911.454869982148;9872;9914.652987145415;9929.702108936743;9957.0540798624;9987.550560224807;9820.21438284939;9895.01049895012;9896.999999999927;9905.603775848957;9919.702408927707;8880.289576833839;9797.90202097977;9919.454430006346;9941.304108712393;9958;37803;38344.616553834385;41677;41736.16527669429;42727.786361068305;3329.3174899145615;3422.19578399076;3886.455896174538;4136.482939632546;4235.280002399569;30024.849875750482;30908.227294317596;31418.685813141805;31439.84280078585;31448.52827207594;3232.6444091149956;3346.748993825473;3383.1711230748624;3420.9657903421144;3423.8972830815114;486379;490096;493456;494092;495629.9999999964;61375;61379;61464.16090471398;61611.07583386253;61801.07298390528;63669.68165159145;64535.67732161309;64831.02753458702;64863.02705459422;64874.485668717745;15986;16146.354145834035;16157.838421615634;16175.919120404322;16225.026498410132;12923.353832308347;12978.675533111747;12984.415701293465;13022.153560018569;13029.283389413673;17064.57338566546;17464;17699.991001529772;17762.11189440523;17815.73276400855;5679.375268720438;6388.776392826228;6519.348065193442;6654.13496245485;6665.566738162004;721.5778769419948;858.7337925243195;893.65147592439;1005.1154983614518;1162.7441962768178;25348.619770703455;30170.84914575457;30187.849060754994;30282.697173028428;30967.535486967714;980.7499087732582;1023.1814548361281;1041.7083216699336;1063.9095676867553;1075.714935542082;15163.772543411858;15475.303611337516;15806.525804225892;15869.444569440015;15903.807214458962;695794;702555;710052;710501;712205;57441.42558574361;58290.708546457;58349;58402.415975840544;58468;1329.2556168545646;1354.688421663023;1366.5217173989224;1374.4502199120432;1381.1229869033036;23997.760022399554;25802.48395032051;29819.850900745358;31593;32294.677053229167;56086.878262433704;56651;56746.14880776874;56797;56968.715156423954;536582;542475;545094;547779;549163;26427.471450571265;27238;27376.726232738216;43080.92297692583;43667;47275;47776.5222347786;48340.79148021327;48941.77645558889;49072.263916040574;39353.60646393499;39388;40029.596744357514;40590.09968305454;41010.589894100674;39563.604363955994;39649;40418.79790601028;40739.185216294914;40797.592024080564;33514.329713406085;33896.322073557894;38364.61635383611;38520.42219366768;39133.60866391299;32492;32727.29089537384;35479.46780798342;35503.93488195358;35594.822025889705;25519.617205741557;25646.487070258117;25818.354541135872;25820.870895645403;26175.73824261733 22:43:15 INFO - PROCESS | 1660 | |2;jquery.html;351.40261555355903;361.42352947049454;372.080960028729;381.20328513406974;394.9348357521009;19654.803451965476;19883.502912427197;20502.89748551259;20795.896020519875;20909.790902090976;9979.650712225073;10183.134433573137;11866.82199767002;11890.10824188185;11896.167268291223;4434.467863856342;5421.268128802601;5443.074677304868;5493.011257973563;5501.5323697485765;3882.107115363468;4099.918001639965;5340.813071542497;5467.917981230265;5773.769049238046;5983.551233657471;6091.360407157251;6094.878102437949;6105.572609917308;6113.296970848342;5818.650880947135;6021.939780602203;6054.576179667425;6080.422359875849;6085.452309292163;5626.1842032905;5870.090136028923;5873.119032145212;5897.056470964625;5906.527477801766;12872.29202393868;13128.015398845126;13131.277779722112;13156.736865262737;13171.473141074346;2343.308723926446;2661.906833260846;2959.7632189424794;2966.2287805170813;2966.7478264347556;8891.822163556693;9064.776255205596;9825.803483930353;10308.433036183007;10308.94845525775;1803.1074618064142;1845.9907700461413;1874.2690350763214;1895.3176856331709;1921.2699174313811;78320.60839695766;87229;94952;105854;121782.99999999911;9961.904190539035;11113.277636953571;11137.721556960978;11160.218784684994;11398.316101033965;13104.2137471752;14119.082259653294;14177.936654750729;14180.503682371067;14243.572692819233;8222.38332125093;8458.407911446262;8495.490270583785;8620.698275560326;8639.784005399915;8451.957740211259;8477.194666506672;8519.787005324792;8625.439346442461;8678.958524976917;4330.826766929351;4427.158839820424;4464.17412778637;4471.8658440246845;4498.955010449919;1556.8754499640002;1639.14764322554;1865.5988962372883;1921.1258877210835;1933.806619338055;797.5055465611358;831.5675848558836;855.7389996051139;856.4433118473042;904.9683360968501;17911.910440447715;19225.615487690167;20044;21082.367528974155;21273.149074037174;897.1970086772302;918.3938600523622;930.4556834251903;950.2920324358397;1036.3574583758118;8978;10705.9464702676;11242.269252498561;11255.94372028151;11260.887391125983;554378;575162;587990;610826;612581;106416.63375444371;127646;129122;133104.33447832894;140886;914.8078903430221;929.6792606550729;939.4410325856105;950.7195377363694;988.9950550247347;19566.902165489082;19795.30716424918;19904.203831847142;19946.00269986524;20208.49478763043;57356;58488.707556461944;59117.40882591291;59439.70280148571;59854;84454;86056.56971715101;86538;88528.5573572128;88817;6768.796936091925;6966.407855332353;8012;8193.139720329518;8313.792155196168;10254.384736915808;11543.653690389301;12807;13282.53511127106;13427.992900532303;11019.453704164258;11111.277766945122;11216.270942388719;11369.602063927723;11528.308301501937;11112.722181945515;11359.829602556134;11379.715507112389;11388.088952883583;11617.825732614187;10847.945760271148;11270.380129092651;11414.801445848067;11653.359065251492;11838.28970261787;8033;8057.919420805717;8117.066537348044;8267.255946964802;8275.379346549153;10670.30643008202;11406.885931140914;11498.08015358786;11639.59261425846;11722.531098755955 22:43:15 INFO - PROCESS | 1660 | |3;mootools.html;1493.029530804977;1548.852858978397;1627.5442875994725;1751.9225676209135;1880.5956719305348;7912.485688430248;8161.347092232622;8327.500349978998;8841.646334146626;8857.158569935853;8355.665773369057;8634.568271586411;8652.610632521535;8711.695090671828;8755.737327880173;2355.1286024171036;2390.521895620874;2392.3779817247555;2399.6160614301716;2408.1089996701244;2364.7280562735245;2380.1907351500486;2400.9639855402183;2402.195264586357;2409.0363854458183;2374.9050037998545;2380.5000949800565;2387.3792813868345;2401.5917294059964;2404.4109193247677;2071.4200023993308;2313.2713195343413;2335.1826860598826;2353.6116540770754;2373.56089123511;2342.0865862313713;2343.1915988983774;2347.9647805282934;2349.77677120675;2354.1642716835618;8683.56582170889;8744.387892847502;8768;8785.077566855516;8786.341024423195;5126.384833819928;5225.372955245395;5283.577313814885;5297.417284098746;5310.70791106489;3018.381231847466;3527.682508574215;3574.946375804365;3600;3610.981945090284;1063.6596289187464;1070.5985255529176;1073.7369344510566;1090.4002798460815;1094.9890501094967;11175.329480231212;11187.832182517188;11254.381009044499;11260.21178517504;11275.718107047307;3897.7661340319673;4506.932396014063;4771.117343291433;4771.9522804772205;4789.8323558675975;9701.951490242503;9769.755756106011;9814.509274536245;9834.75413114678;9848;5287.920681189786;5291.497307755834;5299.470052994747;5300.231466437345;5301.416844147141;4322.459692538433;4482.439695038121;4659.673822832437;4804.279358096313;4847.563719265283;3849.3840985442193;3879.8836034919;3951.920961580752;3968.166684996183;4041.2725709372007;1152.6138743520846;1307.5685023942076;1326.4230059923964;1329.8005299205004;1335.1588499245413;775.3951917504243;888.2804928008334;906.5421961909194;912.3659056955353;942.8962814090445;5472.151816468374;5736.741846616912;5806.216160818235;5946.67293298864;6063.636181829104;843.8270154618289;931.993447077155;933.9673111441067;936.1995493852794;996.9850452243222;3510.3681337359008;3853.537575490959;3922.1175235572337;3941.428492868518;4005.098852758106;10178.389296642225;10645.893541064645;10652.414117223627;10661.307015043998;10716.357018578754;10613.5223914924;10652.573897044187;10670.946645266878;10676.145908327315;10682.465876706288;7709.42179336552;7960.40296977729;8071.596420179085;8076.353891688651;8097.595120243965;5390.326209223847;5947.318657274403;5971.178790468775;5991.281046274301;6089.54328425361;8384.58077096155;9223.35436519464;9709.854352184864;9904.306698531034;9951.601935922483;9883.703488895344;9936.056074672895;9944.30389872702;10107.3430227035;10175.949120254647;6835.521513494206;6901.275366086488;7390.6674199660065;7433.331000210007;7506.174320824595;8232.958835205785;8304.792380190544;8318.126596707258;8318.916810832055;8346.916530834615;7267.818304542428;7406.962965185139;7412.444066695128;7453.180150183584;7489.101307843093;7097.609631470319;7222.74720384784;7257.383122434441;7264.418846492163;7293.0519032525435;6822.317768223138;6837.589744615339;6927.44580433554;6934.479914006369;6939.583624982517;4899.289603007473;4955.380577427822;4962.975185124052;4964.702117872939;5015.22264049073;4818.349522814376;4855.271709243641;4941.209406494943;4957.405111386656;5073.467285935071 22:43:15 INFO - PROCESS | 1660 | |4;prototype.html;306.09853980028817;307.40517099412637;314.93228955774504;319.55581741379484;321.0176858812037;4769.356136921515;5414.16080507521;5436.75534600943;5486.862828429286;5567.777288908449;5255.947440525593;5396.217548455472;5417.485338892809;5449.427810079944;5469.015577196104;3711.2391959648207;4148.792560371984;4197.307444271692;4202.684798640114;4205.780323706122;3887.3974533947285;4112.773797441139;4210.852620158295;4226.429432026668;4235.83056677734;3545.4327307630783;3827.7320587558884;3828.966179131633;4089.6114869087387;4109.979450102745;4079.51045874494;4092.529359123694;4092.8362865485346;4126.731762435432;4148.075606697271;3140.277736120705;3409.897703068912;3546.3793836078585;3556.270964452307;3578.5169002184894;4493;5271.812197937851;5302.390225124122;5363.436839131913;5365.7585408656705;4068.9796551017353;4288.656907447396;4586.151561961048;4662.251655629139;4709.740964246965;5097.668651537638;5676.375598684142;5699.748599303293;5721.713914304268;5790.913136302959;3350.5979282486014;3601.5678118625933;3834.290656228579;3836.2135762168687;3849.268638958589;5328.0675881720545;5533.723313834333;5988.490978266853;6022.156898034279;6033.9396606033815;3352.3630510202984;3923.9607603924164;3956.0219890054973;3963.326234540135;3971.62269584389;3630.2557975614936;3806.562245341821;3854.7494412863075;3960.4257382679352;4006.3790112532606;4005.619466150711;4562.749048802281;4659.207934651117;4667.813287468532;4689.695169813951;5344.064788661969;5516.159178023321;5795.594308398456;5797.449242321973;5809.419058094157;1270.4092596942467;1274.7004453953498;1316.1905428161804;1354;1371.4240019191964;786.6302837666287;870.3994243971766;891.6789955615973;910.5704044649837;912.7398691372927;4604.953950460453;4933.802647894116;5300.549453296436;5311.814086507031;5312.335958005249;4948.505149485023;5268.604854635841;5340.91988620171;5687.289088863892;5796.710164491843;5087.19404611365;5290.206469029677;5298.311219541435;5310.309659744208;5349.384820745586;2540.720520742717;2564.44864354161;2584.4364159683123;2593.390553219992;2601.8178727488894;4195.496540415109;4702.694324868872;5030.849074527697;5049.368828896388;5087.720175390389;4973.303737476756;5001.349015218838;5035.77339019745;5668.461496157858;6166.784162554289;6097;6105.786297479655;6142.85000249909;6149.354317796567;6158;4935.259711043373;4984.700917944935;5239.869003274796;5513.42109078557;5971.343152253336;5605.299337582802;5780.94219057804;5800.344663952613;5875;5896.469317761422;5599.860003499945;6078.665673388006;6117.776444711165;6160.630362178284;6194.659293738888;3823.9235215296094;3880.4955355803563;3938.172983673346;3952.4782958560586;4008.2183974124764;5105.617078719037;5564.360098588714;5871.647701137946;5932.8813423732145;5947.977687586068;5357.517823395913;5366.785328586813;5589.9379117967455;5713.457221563945;5825.50483208932;4677.859664210079;5777.711114444345;5778.884422311614;5795.39148389413;5891.3224979127945;4505.752183629932;4599.563041511051;5349.839504814861;5690.2887139107615;5704.885902281848;4810.831620893252;5365.731713414391;5775.624584402;5863.1791549184;5886.205362276038;4937.876553086202;5674.148877668383;5675.375708672125;5695.800646977336;5706.543476521952 22:43:15 INFO - PROCESS | 1660 | |5;yui.html;626.4862812493755;675.7905049434676;728.792294196154;743.8661041012616;775.255754475704;12974.481020759182;13024.153430027054;14012.789808152886;14934.925325373371;16121.838781612181;11216.887831121687;14237.92881035596;15861.603459913507;15866.84133158668;16124;846.9280111190541;880.520116536486;881.2597418168737;882.4176043811086;883.4434306387;694.121935751275;713.9643017849113;865.4980111535294;872.6858331000834;875.9824803503926;886.1050339157465;916.097643820836;917.8164367126568;922.423485321674;929.6420877961966;776.192759530088;906.0667512462174;908.8136931928972;910.644848509082;916.3951791817368;673.1316601583951;677.4005005570057;682.576802382526;684.6782012454139;686.2622680618355;13803.619638036216;14287;15253.694926101527;15289.923550382287;15333.769993450107;11166.441677916071;13586.25275609841;13641.386137623731;13718.862811371959;13753.724925501534;12916.09587328878;13003.284819334933;13108.672283192996;13116.147450415692;13487;4506.143832671782;4521.683482156251;4596.770161491945;4721.740304283263;4734.526547345238;89325.55337223338;106425;108123.45938270337;108642;114821;10719.571217151382;10759.462026898624;10761.524849284708;10783.892161078445;11065.004149626573;20615.896920515603;20799;20810.063547140417;20879.47801304949;20894.686579701316;7683.654235559413;7728.343090837229;7808.854922510796;8089.352851771844;8134.511929284144;4450.376947227391;4483.484399294123;4493.326001099796;4524.932126018112;4534.050358345943;3362.411577973845;3430.468277417004;3470.7396945229207;3476.791392516457;3477.3914564951538;643.8197304754676;653.4249860123061;658.3285049249835;668.8829454845383;669.0098653992119;514.8172398798448;530.4271386902136;622.4335854372499;628.940250676185;629.7323637454064;7400.5189662671755;8314.501129932223;9072.546372681472;9103.681371151977;9170.633174673072;600.8047384600022;614.1524695919692;621.5742216581656;641.2721561028173;648.1509222917992;4298.161858437575;4387.758673273001;4450.777461126995;4493.146302202636;4602.1025899949855;139919;140019;142083.2895835535;145415;146137.2693136549;95302;115651;119999;120727;123683;98433.50783246038;102945;105370.47314763378;105430.94569054365;106521;9196.35625506208;9577.664781732607;9880.703578892644;9922.851157232502;9945.254105941938;57290.71354643367;58554.53613659522;59387;61764.764704706555;63225;86340;90107.54946225227;90184;92615.53692231496;96044.51977740067;13061.542846000344;13147.408366623717;13224;13236;13430.39563219677;14891.851081489047;15006.549803505912;15029.398824046915;15045.924770376078;15424.228788560751;13749.587512374645;13784.035117541676;13834.65413364674;13914.860851391357;13981.580552583438;13547.525836595672;13894.027418080637;14079.859201407855;14262.232396918971;14420.423183072979;13028.153170043917;13462.057655963989;13569.86430135686;13621.591352259447;13880.375383107583;10964.396958167059;11268.7746245073;11338.716532086433;11400.657980260605;11459.810284573141;8244.055916205221;9272.72181834546;10959.945200273947;11121.076233183856;11484.94257528707 22:43:15 INFO - PROCESS | 1660 | __end_tp_report 22:43:15 INFO - PROCESS | 1660 | __start_cc_report 22:43:15 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,356 22:43:15 INFO - PROCESS | 1660 | __end_cc_report 22:43:15 INFO - PROCESS | 1660 | __startTimestamp1474522995295__endTimestamp 22:43:15 INFO - PROCESS | 1660 | 22:43:15 INFO - PROCESS | 1660 | ------- Summary: start ------- 22:43:15 INFO - PROCESS | 1660 | Number of tests: 6 22:43:15 INFO - PROCESS | 1660 | 22:43:15 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5643.62 Median:5798.88 stddev:653.45 (11.3%) stddev-sans-first:624.64 22:43:15 INFO - PROCESS | 1660 | Values: 3115.9 3233.9 3332.3 3336.6 3380.5 4635.4 5551.6 5592.0 5637.0 5672.5 5607.0 5669.0 5674.2 5762.4 5807.9 5083.6 5151.6 5178.6 5221.7 5270.6 5181.1 5284.3 5286.0 5295.2 5343.9 5063.4 5088.6 5115.3 5186.9 5218.4 5165.4 5174.8 5214.3 5245.7 5262.6 4237.8 5123.4 5157.7 5192.5 5204.5 4855.7 5509.4 5558.9 5610.9 5642.3 6084.6 6098.4 6125.5 6201.9 6223.6 6160.5 6170.4 6171.1 6188.7 6191.8 5586.6 5735.1 5741.7 5746.7 5770.8 6139.5 6145.0 6150.8 6171.4 6231.9 5944.7 6007.2 6026.4 6071.4 6079.8 6101.6 6176.5 6199.6 6208.7 6217.7 6073.4 6098.6 6112.7 6117.5 6191.7 6196.1 6205.5 6221.6 6226.3 6260.0 4872.9 4903.0 4911.6 4918.4 4920.2 4348.2 4350.0 4387.5 4396.6 4411.6 5664.4 5688.0 5739.6 5787.9 5818.2 6151.3 6170.1 6194.7 6221.8 6247.3 5649.4 5715.2 5724.9 5751.9 5798.9 5326.0 5332.2 5335.5 5379.1 5402.2 6218.7 6225.6 6244.9 6252.5 6260.9 6113.7 6124.9 6128.3 6242.9 6251.8 6146.9 6209.1 6247.2 6268.1 6278.8 5102.5 5557.1 6096.2 6109.2 6186.0 4843.4 5034.4 5467.9 5907.8 6088.8 6070.5 6113.8 6139.0 6169.4 6175.5 5467.0 5750.0 6090.1 6105.7 6135.2 5168.4 5788.6 5806.9 5831.2 5947.3 6066.4 6101.0 6116.5 6128.6 6141.3 4996.3 5911.1 5957.4 5983.6 6003.9 22:43:15 INFO - PROCESS | 1660 | 22:43:15 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:71818.74 Median:42026.45 stddev:157250.57 (374.2%) stddev-sans-first:157600.42 22:43:15 INFO - PROCESS | 1660 | Values: 460.3 488.8 494.0 522.6 548.4 34954.7 40545.2 42316.7 44429.8 44440.1 43016.4 43499.1 43578.0 43612.6 43743.6 8340.7 9967.7 9969.0 10005.1 10030.2 9807.5 9882.4 9902.4 9902.4 9911.5 9872.0 9914.7 9929.7 9957.1 9987.6 9820.2 9895.0 9897.0 9905.6 9919.7 8880.3 9797.9 9919.5 9941.3 9958.0 37803.0 38344.6 41677.0 41736.2 42727.8 3329.3 3422.2 3886.5 4136.5 4235.3 30024.8 30908.2 31418.7 31439.8 31448.5 3232.6 3346.7 3383.2 3421.0 3423.9 486379.0 490096.0 493456.0 494092.0 495630.0 61375.0 61379.0 61464.2 61611.1 61801.1 63669.7 64535.7 64831.0 64863.0 64874.5 15986.0 16146.4 16157.8 16175.9 16225.0 12923.4 12978.7 12984.4 13022.2 13029.3 17064.6 17464.0 17700.0 17762.1 17815.7 5679.4 6388.8 6519.3 6654.1 6665.6 721.6 858.7 893.7 1005.1 1162.7 25348.6 30170.8 30187.8 30282.7 30967.5 980.7 1023.2 1041.7 1063.9 1075.7 15163.8 15475.3 15806.5 15869.4 15903.8 695794.0 702555.0 710052.0 710501.0 712205.0 57441.4 58290.7 58349.0 58402.4 58468.0 1329.3 1354.7 1366.5 1374.5 1381.1 23997.8 25802.5 29819.9 31593.0 32294.7 56086.9 56651.0 56746.1 56797.0 56968.7 536582.0 542475.0 545094.0 547779.0 549163.0 26427.5 27238.0 27376.7 43080.9 43667.0 47275.0 47776.5 48340.8 48941.8 49072.3 39353.6 39388.0 40029.6 40590.1 41010.6 39563.6 39649.0 40418.8 40739.2 40797.6 33514.3 33896.3 38364.6 38520.4 39133.6 32492.0 32727.3 35479.5 35503.9 35594.8 25519.6 25646.5 25818.4 25820.9 26175.7 22:43:15 INFO - PROCESS | 1660 | 22:43:15 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:33923.82 Median:2131.66 stddev:98214.17 (4607.4%) stddev-sans-first:98457.33 22:43:15 INFO - PROCESS | 1660 | Values: 351.4 361.4 372.1 381.2 394.9 19654.8 19883.5 20502.9 20795.9 20909.8 9979.7 10183.1 11866.8 11890.1 11896.2 4434.5 5421.3 5443.1 5493.0 5501.5 3882.1 4099.9 5340.8 5467.9 5773.8 5983.6 6091.4 6094.9 6105.6 6113.3 5818.7 6021.9 6054.6 6080.4 6085.5 5626.2 5870.1 5873.1 5897.1 5906.5 12872.3 13128.0 13131.3 13156.7 13171.5 2343.3 2661.9 2959.8 2966.2 2966.7 8891.8 9064.8 9825.8 10308.4 10308.9 1803.1 1846.0 1874.3 1895.3 1921.3 78320.6 87229.0 94952.0 105854.0 121783.0 9961.9 11113.3 11137.7 11160.2 11398.3 13104.2 14119.1 14177.9 14180.5 14243.6 8222.4 8458.4 8495.5 8620.7 8639.8 8452.0 8477.2 8519.8 8625.4 8679.0 4330.8 4427.2 4464.2 4471.9 4499.0 1556.9 1639.1 1865.6 1921.1 1933.8 797.5 831.6 855.7 856.4 905.0 17911.9 19225.6 20044.0 21082.4 21273.1 897.2 918.4 930.5 950.3 1036.4 8978.0 10705.9 11242.3 11255.9 11260.9 554378.0 575162.0 587990.0 610826.0 612581.0 106416.6 127646.0 129122.0 133104.3 140886.0 914.8 929.7 939.4 950.7 989.0 19566.9 19795.3 19904.2 19946.0 20208.5 57356.0 58488.7 59117.4 59439.7 59854.0 84454.0 86056.6 86538.0 88528.6 88817.0 6768.8 6966.4 8012.0 8193.1 8313.8 10254.4 11543.7 12807.0 13282.5 13428.0 11019.5 11111.3 11216.3 11369.6 11528.3 11112.7 11359.8 11379.7 11388.1 11617.8 10847.9 11270.4 11414.8 11653.4 11838.3 8033.0 8057.9 8117.1 8267.3 8275.4 10670.3 11406.9 11498.1 11639.6 11722.5 22:43:15 INFO - PROCESS | 1660 | 22:43:15 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5630.80 Median:5044.34 stddev:3125.30 (62.0%) stddev-sans-first:3118.60 22:43:15 INFO - PROCESS | 1660 | Values: 1493.0 1548.9 1627.5 1751.9 1880.6 7912.5 8161.3 8327.5 8841.6 8857.2 8355.7 8634.6 8652.6 8711.7 8755.7 2355.1 2390.5 2392.4 2399.6 2408.1 2364.7 2380.2 2401.0 2402.2 2409.0 2374.9 2380.5 2387.4 2401.6 2404.4 2071.4 2313.3 2335.2 2353.6 2373.6 2342.1 2343.2 2348.0 2349.8 2354.2 8683.6 8744.4 8768.0 8785.1 8786.3 5126.4 5225.4 5283.6 5297.4 5310.7 3018.4 3527.7 3574.9 3600.0 3611.0 1063.7 1070.6 1073.7 1090.4 1095.0 11175.3 11187.8 11254.4 11260.2 11275.7 3897.8 4506.9 4771.1 4772.0 4789.8 9702.0 9769.8 9814.5 9834.8 9848.0 5287.9 5291.5 5299.5 5300.2 5301.4 4322.5 4482.4 4659.7 4804.3 4847.6 3849.4 3879.9 3951.9 3968.2 4041.3 1152.6 1307.6 1326.4 1329.8 1335.2 775.4 888.3 906.5 912.4 942.9 5472.2 5736.7 5806.2 5946.7 6063.6 843.8 932.0 934.0 936.2 997.0 3510.4 3853.5 3922.1 3941.4 4005.1 10178.4 10645.9 10652.4 10661.3 10716.4 10613.5 10652.6 10670.9 10676.1 10682.5 7709.4 7960.4 8071.6 8076.4 8097.6 5390.3 5947.3 5971.2 5991.3 6089.5 8384.6 9223.4 9709.9 9904.3 9951.6 9883.7 9936.1 9944.3 10107.3 10175.9 6835.5 6901.3 7390.7 7433.3 7506.2 8233.0 8304.8 8318.1 8318.9 8346.9 7267.8 7407.0 7412.4 7453.2 7489.1 7097.6 7222.7 7257.4 7264.4 7293.1 6822.3 6837.6 6927.4 6934.5 6939.6 4899.3 4955.4 4963.0 4964.7 5015.2 4818.3 4855.3 4941.2 4957.4 5073.5 22:43:15 INFO - PROCESS | 1660 | 22:43:15 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4563.00 Median:5092.69 stddev:1427.32 (28.0%) stddev-sans-first:1395.10 22:43:15 INFO - PROCESS | 1660 | Values: 306.1 307.4 314.9 319.6 321.0 4769.4 5414.2 5436.8 5486.9 5567.8 5255.9 5396.2 5417.5 5449.4 5469.0 3711.2 4148.8 4197.3 4202.7 4205.8 3887.4 4112.8 4210.9 4226.4 4235.8 3545.4 3827.7 3829.0 4089.6 4110.0 4079.5 4092.5 4092.8 4126.7 4148.1 3140.3 3409.9 3546.4 3556.3 3578.5 4493.0 5271.8 5302.4 5363.4 5365.8 4069.0 4288.7 4586.2 4662.3 4709.7 5097.7 5676.4 5699.7 5721.7 5790.9 3350.6 3601.6 3834.3 3836.2 3849.3 5328.1 5533.7 5988.5 6022.2 6033.9 3352.4 3924.0 3956.0 3963.3 3971.6 3630.3 3806.6 3854.7 3960.4 4006.4 4005.6 4562.7 4659.2 4667.8 4689.7 5344.1 5516.2 5795.6 5797.4 5809.4 1270.4 1274.7 1316.2 1354.0 1371.4 786.6 870.4 891.7 910.6 912.7 4605.0 4933.8 5300.5 5311.8 5312.3 4948.5 5268.6 5340.9 5687.3 5796.7 5087.2 5290.2 5298.3 5310.3 5349.4 2540.7 2564.4 2584.4 2593.4 2601.8 4195.5 4702.7 5030.8 5049.4 5087.7 4973.3 5001.3 5035.8 5668.5 6166.8 6097.0 6105.8 6142.9 6149.4 6158.0 4935.3 4984.7 5239.9 5513.4 5971.3 5605.3 5780.9 5800.3 5875.0 5896.5 5599.9 6078.7 6117.8 6160.6 6194.7 3823.9 3880.5 3938.2 3952.5 4008.2 5105.6 5564.4 5871.6 5932.9 5948.0 5357.5 5366.8 5589.9 5713.5 5825.5 4677.9 5777.7 5778.9 5795.4 5891.3 4505.8 4599.6 5349.8 5690.3 5704.9 4810.8 5365.7 5775.6 5863.2 5886.2 4937.9 5674.1 5675.4 5695.8 5706.5 22:43:15 INFO - PROCESS | 1660 | 22:43:15 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:23912.19 Median:4342.96 stddev:37397.63 (861.1%) stddev-sans-first:37461.67 22:43:15 INFO - PROCESS | 1660 | Values: 626.5 675.8 728.8 743.9 775.3 12974.5 13024.2 14012.8 14934.9 16121.8 11216.9 14237.9 15861.6 15866.8 16124.0 846.9 880.5 881.3 882.4 883.4 694.1 714.0 865.5 872.7 876.0 886.1 916.1 917.8 922.4 929.6 776.2 906.1 908.8 910.6 916.4 673.1 677.4 682.6 684.7 686.3 13803.6 14287.0 15253.7 15289.9 15333.8 11166.4 13586.3 13641.4 13718.9 13753.7 12916.1 13003.3 13108.7 13116.1 13487.0 4506.1 4521.7 4596.8 4721.7 4734.5 89325.6 106425.0 108123.5 108642.0 114821.0 10719.6 10759.5 10761.5 10783.9 11065.0 20615.9 20799.0 20810.1 20879.5 20894.7 7683.7 7728.3 7808.9 8089.4 8134.5 4450.4 4483.5 4493.3 4524.9 4534.1 3362.4 3430.5 3470.7 3476.8 3477.4 643.8 653.4 658.3 668.9 669.0 514.8 530.4 622.4 628.9 629.7 7400.5 8314.5 9072.5 9103.7 9170.6 600.8 614.2 621.6 641.3 648.2 4298.2 4387.8 4450.8 4493.1 4602.1 139919.0 140019.0 142083.3 145415.0 146137.3 95302.0 115651.0 119999.0 120727.0 123683.0 98433.5 102945.0 105370.5 105430.9 106521.0 9196.4 9577.7 9880.7 9922.9 9945.3 57290.7 58554.5 59387.0 61764.8 63225.0 86340.0 90107.5 90184.0 92615.5 96044.5 13061.5 13147.4 13224.0 13236.0 13430.4 14891.9 15006.5 15029.4 15045.9 15424.2 13749.6 13784.0 13834.7 13914.9 13981.6 13547.5 13894.0 14079.9 14262.2 14420.4 13028.2 13462.1 13569.9 13621.6 13880.4 10964.4 11268.8 11338.7 11400.7 11459.8 8244.1 9272.7 10959.9 11121.1 11484.9 22:43:15 INFO - PROCESS | 1660 | -------- Summary: end -------- 22:43:15 INFO - PROCESS | 1660 | 22:43:15 INFO - TEST-INFO | 1660: exit 0 22:43:15 INFO - TEST-OK | dromaeo_css | took 1113961ms 22:43:15 INFO - TEST-START | kraken 22:43:15 INFO - operating with platform_type : mac_ 22:43:15 INFO - Initialising browser for kraken test... 22:43:15 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp0yMqwi/profile http://localhost:49269/getInfo.html) 22:43:18 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 22:43:18 INFO - PROCESS | 1668 | colorDepth:24 22:43:18 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 22:43:18 INFO - PROCESS | 1668 | __metrics 22:43:18 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 22:43:19 INFO - TEST-INFO | 1668: exit 0 22:43:19 INFO - Browser initialized. 22:43:19 INFO - Running cycle 1/1 for kraken test... 22:43:19 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp0yMqwi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:43:31 INFO - PROCESS | 1670 | RSS: Main: 244088832 22:43:31 INFO - PROCESS | 1670 | 22:43:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 22:43:35 INFO - PROCESS | 1670 | RSS: Main: 256024576 22:43:35 INFO - PROCESS | 1670 | 22:43:38 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 22:43:39 INFO - PROCESS | 1670 | RSS: Main: 263577600 22:43:39 INFO - PROCESS | 1670 | 22:43:42 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 22:43:42 INFO - PROCESS | 1670 | RSS: Main: 262180864 22:43:42 INFO - PROCESS | 1670 | 22:43:44 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 22:43:45 INFO - PROCESS | 1670 | RSS: Main: 264314880 22:43:45 INFO - PROCESS | 1670 | 22:43:47 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:43:48 INFO - PROCESS | 1670 | RSS: Main: 264658944 22:43:48 INFO - PROCESS | 1670 | 22:43:50 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 22:43:51 INFO - PROCESS | 1670 | RSS: Main: 265367552 22:43:51 INFO - PROCESS | 1670 | 22:43:54 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 22:43:54 INFO - PROCESS | 1670 | RSS: Main: 265273344 22:43:54 INFO - PROCESS | 1670 | 22:43:57 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 22:43:58 INFO - PROCESS | 1670 | RSS: Main: 265936896 22:43:58 INFO - PROCESS | 1670 | 22:44:00 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:44:00 INFO - PROCESS | 1670 | RSS: Main: 265195520 22:44:00 INFO - PROCESS | 1670 | 22:44:03 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:44:03 INFO - PROCESS | 1670 | RSS: Main: 265236480 22:44:03 INFO - PROCESS | 1670 | 22:44:05 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:44:06 INFO - PROCESS | 1670 | RSS: Main: 265199616 22:44:06 INFO - PROCESS | 1670 | 22:44:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:44:10 INFO - PROCESS | 1670 | RSS: Main: 265572352 22:44:10 INFO - PROCESS | 1670 | 22:44:13 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:44:14 INFO - PROCESS | 1670 | RSS: Main: 265347072 22:44:14 INFO - PROCESS | 1670 | 22:44:15 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 22:44:16 INFO - PROCESS | 1670 | RSS: Main: 266813440 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | __start_tp_report 22:44:16 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 22:44:16 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 22:44:16 INFO - PROCESS | 1670 | |i|pagename|runs| 22:44:16 INFO - PROCESS | 1670 | |0;ai-astar;114;118;119;117;117;119;97;169;173;109 22:44:16 INFO - PROCESS | 1670 | |1;audio-beat-detection;144;127;109;148;111;113;113;110;136;112 22:44:16 INFO - PROCESS | 1670 | |2;audio-dft;202;207;216;203;197;198;199;197;193;198 22:44:16 INFO - PROCESS | 1670 | |3;audio-fft;82;61;61;81;61;59;57;52;82;78 22:44:16 INFO - PROCESS | 1670 | |4;audio-oscillator;88;70;88;72;69;71;91;69;73;74 22:44:16 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;94;88;88;86;89;86;90;88;94;86 22:44:16 INFO - PROCESS | 1670 | |6;imaging-darkroom;95;96;95;96;96;96;97;116;116;95 22:44:16 INFO - PROCESS | 1670 | |7;imaging-desaturate;93;95;90;122;85;141;148;91;90;95 22:44:16 INFO - PROCESS | 1670 | |8;json-parse-financial;58;56;55;57;59;62;83;84;85;84 22:44:16 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;70;76;91;111;93;99;101;100;70;75 22:44:16 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;91;85;86;89;86;90;88;93;79;100 22:44:16 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;152;158;170;160;160;156;139;143;260;157 22:44:16 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;218;242;238;188;173;173;175;204;178;176 22:44:16 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;71;68;69;69;72;70;70;68;69;70 22:44:16 INFO - PROCESS | 1670 | __end_tp_report 22:44:16 INFO - PROCESS | 1670 | __start_cc_report 22:44:16 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,946 22:44:16 INFO - PROCESS | 1670 | __end_cc_report 22:44:16 INFO - PROCESS | 1670 | __startTimestamp1474523056176__endTimestamp 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | ------- Summary: start ------- 22:44:16 INFO - PROCESS | 1670 | Number of tests: 14 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:125.20 Median:119.00 stddev:25.05 (21.1%) stddev-sans-first:26.24 22:44:16 INFO - PROCESS | 1670 | Values: 114.0 118.0 119.0 117.0 117.0 119.0 97.0 169.0 173.0 109.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:120.00 stddev:15.19 (12.7%) stddev-sans-first:13.93 22:44:16 INFO - PROCESS | 1670 | Values: 144.0 127.0 109.0 148.0 111.0 113.0 113.0 110.0 136.0 112.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:201.00 Median:200.50 stddev:6.53 (3.3%) stddev-sans-first:6.92 22:44:16 INFO - PROCESS | 1670 | Values: 202.0 207.0 216.0 203.0 197.0 198.0 199.0 197.0 193.0 198.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:67.40 Median:69.50 stddev:11.84 (17.0%) stddev-sans-first:11.32 22:44:16 INFO - PROCESS | 1670 | Values: 82.0 61.0 61.0 81.0 61.0 59.0 57.0 52.0 82.0 78.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:73.50 stddev:8.81 (12.0%) stddev-sans-first:8.30 22:44:16 INFO - PROCESS | 1670 | Values: 88.0 70.0 88.0 72.0 69.0 71.0 91.0 69.0 73.0 74.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:88.90 Median:88.50 stddev:3.00 (3.4%) stddev-sans-first:2.55 22:44:16 INFO - PROCESS | 1670 | Values: 94.0 88.0 88.0 86.0 89.0 86.0 90.0 88.0 94.0 86.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:99.80 Median:96.00 stddev:8.56 (8.9%) stddev-sans-first:8.90 22:44:16 INFO - PROCESS | 1670 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 97.0 116.0 116.0 95.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:105.00 Median:90.50 stddev:23.15 (25.6%) stddev-sans-first:24.15 22:44:16 INFO - PROCESS | 1670 | Values: 93.0 95.0 90.0 122.0 85.0 141.0 148.0 91.0 90.0 95.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:68.30 Median:72.50 stddev:13.65 (18.8%) stddev-sans-first:13.96 22:44:16 INFO - PROCESS | 1670 | Values: 58.0 56.0 55.0 57.0 59.0 62.0 83.0 84.0 85.0 84.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:88.60 Median:75.50 stddev:14.74 (19.5%) stddev-sans-first:14.01 22:44:16 INFO - PROCESS | 1670 | Values: 70.0 76.0 91.0 111.0 93.0 99.0 101.0 100.0 70.0 75.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:88.50 stddev:5.54 (6.3%) stddev-sans-first:5.81 22:44:16 INFO - PROCESS | 1670 | Values: 91.0 85.0 86.0 89.0 86.0 90.0 88.0 93.0 79.0 100.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:165.50 Median:159.00 stddev:34.35 (21.6%) stddev-sans-first:36.09 22:44:16 INFO - PROCESS | 1670 | Values: 152.0 158.0 170.0 160.0 160.0 156.0 139.0 143.0 260.0 157.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.50 Median:196.00 stddev:27.31 (13.9%) stddev-sans-first:27.84 22:44:16 INFO - PROCESS | 1670 | Values: 218.0 242.0 238.0 188.0 173.0 173.0 175.0 204.0 178.0 176.0 22:44:16 INFO - PROCESS | 1670 | 22:44:16 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.26 (1.8%) stddev-sans-first:1.24 22:44:16 INFO - PROCESS | 1670 | Values: 71.0 68.0 69.0 69.0 72.0 70.0 70.0 68.0 69.0 70.0 22:44:16 INFO - PROCESS | 1670 | -------- Summary: end -------- 22:44:16 INFO - PROCESS | 1670 | 22:44:17 INFO - TEST-INFO | 1670: exit 0 22:44:17 INFO - TEST-OK | kraken | took 61132ms 22:44:17 INFO - SUITE-END | took 1175s 22:44:17 INFO - Completed test suite (00:19:35) 22:44:17 INFO - javascript benchmark 22:44:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7291.795821837089, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.8909438169667, 3233.900473838896, 3332.3002169544393, 3336.5662463879694, 3380.5436266104084, 4635.420572428447, 5551.639143455683, 5592.0, 5636.971815140929, 5672.546196304291, 5606.971965140168, 5668.971655141719, 5674.205611214434, 5762.366139724627, 5807.941920580793, 5083.618728595352, 5151.639385243035, 5178.611604129686, 5221.71280579568, 5270.578353731711, 5181.145111056671, 5284.339457567804, 5286.0, 5295.152775555912, 5343.946560534403, 5063.367079115111, 5088.643794934356, 5115.258287548322, 5186.948130518703, 5218.42597314297, 5165.405978312467, 5174.818881339173, 5214.32213812202, 5245.659032162897, 5262.578993680497, 4237.80929858154, 5123.410807757118, 5157.742112894378, 5192.506711862367, 5204.505571970657, 4855.660103792736, 5509.393966663663, 5558.86102847428, 5610.877824435089, 5642.294713160855, 6084.634921904656, 6098.371716891094, 6125.479334256594, 6201.906971395388, 6223.626582405071, 6160.5071594272795, 6170.352113028157, 6171.13604095427, 6188.690565471708, 6191.752329906798, 5586.55307575393, 5735.111057786008, 5741.684207368593, 5746.741396637161, 5770.798022069207, 6139.492138333381, 6144.986077297285, 6150.753969841246, 6171.444569988723, 6231.875362492725, 5944.7027648617395, 6007.189029481052, 6026.367231440723, 6071.362506936796, 6079.756809727562, 6101.60339577926, 6176.505879529627, 6199.597026193283, 6208.658523781145, 6217.720202590895, 6073.39266073398, 6098.583513185022, 6112.74665817949, 6117.462039585284, 6191.721372538246, 6196.0705894115345, 6205.503559715212, 6221.595596286227, 6226.346233645492, 6260.0, 4872.926906096412, 4902.975485122623, 4911.607071434277, 4918.434380046269, 4920.21276595743, 4348.173846969065, 4349.978250108729, 4387.495438024668, 4396.560343965642, 4411.625011873963, 5664.376918538957, 5687.971560142256, 5739.598228123991, 5787.913181302284, 5818.21454103699, 6151.292601350902, 6170.074488826712, 6194.690265486708, 6221.844453888599, 6247.312795592481, 5649.350324712711, 5715.199872017921, 5724.885502289931, 5751.8562035949435, 5798.88402231953, 5326.0, 5332.173513105475, 5335.466453354634, 5379.058664733734, 5402.189671549299, 6218.720157592919, 6225.595336303126, 6244.906326405016, 6252.468540174045, 6260.906086408708, 6113.689152827286, 6124.908126378197, 6128.258691089182, 6242.937570624417, 6251.843703907257, 6146.862830376394, 6209.06719339988, 6247.219097612799, 6268.122462855113, 6278.843028924313, 5102.4897510248675, 5557.138643510262, 6096.177016102947, 6109.236345456818, 6186.041163619646, 4843.418789745253, 5034.370703662043, 5467.917981230205, 5907.818436312668, 6088.756449741961, 6070.514358851193, 6113.816585502442, 6138.987067134051, 6169.383061693795, 6175.505959523317, 5467.0, 5750.0, 6090.086487026982, 6105.694715264308, 6135.202423684892, 5168.3539557555305, 5788.623739456922, 5806.941930580809, 5831.154482599914, 5947.256592925884, 6066.393360663898, 6101.0, 6116.548817443993, 6128.594790794166, 6141.263048434216, 4996.2505624156665, 5911.083782013795, 5957.3744756799915, 5983.640981541122, 6003.939960600513], "value": 5602.46693472159, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.3417113527655, 488.7727206848817, 493.9753012349384, 522.6367674466247, 548.3940246028137, 34954.65045349549, 40545.18909621809, 42316.73049808507, 44429.7778511107, 44440.111587725325, 43016.35475467863, 43499.130017399635, 43578.0, 43612.56387436132, 43743.56256437435, 8340.74977750667, 9967.700968970907, 9969.00309969001, 10005.149562287177, 10030.247731420173, 9807.509624518781, 9882.407055576652, 9902.405855648649, 9902.405855648649, 9911.454869982148, 9872.0, 9914.652987145415, 9929.702108936743, 9957.0540798624, 9987.550560224807, 9820.21438284939, 9895.01049895012, 9896.999999999927, 9905.603775848957, 9919.702408927707, 8880.289576833839, 9797.90202097977, 9919.454430006346, 9941.304108712393, 9958.0, 37803.0, 38344.616553834385, 41677.0, 41736.16527669429, 42727.786361068305, 3329.3174899145615, 3422.19578399076, 3886.455896174538, 4136.482939632546, 4235.280002399569, 30024.849875750482, 30908.227294317596, 31418.685813141805, 31439.84280078585, 31448.52827207594, 3232.6444091149956, 3346.748993825473, 3383.1711230748624, 3420.9657903421144, 3423.8972830815114, 486379.0, 490096.0, 493456.0, 494092.0, 495629.9999999964, 61375.0, 61379.0, 61464.16090471398, 61611.07583386253, 61801.07298390528, 63669.68165159145, 64535.67732161309, 64831.02753458702, 64863.02705459422, 64874.485668717745, 15986.0, 16146.354145834035, 16157.838421615634, 16175.919120404322, 16225.026498410132, 12923.353832308347, 12978.675533111747, 12984.415701293465, 13022.153560018569, 13029.283389413673, 17064.57338566546, 17464.0, 17699.991001529772, 17762.11189440523, 17815.73276400855, 5679.375268720438, 6388.776392826228, 6519.348065193442, 6654.13496245485, 6665.566738162004, 721.5778769419948, 858.7337925243195, 893.65147592439, 1005.1154983614518, 1162.7441962768178, 25348.619770703455, 30170.84914575457, 30187.849060754994, 30282.697173028428, 30967.535486967714, 980.7499087732582, 1023.1814548361281, 1041.7083216699336, 1063.9095676867553, 1075.714935542082, 15163.772543411858, 15475.303611337516, 15806.525804225892, 15869.444569440015, 15903.807214458962, 695794.0, 702555.0, 710052.0, 710501.0, 712205.0, 57441.42558574361, 58290.708546457, 58349.0, 58402.415975840544, 58468.0, 1329.2556168545646, 1354.688421663023, 1366.5217173989224, 1374.4502199120432, 1381.1229869033036, 23997.760022399554, 25802.48395032051, 29819.850900745358, 31593.0, 32294.677053229167, 56086.878262433704, 56651.0, 56746.14880776874, 56797.0, 56968.715156423954, 536582.0, 542475.0, 545094.0, 547779.0, 549163.0, 26427.471450571265, 27238.0, 27376.726232738216, 43080.92297692583, 43667.0, 47275.0, 47776.5222347786, 48340.79148021327, 48941.77645558889, 49072.263916040574, 39353.60646393499, 39388.0, 40029.596744357514, 40590.09968305454, 41010.589894100674, 39563.604363955994, 39649.0, 40418.79790601028, 40739.185216294914, 40797.592024080564, 33514.329713406085, 33896.322073557894, 38364.61635383611, 38520.42219366768, 39133.60866391299, 32492.0, 32727.29089537384, 35479.46780798342, 35503.93488195358, 35594.822025889705, 25519.617205741557, 25646.487070258117, 25818.354541135872, 25820.870895645403, 26175.73824261733], "value": 20279.672025396583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.40261555355903, 361.42352947049454, 372.080960028729, 381.20328513406974, 394.9348357521009, 19654.803451965476, 19883.502912427197, 20502.89748551259, 20795.896020519875, 20909.790902090976, 9979.650712225073, 10183.134433573137, 11866.82199767002, 11890.10824188185, 11896.167268291223, 4434.467863856342, 5421.268128802601, 5443.074677304868, 5493.011257973563, 5501.5323697485765, 3882.107115363468, 4099.918001639965, 5340.813071542497, 5467.917981230265, 5773.769049238046, 5983.551233657471, 6091.360407157251, 6094.878102437949, 6105.572609917308, 6113.296970848342, 5818.650880947135, 6021.939780602203, 6054.576179667425, 6080.422359875849, 6085.452309292163, 5626.1842032905, 5870.090136028923, 5873.119032145212, 5897.056470964625, 5906.527477801766, 12872.29202393868, 13128.015398845126, 13131.277779722112, 13156.736865262737, 13171.473141074346, 2343.308723926446, 2661.906833260846, 2959.7632189424794, 2966.2287805170813, 2966.7478264347556, 8891.822163556693, 9064.776255205596, 9825.803483930353, 10308.433036183007, 10308.94845525775, 1803.1074618064142, 1845.9907700461413, 1874.2690350763214, 1895.3176856331709, 1921.2699174313811, 78320.60839695766, 87229.0, 94952.0, 105854.0, 121782.99999999911, 9961.904190539035, 11113.277636953571, 11137.721556960978, 11160.218784684994, 11398.316101033965, 13104.2137471752, 14119.082259653294, 14177.936654750729, 14180.503682371067, 14243.572692819233, 8222.38332125093, 8458.407911446262, 8495.490270583785, 8620.698275560326, 8639.784005399915, 8451.957740211259, 8477.194666506672, 8519.787005324792, 8625.439346442461, 8678.958524976917, 4330.826766929351, 4427.158839820424, 4464.17412778637, 4471.8658440246845, 4498.955010449919, 1556.8754499640002, 1639.14764322554, 1865.5988962372883, 1921.1258877210835, 1933.806619338055, 797.5055465611358, 831.5675848558836, 855.7389996051139, 856.4433118473042, 904.9683360968501, 17911.910440447715, 19225.615487690167, 20044.0, 21082.367528974155, 21273.149074037174, 897.1970086772302, 918.3938600523622, 930.4556834251903, 950.2920324358397, 1036.3574583758118, 8978.0, 10705.9464702676, 11242.269252498561, 11255.94372028151, 11260.887391125983, 554378.0, 575162.0, 587990.0, 610826.0, 612581.0, 106416.63375444371, 127646.0, 129122.0, 133104.33447832894, 140886.0, 914.8078903430221, 929.6792606550729, 939.4410325856105, 950.7195377363694, 988.9950550247347, 19566.902165489082, 19795.30716424918, 19904.203831847142, 19946.00269986524, 20208.49478763043, 57356.0, 58488.707556461944, 59117.40882591291, 59439.70280148571, 59854.0, 84454.0, 86056.56971715101, 86538.0, 88528.5573572128, 88817.0, 6768.796936091925, 6966.407855332353, 8012.0, 8193.139720329518, 8313.792155196168, 10254.384736915808, 11543.653690389301, 12807.0, 13282.53511127106, 13427.992900532303, 11019.453704164258, 11111.277766945122, 11216.270942388719, 11369.602063927723, 11528.308301501937, 11112.722181945515, 11359.829602556134, 11379.715507112389, 11388.088952883583, 11617.825732614187, 10847.945760271148, 11270.380129092651, 11414.801445848067, 11653.359065251492, 11838.28970261787, 8033.0, 8057.919420805717, 8117.066537348044, 8267.255946964802, 8275.379346549153, 10670.30643008202, 11406.885931140914, 11498.08015358786, 11639.59261425846, 11722.531098755955], "value": 9153.332064953252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.029530804977, 1548.852858978397, 1627.5442875994725, 1751.9225676209135, 1880.5956719305348, 7912.485688430248, 8161.347092232622, 8327.500349978998, 8841.646334146626, 8857.158569935853, 8355.665773369057, 8634.568271586411, 8652.610632521535, 8711.695090671828, 8755.737327880173, 2355.1286024171036, 2390.521895620874, 2392.3779817247555, 2399.6160614301716, 2408.1089996701244, 2364.7280562735245, 2380.1907351500486, 2400.9639855402183, 2402.195264586357, 2409.0363854458183, 2374.9050037998545, 2380.5000949800565, 2387.3792813868345, 2401.5917294059964, 2404.4109193247677, 2071.4200023993308, 2313.2713195343413, 2335.1826860598826, 2353.6116540770754, 2373.56089123511, 2342.0865862313713, 2343.1915988983774, 2347.9647805282934, 2349.77677120675, 2354.1642716835618, 8683.56582170889, 8744.387892847502, 8768.0, 8785.077566855516, 8786.341024423195, 5126.384833819928, 5225.372955245395, 5283.577313814885, 5297.417284098746, 5310.70791106489, 3018.381231847466, 3527.682508574215, 3574.946375804365, 3600.0, 3610.981945090284, 1063.6596289187464, 1070.5985255529176, 1073.7369344510566, 1090.4002798460815, 1094.9890501094967, 11175.329480231212, 11187.832182517188, 11254.381009044499, 11260.21178517504, 11275.718107047307, 3897.7661340319673, 4506.932396014063, 4771.117343291433, 4771.9522804772205, 4789.8323558675975, 9701.951490242503, 9769.755756106011, 9814.509274536245, 9834.75413114678, 9848.0, 5287.920681189786, 5291.497307755834, 5299.470052994747, 5300.231466437345, 5301.416844147141, 4322.459692538433, 4482.439695038121, 4659.673822832437, 4804.279358096313, 4847.563719265283, 3849.3840985442193, 3879.8836034919, 3951.920961580752, 3968.166684996183, 4041.2725709372007, 1152.6138743520846, 1307.5685023942076, 1326.4230059923964, 1329.8005299205004, 1335.1588499245413, 775.3951917504243, 888.2804928008334, 906.5421961909194, 912.3659056955353, 942.8962814090445, 5472.151816468374, 5736.741846616912, 5806.216160818235, 5946.67293298864, 6063.636181829104, 843.8270154618289, 931.993447077155, 933.9673111441067, 936.1995493852794, 996.9850452243222, 3510.3681337359008, 3853.537575490959, 3922.1175235572337, 3941.428492868518, 4005.098852758106, 10178.389296642225, 10645.893541064645, 10652.414117223627, 10661.307015043998, 10716.357018578754, 10613.5223914924, 10652.573897044187, 10670.946645266878, 10676.145908327315, 10682.465876706288, 7709.42179336552, 7960.40296977729, 8071.596420179085, 8076.353891688651, 8097.595120243965, 5390.326209223847, 5947.318657274403, 5971.178790468775, 5991.281046274301, 6089.54328425361, 8384.58077096155, 9223.35436519464, 9709.854352184864, 9904.306698531034, 9951.601935922483, 9883.703488895344, 9936.056074672895, 9944.30389872702, 10107.3430227035, 10175.949120254647, 6835.521513494206, 6901.275366086488, 7390.6674199660065, 7433.331000210007, 7506.174320824595, 8232.958835205785, 8304.792380190544, 8318.126596707258, 8318.916810832055, 8346.916530834615, 7267.818304542428, 7406.962965185139, 7412.444066695128, 7453.180150183584, 7489.101307843093, 7097.609631470319, 7222.74720384784, 7257.383122434441, 7264.418846492163, 7293.0519032525435, 6822.317768223138, 6837.589744615339, 6927.44580433554, 6934.479914006369, 6939.583624982517, 4899.289603007473, 4955.380577427822, 4962.975185124052, 4964.702117872939, 5015.22264049073, 4818.349522814376, 4855.271709243641, 4941.209406494943, 4957.405111386656, 5073.467285935071], "value": 4545.100995203229, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.09853980028817, 307.40517099412637, 314.93228955774504, 319.55581741379484, 321.0176858812037, 4769.356136921515, 5414.16080507521, 5436.75534600943, 5486.862828429286, 5567.777288908449, 5255.947440525593, 5396.217548455472, 5417.485338892809, 5449.427810079944, 5469.015577196104, 3711.2391959648207, 4148.792560371984, 4197.307444271692, 4202.684798640114, 4205.780323706122, 3887.3974533947285, 4112.773797441139, 4210.852620158295, 4226.429432026668, 4235.83056677734, 3545.4327307630783, 3827.7320587558884, 3828.966179131633, 4089.6114869087387, 4109.979450102745, 4079.51045874494, 4092.529359123694, 4092.8362865485346, 4126.731762435432, 4148.075606697271, 3140.277736120705, 3409.897703068912, 3546.3793836078585, 3556.270964452307, 3578.5169002184894, 4493.0, 5271.812197937851, 5302.390225124122, 5363.436839131913, 5365.7585408656705, 4068.9796551017353, 4288.656907447396, 4586.151561961048, 4662.251655629139, 4709.740964246965, 5097.668651537638, 5676.375598684142, 5699.748599303293, 5721.713914304268, 5790.913136302959, 3350.5979282486014, 3601.5678118625933, 3834.290656228579, 3836.2135762168687, 3849.268638958589, 5328.0675881720545, 5533.723313834333, 5988.490978266853, 6022.156898034279, 6033.9396606033815, 3352.3630510202984, 3923.9607603924164, 3956.0219890054973, 3963.326234540135, 3971.62269584389, 3630.2557975614936, 3806.562245341821, 3854.7494412863075, 3960.4257382679352, 4006.3790112532606, 4005.619466150711, 4562.749048802281, 4659.207934651117, 4667.813287468532, 4689.695169813951, 5344.064788661969, 5516.159178023321, 5795.594308398456, 5797.449242321973, 5809.419058094157, 1270.4092596942467, 1274.7004453953498, 1316.1905428161804, 1354.0, 1371.4240019191964, 786.6302837666287, 870.3994243971766, 891.6789955615973, 910.5704044649837, 912.7398691372927, 4604.953950460453, 4933.802647894116, 5300.549453296436, 5311.814086507031, 5312.335958005249, 4948.505149485023, 5268.604854635841, 5340.91988620171, 5687.289088863892, 5796.710164491843, 5087.19404611365, 5290.206469029677, 5298.311219541435, 5310.309659744208, 5349.384820745586, 2540.720520742717, 2564.44864354161, 2584.4364159683123, 2593.390553219992, 2601.8178727488894, 4195.496540415109, 4702.694324868872, 5030.849074527697, 5049.368828896388, 5087.720175390389, 4973.303737476756, 5001.349015218838, 5035.77339019745, 5668.461496157858, 6166.784162554289, 6097.0, 6105.786297479655, 6142.85000249909, 6149.354317796567, 6158.0, 4935.259711043373, 4984.700917944935, 5239.869003274796, 5513.42109078557, 5971.343152253336, 5605.299337582802, 5780.94219057804, 5800.344663952613, 5875.0, 5896.469317761422, 5599.860003499945, 6078.665673388006, 6117.776444711165, 6160.630362178284, 6194.659293738888, 3823.9235215296094, 3880.4955355803563, 3938.172983673346, 3952.4782958560586, 4008.2183974124764, 5105.617078719037, 5564.360098588714, 5871.647701137946, 5932.8813423732145, 5947.977687586068, 5357.517823395913, 5366.785328586813, 5589.9379117967455, 5713.457221563945, 5825.50483208932, 4677.859664210079, 5777.711114444345, 5778.884422311614, 5795.39148389413, 5891.3224979127945, 4505.752183629932, 4599.563041511051, 5349.839504814861, 5690.2887139107615, 5704.885902281848, 4810.831620893252, 5365.731713414391, 5775.624584402, 5863.1791549184, 5886.205362276038, 4937.876553086202, 5674.148877668383, 5675.375708672125, 5695.800646977336, 5706.543476521952], "value": 4107.005200141221, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.4862812493755, 675.7905049434676, 728.792294196154, 743.8661041012616, 775.255754475704, 12974.481020759182, 13024.153430027054, 14012.789808152886, 14934.925325373371, 16121.838781612181, 11216.887831121687, 14237.92881035596, 15861.603459913507, 15866.84133158668, 16124.0, 846.9280111190541, 880.520116536486, 881.2597418168737, 882.4176043811086, 883.4434306387, 694.121935751275, 713.9643017849113, 865.4980111535294, 872.6858331000834, 875.9824803503926, 886.1050339157465, 916.097643820836, 917.8164367126568, 922.423485321674, 929.6420877961966, 776.192759530088, 906.0667512462174, 908.8136931928972, 910.644848509082, 916.3951791817368, 673.1316601583951, 677.4005005570057, 682.576802382526, 684.6782012454139, 686.2622680618355, 13803.619638036216, 14287.0, 15253.694926101527, 15289.923550382287, 15333.769993450107, 11166.441677916071, 13586.25275609841, 13641.386137623731, 13718.862811371959, 13753.724925501534, 12916.09587328878, 13003.284819334933, 13108.672283192996, 13116.147450415692, 13487.0, 4506.143832671782, 4521.683482156251, 4596.770161491945, 4721.740304283263, 4734.526547345238, 89325.55337223338, 106425.0, 108123.45938270337, 108642.0, 114821.0, 10719.571217151382, 10759.462026898624, 10761.524849284708, 10783.892161078445, 11065.004149626573, 20615.896920515603, 20799.0, 20810.063547140417, 20879.47801304949, 20894.686579701316, 7683.654235559413, 7728.343090837229, 7808.854922510796, 8089.352851771844, 8134.511929284144, 4450.376947227391, 4483.484399294123, 4493.326001099796, 4524.932126018112, 4534.050358345943, 3362.411577973845, 3430.468277417004, 3470.7396945229207, 3476.791392516457, 3477.3914564951538, 643.8197304754676, 653.4249860123061, 658.3285049249835, 668.8829454845383, 669.0098653992119, 514.8172398798448, 530.4271386902136, 622.4335854372499, 628.940250676185, 629.7323637454064, 7400.5189662671755, 8314.501129932223, 9072.546372681472, 9103.681371151977, 9170.633174673072, 600.8047384600022, 614.1524695919692, 621.5742216581656, 641.2721561028173, 648.1509222917992, 4298.161858437575, 4387.758673273001, 4450.777461126995, 4493.146302202636, 4602.1025899949855, 139919.0, 140019.0, 142083.2895835535, 145415.0, 146137.2693136549, 95302.0, 115651.0, 119999.0, 120727.0, 123683.0, 98433.50783246038, 102945.0, 105370.47314763378, 105430.94569054365, 106521.0, 9196.35625506208, 9577.664781732607, 9880.703578892644, 9922.851157232502, 9945.254105941938, 57290.71354643367, 58554.53613659522, 59387.0, 61764.764704706555, 63225.0, 86340.0, 90107.54946225227, 90184.0, 92615.53692231496, 96044.51977740067, 13061.542846000344, 13147.408366623717, 13224.0, 13236.0, 13430.39563219677, 14891.851081489047, 15006.549803505912, 15029.398824046915, 15045.924770376078, 15424.228788560751, 13749.587512374645, 13784.035117541676, 13834.65413364674, 13914.860851391357, 13981.580552583438, 13547.525836595672, 13894.027418080637, 14079.859201407855, 14262.232396918971, 14420.423183072979, 13028.153170043917, 13462.057655963989, 13569.86430135686, 13621.591352259447, 13880.375383107583, 10964.396958167059, 11268.7746245073, 11338.716532086433, 11400.657980260605, 11459.810284573141, 8244.055916205221, 9272.72181834546, 10959.945200273947, 11121.076233183856, 11484.94257528707], "value": 7742.342093089784, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 119.0, 117.0, 117.0, 119.0, 97.0, 169.0, 173.0, 109.0], "value": 125.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 127.0, 109.0, 148.0, 111.0, 113.0, 113.0, 110.0, 136.0, 112.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 207.0, 216.0, 203.0, 197.0, 198.0, 199.0, 197.0, 193.0, 198.0], "value": 201.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 61.0, 81.0, 61.0, 59.0, 57.0, 52.0, 82.0, 78.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 88.0, 72.0, 69.0, 71.0, 91.0, 69.0, 73.0, 74.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 88.0, 88.0, 86.0, 89.0, 86.0, 90.0, 88.0, 94.0, 86.0], "value": 88.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 116.0, 116.0, 95.0], "value": 99.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 90.0, 122.0, 85.0, 141.0, 148.0, 91.0, 90.0, 95.0], "value": 105.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 55.0, 57.0, 59.0, 62.0, 83.0, 84.0, 85.0, 84.0], "value": 68.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 91.0, 111.0, 93.0, 99.0, 101.0, 100.0, 70.0, 75.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 86.0, 89.0, 86.0, 90.0, 88.0, 93.0, 79.0, 100.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 158.0, 170.0, 160.0, 160.0, 156.0, 139.0, 143.0, 260.0, 157.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [218.0, 242.0, 238.0, 188.0, 173.0, 173.0, 175.0, 204.0, 178.0, 176.0], "value": 196.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 69.0, 69.0, 72.0, 70.0, 70.0, 68.0, 69.0, 70.0], "value": 69.6, "unit": "score"}]}]} 22:44:17 INFO - Return code: 0 22:44:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:44:17 ERROR - # TBPL SUCCESS # 22:44:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:44:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:44:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:44:17 INFO - 2016-09-21 22:44:17.516 screenresolution[1675:10765] starting screenresolution argv=screenresolution get 22:44:17 INFO - 2016-09-21 22:44:17.518 screenresolution[1675:10765] Display 0: 1600x1200x32@60 22:44:17 INFO - 2016-09-21 22:44:17.525 screenresolution[1676:10768] starting screenresolution argv=screenresolution list 22:44:17 INFO - Available Modes on Display 0 22:44:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:44:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:44:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:44:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:44:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:44:17 INFO - Intel Iris: 22:44:17 INFO - Chipset Model: Intel Iris 22:44:17 INFO - Type: GPU 22:44:17 INFO - Bus: Built-In 22:44:17 INFO - VRAM (Dynamic, Max): 1536 MB 22:44:17 INFO - Vendor: Intel (0x8086) 22:44:17 INFO - Device ID: 0x0a2e 22:44:17 INFO - Revision ID: 0x0009 22:44:17 INFO - Displays: 22:44:17 INFO - Display: 22:44:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:44:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:44:17 INFO - Display Serial Number: 1600x1200 60 22:44:17 INFO - Main Display: Yes 22:44:17 INFO - Mirror: Off 22:44:17 INFO - Online: Yes 22:44:17 INFO - Rotation: Supported 22:44:17 INFO - Return code: 0 22:44:17 INFO - Running post-action listener: _resource_record_post_action 22:44:17 INFO - [mozharness: 2016-09-22 05:44:17.761090Z] Finished run-tests step (success) 22:44:17 INFO - Running post-run listener: _resource_record_post_run 22:44:17 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 32922624; Write bytes: 704878592; Read time: 310; Write time: 2037 22:44:17 INFO - TinderboxPrint: CPU usage
54.8% 22:44:17 INFO - TinderboxPrint: I/O read bytes / time
32,922,624 / 310 22:44:17 INFO - TinderboxPrint: I/O write bytes / time
704,878,592 / 2,037 22:44:17 INFO - TinderboxPrint: CPU idle
2,188.5 (45.2%) 22:44:17 INFO - TinderboxPrint: CPU system
986.0 (20.4%) 22:44:17 INFO - TinderboxPrint: CPU user
1,663.2 (34.4%) 22:44:17 INFO - TinderboxPrint: Swap in / out
434,049,024 / 0 22:44:17 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 406196736; Write bytes: 407833600; Read time: 30059; Write time: 738 22:44:17 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 29113344; Write bytes: 295451648; Read time: 276; Write time: 1293 22:44:18 INFO - Running post-run listener: _upload_blobber_files 22:44:18 INFO - Blob upload gear active. 22:44:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:44:18 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 22:44:18 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:44:18 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:44:18 INFO - (blobuploader) - INFO - Open directory for files ... 22:44:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:44:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:44:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:19 INFO - (blobuploader) - INFO - Done attempting. 22:44:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:44:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:44:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:20 INFO - (blobuploader) - INFO - Done attempting. 22:44:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:44:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:44:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:44:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:44:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:44:22 INFO - (blobuploader) - INFO - Done attempting. 22:44:22 INFO - (blobuploader) - INFO - Iteration through files over. 22:44:22 INFO - Return code: 0 22:44:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:44:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:44:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/e7c3db2cb0e06cdb0df91b9322c09660911e26aed37e99a953c4e02cc9e3ac78c7ca31d32e722d5cd722e8e21ee44cb2d699cfa4dcebe75464523dfc2bb649ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/820ffd465e4cc9e404a916ec6b9e420f8fd8700f8c427bbef19274b1cb269875a5f3fdc37ca76f6720f03a2ea076de287d1562190fb80d21a44e1412f60c8157", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b1fc825b890bddab5c3552f8f0087976741e391a13372c77da1475901f92f3a5dbec413394cf5baf519b7bc1e7f6bb72bfaa58824153991aaf78810d31be7a3f"} 22:44:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:44:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:44:22 INFO - Contents: 22:44:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/e7c3db2cb0e06cdb0df91b9322c09660911e26aed37e99a953c4e02cc9e3ac78c7ca31d32e722d5cd722e8e21ee44cb2d699cfa4dcebe75464523dfc2bb649ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/820ffd465e4cc9e404a916ec6b9e420f8fd8700f8c427bbef19274b1cb269875a5f3fdc37ca76f6720f03a2ea076de287d1562190fb80d21a44e1412f60c8157", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b1fc825b890bddab5c3552f8f0087976741e391a13372c77da1475901f92f3a5dbec413394cf5baf519b7bc1e7f6bb72bfaa58824153991aaf78810d31be7a3f"} 22:44:22 INFO - Running post-run listener: copy_logs_to_upload_dir 22:44:22 INFO - Copying logs to upload dir... 22:44:22 INFO - mkdir: /builds/slave/test/build/upload/logs 22:44:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.688674 ========= master_lag: 1.99 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-21 22:44:24.990099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 22:44:24.993382) ========= 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.s9x7sejPqR/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.BVI3EYcPuk/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/e7c3db2cb0e06cdb0df91b9322c09660911e26aed37e99a953c4e02cc9e3ac78c7ca31d32e722d5cd722e8e21ee44cb2d699cfa4dcebe75464523dfc2bb649ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/820ffd465e4cc9e404a916ec6b9e420f8fd8700f8c427bbef19274b1cb269875a5f3fdc37ca76f6720f03a2ea076de287d1562190fb80d21a44e1412f60c8157", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b1fc825b890bddab5c3552f8f0087976741e391a13372c77da1475901f92f3a5dbec413394cf5baf519b7bc1e7f6bb72bfaa58824153991aaf78810d31be7a3f"} build_url:https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011039 build_url: 'https://queue.taskcluster.net/v1/task/KBFVjOghQDqmjl_I6boKvg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/e7c3db2cb0e06cdb0df91b9322c09660911e26aed37e99a953c4e02cc9e3ac78c7ca31d32e722d5cd722e8e21ee44cb2d699cfa4dcebe75464523dfc2bb649ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/820ffd465e4cc9e404a916ec6b9e420f8fd8700f8c427bbef19274b1cb269875a5f3fdc37ca76f6720f03a2ea076de287d1562190fb80d21a44e1412f60c8157", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b1fc825b890bddab5c3552f8f0087976741e391a13372c77da1475901f92f3a5dbec413394cf5baf519b7bc1e7f6bb72bfaa58824153991aaf78810d31be7a3f"}' ========= master_lag: 0.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 22:44:25.389194) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:44:25.389536) ========= 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.s9x7sejPqR/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.BVI3EYcPuk/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.005049 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:44:25.422546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 22:44:25.423035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 22:44:25.423527) ========= ========= Total master_lag: 2.47 =========