builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0382 starttime: 1485890266.52 results: success (0) buildid: 20170131083709 builduid: 3c23e62267f54ccba0bac0521cf1889a revision: 4217fbc0d4feea059a47b6360c627061ab0dd451 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:46.523797) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:46.524192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:46.524482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:47.026366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:47.026735) ========= 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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-31 11:17:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.05M=0.001s 2017-01-31 11:17:47 (8.05 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.226754 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:47.276637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:47.276945) ========= 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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.020783 ========= master_lag: 0.35 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:47.643153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-31 11:17:47.643808) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4217fbc0d4feea059a47b6360c627061ab0dd451 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4217fbc0d4feea059a47b6360c627061ab0dd451 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-31 11:17:48,068 truncating revision to first 12 chars 2017-01-31 11:17:48,069 Setting DEBUG logging. 2017-01-31 11:17:48,069 attempt 1/10 2017-01-31 11:17:48,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4217fbc0d4fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 11:17:49,677 unpacking tar archive at: mozilla-beta-4217fbc0d4fe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.846813 ========= master_lag: 0.36 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-31 11:17:49.846477) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:49.846806) ========= script_repo_revision: 4217fbc0d4feea059a47b6360c627061ab0dd451 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:49.847468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:49.848043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 11:17:49.867721) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-31 11:17:49.868118) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:17:50 INFO - MultiFileLogger online at 20170131 11:17:50 in /builds/slave/test 11:17:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:17:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:17:50 INFO - {'append_to_log': False, 11:17:50 INFO - 'base_work_dir': '/builds/slave/test', 11:17:50 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:17:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:17:50 INFO - 'branch': 'Mozilla-Beta', 11:17:50 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:50 INFO - 'config_files': ('talos/mac_config.py',), 11:17:50 INFO - 'default_actions': ('clobber', 11:17:50 INFO - 'read-buildbot-config', 11:17:50 INFO - 'download-and-extract', 11:17:50 INFO - 'populate-webroot', 11:17:50 INFO - 'create-virtualenv', 11:17:50 INFO - 'install', 11:17:50 INFO - 'run-tests'), 11:17:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:50 INFO - 'download_minidump_stackwalk': True, 11:17:50 INFO - 'download_symbols': 'ondemand', 11:17:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:50 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:50 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:50 INFO - 'installer_path': 'installer.exe', 11:17:50 INFO - 'log_level': 'info', 11:17:50 INFO - 'log_name': 'talos', 11:17:50 INFO - 'log_to_console': True, 11:17:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:17:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:17:50 INFO - 'opt_config_files': (), 11:17:50 INFO - 'pip_index': False, 11:17:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:17:50 INFO - 'cmd': ('bash', 11:17:50 INFO - '-c', 11:17:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:17:50 INFO - 'enabled': True, 11:17:50 INFO - 'halt_on_failure': False, 11:17:50 INFO - 'name': 'check_screen_resolution'},), 11:17:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:17:50 INFO - 'cmd': ('bash', 11:17:50 INFO - '-c', 11:17:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:17:50 INFO - 'enabled': True, 11:17:50 INFO - 'halt_on_failure': False, 11:17:50 INFO - 'name': 'check_screen_resolution'},), 11:17:50 INFO - 'run_cmd_checks_enabled': True, 11:17:50 INFO - 'sps_profile': False, 11:17:50 INFO - 'sps_profile_interval': 0, 11:17:50 INFO - 'suite': 'dromaeojs', 11:17:50 INFO - 'system_bits': '32', 11:17:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:50 INFO - 'title': 't-yosemite-r7-0382', 11:17:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:50 INFO - 'use_talos_json': True, 11:17:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:17:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:50 INFO - 'work_dir': 'build'} 11:17:50 INFO - [mozharness: 2017-01-31 19:17:50.070218Z] Running clobber step. 11:17:50 INFO - Running pre-action listener: _resource_record_pre_action 11:17:50 INFO - Running main action method: clobber 11:17:50 INFO - rmtree: /builds/slave/test/build 11:17:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:52 INFO - Running post-action listener: _resource_record_post_action 11:17:52 INFO - [mozharness: 2017-01-31 19:17:52.400895Z] Finished clobber step (success) 11:17:52 INFO - [mozharness: 2017-01-31 19:17:52.401183Z] Running read-buildbot-config step. 11:17:52 INFO - Running pre-action listener: _resource_record_pre_action 11:17:52 INFO - Running main action method: read_buildbot_config 11:17:52 INFO - Using buildbot properties: 11:17:52 INFO - { 11:17:52 INFO - "project": "", 11:17:52 INFO - "product": "firefox", 11:17:52 INFO - "script_repo_revision": "production", 11:17:52 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:17:52 INFO - "repository": "", 11:17:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:17:52 INFO - "buildid": "20170131083709", 11:17:52 INFO - "pgo_build": "False", 11:17:52 INFO - "basedir": "/builds/slave/test", 11:17:52 INFO - "buildnumber": 11, 11:17:52 INFO - "slavename": "t-yosemite-r7-0382", 11:17:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:17:52 INFO - "platform": "yosemite_r7", 11:17:52 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:17:52 INFO - "branch": "mozilla-beta", 11:17:52 INFO - "repo_path": "releases/mozilla-beta", 11:17:52 INFO - "revision": "4217fbc0d4feea059a47b6360c627061ab0dd451", 11:17:52 INFO - "stage_platform": "macosx64", 11:17:52 INFO - "builduid": "3c23e62267f54ccba0bac0521cf1889a", 11:17:52 INFO - "slavebuilddir": "test" 11:17:52 INFO - } 11:17:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 11:17:52 INFO - Running post-action listener: _resource_record_post_action 11:17:52 INFO - [mozharness: 2017-01-31 19:17:52.407689Z] Finished read-buildbot-config step (success) 11:17:52 INFO - [mozharness: 2017-01-31 19:17:52.408040Z] Running download-and-extract step. 11:17:52 INFO - Running pre-action listener: _resource_record_pre_action 11:17:52 INFO - Running main action method: download_and_extract 11:17:52 INFO - mkdir: /builds/slave/test/build/tests 11:17: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')]} 11:17:52 INFO - trying https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 11:17:52 INFO - Downloading https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:17:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 11:17:53 INFO - Downloaded 1165 bytes. 11:17:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 11:17:53 INFO - Using the following test package requirements: 11:17:53 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:17:53 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:17:53 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 11:17:53 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:17:53 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 11:17:53 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:17:53 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:17:53 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 11:17:53 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 11:17:53 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:17:53 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 11:17:53 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:17:53 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 11:17:53 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:17:53 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 11:17:53 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 11:17:53 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 11:17:53 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 11:17:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:17:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:17:53 INFO - Fetch https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:17:54 INFO - Http code: 200 11:17:54 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 11:17:54 INFO - x-amz-cf-id: itqbz7tF4SDF1lbDwpCDY_FjR6NPzEVGVamILpfLs-UIFhAYo_xqHQ== 11:17:54 INFO - x-amz-version-id: vKqe4Za6PxPUbEilL0RmAYmHn_1asX6q 11:17:54 INFO - Expected file size: 16089088 11:17:54 INFO - Obtained file size: 16089088 11:18:01 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:18:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 11:18:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 11:18:01 INFO - Fetch https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 11:18:01 INFO - Http code: 200 11:18:01 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 11:18:01 INFO - x-amz-cf-id: u1sGMM87VP_AAqHpmcqXqtAh3LDcsx_isQ-mpy_bIOA6rxOfIotvQw== 11:18:01 INFO - x-amz-version-id: vKqe4Za6PxPUbEilL0RmAYmHn_1asX6q 11:18:02 INFO - Expected file size: 16089088 11:18:02 INFO - Obtained file size: 16089088 11:18:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 11:18:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 11:18:08 INFO - Fetch https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 11:18:09 INFO - Http code: 200 11:18:09 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 11:18:09 INFO - x-amz-cf-id: IyZCIRZNbeobhgvV7fKesKS-aTPo_NrVOs8FQzkxIVFYJrjAXRVzgA== 11:18:09 INFO - x-amz-version-id: 5ApRhtAc_.UVQtIRZtnsclPGtmWfFnx7 11:18:09 INFO - Expected file size: 14402992 11:18:09 INFO - Obtained file size: 14402992 11:18: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')]} 11:18:09 INFO - trying https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:18:09 INFO - Downloading https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 11:18:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 11:18:11 INFO - Downloaded 82144948 bytes. 11:18:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:18:11 INFO - mkdir: /builds/slave/test/properties 11:18:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:11 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:11 INFO - Contents: 11:18:11 INFO - build_url:https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 11:18:12 INFO - Running post-action listener: _resource_record_post_action 11:18:12 INFO - Running post-action listener: set_extra_try_arguments 11:18:12 INFO - [mozharness: 2017-01-31 19:18:12.628102Z] Finished download-and-extract step (success) 11:18:12 INFO - [mozharness: 2017-01-31 19:18:12.628217Z] Running populate-webroot step. 11:18:12 INFO - Running pre-action listener: _resource_record_pre_action 11:18:12 INFO - Running main action method: populate_webroot 11:18:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:12 INFO - '--tppagecycles', 11:18:12 INFO - '7'], 11:18:12 INFO - 'tests': ['tsvgm']}}, 11:18:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:12 INFO - 'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:12 INFO - 'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['damp', 'tps']}, 11:18:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:12 INFO - 'tests': ['damp', 'tps']}, 11:18:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['dromaeo_dom']}, 11:18:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['basic_compositor_video']}, 11:18:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:18:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['a11yr', 11:18:12 INFO - 'ts_paint', 11:18:12 INFO - 'tpaint', 11:18:12 INFO - 'sessionrestore', 11:18:12 INFO - 'sessionrestore_no_auto_restore', 11:18:12 INFO - 'tabpaint']}, 11:18:12 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:12 INFO - 'ts_paint', 11:18:12 INFO - 'tpaint', 11:18:12 INFO - 'sessionrestore', 11:18:12 INFO - 'sessionrestore_no_auto_restore', 11:18:12 INFO - 'tabpaint']}, 11:18:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:12 INFO - 'ts_paint', 11:18:12 INFO - 'tpaint', 11:18:12 INFO - 'sessionrestore', 11:18:12 INFO - 'sessionrestore_no_auto_restore', 11:18:12 INFO - 'tabpaint']}, 11:18:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:12 INFO - 'ts_paint', 11:18:12 INFO - 'tpaint', 11:18:12 INFO - 'sessionrestore', 11:18:12 INFO - 'sessionrestore_no_auto_restore', 11:18:12 INFO - 'tabpaint']}, 11:18:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['a11yr', 11:18:12 INFO - 'ts_paint', 11:18:12 INFO - 'tpaint', 11:18:12 INFO - 'sessionrestore', 11:18:12 INFO - 'sessionrestore_no_auto_restore', 11:18:12 INFO - 'tabpaint']}, 11:18:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['a11yr', 11:18:12 INFO - 'ts_paint', 11:18:12 INFO - 'tpaint', 11:18:12 INFO - 'sessionrestore', 11:18:12 INFO - 'sessionrestore_no_auto_restore', 11:18:12 INFO - 'tabpaint']}, 11:18:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['tsvgx', 11:18:12 INFO - 'tsvgr_opacity', 11:18:12 INFO - 'tart', 11:18:12 INFO - 'tscrollx', 11:18:12 INFO - 'cart']}, 11:18:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:12 INFO - 'tsvgr_opacity', 11:18:12 INFO - 'tart', 11:18:12 INFO - 'tscrollx', 11:18:12 INFO - 'cart']}, 11:18:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:12 INFO - 'talos_options': ['--disable-e10s'], 11:18:12 INFO - 'tests': ['tp5o']}, 11:18:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:12 INFO - 'tests': ['tp5o']}, 11:18:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:12 INFO - 'talos_options': ['--disable-e10s', 11:18:12 INFO - '--xperf_path', 11:18:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:12 INFO - 'tests': ['tp5n']}, 11:18:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:12 INFO - 'talos_options': ['--xperf_path', 11:18:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:12 INFO - 'tests': ['tp5n']}}, 11:18:12 INFO - 'talos.zip': {'path': '', 11:18:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:12 INFO - Running post-action listener: _resource_record_post_action 11:18:12 INFO - [mozharness: 2017-01-31 19:18:12.646688Z] Finished populate-webroot step (success) 11:18:12 INFO - [mozharness: 2017-01-31 19:18:12.646795Z] Running create-virtualenv step. 11:18:12 INFO - Running pre-action listener: _resource_record_pre_action 11:18:12 INFO - Running main action method: create_virtualenv 11:18:12 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18: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 11:18:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:12 INFO - Using real prefix '/tools/python27' 11:18:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:13 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:16 INFO - Installing pip.................done. 11:18:16 INFO - Return code: 0 11:18:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:18:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:18:16 INFO - Reading from file tmpfile_stdout 11:18:16 INFO - Output received: 11:18: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) 11:18:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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 0x108b86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108afc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb662d90620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, '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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:18: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 11:18: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 11:18:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:18:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:16 INFO - 'HOME': '/Users/cltbld', 11:18:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:16 INFO - 'LOGNAME': 'cltbld', 11:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:16 INFO - 'MOZ_NO_REMOTE': '1', 11:18:16 INFO - 'NO_EM_RESTART': '1', 11:18:16 INFO - 'PAGER': '/bin/cat', 11:18:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:16 INFO - 'PWD': '/builds/slave/test', 11:18:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:16 INFO - 'SHELL': '/bin/bash', 11:18:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:18:16 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:18:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:16 INFO - 'USER': 'cltbld', 11:18:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:16 INFO - 'XPC_FLAGS': '0x0', 11:18:16 INFO - 'XPC_SERVICE_NAME': '0', 11:18:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:16 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 11:18:16 INFO - Cleaning up... 11:18:16 INFO - Return code: 0 11:18:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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', '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 0x108b86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108afc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb662d90620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, '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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:18: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:18: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 psutil>=3.1.1 11:18:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:18:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:16 INFO - 'HOME': '/Users/cltbld', 11:18:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:16 INFO - 'LOGNAME': 'cltbld', 11:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:16 INFO - 'MOZ_NO_REMOTE': '1', 11:18:16 INFO - 'NO_EM_RESTART': '1', 11:18:16 INFO - 'PAGER': '/bin/cat', 11:18:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:16 INFO - 'PWD': '/builds/slave/test', 11:18:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:16 INFO - 'SHELL': '/bin/bash', 11:18:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:18:16 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:18:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:16 INFO - 'USER': 'cltbld', 11:18:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:16 INFO - 'XPC_FLAGS': '0x0', 11:18:16 INFO - 'XPC_SERVICE_NAME': '0', 11:18:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:17 INFO - Downloading/unpacking psutil>=3.1.1 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:20 INFO - Installing collected packages: psutil 11:18:20 INFO - Running setup.py install for psutil 11:18:20 INFO - building 'psutil._psutil_osx' extension 11:18: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 11:18: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 11:18: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 11:18: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 11:18:21 INFO - building 'psutil._psutil_posix' extension 11:18: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 11:18:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:18:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:18:21 INFO - ^ 11:18:21 INFO - 1 warning generated. 11:18: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 11:18:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:21 INFO - Successfully installed psutil 11:18:21 INFO - Cleaning up... 11:18:21 INFO - Return code: 0 11:18:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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 0x108b86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108afc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb662d90620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, '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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:18: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 11:18: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 11:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:21 INFO - 'HOME': '/Users/cltbld', 11:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:21 INFO - 'LOGNAME': 'cltbld', 11:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:21 INFO - 'MOZ_NO_REMOTE': '1', 11:18:21 INFO - 'NO_EM_RESTART': '1', 11:18:21 INFO - 'PAGER': '/bin/cat', 11:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:21 INFO - 'PWD': '/builds/slave/test', 11:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:21 INFO - 'SHELL': '/bin/bash', 11:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:18:21 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:21 INFO - 'USER': 'cltbld', 11:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:21 INFO - 'XPC_FLAGS': '0x0', 11:18:21 INFO - 'XPC_SERVICE_NAME': '0', 11:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:18:21 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 11:18:21 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 11:18:21 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 11:18:21 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 11:18:21 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 11:18:21 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 11:18:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:18:24 INFO - Installing collected packages: mozsystemmonitor 11:18:24 INFO - Running setup.py install for mozsystemmonitor 11:18:24 INFO - Successfully installed mozsystemmonitor 11:18:24 INFO - Cleaning up... 11:18:24 INFO - Return code: 0 11:18:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:18:24 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')]} 11:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:24 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')]} 11:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:24 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 0x108b86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108afc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb662d90620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, '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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:18:24 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 11:18:24 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 11:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:24 INFO - 'HOME': '/Users/cltbld', 11:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:24 INFO - 'LOGNAME': 'cltbld', 11:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:24 INFO - 'MOZ_NO_REMOTE': '1', 11:18:24 INFO - 'NO_EM_RESTART': '1', 11:18:24 INFO - 'PAGER': '/bin/cat', 11:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:24 INFO - 'PWD': '/builds/slave/test', 11:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:24 INFO - 'SHELL': '/bin/bash', 11:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:18:24 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:24 INFO - 'USER': 'cltbld', 11:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:24 INFO - 'XPC_FLAGS': '0x0', 11:18:24 INFO - 'XPC_SERVICE_NAME': '0', 11:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:25 INFO - Downloading/unpacking jsonschema==2.5.1 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:28 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:28 INFO - warning: no files found matching '*.txt' 11:18:28 INFO - no previously-included directories found matching 'build' 11:18:28 INFO - no previously-included directories found matching 'dist' 11:18:28 INFO - no previously-included directories found matching '.git*' 11:18:28 INFO - Installing collected packages: jsonschema, functools32 11:18:28 INFO - Running setup.py install for functools32 11:18:28 INFO - warning: no files found matching '*.txt' 11:18:28 INFO - no previously-included directories found matching 'build' 11:18:28 INFO - no previously-included directories found matching 'dist' 11:18:28 INFO - no previously-included directories found matching '.git*' 11:18:28 INFO - Successfully installed jsonschema functools32 11:18:28 INFO - Cleaning up... 11:18:28 INFO - Return code: 0 11:18:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:29 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 0x108b86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108afc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb662d90620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, '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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:18:29 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 11:18:29 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 11:18:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:18:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:29 INFO - 'HOME': '/Users/cltbld', 11:18:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:29 INFO - 'LOGNAME': 'cltbld', 11:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:29 INFO - 'MOZ_NO_REMOTE': '1', 11:18:29 INFO - 'NO_EM_RESTART': '1', 11:18:29 INFO - 'PAGER': '/bin/cat', 11:18:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:29 INFO - 'PWD': '/builds/slave/test', 11:18:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:29 INFO - 'SHELL': '/bin/bash', 11:18:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:18:29 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:18:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:29 INFO - 'USER': 'cltbld', 11:18:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:29 INFO - 'XPC_FLAGS': '0x0', 11:18:29 INFO - 'XPC_SERVICE_NAME': '0', 11:18:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:18:29 INFO - Cleaning up... 11:18:29 INFO - Return code: 0 11:18:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:29 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')]} 11:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:29 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')]} 11:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:29 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 0x108b86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108afc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb662d90620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, '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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:18:29 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 11:18:29 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 11:18:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:18:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:29 INFO - 'HOME': '/Users/cltbld', 11:18:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:29 INFO - 'LOGNAME': 'cltbld', 11:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:29 INFO - 'MOZ_NO_REMOTE': '1', 11:18:29 INFO - 'NO_EM_RESTART': '1', 11:18:29 INFO - 'PAGER': '/bin/cat', 11:18:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:29 INFO - 'PWD': '/builds/slave/test', 11:18:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:29 INFO - 'SHELL': '/bin/bash', 11:18:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:18:29 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:18:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:29 INFO - 'USER': 'cltbld', 11:18:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:29 INFO - 'XPC_FLAGS': '0x0', 11:18:29 INFO - 'XPC_SERVICE_NAME': '0', 11:18:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:30 INFO - Downloading/unpacking blobuploader==1.2.4 11:18:30 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 11:18:30 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 11:18:30 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 11:18:30 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 11:18:30 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 11:18:30 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 11:18:32 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:33 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 11:18:33 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 11:18:33 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 11:18:33 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 11:18:33 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 11:18:33 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 11:18:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:33 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 11:18:33 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 11:18:33 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 11:18:33 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 11:18:33 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 11:18:33 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 11:18:34 INFO - Downloading docopt-0.6.1.tar.gz 11:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:34 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:34 INFO - Running setup.py install for blobuploader 11:18:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:34 INFO - Running setup.py install for requests 11:18:34 INFO - Running setup.py install for docopt 11:18:35 INFO - Successfully installed blobuploader requests docopt 11:18:35 INFO - Cleaning up... 11:18:35 INFO - Return code: 0 11:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:35 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 0x108b86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108afc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb662d90620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, '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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:18:35 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 11:18:35 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 11:18:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:18:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:35 INFO - 'HOME': '/Users/cltbld', 11:18:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:35 INFO - 'LOGNAME': 'cltbld', 11:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:35 INFO - 'MOZ_NO_REMOTE': '1', 11:18:35 INFO - 'NO_EM_RESTART': '1', 11:18:35 INFO - 'PAGER': '/bin/cat', 11:18:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:35 INFO - 'PWD': '/builds/slave/test', 11:18:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:35 INFO - 'SHELL': '/bin/bash', 11:18:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:18:35 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:18:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:35 INFO - 'USER': 'cltbld', 11:18:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:35 INFO - 'XPC_FLAGS': '0x0', 11:18:35 INFO - 'XPC_SERVICE_NAME': '0', 11:18:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:35 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-9ON397-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:35 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-touQnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:35 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-9FpOpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:35 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-76IvFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:35 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-x6hjTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:36 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-hbFJ4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:36 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-KiU5RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:36 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-hznvwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:36 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-aPWYGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:36 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-ZfIbAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:36 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-oMzcUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:36 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-jTDWii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:36 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-ZnhRqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:36 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-wp3Teo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:36 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-guFSWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:37 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-qUNPFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:37 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-BeMdQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:37 INFO - Running setup.py install for manifestparser 11:18:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:37 INFO - Running setup.py install for mozcrash 11:18:37 INFO - Running setup.py install for mozdebug 11:18:37 INFO - Running setup.py install for mozdevice 11:18:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:37 INFO - Running setup.py install for mozfile 11:18:38 INFO - Running setup.py install for mozhttpd 11:18:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:38 INFO - Running setup.py install for mozinfo 11:18:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:38 INFO - Running setup.py install for mozInstall 11:18:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:38 INFO - Running setup.py install for mozleak 11:18:38 INFO - Running setup.py install for mozlog 11:18:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:38 INFO - Running setup.py install for moznetwork 11:18:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:38 INFO - Running setup.py install for mozprocess 11:18:39 INFO - Running setup.py install for mozprofile 11:18:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Running setup.py install for mozrunner 11:18:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Running setup.py install for mozscreenshot 11:18:39 INFO - Running setup.py install for moztest 11:18:39 INFO - Running setup.py install for mozversion 11:18:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:39 INFO - Cleaning up... 11:18:39 INFO - Return code: 0 11:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:39 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 0x108b86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108afc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb662d90620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, '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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:18:39 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 11:18:39 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 11:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:39 INFO - 'HOME': '/Users/cltbld', 11:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:39 INFO - 'LOGNAME': 'cltbld', 11:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:39 INFO - 'MOZ_NO_REMOTE': '1', 11:18:39 INFO - 'NO_EM_RESTART': '1', 11:18:39 INFO - 'PAGER': '/bin/cat', 11:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:39 INFO - 'PWD': '/builds/slave/test', 11:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:39 INFO - 'SHELL': '/bin/bash', 11:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:18:39 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:39 INFO - 'USER': 'cltbld', 11:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:39 INFO - 'XPC_FLAGS': '0x0', 11:18:39 INFO - 'XPC_SERVICE_NAME': '0', 11:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:40 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-fiStLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:40 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)) 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:40 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-3kSCa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:40 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-mxUpIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:40 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)) 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:40 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-BFnRun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:40 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)) 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:40 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-i0XqQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:40 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)) 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:40 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-6Wezr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:40 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)) 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:40 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-5DFvv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:40 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)) 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:40 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-HgBM1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:41 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)) 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:41 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-Z3joZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:41 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)) 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:41 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-wKhXfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:41 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)) 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:41 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-VyYxjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:41 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)) 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:41 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-r_Sumj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:41 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)) 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:41 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-SMBil9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:41 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)) 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:41 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-qotgJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:41 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-rx8DII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:41 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)) 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:41 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-iLMLe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:41 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-lXgDNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:41 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)) 11:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:18:41 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)) 11:18:41 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)) 11:18:41 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)) 11:18:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:41 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 11:18:41 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 11:18:41 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 11:18:41 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 11:18:41 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 11:18:41 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 11:18:44 INFO - Downloading blessings-1.6.tar.gz 11:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:44 INFO - Installing collected packages: blessings 11:18:44 INFO - Running setup.py install for blessings 11:18:44 INFO - Successfully installed blessings 11:18:44 INFO - Cleaning up... 11:18:44 INFO - Return code: 0 11:18:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:45 INFO - Reading from file tmpfile_stdout 11:18:45 INFO - Current package versions: 11:18:45 INFO - blessings == 1.6 11:18:45 INFO - blobuploader == 1.2.4 11:18:45 INFO - docopt == 0.6.1 11:18:45 INFO - functools32 == 3.2.3-2 11:18:45 INFO - jsonschema == 2.5.1 11:18:45 INFO - manifestparser == 1.1 11:18:45 INFO - mozInstall == 1.12 11:18:45 INFO - mozcrash == 1.0 11:18:45 INFO - mozdebug == 0.1 11:18:45 INFO - mozdevice == 0.48 11:18:45 INFO - mozfile == 1.2 11:18:45 INFO - mozhttpd == 0.7 11:18:45 INFO - mozinfo == 0.9 11:18:45 INFO - mozleak == 0.1 11:18:45 INFO - mozlog == 3.4 11:18:45 INFO - moznetwork == 0.27 11:18:45 INFO - mozprocess == 0.23 11:18:45 INFO - mozprofile == 0.28 11:18:45 INFO - mozrunner == 6.13 11:18:45 INFO - mozscreenshot == 0.1 11:18:45 INFO - mozsystemmonitor == 0.3 11:18:45 INFO - moztest == 0.8 11:18:45 INFO - mozversion == 1.4 11:18:45 INFO - psutil == 3.1.1 11:18:45 INFO - requests == 1.2.3 11:18:45 INFO - wsgiref == 0.1.2 11:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:45 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 0x108b86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108afc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb662d90620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, '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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:18:45 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 11:18:45 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 11:18:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:18:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:45 INFO - 'HOME': '/Users/cltbld', 11:18:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:45 INFO - 'LOGNAME': 'cltbld', 11:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:45 INFO - 'MOZ_NO_REMOTE': '1', 11:18:45 INFO - 'NO_EM_RESTART': '1', 11:18:45 INFO - 'PAGER': '/bin/cat', 11:18:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:45 INFO - 'PWD': '/builds/slave/test', 11:18:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:45 INFO - 'SHELL': '/bin/bash', 11:18:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:18:45 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:18:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:45 INFO - 'USER': 'cltbld', 11:18:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:45 INFO - 'XPC_FLAGS': '0x0', 11:18:45 INFO - 'XPC_SERVICE_NAME': '0', 11:18:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 INFO - Cleaning up... 11:18:45 INFO - Return code: 0 11:18:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108b86490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108afc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb662d90620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, '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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 11:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:18:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:18:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:45 INFO - 'HOME': '/Users/cltbld', 11:18:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:45 INFO - 'LOGNAME': 'cltbld', 11:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:45 INFO - 'MOZ_NO_REMOTE': '1', 11:18:45 INFO - 'NO_EM_RESTART': '1', 11:18:45 INFO - 'PAGER': '/bin/cat', 11:18:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:45 INFO - 'PWD': '/builds/slave/test', 11:18:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:45 INFO - 'SHELL': '/bin/bash', 11:18:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:18:45 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:18:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:45 INFO - 'USER': 'cltbld', 11:18:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:45 INFO - 'XPC_FLAGS': '0x0', 11:18:45 INFO - 'XPC_SERVICE_NAME': '0', 11:18:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:18:45 INFO - Cleaning up... 11:18:45 INFO - Return code: 0 11:18:45 INFO - Running post-action listener: _resource_record_post_action 11:18:45 INFO - Running post-action listener: _start_resource_monitoring 11:18:45 INFO - Starting resource monitoring. 11:18:45 INFO - [mozharness: 2017-01-31 19:18:45.760145Z] Finished create-virtualenv step (success) 11:18:45 INFO - [mozharness: 2017-01-31 19:18:45.761183Z] Running install step. 11:18:45 INFO - Running pre-action listener: _resource_record_pre_action 11:18:45 INFO - Running main action method: install 11:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:46 INFO - Reading from file tmpfile_stdout 11:18:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:46 INFO - Reading from file tmpfile_stdout 11:18:46 INFO - Output received: 11:18:46 INFO - Usage: mozinstall [options] installer 11:18:46 INFO - Options: 11:18:46 INFO - -h, --help show this help message and exit 11:18:46 INFO - -d DEST, --destination=DEST 11:18:46 INFO - Directory to install application into. [default: 11:18:46 INFO - "/builds/slave/test"] 11:18:46 INFO - --app=APP Application being installed. [default: firefox] 11:18:46 INFO - mkdir: /builds/slave/test/build/application 11:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:19:07 INFO - Reading from file tmpfile_stdout 11:19:07 INFO - Output received: 11:19:07 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:19:07 INFO - Running post-action listener: _resource_record_post_action 11:19:07 INFO - [mozharness: 2017-01-31 19:19:07.583929Z] Finished install step (success) 11:19:07 INFO - [mozharness: 2017-01-31 19:19:07.584084Z] Running run-tests step. 11:19:07 INFO - Running pre-action listener: _resource_record_pre_action 11:19:07 INFO - Running main action method: run_tests 11:19:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:19:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:19:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:19:07 INFO - 2017-01-31 11:19:07.598 screenresolution[2204:71954] starting screenresolution argv=screenresolution get 11:19:07 INFO - 2017-01-31 11:19:07.601 screenresolution[2204:71954] Display 0: 1600x1200x32@60 11:19:07 INFO - 2017-01-31 11:19:07.606 screenresolution[2205:71958] starting screenresolution argv=screenresolution list 11:19:07 INFO - Available Modes on Display 0 11:19:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:19:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:19:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:19:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:19:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:19:07 INFO - Intel Iris: 11:19:07 INFO - Chipset Model: Intel Iris 11:19:07 INFO - Type: GPU 11:19:07 INFO - Bus: Built-In 11:19:07 INFO - VRAM (Dynamic, Max): 1536 MB 11:19:07 INFO - Vendor: Intel (0x8086) 11:19:07 INFO - Device ID: 0x0a2e 11:19:07 INFO - Revision ID: 0x0009 11:19:07 INFO - Displays: 11:19:07 INFO - Display: 11:19:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:19:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:19:07 INFO - Display Serial Number: 1600x1200 60 11:19:07 INFO - Main Display: Yes 11:19:07 INFO - Mirror: Off 11:19:07 INFO - Online: Yes 11:19:07 INFO - Rotation: Supported 11:19:07 INFO - Return code: 0 11:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:07 INFO - Python 2.7.3 11:19:07 INFO - Return code: 0 11:19:07 INFO - grabbing minidump binary from tooltool 11:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:19:07 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 0x10899ad30>, '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 0x108800db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108992b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:07 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 11:19:07 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 11:19:07 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 11:19:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:07 INFO - Return code: 0 11:19:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:19:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:19:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--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 11:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0382 --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 11:19:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I5uQ0jSAoA/Render', 11:19:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:07 INFO - 'HOME': '/Users/cltbld', 11:19:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:07 INFO - 'LOGNAME': 'cltbld', 11:19:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:07 INFO - 'MOZ_NO_REMOTE': '1', 11:19:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:07 INFO - 'NO_EM_RESTART': '1', 11:19:07 INFO - 'PAGER': '/bin/cat', 11:19:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:07 INFO - 'PWD': '/builds/slave/test', 11:19:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:07 INFO - 'SHELL': '/bin/bash', 11:19:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AXkuo4tdK2/Listeners', 11:19:07 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 11:19:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:07 INFO - 'USER': 'cltbld', 11:19:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:07 INFO - 'XPC_FLAGS': '0x0', 11:19:07 INFO - 'XPC_SERVICE_NAME': '0', 11:19:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--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 11:19:08 INFO - mozversion application_buildid: 20170131083709 11:19:08 INFO - mozversion application_changeset: 4217fbc0d4feea059a47b6360c627061ab0dd451 11:19:08 INFO - mozversion application_display_name: Firefox 11:19:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:08 INFO - mozversion application_name: Firefox 11:19:08 INFO - mozversion application_remotingname: firefox 11:19:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:19:08 INFO - mozversion application_vendor: Mozilla 11:19:08 INFO - mozversion application_version: 52.0 11:19:08 INFO - mozversion platform_buildid: 20170131083709 11:19:08 INFO - mozversion platform_changeset: 4217fbc0d4feea059a47b6360c627061ab0dd451 11:19:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:19:08 INFO - mozversion platform_version: 52.0 11:19:08 INFO - using testdate: 1485890348 11:19:08 INFO - actual date: 1485890348 11:19:08 INFO - starting webserver on 'localhost:55011' 11:19:08 INFO - SUITE-START | Running 2 tests 11:19:08 INFO - TEST-START | dromaeo_css 11:19:08 INFO - operating with platform_type : mac_ 11:19:08 INFO - Initialising browser for dromaeo_css test... 11:19:08 INFO - TEST-INFO | started process 2215 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpcQHP5V/profile http://localhost:55011/getInfo.html) 11:19:10 INFO - PROCESS | 2215 | __metrics Screen width/height:1600/1200 11:19:10 INFO - PROCESS | 2215 | colorDepth:24 11:19:10 INFO - PROCESS | 2215 | Browser inner width/height: 1024/689 11:19:10 INFO - PROCESS | 2215 | __metrics 11:19:10 INFO - PROCESS | 2215 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:19:10 INFO - PROCESS | 2215 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:11 INFO - TEST-INFO | 2215: exit 0 11:19:11 INFO - Browser initialized. 11:19:11 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:11 INFO - TEST-INFO | started process 2218 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpcQHP5V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:23 INFO - PROCESS | 2218 | RSS: Main: 172085248 11:19:23 INFO - PROCESS | 2218 | 11:22:26 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:55011/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55011/tests/dromaeo/cssquery-ext.html) 11:22:28 INFO - PROCESS | 2218 | RSS: Main: 313520128 11:22:28 INFO - PROCESS | 2218 | 11:25:31 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:55011/tests/dromaeo/cssquery-ext.html (next: http://localhost:55011/tests/dromaeo/cssquery-jquery.html) 11:25:31 INFO - PROCESS | 2218 | RSS: Main: 297975808 11:25:31 INFO - PROCESS | 2218 | 11:28:34 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:55011/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55011/tests/dromaeo/cssquery-mootools.html) 11:28:34 INFO - PROCESS | 2218 | RSS: Main: 272797696 11:28:34 INFO - PROCESS | 2218 | 11:31:36 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:55011/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55011/tests/dromaeo/cssquery-prototype.html) 11:31:37 INFO - PROCESS | 2218 | RSS: Main: 267345920 11:31:37 INFO - PROCESS | 2218 | 11:34:40 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:55011/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55011/tests/dromaeo/cssquery-yui.html) 11:34:41 INFO - PROCESS | 2218 | RSS: Main: 259108864 11:34:41 INFO - PROCESS | 2218 | 11:37:44 INFO - PROCESS | 2218 | Cycle 1(1): loaded http://localhost:55011/tests/dromaeo/cssquery-yui.html (next: http://localhost:55011/tests/dromaeo/cssquery-dojo.html) 11:37:44 INFO - PROCESS | 2218 | RSS: Main: 320761856 11:37:44 INFO - PROCESS | 2218 | 11:37:44 INFO - PROCESS | 2218 | __start_tp_report 11:37:44 INFO - PROCESS | 2218 | _x_x_mozilla_page_load 11:37:44 INFO - PROCESS | 2218 | _x_x_mozilla_page_load_details 11:37:44 INFO - PROCESS | 2218 | |i|pagename|runs| 11:37:44 INFO - PROCESS | 2218 | |0;dojo.html;3365.7812242204254;3379.6958273755363;3383.4755612880012;3384.255463797964;3432.8626854925806;5775.191473193751;5808.186853840455;5821.476067153955;5831.825045248649;5850.531957443405;5759.971200143993;5809.477147056764;5834.154047663086;5841.386654401291;5858.297004359483;5207.401148867891;5218.1650935850275;5240.266362709204;5284.2866213061325;5330.493603107699;5195.636305458601;5198.064348417283;5208.635395522296;5319.361676598814;5323.866903327409;5239.13554263546;5277.1556550951855;5286.550643195333;5290.603204759639;5312.096943519592;5297.390800058004;5321.707306098163;5332.413434522199;5338.706371149585;5346.492083252124;5097.209932460474;5172.9853013204465;5248.501392367757;5261.815836445706;5288.762005709752;5702.600817942745;5713.542916566665;5763.654180749127;5766.769329226826;5788;6083.422074902877;6162.630242185438;6240.87518249637;6288.276848162428;6294.527910406692;6210.252888663297;6226.1905952225925;6240.656763877985;6240.781572644981;6298.055291706235;5768.307803063659;5830.708464576796;5860.794872179454;5896.7641294348605;5928.970355148197;6318.715657795318;6351.364863513704;6361.5546911716665;6381.936180638227;6382.138411314506;6111.84720381994;6228.532860035515;6246.906296405557;6247.656378899204;6254.061890716429;6140.964409184426;6194.81415557534;6201.596896201732;6202.162708034358;6232.065190221503;6156.476699480594;6213.937860621426;6218.751249950042;6233.407826256498;6245.313015568284;6183.752649894044;6216.160818289473;6221.346758590283;6264.686765661699;6266.874662506724;4885.755712214375;4944.802207911715;4946.208606622995;4954.3311652926395;4984.22744474607;4453.465584129925;4482.8655140345845;4483.910321793546;4494.235979883428;4514.593686568224;5830.679312637845;5841.795537156179;5860.560457965669;5882.117682347596;5965.254343207099;5708.943845388616;5891.617044892068;6115.4190351916495;6212.875742485125;6277.2153480814895;5728.627639203439;5787.855303617359;5795.565332600072;5810.593258471951;5813.09896965971;4608.792604332813;5300.231466437345;5391.110466773017;5408.702521361363;5419.403865574784;6264.686765661699;6282.685865706605;6296.527760418078;6304.085907543381;6309.684515774101;6206.968965155145;6250.49996000328;6275.780347687809;6277.1525844010475;6305;6193.535484838565;6209.59637623553;6268.780592679234;6309.526785491014;6321.620702757666;6232.407921247474;6263.906041409291;6268.373162683695;6291;6300.243970723543;6254.843628909313;6282.560220784501;6286.5599408041;6293.527985401205;6305.1172835803945;6026.126211699367;6027.728752206249;6130.785422510191;6224.128621992834;6233.563650544418;4955.851324460272;6096.725647345968;6114.0828875669;6126.66303353302;6134.9079763804475;5377.574942640282;5944.464998150187;5950.732217050157;5955.702214889325;5961.2846458425265;5925.822225333247;5961.940380596138;6065.969670151621;6087.965045942289;6091.390860913873;6028.4272994065495;6036.154938308552;6087.269527656709;6100.938990610037;6108.8581424937165 11:37:44 INFO - PROCESS | 2218 | |1;ext.html;431.79273948504715;472.74471785235966;500.20217752684454;514.8378260847833;547.2666626720196;31438;33435.49846752298;33454;41295.793521032356;42102.57897421025;42546.7872660637;43207.3518897216;43221.78389108058;43314;43369;8400.663973441086;9411.95294023529;9565.378250413718;9785.630011798354;9827.115559599635;8977.371583989123;9188.081191880792;9625.518724063804;9719.805603887919;11595.24630898993;11639.6508104757;11975.041996640291;11994.520219191221;12013.399330033508;12027.158098933078;11845.703857403547;11881.40592970348;11974.461149248218;11979.640610781691;12002.459889305002;8896.599653015564;9110.225630821322;9123;9233.122853328923;11828.994535464495;39701.60298397037;40260;40414.39378409326;42742.57257427417;43017.13965720699;3357.983210083934;3417.3507033663523;3437.1750779812664;3438.0889064397957;3465.861365545375;29467.70532294671;29768.70231297681;31453.213669658213;31538.842305788552;31875.52186717201;2673.6123262126885;3268.084936217839;3303.752218583592;3314.9005529834144;3321.4685650295837;455450;455708;458519;459386;461068;58642.82714345689;58803.70598146982;58941.41058589445;59139.70430147822;59176.33706483219;62491;62716.43208919813;62946;62951.05573416402;62972.68513657494;16143.950643208154;16860.915695421445;16865.32538698463;16872.57818554546;16875.324987000382;13182.934085329704;13342.399592018382;13346;13354.666133346744;13379.397927093305;14125.717485650435;14179.291035448392;14187.361568729226;14341;15293.923530382499;5381.892362152813;5916.615419997686;5993.951058564734;6172.783952561728;6504.577202481823;871.8517851965181;878.508035500122;962.758042125664;1003.2074661017714;1096.2271598523023;28822.42355152927;29970.25074373158;30071.248218794266;30383.696163038087;30734.61694223765;1091.8908109189017;1120.098320851706;1124.0838716446233;1125.3472985668293;1141.1498433666804;15289.79013916459;15555;15709.842901571066;15851;16012.839871601367;679103.0672699567;683976;687718;688054;690118.0988190154;50451.24323135156;51293.74353128285;58911;61502.38497615056;63496;1387.1538361599416;1404.1364560795037;1416.7874818777266;1426.1300606629948;1430.542226487514;29758.702412975592;30951.535726963662;31089.533656995616;31161;31837.840810796726;49581.50418495913;50087.248691268935;50115.49884501108;50287.74856125842;50884;609594.952025237;613683;643586;811143;814047;30344.84827575848;37324.50701972;37496.6250337504;37959.05102372463;38436.61563384331;44991;45558;45578.54421455743;45947.540524595664;46193;36365.81817090898;37084.44373334456;37297.81351093227;40609.1878162441;41249;38058.809705951295;38289.04277392976;38522.80738596401;40012.799936000134;40702.59297406988;38173.80913095417;38887.80556097201;38894;39271.41092883552;39399.80300098481;32578.022659320257;34106.48840267348;34132.829335854156;34940.65059349374;34958.475622866186;25695.31420846531;25784.742152578983;25860.124364950636;26097.478050438505;26106.34734131586 11:37:44 INFO - PROCESS | 2218 | |2;jquery.html;324.7499425442409;380.09158112112056;392.5309255439749;401.2176256300212;417.1989779623123;19284.421467355984;20092.497687557818;21583.24458643948;21699;21817.563648727017;11800.645980620595;11929.701757456069;12224.51101955923;12360.134790564663;12371;5344.278522399484;5631.71841407928;5633.211350410926;5638.746256418471;5663.490285874271;5247;5406.729663516828;5462.071447853855;5481.314835645544;5576.9163462547895;5067.6452648314635;5283.63014588979;5461.590380721442;5482.643628164156;5486.862828429301;5443.374011988632;5456.045192091368;5811.999999999979;6078.969605151946;6131.540134489931;5941.851453713649;5977.910331345033;5992.2809262888295;5996.220491336098;6005.819825405245;19662.311819086262;21454.785452145436;24896.5020699585;25409.237722868344;25468.745312546824;2201.757806641268;2305.976940230593;2306.7923886850094;2566.7689907908193;2794.2595212268766;9959.452230127341;10541.209409294333;10642.414667193301;13939.930300348535;14282.500112496013;1849.657813304543;1916.1951980168362;1954.3359969841729;1963.9705404418946;2013.1544751204528;103104;106982.3952640711;117307;118315;119710.80289197083;8704.738857834274;9807.26445516589;9839.508024598741;9901.257405694601;11408.258463199865;12230.816537751942;12333.198342107913;12340.444679989421;12350.320732359807;12359.62921112368;8063.032436107587;8082.878756818653;8101.675932962733;8115.29578788461;8210.712625058213;7932.524048557105;8528;8532.70135545253;8688.304935605136;8689.261412779859;3081.27590016346;3872.9612703873163;3894.6494815466745;3950.940735888964;4052.959470405317;1777.8488828449467;1800.756897818804;1977.9505512362018;1978.5844972555637;1992.9003549822742;809.0938149272852;860.7733979079786;911.6080085563271;963.5375019990444;979.7893452907659;20648.79351206499;21265.89367053155;21391.46521336979;21456.678149827763;21641.56716865654;943.4150626946795;953.7806304549993;972.6692924405736;1047.8847326794046;1061.8247989081715;10664.893351066545;11299.926506981823;11357.432128393713;11419.60031398897;11448;611892;612251;614852.9257353685;627958;629108;69959.30040699629;73134.63432682803;86036.5698171505;106024.98419194705;130927.05243075264;893.8748575199477;901.2204443156622;936.2884208001832;937.5452905340904;938.990610093904;18259.908700456413;18452.630947381247;18782.873027618385;18869.018753030734;18878.811211887707;51829;52620;53969.460305396446;54089;54328.72835635796;75446.62276688582;76736.61631692029;77459.83810242964;77575.61212193903;78614;6032.879342413039;6502.837429064311;7710.575918324546;7737.3036426721865;7762.495437796525;10222.591096356062;11728.197645365837;11777.470013849226;12144.210626309261;12284.570040048555;10347.534360953925;10463.790724185626;10555.577776888838;10621.8937810624;10682.092022178202;9525.809483810146;9971.102600765966;10072.748181295527;10185.388876667424;10470.057694807503;8855.778605534655;10561.524731386953;10609.787804243717;10690.144788416752;10914.072303853944;6716.899246511209;7137.714491420493;7651.1201211859125;7848.293653570978;8011.599420029092;9618.230541556799;10397.584096636352;10538.89461105379;10622.309549879234;10866.13070954306 11:37:44 INFO - PROCESS | 2218 | |3;mootools.html;1450.7533719267724;1486.2865824404284;1633.8202797692259;1795.1024487756122;1797.5146710388187;8057.758267251985;8498.532580708059;8514.318854491641;8514.44656097354;8528.488290702562;7502.099748030244;7740.535567865932;7763.534187948713;7844.843103137934;8306.00327960644;2040.1431398812497;2071.6271071207175;2207.4812419081504;2286.0855657736956;2289.050044231642;2306.8731219782903;2316.2587971849016;2316.4903721181313;2317.8029867461287;2317.9884100579557;2238.753737088919;2273.3407311879537;2294.4263934016494;2295.1049090854494;2296.391456264091;2259.0963614554225;2267.353804165805;2279.4073540879326;2291.8051965582777;2291.9312420627325;2232.441889527618;2268.8411811173223;2290.541891621682;2292.415434064303;2295.001674271697;8352.415330926837;8397.286230670401;8455.281301089415;8460.153984601553;8471.872921906177;5086.033653605803;5223.895522089575;5226.451222621608;5231.2937753403185;5245.763940622643;3413.829308534588;3446.4141096013736;3450.9827450862836;3488.5813702355626;3532.0993146747674;1044.3733759744168;1044.670928657478;1060.5545670818274;1068.615298492542;1072.6084978982692;10388.324758890649;10800.135989120852;10896.291741036806;10904.78190436187;10914.836277455845;4449.1991441540185;4549.112922979987;4640.141573808856;4640.65195110368;4733.905321893543;9423.340366174301;9432.245420366355;9433.103855133751;9494.050594940589;9497.14525692691;5221.686698798008;5223.425423203445;5224.085784987612;5224.190250511177;5229.947700523022;4530.524294949048;4770.117528257283;4806.975965120152;4818.036392721469;4857.0043141155975;3560.661737134968;3669.1010702377553;3673.081729567608;3682.650148235913;3787.1857550626196;1191.237607930925;1211.5698926881007;1219.4573414830315;1283.165942137618;1287.6137158852307;778.9026371703537;831.767105210542;854.3464249848871;887.9422837515541;897.3270047464401;5613.971930140323;5659.320881494247;5773.422657734277;5843.357230704619;6034.034554471264;912.6121398405651;917.866909298148;967.2262190247774;973.6300205921846;986.9753256168653;3797.6202379761803;3876.4379165020914;3885.669718073939;4000.4199391088127;4019.015341241356;9920.553575089138;10204.795904081877;10290.3825770454;10300.381977081399;10318.535665895053;10233.590656373663;10239.436830974368;10274.22943279257;10286.845697314546;10297.279190456746;7528.548287102792;7908.644111015018;8058.959705201437;8093.27160555541;8095.311898488577;5430.42980487059;5513.338399392099;5555.2222688822785;5564.165375193753;5664.5751568631695;9325.673601424189;9358.204552613104;9398.389104708172;9509.809803803746;9519.333646644945;8038.276555110068;9538.23694104456;9551.617935282511;9568.043195680377;9603.423794572069;6724.73101075971;6828.078209441662;6898.448124150156;6923.9307606923285;6930.306969303029;7782.766517004499;7805.687772489264;7909.841803164019;7922.603869806371;7933.286004259414;7085.681144348414;7112.288771122846;7229.457790665826;7264;7424.1462231844025;6289.937100628935;6885.483588730765;6978.546394484342;7071.504994650325;7117.288271172842;6618.271990080991;6634.568753031038;6657.73369065232;6730.057791909235;6739.629320387426;4521.6608754344215;4621.3530105785885;4696.882577935579;4809.807607695653;4928.106795631411;4782.402199725035;4810.42274927011;4860.465348811557;4972.776225069808;5123.308353372247 11:37:44 INFO - PROCESS | 2218 | |4;prototype.html;249.4064127376843;315.9605049368827;317.8728508596562;326.5640370105908;329.20332794636977;5217.765200565974;5348.331458567679;5357.892422395012;5384.3807962084275;5398.271233383497;4874.634402419815;5132.435432102475;5268.920966185501;5318.6171595385185;5329.813456529022;4126.741343890112;4135.296999510083;4149.792510374485;4180.184863951531;4183.142455796555;3455.7580969332157;3473.218525831693;3797.449369841371;3841.8271177797064;3980.5621381647998;4075.1442197138635;4111.568285330027;4149.64727998119;4161.795417528517;4170.22850772608;4115.9588404116175;4122.8456032311005;4127.236461254677;4134.37984302354;4139.606737359946;3099.938001239985;3108.725422576755;3158.91017598928;3288.3423315337027;3625.800580968046;4360.645251564151;5132.615053870974;5227.738613069331;5285.564383150944;5317.867053323659;4106.035081755785;4672.252439609646;4731.290306454025;4743.881402964919;4790.880227994293;5637.137377127782;5647.152927060933;5659.528522584116;5681.488666020036;5691.800786972436;3780.584135745066;3929.9957021919026;3930.606939306075;3976.741511801724;3995.580464051291;5866.325372582165;5904.793332233394;5915.852103697399;5915.994280972245;5927.436893495111;4035.8183881725395;4043.332850079704;4055.5538890721996;4068.959310406917;4070.8371665133654;3757.267332870119;3965.266425711253;4017.216642754635;4083.673306135502;4155.168966206771;4655.627549796008;4678.087772884323;4682.2508398656055;4682.321063445781;4700.741459219776;5349.812756553502;5376.1129413647095;5698.287714035746;5708.372079071299;5709.65742055478;1195.3365881935608;1232.5747617072095;1276.9361531923553;1281.9487220511076;1282.9615111546668;758.719273868661;847.2967437027253;879.7580665316962;883.902770695223;887.3965703321803;4949.76255936016;4983.975080124576;5001.824936127218;5029.868279637052;5070.174737094643;4549.3176023596725;5099.974500127476;5404.675719456845;5425.7829686812875;5576.386597474275;4105.794710264535;4263.531011588785;4375.649948004152;4846.303793672257;4976.850694479172;2390.175389490623;2844.4879921613892;2851.8592562974563;2898.3478717288863;2912.1216815154107;5610.607257491936;5643.0249412705225;5669.858253543694;5724.742386592613;5729.455701708331;4729.69256998294;5234.643643470316;5595.496405323459;5596.468335508202;5669.971650141723;4908.925591758903;5595.964746521907;5691.3170419549915;5707.429257074259;5732.77068917247;4637.98814025872;4937.654364194472;5410.513053825174;5435.266239057834;5530.53891018509;5289.593235078107;5458.399576046711;5475.479829416199;5585.3297604287745;5929.911051334319;6163.938360616516;6183;6186.690665466798;6192.2569291683485;6196.969015154896;3518.366693995003;3745.6628903398823;3908.8241029154324;3961.1285517186175;3973.960260397359;5267.970002947672;5464.535514481314;5583.637063590853;5855.619384740148;5946.881062378815;4807.6153907688;5000.224965130411;5490.588205884655;5645.927273817962;5690.374058853606;5179.870503237298;5323.55849422188;5697.040556812975;5794.246747922912;5812.273465816773;4824.831130910401;5194.4805519447755;5356.5714742821265;5534.363548192009;5602.4957753802355;5633.6056476047925;5714.285714285715;5728.885422291448;5755.424457554211;5780.393058728773;4829.633479595043;4897.020595880766;5213.426523082534;5395.568354531707;5592.468715472024 11:37:44 INFO - PROCESS | 2218 | |5;yui.html;681.6285124607092;727.2509315405134;781.1875649324703;798.9360851131909;828.1263267253048;14659.706805863876;15036.24818759063;15556.766648500254;15581.92209038956;15613.111574358738;14203;14249.501267455642;14434.350454229558;14437.5668729938;14449;704.2745971649209;731.4404480572366;736.0872518077599;889.1464194373409;899.640143942425;730.167608925825;736.4550232827696;740.4668638580214;860.3547339495378;888.8577827547593;944.2068662323646;949.0699114867434;953.3183773601874;955.3837774635356;959.9856002159974;948.331426344429;950.9001554836711;951.3816019587255;953.4612943686794;954.6992697300328;702.785650376635;703.9260877607828;705.6824429006916;705.7459314646723;708.3164746020116;14671.55985320442;14886.10683359002;14888.776668349983;14894.553163405115;15328;12529.373531323397;13260.602181934557;13877;13955.302234888215;14668.779968300483;12390.380480975915;12672.619821405373;12686.111972161953;12807.679808004781;12815.935920320338;3800.657940785315;4340.218760623086;4370.322599997005;4722.551357621055;4747.240441529373;91075.54462227713;99595.0040499593;99651.0034899649;99659.50170249247;99699.50450743244;9792.461414622121;10229.693109206735;10299.485025748683;10423.061924426838;10572.418516981486;19548;19616.21535138607;19757.209711611664;19881.900590497244;19899;7594.658240379196;7618.504797188165;7627.389808815282;7641.3886889048745;7770.572618506037;4232.280512312914;4356.346548017823;4379.364992076131;4477.015056687524;4491.348754430589;3251.4635085210675;3332.5001249812235;3360.3279344130783;3365.360581489558;3371.696547310754;567.8041075828833;575.1171951055111;581.9941800582025;582.5659883386904;584.6141546579322;553.3802141601432;556.9944300557023;572.3132241310444;580.1182203051338;608.4250383387745;8574.314054875595;8581.270591999624;8821.38250322484;8909.064548222474;8914.28685705142;615.1510914937447;619.7056398210904;636.5448704176536;643.5334382572597;648.7210499485267;4034.3141665916864;4336.219480493478;4382.824687012484;4876.683015604045;4977.427595826526;76766.61616691881;98519;106126.46936765267;119208;129032;62244;102677.45983810248;102779.4861025705;105121.94878051274;106606.46696766466;80791;82259.17740822634;85782.57108714417;87425.68861467083;88925;9263.814723705353;10095;10127.7468063299;10133.594656213669;10146.79706405853;42937.78531107325;46996.530034699215;50656.493435065175;52419.47580524298;55634.44365556293;70319.29680703332;74486;74579;78712.60643696744;78991;13088.149270297781;13233.536826211037;13495.865041349462;13852.376643051288;13863.306834658026;11807;12963.481460741465;13123.278219698008;13164.078514503894;13293.80059299092;13300.467981281028;13532.72934541284;13548;13644.93177534106;13707;12481.193236063087;12842.00221758288;13208.075434719478;13517.932410337886;13844.861551384358;12417.689557761129;12422.192557483735;12594.740525947333;13458.52895148665;13763.449462021406;9321.347505674808;11227.438628068401;11370.260933039326;11408.201425900439;11860.110491713329;11077;11444.948224998687;11677.532898683958;11682.47428865686;11713.590024349107 11:37:44 INFO - PROCESS | 2218 | __end_tp_report 11:37:44 INFO - PROCESS | 2218 | __start_cc_report 11:37:44 INFO - PROCESS | 2218 | _x_x_mozilla_cycle_collect,1548 11:37:44 INFO - PROCESS | 2218 | __end_cc_report 11:37:44 INFO - PROCESS | 2218 | __startTimestamp1485891464518__endTimestamp 11:37:44 INFO - PROCESS | 2218 | 11:37:44 INFO - PROCESS | 2218 | ------- Summary: start ------- 11:37:44 INFO - PROCESS | 2218 | Number of tests: 6 11:37:44 INFO - PROCESS | 2218 | 11:37:44 INFO - PROCESS | 2218 | [#0] dojo.html Cycles:165 Average:5767.04 Median:5961.28 stddev:636.15 (10.7%) stddev-sans-first:609.57 11:37:44 INFO - PROCESS | 2218 | Values: 3365.8 3379.7 3383.5 3384.3 3432.9 5775.2 5808.2 5821.5 5831.8 5850.5 5760.0 5809.5 5834.2 5841.4 5858.3 5207.4 5218.2 5240.3 5284.3 5330.5 5195.6 5198.1 5208.6 5319.4 5323.9 5239.1 5277.2 5286.6 5290.6 5312.1 5297.4 5321.7 5332.4 5338.7 5346.5 5097.2 5173.0 5248.5 5261.8 5288.8 5702.6 5713.5 5763.7 5766.8 5788.0 6083.4 6162.6 6240.9 6288.3 6294.5 6210.3 6226.2 6240.7 6240.8 6298.1 5768.3 5830.7 5860.8 5896.8 5929.0 6318.7 6351.4 6361.6 6381.9 6382.1 6111.8 6228.5 6246.9 6247.7 6254.1 6141.0 6194.8 6201.6 6202.2 6232.1 6156.5 6213.9 6218.8 6233.4 6245.3 6183.8 6216.2 6221.3 6264.7 6266.9 4885.8 4944.8 4946.2 4954.3 4984.2 4453.5 4482.9 4483.9 4494.2 4514.6 5830.7 5841.8 5860.6 5882.1 5965.3 5708.9 5891.6 6115.4 6212.9 6277.2 5728.6 5787.9 5795.6 5810.6 5813.1 4608.8 5300.2 5391.1 5408.7 5419.4 6264.7 6282.7 6296.5 6304.1 6309.7 6207.0 6250.5 6275.8 6277.2 6305.0 6193.5 6209.6 6268.8 6309.5 6321.6 6232.4 6263.9 6268.4 6291.0 6300.2 6254.8 6282.6 6286.6 6293.5 6305.1 6026.1 6027.7 6130.8 6224.1 6233.6 4955.9 6096.7 6114.1 6126.7 6134.9 5377.6 5944.5 5950.7 5955.7 5961.3 5925.8 5961.9 6066.0 6088.0 6091.4 6028.4 6036.2 6087.3 6100.9 6108.9 11:37:44 INFO - PROCESS | 2218 | 11:37:44 INFO - PROCESS | 2218 | [#1] ext.html Cycles:180 Average:74217.59 Median:38231.43 stddev:168023.30 (439.5%) stddev-sans-first:168403.32 11:37:44 INFO - PROCESS | 2218 | Values: 431.8 472.7 500.2 514.8 547.3 31438.0 33435.5 33454.0 41295.8 42102.6 42546.8 43207.4 43221.8 43314.0 43369.0 8400.7 9412.0 9565.4 9785.6 9827.1 8977.4 9188.1 9625.5 9719.8 11595.2 11639.7 11975.0 11994.5 12013.4 12027.2 11845.7 11881.4 11974.5 11979.6 12002.5 8896.6 9110.2 9123.0 9233.1 11829.0 39701.6 40260.0 40414.4 42742.6 43017.1 3358.0 3417.4 3437.2 3438.1 3465.9 29467.7 29768.7 31453.2 31538.8 31875.5 2673.6 3268.1 3303.8 3314.9 3321.5 455450.0 455708.0 458519.0 459386.0 461068.0 58642.8 58803.7 58941.4 59139.7 59176.3 62491.0 62716.4 62946.0 62951.1 62972.7 16144.0 16860.9 16865.3 16872.6 16875.3 13182.9 13342.4 13346.0 13354.7 13379.4 14125.7 14179.3 14187.4 14341.0 15293.9 5381.9 5916.6 5994.0 6172.8 6504.6 871.9 878.5 962.8 1003.2 1096.2 28822.4 29970.3 30071.2 30383.7 30734.6 1091.9 1120.1 1124.1 1125.3 1141.1 15289.8 15555.0 15709.8 15851.0 16012.8 679103.1 683976.0 687718.0 688054.0 690118.1 50451.2 51293.7 58911.0 61502.4 63496.0 1387.2 1404.1 1416.8 1426.1 1430.5 29758.7 30951.5 31089.5 31161.0 31837.8 49581.5 50087.2 50115.5 50287.7 50884.0 609595.0 613683.0 643586.0 811143.0 814047.0 30344.8 37324.5 37496.6 37959.1 38436.6 44991.0 45558.0 45578.5 45947.5 46193.0 36365.8 37084.4 37297.8 40609.2 41249.0 38058.8 38289.0 38522.8 40012.8 40702.6 38173.8 38887.8 38894.0 39271.4 39399.8 32578.0 34106.5 34132.8 34940.7 34958.5 25695.3 25784.7 25860.1 26097.5 26106.3 11:37:44 INFO - PROCESS | 2218 | 11:37:44 INFO - PROCESS | 2218 | [#2] jquery.html Cycles:180 Average:33980.75 Median:2171.74 stddev:102512.59 (4720.3%) stddev-sans-first:102769.02 11:37:44 INFO - PROCESS | 2218 | Values: 324.7 380.1 392.5 401.2 417.2 19284.4 20092.5 21583.2 21699.0 21817.6 11800.6 11929.7 12224.5 12360.1 12371.0 5344.3 5631.7 5633.2 5638.7 5663.5 5247.0 5406.7 5462.1 5481.3 5576.9 5067.6 5283.6 5461.6 5482.6 5486.9 5443.4 5456.0 5812.0 6079.0 6131.5 5941.9 5977.9 5992.3 5996.2 6005.8 19662.3 21454.8 24896.5 25409.2 25468.7 2201.8 2306.0 2306.8 2566.8 2794.3 9959.5 10541.2 10642.4 13939.9 14282.5 1849.7 1916.2 1954.3 1964.0 2013.2 103104.0 106982.4 117307.0 118315.0 119710.8 8704.7 9807.3 9839.5 9901.3 11408.3 12230.8 12333.2 12340.4 12350.3 12359.6 8063.0 8082.9 8101.7 8115.3 8210.7 7932.5 8528.0 8532.7 8688.3 8689.3 3081.3 3873.0 3894.6 3950.9 4053.0 1777.8 1800.8 1978.0 1978.6 1992.9 809.1 860.8 911.6 963.5 979.8 20648.8 21265.9 21391.5 21456.7 21641.6 943.4 953.8 972.7 1047.9 1061.8 10664.9 11299.9 11357.4 11419.6 11448.0 611892.0 612251.0 614852.9 627958.0 629108.0 69959.3 73134.6 86036.6 106025.0 130927.1 893.9 901.2 936.3 937.5 939.0 18259.9 18452.6 18782.9 18869.0 18878.8 51829.0 52620.0 53969.5 54089.0 54328.7 75446.6 76736.6 77459.8 77575.6 78614.0 6032.9 6502.8 7710.6 7737.3 7762.5 10222.6 11728.2 11777.5 12144.2 12284.6 10347.5 10463.8 10555.6 10621.9 10682.1 9525.8 9971.1 10072.7 10185.4 10470.1 8855.8 10561.5 10609.8 10690.1 10914.1 6716.9 7137.7 7651.1 7848.3 8011.6 9618.2 10397.6 10538.9 10622.3 10866.1 11:37:44 INFO - PROCESS | 2218 | 11:37:44 INFO - PROCESS | 2218 | [#3] mootools.html Cycles:180 Average:5454.66 Median:5222.56 stddev:2994.03 (57.3%) stddev-sans-first:2987.31 11:37:44 INFO - PROCESS | 2218 | Values: 1450.8 1486.3 1633.8 1795.1 1797.5 8057.8 8498.5 8514.3 8514.4 8528.5 7502.1 7740.5 7763.5 7844.8 8306.0 2040.1 2071.6 2207.5 2286.1 2289.1 2306.9 2316.3 2316.5 2317.8 2318.0 2238.8 2273.3 2294.4 2295.1 2296.4 2259.1 2267.4 2279.4 2291.8 2291.9 2232.4 2268.8 2290.5 2292.4 2295.0 8352.4 8397.3 8455.3 8460.2 8471.9 5086.0 5223.9 5226.5 5231.3 5245.8 3413.8 3446.4 3451.0 3488.6 3532.1 1044.4 1044.7 1060.6 1068.6 1072.6 10388.3 10800.1 10896.3 10904.8 10914.8 4449.2 4549.1 4640.1 4640.7 4733.9 9423.3 9432.2 9433.1 9494.1 9497.1 5221.7 5223.4 5224.1 5224.2 5229.9 4530.5 4770.1 4807.0 4818.0 4857.0 3560.7 3669.1 3673.1 3682.7 3787.2 1191.2 1211.6 1219.5 1283.2 1287.6 778.9 831.8 854.3 887.9 897.3 5614.0 5659.3 5773.4 5843.4 6034.0 912.6 917.9 967.2 973.6 987.0 3797.6 3876.4 3885.7 4000.4 4019.0 9920.6 10204.8 10290.4 10300.4 10318.5 10233.6 10239.4 10274.2 10286.8 10297.3 7528.5 7908.6 8059.0 8093.3 8095.3 5430.4 5513.3 5555.2 5564.2 5664.6 9325.7 9358.2 9398.4 9509.8 9519.3 8038.3 9538.2 9551.6 9568.0 9603.4 6724.7 6828.1 6898.4 6923.9 6930.3 7782.8 7805.7 7909.8 7922.6 7933.3 7085.7 7112.3 7229.5 7264.0 7424.1 6289.9 6885.5 6978.5 7071.5 7117.3 6618.3 6634.6 6657.7 6730.1 6739.6 4521.7 4621.4 4696.9 4809.8 4928.1 4782.4 4810.4 4860.5 4972.8 5123.3 11:37:44 INFO - PROCESS | 2218 | 11:37:44 INFO - PROCESS | 2218 | [#4] prototype.html Cycles:180 Average:4537.04 Median:5050.02 stddev:1395.26 (27.6%) stddev-sans-first:1361.56 11:37:44 INFO - PROCESS | 2218 | Values: 249.4 316.0 317.9 326.6 329.2 5217.8 5348.3 5357.9 5384.4 5398.3 4874.6 5132.4 5268.9 5318.6 5329.8 4126.7 4135.3 4149.8 4180.2 4183.1 3455.8 3473.2 3797.4 3841.8 3980.6 4075.1 4111.6 4149.6 4161.8 4170.2 4116.0 4122.8 4127.2 4134.4 4139.6 3099.9 3108.7 3158.9 3288.3 3625.8 4360.6 5132.6 5227.7 5285.6 5317.9 4106.0 4672.3 4731.3 4743.9 4790.9 5637.1 5647.2 5659.5 5681.5 5691.8 3780.6 3930.0 3930.6 3976.7 3995.6 5866.3 5904.8 5915.9 5916.0 5927.4 4035.8 4043.3 4055.6 4069.0 4070.8 3757.3 3965.3 4017.2 4083.7 4155.2 4655.6 4678.1 4682.3 4682.3 4700.7 5349.8 5376.1 5698.3 5708.4 5709.7 1195.3 1232.6 1276.9 1281.9 1283.0 758.7 847.3 879.8 883.9 887.4 4949.8 4984.0 5001.8 5029.9 5070.2 4549.3 5100.0 5404.7 5425.8 5576.4 4105.8 4263.5 4375.6 4846.3 4976.9 2390.2 2844.5 2851.9 2898.3 2912.1 5610.6 5643.0 5669.9 5724.7 5729.5 4729.7 5234.6 5595.5 5596.5 5670.0 4908.9 5596.0 5691.3 5707.4 5732.8 4638.0 4937.7 5410.5 5435.3 5530.5 5289.6 5458.4 5475.5 5585.3 5929.9 6163.9 6183.0 6186.7 6192.3 6197.0 3518.4 3745.7 3908.8 3961.1 3974.0 5268.0 5464.5 5583.6 5855.6 5946.9 4807.6 5000.2 5490.6 5645.9 5690.4 5179.9 5323.6 5697.0 5794.2 5812.3 4824.8 5194.5 5356.6 5534.4 5602.5 5633.6 5714.3 5728.9 5755.4 5780.4 4829.6 4897.0 5213.4 5395.6 5592.5 11:37:44 INFO - PROCESS | 2218 | 11:37:44 INFO - PROCESS | 2218 | [#5] yui.html Cycles:180 Average:20810.76 Median:4363.33 stddev:30549.65 (700.1%) stddev-sans-first:30597.97 11:37:44 INFO - PROCESS | 2218 | Values: 681.6 727.3 781.2 798.9 828.1 14659.7 15036.2 15556.8 15581.9 15613.1 14203.0 14249.5 14434.4 14437.6 14449.0 704.3 731.4 736.1 889.1 899.6 730.2 736.5 740.5 860.4 888.9 944.2 949.1 953.3 955.4 960.0 948.3 950.9 951.4 953.5 954.7 702.8 703.9 705.7 705.7 708.3 14671.6 14886.1 14888.8 14894.6 15328.0 12529.4 13260.6 13877.0 13955.3 14668.8 12390.4 12672.6 12686.1 12807.7 12815.9 3800.7 4340.2 4370.3 4722.6 4747.2 91075.5 99595.0 99651.0 99659.5 99699.5 9792.5 10229.7 10299.5 10423.1 10572.4 19548.0 19616.2 19757.2 19881.9 19899.0 7594.7 7618.5 7627.4 7641.4 7770.6 4232.3 4356.3 4379.4 4477.0 4491.3 3251.5 3332.5 3360.3 3365.4 3371.7 567.8 575.1 582.0 582.6 584.6 553.4 557.0 572.3 580.1 608.4 8574.3 8581.3 8821.4 8909.1 8914.3 615.2 619.7 636.5 643.5 648.7 4034.3 4336.2 4382.8 4876.7 4977.4 76766.6 98519.0 106126.5 119208.0 129032.0 62244.0 102677.5 102779.5 105121.9 106606.5 80791.0 82259.2 85782.6 87425.7 88925.0 9263.8 10095.0 10127.7 10133.6 10146.8 42937.8 46996.5 50656.5 52419.5 55634.4 70319.3 74486.0 74579.0 78712.6 78991.0 13088.1 13233.5 13495.9 13852.4 13863.3 11807.0 12963.5 13123.3 13164.1 13293.8 13300.5 13532.7 13548.0 13644.9 13707.0 12481.2 12842.0 13208.1 13517.9 13844.9 12417.7 12422.2 12594.7 13458.5 13763.4 9321.3 11227.4 11370.3 11408.2 11860.1 11077.0 11444.9 11677.5 11682.5 11713.6 11:37:44 INFO - PROCESS | 2218 | -------- Summary: end -------- 11:37:44 INFO - PROCESS | 2218 | 11:37:45 INFO - TEST-INFO | 2218: exit 0 11:37:45 INFO - TEST-OK | dromaeo_css | took 1116944ms 11:37:45 INFO - TEST-START | kraken 11:37:45 INFO - operating with platform_type : mac_ 11:37:45 INFO - Initialising browser for kraken test... 11:37:45 INFO - TEST-INFO | started process 2221 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpmf6rfR/profile http://localhost:55011/getInfo.html) 11:37:47 INFO - PROCESS | 2221 | __metrics Screen width/height:1600/1200 11:37:47 INFO - PROCESS | 2221 | colorDepth:24 11:37:47 INFO - PROCESS | 2221 | Browser inner width/height: 1024/689 11:37:47 INFO - PROCESS | 2221 | __metrics 11:37:47 INFO - PROCESS | 2221 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:37:47 INFO - PROCESS | 2221 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:37:48 INFO - TEST-INFO | 2221: exit 0 11:37:48 INFO - Browser initialized. 11:37:48 INFO - Running cycle 1/1 for kraken test... 11:37:48 INFO - TEST-INFO | started process 2223 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpmf6rfR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:00 INFO - PROCESS | 2223 | RSS: Main: 172150784 11:38:00 INFO - PROCESS | 2223 | 11:38:03 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55011/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:04 INFO - PROCESS | 2223 | RSS: Main: 223350784 11:38:04 INFO - PROCESS | 2223 | 11:38:07 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55011/tests/kraken/driver.html?testName=audio-dft) 11:38:07 INFO - PROCESS | 2223 | RSS: Main: 235765760 11:38:07 INFO - PROCESS | 2223 | 11:38:11 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55011/tests/kraken/driver.html?testName=audio-fft) 11:38:11 INFO - PROCESS | 2223 | RSS: Main: 331853824 11:38:11 INFO - PROCESS | 2223 | 11:38:13 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55011/tests/kraken/driver.html?testName=audio-oscillator) 11:38:14 INFO - PROCESS | 2223 | RSS: Main: 232103936 11:38:14 INFO - PROCESS | 2223 | 11:38:16 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55011/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:17 INFO - PROCESS | 2223 | RSS: Main: 234418176 11:38:17 INFO - PROCESS | 2223 | 11:38:19 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55011/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:20 INFO - PROCESS | 2223 | RSS: Main: 274227200 11:38:20 INFO - PROCESS | 2223 | 11:38:23 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55011/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:23 INFO - PROCESS | 2223 | RSS: Main: 276316160 11:38:23 INFO - PROCESS | 2223 | 11:38:26 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55011/tests/kraken/driver.html?testName=json-parse-financial) 11:38:27 INFO - PROCESS | 2223 | RSS: Main: 270610432 11:38:27 INFO - PROCESS | 2223 | 11:38:28 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55011/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:29 INFO - PROCESS | 2223 | RSS: Main: 247541760 11:38:29 INFO - PROCESS | 2223 | 11:38:31 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55011/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:31 INFO - PROCESS | 2223 | RSS: Main: 252157952 11:38:31 INFO - PROCESS | 2223 | 11:38:33 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55011/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:34 INFO - PROCESS | 2223 | RSS: Main: 254271488 11:38:34 INFO - PROCESS | 2223 | 11:38:37 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55011/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:38 INFO - PROCESS | 2223 | RSS: Main: 273178624 11:38:38 INFO - PROCESS | 2223 | 11:38:40 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55011/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:41 INFO - PROCESS | 2223 | RSS: Main: 267059200 11:38:41 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | Cycle 1(1): loaded http://localhost:55011/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55011/tests/kraken/driver.html?testName=ai-astar) 11:38:43 INFO - PROCESS | 2223 | RSS: Main: 311123968 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | __start_tp_report 11:38:43 INFO - PROCESS | 2223 | _x_x_mozilla_page_load 11:38:43 INFO - PROCESS | 2223 | _x_x_mozilla_page_load_details 11:38:43 INFO - PROCESS | 2223 | |i|pagename|runs| 11:38:43 INFO - PROCESS | 2223 | |0;ai-astar;158;166;143;114;114;114;114;113;113;114 11:38:43 INFO - PROCESS | 2223 | |1;audio-beat-detection;145;126;94;151;139;143;123;107;136;108 11:38:43 INFO - PROCESS | 2223 | |2;audio-dft;185;193;186;185;181;182;183;184;187;251 11:38:43 INFO - PROCESS | 2223 | |3;audio-fft;82;58;58;89;60;57;59;58;81;56 11:38:43 INFO - PROCESS | 2223 | |4;audio-oscillator;90;70;93;67;78;99;123;89;68;91 11:38:43 INFO - PROCESS | 2223 | |5;imaging-gaussian-blur;89;86;90;87;88;86;90;87;89;86 11:38:43 INFO - PROCESS | 2223 | |6;imaging-darkroom;96;97;96;97;97;98;98;98;95;97 11:38:43 INFO - PROCESS | 2223 | |7;imaging-desaturate;86;81;82;82;85;85;86;84;81;84 11:38:43 INFO - PROCESS | 2223 | |8;json-parse-financial;58;55;56;51;56;58;59;57;58;59 11:38:43 INFO - PROCESS | 2223 | |9;json-stringify-tinderbox;63;76;73;74;70;68;72;70;71;73 11:38:43 INFO - PROCESS | 2223 | |10;stanford-crypto-aes;82;84;80;80;95;95;83;81;86;83 11:38:43 INFO - PROCESS | 2223 | |11;stanford-crypto-ccm;139;135;137;138;136;138;137;140;172;132 11:38:43 INFO - PROCESS | 2223 | |12;stanford-crypto-pbkdf2;163;161;165;165;163;163;162;162;165;161 11:38:43 INFO - PROCESS | 2223 | |13;stanford-crypto-sha256-iterative;68;65;68;66;66;68;64;66;65;65 11:38:43 INFO - PROCESS | 2223 | __end_tp_report 11:38:43 INFO - PROCESS | 2223 | __start_cc_report 11:38:43 INFO - PROCESS | 2223 | _x_x_mozilla_cycle_collect,1934 11:38:43 INFO - PROCESS | 2223 | __end_cc_report 11:38:43 INFO - PROCESS | 2223 | __startTimestamp1485891523475__endTimestamp 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | ------- Summary: start ------- 11:38:43 INFO - PROCESS | 2223 | Number of tests: 14 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#0] ai-astar Cycles:10 Average:126.30 Median:114.00 stddev:21.00 (18.4%) stddev-sans-first:18.89 11:38:43 INFO - PROCESS | 2223 | Values: 158.0 166.0 143.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:141.00 stddev:19.00 (13.5%) stddev-sans-first:19.02 11:38:43 INFO - PROCESS | 2223 | Values: 145.0 126.0 94.0 151.0 139.0 143.0 123.0 107.0 136.0 108.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#2] audio-dft Cycles:10 Average:191.70 Median:185.50 stddev:21.10 (11.4%) stddev-sans-first:22.24 11:38:43 INFO - PROCESS | 2223 | Values: 185.0 193.0 186.0 185.0 181.0 182.0 183.0 184.0 187.0 251.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#3] audio-fft Cycles:10 Average:65.80 Median:59.50 stddev:12.77 (21.5%) stddev-sans-first:12.12 11:38:43 INFO - PROCESS | 2223 | Values: 82.0 58.0 58.0 89.0 60.0 57.0 59.0 58.0 81.0 56.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:89.50 stddev:17.11 (19.1%) stddev-sans-first:18.11 11:38:43 INFO - PROCESS | 2223 | Values: 90.0 70.0 93.0 67.0 78.0 99.0 123.0 89.0 68.0 91.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.50 stddev:1.62 (1.8%) stddev-sans-first:1.66 11:38:43 INFO - PROCESS | 2223 | Values: 89.0 86.0 90.0 87.0 88.0 86.0 90.0 87.0 89.0 86.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:97.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 11:38:43 INFO - PROCESS | 2223 | Values: 96.0 97.0 96.0 97.0 97.0 98.0 98.0 98.0 95.0 97.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:84.50 stddev:1.96 (2.3%) stddev-sans-first:1.87 11:38:43 INFO - PROCESS | 2223 | Values: 86.0 81.0 82.0 82.0 85.0 85.0 86.0 84.0 81.0 84.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:58.00 stddev:2.41 (4.1%) stddev-sans-first:2.51 11:38:43 INFO - PROCESS | 2223 | Values: 58.0 55.0 56.0 51.0 56.0 58.0 59.0 57.0 58.0 59.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:72.50 stddev:3.62 (5.0%) stddev-sans-first:2.42 11:38:43 INFO - PROCESS | 2223 | Values: 63.0 76.0 73.0 74.0 70.0 68.0 72.0 70.0 71.0 73.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:83.50 stddev:5.63 (6.7%) stddev-sans-first:5.87 11:38:43 INFO - PROCESS | 2223 | Values: 82.0 84.0 80.0 80.0 95.0 95.0 83.0 81.0 86.0 83.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:138.00 stddev:11.33 (8.2%) stddev-sans-first:12.00 11:38:43 INFO - PROCESS | 2223 | Values: 139.0 135.0 137.0 138.0 136.0 138.0 137.0 140.0 172.0 132.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:163.00 stddev:1.56 (1.0%) stddev-sans-first:1.66 11:38:43 INFO - PROCESS | 2223 | Values: 163.0 161.0 165.0 165.0 163.0 163.0 162.0 162.0 165.0 161.0 11:38:43 INFO - PROCESS | 2223 | 11:38:43 INFO - PROCESS | 2223 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:1.45 (2.2%) stddev-sans-first:1.36 11:38:43 INFO - PROCESS | 2223 | Values: 68.0 65.0 68.0 66.0 66.0 68.0 64.0 66.0 65.0 65.0 11:38:43 INFO - PROCESS | 2223 | -------- Summary: end -------- 11:38:43 INFO - PROCESS | 2223 | 11:38:44 INFO - TEST-INFO | 2223: exit 0 11:38:44 INFO - TEST-OK | kraken | took 59380ms 11:38:44 INFO - SUITE-END | took 1176s 11:38:44 INFO - Completed test suite (00:19:36) 11:38:44 INFO - javascript benchmark 11:38:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3365.7812242204254, 3379.6958273755363, 3383.4755612880012, 3384.255463797964, 3432.8626854925806, 5775.191473193751, 5808.186853840455, 5821.476067153955, 5831.825045248649, 5850.531957443405, 5759.971200143993, 5809.477147056764, 5834.154047663086, 5841.386654401291, 5858.297004359483, 5207.401148867891, 5218.1650935850275, 5240.266362709204, 5284.2866213061325, 5330.493603107699, 5195.636305458601, 5198.064348417283, 5208.635395522296, 5319.361676598814, 5323.866903327409, 5239.13554263546, 5277.1556550951855, 5286.550643195333, 5290.603204759639, 5312.096943519592, 5297.390800058004, 5321.707306098163, 5332.413434522199, 5338.706371149585, 5346.492083252124, 5097.209932460474, 5172.9853013204465, 5248.501392367757, 5261.815836445706, 5288.762005709752, 5702.600817942745, 5713.542916566665, 5763.654180749127, 5766.769329226826, 5788.0, 6083.422074902877, 6162.630242185438, 6240.87518249637, 6288.276848162428, 6294.527910406692, 6210.252888663297, 6226.1905952225925, 6240.656763877985, 6240.781572644981, 6298.055291706235, 5768.307803063659, 5830.708464576796, 5860.794872179454, 5896.7641294348605, 5928.970355148197, 6318.715657795318, 6351.364863513704, 6361.5546911716665, 6381.936180638227, 6382.138411314506, 6111.84720381994, 6228.532860035515, 6246.906296405557, 6247.656378899204, 6254.061890716429, 6140.964409184426, 6194.81415557534, 6201.596896201732, 6202.162708034358, 6232.065190221503, 6156.476699480594, 6213.937860621426, 6218.751249950042, 6233.407826256498, 6245.313015568284, 6183.752649894044, 6216.160818289473, 6221.346758590283, 6264.686765661699, 6266.874662506724, 4885.755712214375, 4944.802207911715, 4946.208606622995, 4954.3311652926395, 4984.22744474607, 4453.465584129925, 4482.8655140345845, 4483.910321793546, 4494.235979883428, 4514.593686568224, 5830.679312637845, 5841.795537156179, 5860.560457965669, 5882.117682347596, 5965.254343207099, 5708.943845388616, 5891.617044892068, 6115.4190351916495, 6212.875742485125, 6277.2153480814895, 5728.627639203439, 5787.855303617359, 5795.565332600072, 5810.593258471951, 5813.09896965971, 4608.792604332813, 5300.231466437345, 5391.110466773017, 5408.702521361363, 5419.403865574784, 6264.686765661699, 6282.685865706605, 6296.527760418078, 6304.085907543381, 6309.684515774101, 6206.968965155145, 6250.49996000328, 6275.780347687809, 6277.1525844010475, 6305.0, 6193.535484838565, 6209.59637623553, 6268.780592679234, 6309.526785491014, 6321.620702757666, 6232.407921247474, 6263.906041409291, 6268.373162683695, 6291.0, 6300.243970723543, 6254.843628909313, 6282.560220784501, 6286.5599408041, 6293.527985401205, 6305.1172835803945, 6026.126211699367, 6027.728752206249, 6130.785422510191, 6224.128621992834, 6233.563650544418, 4955.851324460272, 6096.725647345968, 6114.0828875669, 6126.66303353302, 6134.9079763804475, 5377.574942640282, 5944.464998150187, 5950.732217050157, 5955.702214889325, 5961.2846458425265, 5925.822225333247, 5961.940380596138, 6065.969670151621, 6087.965045942289, 6091.390860913873, 6028.4272994065495, 6036.154938308552, 6087.269527656709, 6100.938990610037, 6108.8581424937165], "value": 5726.774942767057, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.79273948504715, 472.74471785235966, 500.20217752684454, 514.8378260847833, 547.2666626720196, 31438.0, 33435.49846752298, 33454.0, 41295.793521032356, 42102.57897421025, 42546.7872660637, 43207.3518897216, 43221.78389108058, 43314.0, 43369.0, 8400.663973441086, 9411.95294023529, 9565.378250413718, 9785.630011798354, 9827.115559599635, 8977.371583989123, 9188.081191880792, 9625.518724063804, 9719.805603887919, 11595.24630898993, 11639.6508104757, 11975.041996640291, 11994.520219191221, 12013.399330033508, 12027.158098933078, 11845.703857403547, 11881.40592970348, 11974.461149248218, 11979.640610781691, 12002.459889305002, 8896.599653015564, 9110.225630821322, 9123.0, 9233.122853328923, 11828.994535464495, 39701.60298397037, 40260.0, 40414.39378409326, 42742.57257427417, 43017.13965720699, 3357.983210083934, 3417.3507033663523, 3437.1750779812664, 3438.0889064397957, 3465.861365545375, 29467.70532294671, 29768.70231297681, 31453.213669658213, 31538.842305788552, 31875.52186717201, 2673.6123262126885, 3268.084936217839, 3303.752218583592, 3314.9005529834144, 3321.4685650295837, 455450.0, 455708.0, 458519.0, 459386.0, 461068.0, 58642.82714345689, 58803.70598146982, 58941.41058589445, 59139.70430147822, 59176.33706483219, 62491.0, 62716.43208919813, 62946.0, 62951.05573416402, 62972.68513657494, 16143.950643208154, 16860.915695421445, 16865.32538698463, 16872.57818554546, 16875.324987000382, 13182.934085329704, 13342.399592018382, 13346.0, 13354.666133346744, 13379.397927093305, 14125.717485650435, 14179.291035448392, 14187.361568729226, 14341.0, 15293.923530382499, 5381.892362152813, 5916.615419997686, 5993.951058564734, 6172.783952561728, 6504.577202481823, 871.8517851965181, 878.508035500122, 962.758042125664, 1003.2074661017714, 1096.2271598523023, 28822.42355152927, 29970.25074373158, 30071.248218794266, 30383.696163038087, 30734.61694223765, 1091.8908109189017, 1120.098320851706, 1124.0838716446233, 1125.3472985668293, 1141.1498433666804, 15289.79013916459, 15555.0, 15709.842901571066, 15851.0, 16012.839871601367, 679103.0672699567, 683976.0, 687718.0, 688054.0, 690118.0988190154, 50451.24323135156, 51293.74353128285, 58911.0, 61502.38497615056, 63496.0, 1387.1538361599416, 1404.1364560795037, 1416.7874818777266, 1426.1300606629948, 1430.542226487514, 29758.702412975592, 30951.535726963662, 31089.533656995616, 31161.0, 31837.840810796726, 49581.50418495913, 50087.248691268935, 50115.49884501108, 50287.74856125842, 50884.0, 609594.952025237, 613683.0, 643586.0, 811143.0, 814047.0, 30344.84827575848, 37324.50701972, 37496.6250337504, 37959.05102372463, 38436.61563384331, 44991.0, 45558.0, 45578.54421455743, 45947.540524595664, 46193.0, 36365.81817090898, 37084.44373334456, 37297.81351093227, 40609.1878162441, 41249.0, 38058.809705951295, 38289.04277392976, 38522.80738596401, 40012.799936000134, 40702.59297406988, 38173.80913095417, 38887.80556097201, 38894.0, 39271.41092883552, 39399.80300098481, 32578.022659320257, 34106.48840267348, 34132.829335854156, 34940.65059349374, 34958.475622866186, 25695.31420846531, 25784.742152578983, 25860.124364950636, 26097.478050438505, 26106.34734131586], "value": 20295.508265371198, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.7499425442409, 380.09158112112056, 392.5309255439749, 401.2176256300212, 417.1989779623123, 19284.421467355984, 20092.497687557818, 21583.24458643948, 21699.0, 21817.563648727017, 11800.645980620595, 11929.701757456069, 12224.51101955923, 12360.134790564663, 12371.0, 5344.278522399484, 5631.71841407928, 5633.211350410926, 5638.746256418471, 5663.490285874271, 5247.0, 5406.729663516828, 5462.071447853855, 5481.314835645544, 5576.9163462547895, 5067.6452648314635, 5283.63014588979, 5461.590380721442, 5482.643628164156, 5486.862828429301, 5443.374011988632, 5456.045192091368, 5811.999999999979, 6078.969605151946, 6131.540134489931, 5941.851453713649, 5977.910331345033, 5992.2809262888295, 5996.220491336098, 6005.819825405245, 19662.311819086262, 21454.785452145436, 24896.5020699585, 25409.237722868344, 25468.745312546824, 2201.757806641268, 2305.976940230593, 2306.7923886850094, 2566.7689907908193, 2794.2595212268766, 9959.452230127341, 10541.209409294333, 10642.414667193301, 13939.930300348535, 14282.500112496013, 1849.657813304543, 1916.1951980168362, 1954.3359969841729, 1963.9705404418946, 2013.1544751204528, 103104.0, 106982.3952640711, 117307.0, 118315.0, 119710.80289197083, 8704.738857834274, 9807.26445516589, 9839.508024598741, 9901.257405694601, 11408.258463199865, 12230.816537751942, 12333.198342107913, 12340.444679989421, 12350.320732359807, 12359.62921112368, 8063.032436107587, 8082.878756818653, 8101.675932962733, 8115.29578788461, 8210.712625058213, 7932.524048557105, 8528.0, 8532.70135545253, 8688.304935605136, 8689.261412779859, 3081.27590016346, 3872.9612703873163, 3894.6494815466745, 3950.940735888964, 4052.959470405317, 1777.8488828449467, 1800.756897818804, 1977.9505512362018, 1978.5844972555637, 1992.9003549822742, 809.0938149272852, 860.7733979079786, 911.6080085563271, 963.5375019990444, 979.7893452907659, 20648.79351206499, 21265.89367053155, 21391.46521336979, 21456.678149827763, 21641.56716865654, 943.4150626946795, 953.7806304549993, 972.6692924405736, 1047.8847326794046, 1061.8247989081715, 10664.893351066545, 11299.926506981823, 11357.432128393713, 11419.60031398897, 11448.0, 611892.0, 612251.0, 614852.9257353685, 627958.0, 629108.0, 69959.30040699629, 73134.63432682803, 86036.5698171505, 106024.98419194705, 130927.05243075264, 893.8748575199477, 901.2204443156622, 936.2884208001832, 937.5452905340904, 938.990610093904, 18259.908700456413, 18452.630947381247, 18782.873027618385, 18869.018753030734, 18878.811211887707, 51829.0, 52620.0, 53969.460305396446, 54089.0, 54328.72835635796, 75446.62276688582, 76736.61631692029, 77459.83810242964, 77575.61212193903, 78614.0, 6032.879342413039, 6502.837429064311, 7710.575918324546, 7737.3036426721865, 7762.495437796525, 10222.591096356062, 11728.197645365837, 11777.470013849226, 12144.210626309261, 12284.570040048555, 10347.534360953925, 10463.790724185626, 10555.577776888838, 10621.8937810624, 10682.092022178202, 9525.809483810146, 9971.102600765966, 10072.748181295527, 10185.388876667424, 10470.057694807503, 8855.778605534655, 10561.524731386953, 10609.787804243717, 10690.144788416752, 10914.072303853944, 6716.899246511209, 7137.714491420493, 7651.1201211859125, 7848.293653570978, 8011.599420029092, 9618.230541556799, 10397.584096636352, 10538.89461105379, 10622.309549879234, 10866.13070954306], "value": 9077.515256154007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.7533719267724, 1486.2865824404284, 1633.8202797692259, 1795.1024487756122, 1797.5146710388187, 8057.758267251985, 8498.532580708059, 8514.318854491641, 8514.44656097354, 8528.488290702562, 7502.099748030244, 7740.535567865932, 7763.534187948713, 7844.843103137934, 8306.00327960644, 2040.1431398812497, 2071.6271071207175, 2207.4812419081504, 2286.0855657736956, 2289.050044231642, 2306.8731219782903, 2316.2587971849016, 2316.4903721181313, 2317.8029867461287, 2317.9884100579557, 2238.753737088919, 2273.3407311879537, 2294.4263934016494, 2295.1049090854494, 2296.391456264091, 2259.0963614554225, 2267.353804165805, 2279.4073540879326, 2291.8051965582777, 2291.9312420627325, 2232.441889527618, 2268.8411811173223, 2290.541891621682, 2292.415434064303, 2295.001674271697, 8352.415330926837, 8397.286230670401, 8455.281301089415, 8460.153984601553, 8471.872921906177, 5086.033653605803, 5223.895522089575, 5226.451222621608, 5231.2937753403185, 5245.763940622643, 3413.829308534588, 3446.4141096013736, 3450.9827450862836, 3488.5813702355626, 3532.0993146747674, 1044.3733759744168, 1044.670928657478, 1060.5545670818274, 1068.615298492542, 1072.6084978982692, 10388.324758890649, 10800.135989120852, 10896.291741036806, 10904.78190436187, 10914.836277455845, 4449.1991441540185, 4549.112922979987, 4640.141573808856, 4640.65195110368, 4733.905321893543, 9423.340366174301, 9432.245420366355, 9433.103855133751, 9494.050594940589, 9497.14525692691, 5221.686698798008, 5223.425423203445, 5224.085784987612, 5224.190250511177, 5229.947700523022, 4530.524294949048, 4770.117528257283, 4806.975965120152, 4818.036392721469, 4857.0043141155975, 3560.661737134968, 3669.1010702377553, 3673.081729567608, 3682.650148235913, 3787.1857550626196, 1191.237607930925, 1211.5698926881007, 1219.4573414830315, 1283.165942137618, 1287.6137158852307, 778.9026371703537, 831.767105210542, 854.3464249848871, 887.9422837515541, 897.3270047464401, 5613.971930140323, 5659.320881494247, 5773.422657734277, 5843.357230704619, 6034.034554471264, 912.6121398405651, 917.866909298148, 967.2262190247774, 973.6300205921846, 986.9753256168653, 3797.6202379761803, 3876.4379165020914, 3885.669718073939, 4000.4199391088127, 4019.015341241356, 9920.553575089138, 10204.795904081877, 10290.3825770454, 10300.381977081399, 10318.535665895053, 10233.590656373663, 10239.436830974368, 10274.22943279257, 10286.845697314546, 10297.279190456746, 7528.548287102792, 7908.644111015018, 8058.959705201437, 8093.27160555541, 8095.311898488577, 5430.42980487059, 5513.338399392099, 5555.2222688822785, 5564.165375193753, 5664.5751568631695, 9325.673601424189, 9358.204552613104, 9398.389104708172, 9509.809803803746, 9519.333646644945, 8038.276555110068, 9538.23694104456, 9551.617935282511, 9568.043195680377, 9603.423794572069, 6724.73101075971, 6828.078209441662, 6898.448124150156, 6923.9307606923285, 6930.306969303029, 7782.766517004499, 7805.687772489264, 7909.841803164019, 7922.603869806371, 7933.286004259414, 7085.681144348414, 7112.288771122846, 7229.457790665826, 7264.0, 7424.1462231844025, 6289.937100628935, 6885.483588730765, 6978.546394484342, 7071.504994650325, 7117.288271172842, 6618.271990080991, 6634.568753031038, 6657.73369065232, 6730.057791909235, 6739.629320387426, 4521.6608754344215, 4621.3530105785885, 4696.882577935579, 4809.807607695653, 4928.106795631411, 4782.402199725035, 4810.42274927011, 4860.465348811557, 4972.776225069808, 5123.308353372247], "value": 4417.0651438961, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [249.4064127376843, 315.9605049368827, 317.8728508596562, 326.5640370105908, 329.20332794636977, 5217.765200565974, 5348.331458567679, 5357.892422395012, 5384.3807962084275, 5398.271233383497, 4874.634402419815, 5132.435432102475, 5268.920966185501, 5318.6171595385185, 5329.813456529022, 4126.741343890112, 4135.296999510083, 4149.792510374485, 4180.184863951531, 4183.142455796555, 3455.7580969332157, 3473.218525831693, 3797.449369841371, 3841.8271177797064, 3980.5621381647998, 4075.1442197138635, 4111.568285330027, 4149.64727998119, 4161.795417528517, 4170.22850772608, 4115.9588404116175, 4122.8456032311005, 4127.236461254677, 4134.37984302354, 4139.606737359946, 3099.938001239985, 3108.725422576755, 3158.91017598928, 3288.3423315337027, 3625.800580968046, 4360.645251564151, 5132.615053870974, 5227.738613069331, 5285.564383150944, 5317.867053323659, 4106.035081755785, 4672.252439609646, 4731.290306454025, 4743.881402964919, 4790.880227994293, 5637.137377127782, 5647.152927060933, 5659.528522584116, 5681.488666020036, 5691.800786972436, 3780.584135745066, 3929.9957021919026, 3930.606939306075, 3976.741511801724, 3995.580464051291, 5866.325372582165, 5904.793332233394, 5915.852103697399, 5915.994280972245, 5927.436893495111, 4035.8183881725395, 4043.332850079704, 4055.5538890721996, 4068.959310406917, 4070.8371665133654, 3757.267332870119, 3965.266425711253, 4017.216642754635, 4083.673306135502, 4155.168966206771, 4655.627549796008, 4678.087772884323, 4682.2508398656055, 4682.321063445781, 4700.741459219776, 5349.812756553502, 5376.1129413647095, 5698.287714035746, 5708.372079071299, 5709.65742055478, 1195.3365881935608, 1232.5747617072095, 1276.9361531923553, 1281.9487220511076, 1282.9615111546668, 758.719273868661, 847.2967437027253, 879.7580665316962, 883.902770695223, 887.3965703321803, 4949.76255936016, 4983.975080124576, 5001.824936127218, 5029.868279637052, 5070.174737094643, 4549.3176023596725, 5099.974500127476, 5404.675719456845, 5425.7829686812875, 5576.386597474275, 4105.794710264535, 4263.531011588785, 4375.649948004152, 4846.303793672257, 4976.850694479172, 2390.175389490623, 2844.4879921613892, 2851.8592562974563, 2898.3478717288863, 2912.1216815154107, 5610.607257491936, 5643.0249412705225, 5669.858253543694, 5724.742386592613, 5729.455701708331, 4729.69256998294, 5234.643643470316, 5595.496405323459, 5596.468335508202, 5669.971650141723, 4908.925591758903, 5595.964746521907, 5691.3170419549915, 5707.429257074259, 5732.77068917247, 4637.98814025872, 4937.654364194472, 5410.513053825174, 5435.266239057834, 5530.53891018509, 5289.593235078107, 5458.399576046711, 5475.479829416199, 5585.3297604287745, 5929.911051334319, 6163.938360616516, 6183.0, 6186.690665466798, 6192.2569291683485, 6196.969015154896, 3518.366693995003, 3745.6628903398823, 3908.8241029154324, 3961.1285517186175, 3973.960260397359, 5267.970002947672, 5464.535514481314, 5583.637063590853, 5855.619384740148, 5946.881062378815, 4807.6153907688, 5000.224965130411, 5490.588205884655, 5645.927273817962, 5690.374058853606, 5179.870503237298, 5323.55849422188, 5697.040556812975, 5794.246747922912, 5812.273465816773, 4824.831130910401, 5194.4805519447755, 5356.5714742821265, 5534.363548192009, 5602.4957753802355, 5633.6056476047925, 5714.285714285715, 5728.885422291448, 5755.424457554211, 5780.393058728773, 4829.633479595043, 4897.020595880766, 5213.426523082534, 5395.568354531707, 5592.468715472024], "value": 4083.583681896341, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.6285124607092, 727.2509315405134, 781.1875649324703, 798.9360851131909, 828.1263267253048, 14659.706805863876, 15036.24818759063, 15556.766648500254, 15581.92209038956, 15613.111574358738, 14203.0, 14249.501267455642, 14434.350454229558, 14437.5668729938, 14449.0, 704.2745971649209, 731.4404480572366, 736.0872518077599, 889.1464194373409, 899.640143942425, 730.167608925825, 736.4550232827696, 740.4668638580214, 860.3547339495378, 888.8577827547593, 944.2068662323646, 949.0699114867434, 953.3183773601874, 955.3837774635356, 959.9856002159974, 948.331426344429, 950.9001554836711, 951.3816019587255, 953.4612943686794, 954.6992697300328, 702.785650376635, 703.9260877607828, 705.6824429006916, 705.7459314646723, 708.3164746020116, 14671.55985320442, 14886.10683359002, 14888.776668349983, 14894.553163405115, 15328.0, 12529.373531323397, 13260.602181934557, 13877.0, 13955.302234888215, 14668.779968300483, 12390.380480975915, 12672.619821405373, 12686.111972161953, 12807.679808004781, 12815.935920320338, 3800.657940785315, 4340.218760623086, 4370.322599997005, 4722.551357621055, 4747.240441529373, 91075.54462227713, 99595.0040499593, 99651.0034899649, 99659.50170249247, 99699.50450743244, 9792.461414622121, 10229.693109206735, 10299.485025748683, 10423.061924426838, 10572.418516981486, 19548.0, 19616.21535138607, 19757.209711611664, 19881.900590497244, 19899.0, 7594.658240379196, 7618.504797188165, 7627.389808815282, 7641.3886889048745, 7770.572618506037, 4232.280512312914, 4356.346548017823, 4379.364992076131, 4477.015056687524, 4491.348754430589, 3251.4635085210675, 3332.5001249812235, 3360.3279344130783, 3365.360581489558, 3371.696547310754, 567.8041075828833, 575.1171951055111, 581.9941800582025, 582.5659883386904, 584.6141546579322, 553.3802141601432, 556.9944300557023, 572.3132241310444, 580.1182203051338, 608.4250383387745, 8574.314054875595, 8581.270591999624, 8821.38250322484, 8909.064548222474, 8914.28685705142, 615.1510914937447, 619.7056398210904, 636.5448704176536, 643.5334382572597, 648.7210499485267, 4034.3141665916864, 4336.219480493478, 4382.824687012484, 4876.683015604045, 4977.427595826526, 76766.61616691881, 98519.0, 106126.46936765267, 119208.0, 129032.0, 62244.0, 102677.45983810248, 102779.4861025705, 105121.94878051274, 106606.46696766466, 80791.0, 82259.17740822634, 85782.57108714417, 87425.68861467083, 88925.0, 9263.814723705353, 10095.0, 10127.7468063299, 10133.594656213669, 10146.79706405853, 42937.78531107325, 46996.530034699215, 50656.493435065175, 52419.47580524298, 55634.44365556293, 70319.29680703332, 74486.0, 74579.0, 78712.60643696744, 78991.0, 13088.149270297781, 13233.536826211037, 13495.865041349462, 13852.376643051288, 13863.306834658026, 11807.0, 12963.481460741465, 13123.278219698008, 13164.078514503894, 13293.80059299092, 13300.467981281028, 13532.72934541284, 13548.0, 13644.93177534106, 13707.0, 12481.193236063087, 12842.00221758288, 13208.075434719478, 13517.932410337886, 13844.861551384358, 12417.689557761129, 12422.192557483735, 12594.740525947333, 13458.52895148665, 13763.449462021406, 9321.347505674808, 11227.438628068401, 11370.260933039326, 11408.201425900439, 11860.110491713329, 11077.0, 11444.948224998687, 11677.532898683958, 11682.47428865686, 11713.590024349107], "value": 7436.939854327516, "unit": "score"}], "name": "dromaeo_css", "value": 7219.087260268961, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 166.0, 143.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0], "value": 126.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 126.0, 94.0, 151.0, 139.0, 143.0, 123.0, 107.0, 136.0, 108.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 193.0, 186.0, 185.0, 181.0, 182.0, 183.0, 184.0, 187.0, 251.0], "value": 191.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 89.0, 60.0, 57.0, 59.0, 58.0, 81.0, 56.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 93.0, 67.0, 78.0, 99.0, 123.0, 89.0, 68.0, 91.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 90.0, 87.0, 88.0, 86.0, 90.0, 87.0, 89.0, 86.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 98.0, 98.0, 98.0, 95.0, 97.0], "value": 96.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 82.0, 82.0, 85.0, 85.0, 86.0, 84.0, 81.0, 84.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 51.0, 56.0, 58.0, 59.0, 57.0, 58.0, 59.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 76.0, 73.0, 74.0, 70.0, 68.0, 72.0, 70.0, 71.0, 73.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 80.0, 80.0, 95.0, 95.0, 83.0, 81.0, 86.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 135.0, 137.0, 138.0, 136.0, 138.0, 137.0, 140.0, 172.0, 132.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 165.0, 165.0, 163.0, 163.0, 162.0, 162.0, 165.0, 161.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 68.0, 66.0, 66.0, 68.0, 64.0, 66.0, 65.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1448.2, "alertThreshold": 2.0}]} 11:38:44 INFO - Return code: 0 11:38:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:44 INFO - # TBPL SUCCESS # 11:38:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:38:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:38:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:38:44 INFO - 2017-01-31 11:38:44.818 screenresolution[2227:74013] starting screenresolution argv=screenresolution get 11:38:44 INFO - 2017-01-31 11:38:44.820 screenresolution[2227:74013] Display 0: 1600x1200x32@60 11:38:44 INFO - 2017-01-31 11:38:44.827 screenresolution[2228:74017] starting screenresolution argv=screenresolution list 11:38:44 INFO - Available Modes on Display 0 11:38:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:38:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:38:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:38:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:38:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:38:45 INFO - Intel Iris: 11:38:45 INFO - Chipset Model: Intel Iris 11:38:45 INFO - Type: GPU 11:38:45 INFO - Bus: Built-In 11:38:45 INFO - VRAM (Dynamic, Max): 1536 MB 11:38:45 INFO - Vendor: Intel (0x8086) 11:38:45 INFO - Device ID: 0x0a2e 11:38:45 INFO - Revision ID: 0x0009 11:38:45 INFO - Displays: 11:38:45 INFO - Display: 11:38:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:38:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:38:45 INFO - Display Serial Number: 1600x1200 60 11:38:45 INFO - Main Display: Yes 11:38:45 INFO - Mirror: Off 11:38:45 INFO - Online: Yes 11:38:45 INFO - Rotation: Supported 11:38:45 INFO - Return code: 0 11:38:45 INFO - Running post-action listener: _resource_record_post_action 11:38:45 INFO - [mozharness: 2017-01-31 19:38:45.068783Z] Finished run-tests step (success) 11:38:45 INFO - Running post-run listener: _resource_record_post_run 11:38:45 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 131072; Write bytes: 495921152; Read time: 3; Write time: 1575 11:38:45 INFO - TinderboxPrint: CPU usage
53.6% 11:38:45 INFO - TinderboxPrint: I/O read bytes / time
131,072 / 3 11:38:45 INFO - TinderboxPrint: I/O write bytes / time
495,921,152 / 1,575 11:38:45 INFO - TinderboxPrint: CPU idle
2,225.7 (46.4%) 11:38:45 INFO - TinderboxPrint: CPU system
964.8 (20.1%) 11:38:45 INFO - TinderboxPrint: CPU user
1,603.1 (33.4%) 11:38:45 INFO - TinderboxPrint: Swap in / out
190,873,600 / 0 11:38:45 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 180871680; Write bytes: 176397312; Read time: 16596; Write time: 377 11:38:45 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 131072; Write bytes: 301792256; Read time: 3; Write time: 1140 11:38:45 INFO - Running post-run listener: _upload_blobber_files 11:38:45 INFO - Blob upload gear active. 11:38:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:45 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 11:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:38:45 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:38:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:46 INFO - (blobuploader) - INFO - Done attempting. 11:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:47 INFO - (blobuploader) - INFO - Done attempting. 11:38:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:38:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:38:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:50 INFO - (blobuploader) - INFO - Done attempting. 11:38:50 INFO - (blobuploader) - INFO - Iteration through files over. 11:38:50 INFO - Return code: 0 11:38:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:38:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:38:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da2f4ef087d0409ae906d37d42cf46c28498c1e6b99f39e1f2486ec1930d70102b818deac81bf5c5da012f2d7b4af78211d7f378e3788495cbc8e5fbf4d06065", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b7aaeed45b9839833cd3972d7dd085cc3da3b56029a2983e499db8ab1835f249b27aab9056eae07fe15fde7ed8477945a0ad4f2916590836a9a0362df0b1797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f46be5a9dfcf6e119ee3fa242379a20c5252eda64ff7350f21843357c9eb71234e38d468b40171d3876d86d894e646d3ede51028f52d4617f54570bf49d415a6"} 11:38:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:38:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:38:50 INFO - Contents: 11:38:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da2f4ef087d0409ae906d37d42cf46c28498c1e6b99f39e1f2486ec1930d70102b818deac81bf5c5da012f2d7b4af78211d7f378e3788495cbc8e5fbf4d06065", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b7aaeed45b9839833cd3972d7dd085cc3da3b56029a2983e499db8ab1835f249b27aab9056eae07fe15fde7ed8477945a0ad4f2916590836a9a0362df0b1797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f46be5a9dfcf6e119ee3fa242379a20c5252eda64ff7350f21843357c9eb71234e38d468b40171d3876d86d894e646d3ede51028f52d4617f54570bf49d415a6"} 11:38:50 INFO - Running post-run listener: copy_logs_to_upload_dir 11:38:50 INFO - Copying logs to upload dir... 11:38:50 INFO - mkdir: /builds/slave/test/build/upload/logs 11:38:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.700250 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-31 11:38:50.606477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 11:38:50.609786) ========= 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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da2f4ef087d0409ae906d37d42cf46c28498c1e6b99f39e1f2486ec1930d70102b818deac81bf5c5da012f2d7b4af78211d7f378e3788495cbc8e5fbf4d06065", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b7aaeed45b9839833cd3972d7dd085cc3da3b56029a2983e499db8ab1835f249b27aab9056eae07fe15fde7ed8477945a0ad4f2916590836a9a0362df0b1797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f46be5a9dfcf6e119ee3fa242379a20c5252eda64ff7350f21843357c9eb71234e38d468b40171d3876d86d894e646d3ede51028f52d4617f54570bf49d415a6"} build_url:https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/JNoTAGBMTQOQj_ogTN36nQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da2f4ef087d0409ae906d37d42cf46c28498c1e6b99f39e1f2486ec1930d70102b818deac81bf5c5da012f2d7b4af78211d7f378e3788495cbc8e5fbf4d06065", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b7aaeed45b9839833cd3972d7dd085cc3da3b56029a2983e499db8ab1835f249b27aab9056eae07fe15fde7ed8477945a0ad4f2916590836a9a0362df0b1797", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f46be5a9dfcf6e119ee3fa242379a20c5252eda64ff7350f21843357c9eb71234e38d468b40171d3876d86d894e646d3ede51028f52d4617f54570bf49d415a6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 11:38:50.644022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:38:50.644359) ========= 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.I5uQ0jSAoA/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.AXkuo4tdK2/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.005371 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 11:38:50.693233) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 11:38:50.693577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 11:38:50.693917) ========= ========= Total master_lag: 0.83 =========