builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0345 starttime: 1476360587.89 results: success (0) buildid: 20161013025423 builduid: fbc25fadb5e444d79b4d72705cdbdd92 revision: f03e2740d604d339ed553dad62a3fc54c317f8fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:47.891581) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:47.891934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:47.892199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:47.915962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:47.916218) ========= 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.ZAV1J1d7FL/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.5LxncazX4b/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-10-13 05:09:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.2M=0.001s 2016-10-13 05:09:48 (18.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130333 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:48.073146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:48.073420) ========= 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.ZAV1J1d7FL/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.5LxncazX4b/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.026388 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:48.121262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 05:09:48.121653) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f03e2740d604d339ed553dad62a3fc54c317f8fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f03e2740d604d339ed553dad62a3fc54c317f8fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZAV1J1d7FL/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.5LxncazX4b/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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-10-13 05:09:48,204 truncating revision to first 12 chars 2016-10-13 05:09:48,204 Setting DEBUG logging. 2016-10-13 05:09:48,204 attempt 1/10 2016-10-13 05:09:48,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f03e2740d604?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 05:09:49,419 unpacking tar archive at: mozilla-central-f03e2740d604/testing/mozharness/ program finished with exit code 0 elapsedTime=1.488641 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 05:09:49.631786) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:49.632092) ========= script_repo_revision: f03e2740d604d339ed553dad62a3fc54c317f8fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:49.632458) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:49.632818) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 05:09:49.650698) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-13 05:09:49.650996) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZAV1J1d7FL/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.5LxncazX4b/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:09:49 INFO - MultiFileLogger online at 20161013 05:09:49 in /builds/slave/test 05:09:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:09:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:49 INFO - {'append_to_log': False, 05:09:49 INFO - 'base_work_dir': '/builds/slave/test', 05:09:49 INFO - 'blob_upload_branch': 'Firefox', 05:09:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:49 INFO - 'branch': 'Firefox', 05:09:49 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:49 INFO - 'config_files': ('talos/mac_config.py',), 05:09:49 INFO - 'default_actions': ('clobber', 05:09:49 INFO - 'read-buildbot-config', 05:09:49 INFO - 'download-and-extract', 05:09:49 INFO - 'populate-webroot', 05:09:49 INFO - 'create-virtualenv', 05:09:49 INFO - 'install', 05:09:49 INFO - 'run-tests'), 05:09:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:49 INFO - 'download_minidump_stackwalk': True, 05:09:49 INFO - 'download_symbols': 'ondemand', 05:09:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:49 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:49 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:49 INFO - 'installer_path': 'installer.exe', 05:09:49 INFO - 'log_level': 'info', 05:09:49 INFO - 'log_name': 'talos', 05:09:49 INFO - 'log_to_console': True, 05:09:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:09:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:09:49 INFO - 'opt_config_files': (), 05:09:49 INFO - 'pip_index': False, 05:09:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:49 INFO - 'cmd': ('bash', 05:09:49 INFO - '-c', 05:09:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:49 INFO - 'enabled': True, 05:09:49 INFO - 'halt_on_failure': False, 05:09:49 INFO - 'name': 'check_screen_resolution'},), 05:09:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:09:49 INFO - 'cmd': ('bash', 05:09:49 INFO - '-c', 05:09:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:09:49 INFO - 'enabled': True, 05:09:49 INFO - 'halt_on_failure': False, 05:09:49 INFO - 'name': 'check_screen_resolution'},), 05:09:49 INFO - 'run_cmd_checks_enabled': True, 05:09:49 INFO - 'sps_profile': False, 05:09:49 INFO - 'sps_profile_interval': 0, 05:09:49 INFO - 'suite': 'dromaeojs', 05:09:49 INFO - 'system_bits': '32', 05:09:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:49 INFO - 'title': 't-yosemite-r7-0345', 05:09:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:49 INFO - 'use_talos_json': True, 05:09:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:49 INFO - 'work_dir': 'build'} 05:09:49 INFO - [mozharness: 2016-10-13 12:09:49.855106Z] Running clobber step. 05:09:49 INFO - Running pre-action listener: _resource_record_pre_action 05:09:49 INFO - Running main action method: clobber 05:09:49 INFO - rmtree: /builds/slave/test/build 05:09:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:52 INFO - Running post-action listener: _resource_record_post_action 05:09:52 INFO - [mozharness: 2016-10-13 12:09:52.073087Z] Finished clobber step (success) 05:09:52 INFO - [mozharness: 2016-10-13 12:09:52.073212Z] Running read-buildbot-config step. 05:09:52 INFO - Running pre-action listener: _resource_record_pre_action 05:09:52 INFO - Running main action method: read_buildbot_config 05:09:52 INFO - Using buildbot properties: 05:09:52 INFO - { 05:09:52 INFO - "project": "", 05:09:52 INFO - "product": "firefox", 05:09:52 INFO - "script_repo_revision": "production", 05:09:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:09:52 INFO - "repository": "", 05:09:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:09:52 INFO - "buildid": "20161013025423", 05:09:52 INFO - "pgo_build": "False", 05:09:52 INFO - "basedir": "/builds/slave/test", 05:09:52 INFO - "buildnumber": 3, 05:09:52 INFO - "slavename": "t-yosemite-r7-0345", 05:09:52 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:09:52 INFO - "platform": "yosemite_r7", 05:09:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:09:52 INFO - "branch": "mozilla-central", 05:09:52 INFO - "repo_path": "mozilla-central", 05:09:52 INFO - "revision": "f03e2740d604d339ed553dad62a3fc54c317f8fa", 05:09:52 INFO - "stage_platform": "macosx64", 05:09:52 INFO - "builduid": "fbc25fadb5e444d79b4d72705cdbdd92", 05:09:52 INFO - "slavebuilddir": "test" 05:09:52 INFO - } 05:09:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:09:52 INFO - Running post-action listener: _resource_record_post_action 05:09:52 INFO - [mozharness: 2016-10-13 12:09:52.076620Z] Finished read-buildbot-config step (success) 05:09:52 INFO - [mozharness: 2016-10-13 12:09:52.076722Z] Running download-and-extract step. 05:09:52 INFO - Running pre-action listener: _resource_record_pre_action 05:09:52 INFO - Running main action method: download_and_extract 05:09:52 INFO - mkdir: /builds/slave/test/build/tests 05:09:52 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')]} 05:09:52 INFO - trying https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:09:52 INFO - Downloading https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/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 05:09:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/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 05:09:53 INFO - Downloaded 1199 bytes. 05:09:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:09:53 INFO - Using the following test package requirements: 05:09:53 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:09:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:09:53 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:09:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:09:53 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:09:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:09:53 INFO - u'jsshell-mac.zip'], 05:09:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:09:53 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:09:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:09:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:09:53 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:09:53 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:09:53 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:09:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:09:53 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:09:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:09:53 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:09:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:09:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:09:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:09:53 INFO - Fetch https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:09:53 INFO - Http code: 200 05:09:53 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 05:09:53 INFO - x-amz-cf-id: rkvUQ_U9hoFmLXd3dWZipYdz7-tHMXHZBp_mJx2oTwpbUXCruvFh-Q== 05:09:53 INFO - x-amz-version-id: tymelWDGN0OJOmuooWtJYMR9VLDu8UiJ 05:09:54 INFO - Expected file size: 16520340 05:09:54 INFO - Obtained file size: 16520340 05:10:00 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 05:10:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:10:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:10:00 INFO - Fetch https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:10:01 INFO - Http code: 200 05:10:01 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 05:10:01 INFO - x-amz-cf-id: GKUt_zDEEtO0R91I6ScdnOFHrKQc81h3MbOTGlYjNx64rdk6_gob2A== 05:10:01 INFO - x-amz-version-id: tymelWDGN0OJOmuooWtJYMR9VLDu8UiJ 05:10:01 INFO - Expected file size: 16520340 05:10:01 INFO - Obtained file size: 16520340 05:10:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:10:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:10:07 INFO - Fetch https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:10:08 INFO - Http code: 200 05:10:08 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 05:10:08 INFO - x-amz-cf-id: dEAnwkYD4xSY52qs3c0cd5OOnWtOJhL7hvJy4UEjDNlHVTaHjuz8vg== 05:10:08 INFO - x-amz-version-id: O9kFkc_zRb05ScDXv5H6pCXl6F9kSGMH 05:10:08 INFO - Expected file size: 14409006 05:10:08 INFO - Obtained file size: 14409006 05:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:09 INFO - trying https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:10:09 INFO - Downloading https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/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 05:10:11 INFO - Downloaded 111676422 bytes. 05:10:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:10:11 INFO - mkdir: /builds/slave/test/properties 05:10:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:10:11 INFO - Writing to file /builds/slave/test/properties/build_url 05:10:11 INFO - Contents: 05:10:11 INFO - build_url:https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:10:12 INFO - Running post-action listener: _resource_record_post_action 05:10:12 INFO - Running post-action listener: set_extra_try_arguments 05:10:12 INFO - [mozharness: 2016-10-13 12:10:12.645207Z] Finished download-and-extract step (success) 05:10:12 INFO - [mozharness: 2016-10-13 12:10:12.645346Z] Running populate-webroot step. 05:10:12 INFO - Running pre-action listener: _resource_record_pre_action 05:10:12 INFO - Running main action method: populate_webroot 05:10:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:12 INFO - '--tppagecycles', 05:10:12 INFO - '7'], 05:10:12 INFO - 'tests': ['tsvgm']}}, 05:10:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:10:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:10:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:10:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:12 INFO - 'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:12 INFO - 'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['damp', 'tps']}, 05:10:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:12 INFO - 'tests': ['damp', 'tps']}, 05:10:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['dromaeo_dom']}, 05:10:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['basic_compositor_video']}, 05:10:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:10:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['a11yr', 05:10:12 INFO - 'ts_paint', 05:10:12 INFO - 'tpaint', 05:10:12 INFO - 'sessionrestore', 05:10:12 INFO - 'sessionrestore_no_auto_restore', 05:10:12 INFO - 'tabpaint']}, 05:10:12 INFO - 'other-e10s': {'tests': ['a11yr', 05:10:12 INFO - 'ts_paint', 05:10:12 INFO - 'tpaint', 05:10:12 INFO - 'sessionrestore', 05:10:12 INFO - 'sessionrestore_no_auto_restore', 05:10:12 INFO - 'tabpaint']}, 05:10:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:10:12 INFO - 'ts_paint', 05:10:12 INFO - 'tpaint', 05:10:12 INFO - 'sessionrestore', 05:10:12 INFO - 'sessionrestore_no_auto_restore', 05:10:12 INFO - 'tabpaint']}, 05:10:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:10:12 INFO - 'ts_paint', 05:10:12 INFO - 'tpaint', 05:10:12 INFO - 'sessionrestore', 05:10:12 INFO - 'sessionrestore_no_auto_restore', 05:10:12 INFO - 'tabpaint']}, 05:10:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['a11yr', 05:10:12 INFO - 'ts_paint', 05:10:12 INFO - 'tpaint', 05:10:12 INFO - 'sessionrestore', 05:10:12 INFO - 'sessionrestore_no_auto_restore', 05:10:12 INFO - 'tabpaint']}, 05:10:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['a11yr', 05:10:12 INFO - 'ts_paint', 05:10:12 INFO - 'tpaint', 05:10:12 INFO - 'sessionrestore', 05:10:12 INFO - 'sessionrestore_no_auto_restore', 05:10:12 INFO - 'tabpaint']}, 05:10:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['tsvgx', 05:10:12 INFO - 'tsvgr_opacity', 05:10:12 INFO - 'tart', 05:10:12 INFO - 'tscrollx', 05:10:12 INFO - 'cart']}, 05:10:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:10:12 INFO - 'tsvgr_opacity', 05:10:12 INFO - 'tart', 05:10:12 INFO - 'tscrollx', 05:10:12 INFO - 'cart']}, 05:10:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:12 INFO - 'talos_options': ['--disable-e10s'], 05:10:12 INFO - 'tests': ['tp5o']}, 05:10:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:12 INFO - 'tests': ['tp5o']}, 05:10:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:12 INFO - 'talos_options': ['--disable-e10s', 05:10:12 INFO - '--xperf_path', 05:10:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:12 INFO - 'tests': ['tp5n']}, 05:10:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:12 INFO - 'talos_options': ['--xperf_path', 05:10:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:12 INFO - 'tests': ['tp5n']}}, 05:10:12 INFO - 'talos.zip': {'path': '', 05:10:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:12 INFO - Running post-action listener: _resource_record_post_action 05:10:12 INFO - [mozharness: 2016-10-13 12:10:12.663930Z] Finished populate-webroot step (success) 05:10:12 INFO - [mozharness: 2016-10-13 12:10:12.664075Z] Running create-virtualenv step. 05:10:12 INFO - Running pre-action listener: _resource_record_pre_action 05:10:12 INFO - Running main action method: create_virtualenv 05:10:12 INFO - Creating virtualenv /builds/slave/test/build/venv 05:10:12 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 05:10:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:10:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:12 INFO - Using real prefix '/tools/python27' 05:10:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:10:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:16 INFO - Installing pip.................done. 05:10:16 INFO - Return code: 0 05:10:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:10:16 INFO - Reading from file tmpfile_stdout 05:10:16 INFO - Output received: 05:10:16 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) 05:10:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:10:16 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')]} 05:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:16 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')]} 05:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:16 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 0x10b2db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b251570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871956faa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, '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.ZAV1J1d7FL/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.5LxncazX4b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:10:16 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 05:10:16 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 05:10:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:10:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:16 INFO - 'HOME': '/Users/cltbld', 05:10:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:16 INFO - 'LOGNAME': 'cltbld', 05:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:16 INFO - 'MOZ_NO_REMOTE': '1', 05:10:16 INFO - 'NO_EM_RESTART': '1', 05:10:16 INFO - 'PAGER': '/bin/cat', 05:10:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:16 INFO - 'PWD': '/builds/slave/test', 05:10:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:16 INFO - 'SHELL': '/bin/bash', 05:10:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:10:16 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:10:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:16 INFO - 'USER': 'cltbld', 05:10:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:16 INFO - 'XPC_FLAGS': '0x0', 05:10:16 INFO - 'XPC_SERVICE_NAME': '0', 05:10:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:17 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 05:10:17 INFO - Cleaning up... 05:10:17 INFO - Return code: 0 05:10:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:17 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 0x10b2db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b251570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871956faa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, '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.ZAV1J1d7FL/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.5LxncazX4b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:10:17 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 05:10:17 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 05:10:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:10:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:17 INFO - 'HOME': '/Users/cltbld', 05:10:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:17 INFO - 'LOGNAME': 'cltbld', 05:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:17 INFO - 'MOZ_NO_REMOTE': '1', 05:10:17 INFO - 'NO_EM_RESTART': '1', 05:10:17 INFO - 'PAGER': '/bin/cat', 05:10:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:17 INFO - 'PWD': '/builds/slave/test', 05:10:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:17 INFO - 'SHELL': '/bin/bash', 05:10:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:10:17 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:10:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:17 INFO - 'USER': 'cltbld', 05:10:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:17 INFO - 'XPC_FLAGS': '0x0', 05:10:17 INFO - 'XPC_SERVICE_NAME': '0', 05:10:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:17 INFO - Downloading/unpacking psutil>=3.1.1 05:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:20 INFO - Installing collected packages: psutil 05:10:20 INFO - Running setup.py install for psutil 05:10:20 INFO - building 'psutil._psutil_osx' extension 05:10:20 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 05:10:21 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 05:10:21 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 05:10:21 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 05:10:21 INFO - building 'psutil._psutil_posix' extension 05:10:21 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 05:10:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:10:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:10:21 INFO - ^ 05:10:21 INFO - 1 warning generated. 05:10:21 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 05:10:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:21 INFO - Successfully installed psutil 05:10:21 INFO - Cleaning up... 05:10:21 INFO - Return code: 0 05:10:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:10:21 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')]} 05:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:21 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')]} 05:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:21 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 0x10b2db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b251570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871956faa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, '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.ZAV1J1d7FL/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.5LxncazX4b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:10:21 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 05:10:21 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 05:10:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:10:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:21 INFO - 'HOME': '/Users/cltbld', 05:10:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:21 INFO - 'LOGNAME': 'cltbld', 05:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:21 INFO - 'MOZ_NO_REMOTE': '1', 05:10:21 INFO - 'NO_EM_RESTART': '1', 05:10:21 INFO - 'PAGER': '/bin/cat', 05:10:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:21 INFO - 'PWD': '/builds/slave/test', 05:10:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:21 INFO - 'SHELL': '/bin/bash', 05:10:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:10:21 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:10:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:21 INFO - 'USER': 'cltbld', 05:10:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:21 INFO - 'XPC_FLAGS': '0x0', 05:10:21 INFO - 'XPC_SERVICE_NAME': '0', 05:10:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:10:22 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 05:10:22 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 05:10:22 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 05:10:22 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 05:10:22 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 05:10:22 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 05:10:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:10:24 INFO - Installing collected packages: mozsystemmonitor 05:10:24 INFO - Running setup.py install for mozsystemmonitor 05:10:24 INFO - Successfully installed mozsystemmonitor 05:10:24 INFO - Cleaning up... 05:10:25 INFO - Return code: 0 05:10:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:25 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 0x10b2db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b251570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871956faa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, '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.ZAV1J1d7FL/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.5LxncazX4b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:10:25 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 05:10:25 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 05:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:25 INFO - 'HOME': '/Users/cltbld', 05:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:25 INFO - 'LOGNAME': 'cltbld', 05:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:25 INFO - 'MOZ_NO_REMOTE': '1', 05:10:25 INFO - 'NO_EM_RESTART': '1', 05:10:25 INFO - 'PAGER': '/bin/cat', 05:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:25 INFO - 'PWD': '/builds/slave/test', 05:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:25 INFO - 'SHELL': '/bin/bash', 05:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:10:25 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:25 INFO - 'USER': 'cltbld', 05:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:25 INFO - 'XPC_FLAGS': '0x0', 05:10:25 INFO - 'XPC_SERVICE_NAME': '0', 05:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:25 INFO - Downloading/unpacking jsonschema==2.5.1 05:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:10:27 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 05:10:27 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 05:10:27 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 05:10:27 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 05:10:27 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 05:10:27 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 05:10:28 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:28 INFO - warning: no files found matching '*.txt' 05:10:28 INFO - no previously-included directories found matching 'build' 05:10:28 INFO - no previously-included directories found matching 'dist' 05:10:28 INFO - no previously-included directories found matching '.git*' 05:10:28 INFO - Installing collected packages: jsonschema, functools32 05:10:28 INFO - Running setup.py install for functools32 05:10:28 INFO - warning: no files found matching '*.txt' 05:10:28 INFO - no previously-included directories found matching 'build' 05:10:28 INFO - no previously-included directories found matching 'dist' 05:10:28 INFO - no previously-included directories found matching '.git*' 05:10:28 INFO - Successfully installed jsonschema functools32 05:10:28 INFO - Cleaning up... 05:10:28 INFO - Return code: 0 05:10:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b2db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b251570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871956faa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, '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.ZAV1J1d7FL/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.5LxncazX4b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:28 INFO - 'HOME': '/Users/cltbld', 05:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:28 INFO - 'LOGNAME': 'cltbld', 05:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:28 INFO - 'MOZ_NO_REMOTE': '1', 05:10:28 INFO - 'NO_EM_RESTART': '1', 05:10:28 INFO - 'PAGER': '/bin/cat', 05:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:28 INFO - 'PWD': '/builds/slave/test', 05:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:28 INFO - 'SHELL': '/bin/bash', 05:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:10:28 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:28 INFO - 'USER': 'cltbld', 05:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:28 INFO - 'XPC_FLAGS': '0x0', 05:10:28 INFO - 'XPC_SERVICE_NAME': '0', 05:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:10:28 INFO - Cleaning up... 05:10:28 INFO - Return code: 0 05:10:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b2db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b251570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871956faa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, '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.ZAV1J1d7FL/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.5LxncazX4b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:28 INFO - 'HOME': '/Users/cltbld', 05:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:28 INFO - 'LOGNAME': 'cltbld', 05:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:28 INFO - 'MOZ_NO_REMOTE': '1', 05:10:28 INFO - 'NO_EM_RESTART': '1', 05:10:28 INFO - 'PAGER': '/bin/cat', 05:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:28 INFO - 'PWD': '/builds/slave/test', 05:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:28 INFO - 'SHELL': '/bin/bash', 05:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:10:28 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:28 INFO - 'USER': 'cltbld', 05:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:28 INFO - 'XPC_FLAGS': '0x0', 05:10:28 INFO - 'XPC_SERVICE_NAME': '0', 05:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:29 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 05:10:29 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 05:10:29 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 05:10:29 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 05:10:29 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 05:10:29 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 05:10:31 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:31 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 05:10:31 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 05:10:31 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 05:10:31 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 05:10:31 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 05:10:31 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 05:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:10:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:32 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 05:10:32 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 05:10:32 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 05:10:32 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 05:10:32 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 05:10:32 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 05:10:32 INFO - Downloading docopt-0.6.1.tar.gz 05:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:32 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:32 INFO - Running setup.py install for blobuploader 05:10:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:10:33 INFO - Running setup.py install for requests 05:10:33 INFO - Running setup.py install for docopt 05:10:33 INFO - Successfully installed blobuploader requests docopt 05:10:33 INFO - Cleaning up... 05:10:33 INFO - Return code: 0 05:10:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:33 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')]} 05:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:33 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')]} 05:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:33 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 0x10b2db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b251570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871956faa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, '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.ZAV1J1d7FL/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.5LxncazX4b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:10:33 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 05:10:33 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 05:10:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:10:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:33 INFO - 'HOME': '/Users/cltbld', 05:10:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:33 INFO - 'LOGNAME': 'cltbld', 05:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:33 INFO - 'MOZ_NO_REMOTE': '1', 05:10:33 INFO - 'NO_EM_RESTART': '1', 05:10:33 INFO - 'PAGER': '/bin/cat', 05:10:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:33 INFO - 'PWD': '/builds/slave/test', 05:10:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:33 INFO - 'SHELL': '/bin/bash', 05:10:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:10:33 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:10:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:33 INFO - 'USER': 'cltbld', 05:10:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:33 INFO - 'XPC_FLAGS': '0x0', 05:10:33 INFO - 'XPC_SERVICE_NAME': '0', 05:10:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-KoAkg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-4_uJkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-bCcc8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-spIE62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Pv4gXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-XB2Bcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-zvBP9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:34 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-pJ7ULX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-IBXn8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-5NQj4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Y3T9EU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-7myVEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-MLf7Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Ey9Ptn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-FdC2_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-n5Tg9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:35 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-_fs18L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:35 INFO - Running setup.py install for manifestparser 05:10:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:10:36 INFO - Running setup.py install for mozcrash 05:10:36 INFO - Running setup.py install for mozdebug 05:10:36 INFO - Running setup.py install for mozdevice 05:10:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:10:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:10:36 INFO - Running setup.py install for mozfile 05:10:36 INFO - Running setup.py install for mozhttpd 05:10:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:10:36 INFO - Running setup.py install for mozinfo 05:10:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:10:36 INFO - Running setup.py install for mozInstall 05:10:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:10:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:10:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:10:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:10:37 INFO - Running setup.py install for mozleak 05:10:37 INFO - Running setup.py install for mozlog 05:10:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:10:37 INFO - Running setup.py install for moznetwork 05:10:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:10:37 INFO - Running setup.py install for mozprocess 05:10:37 INFO - Running setup.py install for mozprofile 05:10:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:10:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:10:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:10:37 INFO - Running setup.py install for mozrunner 05:10:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:10:38 INFO - Running setup.py install for mozscreenshot 05:10:38 INFO - Running setup.py install for moztest 05:10:38 INFO - Running setup.py install for mozversion 05:10:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:10:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:38 INFO - Cleaning up... 05:10:38 INFO - Return code: 0 05:10:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:38 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')]} 05:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:38 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')]} 05:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:38 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 0x10b2db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b251570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871956faa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, '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.ZAV1J1d7FL/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.5LxncazX4b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:10:38 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 05:10:38 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 05:10:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:10:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:38 INFO - 'HOME': '/Users/cltbld', 05:10:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:38 INFO - 'LOGNAME': 'cltbld', 05:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:38 INFO - 'MOZ_NO_REMOTE': '1', 05:10:38 INFO - 'NO_EM_RESTART': '1', 05:10:38 INFO - 'PAGER': '/bin/cat', 05:10:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:38 INFO - 'PWD': '/builds/slave/test', 05:10:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:38 INFO - 'SHELL': '/bin/bash', 05:10:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:10:38 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:10:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:38 INFO - 'USER': 'cltbld', 05:10:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:38 INFO - 'XPC_FLAGS': '0x0', 05:10:38 INFO - 'XPC_SERVICE_NAME': '0', 05:10:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:10:38 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-T9QK4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:10:38 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)) 05:10:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:10:38 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-aZ_v6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:10:39 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)) 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:10:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Bt4pjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:10:39 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)) 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:10:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-FTa06D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:10:39 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)) 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:10:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-l7dZnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:10:39 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)) 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:10:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-G1qNSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:10:39 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)) 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:10:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-OlAI0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:10:39 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)) 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:10:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-O7OYSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:10:39 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)) 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:10:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ixFEFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:10:39 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)) 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:10:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-a7rM14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:10:39 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)) 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:10:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-xkbrH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:10:39 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)) 05:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:10:39 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-4ZueTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:10:40 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)) 05:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:10:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-DlHUj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:10:40 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)) 05:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:10:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-UL8bLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:10:40 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)) 05:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-t37UEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:10:40 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)) 05:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:10:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-zpi69c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:10:40 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)) 05:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:10:40 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-W0ngmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:10:40 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)) 05:10:40 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)) 05:10:40 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)) 05:10:40 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)) 05:10:40 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)) 05:10:40 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)) 05:10:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:40 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 05:10:40 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 05:10:40 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 05:10:40 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 05:10:40 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 05:10:40 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 05:10:43 INFO - Downloading blessings-1.6.tar.gz 05:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:43 INFO - Installing collected packages: blessings 05:10:43 INFO - Running setup.py install for blessings 05:10:43 INFO - Successfully installed blessings 05:10:43 INFO - Cleaning up... 05:10:43 INFO - Return code: 0 05:10:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:44 INFO - Reading from file tmpfile_stdout 05:10:44 INFO - Current package versions: 05:10:44 INFO - blessings == 1.6 05:10:44 INFO - blobuploader == 1.2.4 05:10:44 INFO - docopt == 0.6.1 05:10:44 INFO - functools32 == 3.2.3-2 05:10:44 INFO - jsonschema == 2.5.1 05:10:44 INFO - manifestparser == 1.1 05:10:44 INFO - mozInstall == 1.12 05:10:44 INFO - mozcrash == 0.17 05:10:44 INFO - mozdebug == 0.1 05:10:44 INFO - mozdevice == 0.48 05:10:44 INFO - mozfile == 1.2 05:10:44 INFO - mozhttpd == 0.7 05:10:44 INFO - mozinfo == 0.9 05:10:44 INFO - mozleak == 0.1 05:10:44 INFO - mozlog == 3.4 05:10:44 INFO - moznetwork == 0.27 05:10:44 INFO - mozprocess == 0.23 05:10:44 INFO - mozprofile == 0.28 05:10:44 INFO - mozrunner == 6.12 05:10:44 INFO - mozscreenshot == 0.1 05:10:44 INFO - mozsystemmonitor == 0.3 05:10:44 INFO - moztest == 0.7 05:10:44 INFO - mozversion == 1.4 05:10:44 INFO - psutil == 3.1.1 05:10:44 INFO - requests == 1.2.3 05:10:44 INFO - wsgiref == 0.1.2 05:10:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:44 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 0x10b2db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b251570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871956faa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, '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.ZAV1J1d7FL/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.5LxncazX4b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:10:44 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 05:10:44 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 05:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:44 INFO - 'HOME': '/Users/cltbld', 05:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:44 INFO - 'LOGNAME': 'cltbld', 05:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:44 INFO - 'MOZ_NO_REMOTE': '1', 05:10:44 INFO - 'NO_EM_RESTART': '1', 05:10:44 INFO - 'PAGER': '/bin/cat', 05:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:44 INFO - 'PWD': '/builds/slave/test', 05:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:44 INFO - 'SHELL': '/bin/bash', 05:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:10:44 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:44 INFO - 'USER': 'cltbld', 05:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:44 INFO - 'XPC_FLAGS': '0x0', 05:10:44 INFO - 'XPC_SERVICE_NAME': '0', 05:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:44 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)) 05:10:44 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)) 05:10:44 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)) 05:10:44 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)) 05:10:44 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)) 05:10:44 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)) 05:10:44 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)) 05:10:44 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)) 05:10:44 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)) 05:10:44 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)) 05:10:44 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)) 05:10:44 INFO - Cleaning up... 05:10:44 INFO - Return code: 0 05:10:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b2db490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b251570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f871956faa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, '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.ZAV1J1d7FL/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.5LxncazX4b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 05:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:44 INFO - 'HOME': '/Users/cltbld', 05:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:44 INFO - 'LOGNAME': 'cltbld', 05:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:44 INFO - 'MOZ_NO_REMOTE': '1', 05:10:44 INFO - 'NO_EM_RESTART': '1', 05:10:44 INFO - 'PAGER': '/bin/cat', 05:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:44 INFO - 'PWD': '/builds/slave/test', 05:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:44 INFO - 'SHELL': '/bin/bash', 05:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:10:44 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:44 INFO - 'USER': 'cltbld', 05:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:44 INFO - 'XPC_FLAGS': '0x0', 05:10:44 INFO - 'XPC_SERVICE_NAME': '0', 05:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:10:44 INFO - Cleaning up... 05:10:44 INFO - Return code: 0 05:10:44 INFO - Running post-action listener: _resource_record_post_action 05:10:44 INFO - Running post-action listener: _start_resource_monitoring 05:10:45 INFO - Starting resource monitoring. 05:10:45 INFO - [mozharness: 2016-10-13 12:10:45.010778Z] Finished create-virtualenv step (success) 05:10:45 INFO - [mozharness: 2016-10-13 12:10:45.011804Z] Running install step. 05:10:45 INFO - Running pre-action listener: _resource_record_pre_action 05:10:45 INFO - Running main action method: install 05:10:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:45 INFO - Reading from file tmpfile_stdout 05:10:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:45 INFO - Reading from file tmpfile_stdout 05:10:45 INFO - Output received: 05:10:45 INFO - Usage: mozinstall [options] installer 05:10:45 INFO - Options: 05:10:45 INFO - -h, --help show this help message and exit 05:10:45 INFO - -d DEST, --destination=DEST 05:10:45 INFO - Directory to install application into. [default: 05:10:45 INFO - "/builds/slave/test"] 05:10:45 INFO - --app=APP Application being installed. [default: firefox] 05:10:45 INFO - mkdir: /builds/slave/test/build/application 05:10:45 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'] 05:10:45 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 05:11:20 INFO - Reading from file tmpfile_stdout 05:11:20 INFO - Output received: 05:11:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:11:20 INFO - Running post-action listener: _resource_record_post_action 05:11:20 INFO - [mozharness: 2016-10-13 12:11:20.090564Z] Finished install step (success) 05:11:20 INFO - [mozharness: 2016-10-13 12:11:20.090677Z] Running run-tests step. 05:11:20 INFO - Running pre-action listener: _resource_record_pre_action 05:11:20 INFO - Running main action method: run_tests 05:11:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:11:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:11:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:11:20 INFO - 2016-10-13 05:11:20.105 screenresolution[1641:7716] starting screenresolution argv=screenresolution get 05:11:20 INFO - 2016-10-13 05:11:20.107 screenresolution[1641:7716] Display 0: 1600x1200x32@60 05:11:20 INFO - 2016-10-13 05:11:20.113 screenresolution[1642:7718] starting screenresolution argv=screenresolution list 05:11:20 INFO - Available Modes on Display 0 05:11:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:11:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:11:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:11:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:11:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:11:20 INFO - Intel Iris: 05:11:20 INFO - Chipset Model: Intel Iris 05:11:20 INFO - Type: GPU 05:11:20 INFO - Bus: Built-In 05:11:20 INFO - VRAM (Dynamic, Max): 1536 MB 05:11:20 INFO - Vendor: Intel (0x8086) 05:11:20 INFO - Device ID: 0x0a2e 05:11:20 INFO - Revision ID: 0x0009 05:11:20 INFO - Displays: 05:11:20 INFO - Display: 05:11:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:11:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:11:20 INFO - Display Serial Number: 1600x1200 60 05:11:20 INFO - Main Display: Yes 05:11:20 INFO - Mirror: Off 05:11:20 INFO - Online: Yes 05:11:20 INFO - Rotation: Supported 05:11:20 INFO - Return code: 0 05:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:20 INFO - Python 2.7.3 05:11:20 INFO - Return code: 0 05:11:20 INFO - grabbing minidump binary from tooltool 05:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:20 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 0x10b0efd30>, '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 0x10af15db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b0e7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:20 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 05:11:20 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 05:11:20 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 05:11:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:20 INFO - Return code: 0 05:11:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:11:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:11:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--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 05:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0345 --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 05:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZAV1J1d7FL/Render', 05:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:11:20 INFO - 'HOME': '/Users/cltbld', 05:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:11:20 INFO - 'LOGNAME': 'cltbld', 05:11:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:20 INFO - 'MOZ_NO_REMOTE': '1', 05:11:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:20 INFO - 'NO_EM_RESTART': '1', 05:11:20 INFO - 'PAGER': '/bin/cat', 05:11:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:20 INFO - 'PWD': '/builds/slave/test', 05:11:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:11:20 INFO - 'SHELL': '/bin/bash', 05:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5LxncazX4b/Listeners', 05:11:20 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 05:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:11:20 INFO - 'USER': 'cltbld', 05:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:20 INFO - 'XPC_FLAGS': '0x0', 05:11:20 INFO - 'XPC_SERVICE_NAME': '0', 05:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:11:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--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 05:11:20 INFO - mozversion application_buildid: 20161013025423 05:11:20 INFO - mozversion application_changeset: f03e2740d604d339ed553dad62a3fc54c317f8fa 05:11:20 INFO - mozversion application_display_name: Nightly 05:11:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:20 INFO - mozversion application_name: Firefox 05:11:20 INFO - mozversion application_remotingname: firefox 05:11:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:11:20 INFO - mozversion application_vendor: Mozilla 05:11:20 INFO - mozversion application_version: 52.0a1 05:11:20 INFO - mozversion platform_buildid: 20161013025423 05:11:20 INFO - mozversion platform_changeset: f03e2740d604d339ed553dad62a3fc54c317f8fa 05:11:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:11:20 INFO - mozversion platform_version: 52.0a1 05:11:20 INFO - using testdate: 1476360680 05:11:20 INFO - actual date: 1476360680 05:11:20 INFO - starting webserver on 'localhost:49272' 05:11:20 INFO - SUITE-START | Running 2 tests 05:11:20 INFO - TEST-START | dromaeo_css 05:11:20 INFO - operating with platform_type : mac_ 05:11:20 INFO - Initialising browser for dromaeo_css test... 05:11:20 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmptSmXgk/profile http://localhost:49272/getInfo.html) 05:11:23 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 05:11:23 INFO - PROCESS | 1652 | colorDepth:24 05:11:23 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 05:11:23 INFO - PROCESS | 1652 | __metrics 05:11:23 INFO - PROCESS | 1652 | 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" 05:11:23 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:24 INFO - TEST-INFO | 1652: exit 0 05:11:24 INFO - Browser initialized. 05:11:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:24 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmptSmXgk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:36 INFO - PROCESS | 1654 | RSS: Main: 236675072 05:11:36 INFO - PROCESS | 1654 | 05:12:27 INFO - PROCESS | 1654 | 1476360747630 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] 05:14:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 05:14:41 INFO - PROCESS | 1654 | RSS: Main: 369340416 05:14:41 INFO - PROCESS | 1654 | 05:17:44 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 05:17:44 INFO - PROCESS | 1654 | RSS: Main: 374087680 05:17:44 INFO - PROCESS | 1654 | 05:20:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 05:20:48 INFO - PROCESS | 1654 | RSS: Main: 343080960 05:20:48 INFO - PROCESS | 1654 | 05:23:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 05:23:51 INFO - PROCESS | 1654 | RSS: Main: 339152896 05:23:51 INFO - PROCESS | 1654 | 05:26:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 05:26:55 INFO - PROCESS | 1654 | RSS: Main: 337997824 05:26:55 INFO - PROCESS | 1654 | 05:29:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 05:29:58 INFO - PROCESS | 1654 | RSS: Main: 374558720 05:29:58 INFO - PROCESS | 1654 | 05:29:58 INFO - PROCESS | 1654 | __start_tp_report 05:29:58 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 05:29:58 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 05:29:58 INFO - PROCESS | 1654 | |i|pagename|runs| 05:29:58 INFO - PROCESS | 1654 | |0;dojo.html;3155.6528781834;3293.538904553362;3304.4052070627295;3341.114604629775;3359.277755282615;5367.46325367463;5485.61600687952;5496.148097044955;5528.281323427954;5562.833115006546;5481.616286859921;5534.557235421166;5534.916976245349;5542.0855558832845;5552.472515111068;5008.474110218429;5035.295058691786;5054.5198206170535;5074.594032477393;5127.641065125443;4297.763623000749;5065.746712664352;5119.078565858144;5151.253068305112;5202.92195617066;5130.538251557359;5142.434332223453;5151.896962060757;5212.687238765686;5212.817551385702;169.45093108197105;5110.591152707774;5152.74236288186;5186.118359878829;5238.81664141757;3045.392465410633;5039.193729003378;5087.949120508784;5121.2318152277085;5178.559822415099;5403.729813509348;5552.278203833516;5558.527525160366;5567.415421380778;5581.8604534886545;5862.912056319158;5968.134620480049;5996.040633498619;6006.699665016776;6020.608660437101;6024.307204671475;6039.909401358983;6043.607165534227;6067.605605635619;6111.87776244477;5578.24693666358;5597.216389705444;5602.635828671123;5627;5633.971830140905;6284.748610055546;6287.465565426898;6307;6307.810765677037;6320.462760665395;5781.277340332458;5805.8548536286935;5816.12758086282;5869.911951320733;5916.674582897982;6086.239220097488;6099.237595300588;6108.511319094462;6111.57218994675;6120.326764055951;6008.639481631116;6021.608595441282;6033.396660333931;6036.939630603725;6042.9122757904;5839.299284085937;5846.327672317653;5912.881742365129;5994.760209591567;6123.571350005546;4795.640326975491;4797.496262892416;4800.879978000508;4807.807687692453;4819.204831202812;4334.804933777988;4380.189664912002;4392.714473559208;4398.274284743045;4401.691881568324;5497.5601951843755;5544.61187716856;5581.5255703265675;5590.413006634326;5593.105103183471;6042.4561789438285;6107.389261073857;6123;6124.686092398479;6145.293291271471;4807.471178170398;5567.777288908479;5587.804426845041;5590.832275031756;5640.689762063126;5150.098732721759;5271.314729085195;5272.604554658416;5284.180951952453;5319.148936170194;6221.129041934133;6257.311695713468;6278.215223097113;6285.779997700059;6298.779542715983;6156.846078848064;6157.96921015392;6160.722767475385;6161.137440758208;6180.690965451619;6300.495960323072;6307.148534947723;6321.241451025722;6323.715432805443;6337.841553961003;5859.970700146472;5923.200367950271;5941.257342832146;5990.64056156632;5991.400859913973;5954.821355359346;5978.4021597839865;5986.07215881539;6012.789552365646;6091.817245482643;5842.766289348378;5845.561582881216;5858;5863.296404431496;5867.853303667443;5511.3937466879415;5647.350554686263;5803.65178089316;5862.149988251595;5870.236869206976;4822.68652537584;5453.127499600045;5517.337919449692;5672.546196304368;5721.971390143022;5834.94165058344;5845.795397161079;5850.12248162779;5858.502027327725;5882.705864706833;5669.149627555899;5682.204491371129;5691.914621280767;5701.173329867063;5704.486596206361 05:29:58 INFO - PROCESS | 1654 | |1;ext.html;486.1540918801286;487.05997424969803;503.0065620399709;515.7369741431869;523.6570046619463;29174.708252917466;38950.41574376383;39973.80013099938;40049.79975100121;42189.7890510547;40571.797141014256;41027.38458923119;41062.17875642493;41112;41172.58827411733;9406;9575.61697532098;9586.424814511116;9592.712218633453;9615.903840961606;8505.914940850575;8741.038485766592;11324.547018119307;11587;11595.884041159565;11422.314661120317;11492.597759078433;11516.481758320895;11523.942380288128;11589.942050289737;11481.311121332747;11563.826542601868;11572.189946703735;11589.420528973602;11601;8407.579621018986;8636.697715579987;11178.552857885676;11475.942620286845;11560.768784624344;39193.41209881854;39434.21131577352;39458.60541394607;39567.208655826726;39622;3204.951925721116;3290.7696461247724;3364.327134573095;3385.492176173569;3666.944995825065;30153.465346534653;30165;30373.848130759427;30465.086047418612;31088.533671994937;3190;3190.441672707267;3210.6307774605752;3283.4254005549174;3292.226326813197;470453;470947;471891;473445;480568;55564.888702225726;55835.44164558302;55845.16232256519;55904;56015;58218.7089064552;58269.70865145647;58350.4164958345;58374;58427.70786146042;13261.403236854365;15248.085114893142;15666.92659908432;15678.137702426477;15691.058536487848;11168.832467512993;12267.754644907052;12349.93825030869;12364.567240146731;12382.5666101686;11849.289042657469;13101.344932753324;14571.489997850236;14849.257537123101;14934.431884651955;5435.7825686972865;6615.338466153346;6638.336166383323;6644.501662375341;6663.666816659148;815.8857759913617;838.1450920061503;888.8622263549161;904.9592768325441;912.9136327769933;28089.859550702116;29157.556590382665;29202.269943251165;29377.559336609967;29434.705652943197;914.6935776514943;970.8980557041409;978.3933960944261;1057.4818339013982;1063.9734006649896;12312.384380781104;14222.644433889236;14838.851611483962;14867.405303787944;15165.848341516665;634078;638963;639231;640010;640806;54971.900561989336;55203.72398138064;55230;55240.17139742907;55368.446315537134;1304.4586496603993;1352.452256835983;1353.5397964692052;1360.0207850347733;1365.8838998685023;28362.57456138118;28447.715522844508;28523.001694940576;29122.12633620995;29183.416331673674;47456.7627161862;47466.28800568063;47499;47667.523324766305;47789.761051194524;579491.1025444845;584954.1064250923;585381;585709;587466;22991.195308164133;24182.39544011414;24259.150929717376;24589;24771.62842557327;38359.04102397351;38814.835554933394;38884.416733748454;40220.3966940502;45430.318545221184;37135.13000094991;37694.8115259422;38033.619663804115;38626.66093442237;39189.80405097956;37358.813205933795;37712.795716111745;38484;38578.421323680726;38581;36700.63299366972;36944.1764711736;37654;37779.81110094432;37976.62023379731;27896.44207115887;32196.517052243766;33217.667823321455;33442.83278583591;33536.49695254622;24420.26739197827;24751;24770.628440573768;25101;25758.356041099123 05:29:58 INFO - PROCESS | 1654 | |2;jquery.html;344.5348779148149;360.1266927700326;364.606225276701;366.9724770642201;387.82741679952414;14687.926560367197;14844.628884277885;15794.289256983435;20039.699404508945;20715.482112947186;17563.73654395185;20087.397378078644;20248.797512024874;20299.594008119828;20552.280670176548;5569.777208911649;5852.619579727326;5872.265966754156;5924.081767326072;5934.5845790794665;5077.213031980049;5589.552835773128;5739.799107031255;5801.361850196475;5808.680522571257;5665.801696940608;5763.798267060653;5766.394528574502;5770.480656740892;5772.797952071678;5544.445555444464;5700.91448628273;5757.424257574209;5770.19217309577;5778.075507918713;4863.805447782084;4952.232403977353;5035.320231768701;5036.143855544567;5054.797808087672;25170.86731097105;25550.488990220092;25742.74257257422;25822.096226632166;26054;2171.185805323004;2435.939101522476;2475.0347364527847;2630.8684565771637;2654.0047482194177;15321.6169595761;15367.923160384127;15628;16018.038917664977;16189.757153642704;1847.8429333506667;1866.337450205171;1958.7159861820098;1968.4586738646844;1981.9801801982085;86080.27496734259;101635.47546786805;107318;108973;109303.45348273207;9210.861837072449;11103;11383.430828458544;11441.656750297505;11548.59579914699;13970.720585588231;14118.152910825384;14320.856791432161;14336.85663143376;14376.137431754129;8079;8223.54770487629;8251.29863961558;8346.290565302017;8383.916160838313;7824.608769561613;7961.124276329715;7981.840363192704;8182.795430114175;8200.835983280302;4445.377647129404;4534.727916325031;4535.63714902807;4629.51390104041;4638.165130276582;1887.546988722724;1894.7915729269769;1912.4740696308627;1953.9023048847785;1960.7941166177632;818.6357071103301;916.3209713002301;947.6683160893632;957.7222605444343;966.4056605187759;16002.359905603878;19924.90037549803;20653.27713530019;20684.58630827375;20748.896255518626;844.7918581942257;862.2929198057658;869.7695110795644;971.8007808399261;971.9902800972042;9300.627974880928;10612.734681632866;11201.71995700114;11239.269447485887;11242.550297988153;594055.3863998826;603508;604118;613690;616272;89775.55112224397;101284;103478;111143;112733;887.3123329419751;890.9153630405231;933.4399360383716;998.8351921932945;1005.4419797012728;19219.13513891906;19228.71156932675;19281.710774338117;19479;19599.608007839477;56058;56499;57047.42952570421;57464;57467;76630;81502.3699526018;82100.58949705213;82401;82802;7832.882506762289;7993.320567751573;8122.228388303101;8158.265756081981;8180.181981801772;11267.549298027987;12845.293508856728;12967.092303538662;13251.933740331237;13340;10746.032857042903;11078.723031923944;11154.721131971766;11242.775144497227;11384.14618903569;9642.758931026781;10866.782664346827;10946.781064378827;11021.614243501439;11337.433128343715;11123.555057797921;11303.943480282545;11349.092072634005;11543.134264930331;11593.6521904343;8053.436259461781;8099.028116626043;8137.918620813716;8143.429959902987;8155.632996515053;9774.804503910023;11158.330500170016;11410.543578256777;11421.714457138638;11507.654770356903 05:29:58 INFO - PROCESS | 1654 | |3;mootools.html;1483.6216764724993;1513.1980050573193;1694.6356533345336;1860.3116846766698;1871.6911709567921;6669.266380698119;8181.91818081819;8378.539180345086;8854.778630534232;8855.335849811267;7980.521168729881;8331.58384068621;8605.526696031715;8613.138686131384;8663.176998185163;2047.3857842647221;2319.6404557293645;2336.995092110392;2346.8005219556358;2351.564960482316;2046.6623007203868;2127;2315.513742114158;2332.1371092695726;2370.2533701883854;2145.442185031887;2291.4385975436044;2364.9645255321184;2365.302235840423;2369.360272726363;2001.9199232030846;2306.4579823741406;2333.5099629077913;2336.439254578906;2346.624540073597;2302.320815359473;2321.454458202321;2327.755585663515;2328.1036800831635;2330.4406942333885;8703.695370662059;8726.650933962634;8787.209151176361;8810.163034511712;8815.867761983576;5061.392632884077;5229.378892543324;5233.084210263189;5242.239875218072;5244.685318880879;3565.286942611488;3565.625609311011;3628.092976755811;3642.1623026704005;3645.4167333226824;1055.984160237597;1067.2795862792661;1071.539238127605;1083.4149559238;1091.5251865438481;11549.422528873607;11595.652130436016;11603.651890443216;11625.59310424131;11684.532618695242;4473.6868419211;4474.709143905636;4650.139724151043;4752.809887604457;4760.690555113906;9070.682526111554;9828;9835.360701554377;9852.45811480361;9872.60509579623;5220.686758794484;5226.686398816008;5227.085260079471;5252.395974462909;5255.605829562798;4641.118187544355;4781.402324709411;4802.567768900815;4813.253945638432;4813.975930120327;3830.482884810571;3849.4995650565247;3867.9226415472094;3935.5080614923136;3978.1844721831953;1122.2256642916361;1161.7211869151513;1198.7542553776454;1242.9005679545614;1259.508791571288;717.4619035723208;867.1891781184613;887.2990337633327;912.543728135932;983.5623147699205;4996.275540046673;5469.906018796257;5839.299284085937;6112.235970503687;6135.447809697149;861.8410880743822;869.8303830752942;891.6344298837446;945.1776954049883;967.4098799732158;3681.8770275065826;3886.9065588454996;4064.552899181088;4075.347944328893;4127.153933443637;8959.328050396116;10873.401962892116;10880.510377032893;10902.291351062155;10904.563817447372;10840.945795270973;10845.945770271099;10861;10867.45662716861;10873;8002.159773223844;8225.79435514117;8236.958815206006;8242.423030387936;8249.257566819015;5776.220210271727;5890.440408161217;6097.634141951497;6174.629522228501;6178.196834411498;9480.57337419804;9883.901160988298;10057;10129.240306977154;10135.239857010902;8700.912990870263;10027.548760305657;10163.186945044527;10185.592576296865;10208.979102089732;7373.078365204349;7411.62941852916;7538.509996850187;7554.811129721801;7559.470837041355;8046;8084.514929104273;8110.635021423932;8163.306118979954;8234.917650823654;7162.606056666933;7338.596377199306;7390.815229619303;7416.851662966603;7586.468947173645;7252.311030452099;7319.304666056716;7368.005319282042;7418.740344087931;7459.440541959266;6766.661666916733;6918.169819621678;7015.438764898694;7023.754168604074;7062.611556364449;4912.7543622818;4928.67963582366;4963.602911767122;4997.575206107522;5097.235414687826;4479.0817882334695;4979.228219625964;4989.575886049582;5055.494450554915;5146.382434107931 05:29:58 INFO - PROCESS | 1654 | |4;prototype.html;276.42641518848393;294.9026821149021;304.7196579147185;307.9615048118985;311.36015488171796;4713.858584242474;4777.283407488874;4975.701457912528;5264.341957255343;5317.787288508464;4201.957980420195;4899.975500122495;5101.821436249723;5112.079825631394;5208.593679706486;3765.943510847326;3817.6373244541865;3974.3839704845795;3976.3041467743174;3979;3783.697304215656;3951.940720889189;3959.7922633596886;3980.1641655252433;4002.3396139636925;3534.9571876296427;3617.408340330246;3739.551253849528;3940.3104456720102;3999.800009999503;3949.921001579981;3954.5649978502342;3966.9884179534033;3979.8607048753156;3996.980769903685;3417.624061353249;3429.262708517656;3429.605595356541;3432.9059273843186;3446.7414943879307;4211.410402543646;5101.617378696613;5102.9078077988215;5103.668261563023;5149.241054030579;4235.830566777326;4444.266695995157;4480.395146655193;4496.100779844011;4560.612347950429;4519.683622146451;5461.317335333083;5483.533899618537;5483.588730845203;5556.527695145917;3175.714185723296;3418.384690755663;3682.779033258013;3682.85678611562;3744.756590821588;5441.483059109379;5489.890202195974;5725.656460612335;5726.427357264281;5747.994101032303;3817.6945844332386;3819.3507103791867;3824.521934758155;3833.463315135883;3854.768713877176;3172.8254945977733;3896.9610303897166;3935.6457918787446;3948.6446219840354;3952.5454572724507;3699.4820725098507;4378.759168245777;4472.0608672179205;4561.589456948891;4606.585407313358;4253.893652658647;4925.507449255046;5464.480874316933;5497.505224529811;5593.496585307342;1096.0354887698775;1132;1162.6802629277017;1226.9141809498658;1334.813126162338;823.3084209264247;850.3154960256929;853.3642436384933;869.7260362985639;873.5850471026212;4346.195953748566;4682.578567928903;4857.004314115668;5060.51925067118;5113.821016264413;5010.674306170087;5505.807296744675;5540.667559946416;5557.833265001976;5598.972005139948;4422.678094000676;4778.228627396102;4843.539863712942;5131.640785145079;5207.047357241035;2663.9733602663723;2789.8744556495008;2912.606798082274;2945.4550908082074;2976.8836686242657;5851.912221316684;5877.265341832271;5879.676617785977;5887.322957859816;5895.793647222413;5411.404745477994;5660.801871934463;5664.830055098354;5742.368339482654;5768.884622307614;5747;5781.710914454345;5809.419058094241;5829.679367634821;5863.032599621015;5107.591392688651;5153.561947234527;5554.222408862844;5572.3034620672415;5636.140073775726;4510.413646226101;5494.890102198014;5534;5554;5576.414476479911;5392.649477783932;5435.646682965595;5886.882262354815;5927.110933360031;5945.681184338026;3259.152620318782;3332.833358332025;3362.4620060790157;3746.3818469952153;3823.502944617182;5426.023315803193;5428.864278393072;5440.401555828935;5544.251526043932;5551.306086739158;5353.4571078738845;5378.892422151457;5394.004218439202;5406.324209473816;5425.376081750649;4748.3827102477835;5134.409542902614;5314.864230104103;5352.063388907003;5443.727813609383;4219.894502637459;5198.8960220794615;5242.213667949838;5260.237265596544;5265.6835791052235;4558.772061396983;5219;5233.822389962228;5322.733863306742;5451.754671039734;4956.77694503741;5323.680579165262;5354.089804733127;5421.484958928895;5421.861409104133 05:29:58 INFO - PROCESS | 1654 | |5;yui.html;676.1142902797334;711.33845523663;712.4264966701803;719.9856002879942;832.7501749475156;13714.588562343133;14741.926290368547;15790.526284211477;16410.343586256535;16425.17874106296;15690.686186276296;15809.051456912593;15816.209189540506;15833.050016998988;15873.603159921007;836.456303402787;854.995725021374;860.7934095817021;861.2980420956932;864.844328020956;682.7064362324198;699.6921354603984;703.5884007855385;824.4764574495209;840.7729912923508;852.1733918099465;903.5030733096803;905.868649045888;908.9409188402733;909.3543584055295;800.7148526614816;878.5124256037897;902.296208957008;902.891653001644;903.2818908967387;521.0724909660772;537.3471232452589;539.2477493896032;540.5081375947868;646.977355792545;14043.157410555297;14377.353019114165;14500.347484363123;14504.492342768059;14515.419383224658;13604.183748974994;14027.438902443992;14118;14123.223222722747;14132.293385330693;11350.375729334883;11539.826902596467;11648.650540483799;11711.121665875009;11975.64073077809;3577.6783978222757;3605.56733192016;3632.0738211755834;3632.5640923089136;3733;108497.91502084957;110287.44856275668;110302;110307.44846275717;111496.4425177869;9548.331616786758;10192.898071019343;10200.3369780964;10275.588976441008;10684.038436540748;20935.68596471054;21278.893605531874;21344.146234150772;21639.078724372324;21727.78272217289;7230.891536626955;7337.41300695943;7378.852422951618;7383.003294555274;7476;4132.896677583084;4228.682848786353;4246.426732391088;4290.613844753924;4421.513633500313;3483.512308276843;3600.963990360115;3601.2077342984503;3603.387424137903;3608.025833025121;610.5878531990888;612.3600837125215;615.7013848283578;626.9968650156811;631.7283568065776;543.9184122381595;633.7686744338283;640.8397900524869;648.4552975500602;655.1025095619033;8411.285040771603;8532.616032278562;8766.868496972551;8808.647654093764;8907.955460222658;601.7713268957856;612.2194202391986;638.1225814505055;648.7567162314132;653.6143675231541;3578.6421357864006;4245.299525578307;4298.591633794785;4299.118680670517;4358.978205109018;96316.03417504423;111780;159682;166513;168666;127512;127577;133814.3309283467;134407.32796336152;145988;64783;102545;115217.42391288158;121677;124558.3772081152;8122.959385203036;8953.373263871466;8972.102789721237;8979.551022448983;9142.3600347975;52266;57473;59691;60021;63374.36625633869;82207.58896205481;89485;90155.54922225347;92001;95302;12223.511059557519;12347.567835125728;12653.304068276333;13144.342782860627;13279.66800829987;12350.258984460961;14347.641308967359;14370.784438233226;14488.348024338718;15044.323005465;13070.085094043327;13776.448942042207;13940.79088813689;13971.930140349234;14013.089149205269;13145.53990610324;13460.663483412993;13625.86374136246;13857.30713464343;13876.930615347263;12916.28960407149;13163.463015544956;13341.273977021685;13576.86423135756;13645.385957631732;11087.8285337964;11092.889071109186;11290.379029153475;11326.37704926204;11534.711632209262;8229.588520574067;9356.625734970525;9918.111897157023;9925.503724813874;10046.497675116361 05:29:58 INFO - PROCESS | 1654 | __end_tp_report 05:29:58 INFO - PROCESS | 1654 | __start_cc_report 05:29:58 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1389 05:29:58 INFO - PROCESS | 1654 | __end_cc_report 05:29:58 INFO - PROCESS | 1654 | __startTimestamp1476361798570__endTimestamp 05:29:58 INFO - PROCESS | 1654 | 05:29:58 INFO - PROCESS | 1654 | ------- Summary: start ------- 05:29:58 INFO - PROCESS | 1654 | Number of tests: 6 05:29:58 INFO - PROCESS | 1654 | 05:29:58 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5532.83 Median:5682.20 stddev:775.64 (13.7%) stddev-sans-first:755.27 05:29:58 INFO - PROCESS | 1654 | Values: 3155.7 3293.5 3304.4 3341.1 3359.3 5367.5 5485.6 5496.1 5528.3 5562.8 5481.6 5534.6 5534.9 5542.1 5552.5 5008.5 5035.3 5054.5 5074.6 5127.6 4297.8 5065.7 5119.1 5151.3 5202.9 5130.5 5142.4 5151.9 5212.7 5212.8 169.5 5110.6 5152.7 5186.1 5238.8 3045.4 5039.2 5087.9 5121.2 5178.6 5403.7 5552.3 5558.5 5567.4 5581.9 5862.9 5968.1 5996.0 6006.7 6020.6 6024.3 6039.9 6043.6 6067.6 6111.9 5578.2 5597.2 5602.6 5627.0 5634.0 6284.7 6287.5 6307.0 6307.8 6320.5 5781.3 5805.9 5816.1 5869.9 5916.7 6086.2 6099.2 6108.5 6111.6 6120.3 6008.6 6021.6 6033.4 6036.9 6042.9 5839.3 5846.3 5912.9 5994.8 6123.6 4795.6 4797.5 4800.9 4807.8 4819.2 4334.8 4380.2 4392.7 4398.3 4401.7 5497.6 5544.6 5581.5 5590.4 5593.1 6042.5 6107.4 6123.0 6124.7 6145.3 4807.5 5567.8 5587.8 5590.8 5640.7 5150.1 5271.3 5272.6 5284.2 5319.1 6221.1 6257.3 6278.2 6285.8 6298.8 6156.8 6158.0 6160.7 6161.1 6180.7 6300.5 6307.1 6321.2 6323.7 6337.8 5860.0 5923.2 5941.3 5990.6 5991.4 5954.8 5978.4 5986.1 6012.8 6091.8 5842.8 5845.6 5858.0 5863.3 5867.9 5511.4 5647.4 5803.7 5862.1 5870.2 4822.7 5453.1 5517.3 5672.5 5722.0 5834.9 5845.8 5850.1 5858.5 5882.7 5669.1 5682.2 5691.9 5701.2 5704.5 05:29:58 INFO - PROCESS | 1654 | 05:29:58 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:68913.63 Median:37746.30 stddev:152405.98 (403.8%) stddev-sans-first:152746.92 05:29:58 INFO - PROCESS | 1654 | Values: 486.2 487.1 503.0 515.7 523.7 29174.7 38950.4 39973.8 40049.8 42189.8 40571.8 41027.4 41062.2 41112.0 41172.6 9406.0 9575.6 9586.4 9592.7 9615.9 8505.9 8741.0 11324.5 11587.0 11595.9 11422.3 11492.6 11516.5 11523.9 11589.9 11481.3 11563.8 11572.2 11589.4 11601.0 8407.6 8636.7 11178.6 11475.9 11560.8 39193.4 39434.2 39458.6 39567.2 39622.0 3205.0 3290.8 3364.3 3385.5 3666.9 30153.5 30165.0 30373.8 30465.1 31088.5 3190.0 3190.4 3210.6 3283.4 3292.2 470453.0 470947.0 471891.0 473445.0 480568.0 55564.9 55835.4 55845.2 55904.0 56015.0 58218.7 58269.7 58350.4 58374.0 58427.7 13261.4 15248.1 15666.9 15678.1 15691.1 11168.8 12267.8 12349.9 12364.6 12382.6 11849.3 13101.3 14571.5 14849.3 14934.4 5435.8 6615.3 6638.3 6644.5 6663.7 815.9 838.1 888.9 905.0 912.9 28089.9 29157.6 29202.3 29377.6 29434.7 914.7 970.9 978.4 1057.5 1064.0 12312.4 14222.6 14838.9 14867.4 15165.8 634078.0 638963.0 639231.0 640010.0 640806.0 54971.9 55203.7 55230.0 55240.2 55368.4 1304.5 1352.5 1353.5 1360.0 1365.9 28362.6 28447.7 28523.0 29122.1 29183.4 47456.8 47466.3 47499.0 47667.5 47789.8 579491.1 584954.1 585381.0 585709.0 587466.0 22991.2 24182.4 24259.2 24589.0 24771.6 38359.0 38814.8 38884.4 40220.4 45430.3 37135.1 37694.8 38033.6 38626.7 39189.8 37358.8 37712.8 38484.0 38578.4 38581.0 36700.6 36944.2 37654.0 37779.8 37976.6 27896.4 32196.5 33217.7 33442.8 33536.5 24420.3 24751.0 24770.6 25101.0 25758.4 05:29:58 INFO - PROCESS | 1654 | 05:29:58 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:34312.85 Median:352.33 stddev:100345.37 (28480.4%) stddev-sans-first:100594.45 05:29:58 INFO - PROCESS | 1654 | Values: 344.5 360.1 364.6 367.0 387.8 14687.9 14844.6 15794.3 20039.7 20715.5 17563.7 20087.4 20248.8 20299.6 20552.3 5569.8 5852.6 5872.3 5924.1 5934.6 5077.2 5589.6 5739.8 5801.4 5808.7 5665.8 5763.8 5766.4 5770.5 5772.8 5544.4 5700.9 5757.4 5770.2 5778.1 4863.8 4952.2 5035.3 5036.1 5054.8 25170.9 25550.5 25742.7 25822.1 26054.0 2171.2 2435.9 2475.0 2630.9 2654.0 15321.6 15367.9 15628.0 16018.0 16189.8 1847.8 1866.3 1958.7 1968.5 1982.0 86080.3 101635.5 107318.0 108973.0 109303.5 9210.9 11103.0 11383.4 11441.7 11548.6 13970.7 14118.2 14320.9 14336.9 14376.1 8079.0 8223.5 8251.3 8346.3 8383.9 7824.6 7961.1 7981.8 8182.8 8200.8 4445.4 4534.7 4535.6 4629.5 4638.2 1887.5 1894.8 1912.5 1953.9 1960.8 818.6 916.3 947.7 957.7 966.4 16002.4 19924.9 20653.3 20684.6 20748.9 844.8 862.3 869.8 971.8 972.0 9300.6 10612.7 11201.7 11239.3 11242.6 594055.4 603508.0 604118.0 613690.0 616272.0 89775.6 101284.0 103478.0 111143.0 112733.0 887.3 890.9 933.4 998.8 1005.4 19219.1 19228.7 19281.7 19479.0 19599.6 56058.0 56499.0 57047.4 57464.0 57467.0 76630.0 81502.4 82100.6 82401.0 82802.0 7832.9 7993.3 8122.2 8158.3 8180.2 11267.5 12845.3 12967.1 13251.9 13340.0 10746.0 11078.7 11154.7 11242.8 11384.1 9642.8 10866.8 10946.8 11021.6 11337.4 11123.6 11303.9 11349.1 11543.1 11593.7 8053.4 8099.0 8137.9 8143.4 8155.6 9774.8 11158.3 11410.5 11421.7 11507.7 05:29:58 INFO - PROCESS | 1654 | 05:29:58 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5651.55 Median:4984.40 stddev:3172.77 (63.7%) stddev-sans-first:3166.21 05:29:58 INFO - PROCESS | 1654 | Values: 1483.6 1513.2 1694.6 1860.3 1871.7 6669.3 8181.9 8378.5 8854.8 8855.3 7980.5 8331.6 8605.5 8613.1 8663.2 2047.4 2319.6 2337.0 2346.8 2351.6 2046.7 2127.0 2315.5 2332.1 2370.3 2145.4 2291.4 2365.0 2365.3 2369.4 2001.9 2306.5 2333.5 2336.4 2346.6 2302.3 2321.5 2327.8 2328.1 2330.4 8703.7 8726.7 8787.2 8810.2 8815.9 5061.4 5229.4 5233.1 5242.2 5244.7 3565.3 3565.6 3628.1 3642.2 3645.4 1056.0 1067.3 1071.5 1083.4 1091.5 11549.4 11595.7 11603.7 11625.6 11684.5 4473.7 4474.7 4650.1 4752.8 4760.7 9070.7 9828.0 9835.4 9852.5 9872.6 5220.7 5226.7 5227.1 5252.4 5255.6 4641.1 4781.4 4802.6 4813.3 4814.0 3830.5 3849.5 3867.9 3935.5 3978.2 1122.2 1161.7 1198.8 1242.9 1259.5 717.5 867.2 887.3 912.5 983.6 4996.3 5469.9 5839.3 6112.2 6135.4 861.8 869.8 891.6 945.2 967.4 3681.9 3886.9 4064.6 4075.3 4127.2 8959.3 10873.4 10880.5 10902.3 10904.6 10840.9 10845.9 10861.0 10867.5 10873.0 8002.2 8225.8 8237.0 8242.4 8249.3 5776.2 5890.4 6097.6 6174.6 6178.2 9480.6 9883.9 10057.0 10129.2 10135.2 8700.9 10027.5 10163.2 10185.6 10209.0 7373.1 7411.6 7538.5 7554.8 7559.5 8046.0 8084.5 8110.6 8163.3 8234.9 7162.6 7338.6 7390.8 7416.9 7586.5 7252.3 7319.3 7368.0 7418.7 7459.4 6766.7 6918.2 7015.4 7023.8 7062.6 4912.8 4928.7 4963.6 4997.6 5097.2 4479.1 4979.2 4989.6 5055.5 5146.4 05:29:58 INFO - PROCESS | 1654 | 05:29:58 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4418.18 Median:5035.60 stddev:1372.85 (27.3%) stddev-sans-first:1341.04 05:29:58 INFO - PROCESS | 1654 | Values: 276.4 294.9 304.7 308.0 311.4 4713.9 4777.3 4975.7 5264.3 5317.8 4202.0 4900.0 5101.8 5112.1 5208.6 3765.9 3817.6 3974.4 3976.3 3979.0 3783.7 3951.9 3959.8 3980.2 4002.3 3535.0 3617.4 3739.6 3940.3 3999.8 3949.9 3954.6 3967.0 3979.9 3997.0 3417.6 3429.3 3429.6 3432.9 3446.7 4211.4 5101.6 5102.9 5103.7 5149.2 4235.8 4444.3 4480.4 4496.1 4560.6 4519.7 5461.3 5483.5 5483.6 5556.5 3175.7 3418.4 3682.8 3682.9 3744.8 5441.5 5489.9 5725.7 5726.4 5748.0 3817.7 3819.4 3824.5 3833.5 3854.8 3172.8 3897.0 3935.6 3948.6 3952.5 3699.5 4378.8 4472.1 4561.6 4606.6 4253.9 4925.5 5464.5 5497.5 5593.5 1096.0 1132.0 1162.7 1226.9 1334.8 823.3 850.3 853.4 869.7 873.6 4346.2 4682.6 4857.0 5060.5 5113.8 5010.7 5505.8 5540.7 5557.8 5599.0 4422.7 4778.2 4843.5 5131.6 5207.0 2664.0 2789.9 2912.6 2945.5 2976.9 5851.9 5877.3 5879.7 5887.3 5895.8 5411.4 5660.8 5664.8 5742.4 5768.9 5747.0 5781.7 5809.4 5829.7 5863.0 5107.6 5153.6 5554.2 5572.3 5636.1 4510.4 5494.9 5534.0 5554.0 5576.4 5392.6 5435.6 5886.9 5927.1 5945.7 3259.2 3332.8 3362.5 3746.4 3823.5 5426.0 5428.9 5440.4 5544.3 5551.3 5353.5 5378.9 5394.0 5406.3 5425.4 4748.4 5134.4 5314.9 5352.1 5443.7 4219.9 5198.9 5242.2 5260.2 5265.7 4558.8 5219.0 5233.8 5322.7 5451.8 4956.8 5323.7 5354.1 5421.5 5421.9 05:29:58 INFO - PROCESS | 1654 | 05:29:58 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24359.66 Median:3620.05 stddev:39415.58 (1088.8%) stddev-sans-first:39486.04 05:29:58 INFO - PROCESS | 1654 | Values: 676.1 711.3 712.4 720.0 832.8 13714.6 14741.9 15790.5 16410.3 16425.2 15690.7 15809.1 15816.2 15833.1 15873.6 836.5 855.0 860.8 861.3 864.8 682.7 699.7 703.6 824.5 840.8 852.2 903.5 905.9 908.9 909.4 800.7 878.5 902.3 902.9 903.3 521.1 537.3 539.2 540.5 647.0 14043.2 14377.4 14500.3 14504.5 14515.4 13604.2 14027.4 14118.0 14123.2 14132.3 11350.4 11539.8 11648.7 11711.1 11975.6 3577.7 3605.6 3632.1 3632.6 3733.0 108497.9 110287.4 110302.0 110307.4 111496.4 9548.3 10192.9 10200.3 10275.6 10684.0 20935.7 21278.9 21344.1 21639.1 21727.8 7230.9 7337.4 7378.9 7383.0 7476.0 4132.9 4228.7 4246.4 4290.6 4421.5 3483.5 3601.0 3601.2 3603.4 3608.0 610.6 612.4 615.7 627.0 631.7 543.9 633.8 640.8 648.5 655.1 8411.3 8532.6 8766.9 8808.6 8908.0 601.8 612.2 638.1 648.8 653.6 3578.6 4245.3 4298.6 4299.1 4359.0 96316.0 111780.0 159682.0 166513.0 168666.0 127512.0 127577.0 133814.3 134407.3 145988.0 64783.0 102545.0 115217.4 121677.0 124558.4 8123.0 8953.4 8972.1 8979.6 9142.4 52266.0 57473.0 59691.0 60021.0 63374.4 82207.6 89485.0 90155.5 92001.0 95302.0 12223.5 12347.6 12653.3 13144.3 13279.7 12350.3 14347.6 14370.8 14488.3 15044.3 13070.1 13776.4 13940.8 13971.9 14013.1 13145.5 13460.7 13625.9 13857.3 13876.9 12916.3 13163.5 13341.3 13576.9 13645.4 11087.8 11092.9 11290.4 11326.4 11534.7 8229.6 9356.6 9918.1 9925.5 10046.5 05:29:58 INFO - PROCESS | 1654 | -------- Summary: end -------- 05:29:58 INFO - PROCESS | 1654 | 05:29:59 INFO - TEST-INFO | 1654: exit 0 05:29:59 INFO - TEST-OK | dromaeo_css | took 1118496ms 05:29:59 INFO - TEST-START | kraken 05:29:59 INFO - operating with platform_type : mac_ 05:29:59 INFO - Initialising browser for kraken test... 05:29:59 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpjt1pyJ/profile http://localhost:49272/getInfo.html) 05:30:01 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 05:30:01 INFO - PROCESS | 1661 | colorDepth:24 05:30:01 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 05:30:01 INFO - PROCESS | 1661 | __metrics 05:30:01 INFO - PROCESS | 1661 | 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" 05:30:01 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:02 INFO - TEST-INFO | 1661: exit 0 05:30:02 INFO - Browser initialized. 05:30:02 INFO - Running cycle 1/1 for kraken test... 05:30:02 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpjt1pyJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:14 INFO - PROCESS | 1663 | RSS: Main: 236769280 05:30:14 INFO - PROCESS | 1663 | 05:30:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:18 INFO - PROCESS | 1663 | RSS: Main: 294334464 05:30:18 INFO - PROCESS | 1663 | 05:30:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 05:30:21 INFO - PROCESS | 1663 | RSS: Main: 296407040 05:30:21 INFO - PROCESS | 1663 | 05:30:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 05:30:25 INFO - PROCESS | 1663 | RSS: Main: 384008192 05:30:25 INFO - PROCESS | 1663 | 05:30:27 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 05:30:28 INFO - PROCESS | 1663 | RSS: Main: 287363072 05:30:28 INFO - PROCESS | 1663 | 05:30:30 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:31 INFO - PROCESS | 1663 | RSS: Main: 291430400 05:30:31 INFO - PROCESS | 1663 | 05:30:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:34 INFO - PROCESS | 1663 | RSS: Main: 329760768 05:30:34 INFO - PROCESS | 1663 | 05:30:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:37 INFO - PROCESS | 1663 | RSS: Main: 330555392 05:30:37 INFO - PROCESS | 1663 | 05:30:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 05:30:41 INFO - PROCESS | 1663 | RSS: Main: 330407936 05:30:41 INFO - PROCESS | 1663 | 05:30:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:43 INFO - PROCESS | 1663 | RSS: Main: 301584384 05:30:43 INFO - PROCESS | 1663 | 05:30:45 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:46 INFO - PROCESS | 1663 | RSS: Main: 305823744 05:30:46 INFO - PROCESS | 1663 | 05:30:48 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:48 INFO - PROCESS | 1663 | RSS: Main: 311652352 05:30:48 INFO - PROCESS | 1663 | 05:30:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:52 INFO - PROCESS | 1663 | RSS: Main: 326266880 05:30:52 INFO - PROCESS | 1663 | 05:30:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:56 INFO - PROCESS | 1663 | RSS: Main: 320139264 05:30:56 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 05:30:58 INFO - PROCESS | 1663 | RSS: Main: 364179456 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | __start_tp_report 05:30:58 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 05:30:58 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 05:30:58 INFO - PROCESS | 1663 | |i|pagename|runs| 05:30:58 INFO - PROCESS | 1663 | |0;ai-astar;121;163;140;113;113;112;112;113;113;112 05:30:58 INFO - PROCESS | 1663 | |1;audio-beat-detection;148;113;117;150;114;121;114;115;146;112 05:30:58 INFO - PROCESS | 1663 | |2;audio-dft;194;265;200;183;186;184;185;185;257;185 05:30:58 INFO - PROCESS | 1663 | |3;audio-fft;81;60;76;112;84;63;60;59;82;57 05:30:58 INFO - PROCESS | 1663 | |4;audio-oscillator;84;71;93;70;68;69;91;66;68;89 05:30:58 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;90;83;129;130;88;84;89;86;88;84 05:30:58 INFO - PROCESS | 1663 | |6;imaging-darkroom;94;93;93;94;94;94;93;93;92;94 05:30:58 INFO - PROCESS | 1663 | |7;imaging-desaturate;84;85;85;86;83;84;83;85;84;90 05:30:58 INFO - PROCESS | 1663 | |8;json-parse-financial;56;52;56;76;83;82;80;54;54;53 05:30:58 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;68;70;66;74;70;68;68;70;69;70 05:30:58 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;87;85;88;87;84;87;91;83;90;84 05:30:58 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;139;160;155;137;162;159;154;154;171;157 05:30:58 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;173;173;171;172;170;171;172;169;171;173 05:30:58 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;70;69;68;68;68;69;68;67;69;69 05:30:58 INFO - PROCESS | 1663 | __end_tp_report 05:30:58 INFO - PROCESS | 1663 | __start_cc_report 05:30:58 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2106 05:30:58 INFO - PROCESS | 1663 | __end_cc_report 05:30:58 INFO - PROCESS | 1663 | __startTimestamp1476361858295__endTimestamp 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | ------- Summary: start ------- 05:30:58 INFO - PROCESS | 1663 | Number of tests: 14 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:121.20 Median:113.00 stddev:17.07 (15.1%) stddev-sans-first:18.11 05:30:58 INFO - PROCESS | 1663 | Values: 121.0 163.0 140.0 113.0 113.0 112.0 112.0 113.0 113.0 112.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:119.00 stddev:16.09 (13.5%) stddev-sans-first:14.76 05:30:58 INFO - PROCESS | 1663 | Values: 148.0 113.0 117.0 150.0 114.0 121.0 114.0 115.0 146.0 112.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:202.40 Median:190.00 stddev:31.39 (16.5%) stddev-sans-first:33.15 05:30:58 INFO - PROCESS | 1663 | Values: 194.0 265.0 200.0 183.0 186.0 184.0 185.0 185.0 257.0 185.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:73.40 Median:69.50 stddev:17.27 (24.8%) stddev-sans-first:18.10 05:30:58 INFO - PROCESS | 1663 | Values: 81.0 60.0 76.0 112.0 84.0 63.0 60.0 59.0 82.0 57.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.50 stddev:10.94 (14.1%) stddev-sans-first:11.30 05:30:58 INFO - PROCESS | 1663 | Values: 84.0 71.0 93.0 70.0 68.0 69.0 91.0 66.0 68.0 89.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:87.00 stddev:18.28 (21.0%) stddev-sans-first:19.29 05:30:58 INFO - PROCESS | 1663 | Values: 90.0 83.0 129.0 130.0 88.0 84.0 89.0 86.0 88.0 84.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:30:58 INFO - PROCESS | 1663 | Values: 94.0 93.0 93.0 94.0 94.0 94.0 93.0 93.0 92.0 94.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:2.02 (2.4%) stddev-sans-first:2.12 05:30:58 INFO - PROCESS | 1663 | Values: 84.0 85.0 85.0 86.0 83.0 84.0 83.0 85.0 84.0 90.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:66.00 stddev:13.64 (20.7%) stddev-sans-first:14.11 05:30:58 INFO - PROCESS | 1663 | Values: 56.0 52.0 56.0 76.0 83.0 82.0 80.0 54.0 54.0 53.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:70.00 stddev:2.11 (3.0%) stddev-sans-first:2.19 05:30:58 INFO - PROCESS | 1663 | Values: 68.0 70.0 66.0 74.0 70.0 68.0 68.0 70.0 69.0 70.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:2.63 (3.0%) stddev-sans-first:2.79 05:30:58 INFO - PROCESS | 1663 | Values: 87.0 85.0 88.0 87.0 84.0 87.0 91.0 83.0 90.0 84.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:154.80 Median:158.00 stddev:10.17 (6.4%) stddev-sans-first:9.04 05:30:58 INFO - PROCESS | 1663 | Values: 139.0 160.0 155.0 137.0 162.0 159.0 154.0 154.0 171.0 157.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.00 stddev:1.35 (0.8%) stddev-sans-first:1.32 05:30:58 INFO - PROCESS | 1663 | Values: 173.0 173.0 171.0 172.0 170.0 171.0 172.0 169.0 171.0 173.0 05:30:58 INFO - PROCESS | 1663 | 05:30:58 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 05:30:58 INFO - PROCESS | 1663 | Values: 70.0 69.0 68.0 68.0 68.0 69.0 68.0 67.0 69.0 69.0 05:30:58 INFO - PROCESS | 1663 | -------- Summary: end -------- 05:30:58 INFO - PROCESS | 1663 | 05:30:59 INFO - TEST-INFO | 1663: exit 0 05:30:59 INFO - TEST-OK | kraken | took 60022ms 05:30:59 INFO - SUITE-END | took 1178s 05:30:59 INFO - Completed test suite (00:19:38) 05:30:59 INFO - javascript benchmark 05:30:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3155.6528781834, 3293.538904553362, 3304.4052070627295, 3341.114604629775, 3359.277755282615, 5367.46325367463, 5485.61600687952, 5496.148097044955, 5528.281323427954, 5562.833115006546, 5481.616286859921, 5534.557235421166, 5534.916976245349, 5542.0855558832845, 5552.472515111068, 5008.474110218429, 5035.295058691786, 5054.5198206170535, 5074.594032477393, 5127.641065125443, 4297.763623000749, 5065.746712664352, 5119.078565858144, 5151.253068305112, 5202.92195617066, 5130.538251557359, 5142.434332223453, 5151.896962060757, 5212.687238765686, 5212.817551385702, 169.45093108197105, 5110.591152707774, 5152.74236288186, 5186.118359878829, 5238.81664141757, 3045.392465410633, 5039.193729003378, 5087.949120508784, 5121.2318152277085, 5178.559822415099, 5403.729813509348, 5552.278203833516, 5558.527525160366, 5567.415421380778, 5581.8604534886545, 5862.912056319158, 5968.134620480049, 5996.040633498619, 6006.699665016776, 6020.608660437101, 6024.307204671475, 6039.909401358983, 6043.607165534227, 6067.605605635619, 6111.87776244477, 5578.24693666358, 5597.216389705444, 5602.635828671123, 5627.0, 5633.971830140905, 6284.748610055546, 6287.465565426898, 6307.0, 6307.810765677037, 6320.462760665395, 5781.277340332458, 5805.8548536286935, 5816.12758086282, 5869.911951320733, 5916.674582897982, 6086.239220097488, 6099.237595300588, 6108.511319094462, 6111.57218994675, 6120.326764055951, 6008.639481631116, 6021.608595441282, 6033.396660333931, 6036.939630603725, 6042.9122757904, 5839.299284085937, 5846.327672317653, 5912.881742365129, 5994.760209591567, 6123.571350005546, 4795.640326975491, 4797.496262892416, 4800.879978000508, 4807.807687692453, 4819.204831202812, 4334.804933777988, 4380.189664912002, 4392.714473559208, 4398.274284743045, 4401.691881568324, 5497.5601951843755, 5544.61187716856, 5581.5255703265675, 5590.413006634326, 5593.105103183471, 6042.4561789438285, 6107.389261073857, 6123.0, 6124.686092398479, 6145.293291271471, 4807.471178170398, 5567.777288908479, 5587.804426845041, 5590.832275031756, 5640.689762063126, 5150.098732721759, 5271.314729085195, 5272.604554658416, 5284.180951952453, 5319.148936170194, 6221.129041934133, 6257.311695713468, 6278.215223097113, 6285.779997700059, 6298.779542715983, 6156.846078848064, 6157.96921015392, 6160.722767475385, 6161.137440758208, 6180.690965451619, 6300.495960323072, 6307.148534947723, 6321.241451025722, 6323.715432805443, 6337.841553961003, 5859.970700146472, 5923.200367950271, 5941.257342832146, 5990.64056156632, 5991.400859913973, 5954.821355359346, 5978.4021597839865, 5986.07215881539, 6012.789552365646, 6091.817245482643, 5842.766289348378, 5845.561582881216, 5858.0, 5863.296404431496, 5867.853303667443, 5511.3937466879415, 5647.350554686263, 5803.65178089316, 5862.149988251595, 5870.236869206976, 4822.68652537584, 5453.127499600045, 5517.337919449692, 5672.546196304368, 5721.971390143022, 5834.94165058344, 5845.795397161079, 5850.12248162779, 5858.502027327725, 5882.705864706833, 5669.149627555899, 5682.204491371129, 5691.914621280767, 5701.173329867063, 5704.486596206361], "value": 5486.188826479971, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.1540918801286, 487.05997424969803, 503.0065620399709, 515.7369741431869, 523.6570046619463, 29174.708252917466, 38950.41574376383, 39973.80013099938, 40049.79975100121, 42189.7890510547, 40571.797141014256, 41027.38458923119, 41062.17875642493, 41112.0, 41172.58827411733, 9406.0, 9575.61697532098, 9586.424814511116, 9592.712218633453, 9615.903840961606, 8505.914940850575, 8741.038485766592, 11324.547018119307, 11587.0, 11595.884041159565, 11422.314661120317, 11492.597759078433, 11516.481758320895, 11523.942380288128, 11589.942050289737, 11481.311121332747, 11563.826542601868, 11572.189946703735, 11589.420528973602, 11601.0, 8407.579621018986, 8636.697715579987, 11178.552857885676, 11475.942620286845, 11560.768784624344, 39193.41209881854, 39434.21131577352, 39458.60541394607, 39567.208655826726, 39622.0, 3204.951925721116, 3290.7696461247724, 3364.327134573095, 3385.492176173569, 3666.944995825065, 30153.465346534653, 30165.0, 30373.848130759427, 30465.086047418612, 31088.533671994937, 3190.0, 3190.441672707267, 3210.6307774605752, 3283.4254005549174, 3292.226326813197, 470453.0, 470947.0, 471891.0, 473445.0, 480568.0, 55564.888702225726, 55835.44164558302, 55845.16232256519, 55904.0, 56015.0, 58218.7089064552, 58269.70865145647, 58350.4164958345, 58374.0, 58427.70786146042, 13261.403236854365, 15248.085114893142, 15666.92659908432, 15678.137702426477, 15691.058536487848, 11168.832467512993, 12267.754644907052, 12349.93825030869, 12364.567240146731, 12382.5666101686, 11849.289042657469, 13101.344932753324, 14571.489997850236, 14849.257537123101, 14934.431884651955, 5435.7825686972865, 6615.338466153346, 6638.336166383323, 6644.501662375341, 6663.666816659148, 815.8857759913617, 838.1450920061503, 888.8622263549161, 904.9592768325441, 912.9136327769933, 28089.859550702116, 29157.556590382665, 29202.269943251165, 29377.559336609967, 29434.705652943197, 914.6935776514943, 970.8980557041409, 978.3933960944261, 1057.4818339013982, 1063.9734006649896, 12312.384380781104, 14222.644433889236, 14838.851611483962, 14867.405303787944, 15165.848341516665, 634078.0, 638963.0, 639231.0, 640010.0, 640806.0, 54971.900561989336, 55203.72398138064, 55230.0, 55240.17139742907, 55368.446315537134, 1304.4586496603993, 1352.452256835983, 1353.5397964692052, 1360.0207850347733, 1365.8838998685023, 28362.57456138118, 28447.715522844508, 28523.001694940576, 29122.12633620995, 29183.416331673674, 47456.7627161862, 47466.28800568063, 47499.0, 47667.523324766305, 47789.761051194524, 579491.1025444845, 584954.1064250923, 585381.0, 585709.0, 587466.0, 22991.195308164133, 24182.39544011414, 24259.150929717376, 24589.0, 24771.62842557327, 38359.04102397351, 38814.835554933394, 38884.416733748454, 40220.3966940502, 45430.318545221184, 37135.13000094991, 37694.8115259422, 38033.619663804115, 38626.66093442237, 39189.80405097956, 37358.813205933795, 37712.795716111745, 38484.0, 38578.421323680726, 38581.0, 36700.63299366972, 36944.1764711736, 37654.0, 37779.81110094432, 37976.62023379731, 27896.44207115887, 32196.517052243766, 33217.667823321455, 33442.83278583591, 33536.49695254622, 24420.26739197827, 24751.0, 24770.628440573768, 25101.0, 25758.356041099123], "value": 19334.81716195336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.5348779148149, 360.1266927700326, 364.606225276701, 366.9724770642201, 387.82741679952414, 14687.926560367197, 14844.628884277885, 15794.289256983435, 20039.699404508945, 20715.482112947186, 17563.73654395185, 20087.397378078644, 20248.797512024874, 20299.594008119828, 20552.280670176548, 5569.777208911649, 5852.619579727326, 5872.265966754156, 5924.081767326072, 5934.5845790794665, 5077.213031980049, 5589.552835773128, 5739.799107031255, 5801.361850196475, 5808.680522571257, 5665.801696940608, 5763.798267060653, 5766.394528574502, 5770.480656740892, 5772.797952071678, 5544.445555444464, 5700.91448628273, 5757.424257574209, 5770.19217309577, 5778.075507918713, 4863.805447782084, 4952.232403977353, 5035.320231768701, 5036.143855544567, 5054.797808087672, 25170.86731097105, 25550.488990220092, 25742.74257257422, 25822.096226632166, 26054.0, 2171.185805323004, 2435.939101522476, 2475.0347364527847, 2630.8684565771637, 2654.0047482194177, 15321.6169595761, 15367.923160384127, 15628.0, 16018.038917664977, 16189.757153642704, 1847.8429333506667, 1866.337450205171, 1958.7159861820098, 1968.4586738646844, 1981.9801801982085, 86080.27496734259, 101635.47546786805, 107318.0, 108973.0, 109303.45348273207, 9210.861837072449, 11103.0, 11383.430828458544, 11441.656750297505, 11548.59579914699, 13970.720585588231, 14118.152910825384, 14320.856791432161, 14336.85663143376, 14376.137431754129, 8079.0, 8223.54770487629, 8251.29863961558, 8346.290565302017, 8383.916160838313, 7824.608769561613, 7961.124276329715, 7981.840363192704, 8182.795430114175, 8200.835983280302, 4445.377647129404, 4534.727916325031, 4535.63714902807, 4629.51390104041, 4638.165130276582, 1887.546988722724, 1894.7915729269769, 1912.4740696308627, 1953.9023048847785, 1960.7941166177632, 818.6357071103301, 916.3209713002301, 947.6683160893632, 957.7222605444343, 966.4056605187759, 16002.359905603878, 19924.90037549803, 20653.27713530019, 20684.58630827375, 20748.896255518626, 844.7918581942257, 862.2929198057658, 869.7695110795644, 971.8007808399261, 971.9902800972042, 9300.627974880928, 10612.734681632866, 11201.71995700114, 11239.269447485887, 11242.550297988153, 594055.3863998826, 603508.0, 604118.0, 613690.0, 616272.0, 89775.55112224397, 101284.0, 103478.0, 111143.0, 112733.0, 887.3123329419751, 890.9153630405231, 933.4399360383716, 998.8351921932945, 1005.4419797012728, 19219.13513891906, 19228.71156932675, 19281.710774338117, 19479.0, 19599.608007839477, 56058.0, 56499.0, 57047.42952570421, 57464.0, 57467.0, 76630.0, 81502.3699526018, 82100.58949705213, 82401.0, 82802.0, 7832.882506762289, 7993.320567751573, 8122.228388303101, 8158.265756081981, 8180.181981801772, 11267.549298027987, 12845.293508856728, 12967.092303538662, 13251.933740331237, 13340.0, 10746.032857042903, 11078.723031923944, 11154.721131971766, 11242.775144497227, 11384.14618903569, 9642.758931026781, 10866.782664346827, 10946.781064378827, 11021.614243501439, 11337.433128343715, 11123.555057797921, 11303.943480282545, 11349.092072634005, 11543.134264930331, 11593.6521904343, 8053.436259461781, 8099.028116626043, 8137.918620813716, 8143.429959902987, 8155.632996515053, 9774.804503910023, 11158.330500170016, 11410.543578256777, 11421.714457138638, 11507.654770356903], "value": 9465.21281586819, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.6216764724993, 1513.1980050573193, 1694.6356533345336, 1860.3116846766698, 1871.6911709567921, 6669.266380698119, 8181.91818081819, 8378.539180345086, 8854.778630534232, 8855.335849811267, 7980.521168729881, 8331.58384068621, 8605.526696031715, 8613.138686131384, 8663.176998185163, 2047.3857842647221, 2319.6404557293645, 2336.995092110392, 2346.8005219556358, 2351.564960482316, 2046.6623007203868, 2127.0, 2315.513742114158, 2332.1371092695726, 2370.2533701883854, 2145.442185031887, 2291.4385975436044, 2364.9645255321184, 2365.302235840423, 2369.360272726363, 2001.9199232030846, 2306.4579823741406, 2333.5099629077913, 2336.439254578906, 2346.624540073597, 2302.320815359473, 2321.454458202321, 2327.755585663515, 2328.1036800831635, 2330.4406942333885, 8703.695370662059, 8726.650933962634, 8787.209151176361, 8810.163034511712, 8815.867761983576, 5061.392632884077, 5229.378892543324, 5233.084210263189, 5242.239875218072, 5244.685318880879, 3565.286942611488, 3565.625609311011, 3628.092976755811, 3642.1623026704005, 3645.4167333226824, 1055.984160237597, 1067.2795862792661, 1071.539238127605, 1083.4149559238, 1091.5251865438481, 11549.422528873607, 11595.652130436016, 11603.651890443216, 11625.59310424131, 11684.532618695242, 4473.6868419211, 4474.709143905636, 4650.139724151043, 4752.809887604457, 4760.690555113906, 9070.682526111554, 9828.0, 9835.360701554377, 9852.45811480361, 9872.60509579623, 5220.686758794484, 5226.686398816008, 5227.085260079471, 5252.395974462909, 5255.605829562798, 4641.118187544355, 4781.402324709411, 4802.567768900815, 4813.253945638432, 4813.975930120327, 3830.482884810571, 3849.4995650565247, 3867.9226415472094, 3935.5080614923136, 3978.1844721831953, 1122.2256642916361, 1161.7211869151513, 1198.7542553776454, 1242.9005679545614, 1259.508791571288, 717.4619035723208, 867.1891781184613, 887.2990337633327, 912.543728135932, 983.5623147699205, 4996.275540046673, 5469.906018796257, 5839.299284085937, 6112.235970503687, 6135.447809697149, 861.8410880743822, 869.8303830752942, 891.6344298837446, 945.1776954049883, 967.4098799732158, 3681.8770275065826, 3886.9065588454996, 4064.552899181088, 4075.347944328893, 4127.153933443637, 8959.328050396116, 10873.401962892116, 10880.510377032893, 10902.291351062155, 10904.563817447372, 10840.945795270973, 10845.945770271099, 10861.0, 10867.45662716861, 10873.0, 8002.159773223844, 8225.79435514117, 8236.958815206006, 8242.423030387936, 8249.257566819015, 5776.220210271727, 5890.440408161217, 6097.634141951497, 6174.629522228501, 6178.196834411498, 9480.57337419804, 9883.901160988298, 10057.0, 10129.240306977154, 10135.239857010902, 8700.912990870263, 10027.548760305657, 10163.186945044527, 10185.592576296865, 10208.979102089732, 7373.078365204349, 7411.62941852916, 7538.509996850187, 7554.811129721801, 7559.470837041355, 8046.0, 8084.514929104273, 8110.635021423932, 8163.306118979954, 8234.917650823654, 7162.606056666933, 7338.596377199306, 7390.815229619303, 7416.851662966603, 7586.468947173645, 7252.311030452099, 7319.304666056716, 7368.005319282042, 7418.740344087931, 7459.440541959266, 6766.661666916733, 6918.169819621678, 7015.438764898694, 7023.754168604074, 7062.611556364449, 4912.7543622818, 4928.67963582366, 4963.602911767122, 4997.575206107522, 5097.235414687826, 4479.0817882334695, 4979.228219625964, 4989.575886049582, 5055.494450554915, 5146.382434107931], "value": 4534.842711849448, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.42641518848393, 294.9026821149021, 304.7196579147185, 307.9615048118985, 311.36015488171796, 4713.858584242474, 4777.283407488874, 4975.701457912528, 5264.341957255343, 5317.787288508464, 4201.957980420195, 4899.975500122495, 5101.821436249723, 5112.079825631394, 5208.593679706486, 3765.943510847326, 3817.6373244541865, 3974.3839704845795, 3976.3041467743174, 3979.0, 3783.697304215656, 3951.940720889189, 3959.7922633596886, 3980.1641655252433, 4002.3396139636925, 3534.9571876296427, 3617.408340330246, 3739.551253849528, 3940.3104456720102, 3999.800009999503, 3949.921001579981, 3954.5649978502342, 3966.9884179534033, 3979.8607048753156, 3996.980769903685, 3417.624061353249, 3429.262708517656, 3429.605595356541, 3432.9059273843186, 3446.7414943879307, 4211.410402543646, 5101.617378696613, 5102.9078077988215, 5103.668261563023, 5149.241054030579, 4235.830566777326, 4444.266695995157, 4480.395146655193, 4496.100779844011, 4560.612347950429, 4519.683622146451, 5461.317335333083, 5483.533899618537, 5483.588730845203, 5556.527695145917, 3175.714185723296, 3418.384690755663, 3682.779033258013, 3682.85678611562, 3744.756590821588, 5441.483059109379, 5489.890202195974, 5725.656460612335, 5726.427357264281, 5747.994101032303, 3817.6945844332386, 3819.3507103791867, 3824.521934758155, 3833.463315135883, 3854.768713877176, 3172.8254945977733, 3896.9610303897166, 3935.6457918787446, 3948.6446219840354, 3952.5454572724507, 3699.4820725098507, 4378.759168245777, 4472.0608672179205, 4561.589456948891, 4606.585407313358, 4253.893652658647, 4925.507449255046, 5464.480874316933, 5497.505224529811, 5593.496585307342, 1096.0354887698775, 1132.0, 1162.6802629277017, 1226.9141809498658, 1334.813126162338, 823.3084209264247, 850.3154960256929, 853.3642436384933, 869.7260362985639, 873.5850471026212, 4346.195953748566, 4682.578567928903, 4857.004314115668, 5060.51925067118, 5113.821016264413, 5010.674306170087, 5505.807296744675, 5540.667559946416, 5557.833265001976, 5598.972005139948, 4422.678094000676, 4778.228627396102, 4843.539863712942, 5131.640785145079, 5207.047357241035, 2663.9733602663723, 2789.8744556495008, 2912.606798082274, 2945.4550908082074, 2976.8836686242657, 5851.912221316684, 5877.265341832271, 5879.676617785977, 5887.322957859816, 5895.793647222413, 5411.404745477994, 5660.801871934463, 5664.830055098354, 5742.368339482654, 5768.884622307614, 5747.0, 5781.710914454345, 5809.419058094241, 5829.679367634821, 5863.032599621015, 5107.591392688651, 5153.561947234527, 5554.222408862844, 5572.3034620672415, 5636.140073775726, 4510.413646226101, 5494.890102198014, 5534.0, 5554.0, 5576.414476479911, 5392.649477783932, 5435.646682965595, 5886.882262354815, 5927.110933360031, 5945.681184338026, 3259.152620318782, 3332.833358332025, 3362.4620060790157, 3746.3818469952153, 3823.502944617182, 5426.023315803193, 5428.864278393072, 5440.401555828935, 5544.251526043932, 5551.306086739158, 5353.4571078738845, 5378.892422151457, 5394.004218439202, 5406.324209473816, 5425.376081750649, 4748.3827102477835, 5134.409542902614, 5314.864230104103, 5352.063388907003, 5443.727813609383, 4219.894502637459, 5198.8960220794615, 5242.213667949838, 5260.237265596544, 5265.6835791052235, 4558.772061396983, 5219.0, 5233.822389962228, 5322.733863306742, 5451.754671039734, 4956.77694503741, 5323.680579165262, 5354.089804733127, 5421.484958928895, 5421.861409104133], "value": 3976.0449366030557, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.1142902797334, 711.33845523663, 712.4264966701803, 719.9856002879942, 832.7501749475156, 13714.588562343133, 14741.926290368547, 15790.526284211477, 16410.343586256535, 16425.17874106296, 15690.686186276296, 15809.051456912593, 15816.209189540506, 15833.050016998988, 15873.603159921007, 836.456303402787, 854.995725021374, 860.7934095817021, 861.2980420956932, 864.844328020956, 682.7064362324198, 699.6921354603984, 703.5884007855385, 824.4764574495209, 840.7729912923508, 852.1733918099465, 903.5030733096803, 905.868649045888, 908.9409188402733, 909.3543584055295, 800.7148526614816, 878.5124256037897, 902.296208957008, 902.891653001644, 903.2818908967387, 521.0724909660772, 537.3471232452589, 539.2477493896032, 540.5081375947868, 646.977355792545, 14043.157410555297, 14377.353019114165, 14500.347484363123, 14504.492342768059, 14515.419383224658, 13604.183748974994, 14027.438902443992, 14118.0, 14123.223222722747, 14132.293385330693, 11350.375729334883, 11539.826902596467, 11648.650540483799, 11711.121665875009, 11975.64073077809, 3577.6783978222757, 3605.56733192016, 3632.0738211755834, 3632.5640923089136, 3733.0, 108497.91502084957, 110287.44856275668, 110302.0, 110307.44846275717, 111496.4425177869, 9548.331616786758, 10192.898071019343, 10200.3369780964, 10275.588976441008, 10684.038436540748, 20935.68596471054, 21278.893605531874, 21344.146234150772, 21639.078724372324, 21727.78272217289, 7230.891536626955, 7337.41300695943, 7378.852422951618, 7383.003294555274, 7476.0, 4132.896677583084, 4228.682848786353, 4246.426732391088, 4290.613844753924, 4421.513633500313, 3483.512308276843, 3600.963990360115, 3601.2077342984503, 3603.387424137903, 3608.025833025121, 610.5878531990888, 612.3600837125215, 615.7013848283578, 626.9968650156811, 631.7283568065776, 543.9184122381595, 633.7686744338283, 640.8397900524869, 648.4552975500602, 655.1025095619033, 8411.285040771603, 8532.616032278562, 8766.868496972551, 8808.647654093764, 8907.955460222658, 601.7713268957856, 612.2194202391986, 638.1225814505055, 648.7567162314132, 653.6143675231541, 3578.6421357864006, 4245.299525578307, 4298.591633794785, 4299.118680670517, 4358.978205109018, 96316.03417504423, 111780.0, 159682.0, 166513.0, 168666.0, 127512.0, 127577.0, 133814.3309283467, 134407.32796336152, 145988.0, 64783.0, 102545.0, 115217.42391288158, 121677.0, 124558.3772081152, 8122.959385203036, 8953.373263871466, 8972.102789721237, 8979.551022448983, 9142.3600347975, 52266.0, 57473.0, 59691.0, 60021.0, 63374.36625633869, 82207.58896205481, 89485.0, 90155.54922225347, 92001.0, 95302.0, 12223.511059557519, 12347.567835125728, 12653.304068276333, 13144.342782860627, 13279.66800829987, 12350.258984460961, 14347.641308967359, 14370.784438233226, 14488.348024338718, 15044.323005465, 13070.085094043327, 13776.448942042207, 13940.79088813689, 13971.930140349234, 14013.089149205269, 13145.53990610324, 13460.663483412993, 13625.86374136246, 13857.30713464343, 13876.930615347263, 12916.28960407149, 13163.463015544956, 13341.273977021685, 13576.86423135756, 13645.385957631732, 11087.8285337964, 11092.889071109186, 11290.379029153475, 11326.37704926204, 11534.711632209262, 8229.588520574067, 9356.625734970525, 9918.111897157023, 9925.503724813874, 10046.497675116361], "value": 7574.620450576969, "unit": "score"}], "name": "dromaeo_css", "value": 7181.146045384635, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 163.0, 140.0, 113.0, 113.0, 112.0, 112.0, 113.0, 113.0, 112.0], "value": 121.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 117.0, 150.0, 114.0, 121.0, 114.0, 115.0, 146.0, 112.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 265.0, 200.0, 183.0, 186.0, 184.0, 185.0, 185.0, 257.0, 185.0], "value": 202.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 76.0, 112.0, 84.0, 63.0, 60.0, 59.0, 82.0, 57.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 93.0, 70.0, 68.0, 69.0, 91.0, 66.0, 68.0, 89.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 129.0, 130.0, 88.0, 84.0, 89.0, 86.0, 88.0, 84.0], "value": 95.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 93.0, 93.0, 92.0, 94.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 86.0, 83.0, 84.0, 83.0, 85.0, 84.0, 90.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 56.0, 76.0, 83.0, 82.0, 80.0, 54.0, 54.0, 53.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 66.0, 74.0, 70.0, 68.0, 68.0, 70.0, 69.0, 70.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 87.0, 84.0, 87.0, 91.0, 83.0, 90.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 160.0, 155.0, 137.0, 162.0, 159.0, 154.0, 154.0, 171.0, 157.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 171.0, 172.0, 170.0, 171.0, 172.0, 169.0, 171.0, 173.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 67.0, 69.0, 69.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1487.6, "alertThreshold": 2.0}]} 05:30:59 INFO - Return code: 0 05:30:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:30:59 INFO - # TBPL SUCCESS # 05:30:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:30:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:30:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:30:59 INFO - 2016-10-13 05:30:59.615 screenresolution[1667:10009] starting screenresolution argv=screenresolution get 05:30:59 INFO - 2016-10-13 05:30:59.618 screenresolution[1667:10009] Display 0: 1600x1200x32@60 05:30:59 INFO - 2016-10-13 05:30:59.624 screenresolution[1668:10012] starting screenresolution argv=screenresolution list 05:30:59 INFO - Available Modes on Display 0 05:30:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:30:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:30:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:30:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:30:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:30:59 INFO - Intel Iris: 05:30:59 INFO - Chipset Model: Intel Iris 05:30:59 INFO - Type: GPU 05:30:59 INFO - Bus: Built-In 05:30:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:30:59 INFO - Vendor: Intel (0x8086) 05:30:59 INFO - Device ID: 0x0a2e 05:30:59 INFO - Revision ID: 0x0009 05:30:59 INFO - Displays: 05:30:59 INFO - Display: 05:30:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:30:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:30:59 INFO - Display Serial Number: 1600x1200 60 05:30:59 INFO - Main Display: Yes 05:30:59 INFO - Mirror: Off 05:30:59 INFO - Online: Yes 05:30:59 INFO - Rotation: Supported 05:30:59 INFO - Return code: 0 05:30:59 INFO - Running post-action listener: _resource_record_post_action 05:30:59 INFO - [mozharness: 2016-10-13 12:30:59.860314Z] Finished run-tests step (success) 05:30:59 INFO - Running post-run listener: _resource_record_post_run 05:30:59 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37417984; Write bytes: 708550144; Read time: 247; Write time: 1994 05:30:59 INFO - TinderboxPrint: CPU usage
53.7% 05:30:59 INFO - TinderboxPrint: I/O read bytes / time
37,417,984 / 247 05:30:59 INFO - TinderboxPrint: I/O write bytes / time
708,550,144 / 1,994 05:30:59 INFO - TinderboxPrint: CPU idle
2,246.9 (46.3%) 05:30:59 INFO - TinderboxPrint: CPU system
974.8 (20.1%) 05:30:59 INFO - TinderboxPrint: CPU user
1,636.1 (33.7%) 05:30:59 INFO - TinderboxPrint: Swap in / out
444,710,912 / 0 05:30:59 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 413518336; Write bytes: 410576896; Read time: 31732; Write time: 870 05:30:59 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 29133824; Write bytes: 296367616; Read time: 180; Write time: 1117 05:31:00 INFO - Running post-run listener: _upload_blobber_files 05:31:00 INFO - Blob upload gear active. 05:31:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:00 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 05:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:00 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:01 INFO - (blobuploader) - INFO - Done attempting. 05:31:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:31:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:31:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:02 INFO - (blobuploader) - INFO - Done attempting. 05:31:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:04 INFO - (blobuploader) - INFO - Done attempting. 05:31:04 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:04 INFO - Return code: 0 05:31:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9f2fcca8797a8465f890a62b3f0cc315a4104348b66a57e8704d0c44f586adc02bb03934949a6c4bf654e931e3585441de737da8213e363591549acc1e56511", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7170cb579b99ece35c8d123743bff45324c1b4ab5750d0db5357bd73489fdee3e0dc873d1b86bb6b91e3420791412a10bb32518d1ee805c37e110bf4866ded2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ee52ddf156650d6e2418cee4daa3b47dbb0a48088d7617ef71701d6d4767770d8cf4c55f19542204f538bd15cca29e10196532c11f0e617acae77c379160c12"} 05:31:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:04 INFO - Contents: 05:31:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9f2fcca8797a8465f890a62b3f0cc315a4104348b66a57e8704d0c44f586adc02bb03934949a6c4bf654e931e3585441de737da8213e363591549acc1e56511", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7170cb579b99ece35c8d123743bff45324c1b4ab5750d0db5357bd73489fdee3e0dc873d1b86bb6b91e3420791412a10bb32518d1ee805c37e110bf4866ded2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ee52ddf156650d6e2418cee4daa3b47dbb0a48088d7617ef71701d6d4767770d8cf4c55f19542204f538bd15cca29e10196532c11f0e617acae77c379160c12"} 05:31:04 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:04 INFO - Copying logs to upload dir... 05:31:04 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.076431 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-13 05:31:04.763681) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 05:31:04.767373) ========= 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.ZAV1J1d7FL/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.5LxncazX4b/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9f2fcca8797a8465f890a62b3f0cc315a4104348b66a57e8704d0c44f586adc02bb03934949a6c4bf654e931e3585441de737da8213e363591549acc1e56511", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7170cb579b99ece35c8d123743bff45324c1b4ab5750d0db5357bd73489fdee3e0dc873d1b86bb6b91e3420791412a10bb32518d1ee805c37e110bf4866ded2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ee52ddf156650d6e2418cee4daa3b47dbb0a48088d7617ef71701d6d4767770d8cf4c55f19542204f538bd15cca29e10196532c11f0e617acae77c379160c12"} build_url:https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011118 build_url: 'https://queue.taskcluster.net/v1/task/NrHNfP3pT4-nwpDr_CkIiQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9f2fcca8797a8465f890a62b3f0cc315a4104348b66a57e8704d0c44f586adc02bb03934949a6c4bf654e931e3585441de737da8213e363591549acc1e56511", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7170cb579b99ece35c8d123743bff45324c1b4ab5750d0db5357bd73489fdee3e0dc873d1b86bb6b91e3420791412a10bb32518d1ee805c37e110bf4866ded2d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ee52ddf156650d6e2418cee4daa3b47dbb0a48088d7617ef71701d6d4767770d8cf4c55f19542204f538bd15cca29e10196532c11f0e617acae77c379160c12"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 05:31:04.803389) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:31:04.803717) ========= 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.ZAV1J1d7FL/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.5LxncazX4b/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.005257 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:31:04.851777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 05:31:04.852109) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 05:31:04.852418) ========= ========= Total master_lag: 0.17 =========