builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0166 starttime: 1474810686.44 results: success (0) buildid: 20160925041650 builduid: 1741ca0c43c74a9a8e254c688c139e0e revision: 5011b0476532fbc5b36a8d75e4618c7d040526cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:06.440250) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:06.440779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:06.441084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:06.838265) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:06.838628) ========= 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.41CLMOnFgj/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.JaSygNdjRl/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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-25 06:38:06-- 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% 8.74M=0.001s 2016-09-25 06:38:06 (8.74 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122570 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:07.064961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:07.065320) ========= 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.41CLMOnFgj/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.JaSygNdjRl/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.035431 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:07.144366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-25 06:38:07.144797) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5011b0476532fbc5b36a8d75e4618c7d040526cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 5011b0476532fbc5b36a8d75e4618c7d040526cd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.41CLMOnFgj/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.JaSygNdjRl/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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-25 06:38:07,232 truncating revision to first 12 chars 2016-09-25 06:38:07,232 Setting DEBUG logging. 2016-09-25 06:38:07,233 attempt 1/10 2016-09-25 06:38:07,233 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5011b0476532?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-25 06:38:08,060 unpacking tar archive at: autoland-5011b0476532/testing/mozharness/ program finished with exit code 0 elapsedTime=1.099517 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-25 06:38:08.323067) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:08.323398) ========= script_repo_revision: 5011b0476532fbc5b36a8d75e4618c7d040526cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:08.323845) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:08.324175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-25 06:38:08.505147) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-25 06:38:08.505606) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.41CLMOnFgj/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.JaSygNdjRl/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:38:08 INFO - MultiFileLogger online at 20160925 06:38:08 in /builds/slave/test 06:38:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 06:38:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:38:08 INFO - {'append_to_log': False, 06:38:08 INFO - 'base_work_dir': '/builds/slave/test', 06:38:08 INFO - 'blob_upload_branch': 'Autoland', 06:38:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:38:08 INFO - 'branch': 'Autoland', 06:38:08 INFO - 'buildbot_json_path': 'buildprops.json', 06:38:08 INFO - 'config_files': ('talos/mac_config.py',), 06:38:08 INFO - 'default_actions': ('clobber', 06:38:08 INFO - 'read-buildbot-config', 06:38:08 INFO - 'download-and-extract', 06:38:08 INFO - 'populate-webroot', 06:38:08 INFO - 'create-virtualenv', 06:38:08 INFO - 'install', 06:38:08 INFO - 'run-tests'), 06:38:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:38:08 INFO - 'download_minidump_stackwalk': True, 06:38:08 INFO - 'download_symbols': 'ondemand', 06:38:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:38:08 INFO - 'tooltool.py': '/tools/tooltool.py', 06:38:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:38:08 INFO - '/tools/misc-python/virtualenv.py')}, 06:38:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:38:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:38:08 INFO - 'installer_path': 'installer.exe', 06:38:08 INFO - 'log_level': 'info', 06:38:08 INFO - 'log_name': 'talos', 06:38:08 INFO - 'log_to_console': True, 06:38:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:38:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:38:08 INFO - 'opt_config_files': (), 06:38:08 INFO - 'pip_index': False, 06:38:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:38:08 INFO - 'cmd': ('bash', 06:38:08 INFO - '-c', 06:38:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:38:08 INFO - 'enabled': True, 06:38:08 INFO - 'halt_on_failure': False, 06:38:08 INFO - 'name': 'check_screen_resolution'},), 06:38:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:38:08 INFO - 'cmd': ('bash', 06:38:08 INFO - '-c', 06:38:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:38:08 INFO - 'enabled': True, 06:38:08 INFO - 'halt_on_failure': False, 06:38:08 INFO - 'name': 'check_screen_resolution'},), 06:38:08 INFO - 'run_cmd_checks_enabled': True, 06:38:08 INFO - 'sps_profile': False, 06:38:08 INFO - 'sps_profile_interval': 0, 06:38:08 INFO - 'suite': 'dromaeojs', 06:38:08 INFO - 'system_bits': '32', 06:38:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:38:08 INFO - 'title': 't-yosemite-r7-0166', 06:38:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:38:08 INFO - 'use_talos_json': True, 06:38:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:38:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:38:08 INFO - 'work_dir': 'build'} 06:38:08 INFO - [mozharness: 2016-09-25 13:38:08.720634Z] Running clobber step. 06:38:08 INFO - Running pre-action listener: _resource_record_pre_action 06:38:08 INFO - Running main action method: clobber 06:38:08 INFO - rmtree: /builds/slave/test/build 06:38:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:38:10 INFO - Running post-action listener: _resource_record_post_action 06:38:10 INFO - [mozharness: 2016-09-25 13:38:10.863207Z] Finished clobber step (success) 06:38:10 INFO - [mozharness: 2016-09-25 13:38:10.863413Z] Running read-buildbot-config step. 06:38:10 INFO - Running pre-action listener: _resource_record_pre_action 06:38:10 INFO - Running main action method: read_buildbot_config 06:38:10 INFO - Using buildbot properties: 06:38:10 INFO - { 06:38:10 INFO - "project": "", 06:38:10 INFO - "product": "firefox", 06:38:10 INFO - "script_repo_revision": "production", 06:38:10 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 06:38:10 INFO - "repository": "", 06:38:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 06:38:10 INFO - "buildid": "20160925041650", 06:38:10 INFO - "pgo_build": "False", 06:38:10 INFO - "basedir": "/builds/slave/test", 06:38:10 INFO - "buildnumber": 240, 06:38:10 INFO - "slavename": "t-yosemite-r7-0166", 06:38:10 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:38:10 INFO - "platform": "yosemite_r7", 06:38:10 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 06:38:10 INFO - "branch": "autoland", 06:38:10 INFO - "repo_path": "integration/autoland", 06:38:10 INFO - "revision": "5011b0476532fbc5b36a8d75e4618c7d040526cd", 06:38:10 INFO - "stage_platform": "macosx64", 06:38:10 INFO - "builduid": "1741ca0c43c74a9a8e254c688c139e0e", 06:38:10 INFO - "slavebuilddir": "test" 06:38:10 INFO - } 06:38:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:38:10 INFO - Running post-action listener: _resource_record_post_action 06:38:10 INFO - [mozharness: 2016-09-25 13:38:10.869002Z] Finished read-buildbot-config step (success) 06:38:10 INFO - [mozharness: 2016-09-25 13:38:10.869230Z] Running download-and-extract step. 06:38:10 INFO - Running pre-action listener: _resource_record_pre_action 06:38:10 INFO - Running main action method: download_and_extract 06:38:10 INFO - mkdir: /builds/slave/test/build/tests 06:38:10 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')]} 06:38:10 INFO - trying https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:38:10 INFO - Downloading https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/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 06:38:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/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 06:38:11 INFO - Downloaded 1199 bytes. 06:38:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:38:11 INFO - Using the following test package requirements: 06:38:11 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:38:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:38:11 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:38:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:38:11 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:38:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:38:11 INFO - u'jsshell-mac.zip'], 06:38:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:38:11 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:38:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:38:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:38:11 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:38:11 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:38:11 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:38:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:38:11 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:38:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:38:11 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:38:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:38:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:38:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:38:11 INFO - Fetch https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:38:12 INFO - Expected file size: 16438934 06:38:18 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 06:38:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:38:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:38:18 INFO - Fetch https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:38:19 INFO - Expected file size: 16438934 06:38:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:38:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:38:26 INFO - Fetch https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:38:26 INFO - Expected file size: 14414059 06:38:27 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')]} 06:38:27 INFO - trying https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:38:27 INFO - Downloading https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/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 06:38:32 INFO - Downloaded 111591733 bytes. 06:38:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:38:32 INFO - mkdir: /builds/slave/test/properties 06:38:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:38:32 INFO - Writing to file /builds/slave/test/properties/build_url 06:38:32 INFO - Contents: 06:38:32 INFO - build_url:https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:38:32 INFO - Running post-action listener: _resource_record_post_action 06:38:32 INFO - Running post-action listener: set_extra_try_arguments 06:38:32 INFO - [mozharness: 2016-09-25 13:38:32.793056Z] Finished download-and-extract step (success) 06:38:32 INFO - [mozharness: 2016-09-25 13:38:32.793176Z] Running populate-webroot step. 06:38:32 INFO - Running pre-action listener: _resource_record_pre_action 06:38:32 INFO - Running main action method: populate_webroot 06:38:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:38:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:38:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:38:32 INFO - '--tppagecycles', 06:38:32 INFO - '7'], 06:38:32 INFO - 'tests': ['tsvgm']}}, 06:38:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:38:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:38:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:38:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:38:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:32 INFO - 'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:38:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:32 INFO - 'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['damp', 'tps']}, 06:38:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:32 INFO - 'tests': ['damp', 'tps']}, 06:38:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['dromaeo_dom']}, 06:38:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:38:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['basic_compositor_video']}, 06:38:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:38:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['a11yr', 06:38:32 INFO - 'ts_paint', 06:38:32 INFO - 'tpaint', 06:38:32 INFO - 'sessionrestore', 06:38:32 INFO - 'sessionrestore_no_auto_restore', 06:38:32 INFO - 'tabpaint']}, 06:38:32 INFO - 'other-e10s': {'tests': ['a11yr', 06:38:32 INFO - 'ts_paint', 06:38:32 INFO - 'tpaint', 06:38:32 INFO - 'sessionrestore', 06:38:32 INFO - 'sessionrestore_no_auto_restore', 06:38:32 INFO - 'tabpaint']}, 06:38:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:38:32 INFO - 'ts_paint', 06:38:32 INFO - 'tpaint', 06:38:32 INFO - 'sessionrestore', 06:38:32 INFO - 'sessionrestore_no_auto_restore', 06:38:32 INFO - 'tabpaint']}, 06:38:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:38:32 INFO - 'ts_paint', 06:38:32 INFO - 'tpaint', 06:38:32 INFO - 'sessionrestore', 06:38:32 INFO - 'sessionrestore_no_auto_restore', 06:38:32 INFO - 'tabpaint']}, 06:38:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['a11yr', 06:38:32 INFO - 'ts_paint', 06:38:32 INFO - 'tpaint', 06:38:32 INFO - 'sessionrestore', 06:38:32 INFO - 'sessionrestore_no_auto_restore', 06:38:32 INFO - 'tabpaint']}, 06:38:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['a11yr', 06:38:32 INFO - 'ts_paint', 06:38:32 INFO - 'tpaint', 06:38:32 INFO - 'sessionrestore', 06:38:32 INFO - 'sessionrestore_no_auto_restore', 06:38:32 INFO - 'tabpaint']}, 06:38:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['tsvgx', 06:38:32 INFO - 'tsvgr_opacity', 06:38:32 INFO - 'tart', 06:38:32 INFO - 'tscrollx', 06:38:32 INFO - 'cart']}, 06:38:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:38:32 INFO - 'tsvgr_opacity', 06:38:32 INFO - 'tart', 06:38:32 INFO - 'tscrollx', 06:38:32 INFO - 'cart']}, 06:38:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:32 INFO - 'talos_options': ['--disable-e10s'], 06:38:32 INFO - 'tests': ['tp5o']}, 06:38:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:32 INFO - 'tests': ['tp5o']}, 06:38:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:32 INFO - 'talos_options': ['--disable-e10s', 06:38:32 INFO - '--xperf_path', 06:38:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:32 INFO - 'tests': ['tp5n']}, 06:38:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:38:32 INFO - 'talos_options': ['--xperf_path', 06:38:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:38:32 INFO - 'tests': ['tp5n']}}, 06:38:32 INFO - 'talos.zip': {'path': '', 06:38:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:38:32 INFO - Running post-action listener: _resource_record_post_action 06:38:32 INFO - [mozharness: 2016-09-25 13:38:32.812117Z] Finished populate-webroot step (success) 06:38:32 INFO - [mozharness: 2016-09-25 13:38:32.812214Z] Running create-virtualenv step. 06:38:32 INFO - Running pre-action listener: _resource_record_pre_action 06:38:32 INFO - Running main action method: create_virtualenv 06:38:32 INFO - Creating virtualenv /builds/slave/test/build/venv 06:38:32 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 06:38:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:38:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:38:32 INFO - Using real prefix '/tools/python27' 06:38:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:38:33 INFO - Installing distribute.............................................................................................................................................................................................done. 06:38:36 INFO - Installing pip.................done. 06:38:36 INFO - Return code: 0 06:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:38:36 INFO - Reading from file tmpfile_stdout 06:38:36 INFO - Output received: 06:38:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:38:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:36 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 0x10c85c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad485be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, '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.41CLMOnFgj/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.JaSygNdjRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:38:36 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 06:38:36 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 06:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:36 INFO - 'HOME': '/Users/cltbld', 06:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:36 INFO - 'LOGNAME': 'cltbld', 06:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:36 INFO - 'MOZ_NO_REMOTE': '1', 06:38:36 INFO - 'NO_EM_RESTART': '1', 06:38:36 INFO - 'PAGER': '/bin/cat', 06:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:36 INFO - 'PWD': '/builds/slave/test', 06:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:36 INFO - 'SHELL': '/bin/bash', 06:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:38:36 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:36 INFO - 'USER': 'cltbld', 06:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:36 INFO - 'XPC_FLAGS': '0x0', 06:38:36 INFO - 'XPC_SERVICE_NAME': '0', 06:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:37 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 06:38:37 INFO - Cleaning up... 06:38:37 INFO - Return code: 0 06:38:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:38:37 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')]} 06:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:37 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')]} 06:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:37 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 0x10c85c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad485be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, '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.41CLMOnFgj/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.JaSygNdjRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:38:37 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 06:38:37 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 06:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:37 INFO - 'HOME': '/Users/cltbld', 06:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:37 INFO - 'LOGNAME': 'cltbld', 06:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:37 INFO - 'MOZ_NO_REMOTE': '1', 06:38:37 INFO - 'NO_EM_RESTART': '1', 06:38:37 INFO - 'PAGER': '/bin/cat', 06:38:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:37 INFO - 'PWD': '/builds/slave/test', 06:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:37 INFO - 'SHELL': '/bin/bash', 06:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:38:37 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:37 INFO - 'USER': 'cltbld', 06:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:37 INFO - 'XPC_FLAGS': '0x0', 06:38:37 INFO - 'XPC_SERVICE_NAME': '0', 06:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:37 INFO - Downloading/unpacking psutil>=3.1.1 06:38:37 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 06:38:37 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 06:38:37 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 06:38:37 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 06:38:37 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 06:38:37 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 06:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:40 INFO - Installing collected packages: psutil 06:38:40 INFO - Running setup.py install for psutil 06:38:40 INFO - building 'psutil._psutil_osx' extension 06:38:40 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 06:38:41 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 06:38:41 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 06:38:41 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 06:38:41 INFO - building 'psutil._psutil_posix' extension 06:38:41 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 06:38:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:38:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:38:41 INFO - ^ 06:38:41 INFO - 1 warning generated. 06:38:41 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 06:38:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:38:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:38:41 INFO - Successfully installed psutil 06:38:42 INFO - Cleaning up... 06:38:42 INFO - Return code: 0 06:38:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:38:42 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')]} 06:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:42 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')]} 06:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:42 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 0x10c85c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad485be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, '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.41CLMOnFgj/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.JaSygNdjRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:38:42 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 06:38:42 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 06:38:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:38:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:42 INFO - 'HOME': '/Users/cltbld', 06:38:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:42 INFO - 'LOGNAME': 'cltbld', 06:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:42 INFO - 'MOZ_NO_REMOTE': '1', 06:38:42 INFO - 'NO_EM_RESTART': '1', 06:38:42 INFO - 'PAGER': '/bin/cat', 06:38:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:42 INFO - 'PWD': '/builds/slave/test', 06:38:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:42 INFO - 'SHELL': '/bin/bash', 06:38:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:38:42 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:38:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:42 INFO - 'USER': 'cltbld', 06:38:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:42 INFO - 'XPC_FLAGS': '0x0', 06:38:42 INFO - 'XPC_SERVICE_NAME': '0', 06:38:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:38:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:38:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:38:44 INFO - Installing collected packages: mozsystemmonitor 06:38:44 INFO - Running setup.py install for mozsystemmonitor 06:38:45 INFO - Successfully installed mozsystemmonitor 06:38:45 INFO - Cleaning up... 06:38:45 INFO - Return code: 0 06:38:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:38:45 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')]} 06:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:45 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')]} 06:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:45 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 0x10c85c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad485be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, '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.41CLMOnFgj/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.JaSygNdjRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:38:45 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 06:38:45 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 06:38:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:38:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:45 INFO - 'HOME': '/Users/cltbld', 06:38:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:45 INFO - 'LOGNAME': 'cltbld', 06:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:45 INFO - 'MOZ_NO_REMOTE': '1', 06:38:45 INFO - 'NO_EM_RESTART': '1', 06:38:45 INFO - 'PAGER': '/bin/cat', 06:38:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:45 INFO - 'PWD': '/builds/slave/test', 06:38:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:45 INFO - 'SHELL': '/bin/bash', 06:38:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:38:45 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:38:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:45 INFO - 'USER': 'cltbld', 06:38:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:45 INFO - 'XPC_FLAGS': '0x0', 06:38:45 INFO - 'XPC_SERVICE_NAME': '0', 06:38:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:45 INFO - Downloading/unpacking jsonschema==2.5.1 06:38:45 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 06:38:45 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 06:38:45 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 06:38:45 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 06:38:45 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 06:38:45 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 06:38:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:38:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:48 INFO - Downloading functools32-3.2.3-2.tar.gz 06:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:38:48 INFO - warning: no files found matching '*.txt' 06:38:48 INFO - no previously-included directories found matching 'build' 06:38:48 INFO - no previously-included directories found matching 'dist' 06:38:48 INFO - no previously-included directories found matching '.git*' 06:38:48 INFO - Installing collected packages: jsonschema, functools32 06:38:48 INFO - Running setup.py install for functools32 06:38:48 INFO - warning: no files found matching '*.txt' 06:38:48 INFO - no previously-included directories found matching 'build' 06:38:48 INFO - no previously-included directories found matching 'dist' 06:38:48 INFO - no previously-included directories found matching '.git*' 06:38:48 INFO - Successfully installed jsonschema functools32 06:38:48 INFO - Cleaning up... 06:38:48 INFO - Return code: 0 06:38:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:38:48 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')]} 06:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:48 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')]} 06:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:48 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 0x10c85c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad485be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, '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.41CLMOnFgj/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.JaSygNdjRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:38:48 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 06:38:48 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 06:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:48 INFO - 'HOME': '/Users/cltbld', 06:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:48 INFO - 'LOGNAME': 'cltbld', 06:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:48 INFO - 'MOZ_NO_REMOTE': '1', 06:38:48 INFO - 'NO_EM_RESTART': '1', 06:38:48 INFO - 'PAGER': '/bin/cat', 06:38:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:48 INFO - 'PWD': '/builds/slave/test', 06:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:48 INFO - 'SHELL': '/bin/bash', 06:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:38:48 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:48 INFO - 'USER': 'cltbld', 06:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:48 INFO - 'XPC_FLAGS': '0x0', 06:38:48 INFO - 'XPC_SERVICE_NAME': '0', 06:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:38:48 INFO - Cleaning up... 06:38:48 INFO - Return code: 0 06:38:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:38:48 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')]} 06:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:48 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')]} 06:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:48 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 0x10c85c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad485be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, '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.41CLMOnFgj/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.JaSygNdjRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:38:48 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 06:38:48 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 06:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:48 INFO - 'HOME': '/Users/cltbld', 06:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:48 INFO - 'LOGNAME': 'cltbld', 06:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:48 INFO - 'MOZ_NO_REMOTE': '1', 06:38:48 INFO - 'NO_EM_RESTART': '1', 06:38:48 INFO - 'PAGER': '/bin/cat', 06:38:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:48 INFO - 'PWD': '/builds/slave/test', 06:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:48 INFO - 'SHELL': '/bin/bash', 06:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:38:48 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:48 INFO - 'USER': 'cltbld', 06:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:48 INFO - 'XPC_FLAGS': '0x0', 06:38:48 INFO - 'XPC_SERVICE_NAME': '0', 06:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:49 INFO - Downloading/unpacking blobuploader==1.2.4 06:38:49 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 06:38:49 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 06:38:49 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 06:38:49 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 06:38:49 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 06:38:49 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 06:38:51 INFO - Downloading blobuploader-1.2.4.tar.gz 06:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:38:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38: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 06:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:38:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:38:52 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 06:38:52 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 06:38:52 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 06:38:52 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 06:38:52 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 06:38:52 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 06:38:52 INFO - Downloading docopt-0.6.1.tar.gz 06:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:38:52 INFO - Installing collected packages: blobuploader, requests, docopt 06:38:52 INFO - Running setup.py install for blobuploader 06:38:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:38:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:38:53 INFO - Running setup.py install for requests 06:38:53 INFO - Running setup.py install for docopt 06:38:53 INFO - Successfully installed blobuploader requests docopt 06:38:53 INFO - Cleaning up... 06:38:53 INFO - Return code: 0 06:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:53 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 0x10c85c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad485be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, '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.41CLMOnFgj/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.JaSygNdjRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:38:53 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 06:38:53 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 06:38:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:38:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:53 INFO - 'HOME': '/Users/cltbld', 06:38:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:53 INFO - 'LOGNAME': 'cltbld', 06:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:53 INFO - 'MOZ_NO_REMOTE': '1', 06:38:53 INFO - 'NO_EM_RESTART': '1', 06:38:53 INFO - 'PAGER': '/bin/cat', 06:38:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:53 INFO - 'PWD': '/builds/slave/test', 06:38:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:53 INFO - 'SHELL': '/bin/bash', 06:38:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:38:53 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:38:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:53 INFO - 'USER': 'cltbld', 06:38:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:53 INFO - 'XPC_FLAGS': '0x0', 06:38:53 INFO - 'XPC_SERVICE_NAME': '0', 06:38:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-JH2UDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-HDfMdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-ZHGh7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-kceX6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-snGt0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-f74Y_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-EBhvG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-VLTNao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:54 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-Ht_g_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-P9tXs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-nrYPoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-P7Lxff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-7OW24g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-W1mxGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-WLQ3_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-vXmM6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:38:55 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-uGrrD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:38:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:38:55 INFO - Running setup.py install for manifestparser 06:38:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:38:56 INFO - Running setup.py install for mozcrash 06:38:56 INFO - Running setup.py install for mozdebug 06:38:56 INFO - Running setup.py install for mozdevice 06:38:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:38:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:38:56 INFO - Running setup.py install for mozfile 06:38:56 INFO - Running setup.py install for mozhttpd 06:38:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:38:56 INFO - Running setup.py install for mozinfo 06:38:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:38:56 INFO - Running setup.py install for mozInstall 06:38:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:38:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:38:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:38:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:38:57 INFO - Running setup.py install for mozleak 06:38:57 INFO - Running setup.py install for mozlog 06:38:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:38:57 INFO - Running setup.py install for moznetwork 06:38:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:38:57 INFO - Running setup.py install for mozprocess 06:38:57 INFO - Running setup.py install for mozprofile 06:38:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:38:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:38:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:38:57 INFO - Running setup.py install for mozrunner 06:38:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:38:58 INFO - Running setup.py install for mozscreenshot 06:38:58 INFO - Running setup.py install for moztest 06:38:58 INFO - Running setup.py install for mozversion 06:38:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:38:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:38:58 INFO - Cleaning up... 06:38:58 INFO - Return code: 0 06:38:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:38:58 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 0x10c85c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad485be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, '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.41CLMOnFgj/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.JaSygNdjRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:38:58 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 06:38:58 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 06:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:38:58 INFO - 'HOME': '/Users/cltbld', 06:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:38:58 INFO - 'LOGNAME': 'cltbld', 06:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:38:58 INFO - 'MOZ_NO_REMOTE': '1', 06:38:58 INFO - 'NO_EM_RESTART': '1', 06:38:58 INFO - 'PAGER': '/bin/cat', 06:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:38:58 INFO - 'PWD': '/builds/slave/test', 06:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:38:58 INFO - 'SHELL': '/bin/bash', 06:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:38:58 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:38:58 INFO - 'USER': 'cltbld', 06:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:38:58 INFO - 'XPC_FLAGS': '0x0', 06:38:58 INFO - 'XPC_SERVICE_NAME': '0', 06:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:38:58 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-4PHG97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:38:58 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)) 06:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:38:58 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-gyFRXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:38:58 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)) 06:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:38:58 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-nSfXnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:38:59 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)) 06:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:38:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-_WOPem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:38:59 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)) 06:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:38:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-CwPA41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:38:59 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)) 06:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:38:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-rKBH1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:38:59 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)) 06:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:38:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-VqHpGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:38:59 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)) 06:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:38:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-wk7PuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:38:59 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)) 06:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:38:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-dFr6mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:38:59 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)) 06:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:38:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-9jXjRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:38:59 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)) 06:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:38:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-9TKzcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:38:59 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)) 06:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:38:59 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-dwhTDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:00 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)) 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:00 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-0TyLlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:00 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)) 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:00 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-YWV7aT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:00 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)) 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:00 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-JFqkvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:00 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)) 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:00 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-cYn9Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:00 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)) 06:39:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:00 INFO - Running setup.py (path:/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/pip-UNjYhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:00 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)) 06:39:00 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)) 06:39:00 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)) 06:39:00 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)) 06:39:00 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)) 06:39:00 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)) 06:39:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:39:00 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 06:39:00 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 06:39:00 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 06:39:00 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 06:39:00 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 06:39:00 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 06:39:02 INFO - Downloading blessings-1.6.tar.gz 06:39:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:39:03 INFO - Installing collected packages: blessings 06:39:03 INFO - Running setup.py install for blessings 06:39:03 INFO - Successfully installed blessings 06:39:03 INFO - Cleaning up... 06:39:03 INFO - Return code: 0 06:39:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:39:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:03 INFO - Reading from file tmpfile_stdout 06:39:03 INFO - Current package versions: 06:39:03 INFO - blessings == 1.6 06:39:03 INFO - blobuploader == 1.2.4 06:39:03 INFO - docopt == 0.6.1 06:39:03 INFO - functools32 == 3.2.3-2 06:39:03 INFO - jsonschema == 2.5.1 06:39:03 INFO - manifestparser == 1.1 06:39:03 INFO - mozInstall == 1.12 06:39:03 INFO - mozcrash == 0.17 06:39:03 INFO - mozdebug == 0.1 06:39:03 INFO - mozdevice == 0.48 06:39:03 INFO - mozfile == 1.2 06:39:03 INFO - mozhttpd == 0.7 06:39:03 INFO - mozinfo == 0.9 06:39:03 INFO - mozleak == 0.1 06:39:03 INFO - mozlog == 3.4 06:39:03 INFO - moznetwork == 0.27 06:39:03 INFO - mozprocess == 0.23 06:39:03 INFO - mozprofile == 0.28 06:39:03 INFO - mozrunner == 6.12 06:39:03 INFO - mozscreenshot == 0.1 06:39:03 INFO - mozsystemmonitor == 0.3 06:39:03 INFO - moztest == 0.7 06:39:03 INFO - mozversion == 1.4 06:39:03 INFO - psutil == 3.1.1 06:39:03 INFO - requests == 1.2.3 06:39:03 INFO - wsgiref == 0.1.2 06:39:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:03 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')]} 06:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:03 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')]} 06:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:03 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 0x10c85c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad485be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, '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.41CLMOnFgj/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.JaSygNdjRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:39:03 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 06:39:03 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 06:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:39:03 INFO - 'HOME': '/Users/cltbld', 06:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:39:03 INFO - 'LOGNAME': 'cltbld', 06:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:03 INFO - 'MOZ_NO_REMOTE': '1', 06:39:03 INFO - 'NO_EM_RESTART': '1', 06:39:03 INFO - 'PAGER': '/bin/cat', 06:39:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:03 INFO - 'PWD': '/builds/slave/test', 06:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:39:03 INFO - 'SHELL': '/bin/bash', 06:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:39:03 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:39:03 INFO - 'USER': 'cltbld', 06:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:03 INFO - 'XPC_FLAGS': '0x0', 06:39:03 INFO - 'XPC_SERVICE_NAME': '0', 06:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:04 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)) 06:39:04 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)) 06:39:04 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)) 06:39:04 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)) 06:39:04 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)) 06:39:04 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)) 06:39:04 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)) 06:39:04 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)) 06:39:04 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)) 06:39:04 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)) 06:39:04 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)) 06:39:04 INFO - Cleaning up... 06:39:04 INFO - Return code: 0 06:39:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:04 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 0x10c85c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7d2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad485be120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, '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.41CLMOnFgj/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.JaSygNdjRl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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 06:39:04 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 06:39:04 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 06:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:39:04 INFO - 'HOME': '/Users/cltbld', 06:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:39:04 INFO - 'LOGNAME': 'cltbld', 06:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:04 INFO - 'MOZ_NO_REMOTE': '1', 06:39:04 INFO - 'NO_EM_RESTART': '1', 06:39:04 INFO - 'PAGER': '/bin/cat', 06:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:04 INFO - 'PWD': '/builds/slave/test', 06:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:39:04 INFO - 'SHELL': '/bin/bash', 06:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:39:04 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:39:04 INFO - 'USER': 'cltbld', 06:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:04 INFO - 'XPC_FLAGS': '0x0', 06:39:04 INFO - 'XPC_SERVICE_NAME': '0', 06:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:39:04 INFO - Cleaning up... 06:39:04 INFO - Return code: 0 06:39:04 INFO - Running post-action listener: _resource_record_post_action 06:39:04 INFO - Running post-action listener: _start_resource_monitoring 06:39:04 INFO - Starting resource monitoring. 06:39:04 INFO - [mozharness: 2016-09-25 13:39:04.321849Z] Finished create-virtualenv step (success) 06:39:04 INFO - [mozharness: 2016-09-25 13:39:04.322743Z] Running install step. 06:39:04 INFO - Running pre-action listener: _resource_record_pre_action 06:39:04 INFO - Running main action method: install 06:39:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:04 INFO - Reading from file tmpfile_stdout 06:39:04 INFO - Detecting whether we're running mozinstall >=1.0... 06:39:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:39:04 INFO - Reading from file tmpfile_stdout 06:39:04 INFO - Output received: 06:39:04 INFO - Usage: mozinstall [options] installer 06:39:04 INFO - Options: 06:39:04 INFO - -h, --help show this help message and exit 06:39:04 INFO - -d DEST, --destination=DEST 06:39:04 INFO - Directory to install application into. [default: 06:39:04 INFO - "/builds/slave/test"] 06:39:04 INFO - --app=APP Application being installed. [default: firefox] 06:39:04 INFO - mkdir: /builds/slave/test/build/application 06:39:04 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'] 06:39:04 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 06:39:39 INFO - Reading from file tmpfile_stdout 06:39:39 INFO - Output received: 06:39:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:39:39 INFO - Running post-action listener: _resource_record_post_action 06:39:39 INFO - [mozharness: 2016-09-25 13:39:39.848883Z] Finished install step (success) 06:39:39 INFO - [mozharness: 2016-09-25 13:39:39.849010Z] Running run-tests step. 06:39:39 INFO - Running pre-action listener: _resource_record_pre_action 06:39:39 INFO - Running main action method: run_tests 06:39:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:39:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:39:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:39:39 INFO - 2016-09-25 06:39:39.862 screenresolution[1652:10265] starting screenresolution argv=screenresolution get 06:39:39 INFO - 2016-09-25 06:39:39.865 screenresolution[1652:10265] Display 0: 1600x1200x32@60 06:39:39 INFO - 2016-09-25 06:39:39.871 screenresolution[1653:10268] starting screenresolution argv=screenresolution list 06:39:39 INFO - Available Modes on Display 0 06:39:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:39:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:39:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:39:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:39:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:39:40 INFO - Intel Iris: 06:39:40 INFO - Chipset Model: Intel Iris 06:39:40 INFO - Type: GPU 06:39:40 INFO - Bus: Built-In 06:39:40 INFO - VRAM (Dynamic, Max): 1536 MB 06:39:40 INFO - Vendor: Intel (0x8086) 06:39:40 INFO - Device ID: 0x0a2e 06:39:40 INFO - Revision ID: 0x0009 06:39:40 INFO - Displays: 06:39:40 INFO - Display: 06:39:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:39:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:39:40 INFO - Display Serial Number: 1600x1200 60 06:39:40 INFO - Main Display: Yes 06:39:40 INFO - Mirror: Off 06:39:40 INFO - Online: Yes 06:39:40 INFO - Rotation: Supported 06:39:40 INFO - Return code: 0 06:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:39:40 INFO - Python 2.7.3 06:39:40 INFO - Return code: 0 06:39:40 INFO - grabbing minidump binary from tooltool 06:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:39:40 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 0x10c670d30>, '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 0x10c496db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c668b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:39:40 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 06:39:40 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 06:39:40 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 06:39:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:39:40 INFO - Return code: 0 06:39:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:39:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:39:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:39:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:39:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0166 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.41CLMOnFgj/Render', 06:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:39:40 INFO - 'HOME': '/Users/cltbld', 06:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:39:40 INFO - 'LOGNAME': 'cltbld', 06:39:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:39:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:40 INFO - 'MOZ_NO_REMOTE': '1', 06:39:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:39:40 INFO - 'NO_EM_RESTART': '1', 06:39:40 INFO - 'PAGER': '/bin/cat', 06:39:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:40 INFO - 'PWD': '/builds/slave/test', 06:39:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:39:40 INFO - 'SHELL': '/bin/bash', 06:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JaSygNdjRl/Listeners', 06:39:40 INFO - 'TMPDIR': '/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/', 06:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:39:40 INFO - 'USER': 'cltbld', 06:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:40 INFO - 'XPC_FLAGS': '0x0', 06:39:40 INFO - 'XPC_SERVICE_NAME': '0', 06:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:39:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0166', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:39:40 INFO - mozversion application_buildid: 20160925041650 06:39:40 INFO - mozversion application_changeset: 5011b0476532fbc5b36a8d75e4618c7d040526cd 06:39:40 INFO - mozversion application_display_name: Nightly 06:39:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:39:40 INFO - mozversion application_name: Firefox 06:39:40 INFO - mozversion application_remotingname: firefox 06:39:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:39:40 INFO - mozversion application_vendor: Mozilla 06:39:40 INFO - mozversion application_version: 52.0a1 06:39:40 INFO - mozversion platform_buildid: 20160925041650 06:39:40 INFO - mozversion platform_changeset: 5011b0476532fbc5b36a8d75e4618c7d040526cd 06:39:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:39:40 INFO - mozversion platform_version: 52.0a1 06:39:40 INFO - using testdate: 1474810780 06:39:40 INFO - actual date: 1474810780 06:39:40 INFO - starting webserver on 'localhost:49271' 06:39:40 INFO - SUITE-START | Running 2 tests 06:39:40 INFO - TEST-START | dromaeo_css 06:39:40 INFO - operating with platform_type : mac_ 06:39:40 INFO - Initialising browser for dromaeo_css test... 06:39:40 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpQVi6UO/profile http://localhost:49271/getInfo.html) 06:39:43 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 06:39:43 INFO - PROCESS | 1663 | colorDepth:24 06:39:43 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 06:39:43 INFO - PROCESS | 1663 | __metrics 06:39:43 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:39:43 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:39:43 INFO - TEST-INFO | 1663: exit 0 06:39:43 INFO - Browser initialized. 06:39:43 INFO - Running cycle 1/1 for dromaeo_css test... 06:39:43 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpQVi6UO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:55 INFO - PROCESS | 1666 | RSS: Main: 235139072 06:39:55 INFO - PROCESS | 1666 | 06:40:47 INFO - PROCESS | 1666 | 1474810847190 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] 06:42:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 06:42:59 INFO - PROCESS | 1666 | RSS: Main: 396144640 06:42:59 INFO - PROCESS | 1666 | 06:46:02 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 06:46:03 INFO - PROCESS | 1666 | RSS: Main: 372412416 06:46:03 INFO - PROCESS | 1666 | 06:49:05 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 06:49:06 INFO - PROCESS | 1666 | RSS: Main: 364208128 06:49:06 INFO - PROCESS | 1666 | 06:52:08 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 06:52:09 INFO - PROCESS | 1666 | RSS: Main: 343810048 06:52:09 INFO - PROCESS | 1666 | 06:55:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 06:55:13 INFO - PROCESS | 1666 | RSS: Main: 327221248 06:55:13 INFO - PROCESS | 1666 | 06:58:16 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 06:58:17 INFO - PROCESS | 1666 | RSS: Main: 479645696 06:58:17 INFO - PROCESS | 1666 | 06:58:17 INFO - PROCESS | 1666 | __start_tp_report 06:58:17 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 06:58:17 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 06:58:17 INFO - PROCESS | 1666 | |i|pagename|runs| 06:58:17 INFO - PROCESS | 1666 | |0;dojo.html;2583.5866261398173;3254.625718042426;3264.72249858762;3282.7537934654906;3323.3353329334122;5321.680699158053;5411.485908838654;5416.106342453495;5451.454854514542;5471.261379713737;5366.168243922189;5442.210879422481;5450.56395488361;5460.262864513289;5590.804321848736;4908.190148625473;4979.925301120486;5004.649674522785;5012.824551140701;5047.520485553885;4484.215262329096;4969.180085285923;5011.699298042111;5074.28959945606;5084.2373643953515;5005.324281222025;5047.596192304607;5067.797288108472;5101.51535604117;5119.923201151967;4943.901121977577;4951.480094590052;4967.627427942919;4967.751612419364;5023.070731914608;4959.553640172402;5033.345665063555;5037.748112594392;5052.9242061369105;5055.646104772667;5408.323959505062;5448.809291674812;5459.863503412406;5460.26286451328;5473.17902314652;5717;5900.527957763368;5905.527557795409;5905.877883202178;5979.1031345298115;5820.330661973842;5939.049752039653;5952.285725712899;5968.67172305523;6022.427869352405;4657.836975705902;5557.749901254413;5559.471850174227;5577.05190117681;5609.270794796691;6208.751649933952;6218.440340369389;6219.315875253718;6224.315325314303;6228.190335256479;5668.659880407189;5688.772449102073;5720.856978575569;5730.3410107838135;5734.283214598176;4910.508949105061;5974.61165024272;6000.699965001732;6023.427774361517;6049.425304596057;5875.823725288248;5876.471117599436;5899.351071382144;5900.4099590041515;5911.024680927599;5761.337446193657;5919.67441790697;5927.614705044159;5940.940590594125;5951.196588460589;4663;4693.413323334583;4704.835330763407;4706.882327941828;4752.500987396343;4257.510386305615;4276.5295817460055;4300.16146851361;4317.805698743564;4333.934990975138;5491.341039075257;5506.91739623906;5515.669059856422;5519.061759500894;5519.172124181325;5769.567282453832;5931.73307201177;5939.10913362999;6010.699465026819;6031.487323577545;4534.229181039232;5414.458554144554;5436.91844622331;5491.395946445888;5542.722863856791;5090.745462726849;5142.61430392722;5157.9684063187515;5164.122099243138;5191.558717508979;6119.84700382494;6173.079899545204;6200.844978875564;6217.285012223471;6223.159873417031;5848.210491583752;5887.941120588911;5923.318818335774;5935.970320148372;5939.613925094855;6202.224721909762;6210.937890621217;6222.377762223741;6234.376562343729;6244.781432649836;5810.186573879745;5820.679862607428;5822.70886455684;5829.970850145722;5849.5612829037145;5769.480746732815;5831.650100993954;5838.0966096729335;5865.736041878211;5908.468237858613;4860.805567777249;5797;5799.681017543907;5821.359650438364;5830.4461076197695;5770.826875193751;5774.1338799178775;5783.306003279465;5811.535077193899;5813.273340832396;5519.254900588529;5563.1655251710945;5613.522850557748;5631.1271752878365;5674.319081710056;5704.258446401941;5714.228579141763;5717.8570535736935;5770.3652598215;5839.124131380327;4725.220338644085;5474.452554744494;5578.051731205624;5622;5656.830295091154 06:58:17 INFO - PROCESS | 1666 | |1;ext.html;504.74510372262;522.9294045303885;525.2436491452308;525.731876742861;526.8735503479166;30578.776848926045;39654.80172599137;40919.59080409199;41049.794751026275;43032.35451468223;41612.583874161246;41921.79039104808;41973.53092641758;42045.789771051175;42079;8701.390902636786;9759.902400975989;9935.05616966387;9954.452505112216;9958.352707074053;7786.416018798613;8828.042605727089;8894.377393582452;8941.463512189257;8946.776330591754;11956.940215298911;12286.508539658404;12296.815547766791;12442.751144977095;12490.00079993603;12112.515499380013;12174.391280435988;12198.268103913793;12206.023518118529;12225.388730563436;11925.284482931052;11981.580644677395;12001.879981200163;12002.69993250167;12006.159568830186;39443.80278098591;39744.80127599373;39816.60183398158;39821.80534583967;39850.80074599638;3081.1218802641138;3138.4350816852957;3194.1535493094348;3326.334733053399;3431.828408579586;30292.394152116834;31166.532502012487;31673.84163079193;31762.364752704816;31836.04491865248;3201.6478187399366;3220.5813244278092;3233.7413006959387;3355.932881342384;3387.8814241501677;469301;469421;469531;471959;478926;32473;33129;33161;60093.39906600965;60509.39490605125;34157.829210853786;34655.82672086624;34670.13324666904;34780.82609586936;34845.477317840254;14242.501512447014;14384.28078596066;14388.28058597066;14394.856051439352;14396.920230982718;12147.392630368446;12248.38758062111;12257.142000060088;12270.079744019235;12275.2021118627;7136;7279.745208917662;7293.27067293277;7592;7657.310842024133;2706.972930270672;3195.2491164576304;3227.2254658881698;3228.257500774835;3230.2731885325616;877.1053525404052;902.4089221559889;932.2355668352022;944.568977998333;957.9329446938787;28274.85862570674;28673.856630716713;29265.683579105225;29342.706572933996;30167;879.4415546128126;1036.5957276662107;1059.8357254625546;1066.3631325914685;1180.5159884447335;13800.93099534516;14226.502072427415;14441;15308.158051307062;15848.018997625297;643405;647771;648240;649765;649873;57697.42302577005;58333.416665832796;58336;58483;58554.53613659607;1312.1339915655622;1354.8170996915487;1374.2853716067789;1375.7454870848926;1378.9724205516034;29287;29337.11988640344;29505.557416638338;30134.698653014068;30370.54444183295;50417.243741344646;50452.243216352515;50514.49485505098;50603.24095138502;50727.492725072276;536903;537871;538958.9156162739;538985;539696;24745.752542474343;25163.87418062971;25794.484110318062;25902.611460827724;25910.963561458084;45550;45927;46307;46670.29994550152;47410.52589474061;28849;38540.22919541538;38608.03479913025;38663.42004869985;38724.80637596794;38067.80966095152;38165.80917095508;39065.609343906195;39395;39415.408768867914;36999.52001919893;37928.62071379251;38598.6140138595;38660.6133938657;38715.80642096772;29871.103866884027;30223.69776302209;33274.66725332812;33678.49482257719;33744.66255337415;24584.75415245896;24643.507129856946;24862;25001.624975625746;25088.874555627106 06:58:17 INFO - PROCESS | 1666 | |2;jquery.html;342.2999965071432;355.253966669993;357.2604708253914;367.15920541958917;391.2839503708214;15273.847261527382;15571.29929153188;16920.91539542302;18417.723734143998;21074.367768966917;18503.722444163348;18698;20403;20407.897960510214;20637.277695280667;5801.6519008859395;5980.372060933604;6007.819765407023;6137.9386206137815;6140.478059364959;4731.243001119821;5822.854428639297;5948.7323070461935;6003.789867354643;6007.4893634041155;5955.553333499983;5970.1940238067955;5970.910436343458;5971.85070373242;5972.611780234271;7470.813229669247;7871.21287871214;7900;7919.881201781978;7997.520148791091;7401.185869554345;7520.736774212931;7717.459777815555;7721.305082542542;7739.419543534257;24637.876810616013;26591.936322547073;28295.15114546567;28494.28764280889;28630.427391452264;2355.305184970438;2842.701516340775;3318.286568387784;3351.6815902489225;3356;16605.50183494497;16640.251188696537;16911.91544042272;17142.571435714082;17142.742858857127;1793.4171394296775;1882.1812511557516;2007.65869802134;2019.4143698327468;2082.6415150448747;94349.41418334925;115532.84467155304;129805.99999999905;141394;156623.21688391487;18991.62016759657;21099.894500527706;21225.257116000867;21448.678269825967;21534.892325538272;34890.82554587211;34899.302013959576;35031.82484087563;35045;35097.771577994645;10134.391936483687;10688.198385121146;10842.403667798348;10894;11074.390908499949;8824;8850;8858.955705221433;9028.322875784343;9054.954725226464;8031.55826429552;9271.582778774971;9707.951460242653;9713.90286097144;9718.319717619841;3180.220845892771;3703.6481534254203;3715.3126671565847;3805.296020236265;3814.256220037066;757.394084732212;860.9827803443897;892.848215803315;902.4675441489553;909.1090731083575;17808.732869006973;19906.203751849764;20139.496512587302;20499.38501844947;23883;823.4318320358933;908.0329449136781;943.2925306020485;988.2637435110888;991.3853410885297;10936.781264374667;11237.600095613792;11352.432378381049;11377.544898204145;11394.145439091935;492084;574492;582994;583262;598870;72638;134101;135789.06978018896;136908;140706;953.828310904044;1008.9344192627309;1011.1607365886297;1020.3265844542715;1023.2581378500528;17865.196066177312;18625.44123676292;18664.34674786376;18689.53276168107;18745.250189992246;43967.78016109899;46950;55708.84325209533;56509.71745141248;57109.42890571041;81267;81889.9527511817;82534;85540.14459855322;86989.56505217687;8002.879956800769;8052.355811535181;8178.672853086048;8344.707935222237;8428.217636770361;10541.789164216827;12689.23864568129;12776.554733182273;13039.413226405024;13081.345932703136;11034.172437067413;11083.944580277048;11261.71845703864;11320.433978301216;11423.657290281304;9306.302027347841;10547.841782373423;10877.347359158475;10995.560177592806;11016.614418495314;10328.483575821328;11326.830097548378;11442.141839361915;11493.195476316578;11753;7965.601719913865;8043.316318113026;8059.194080591894;8188.754337369888;8416.989961204694;8302.584870756316;10786.406747628642;11335.886641133484;11358.54565817391;11484.253523520945 06:58:17 INFO - PROCESS | 1666 | |3;mootools.html;1343.583489118374;1526.854948779866;1535.4549135057055;1729.1527151695666;1897.8386837118853;7768.533887966719;8235.588220588968;8393.664253429855;8775.648974041047;8829.779255518615;7464.738734144306;8718.476891386505;8731;8745.650173993032;8763.51800650964;2330.82518811089;2386.451116243265;2391.7727815857465;2395.568797616428;2396.4727759892794;2336.474293284006;2376.9762302376926;2379.3218932604213;2386.486905315357;2389.104085967762;2349.1777877742825;2374.620060790274;2377.940551486209;2379.512199998996;2388.450656349041;2327.0924339507606;2350.5063936573342;2359.3511784259294;2360.409897525619;2372.5966585680303;2323.0591610397646;2344.1912540173785;2352.4001379648253;2356.1164563288767;2361.669366288721;8728.039915609277;8762.649494020232;8823.955880220621;8851.60167792451;8856.822863542693;5154.664946778485;5348.545373643206;5352.116900711378;5365.731713414314;5371.811986580451;3439.914002149966;3594.820258987066;3660.4875317455576;3673.0266479382985;3684.5025921500524;1045.7281106912183;1076.0530732955028;1079.4494807648157;1101.7355834599718;1103.9779204415868;11478.139139564566;11479.139064570107;11588.956993870508;11596.768064638743;11614.709632259177;4328.913421731548;4410.360497727812;4582.610478109332;4596.310553416947;4604;9051;9078.45529268246;9082.682106126254;9102.408343457653;9103.908960910307;5185.325907631984;5192.299039629677;5199;5199.818006369759;5205;4098.815553300109;4335.414719012956;4493.932591011137;4503.482099558527;4847.321375007502;3684.4473329000866;3725.7391982561503;3768.2086761779783;3808.409696497047;3811.9618803812164;1124.9381284029294;1128.8306753986967;1134.2173900008968;1140.0423644138964;1147.363213416545;844.957752112392;866.1338661338661;878.6090189865448;923.420950175208;930.3905941608258;5357.08929481989;5751.913721294184;5956.106584012433;5998.260504453659;6158.353372895782;348.70185990977853;417.6909087275394;437.2239275286392;442.1312121680912;447.4027173723051;3541.698955588804;3948.506436695413;3973.264945985002;4075.612816782401;4088.264112459786;10335.74160645975;10665.040146386862;10762.24664273509;10788.78422431547;10792.892071079188;10778.19163562736;10781.676549703521;10782.137429005661;10787.568497260021;10801.405922674172;7818.6090695465;8095.745159500287;8238.217369349903;8240.876386854203;8255.42212045163;5776.913346299725;5836.445537673914;5891.293044834647;5935.34711181761;5990.400959903975;9887.604495820087;9974.102330790263;9999.000099990233;10016.449095299828;10019.849702254327;8957.776055598402;9859.408435493893;10100.98990100984;10183;10272.640457583948;6141.539384546266;7020.684069216795;7022.297770222936;7086.114235720535;7086.4685148613025;8196.30331421812;8242.670293188205;8243.340532757486;8291.08798032204;8336.791580210544;6329.588576742497;6959.791206263821;6967.512274140761;7055.576665400093;7067.151941767021;7320.194778574459;7350.154732205865;7382.926170738224;7429.665665045194;7444.516106453063;6931.237563868071;7056.6118863463;7061.2938706131035;7066.470014748812;7068.257832927468;4878.634102442402;4969.602431805519;5019.874503137305;5053.065182941167;5251.212318152155;4863.294822250825;4914.877128071684;4975.6019518437715;5095.439501654889;5213.426523082534 06:58:17 INFO - PROCESS | 1666 | |4;prototype.html;249.8188813110494;274.2171101505203;306.4682775384708;310.3544627175475;310.72500836759474;5148.253503242027;5174.767135478903;5185.118529849925;5194.818181363653;5216.9478305216935;4005.09757865014;4355.673324500667;4964.578010869081;5028.924566131511;5168.2764412982215;3224.0972527692284;3755.3991361382186;3894.6689531389866;3905.4922860028155;3931.9017024574327;3433.948490772628;3923.3330333843314;3962.4650672159178;3978.9005274868214;4025.1144748155357;3135.2788858562544;3626.70986321095;3872.9930218143345;3893.4620824774197;3945.4476373307616;3431.9656803431894;3921.784301863396;3962.722609417342;3976.284268831609;3983.42240375144;3475.6524347565296;3493.1616412061176;3495.427057823964;3503.562054743157;3516.033090899997;4994.126027945095;5045.520675535819;5055.292259083694;5069.594432445396;5070.73231692077;3538.982305088484;4315.374270730757;4471.630036080883;4513.916660001576;4558.743422006095;4547.567981041796;5355.410904800468;5369.40936496985;5423.593230507728;5433.945660543383;3645.5989841117457;3779.1874746929543;3802.695784337274;3826.4260360945805;3839.654431101186;4497.96387438481;5373.1402975524115;5483.656504156467;5711.714414279311;5730.226419433407;3529.8941031769086;3823.5794062653085;3842.269968705937;3847.7306588539095;3851.9614803852164;3895.376739721631;3900.941485877714;3906.687465002793;3910.393888947218;3920.7059470539825;4321.395004699345;4450.844220452269;4498.685092043525;4503.504614492404;4508.549145085465;4033.015568479304;5228.869278267997;5404.189371594213;5424.701641409761;5437.401885792559;1309.9607011789662;1324.8277723896024;1328.8538260791306;1330.5476138112895;1333.8599447058114;776.9844603107906;846.3187134356901;870.2559311788457;881.413859783237;892.4243862708516;4696.459907110658;4893.336265669689;5010.223415370623;5016.498350164954;5039.697618142924;4942.851714448572;5206.947930520722;5358.169483730028;5389.5987043369005;5450.700211488327;4404.546499655106;4570.177368073779;4680.882977925579;4916.115099282092;4944.332515110414;2435.707715074167;2835.6597208335133;2853;2857.7856660750526;2899.072296864983;4872.342233798463;5038.6976781392505;5553.77784888608;5671.582104473881;5681.687507187062;4375.549692172393;4936.456989731127;5129.79480820763;5497.526113248974;5524.8342549722765;4748.121597504472;5413.242146099549;5480.342358916955;5532.30846144232;5554.277943867352;5176.896462070662;5197.4542673020305;5289.625270087612;5411.9717253721665;5431.972840135774;4315.244832154423;4895.5593996539055;4907.8466560359;5126.8974620508125;5336.493033161843;5354.732263386893;5391.137418013099;5503.174523821299;5612;5626.324841019104;3317.4692049272967;3797.3291751629195;3811.352070148026;3823.1780167264174;3827.27281816454;4905.533974272438;5129.846104616868;5517.44825517445;5522.5858060646415;5530.861728456821;4523.773811309487;4999.475055119306;5166.4316925138955;5397.541208997122;5411.594130440311;5159.819406320761;5321.946780532146;5380.946190538045;5389.353277606712;5396.865078373072;5020.974895125501;5050.292958985671;5253.317068781034;5277.683338999673;5303.416624171416;4560.817567297404;5136.332276804141;5216.365735303647;5272.235525848654;5374.4145477083575;4366.104948485617;5274.314339135888;5285.788568457372;5299.49654782795;5399.1665917199225 06:58:17 INFO - PROCESS | 1666 | |5;yui.html;690.5787469643519;698.1587187439134;698.514532399982;751.9511231769934;792.7265093542727;15233.238338083092;16010.279537420814;16018.75971860423;16029.958052726579;16032.839671603295;14482.42070317186;14494.637634059154;14521.636959076028;14521.910856685765;14682.265886705649;650.4991156809255;681.4344094401634;820.228984754332;832.2925513313666;835.1940377535677;808.49873078691;834.6536187482187;843.236870632079;847.1105339393612;847.1316900177337;895.0646574329841;895.9328050396247;896.4755617963499;896.5696465696469;899.3839220134229;887.3699673232013;890.1143362354434;891.4383938118943;891.8706787515806;892.5983307511646;509.17259453388243;528.3897098850833;628.1802248066272;650.187265917603;660.6531570925255;15037.097774133477;15457.922710386489;15461.922690386476;15479.071255724693;15510.767338489932;13656.726865462735;14040.508582199574;14189.716205675828;14212.360443780055;14262.85737142636;10949.945250273777;12527.248365098123;12984.28586427746;13143.211407315592;13143.474261029547;4497.23546997008;4534.591886730177;4588.954110458886;4653.650976176767;4676.275177347517;109170;109783.45108274487;110368.4481577595;111917;119812;10104.797904041878;10482.27042537988;11135.832962505569;11136.387498687487;11653.41732913351;21723.34829955104;22392.216272430713;22428.775712242994;22493.88753056257;22505.88747056287;7909.24862138096;7928.8810667840025;7953.483023603448;7988.920110798934;8063.032436107587;4379.408779814684;4424.336349547593;4465.665075119314;4607.516210797885;4623.653226008063;3511.17487390463;3654.780713157219;3658.926821463556;3661.139632186434;3667.7065834733157;599.2056810641111;640.3308542573022;650.067153634536;664.3157547725754;667.5060455263167;558.4638746803033;559.8600349912522;561.0322194214947;601.9413605469306;633.1104797759156;8768.298536117096;8940.821183576292;8957.462552246887;8960;9092.772680683036;560.9186667933209;573.0945106731355;608.3672980100735;613.7619735724827;627.5795217204393;4282.122164956177;4344.239758042393;4377.802998865059;4463.687541872103;4528.569785870337;135620;155447;163513;163687.1815640914;170842.31209595597;144207;144985;146904;147389;149409.50590493955;106484;122094.38952805357;123853;125075.61932855072;125407.37296313643;8038.644091284825;8476.915230847859;8484.406091573777;8517.536836556446;8722.65109395617;65263.347366527625;66866;68248.81014278319;69859.65070174617;70696.64651676708;94866;104438.47780761047;105692;107646.46176769379;107691.46154269179;11347.48936297852;11526.538938442704;11589.6523104307;11714.414279285831;11805.937465628134;11916;11935.224210426295;12030.63908082759;12195.390230488618;12613.30626815534;10608.416537090534;11890.28658280506;11934.880706040807;12260.203086799329;12446.688832778891;11099.94450027777;12742.171758836017;13284.86715132875;13395.933020334836;13567.321633918067;11507.539698412305;13215.339233038501;13303.933480332536;13338.932885368953;13653.931730341284;10298.176145908159;10936.56253749841;11441.199116061796;11443.084553235887;11469.942650287028;8291.917080829115;10933.671989840317;11298.870112988636;11458.073278143222;11540.422978850856 06:58:17 INFO - PROCESS | 1666 | __end_tp_report 06:58:17 INFO - PROCESS | 1666 | __start_cc_report 06:58:17 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1571 06:58:17 INFO - PROCESS | 1666 | __end_cc_report 06:58:17 INFO - PROCESS | 1666 | __startTimestamp1474811897084__endTimestamp 06:58:17 INFO - PROCESS | 1666 | 06:58:17 INFO - PROCESS | 1666 | ------- Summary: start ------- 06:58:17 INFO - PROCESS | 1666 | Number of tests: 6 06:58:17 INFO - PROCESS | 1666 | 06:58:17 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5461.18 Median:5613.52 stddev:630.53 (11.2%) stddev-sans-first:590.68 06:58:17 INFO - PROCESS | 1666 | Values: 2583.6 3254.6 3264.7 3282.8 3323.3 5321.7 5411.5 5416.1 5451.5 5471.3 5366.2 5442.2 5450.6 5460.3 5590.8 4908.2 4979.9 5004.6 5012.8 5047.5 4484.2 4969.2 5011.7 5074.3 5084.2 5005.3 5047.6 5067.8 5101.5 5119.9 4943.9 4951.5 4967.6 4967.8 5023.1 4959.6 5033.3 5037.7 5052.9 5055.6 5408.3 5448.8 5459.9 5460.3 5473.2 5717.0 5900.5 5905.5 5905.9 5979.1 5820.3 5939.0 5952.3 5968.7 6022.4 4657.8 5557.7 5559.5 5577.1 5609.3 6208.8 6218.4 6219.3 6224.3 6228.2 5668.7 5688.8 5720.9 5730.3 5734.3 4910.5 5974.6 6000.7 6023.4 6049.4 5875.8 5876.5 5899.4 5900.4 5911.0 5761.3 5919.7 5927.6 5940.9 5951.2 4663.0 4693.4 4704.8 4706.9 4752.5 4257.5 4276.5 4300.2 4317.8 4333.9 5491.3 5506.9 5515.7 5519.1 5519.2 5769.6 5931.7 5939.1 6010.7 6031.5 4534.2 5414.5 5436.9 5491.4 5542.7 5090.7 5142.6 5158.0 5164.1 5191.6 6119.8 6173.1 6200.8 6217.3 6223.2 5848.2 5887.9 5923.3 5936.0 5939.6 6202.2 6210.9 6222.4 6234.4 6244.8 5810.2 5820.7 5822.7 5830.0 5849.6 5769.5 5831.7 5838.1 5865.7 5908.5 4860.8 5797.0 5799.7 5821.4 5830.4 5770.8 5774.1 5783.3 5811.5 5813.3 5519.3 5563.2 5613.5 5631.1 5674.3 5704.3 5714.2 5717.9 5770.4 5839.1 4725.2 5474.5 5578.1 5622.0 5656.8 06:58:17 INFO - PROCESS | 1666 | 06:58:17 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:67108.84 Median:34662.98 stddev:149210.58 (430.5%) stddev-sans-first:149545.36 06:58:17 INFO - PROCESS | 1666 | Values: 504.7 522.9 525.2 525.7 526.9 30578.8 39654.8 40919.6 41049.8 43032.4 41612.6 41921.8 41973.5 42045.8 42079.0 8701.4 9759.9 9935.1 9954.5 9958.4 7786.4 8828.0 8894.4 8941.5 8946.8 11956.9 12286.5 12296.8 12442.8 12490.0 12112.5 12174.4 12198.3 12206.0 12225.4 11925.3 11981.6 12001.9 12002.7 12006.2 39443.8 39744.8 39816.6 39821.8 39850.8 3081.1 3138.4 3194.2 3326.3 3431.8 30292.4 31166.5 31673.8 31762.4 31836.0 3201.6 3220.6 3233.7 3355.9 3387.9 469301.0 469421.0 469531.0 471959.0 478926.0 32473.0 33129.0 33161.0 60093.4 60509.4 34157.8 34655.8 34670.1 34780.8 34845.5 14242.5 14384.3 14388.3 14394.9 14396.9 12147.4 12248.4 12257.1 12270.1 12275.2 7136.0 7279.7 7293.3 7592.0 7657.3 2707.0 3195.2 3227.2 3228.3 3230.3 877.1 902.4 932.2 944.6 957.9 28274.9 28673.9 29265.7 29342.7 30167.0 879.4 1036.6 1059.8 1066.4 1180.5 13800.9 14226.5 14441.0 15308.2 15848.0 643405.0 647771.0 648240.0 649765.0 649873.0 57697.4 58333.4 58336.0 58483.0 58554.5 1312.1 1354.8 1374.3 1375.7 1379.0 29287.0 29337.1 29505.6 30134.7 30370.5 50417.2 50452.2 50514.5 50603.2 50727.5 536903.0 537871.0 538958.9 538985.0 539696.0 24745.8 25163.9 25794.5 25902.6 25911.0 45550.0 45927.0 46307.0 46670.3 47410.5 28849.0 38540.2 38608.0 38663.4 38724.8 38067.8 38165.8 39065.6 39395.0 39415.4 36999.5 37928.6 38598.6 38660.6 38715.8 29871.1 30223.7 33274.7 33678.5 33744.7 24584.8 24643.5 24862.0 25001.6 25088.9 06:58:17 INFO - PROCESS | 1666 | 06:58:17 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:35761.70 Median:1849.15 stddev:95168.78 (5146.6%) stddev-sans-first:95398.60 06:58:17 INFO - PROCESS | 1666 | Values: 342.3 355.3 357.3 367.2 391.3 15273.8 15571.3 16920.9 18417.7 21074.4 18503.7 18698.0 20403.0 20407.9 20637.3 5801.7 5980.4 6007.8 6137.9 6140.5 4731.2 5822.9 5948.7 6003.8 6007.5 5955.6 5970.2 5970.9 5971.9 5972.6 7470.8 7871.2 7900.0 7919.9 7997.5 7401.2 7520.7 7717.5 7721.3 7739.4 24637.9 26591.9 28295.2 28494.3 28630.4 2355.3 2842.7 3318.3 3351.7 3356.0 16605.5 16640.3 16911.9 17142.6 17142.7 1793.4 1882.2 2007.7 2019.4 2082.6 94349.4 115532.8 129806.0 141394.0 156623.2 18991.6 21099.9 21225.3 21448.7 21534.9 34890.8 34899.3 35031.8 35045.0 35097.8 10134.4 10688.2 10842.4 10894.0 11074.4 8824.0 8850.0 8859.0 9028.3 9055.0 8031.6 9271.6 9708.0 9713.9 9718.3 3180.2 3703.6 3715.3 3805.3 3814.3 757.4 861.0 892.8 902.5 909.1 17808.7 19906.2 20139.5 20499.4 23883.0 823.4 908.0 943.3 988.3 991.4 10936.8 11237.6 11352.4 11377.5 11394.1 492084.0 574492.0 582994.0 583262.0 598870.0 72638.0 134101.0 135789.1 136908.0 140706.0 953.8 1008.9 1011.2 1020.3 1023.3 17865.2 18625.4 18664.3 18689.5 18745.3 43967.8 46950.0 55708.8 56509.7 57109.4 81267.0 81890.0 82534.0 85540.1 86989.6 8002.9 8052.4 8178.7 8344.7 8428.2 10541.8 12689.2 12776.6 13039.4 13081.3 11034.2 11083.9 11261.7 11320.4 11423.7 9306.3 10547.8 10877.3 10995.6 11016.6 10328.5 11326.8 11442.1 11493.2 11753.0 7965.6 8043.3 8059.2 8188.8 8417.0 8302.6 10786.4 11335.9 11358.5 11484.3 06:58:17 INFO - PROCESS | 1666 | 06:58:17 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5602.89 Median:4870.96 stddev:3164.81 (65.0%) stddev-sans-first:3157.50 06:58:17 INFO - PROCESS | 1666 | Values: 1343.6 1526.9 1535.5 1729.2 1897.8 7768.5 8235.6 8393.7 8775.6 8829.8 7464.7 8718.5 8731.0 8745.7 8763.5 2330.8 2386.5 2391.8 2395.6 2396.5 2336.5 2377.0 2379.3 2386.5 2389.1 2349.2 2374.6 2377.9 2379.5 2388.5 2327.1 2350.5 2359.4 2360.4 2372.6 2323.1 2344.2 2352.4 2356.1 2361.7 8728.0 8762.6 8824.0 8851.6 8856.8 5154.7 5348.5 5352.1 5365.7 5371.8 3439.9 3594.8 3660.5 3673.0 3684.5 1045.7 1076.1 1079.4 1101.7 1104.0 11478.1 11479.1 11589.0 11596.8 11614.7 4328.9 4410.4 4582.6 4596.3 4604.0 9051.0 9078.5 9082.7 9102.4 9103.9 5185.3 5192.3 5199.0 5199.8 5205.0 4098.8 4335.4 4493.9 4503.5 4847.3 3684.4 3725.7 3768.2 3808.4 3812.0 1124.9 1128.8 1134.2 1140.0 1147.4 845.0 866.1 878.6 923.4 930.4 5357.1 5751.9 5956.1 5998.3 6158.4 348.7 417.7 437.2 442.1 447.4 3541.7 3948.5 3973.3 4075.6 4088.3 10335.7 10665.0 10762.2 10788.8 10792.9 10778.2 10781.7 10782.1 10787.6 10801.4 7818.6 8095.7 8238.2 8240.9 8255.4 5776.9 5836.4 5891.3 5935.3 5990.4 9887.6 9974.1 9999.0 10016.4 10019.8 8957.8 9859.4 10101.0 10183.0 10272.6 6141.5 7020.7 7022.3 7086.1 7086.5 8196.3 8242.7 8243.3 8291.1 8336.8 6329.6 6959.8 6967.5 7055.6 7067.2 7320.2 7350.2 7382.9 7429.7 7444.5 6931.2 7056.6 7061.3 7066.5 7068.3 4878.6 4969.6 5019.9 5053.1 5251.2 4863.3 4914.9 4975.6 5095.4 5213.4 06:58:17 INFO - PROCESS | 1666 | 06:58:17 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:4334.25 Median:4926.29 stddev:1298.58 (26.4%) stddev-sans-first:1265.51 06:58:17 INFO - PROCESS | 1666 | Values: 249.8 274.2 306.5 310.4 310.7 5148.3 5174.8 5185.1 5194.8 5216.9 4005.1 4355.7 4964.6 5028.9 5168.3 3224.1 3755.4 3894.7 3905.5 3931.9 3433.9 3923.3 3962.5 3978.9 4025.1 3135.3 3626.7 3873.0 3893.5 3945.4 3432.0 3921.8 3962.7 3976.3 3983.4 3475.7 3493.2 3495.4 3503.6 3516.0 4994.1 5045.5 5055.3 5069.6 5070.7 3539.0 4315.4 4471.6 4513.9 4558.7 4547.6 5355.4 5369.4 5423.6 5433.9 3645.6 3779.2 3802.7 3826.4 3839.7 4498.0 5373.1 5483.7 5711.7 5730.2 3529.9 3823.6 3842.3 3847.7 3852.0 3895.4 3900.9 3906.7 3910.4 3920.7 4321.4 4450.8 4498.7 4503.5 4508.5 4033.0 5228.9 5404.2 5424.7 5437.4 1310.0 1324.8 1328.9 1330.5 1333.9 777.0 846.3 870.3 881.4 892.4 4696.5 4893.3 5010.2 5016.5 5039.7 4942.9 5206.9 5358.2 5389.6 5450.7 4404.5 4570.2 4680.9 4916.1 4944.3 2435.7 2835.7 2853.0 2857.8 2899.1 4872.3 5038.7 5553.8 5671.6 5681.7 4375.5 4936.5 5129.8 5497.5 5524.8 4748.1 5413.2 5480.3 5532.3 5554.3 5176.9 5197.5 5289.6 5412.0 5432.0 4315.2 4895.6 4907.8 5126.9 5336.5 5354.7 5391.1 5503.2 5612.0 5626.3 3317.5 3797.3 3811.4 3823.2 3827.3 4905.5 5129.8 5517.4 5522.6 5530.9 4523.8 4999.5 5166.4 5397.5 5411.6 5159.8 5321.9 5380.9 5389.4 5396.9 5021.0 5050.3 5253.3 5277.7 5303.4 4560.8 5136.3 5216.4 5272.2 5374.4 4366.1 5274.3 5285.8 5299.5 5399.2 06:58:17 INFO - PROCESS | 1666 | 06:58:17 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:26313.81 Median:22461.33 stddev:43352.53 (193.0%) stddev-sans-first:43431.45 06:58:17 INFO - PROCESS | 1666 | Values: 690.6 698.2 698.5 752.0 792.7 15233.2 16010.3 16018.8 16030.0 16032.8 14482.4 14494.6 14521.6 14521.9 14682.3 650.5 681.4 820.2 832.3 835.2 808.5 834.7 843.2 847.1 847.1 895.1 895.9 896.5 896.6 899.4 887.4 890.1 891.4 891.9 892.6 509.2 528.4 628.2 650.2 660.7 15037.1 15457.9 15461.9 15479.1 15510.8 13656.7 14040.5 14189.7 14212.4 14262.9 10949.9 12527.2 12984.3 13143.2 13143.5 4497.2 4534.6 4589.0 4653.7 4676.3 109170.0 109783.5 110368.4 111917.0 119812.0 10104.8 10482.3 11135.8 11136.4 11653.4 21723.3 22392.2 22428.8 22493.9 22505.9 7909.2 7928.9 7953.5 7988.9 8063.0 4379.4 4424.3 4465.7 4607.5 4623.7 3511.2 3654.8 3658.9 3661.1 3667.7 599.2 640.3 650.1 664.3 667.5 558.5 559.9 561.0 601.9 633.1 8768.3 8940.8 8957.5 8960.0 9092.8 560.9 573.1 608.4 613.8 627.6 4282.1 4344.2 4377.8 4463.7 4528.6 135620.0 155447.0 163513.0 163687.2 170842.3 144207.0 144985.0 146904.0 147389.0 149409.5 106484.0 122094.4 123853.0 125075.6 125407.4 8038.6 8476.9 8484.4 8517.5 8722.7 65263.3 66866.0 68248.8 69859.7 70696.6 94866.0 104438.5 105692.0 107646.5 107691.5 11347.5 11526.5 11589.7 11714.4 11805.9 11916.0 11935.2 12030.6 12195.4 12613.3 10608.4 11890.3 11934.9 12260.2 12446.7 11099.9 12742.2 13284.9 13395.9 13567.3 11507.5 13215.3 13303.9 13338.9 13653.9 10298.2 10936.6 11441.2 11443.1 11469.9 8291.9 10933.7 11298.9 11458.1 11540.4 06:58:17 INFO - PROCESS | 1666 | -------- Summary: end -------- 06:58:17 INFO - PROCESS | 1666 | 06:58:17 INFO - TEST-INFO | 1666: exit 0 06:58:17 INFO - TEST-OK | dromaeo_css | took 1117369ms 06:58:17 INFO - TEST-START | kraken 06:58:17 INFO - operating with platform_type : mac_ 06:58:17 INFO - Initialising browser for kraken test... 06:58:17 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpbOCrb0/profile http://localhost:49271/getInfo.html) 06:58:20 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 06:58:20 INFO - PROCESS | 1672 | colorDepth:24 06:58:20 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 06:58:20 INFO - PROCESS | 1672 | __metrics 06:58:20 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:58:20 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:58:20 INFO - TEST-INFO | 1672: exit 0 06:58:20 INFO - Browser initialized. 06:58:20 INFO - Running cycle 1/1 for kraken test... 06:58:20 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/tmpbOCrb0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:32 INFO - PROCESS | 1673 | RSS: Main: 236068864 06:58:32 INFO - PROCESS | 1673 | 06:58:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 06:58:36 INFO - PROCESS | 1673 | RSS: Main: 295792640 06:58:36 INFO - PROCESS | 1673 | 06:58:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 06:58:39 INFO - PROCESS | 1673 | RSS: Main: 294137856 06:58:39 INFO - PROCESS | 1673 | 06:58:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 06:58:44 INFO - PROCESS | 1673 | RSS: Main: 384618496 06:58:44 INFO - PROCESS | 1673 | 06:58:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 06:58:46 INFO - PROCESS | 1673 | RSS: Main: 285679616 06:58:46 INFO - PROCESS | 1673 | 06:58:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:58:49 INFO - PROCESS | 1673 | RSS: Main: 289509376 06:58:49 INFO - PROCESS | 1673 | 06:58:52 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 06:58:52 INFO - PROCESS | 1673 | RSS: Main: 326660096 06:58:52 INFO - PROCESS | 1673 | 06:58:55 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 06:58:56 INFO - PROCESS | 1673 | RSS: Main: 328679424 06:58:56 INFO - PROCESS | 1673 | 06:58:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 06:58:59 INFO - PROCESS | 1673 | RSS: Main: 328097792 06:58:59 INFO - PROCESS | 1673 | 06:59:01 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:59:01 INFO - PROCESS | 1673 | RSS: Main: 304107520 06:59:01 INFO - PROCESS | 1673 | 06:59:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:59:04 INFO - PROCESS | 1673 | RSS: Main: 303771648 06:59:04 INFO - PROCESS | 1673 | 06:59:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:59:07 INFO - PROCESS | 1673 | RSS: Main: 302321664 06:59:07 INFO - PROCESS | 1673 | 06:59:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:59:10 INFO - PROCESS | 1673 | RSS: Main: 315293696 06:59:10 INFO - PROCESS | 1673 | 06:59:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:59:14 INFO - PROCESS | 1673 | RSS: Main: 318111744 06:59:14 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 06:59:16 INFO - PROCESS | 1673 | RSS: Main: 361656320 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | __start_tp_report 06:59:16 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 06:59:16 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 06:59:16 INFO - PROCESS | 1673 | |i|pagename|runs| 06:59:16 INFO - PROCESS | 1673 | |0;ai-astar;159;166;145;113;117;162;165;114;113;114 06:59:16 INFO - PROCESS | 1673 | |1;audio-beat-detection;146;110;108;145;107;109;108;111;167;132 06:59:16 INFO - PROCESS | 1673 | |2;audio-dft;185;182;182;186;185;184;183;183;183;181 06:59:16 INFO - PROCESS | 1673 | |3;audio-fft;80;60;59;89;62;58;59;58;82;57 06:59:16 INFO - PROCESS | 1673 | |4;audio-oscillator;83;70;91;69;70;91;125;95;69;89 06:59:16 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;91;88;90;87;90;87;91;88;92;88 06:59:16 INFO - PROCESS | 1673 | |6;imaging-darkroom;96;96;96;96;96;95;96;96;95;94 06:59:16 INFO - PROCESS | 1673 | |7;imaging-desaturate;86;86;86;85;83;84;86;84;84;84 06:59:16 INFO - PROCESS | 1673 | |8;json-parse-financial;55;55;54;53;55;56;54;55;56;54 06:59:16 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;64;74;69;75;99;94;84;69;71;70 06:59:16 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;85;76;94;103;102;103;85;87;84;84 06:59:16 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;139;138;141;137;137;140;141;154;173;140 06:59:16 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;170;169;167;169;169;165;208;196;166;169 06:59:16 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;69;68;74;82;84;84;85;83;80;67 06:59:16 INFO - PROCESS | 1673 | __end_tp_report 06:59:16 INFO - PROCESS | 1673 | __start_cc_report 06:59:16 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1947 06:59:16 INFO - PROCESS | 1673 | __end_cc_report 06:59:16 INFO - PROCESS | 1673 | __startTimestamp1474811956524__endTimestamp 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | ------- Summary: start ------- 06:59:16 INFO - PROCESS | 1673 | Number of tests: 14 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:136.80 Median:152.00 stddev:24.51 (16.1%) stddev-sans-first:24.65 06:59:16 INFO - PROCESS | 1673 | Values: 159.0 166.0 145.0 113.0 117.0 162.0 165.0 114.0 113.0 114.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:121.50 stddev:21.67 (17.8%) stddev-sans-first:21.52 06:59:16 INFO - PROCESS | 1673 | Values: 146.0 110.0 108.0 145.0 107.0 109.0 108.0 111.0 167.0 132.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:183.40 Median:183.50 stddev:1.58 (0.9%) stddev-sans-first:1.56 06:59:16 INFO - PROCESS | 1673 | Values: 185.0 182.0 182.0 186.0 185.0 184.0 183.0 183.0 183.0 181.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:66.40 Median:61.00 stddev:12.19 (20.0%) stddev-sans-first:11.90 06:59:16 INFO - PROCESS | 1673 | Values: 80.0 60.0 59.0 89.0 62.0 58.0 59.0 58.0 82.0 57.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:85.20 Median:86.00 stddev:17.49 (20.3%) stddev-sans-first:18.53 06:59:16 INFO - PROCESS | 1673 | Values: 83.0 70.0 91.0 69.0 70.0 91.0 125.0 95.0 69.0 89.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:90.00 stddev:1.81 (2.0%) stddev-sans-first:1.80 06:59:16 INFO - PROCESS | 1673 | Values: 91.0 88.0 90.0 87.0 90.0 87.0 91.0 88.0 92.0 88.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 06:59:16 INFO - PROCESS | 1673 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 94.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.50 stddev:1.14 (1.3%) stddev-sans-first:1.12 06:59:16 INFO - PROCESS | 1673 | Values: 86.0 86.0 86.0 85.0 83.0 84.0 86.0 84.0 84.0 84.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:0.95 (1.7%) stddev-sans-first:1.00 06:59:16 INFO - PROCESS | 1673 | Values: 55.0 55.0 54.0 53.0 55.0 56.0 54.0 55.0 56.0 54.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:74.50 stddev:11.63 (15.6%) stddev-sans-first:11.36 06:59:16 INFO - PROCESS | 1673 | Values: 64.0 74.0 69.0 75.0 99.0 94.0 84.0 69.0 71.0 70.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:84.50 stddev:9.57 (11.3%) stddev-sans-first:9.96 06:59:16 INFO - PROCESS | 1673 | Values: 85.0 76.0 94.0 103.0 102.0 103.0 85.0 87.0 84.0 84.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:140.50 stddev:11.30 (8.0%) stddev-sans-first:11.84 06:59:16 INFO - PROCESS | 1673 | Values: 139.0 138.0 141.0 137.0 137.0 140.0 141.0 154.0 173.0 140.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:169.00 stddev:14.70 (8.7%) stddev-sans-first:15.48 06:59:16 INFO - PROCESS | 1673 | Values: 170.0 169.0 167.0 169.0 169.0 165.0 208.0 196.0 166.0 169.0 06:59:16 INFO - PROCESS | 1673 | 06:59:16 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.60 Median:82.50 stddev:7.32 (8.9%) stddev-sans-first:7.07 06:59:16 INFO - PROCESS | 1673 | Values: 69.0 68.0 74.0 82.0 84.0 84.0 85.0 83.0 80.0 67.0 06:59:16 INFO - PROCESS | 1673 | -------- Summary: end -------- 06:59:16 INFO - PROCESS | 1673 | 06:59:17 INFO - TEST-INFO | 1673: exit 0 06:59:17 INFO - TEST-OK | kraken | took 59549ms 06:59:17 INFO - SUITE-END | took 1176s 06:59:17 INFO - Completed test suite (00:19:37) 06:59:17 INFO - javascript benchmark 06:59:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2583.5866261398173, 3254.625718042426, 3264.72249858762, 3282.7537934654906, 3323.3353329334122, 5321.680699158053, 5411.485908838654, 5416.106342453495, 5451.454854514542, 5471.261379713737, 5366.168243922189, 5442.210879422481, 5450.56395488361, 5460.262864513289, 5590.804321848736, 4908.190148625473, 4979.925301120486, 5004.649674522785, 5012.824551140701, 5047.520485553885, 4484.215262329096, 4969.180085285923, 5011.699298042111, 5074.28959945606, 5084.2373643953515, 5005.324281222025, 5047.596192304607, 5067.797288108472, 5101.51535604117, 5119.923201151967, 4943.901121977577, 4951.480094590052, 4967.627427942919, 4967.751612419364, 5023.070731914608, 4959.553640172402, 5033.345665063555, 5037.748112594392, 5052.9242061369105, 5055.646104772667, 5408.323959505062, 5448.809291674812, 5459.863503412406, 5460.26286451328, 5473.17902314652, 5717.0, 5900.527957763368, 5905.527557795409, 5905.877883202178, 5979.1031345298115, 5820.330661973842, 5939.049752039653, 5952.285725712899, 5968.67172305523, 6022.427869352405, 4657.836975705902, 5557.749901254413, 5559.471850174227, 5577.05190117681, 5609.270794796691, 6208.751649933952, 6218.440340369389, 6219.315875253718, 6224.315325314303, 6228.190335256479, 5668.659880407189, 5688.772449102073, 5720.856978575569, 5730.3410107838135, 5734.283214598176, 4910.508949105061, 5974.61165024272, 6000.699965001732, 6023.427774361517, 6049.425304596057, 5875.823725288248, 5876.471117599436, 5899.351071382144, 5900.4099590041515, 5911.024680927599, 5761.337446193657, 5919.67441790697, 5927.614705044159, 5940.940590594125, 5951.196588460589, 4663.0, 4693.413323334583, 4704.835330763407, 4706.882327941828, 4752.500987396343, 4257.510386305615, 4276.5295817460055, 4300.16146851361, 4317.805698743564, 4333.934990975138, 5491.341039075257, 5506.91739623906, 5515.669059856422, 5519.061759500894, 5519.172124181325, 5769.567282453832, 5931.73307201177, 5939.10913362999, 6010.699465026819, 6031.487323577545, 4534.229181039232, 5414.458554144554, 5436.91844622331, 5491.395946445888, 5542.722863856791, 5090.745462726849, 5142.61430392722, 5157.9684063187515, 5164.122099243138, 5191.558717508979, 6119.84700382494, 6173.079899545204, 6200.844978875564, 6217.285012223471, 6223.159873417031, 5848.210491583752, 5887.941120588911, 5923.318818335774, 5935.970320148372, 5939.613925094855, 6202.224721909762, 6210.937890621217, 6222.377762223741, 6234.376562343729, 6244.781432649836, 5810.186573879745, 5820.679862607428, 5822.70886455684, 5829.970850145722, 5849.5612829037145, 5769.480746732815, 5831.650100993954, 5838.0966096729335, 5865.736041878211, 5908.468237858613, 4860.805567777249, 5797.0, 5799.681017543907, 5821.359650438364, 5830.4461076197695, 5770.826875193751, 5774.1338799178775, 5783.306003279465, 5811.535077193899, 5813.273340832396, 5519.254900588529, 5563.1655251710945, 5613.522850557748, 5631.1271752878365, 5674.319081710056, 5704.258446401941, 5714.228579141763, 5717.8570535736935, 5770.3652598215, 5839.124131380327, 4725.220338644085, 5474.452554744494, 5578.051731205624, 5622.0, 5656.830295091154], "value": 5421.061688938754, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.74510372262, 522.9294045303885, 525.2436491452308, 525.731876742861, 526.8735503479166, 30578.776848926045, 39654.80172599137, 40919.59080409199, 41049.794751026275, 43032.35451468223, 41612.583874161246, 41921.79039104808, 41973.53092641758, 42045.789771051175, 42079.0, 8701.390902636786, 9759.902400975989, 9935.05616966387, 9954.452505112216, 9958.352707074053, 7786.416018798613, 8828.042605727089, 8894.377393582452, 8941.463512189257, 8946.776330591754, 11956.940215298911, 12286.508539658404, 12296.815547766791, 12442.751144977095, 12490.00079993603, 12112.515499380013, 12174.391280435988, 12198.268103913793, 12206.023518118529, 12225.388730563436, 11925.284482931052, 11981.580644677395, 12001.879981200163, 12002.69993250167, 12006.159568830186, 39443.80278098591, 39744.80127599373, 39816.60183398158, 39821.80534583967, 39850.80074599638, 3081.1218802641138, 3138.4350816852957, 3194.1535493094348, 3326.334733053399, 3431.828408579586, 30292.394152116834, 31166.532502012487, 31673.84163079193, 31762.364752704816, 31836.04491865248, 3201.6478187399366, 3220.5813244278092, 3233.7413006959387, 3355.932881342384, 3387.8814241501677, 469301.0, 469421.0, 469531.0, 471959.0, 478926.0, 32473.0, 33129.0, 33161.0, 60093.39906600965, 60509.39490605125, 34157.829210853786, 34655.82672086624, 34670.13324666904, 34780.82609586936, 34845.477317840254, 14242.501512447014, 14384.28078596066, 14388.28058597066, 14394.856051439352, 14396.920230982718, 12147.392630368446, 12248.38758062111, 12257.142000060088, 12270.079744019235, 12275.2021118627, 7136.0, 7279.745208917662, 7293.27067293277, 7592.0, 7657.310842024133, 2706.972930270672, 3195.2491164576304, 3227.2254658881698, 3228.257500774835, 3230.2731885325616, 877.1053525404052, 902.4089221559889, 932.2355668352022, 944.568977998333, 957.9329446938787, 28274.85862570674, 28673.856630716713, 29265.683579105225, 29342.706572933996, 30167.0, 879.4415546128126, 1036.5957276662107, 1059.8357254625546, 1066.3631325914685, 1180.5159884447335, 13800.93099534516, 14226.502072427415, 14441.0, 15308.158051307062, 15848.018997625297, 643405.0, 647771.0, 648240.0, 649765.0, 649873.0, 57697.42302577005, 58333.416665832796, 58336.0, 58483.0, 58554.53613659607, 1312.1339915655622, 1354.8170996915487, 1374.2853716067789, 1375.7454870848926, 1378.9724205516034, 29287.0, 29337.11988640344, 29505.557416638338, 30134.698653014068, 30370.54444183295, 50417.243741344646, 50452.243216352515, 50514.49485505098, 50603.24095138502, 50727.492725072276, 536903.0, 537871.0, 538958.9156162739, 538985.0, 539696.0, 24745.752542474343, 25163.87418062971, 25794.484110318062, 25902.611460827724, 25910.963561458084, 45550.0, 45927.0, 46307.0, 46670.29994550152, 47410.52589474061, 28849.0, 38540.22919541538, 38608.03479913025, 38663.42004869985, 38724.80637596794, 38067.80966095152, 38165.80917095508, 39065.609343906195, 39395.0, 39415.408768867914, 36999.52001919893, 37928.62071379251, 38598.6140138595, 38660.6133938657, 38715.80642096772, 29871.103866884027, 30223.69776302209, 33274.66725332812, 33678.49482257719, 33744.66255337415, 24584.75415245896, 24643.507129856946, 24862.0, 25001.624975625746, 25088.874555627106], "value": 18525.999953517086, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.2999965071432, 355.253966669993, 357.2604708253914, 367.15920541958917, 391.2839503708214, 15273.847261527382, 15571.29929153188, 16920.91539542302, 18417.723734143998, 21074.367768966917, 18503.722444163348, 18698.0, 20403.0, 20407.897960510214, 20637.277695280667, 5801.6519008859395, 5980.372060933604, 6007.819765407023, 6137.9386206137815, 6140.478059364959, 4731.243001119821, 5822.854428639297, 5948.7323070461935, 6003.789867354643, 6007.4893634041155, 5955.553333499983, 5970.1940238067955, 5970.910436343458, 5971.85070373242, 5972.611780234271, 7470.813229669247, 7871.21287871214, 7900.0, 7919.881201781978, 7997.520148791091, 7401.185869554345, 7520.736774212931, 7717.459777815555, 7721.305082542542, 7739.419543534257, 24637.876810616013, 26591.936322547073, 28295.15114546567, 28494.28764280889, 28630.427391452264, 2355.305184970438, 2842.701516340775, 3318.286568387784, 3351.6815902489225, 3356.0, 16605.50183494497, 16640.251188696537, 16911.91544042272, 17142.571435714082, 17142.742858857127, 1793.4171394296775, 1882.1812511557516, 2007.65869802134, 2019.4143698327468, 2082.6415150448747, 94349.41418334925, 115532.84467155304, 129805.99999999905, 141394.0, 156623.21688391487, 18991.62016759657, 21099.894500527706, 21225.257116000867, 21448.678269825967, 21534.892325538272, 34890.82554587211, 34899.302013959576, 35031.82484087563, 35045.0, 35097.771577994645, 10134.391936483687, 10688.198385121146, 10842.403667798348, 10894.0, 11074.390908499949, 8824.0, 8850.0, 8858.955705221433, 9028.322875784343, 9054.954725226464, 8031.55826429552, 9271.582778774971, 9707.951460242653, 9713.90286097144, 9718.319717619841, 3180.220845892771, 3703.6481534254203, 3715.3126671565847, 3805.296020236265, 3814.256220037066, 757.394084732212, 860.9827803443897, 892.848215803315, 902.4675441489553, 909.1090731083575, 17808.732869006973, 19906.203751849764, 20139.496512587302, 20499.38501844947, 23883.0, 823.4318320358933, 908.0329449136781, 943.2925306020485, 988.2637435110888, 991.3853410885297, 10936.781264374667, 11237.600095613792, 11352.432378381049, 11377.544898204145, 11394.145439091935, 492084.0, 574492.0, 582994.0, 583262.0, 598870.0, 72638.0, 134101.0, 135789.06978018896, 136908.0, 140706.0, 953.828310904044, 1008.9344192627309, 1011.1607365886297, 1020.3265844542715, 1023.2581378500528, 17865.196066177312, 18625.44123676292, 18664.34674786376, 18689.53276168107, 18745.250189992246, 43967.78016109899, 46950.0, 55708.84325209533, 56509.71745141248, 57109.42890571041, 81267.0, 81889.9527511817, 82534.0, 85540.14459855322, 86989.56505217687, 8002.879956800769, 8052.355811535181, 8178.672853086048, 8344.707935222237, 8428.217636770361, 10541.789164216827, 12689.23864568129, 12776.554733182273, 13039.413226405024, 13081.345932703136, 11034.172437067413, 11083.944580277048, 11261.71845703864, 11320.433978301216, 11423.657290281304, 9306.302027347841, 10547.841782373423, 10877.347359158475, 10995.560177592806, 11016.614418495314, 10328.483575821328, 11326.830097548378, 11442.141839361915, 11493.195476316578, 11753.0, 7965.601719913865, 8043.316318113026, 8059.194080591894, 8188.754337369888, 8416.989961204694, 8302.584870756316, 10786.406747628642, 11335.886641133484, 11358.54565817391, 11484.253523520945], "value": 10796.728424249384, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.583489118374, 1526.854948779866, 1535.4549135057055, 1729.1527151695666, 1897.8386837118853, 7768.533887966719, 8235.588220588968, 8393.664253429855, 8775.648974041047, 8829.779255518615, 7464.738734144306, 8718.476891386505, 8731.0, 8745.650173993032, 8763.51800650964, 2330.82518811089, 2386.451116243265, 2391.7727815857465, 2395.568797616428, 2396.4727759892794, 2336.474293284006, 2376.9762302376926, 2379.3218932604213, 2386.486905315357, 2389.104085967762, 2349.1777877742825, 2374.620060790274, 2377.940551486209, 2379.512199998996, 2388.450656349041, 2327.0924339507606, 2350.5063936573342, 2359.3511784259294, 2360.409897525619, 2372.5966585680303, 2323.0591610397646, 2344.1912540173785, 2352.4001379648253, 2356.1164563288767, 2361.669366288721, 8728.039915609277, 8762.649494020232, 8823.955880220621, 8851.60167792451, 8856.822863542693, 5154.664946778485, 5348.545373643206, 5352.116900711378, 5365.731713414314, 5371.811986580451, 3439.914002149966, 3594.820258987066, 3660.4875317455576, 3673.0266479382985, 3684.5025921500524, 1045.7281106912183, 1076.0530732955028, 1079.4494807648157, 1101.7355834599718, 1103.9779204415868, 11478.139139564566, 11479.139064570107, 11588.956993870508, 11596.768064638743, 11614.709632259177, 4328.913421731548, 4410.360497727812, 4582.610478109332, 4596.310553416947, 4604.0, 9051.0, 9078.45529268246, 9082.682106126254, 9102.408343457653, 9103.908960910307, 5185.325907631984, 5192.299039629677, 5199.0, 5199.818006369759, 5205.0, 4098.815553300109, 4335.414719012956, 4493.932591011137, 4503.482099558527, 4847.321375007502, 3684.4473329000866, 3725.7391982561503, 3768.2086761779783, 3808.409696497047, 3811.9618803812164, 1124.9381284029294, 1128.8306753986967, 1134.2173900008968, 1140.0423644138964, 1147.363213416545, 844.957752112392, 866.1338661338661, 878.6090189865448, 923.420950175208, 930.3905941608258, 5357.08929481989, 5751.913721294184, 5956.106584012433, 5998.260504453659, 6158.353372895782, 348.70185990977853, 417.6909087275394, 437.2239275286392, 442.1312121680912, 447.4027173723051, 3541.698955588804, 3948.506436695413, 3973.264945985002, 4075.612816782401, 4088.264112459786, 10335.74160645975, 10665.040146386862, 10762.24664273509, 10788.78422431547, 10792.892071079188, 10778.19163562736, 10781.676549703521, 10782.137429005661, 10787.568497260021, 10801.405922674172, 7818.6090695465, 8095.745159500287, 8238.217369349903, 8240.876386854203, 8255.42212045163, 5776.913346299725, 5836.445537673914, 5891.293044834647, 5935.34711181761, 5990.400959903975, 9887.604495820087, 9974.102330790263, 9999.000099990233, 10016.449095299828, 10019.849702254327, 8957.776055598402, 9859.408435493893, 10100.98990100984, 10183.0, 10272.640457583948, 6141.539384546266, 7020.684069216795, 7022.297770222936, 7086.114235720535, 7086.4685148613025, 8196.30331421812, 8242.670293188205, 8243.340532757486, 8291.08798032204, 8336.791580210544, 6329.588576742497, 6959.791206263821, 6967.512274140761, 7055.576665400093, 7067.151941767021, 7320.194778574459, 7350.154732205865, 7382.926170738224, 7429.665665045194, 7444.516106453063, 6931.237563868071, 7056.6118863463, 7061.2938706131035, 7066.470014748812, 7068.257832927468, 4878.634102442402, 4969.602431805519, 5019.874503137305, 5053.065182941167, 5251.212318152155, 4863.294822250825, 4914.877128071684, 4975.6019518437715, 5095.439501654889, 5213.426523082534], "value": 4420.476250097833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [249.8188813110494, 274.2171101505203, 306.4682775384708, 310.3544627175475, 310.72500836759474, 5148.253503242027, 5174.767135478903, 5185.118529849925, 5194.818181363653, 5216.9478305216935, 4005.09757865014, 4355.673324500667, 4964.578010869081, 5028.924566131511, 5168.2764412982215, 3224.0972527692284, 3755.3991361382186, 3894.6689531389866, 3905.4922860028155, 3931.9017024574327, 3433.948490772628, 3923.3330333843314, 3962.4650672159178, 3978.9005274868214, 4025.1144748155357, 3135.2788858562544, 3626.70986321095, 3872.9930218143345, 3893.4620824774197, 3945.4476373307616, 3431.9656803431894, 3921.784301863396, 3962.722609417342, 3976.284268831609, 3983.42240375144, 3475.6524347565296, 3493.1616412061176, 3495.427057823964, 3503.562054743157, 3516.033090899997, 4994.126027945095, 5045.520675535819, 5055.292259083694, 5069.594432445396, 5070.73231692077, 3538.982305088484, 4315.374270730757, 4471.630036080883, 4513.916660001576, 4558.743422006095, 4547.567981041796, 5355.410904800468, 5369.40936496985, 5423.593230507728, 5433.945660543383, 3645.5989841117457, 3779.1874746929543, 3802.695784337274, 3826.4260360945805, 3839.654431101186, 4497.96387438481, 5373.1402975524115, 5483.656504156467, 5711.714414279311, 5730.226419433407, 3529.8941031769086, 3823.5794062653085, 3842.269968705937, 3847.7306588539095, 3851.9614803852164, 3895.376739721631, 3900.941485877714, 3906.687465002793, 3910.393888947218, 3920.7059470539825, 4321.395004699345, 4450.844220452269, 4498.685092043525, 4503.504614492404, 4508.549145085465, 4033.015568479304, 5228.869278267997, 5404.189371594213, 5424.701641409761, 5437.401885792559, 1309.9607011789662, 1324.8277723896024, 1328.8538260791306, 1330.5476138112895, 1333.8599447058114, 776.9844603107906, 846.3187134356901, 870.2559311788457, 881.413859783237, 892.4243862708516, 4696.459907110658, 4893.336265669689, 5010.223415370623, 5016.498350164954, 5039.697618142924, 4942.851714448572, 5206.947930520722, 5358.169483730028, 5389.5987043369005, 5450.700211488327, 4404.546499655106, 4570.177368073779, 4680.882977925579, 4916.115099282092, 4944.332515110414, 2435.707715074167, 2835.6597208335133, 2853.0, 2857.7856660750526, 2899.072296864983, 4872.342233798463, 5038.6976781392505, 5553.77784888608, 5671.582104473881, 5681.687507187062, 4375.549692172393, 4936.456989731127, 5129.79480820763, 5497.526113248974, 5524.8342549722765, 4748.121597504472, 5413.242146099549, 5480.342358916955, 5532.30846144232, 5554.277943867352, 5176.896462070662, 5197.4542673020305, 5289.625270087612, 5411.9717253721665, 5431.972840135774, 4315.244832154423, 4895.5593996539055, 4907.8466560359, 5126.8974620508125, 5336.493033161843, 5354.732263386893, 5391.137418013099, 5503.174523821299, 5612.0, 5626.324841019104, 3317.4692049272967, 3797.3291751629195, 3811.352070148026, 3823.1780167264174, 3827.27281816454, 4905.533974272438, 5129.846104616868, 5517.44825517445, 5522.5858060646415, 5530.861728456821, 4523.773811309487, 4999.475055119306, 5166.4316925138955, 5397.541208997122, 5411.594130440311, 5159.819406320761, 5321.946780532146, 5380.946190538045, 5389.353277606712, 5396.865078373072, 5020.974895125501, 5050.292958985671, 5253.317068781034, 5277.683338999673, 5303.416624171416, 4560.817567297404, 5136.332276804141, 5216.365735303647, 5272.235525848654, 5374.4145477083575, 4366.104948485617, 5274.314339135888, 5285.788568457372, 5299.49654782795, 5399.1665917199225], "value": 3920.9996272240624, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.5787469643519, 698.1587187439134, 698.514532399982, 751.9511231769934, 792.7265093542727, 15233.238338083092, 16010.279537420814, 16018.75971860423, 16029.958052726579, 16032.839671603295, 14482.42070317186, 14494.637634059154, 14521.636959076028, 14521.910856685765, 14682.265886705649, 650.4991156809255, 681.4344094401634, 820.228984754332, 832.2925513313666, 835.1940377535677, 808.49873078691, 834.6536187482187, 843.236870632079, 847.1105339393612, 847.1316900177337, 895.0646574329841, 895.9328050396247, 896.4755617963499, 896.5696465696469, 899.3839220134229, 887.3699673232013, 890.1143362354434, 891.4383938118943, 891.8706787515806, 892.5983307511646, 509.17259453388243, 528.3897098850833, 628.1802248066272, 650.187265917603, 660.6531570925255, 15037.097774133477, 15457.922710386489, 15461.922690386476, 15479.071255724693, 15510.767338489932, 13656.726865462735, 14040.508582199574, 14189.716205675828, 14212.360443780055, 14262.85737142636, 10949.945250273777, 12527.248365098123, 12984.28586427746, 13143.211407315592, 13143.474261029547, 4497.23546997008, 4534.591886730177, 4588.954110458886, 4653.650976176767, 4676.275177347517, 109170.0, 109783.45108274487, 110368.4481577595, 111917.0, 119812.0, 10104.797904041878, 10482.27042537988, 11135.832962505569, 11136.387498687487, 11653.41732913351, 21723.34829955104, 22392.216272430713, 22428.775712242994, 22493.88753056257, 22505.88747056287, 7909.24862138096, 7928.8810667840025, 7953.483023603448, 7988.920110798934, 8063.032436107587, 4379.408779814684, 4424.336349547593, 4465.665075119314, 4607.516210797885, 4623.653226008063, 3511.17487390463, 3654.780713157219, 3658.926821463556, 3661.139632186434, 3667.7065834733157, 599.2056810641111, 640.3308542573022, 650.067153634536, 664.3157547725754, 667.5060455263167, 558.4638746803033, 559.8600349912522, 561.0322194214947, 601.9413605469306, 633.1104797759156, 8768.298536117096, 8940.821183576292, 8957.462552246887, 8960.0, 9092.772680683036, 560.9186667933209, 573.0945106731355, 608.3672980100735, 613.7619735724827, 627.5795217204393, 4282.122164956177, 4344.239758042393, 4377.802998865059, 4463.687541872103, 4528.569785870337, 135620.0, 155447.0, 163513.0, 163687.1815640914, 170842.31209595597, 144207.0, 144985.0, 146904.0, 147389.0, 149409.50590493955, 106484.0, 122094.38952805357, 123853.0, 125075.61932855072, 125407.37296313643, 8038.644091284825, 8476.915230847859, 8484.406091573777, 8517.536836556446, 8722.65109395617, 65263.347366527625, 66866.0, 68248.81014278319, 69859.65070174617, 70696.64651676708, 94866.0, 104438.47780761047, 105692.0, 107646.46176769379, 107691.46154269179, 11347.48936297852, 11526.538938442704, 11589.6523104307, 11714.414279285831, 11805.937465628134, 11916.0, 11935.224210426295, 12030.63908082759, 12195.390230488618, 12613.30626815534, 10608.416537090534, 11890.28658280506, 11934.880706040807, 12260.203086799329, 12446.688832778891, 11099.94450027777, 12742.171758836017, 13284.86715132875, 13395.933020334836, 13567.321633918067, 11507.539698412305, 13215.339233038501, 13303.933480332536, 13338.932885368953, 13653.931730341284, 10298.176145908159, 10936.56253749841, 11441.199116061796, 11443.084553235887, 11469.942650287028, 8291.917080829115, 10933.671989840317, 11298.870112988636, 11458.073278143222, 11540.422978850856], "value": 7765.164489783559, "unit": "score"}], "name": "dromaeo_css", "value": 7256.113199042549, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 166.0, 145.0, 113.0, 117.0, 162.0, 165.0, 114.0, 113.0, 114.0], "value": 136.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 108.0, 145.0, 107.0, 109.0, 108.0, 111.0, 167.0, 132.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 182.0, 186.0, 185.0, 184.0, 183.0, 183.0, 183.0, 181.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 59.0, 89.0, 62.0, 58.0, 59.0, 58.0, 82.0, 57.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 91.0, 69.0, 70.0, 91.0, 125.0, 95.0, 69.0, 89.0], "value": 85.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 90.0, 87.0, 90.0, 87.0, 91.0, 88.0, 92.0, 88.0], "value": 89.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 85.0, 83.0, 84.0, 86.0, 84.0, 84.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 53.0, 55.0, 56.0, 54.0, 55.0, 56.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 69.0, 75.0, 99.0, 94.0, 84.0, 69.0, 71.0, 70.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 76.0, 94.0, 103.0, 102.0, 103.0, 85.0, 87.0, 84.0, 84.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 141.0, 137.0, 137.0, 140.0, 141.0, 154.0, 173.0, 140.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 167.0, 169.0, 169.0, 165.0, 208.0, 196.0, 166.0, 169.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 74.0, 82.0, 84.0, 84.0, 85.0, 83.0, 80.0, 67.0], "value": 77.6, "unit": "score"}], "name": "kraken", "value": 1484.0, "alertThreshold": 2.0}]} 06:59:17 INFO - Return code: 0 06:59:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:59:17 INFO - # TBPL SUCCESS # 06:59:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:59:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:59:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:59:17 INFO - 2016-09-25 06:59:17.829 screenresolution[1677:12447] starting screenresolution argv=screenresolution get 06:59:17 INFO - 2016-09-25 06:59:17.833 screenresolution[1677:12447] Display 0: 1600x1200x32@60 06:59:17 INFO - 2016-09-25 06:59:17.840 screenresolution[1678:12450] starting screenresolution argv=screenresolution list 06:59:17 INFO - Available Modes on Display 0 06:59:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:59:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:59:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:59:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:59:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:59:18 INFO - Intel Iris: 06:59:18 INFO - Chipset Model: Intel Iris 06:59:18 INFO - Type: GPU 06:59:18 INFO - Bus: Built-In 06:59:18 INFO - VRAM (Dynamic, Max): 1536 MB 06:59:18 INFO - Vendor: Intel (0x8086) 06:59:18 INFO - Device ID: 0x0a2e 06:59:18 INFO - Revision ID: 0x0009 06:59:18 INFO - Displays: 06:59:18 INFO - Display: 06:59:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:59:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:59:18 INFO - Display Serial Number: 1600x1200 60 06:59:18 INFO - Main Display: Yes 06:59:18 INFO - Mirror: Off 06:59:18 INFO - Online: Yes 06:59:18 INFO - Rotation: Supported 06:59:18 INFO - Return code: 0 06:59:18 INFO - Running post-action listener: _resource_record_post_action 06:59:18 INFO - [mozharness: 2016-09-25 13:59:18.076986Z] Finished run-tests step (success) 06:59:18 INFO - Running post-run listener: _resource_record_post_run 06:59:18 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 31578112; Write bytes: 705946624; Read time: 295; Write time: 2483 06:59:18 INFO - TinderboxPrint: CPU usage
53.5% 06:59:18 INFO - TinderboxPrint: I/O read bytes / time
31,578,112 / 295 06:59:18 INFO - TinderboxPrint: I/O write bytes / time
705,946,624 / 2,483 06:59:18 INFO - TinderboxPrint: CPU idle
2,257.9 (46.5%) 06:59:18 INFO - TinderboxPrint: CPU system
970.7 (20.0%) 06:59:18 INFO - TinderboxPrint: CPU user
1,625.1 (33.5%) 06:59:18 INFO - TinderboxPrint: Swap in / out
435,150,848 / 0 06:59:18 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 397187584; Write bytes: 390415872; Read time: 30332; Write time: 680 06:59:18 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 29583360; Write bytes: 296705536; Read time: 271; Write time: 1761 06:59:18 INFO - Running post-run listener: _upload_blobber_files 06:59:18 INFO - Blob upload gear active. 06:59:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:59: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 06:59: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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:59: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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:59:18 INFO - (blobuploader) - INFO - Open directory for files ... 06:59:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:59:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:59:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:19 INFO - (blobuploader) - INFO - Done attempting. 06:59:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:59:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:59:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:20 INFO - (blobuploader) - INFO - Done attempting. 06:59:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:59:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:59:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:23 INFO - (blobuploader) - INFO - Done attempting. 06:59:23 INFO - (blobuploader) - INFO - Iteration through files over. 06:59:23 INFO - Return code: 0 06:59:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:59:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:59:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/765c533419063150040404a391e80b0bdf528640811dd53a8c60fbd0c9ed31e4b25f9e359835146a50eae1a5f696379cf8fbf978e3050e4e409f5cabd7cc425f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8724c1c4637d007b56b42c608d2778c2d2f8159527de7eda2418b854072be91b0e9c52b2019ecd2c8c248750c24196b1a3760e7a1b830783b4bce9ef4befaf92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a668de19bc620ffd440ceb882070ffcd0f7b379dfc48d31779e9ab19d830ff1088d0021c12e43a5d5b2660609ce9cf6f1d73f47a60fb7ae9232daabfd7980ac"} 06:59:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:59:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:59:23 INFO - Contents: 06:59:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/765c533419063150040404a391e80b0bdf528640811dd53a8c60fbd0c9ed31e4b25f9e359835146a50eae1a5f696379cf8fbf978e3050e4e409f5cabd7cc425f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8724c1c4637d007b56b42c608d2778c2d2f8159527de7eda2418b854072be91b0e9c52b2019ecd2c8c248750c24196b1a3760e7a1b830783b4bce9ef4befaf92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a668de19bc620ffd440ceb882070ffcd0f7b379dfc48d31779e9ab19d830ff1088d0021c12e43a5d5b2660609ce9cf6f1d73f47a60fb7ae9232daabfd7980ac"} 06:59:23 INFO - Running post-run listener: copy_logs_to_upload_dir 06:59:23 INFO - Copying logs to upload dir... 06:59:23 INFO - mkdir: /builds/slave/test/build/upload/logs 06:59:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.542318 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-25 06:59:23.095851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 06:59:23.100955) ========= 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.41CLMOnFgj/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.JaSygNdjRl/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/765c533419063150040404a391e80b0bdf528640811dd53a8c60fbd0c9ed31e4b25f9e359835146a50eae1a5f696379cf8fbf978e3050e4e409f5cabd7cc425f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8724c1c4637d007b56b42c608d2778c2d2f8159527de7eda2418b854072be91b0e9c52b2019ecd2c8c248750c24196b1a3760e7a1b830783b4bce9ef4befaf92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a668de19bc620ffd440ceb882070ffcd0f7b379dfc48d31779e9ab19d830ff1088d0021c12e43a5d5b2660609ce9cf6f1d73f47a60fb7ae9232daabfd7980ac"} build_url:https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011099 build_url: 'https://queue.taskcluster.net/v1/task/F4EjzwAITcKhFc-otwG6rg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/765c533419063150040404a391e80b0bdf528640811dd53a8c60fbd0c9ed31e4b25f9e359835146a50eae1a5f696379cf8fbf978e3050e4e409f5cabd7cc425f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8724c1c4637d007b56b42c608d2778c2d2f8159527de7eda2418b854072be91b0e9c52b2019ecd2c8c248750c24196b1a3760e7a1b830783b4bce9ef4befaf92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5a668de19bc620ffd440ceb882070ffcd0f7b379dfc48d31779e9ab19d830ff1088d0021c12e43a5d5b2660609ce9cf6f1d73f47a60fb7ae9232daabfd7980ac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-25 06:59:23.134356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:59:23.134687) ========= 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.41CLMOnFgj/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.JaSygNdjRl/Listeners TMPDIR=/var/folders/6j/k4rbm30d51j_ptbxwx2xwvqw00000w/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.005113 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-25 06:59:23.183384) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 06:59:23.183696) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-25 06:59:23.184071) ========= ========= Total master_lag: 0.34 =========