builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0387 starttime: 1477084252.84 results: success (0) buildid: 20161021075723 builduid: f20d5982a12c429db2c5e6f7ca6eee24 revision: 28681d252003e3110105473754da2f4097cb83a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:52.842833) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:52.843260) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:52.843549) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:52.944948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:52.945436) ========= 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.oKbcTj4llB/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.4uUnBKpKsG/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-21 14:10:52-- 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% 19.2M=0.001s 2016-10-21 14:10:53 (19.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133630 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:53.103472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:53.103775) ========= 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.oKbcTj4llB/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.4uUnBKpKsG/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.023011 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:53.151797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 14:10:53.152114) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 28681d252003e3110105473754da2f4097cb83a6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 28681d252003e3110105473754da2f4097cb83a6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oKbcTj4llB/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.4uUnBKpKsG/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-21 14:10:53,256 truncating revision to first 12 chars 2016-10-21 14:10:53,256 Setting DEBUG logging. 2016-10-21 14:10:53,256 attempt 1/10 2016-10-21 14:10:53,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/28681d252003?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-21 14:10:54,438 unpacking tar archive at: mozilla-central-28681d252003/testing/mozharness/ program finished with exit code 0 elapsedTime=1.480156 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 14:10:54.653959) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:54.654247) ========= script_repo_revision: 28681d252003e3110105473754da2f4097cb83a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:54.654641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:54.654916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 14:10:54.673742) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-21 14:10:54.674067) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oKbcTj4llB/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.4uUnBKpKsG/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:10:54 INFO - MultiFileLogger online at 20161021 14:10:54 in /builds/slave/test 14:10:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:10:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:54 INFO - {'append_to_log': False, 14:10:54 INFO - 'base_work_dir': '/builds/slave/test', 14:10:54 INFO - 'blob_upload_branch': 'Firefox', 14:10:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:54 INFO - 'branch': 'Firefox', 14:10:54 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:54 INFO - 'config_files': ('talos/mac_config.py',), 14:10:54 INFO - 'default_actions': ('clobber', 14:10:54 INFO - 'read-buildbot-config', 14:10:54 INFO - 'download-and-extract', 14:10:54 INFO - 'populate-webroot', 14:10:54 INFO - 'create-virtualenv', 14:10:54 INFO - 'install', 14:10:54 INFO - 'run-tests'), 14:10:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:54 INFO - 'download_minidump_stackwalk': True, 14:10:54 INFO - 'download_symbols': 'ondemand', 14:10:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:54 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:54 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:54 INFO - 'installer_path': 'installer.exe', 14:10:54 INFO - 'log_level': 'info', 14:10:54 INFO - 'log_name': 'talos', 14:10:54 INFO - 'log_to_console': True, 14:10:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:10:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:10:54 INFO - 'opt_config_files': (), 14:10:54 INFO - 'pip_index': False, 14:10:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:10:54 INFO - 'cmd': ('bash', 14:10:54 INFO - '-c', 14:10:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:10:54 INFO - 'enabled': True, 14:10:54 INFO - 'halt_on_failure': False, 14:10:54 INFO - 'name': 'check_screen_resolution'},), 14:10:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:10:54 INFO - 'cmd': ('bash', 14:10:54 INFO - '-c', 14:10:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:10:54 INFO - 'enabled': True, 14:10:54 INFO - 'halt_on_failure': False, 14:10:54 INFO - 'name': 'check_screen_resolution'},), 14:10:54 INFO - 'run_cmd_checks_enabled': True, 14:10:54 INFO - 'sps_profile': False, 14:10:54 INFO - 'sps_profile_interval': 0, 14:10:54 INFO - 'suite': 'dromaeojs', 14:10:54 INFO - 'system_bits': '32', 14:10:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:54 INFO - 'title': 't-yosemite-r7-0387', 14:10:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:54 INFO - 'use_talos_json': True, 14:10:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:54 INFO - 'work_dir': 'build'} 14:10:54 INFO - [mozharness: 2016-10-21 21:10:54.902350Z] Running clobber step. 14:10:54 INFO - Running pre-action listener: _resource_record_pre_action 14:10:54 INFO - Running main action method: clobber 14:10:54 INFO - rmtree: /builds/slave/test/build 14:10:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:54 INFO - Running post-action listener: _resource_record_post_action 14:10:54 INFO - [mozharness: 2016-10-21 21:10:54.907697Z] Finished clobber step (success) 14:10:54 INFO - [mozharness: 2016-10-21 21:10:54.907817Z] Running read-buildbot-config step. 14:10:54 INFO - Running pre-action listener: _resource_record_pre_action 14:10:54 INFO - Running main action method: read_buildbot_config 14:10:54 INFO - Using buildbot properties: 14:10:54 INFO - { 14:10:54 INFO - "project": "", 14:10:54 INFO - "product": "firefox", 14:10:54 INFO - "script_repo_revision": "production", 14:10:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:10:54 INFO - "repository": "", 14:10:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:10:54 INFO - "buildid": "20161021075723", 14:10:54 INFO - "pgo_build": "False", 14:10:54 INFO - "basedir": "/builds/slave/test", 14:10:54 INFO - "buildnumber": 125, 14:10:54 INFO - "slavename": "t-yosemite-r7-0387", 14:10:54 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:10:54 INFO - "platform": "yosemite_r7", 14:10:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:10:54 INFO - "branch": "mozilla-central", 14:10:54 INFO - "repo_path": "mozilla-central", 14:10:54 INFO - "revision": "28681d252003e3110105473754da2f4097cb83a6", 14:10:54 INFO - "stage_platform": "macosx64", 14:10:54 INFO - "builduid": "f20d5982a12c429db2c5e6f7ca6eee24", 14:10:54 INFO - "slavebuilddir": "test" 14:10:54 INFO - } 14:10:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:10:54 INFO - Running post-action listener: _resource_record_post_action 14:10:54 INFO - [mozharness: 2016-10-21 21:10:54.911249Z] Finished read-buildbot-config step (success) 14:10:54 INFO - [mozharness: 2016-10-21 21:10:54.911361Z] Running download-and-extract step. 14:10:54 INFO - Running pre-action listener: _resource_record_pre_action 14:10:54 INFO - Running main action method: download_and_extract 14:10:54 INFO - mkdir: /builds/slave/test/build/tests 14:10:54 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')]} 14:10:54 INFO - trying https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:10:54 INFO - Downloading https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 14:10:55 INFO - Downloaded 1199 bytes. 14:10:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:10:55 INFO - Using the following test package requirements: 14:10:55 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:10:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:10:55 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:10:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:10:55 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:10:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:10:55 INFO - u'jsshell-mac.zip'], 14:10:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:10:55 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:10:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:10:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:10:55 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:10:55 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:10:55 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:10:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:10:55 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 14:10:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:10:55 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:10:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:10:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:10:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:10:55 INFO - Fetch https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:10:56 INFO - Http code: 200 14:10:56 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 14:10:56 INFO - x-amz-cf-id: obrh6jwz8GyKQ09EUVdN0QP9edT911UWt3Zo6NRlL06RlbltOZCVzg== 14:10:56 INFO - x-amz-version-id: SOv5GcUapMzC6jnSPas3AAHZxEAanl.3 14:10:56 INFO - Expected file size: 16419254 14:10:56 INFO - Obtained file size: 16419254 14:11:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:11:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:11:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:11:03 INFO - Fetch https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:11:03 INFO - Http code: 200 14:11:03 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 14:11:03 INFO - x-amz-cf-id: IQyuiQ-Td3YL5g-G6I1ZE1_o_Cs_gI_ICxo1QG5855zsu5AiGjKVoQ== 14:11:03 INFO - x-amz-version-id: SOv5GcUapMzC6jnSPas3AAHZxEAanl.3 14:11:04 INFO - Expected file size: 16419254 14:11:04 INFO - Obtained file size: 16419254 14:11:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:11:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:11:10 INFO - Fetch https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:11:11 INFO - Http code: 200 14:11:11 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 14:11:11 INFO - x-amz-cf-id: Su7ZflCl7YOKlDqHoGdvchAdFYmIbwcH_ixTOisrfRGvYbqWYqN4Fg== 14:11:11 INFO - x-amz-version-id: p6bBU5AmDkqYlK2PC_JVdHGWau7iQe1P 14:11:12 INFO - Expected file size: 14409028 14:11:12 INFO - Obtained file size: 14409028 14:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:12 INFO - trying https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:11:12 INFO - Downloading https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:11:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 14:11:15 INFO - Downloaded 111226718 bytes. 14:11:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:11:15 INFO - mkdir: /builds/slave/test/properties 14:11:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:15 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:15 INFO - Contents: 14:11:15 INFO - build_url:https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:11:16 INFO - Running post-action listener: _resource_record_post_action 14:11:16 INFO - Running post-action listener: set_extra_try_arguments 14:11:16 INFO - [mozharness: 2016-10-21 21:11:16.298315Z] Finished download-and-extract step (success) 14:11:16 INFO - [mozharness: 2016-10-21 21:11:16.298453Z] Running populate-webroot step. 14:11:16 INFO - Running pre-action listener: _resource_record_pre_action 14:11:16 INFO - Running main action method: populate_webroot 14:11:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:16 INFO - '--tppagecycles', 14:11:16 INFO - '7'], 14:11:16 INFO - 'tests': ['tsvgm']}}, 14:11:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:16 INFO - 'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:16 INFO - 'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['damp', 'tps']}, 14:11:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:16 INFO - 'tests': ['damp', 'tps']}, 14:11:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['dromaeo_dom']}, 14:11:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['basic_compositor_video']}, 14:11:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:11:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['a11yr', 14:11:16 INFO - 'ts_paint', 14:11:16 INFO - 'tpaint', 14:11:16 INFO - 'sessionrestore', 14:11:16 INFO - 'sessionrestore_no_auto_restore', 14:11:16 INFO - 'tabpaint']}, 14:11:16 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:16 INFO - 'ts_paint', 14:11:16 INFO - 'tpaint', 14:11:16 INFO - 'sessionrestore', 14:11:16 INFO - 'sessionrestore_no_auto_restore', 14:11:16 INFO - 'tabpaint']}, 14:11:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:16 INFO - 'ts_paint', 14:11:16 INFO - 'tpaint', 14:11:16 INFO - 'sessionrestore', 14:11:16 INFO - 'sessionrestore_no_auto_restore', 14:11:16 INFO - 'tabpaint']}, 14:11:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:16 INFO - 'ts_paint', 14:11:16 INFO - 'tpaint', 14:11:16 INFO - 'sessionrestore', 14:11:16 INFO - 'sessionrestore_no_auto_restore', 14:11:16 INFO - 'tabpaint']}, 14:11:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['a11yr', 14:11:16 INFO - 'ts_paint', 14:11:16 INFO - 'tpaint', 14:11:16 INFO - 'sessionrestore', 14:11:16 INFO - 'sessionrestore_no_auto_restore', 14:11:16 INFO - 'tabpaint']}, 14:11:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['a11yr', 14:11:16 INFO - 'ts_paint', 14:11:16 INFO - 'tpaint', 14:11:16 INFO - 'sessionrestore', 14:11:16 INFO - 'sessionrestore_no_auto_restore', 14:11:16 INFO - 'tabpaint']}, 14:11:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['tsvgx', 14:11:16 INFO - 'tsvgr_opacity', 14:11:16 INFO - 'tart', 14:11:16 INFO - 'tscrollx', 14:11:16 INFO - 'cart']}, 14:11:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:16 INFO - 'tsvgr_opacity', 14:11:16 INFO - 'tart', 14:11:16 INFO - 'tscrollx', 14:11:16 INFO - 'cart']}, 14:11:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:16 INFO - 'talos_options': ['--disable-e10s'], 14:11:16 INFO - 'tests': ['tp5o']}, 14:11:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:16 INFO - 'tests': ['tp5o']}, 14:11:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:16 INFO - 'talos_options': ['--disable-e10s', 14:11:16 INFO - '--xperf_path', 14:11:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:16 INFO - 'tests': ['tp5n']}, 14:11:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:16 INFO - 'talos_options': ['--xperf_path', 14:11:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:16 INFO - 'tests': ['tp5n']}}, 14:11:16 INFO - 'talos.zip': {'path': '', 14:11:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:16 INFO - Running post-action listener: _resource_record_post_action 14:11:16 INFO - [mozharness: 2016-10-21 21:11:16.317292Z] Finished populate-webroot step (success) 14:11:16 INFO - [mozharness: 2016-10-21 21:11:16.317427Z] Running create-virtualenv step. 14:11:16 INFO - Running pre-action listener: _resource_record_pre_action 14:11:16 INFO - Running main action method: create_virtualenv 14:11:16 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:16 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 14:11:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:16 INFO - Using real prefix '/tools/python27' 14:11:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:17 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:20 INFO - Installing pip.................done. 14:11:20 INFO - Return code: 0 14:11:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:11:20 INFO - Reading from file tmpfile_stdout 14:11:20 INFO - Output received: 14:11:20 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) 14:11:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:20 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 0x1017f3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101769570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a059c040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, '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.oKbcTj4llB/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.4uUnBKpKsG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:11:20 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 14:11:20 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 14:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:20 INFO - 'HOME': '/Users/cltbld', 14:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:20 INFO - 'LOGNAME': 'cltbld', 14:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:20 INFO - 'MOZ_NO_REMOTE': '1', 14:11:20 INFO - 'NO_EM_RESTART': '1', 14:11:20 INFO - 'PAGER': '/bin/cat', 14:11:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:20 INFO - 'PWD': '/builds/slave/test', 14:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:20 INFO - 'SHELL': '/bin/bash', 14:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:11:20 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:20 INFO - 'USER': 'cltbld', 14:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:20 INFO - 'XPC_FLAGS': '0x0', 14:11:20 INFO - 'XPC_SERVICE_NAME': '0', 14:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:20 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 14:11:20 INFO - Cleaning up... 14:11:20 INFO - Return code: 0 14:11:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:20 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 0x1017f3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101769570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a059c040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, '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.oKbcTj4llB/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.4uUnBKpKsG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:11:20 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 14:11:20 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 14:11:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:11:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:20 INFO - 'HOME': '/Users/cltbld', 14:11:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:20 INFO - 'LOGNAME': 'cltbld', 14:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:20 INFO - 'MOZ_NO_REMOTE': '1', 14:11:20 INFO - 'NO_EM_RESTART': '1', 14:11:20 INFO - 'PAGER': '/bin/cat', 14:11:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:20 INFO - 'PWD': '/builds/slave/test', 14:11:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:20 INFO - 'SHELL': '/bin/bash', 14:11:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:11:20 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:11:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:20 INFO - 'USER': 'cltbld', 14:11:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:20 INFO - 'XPC_FLAGS': '0x0', 14:11:20 INFO - 'XPC_SERVICE_NAME': '0', 14:11:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:20 INFO - Downloading/unpacking psutil>=3.1.1 14:11:20 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 14:11:20 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 14:11:20 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 14:11:20 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 14:11:20 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 14:11:20 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 14:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:24 INFO - Installing collected packages: psutil 14:11:24 INFO - Running setup.py install for psutil 14:11:24 INFO - building 'psutil._psutil_osx' extension 14:11:24 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 14:11:25 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 14:11:25 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 14:11:25 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 14:11:25 INFO - building 'psutil._psutil_posix' extension 14:11:25 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 14:11:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:11:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:11:25 INFO - ^ 14:11:25 INFO - 1 warning generated. 14:11:25 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 14:11:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:25 INFO - Successfully installed psutil 14:11:25 INFO - Cleaning up... 14:11:25 INFO - Return code: 0 14:11:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017f3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101769570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a059c040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, '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.oKbcTj4llB/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.4uUnBKpKsG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:11:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:11:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:11:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:25 INFO - 'HOME': '/Users/cltbld', 14:11:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:25 INFO - 'LOGNAME': 'cltbld', 14:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:25 INFO - 'MOZ_NO_REMOTE': '1', 14:11:25 INFO - 'NO_EM_RESTART': '1', 14:11:25 INFO - 'PAGER': '/bin/cat', 14:11:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:25 INFO - 'PWD': '/builds/slave/test', 14:11:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:25 INFO - 'SHELL': '/bin/bash', 14:11:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:11:25 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:11:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:25 INFO - 'USER': 'cltbld', 14:11:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:25 INFO - 'XPC_FLAGS': '0x0', 14:11:25 INFO - 'XPC_SERVICE_NAME': '0', 14:11:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11:26 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 14:11:26 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 14:11:26 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 14:11:26 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 14:11:26 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 14:11:26 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 14:11:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:28 INFO - Installing collected packages: mozsystemmonitor 14:11:28 INFO - Running setup.py install for mozsystemmonitor 14:11:28 INFO - Successfully installed mozsystemmonitor 14:11:28 INFO - Cleaning up... 14:11:28 INFO - Return code: 0 14:11:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1017f3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101769570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a059c040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, '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.oKbcTj4llB/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.4uUnBKpKsG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:11:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:11:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:28 INFO - 'HOME': '/Users/cltbld', 14:11:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:28 INFO - 'LOGNAME': 'cltbld', 14:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:28 INFO - 'MOZ_NO_REMOTE': '1', 14:11:28 INFO - 'NO_EM_RESTART': '1', 14:11:28 INFO - 'PAGER': '/bin/cat', 14:11:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:28 INFO - 'PWD': '/builds/slave/test', 14:11:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:28 INFO - 'SHELL': '/bin/bash', 14:11:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:11:28 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:11:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:28 INFO - 'USER': 'cltbld', 14:11:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:28 INFO - 'XPC_FLAGS': '0x0', 14:11:28 INFO - 'XPC_SERVICE_NAME': '0', 14:11:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:29 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:32 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:32 INFO - warning: no files found matching '*.txt' 14:11:32 INFO - no previously-included directories found matching 'build' 14:11:32 INFO - no previously-included directories found matching 'dist' 14:11:32 INFO - no previously-included directories found matching '.git*' 14:11:32 INFO - Installing collected packages: jsonschema, functools32 14:11:32 INFO - Running setup.py install for functools32 14:11:32 INFO - warning: no files found matching '*.txt' 14:11:32 INFO - no previously-included directories found matching 'build' 14:11:32 INFO - no previously-included directories found matching 'dist' 14:11:32 INFO - no previously-included directories found matching '.git*' 14:11:32 INFO - Successfully installed jsonschema functools32 14:11:32 INFO - Cleaning up... 14:11:32 INFO - Return code: 0 14:11:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:11:32 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')]} 14:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:32 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')]} 14:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:32 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 0x1017f3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101769570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a059c040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, '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.oKbcTj4llB/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.4uUnBKpKsG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:11:32 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 14:11:32 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 14:11:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:11:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:32 INFO - 'HOME': '/Users/cltbld', 14:11:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:32 INFO - 'LOGNAME': 'cltbld', 14:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:32 INFO - 'MOZ_NO_REMOTE': '1', 14:11:32 INFO - 'NO_EM_RESTART': '1', 14:11:32 INFO - 'PAGER': '/bin/cat', 14:11:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:32 INFO - 'PWD': '/builds/slave/test', 14:11:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:32 INFO - 'SHELL': '/bin/bash', 14:11:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:11:32 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:11:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:32 INFO - 'USER': 'cltbld', 14:11:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:32 INFO - 'XPC_FLAGS': '0x0', 14:11:32 INFO - 'XPC_SERVICE_NAME': '0', 14:11:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:11:32 INFO - Cleaning up... 14:11:32 INFO - Return code: 0 14:11:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11:32 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')]} 14:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:32 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')]} 14:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:32 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 0x1017f3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101769570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a059c040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, '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.oKbcTj4llB/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.4uUnBKpKsG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:11:32 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 14:11:32 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 14:11:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:11:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:32 INFO - 'HOME': '/Users/cltbld', 14:11:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:32 INFO - 'LOGNAME': 'cltbld', 14:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:32 INFO - 'MOZ_NO_REMOTE': '1', 14:11:32 INFO - 'NO_EM_RESTART': '1', 14:11:32 INFO - 'PAGER': '/bin/cat', 14:11:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:32 INFO - 'PWD': '/builds/slave/test', 14:11:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:32 INFO - 'SHELL': '/bin/bash', 14:11:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:11:32 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:11:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:32 INFO - 'USER': 'cltbld', 14:11:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:32 INFO - 'XPC_FLAGS': '0x0', 14:11:32 INFO - 'XPC_SERVICE_NAME': '0', 14:11:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:33 INFO - Downloading/unpacking blobuploader==1.2.4 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:35 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11:35 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 14:11:35 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 14:11:35 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 14:11:35 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 14:11:35 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 14:11:35 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 14:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:36 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 14:11:36 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 14:11:36 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 14:11:36 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 14:11:36 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 14:11:36 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 14:11:36 INFO - Downloading docopt-0.6.1.tar.gz 14:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:36 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:36 INFO - Running setup.py install for blobuploader 14:11:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:36 INFO - Running setup.py install for requests 14:11:37 INFO - Running setup.py install for docopt 14:11:37 INFO - Successfully installed blobuploader requests docopt 14:11:37 INFO - Cleaning up... 14:11:37 INFO - Return code: 0 14:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:37 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 0x1017f3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101769570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a059c040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, '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.oKbcTj4llB/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.4uUnBKpKsG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:11:37 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 14:11:37 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 14:11:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:11:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:37 INFO - 'HOME': '/Users/cltbld', 14:11:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:37 INFO - 'LOGNAME': 'cltbld', 14:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:37 INFO - 'MOZ_NO_REMOTE': '1', 14:11:37 INFO - 'NO_EM_RESTART': '1', 14:11:37 INFO - 'PAGER': '/bin/cat', 14:11:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:37 INFO - 'PWD': '/builds/slave/test', 14:11:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:37 INFO - 'SHELL': '/bin/bash', 14:11:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:11:37 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:11:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:37 INFO - 'USER': 'cltbld', 14:11:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:37 INFO - 'XPC_FLAGS': '0x0', 14:11:37 INFO - 'XPC_SERVICE_NAME': '0', 14:11:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:37 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ZmiqhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-GOBoDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-SIPAo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-tPSdVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-7D8Qtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Bqktvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-TCIQdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-VfKUU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-72occw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-c9T4Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:38 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-EDkY87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-RqFZ7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-6E_B9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-5BnBYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Ci3shL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-xTE2fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:39 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-9d3oW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:39 INFO - Running setup.py install for manifestparser 14:11:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:39 INFO - Running setup.py install for mozcrash 14:11:39 INFO - Running setup.py install for mozdebug 14:11:40 INFO - Running setup.py install for mozdevice 14:11:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Running setup.py install for mozfile 14:11:40 INFO - Running setup.py install for mozhttpd 14:11:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Running setup.py install for mozinfo 14:11:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Running setup.py install for mozInstall 14:11:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:40 INFO - Running setup.py install for mozleak 14:11:40 INFO - Running setup.py install for mozlog 14:11:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for moznetwork 14:11:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for mozprocess 14:11:41 INFO - Running setup.py install for mozprofile 14:11:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for mozrunner 14:11:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for mozscreenshot 14:11:41 INFO - Running setup.py install for moztest 14:11:42 INFO - Running setup.py install for mozversion 14:11:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:42 INFO - Cleaning up... 14:11:42 INFO - Return code: 0 14:11:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:42 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 0x1017f3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101769570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a059c040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, '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.oKbcTj4llB/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.4uUnBKpKsG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:11:42 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 14:11:42 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 14:11:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:11:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:42 INFO - 'HOME': '/Users/cltbld', 14:11:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:42 INFO - 'LOGNAME': 'cltbld', 14:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:42 INFO - 'MOZ_NO_REMOTE': '1', 14:11:42 INFO - 'NO_EM_RESTART': '1', 14:11:42 INFO - 'PAGER': '/bin/cat', 14:11:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:42 INFO - 'PWD': '/builds/slave/test', 14:11:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:42 INFO - 'SHELL': '/bin/bash', 14:11:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:11:42 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:11:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:42 INFO - 'USER': 'cltbld', 14:11:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:42 INFO - 'XPC_FLAGS': '0x0', 14:11:42 INFO - 'XPC_SERVICE_NAME': '0', 14:11:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:42 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-j84Iiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:42 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)) 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:42 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Sv6mdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:42 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-4dPvWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:42 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)) 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:42 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-sfw4tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:42 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)) 14:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:42 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-4SDsJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-NZYynV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ZynPsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-kiDKSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-oP6Fu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-rpvhk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-q8RtD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-XvBdyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-EGjbJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:43 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)) 14:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:43 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ryNqEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:44 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-HNpSLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:44 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)) 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:44 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-AfxEJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:44 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Ce7XEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:44 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)) 14:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:44 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)) 14:11:44 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)) 14:11:44 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)) 14:11:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:46 INFO - Downloading blessings-1.6.tar.gz 14:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:46 INFO - Installing collected packages: blessings 14:11:46 INFO - Running setup.py install for blessings 14:11:47 INFO - Successfully installed blessings 14:11:47 INFO - Cleaning up... 14:11:47 INFO - Return code: 0 14:11:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:47 INFO - Reading from file tmpfile_stdout 14:11:47 INFO - Current package versions: 14:11:47 INFO - blessings == 1.6 14:11:47 INFO - blobuploader == 1.2.4 14:11:47 INFO - docopt == 0.6.1 14:11:47 INFO - functools32 == 3.2.3-2 14:11:47 INFO - jsonschema == 2.5.1 14:11:47 INFO - manifestparser == 1.1 14:11:47 INFO - mozInstall == 1.12 14:11:47 INFO - mozcrash == 0.17 14:11:47 INFO - mozdebug == 0.1 14:11:47 INFO - mozdevice == 0.48 14:11:47 INFO - mozfile == 1.2 14:11:47 INFO - mozhttpd == 0.7 14:11:47 INFO - mozinfo == 0.9 14:11:47 INFO - mozleak == 0.1 14:11:47 INFO - mozlog == 3.4 14:11:47 INFO - moznetwork == 0.27 14:11:47 INFO - mozprocess == 0.23 14:11:47 INFO - mozprofile == 0.28 14:11:47 INFO - mozrunner == 6.12 14:11:47 INFO - mozscreenshot == 0.1 14:11:47 INFO - mozsystemmonitor == 0.3 14:11:47 INFO - moztest == 0.7 14:11:47 INFO - mozversion == 1.4 14:11:47 INFO - psutil == 3.1.1 14:11:47 INFO - requests == 1.2.3 14:11:47 INFO - wsgiref == 0.1.2 14:11:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:47 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 0x1017f3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101769570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a059c040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, '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.oKbcTj4llB/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.4uUnBKpKsG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:11:47 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 14:11:47 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 14:11:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:11:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:47 INFO - 'HOME': '/Users/cltbld', 14:11:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:47 INFO - 'LOGNAME': 'cltbld', 14:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:47 INFO - 'MOZ_NO_REMOTE': '1', 14:11:47 INFO - 'NO_EM_RESTART': '1', 14:11:47 INFO - 'PAGER': '/bin/cat', 14:11:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:47 INFO - 'PWD': '/builds/slave/test', 14:11:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:47 INFO - 'SHELL': '/bin/bash', 14:11:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:11:47 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:11:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:47 INFO - 'USER': 'cltbld', 14:11:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:47 INFO - 'XPC_FLAGS': '0x0', 14:11:47 INFO - 'XPC_SERVICE_NAME': '0', 14:11:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:47 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)) 14:11:47 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)) 14:11:47 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)) 14:11:47 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)) 14:11:47 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)) 14:11:47 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)) 14:11:47 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)) 14:11:47 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)) 14:11:47 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)) 14:11:47 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)) 14:11:47 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)) 14:11:47 INFO - Cleaning up... 14:11:47 INFO - Return code: 0 14:11:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1017f3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101769570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a059c040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, '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.oKbcTj4llB/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.4uUnBKpKsG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 14:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:11:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:11:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:47 INFO - 'HOME': '/Users/cltbld', 14:11:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:47 INFO - 'LOGNAME': 'cltbld', 14:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:47 INFO - 'MOZ_NO_REMOTE': '1', 14:11:47 INFO - 'NO_EM_RESTART': '1', 14:11:47 INFO - 'PAGER': '/bin/cat', 14:11:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:47 INFO - 'PWD': '/builds/slave/test', 14:11:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:47 INFO - 'SHELL': '/bin/bash', 14:11:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:11:47 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:11:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:47 INFO - 'USER': 'cltbld', 14:11:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:47 INFO - 'XPC_FLAGS': '0x0', 14:11:47 INFO - 'XPC_SERVICE_NAME': '0', 14:11:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:48 INFO - Cleaning up... 14:11:48 INFO - Return code: 0 14:11:48 INFO - Running post-action listener: _resource_record_post_action 14:11:48 INFO - Running post-action listener: _start_resource_monitoring 14:11:48 INFO - Starting resource monitoring. 14:11:48 INFO - [mozharness: 2016-10-21 21:11:48.092549Z] Finished create-virtualenv step (success) 14:11:48 INFO - [mozharness: 2016-10-21 21:11:48.093524Z] Running install step. 14:11:48 INFO - Running pre-action listener: _resource_record_pre_action 14:11:48 INFO - Running main action method: install 14:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:48 INFO - Reading from file tmpfile_stdout 14:11:48 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:48 INFO - Reading from file tmpfile_stdout 14:11:48 INFO - Output received: 14:11:48 INFO - Usage: mozinstall [options] installer 14:11:48 INFO - Options: 14:11:48 INFO - -h, --help show this help message and exit 14:11:48 INFO - -d DEST, --destination=DEST 14:11:48 INFO - Directory to install application into. [default: 14:11:48 INFO - "/builds/slave/test"] 14:11:48 INFO - --app=APP Application being installed. [default: firefox] 14:11:48 INFO - mkdir: /builds/slave/test/build/application 14:11:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:11:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:12:22 INFO - Reading from file tmpfile_stdout 14:12:22 INFO - Output received: 14:12:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:12:22 INFO - Running post-action listener: _resource_record_post_action 14:12:22 INFO - [mozharness: 2016-10-21 21:12:22.449925Z] Finished install step (success) 14:12:22 INFO - [mozharness: 2016-10-21 21:12:22.450072Z] Running run-tests step. 14:12:22 INFO - Running pre-action listener: _resource_record_pre_action 14:12:22 INFO - Running main action method: run_tests 14:12:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:12:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:12:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:12:22 INFO - 2016-10-21 14:12:22.464 screenresolution[1755:17409] starting screenresolution argv=screenresolution get 14:12:22 INFO - 2016-10-21 14:12:22.467 screenresolution[1755:17409] Display 0: 1600x1200x32@60 14:12:22 INFO - 2016-10-21 14:12:22.473 screenresolution[1756:17411] starting screenresolution argv=screenresolution list 14:12:22 INFO - Available Modes on Display 0 14:12:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:12:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:12:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:12:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:12:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:12:22 INFO - Intel Iris: 14:12:22 INFO - Chipset Model: Intel Iris 14:12:22 INFO - Type: GPU 14:12:22 INFO - Bus: Built-In 14:12:22 INFO - VRAM (Dynamic, Max): 1536 MB 14:12:22 INFO - Vendor: Intel (0x8086) 14:12:22 INFO - Device ID: 0x0a2e 14:12:22 INFO - Revision ID: 0x0009 14:12:22 INFO - Displays: 14:12:22 INFO - Display: 14:12:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:12:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:12:22 INFO - Display Serial Number: 1600x1200 60 14:12:22 INFO - Main Display: Yes 14:12:22 INFO - Mirror: Off 14:12:22 INFO - Online: Yes 14:12:22 INFO - Rotation: Supported 14:12:22 INFO - Return code: 0 14:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:12:22 INFO - Python 2.7.3 14:12:22 INFO - Return code: 0 14:12:22 INFO - grabbing minidump binary from tooltool 14:12:22 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')]} 14:12:22 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 0x101607d30>, '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 0x10142ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1015ffb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:12:22 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 14:12:22 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 14:12:22 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 14:12:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:12:22 INFO - Return code: 0 14:12:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:12:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:12:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:12:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:12:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--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 14:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0387 --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 14:12:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oKbcTj4llB/Render', 14:12:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:12:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:12:22 INFO - 'HOME': '/Users/cltbld', 14:12:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:12:22 INFO - 'LOGNAME': 'cltbld', 14:12:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:22 INFO - 'MOZ_NO_REMOTE': '1', 14:12:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:22 INFO - 'NO_EM_RESTART': '1', 14:12:22 INFO - 'PAGER': '/bin/cat', 14:12:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:22 INFO - 'PWD': '/builds/slave/test', 14:12:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:12:22 INFO - 'SHELL': '/bin/bash', 14:12:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4uUnBKpKsG/Listeners', 14:12:22 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 14:12:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:12:22 INFO - 'USER': 'cltbld', 14:12:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:12:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:22 INFO - 'XPC_FLAGS': '0x0', 14:12:22 INFO - 'XPC_SERVICE_NAME': '0', 14:12:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--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 14:12:23 INFO - mozversion application_buildid: 20161021075723 14:12:23 INFO - mozversion application_changeset: 28681d252003e3110105473754da2f4097cb83a6 14:12:23 INFO - mozversion application_display_name: Nightly 14:12:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:12:23 INFO - mozversion application_name: Firefox 14:12:23 INFO - mozversion application_remotingname: firefox 14:12:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:12:23 INFO - mozversion application_vendor: Mozilla 14:12:23 INFO - mozversion application_version: 52.0a1 14:12:23 INFO - mozversion platform_buildid: 20161021075723 14:12:23 INFO - mozversion platform_changeset: 28681d252003e3110105473754da2f4097cb83a6 14:12:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:12:23 INFO - mozversion platform_version: 52.0a1 14:12:23 INFO - using testdate: 1477084343 14:12:23 INFO - actual date: 1477084343 14:12:23 INFO - starting webserver on 'localhost:49279' 14:12:23 INFO - SUITE-START | Running 2 tests 14:12:23 INFO - TEST-START | dromaeo_css 14:12:23 INFO - operating with platform_type : mac_ 14:12:23 INFO - Initialising browser for dromaeo_css test... 14:12:23 INFO - TEST-INFO | started process 1766 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpWmMtMs/profile http://localhost:49279/getInfo.html) 14:12:25 INFO - PROCESS | 1766 | __metrics Screen width/height:1600/1200 14:12:25 INFO - PROCESS | 1766 | colorDepth:24 14:12:25 INFO - PROCESS | 1766 | Browser inner width/height: 1024/689 14:12:25 INFO - PROCESS | 1766 | __metrics 14:12:25 INFO - PROCESS | 1766 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:12:25 INFO - PROCESS | 1766 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:12:26 INFO - TEST-INFO | 1766: exit 0 14:12:26 INFO - Browser initialized. 14:12:26 INFO - Running cycle 1/1 for dromaeo_css test... 14:12:26 INFO - TEST-INFO | started process 1769 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpWmMtMs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:38 INFO - PROCESS | 1769 | RSS: Main: 231612416 14:12:38 INFO - PROCESS | 1769 | 14:13:29 INFO - PROCESS | 1769 | 1477084409319 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:15:42 INFO - PROCESS | 1769 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 14:15:44 INFO - PROCESS | 1769 | RSS: Main: 378855424 14:15:44 INFO - PROCESS | 1769 | 14:18:47 INFO - PROCESS | 1769 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 14:18:47 INFO - PROCESS | 1769 | RSS: Main: 369127424 14:18:47 INFO - PROCESS | 1769 | 14:21:50 INFO - PROCESS | 1769 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 14:21:50 INFO - PROCESS | 1769 | RSS: Main: 360833024 14:21:50 INFO - PROCESS | 1769 | 14:24:52 INFO - PROCESS | 1769 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 14:24:53 INFO - PROCESS | 1769 | RSS: Main: 346669056 14:24:53 INFO - PROCESS | 1769 | 14:27:56 INFO - PROCESS | 1769 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 14:27:57 INFO - PROCESS | 1769 | RSS: Main: 331739136 14:27:57 INFO - PROCESS | 1769 | 14:31:00 INFO - PROCESS | 1769 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 14:31:01 INFO - PROCESS | 1769 | RSS: Main: 486817792 14:31:01 INFO - PROCESS | 1769 | 14:31:01 INFO - PROCESS | 1769 | __start_tp_report 14:31:01 INFO - PROCESS | 1769 | _x_x_mozilla_page_load 14:31:01 INFO - PROCESS | 1769 | _x_x_mozilla_page_load_details 14:31:01 INFO - PROCESS | 1769 | |i|pagename|runs| 14:31:01 INFO - PROCESS | 1769 | |0;dojo.html;2931.648202215734;3299.5215693724413;3306.520554519593;3324.634290228076;3373.173572474744;5506.174073888918;5602.299712535933;5606.635568688032;5655.434456554348;5656.151577263413;5610.523105536025;5629.183768353597;5683.8579035524135;5688.573356998231;5729.111987641912;4261.488621365433;5185.948140518603;5228.47715228478;5235.188545775411;5241.554467870235;5154.92267615986;5234.528892399683;5236.528712415882;5238.52853243208;5245.8950820983555;5103.9026609279;5228.215767634847;5237.109691352479;5246.68519888806;5294.285271488338;5115.61632877532;5203.895922081575;5205.8958820823755;5214.895702085975;5259.974305010524;5085.821996230115;5114.43741188469;5161.5870730341485;5166.948330516684;5187.221916712523;5547.833564993057;5596.104623260299;5596.776128954837;5599.496045355938;5629.408912064216;6201.751929922798;6210.875782484325;6215.223097112861;6228.532860035515;6234.438900498977;4496.55034496551;6007.759689612454;6100.786472473442;6139.8294713812775;6262.655553944532;5749.080147176432;5756.827295181151;5763.538916886681;5765.596408251382;5777.768889244468;6326.398992095744;6342.365763423713;6351.428371446592;6359.300476947532;6370.076338930921;5929.881402372014;5989.670568118795;6004.219451471281;6085.330613632497;6098.26820781509;6105.611380716617;6190.7523699052435;6191.752329906843;6248.094026366242;6260.624362538262;6116.174316467309;6153.138560601519;6158.538109641795;6159.784407545714;6175.96912015437;6132.386761323832;6185.876282474325;6190.81427557174;6191.226096737908;6214.316425193225;4826.469088400273;4841.031793641286;4874.976254986493;4877.756112194376;4918.631102667243;4408.272635015251;4461.754603496774;4463.419755431838;4489.393931819162;4490.3040028795585;5637.43625637433;5643.717814109278;5644.407337229614;5645.01212287848;5663.575231857627;6103.35914728956;6120.571559990847;6245.656488893154;6251.468625166912;6275.121482992385;5576.972115139399;5610.270664813548;5642.605017648807;5649.491545760901;5655.349634791969;5402.459754024566;5403.13549832025;5403.783848646089;5403.918941215885;5424.023675738405;6277.183966084471;6277.686115694106;6282.183316168869;6294.4964402846745;6296.748130074746;6063.484603808549;6143.788236234863;6146.754129834757;6202.4417802398;6271.62370257786;6219.346968568235;6282;6312.621242725451;6333.1766870306565;6336;6107.097787096225;6163.291221509405;6185.134081228722;6189.84525386869;6191.380861913773;6275.152854364785;6281;6288.182536270256;6288.496920246461;6297.52768542352;5845.035569131046;6086.087086936995;6097.847553811012;6112.786052488142;6135.417135372132;4443.022535042285;5886.499647530008;5895.469407753323;5948.762049517971;5966.910496342472;5418.106012507892;5437.918431223456;5880.206172166702;5930.703464826827;5951.404859514014;6052.334243233329;6074.969625151846;6079.361667024898;6083.330833608211;6087.512998960161;5471.179323101566;5758.395368486249;5821.854453638523;5915.911261330997;5920.733566989582 14:31:01 INFO - PROCESS | 1769 | |1;ext.html;467.6819762561458;469.8989717210799;521.7234865521273;522.9006488767136;531.6597377678287;29761.55357669634;39364.819055428314;40061.59938400615;40345.39481907774;42196.78901605495;41388.79305603475;41976;42012;42043;42136;9403.38877972933;9586.616535338579;9591.808163836718;9605.855912161323;9608.2313414927;9379.953100234488;9476.478793666345;9479.763005924839;9487.71536853892;9504.287178461609;9442.858357124649;9495.952520237424;9507.619695212183;9517.048295170496;9525.5713492893;9403.62385504579;9484.14642682155;9495.192908602778;9500.762480937963;9503.667371641994;8066.354691624656;9387.15515603599;9470.14768670816;9470.195033422098;9483.715488535356;39337.60662393368;39671.60328396708;39676.80161599174;39748;39774.20451590981;2960.4967155583604;3392.8303584820906;3408.6109661871706;3645.9453108203397;4047.736897101679;24351.14770983025;29874.103776886728;30441.895261845388;30471;31259.687403125907;2891.872169853759;3133.8903138390274;3157.289609837791;3196.6004249468815;3295.4562497187935;487048.95328663324;487449;487694;487712;488570;52925.2061219082;53198.73400632972;53209.733951329996;53221;53272;61288;61304.77390452166;61392.77214455686;61484.69257653683;61488;15350.155741434104;15524.534263972098;15534.300956456986;15554.066755994676;15590.844091559165;12012.579559715368;12076.21504602198;12094.455749491293;12107.33409662477;12109.576164834189;14508;15956.441524546584;15977.760333595006;16001;16010.519684409486;7170.677319520634;7277.345038946521;7282.890756638654;7295.854082918312;7301.306375894282;866.7876370289193;940.1726480696943;957.8706874571983;961.9951900240454;1018.23123541727;25343.85952632136;28707.56938645922;29468.11595652134;29621.555676664866;30204.94282700095;987.7481242283316;1024.5031159887449;1046.3355769086684;1089.6839916424308;1104.309806371018;14780.778288325684;15390.461333853262;15421.460248891235;15748;15844.841551584566;627091;631782;631989;633176;633872;57854.71072644694;57880.421195788345;57895;57904;57975;1237.3751255615857;1287.4077924154994;1358.3140514040545;1383.9930800345933;1408.4718230663502;25084.49831003406;28714.425711485237;29776.533519972178;30293.394132116795;30385.544216836322;44530.3320450187;44815.32777008413;44912.87717807081;44929.55070449254;44934;527118;529901;530738;530825;531163;25545.74454255508;25987.35031624149;25995.48009039771;38849.6115038846;39255.41116883192;46534.836629084544;46554.06891862211;46752;46765;47693.761531192125;38610.709984959896;38704.6129538701;38991.6100838988;39956.40065399079;40079.1984160321;32655.836720816245;38187.61812381841;38987.41518877162;39947.40078898761;39952.4007139899;37122.44316335311;37246.81376593208;38037.42943855789;38044.80977595094;38070.2385952285;30480;30602.92889748937;34453.82773086119;34693.82653086718;34819.82590087033;24930.750692492842;25203.99184032618;25263.494730105664;25535.461205261734;25925.092621758147 14:31:01 INFO - PROCESS | 1769 | |2;jquery.html;353.0802260112409;366.0811363477671;375.6168707917924;382.6517868739446;403.5701977394075;15000.174990375539;15346.309416076276;15893.761593576106;20188.394348169542;20638.38084857453;20370.796292037114;20787.376378708625;21328.786712132875;21415.892920535374;21706;4713.929291060628;4870.805167793284;4888.144574699413;4890.510948905099;4895.6083513318845;4541.250693635546;6191.876162476748;6766.289539598345;6836.179658440994;6848.3494068063455;5739.454751798572;6054.424829641177;6758.256591774901;6775.62734049627;6780.254172041096;6066.363031881633;6083.30042045166;6127.325994140641;6143.2320959880235;6164.599301045462;5901.822945311605;5901.911471327933;6013.939860601426;6076.210092687922;6081;13237.669058273621;13379.063465557414;13428.86571134286;13523.45906163762;13540.119892206974;1718.9398371056952;2313.618252988255;2450.8529488230765;2937.8237305761722;2977.880884764607;9336.439813611138;9824.870139933928;10335.069843714102;10367.22245831558;10372.585096596127;1384.4462215114036;1797.9550511237194;1798.856091512676;1825.4614888607894;1838.154448953483;111038.32718083425;113252.99999999917;123027.15459268118;123459.22069096501;129009.70990290071;9356.578953947088;9541.47521886289;11183.384913829655;11587.452424679643;11594.956453919187;14657.413703451743;14657.560273191608;14669.926650366893;14675;14675.19286439256;7926.207379262143;8044;8085.676572937135;8175.7138500152205;8183.468074575134;7783.182765809622;7799.06411230656;7799.766007019798;7933.484323518953;7962.800929976797;4432.246518091868;4522.570355816258;4538.2738761797955;4598.195315819718;4610.4697959734385;1586.8651164651135;1919.3378284491828;1922.1350392323511;1930.5945751392085;1930.8744931579402;848.8429640516524;904.841652710773;946.1437399153776;963.3882484622176;983.7638966648096;20439.8978005112;21905.890470547547;21925.671114933288;21989.890050549646;22003.889980550313;914.3371055984358;926.8609708543772;936.7634722166674;941.7975135345933;1022.7698767777339;10453.738656533647;11514.827277590843;11524.711882203012;11540.24988375753;11549.36478493674;552941;556299;558732;560146;563376.3662363406;94078.83102982947;102751.45872811913;114696.85303146862;123141.38429307975;125519.28931726345;940;959.932804703664;986.9309148359546;994.0258546624493;996.940183588987;19098.52253693669;19104.426867194008;19819.009049547753;19820.306289280383;19848.50378740543;41456.37815432831;50917;51132.79609670295;52098.21852672137;55874;51652.22521662253;63678;74538.25461745313;78808.60595696984;80156.3968720634;7577;7748.334108166771;8015;8047.959760201162;8284.25441710225;8985.326100542356;12260.75478490443;12326;12444.764361265956;12904;5295.788168473372;5335.279737235423;10844.993676169934;10853.387789814946;11143.832842507207;10732.141428685842;10774.461276935965;10853.45732713377;11197;11412.885871141183;9907.851382229417;10361.171106311327;11132.499037543492;11164.385958772345;11635.47640356169;7815.765527034198;7955.681772729026;8005.679772809022;8053.35573154158;8075.798105047185;8210;8993.595288212176;9104.90741111071;10799;10931.852155523555 14:31:01 INFO - PROCESS | 1769 | |3;mootools.html;1525.2145145250195;1553.7747026681132;1747.5805806606418;1838.4025191812664;1898.0889173196856;8311.376646751494;8744.693935712252;8750.562471876405;8776.42953208041;8785.297176225911;7126.1804892437385;7746.264104910038;8050.4364694471415;8074.354051675867;8685.305175585954;2075.63676356637;2307.6615562973434;2323.6398358254455;2362.574736547421;2373.0507796881298;2324.0471406723245;2337.4273303040695;2357.5284943011466;2361.126383238204;2364.278894937052;2325;2334.2297041976194;2344.5193735284224;2346.1905642553293;2361;2299.1608063057033;2320.9535809283802;2325.069972011192;2328.6623439601162;2332.591796435634;2322.256877799105;2322.907083716649;2326.732425771041;2327.1389585853344;2329.4409341757855;8639.870401943976;8721.520316382597;8766.649334026632;8770.693025744133;8805.64777408903;4269.466316710411;5313.601479889024;5322.121849894763;5322.654027488201;5323.680579165224;3448.2930999145115;3518.894433167009;3668.7982160981137;3672.8530858765616;3678.6873115785193;1059.2161800267822;1062.9309094908806;1067.1729409707539;1086;1101.5593762494987;11239.550417983271;11371.374574398405;11388.71528211793;11391.145664075144;11405.714857128554;4086.4687590613626;4494.70784399013;4622.791974361162;4702.012577358724;4736.905261894743;9756.219502439788;9771.120599145968;9771.218302535923;9783.266255030901;9790.608375664893;5293.232481290192;5296.073187192226;5309.203619457112;5310.867228319323;5323.494268044529;4086.877393678135;4356.390105385249;4434.778261086933;4869.829555965595;4874.610031197567;3249.3988612106837;3783.5459744830796;3905.297046531595;3943.861964831217;3951.3480275754755;1262.6590820478602;1269.5683467621054;1273.1279073834453;1280.8398950131234;1282.179405180685;851.3231980575457;864.6109250837148;880.3133555826465;911.6125646600168;914.0813482450228;5835.649861008353;5836.182934389189;5984.431479009487;6132.264128304543;6313.305536390993;823.3289868756943;909.2862103248918;953.113604347963;956.7703751099685;960.9039096090474;3779.3952967525065;3955.1891862168186;4029.6977726670616;4059.736117152435;4104.979475102606;10176.694699159038;10601.151907847508;10668.253222274521;10689.144868410509;10693.893061069446;10640.78718425627;10645.988631080036;10646.840297395545;10649.574017039231;10676.199285053652;7921.960390198012;8119.715809946623;8127.349812015024;8148.714794982147;8183.099859015503;5652.576056795675;5885.499732522783;6044.516438684983;6143.508519318533;6146.139540464428;9766.535019747094;9900.653477128266;9907.603695852085;9915.801683966136;9935.900640993497;7821.608919553886;10257.435841028815;10266.691999240034;10268.973102689672;10307.742306442398;6938.618375989167;7164.89252661221;7165.964170179116;7488.438367122379;7633.351165151024;7859.84280314402;7895.328897043815;7947.960260198662;8236.693725756797;8396.034456037634;7329.303716146957;7433.851322973618;7471.3649339806725;7524.134724506533;7565.470417070752;7310.801247869569;7334.449916256195;7339.9633001834645;7519.548827070394;7562.395008399205;5961.850953726018;6847.315268473113;6996.615186164606;6999.370056694718;7004.824879378057;4948.678335908155;5003.799848006039;5031.496850314939;5054.418741844588;5113.948860511347;4896.951030489649;4986.12742770021;5055.317532133115;5116.846494605168;5191.870203244949 14:31:01 INFO - PROCESS | 1769 | |4;prototype.html;271.2892222377371;281.676072516606;296.2962962962963;303.1965291976262;305.97552195824335;4141.473701042361;5263.420923747365;5267.682219823279;5357.812476563321;5405.648632838867;4651.604613607839;4863.100326439602;5102.285680004793;5188.610854185932;5221.373435187773;3131.577237073;3433.9484907726405;3770.7360484766077;4031.4154447605224;4139.172165566883;3672.6510981456718;3791.184895247521;3919.5492518360325;4053.29067413203;4069.308217603;3709.610490898457;3727.9440808387894;4043.373277142033;4096.87709368718;4099.631033207011;3603.8738644147593;3751.3060083884434;4017.7790221537803;4037.1118353962083;4087.9386809197886;3552.626974167701;3557.964420355789;3567.9108022299392;3569;3583.964160358415;3708.5364329458816;5065.366829146356;5135.870108576108;5213.921791173136;5268.972550352682;3835.3096442640312;4556.384888040106;4569.903223226435;4630.583247507707;4684.6576711644175;5289.444608316148;5316.601254905859;5509.862253443656;5565.5493593972;5578.944210557883;3473.9131521711906;3583.301256255031;3765.9811700941596;3895.8636447724475;3936.665383442411;5116.897662046776;5819.301683797971;5845.2401187845735;5851.502622277111;5873.2658417697785;3524.6827785499427;3962.821673024721;3989.3617021276455;3993.201359728066;4014.397840323916;3758.981205093957;3990.8204130814183;3996.6819244837925;4055.97972010144;4057.655099316532;3894.7857867817543;4540.773991022405;4550.930531325136;4601.3558101865765;4603.976980115145;5537.889242215214;5545.195946587723;5564.972175139098;5614.466625670555;5635.295588051494;1284.653143651209;1316.6510874618043;1317.4598414649947;1347.8786909178025;1348.730253949214;810.3314765318636;907.2379201470796;928.1390811423188;937.6999360204805;937.7749340158313;4522.299043648174;5121.8463446096675;5221.216817477409;5237.502437268454;5239;4995.100881841304;5474.178873168977;5650;5683.602147849693;5711;4429.822807087745;4442.777861106932;4448.55514448559;5311.628186027018;5354.303940487712;3004.7896647234484;3024.470717624407;3034.892264323506;3038.8908048562116;3067.3098552825436;5494.120940649477;5920.644761314335;5945.989181839098;6000.729967151488;6014.458698717136;4974.552290293818;5414.130510829267;5890.760081954908;5930.309861689398;5947.702614869239;4971.950280497221;5501.532369748536;5556.16657501378;5995.880082398415;6044.486218671374;5419.336793051192;5575.968445837533;5626.915596265977;5641.943580564306;5694.430556944272;4519.5480451954545;5648.926703926241;5686.687232202103;5724.282715185344;5749.252597162342;4538.841140560065;4970.353853998957;5571.582131340247;5829.76680932758;5991.850203744767;3433.896983090511;3645.828129527328;3808.27642747877;3821.2739579479808;3830.712696547714;4896.853094407174;5055;5584.553235741212;5706.28671416073;5778.479936805707;5257.658252213594;5521.641093328921;5559.58303127259;5574.749136288958;5660.7169641518585;5480.972595136999;5510.476504732044;5516.420775818642;5531.308586426697;5599.692016939108;5144.408393034849;5306.920396193983;5323.893522129459;5330.413654498079;5489.8471321023035;4821.349117869183;5096.592272618256;5588.692621905834;5622.606417550732;5629.605927585029;5082.822101226439;5394.919076213939;5395.298611180521;5465.890682186255;5467.578429608251 14:31:01 INFO - PROCESS | 1769 | |5;yui.html;721.5454263813797;769.8652735771238;788.9329407000408;814.8370325934815;858.6393714639851;14617.561473155809;15338.309776060076;15352.692946141098;15401.152936588498;15418.614534636627;14018.929905350458;14127.858721412782;14130.64673383166;14149.504767333145;14168.220747858864;688.5558814564603;714.8177214810216;852.7697521669146;863.8617821148633;891.2914233184601;895.7491902267343;899.2266650680409;901.2789768185459;901.5897766516252;901.8196360727848;952.0955092661965;953.7091187187905;955.69895482923;956.3879117364892;956.5934477846922;727.3744579661487;754.2608243920934;904.1094521895927;925.9259259259243;949.3164921256719;690.6063543780048;690.623610132479;692.0380670867498;694.135800927843;696.474162007686;13083.738325233442;13084.018698597643;13084.803727944089;13099.148555343872;13103.672408189872;13801.723965520634;14020.298985050707;14094.718105637932;14140.575782726431;14261.215633140173;12783.680407989781;12909.32084355954;13092.672683182902;13132.34338283082;13550.932245338809;4462.821487140511;4480.14877173336;4562.885927851797;4618.607418369443;4692.788824502905;78682.60658696727;107769;108986.91013089847;112636;115742;10919.13894790019;11009.449527523591;11064.778704425866;11115.608525098101;11526.59656912004;22216.666749998763;22283;22304.665430018562;22310.442238943833;22347.329580112622;7755.7673269802;7763.1848655891445;7842.882356764653;7854.528728276322;8035.919640803634;4133.855315064018;4169.082801783603;4259.595338442843;4341.479022517318;4461.464624245112;3446;3545.8758943436856;3545.8936231913085;3548.503209550665;3555.484454754046;543.5461389739532;650.4016304999412;660.9372109649576;660.96364699941;661.9834504137435;550.8595308196465;579.8666306749471;596.1385350318541;669.3607604737464;681.9522633415613;8930.955345223232;9557.23542116629;9576.856347154799;9620.71137865865;9763;596.2963702830701;646.4311405962817;676.5061505101205;677.6239187251024;678.4940210194238;3919.1377896862646;4165.937685890079;4667.229907065364;5195.428502864682;5210.869728256748;128007;132074;152423;158367;158663.40717188854;109410.90589094166;122827;124081;124673;128069;73577.26422735812;91238.54380728054;106261.40607890888;108242;109236;8555.562762247368;9460.763480912758;9918.543363679832;9963.651272205438;10002.649907253211;53830;57333.71333143308;60659.69670151621;61755.07367389583;64772.35227647663;74742.62628686822;89529.55235223782;91529.54235228781;93776.53111734397;94071.05928940623;12999.415026324028;13201.20792752438;13320;13374.398152082986;13522.25627590492;14895.106293622417;15027.624309392353;15104.244787760788;15523.922380388025;15597.376104956129;13812.585622431343;13831.30843457803;14079.296035198404;14106.224157671017;14392.352344144329;13546.390412431661;13834.723305534035;13893.652658683613;14146.292685365896;14233.288335583387;13419;13469.259190744211;13540.86459135396;13777;13945.790813137608;10834.837477438003;10873.728156796144;11356.659300221007;11576.710582235512;11622.82565761531;9399.906000940176;9707.951460242653;11445.713857153638;11510.63450217039;11590.884091159318 14:31:01 INFO - PROCESS | 1769 | __end_tp_report 14:31:01 INFO - PROCESS | 1769 | __start_cc_report 14:31:01 INFO - PROCESS | 1769 | _x_x_mozilla_cycle_collect,1477 14:31:01 INFO - PROCESS | 1769 | __end_cc_report 14:31:01 INFO - PROCESS | 1769 | __startTimestamp1477085461046__endTimestamp 14:31:01 INFO - PROCESS | 1769 | 14:31:01 INFO - PROCESS | 1769 | ------- Summary: start ------- 14:31:01 INFO - PROCESS | 1769 | Number of tests: 6 14:31:01 INFO - PROCESS | 1769 | 14:31:01 INFO - PROCESS | 1769 | [#0] dojo.html Cycles:165 Average:5675.57 Median:5845.04 stddev:662.52 (11.3%) stddev-sans-first:628.61 14:31:01 INFO - PROCESS | 1769 | Values: 2931.6 3299.5 3306.5 3324.6 3373.2 5506.2 5602.3 5606.6 5655.4 5656.2 5610.5 5629.2 5683.9 5688.6 5729.1 4261.5 5185.9 5228.5 5235.2 5241.6 5154.9 5234.5 5236.5 5238.5 5245.9 5103.9 5228.2 5237.1 5246.7 5294.3 5115.6 5203.9 5205.9 5214.9 5260.0 5085.8 5114.4 5161.6 5166.9 5187.2 5547.8 5596.1 5596.8 5599.5 5629.4 6201.8 6210.9 6215.2 6228.5 6234.4 4496.6 6007.8 6100.8 6139.8 6262.7 5749.1 5756.8 5763.5 5765.6 5777.8 6326.4 6342.4 6351.4 6359.3 6370.1 5929.9 5989.7 6004.2 6085.3 6098.3 6105.6 6190.8 6191.8 6248.1 6260.6 6116.2 6153.1 6158.5 6159.8 6176.0 6132.4 6185.9 6190.8 6191.2 6214.3 4826.5 4841.0 4875.0 4877.8 4918.6 4408.3 4461.8 4463.4 4489.4 4490.3 5637.4 5643.7 5644.4 5645.0 5663.6 6103.4 6120.6 6245.7 6251.5 6275.1 5577.0 5610.3 5642.6 5649.5 5655.3 5402.5 5403.1 5403.8 5403.9 5424.0 6277.2 6277.7 6282.2 6294.5 6296.7 6063.5 6143.8 6146.8 6202.4 6271.6 6219.3 6282.0 6312.6 6333.2 6336.0 6107.1 6163.3 6185.1 6189.8 6191.4 6275.2 6281.0 6288.2 6288.5 6297.5 5845.0 6086.1 6097.8 6112.8 6135.4 4443.0 5886.5 5895.5 5948.8 5966.9 5418.1 5437.9 5880.2 5930.7 5951.4 6052.3 6075.0 6079.4 6083.3 6087.5 5471.2 5758.4 5821.9 5915.9 5920.7 14:31:01 INFO - PROCESS | 1769 | 14:31:01 INFO - PROCESS | 1769 | [#1] ext.html Cycles:180 Average:68003.29 Median:40070.40 stddev:147717.07 (368.6%) stddev-sans-first:148044.42 14:31:01 INFO - PROCESS | 1769 | Values: 467.7 469.9 521.7 522.9 531.7 29761.6 39364.8 40061.6 40345.4 42196.8 41388.8 41976.0 42012.0 42043.0 42136.0 9403.4 9586.6 9591.8 9605.9 9608.2 9380.0 9476.5 9479.8 9487.7 9504.3 9442.9 9496.0 9507.6 9517.0 9525.6 9403.6 9484.1 9495.2 9500.8 9503.7 8066.4 9387.2 9470.1 9470.2 9483.7 39337.6 39671.6 39676.8 39748.0 39774.2 2960.5 3392.8 3408.6 3645.9 4047.7 24351.1 29874.1 30441.9 30471.0 31259.7 2891.9 3133.9 3157.3 3196.6 3295.5 487049.0 487449.0 487694.0 487712.0 488570.0 52925.2 53198.7 53209.7 53221.0 53272.0 61288.0 61304.8 61392.8 61484.7 61488.0 15350.2 15524.5 15534.3 15554.1 15590.8 12012.6 12076.2 12094.5 12107.3 12109.6 14508.0 15956.4 15977.8 16001.0 16010.5 7170.7 7277.3 7282.9 7295.9 7301.3 866.8 940.2 957.9 962.0 1018.2 25343.9 28707.6 29468.1 29621.6 30204.9 987.7 1024.5 1046.3 1089.7 1104.3 14780.8 15390.5 15421.5 15748.0 15844.8 627091.0 631782.0 631989.0 633176.0 633872.0 57854.7 57880.4 57895.0 57904.0 57975.0 1237.4 1287.4 1358.3 1384.0 1408.5 25084.5 28714.4 29776.5 30293.4 30385.5 44530.3 44815.3 44912.9 44929.6 44934.0 527118.0 529901.0 530738.0 530825.0 531163.0 25545.7 25987.4 25995.5 38849.6 39255.4 46534.8 46554.1 46752.0 46765.0 47693.8 38610.7 38704.6 38991.6 39956.4 40079.2 32655.8 38187.6 38987.4 39947.4 39952.4 37122.4 37246.8 38037.4 38044.8 38070.2 30480.0 30602.9 34453.8 34693.8 34819.8 24930.8 25204.0 25263.5 25535.5 25925.1 14:31:01 INFO - PROCESS | 1769 | 14:31:01 INFO - PROCESS | 1769 | [#2] jquery.html Cycles:180 Average:32706.18 Median:4477.41 stddev:93240.66 (2082.5%) stddev-sans-first:93470.58 14:31:01 INFO - PROCESS | 1769 | Values: 353.1 366.1 375.6 382.7 403.6 15000.2 15346.3 15893.8 20188.4 20638.4 20370.8 20787.4 21328.8 21415.9 21706.0 4713.9 4870.8 4888.1 4890.5 4895.6 4541.3 6191.9 6766.3 6836.2 6848.3 5739.5 6054.4 6758.3 6775.6 6780.3 6066.4 6083.3 6127.3 6143.2 6164.6 5901.8 5901.9 6013.9 6076.2 6081.0 13237.7 13379.1 13428.9 13523.5 13540.1 1718.9 2313.6 2450.9 2937.8 2977.9 9336.4 9824.9 10335.1 10367.2 10372.6 1384.4 1798.0 1798.9 1825.5 1838.2 111038.3 113253.0 123027.2 123459.2 129009.7 9356.6 9541.5 11183.4 11587.5 11595.0 14657.4 14657.6 14669.9 14675.0 14675.2 7926.2 8044.0 8085.7 8175.7 8183.5 7783.2 7799.1 7799.8 7933.5 7962.8 4432.2 4522.6 4538.3 4598.2 4610.5 1586.9 1919.3 1922.1 1930.6 1930.9 848.8 904.8 946.1 963.4 983.8 20439.9 21905.9 21925.7 21989.9 22003.9 914.3 926.9 936.8 941.8 1022.8 10453.7 11514.8 11524.7 11540.2 11549.4 552941.0 556299.0 558732.0 560146.0 563376.4 94078.8 102751.5 114696.9 123141.4 125519.3 940.0 959.9 986.9 994.0 996.9 19098.5 19104.4 19819.0 19820.3 19848.5 41456.4 50917.0 51132.8 52098.2 55874.0 51652.2 63678.0 74538.3 78808.6 80156.4 7577.0 7748.3 8015.0 8048.0 8284.3 8985.3 12260.8 12326.0 12444.8 12904.0 5295.8 5335.3 10845.0 10853.4 11143.8 10732.1 10774.5 10853.5 11197.0 11412.9 9907.9 10361.2 11132.5 11164.4 11635.5 7815.8 7955.7 8005.7 8053.4 8075.8 8210.0 8993.6 9104.9 10799.0 10931.9 14:31:01 INFO - PROCESS | 1769 | 14:31:01 INFO - PROCESS | 1769 | [#3] mootools.html Cycles:180 Average:5634.61 Median:5054.87 stddev:3137.43 (62.1%) stddev-sans-first:3131.03 14:31:01 INFO - PROCESS | 1769 | Values: 1525.2 1553.8 1747.6 1838.4 1898.1 8311.4 8744.7 8750.6 8776.4 8785.3 7126.2 7746.3 8050.4 8074.4 8685.3 2075.6 2307.7 2323.6 2362.6 2373.1 2324.0 2337.4 2357.5 2361.1 2364.3 2325.0 2334.2 2344.5 2346.2 2361.0 2299.2 2321.0 2325.1 2328.7 2332.6 2322.3 2322.9 2326.7 2327.1 2329.4 8639.9 8721.5 8766.6 8770.7 8805.6 4269.5 5313.6 5322.1 5322.7 5323.7 3448.3 3518.9 3668.8 3672.9 3678.7 1059.2 1062.9 1067.2 1086.0 1101.6 11239.6 11371.4 11388.7 11391.1 11405.7 4086.5 4494.7 4622.8 4702.0 4736.9 9756.2 9771.1 9771.2 9783.3 9790.6 5293.2 5296.1 5309.2 5310.9 5323.5 4086.9 4356.4 4434.8 4869.8 4874.6 3249.4 3783.5 3905.3 3943.9 3951.3 1262.7 1269.6 1273.1 1280.8 1282.2 851.3 864.6 880.3 911.6 914.1 5835.6 5836.2 5984.4 6132.3 6313.3 823.3 909.3 953.1 956.8 960.9 3779.4 3955.2 4029.7 4059.7 4105.0 10176.7 10601.2 10668.3 10689.1 10693.9 10640.8 10646.0 10646.8 10649.6 10676.2 7922.0 8119.7 8127.3 8148.7 8183.1 5652.6 5885.5 6044.5 6143.5 6146.1 9766.5 9900.7 9907.6 9915.8 9935.9 7821.6 10257.4 10266.7 10269.0 10307.7 6938.6 7164.9 7166.0 7488.4 7633.4 7859.8 7895.3 7948.0 8236.7 8396.0 7329.3 7433.9 7471.4 7524.1 7565.5 7310.8 7334.4 7340.0 7519.5 7562.4 5961.9 6847.3 6996.6 6999.4 7004.8 4948.7 5003.8 5031.5 5054.4 5113.9 4897.0 4986.1 5055.3 5116.8 5191.9 14:31:01 INFO - PROCESS | 1769 | 14:31:01 INFO - PROCESS | 1769 | [#4] prototype.html Cycles:180 Average:4496.36 Median:5109.59 stddev:1378.77 (27.0%) stddev-sans-first:1345.67 14:31:01 INFO - PROCESS | 1769 | Values: 271.3 281.7 296.3 303.2 306.0 4141.5 5263.4 5267.7 5357.8 5405.6 4651.6 4863.1 5102.3 5188.6 5221.4 3131.6 3433.9 3770.7 4031.4 4139.2 3672.7 3791.2 3919.5 4053.3 4069.3 3709.6 3727.9 4043.4 4096.9 4099.6 3603.9 3751.3 4017.8 4037.1 4087.9 3552.6 3558.0 3567.9 3569.0 3584.0 3708.5 5065.4 5135.9 5213.9 5269.0 3835.3 4556.4 4569.9 4630.6 4684.7 5289.4 5316.6 5509.9 5565.5 5578.9 3473.9 3583.3 3766.0 3895.9 3936.7 5116.9 5819.3 5845.2 5851.5 5873.3 3524.7 3962.8 3989.4 3993.2 4014.4 3759.0 3990.8 3996.7 4056.0 4057.7 3894.8 4540.8 4550.9 4601.4 4604.0 5537.9 5545.2 5565.0 5614.5 5635.3 1284.7 1316.7 1317.5 1347.9 1348.7 810.3 907.2 928.1 937.7 937.8 4522.3 5121.8 5221.2 5237.5 5239.0 4995.1 5474.2 5650.0 5683.6 5711.0 4429.8 4442.8 4448.6 5311.6 5354.3 3004.8 3024.5 3034.9 3038.9 3067.3 5494.1 5920.6 5946.0 6000.7 6014.5 4974.6 5414.1 5890.8 5930.3 5947.7 4972.0 5501.5 5556.2 5995.9 6044.5 5419.3 5576.0 5626.9 5641.9 5694.4 4519.5 5648.9 5686.7 5724.3 5749.3 4538.8 4970.4 5571.6 5829.8 5991.9 3433.9 3645.8 3808.3 3821.3 3830.7 4896.9 5055.0 5584.6 5706.3 5778.5 5257.7 5521.6 5559.6 5574.7 5660.7 5481.0 5510.5 5516.4 5531.3 5599.7 5144.4 5306.9 5323.9 5330.4 5489.8 4821.3 5096.6 5588.7 5622.6 5629.6 5082.8 5394.9 5395.3 5465.9 5467.6 14:31:01 INFO - PROCESS | 1769 | 14:31:01 INFO - PROCESS | 1769 | [#5] yui.html Cycles:180 Average:24014.59 Median:3737.31 stddev:37785.75 (1011.0%) stddev-sans-first:37851.28 14:31:01 INFO - PROCESS | 1769 | Values: 721.5 769.9 788.9 814.8 858.6 14617.6 15338.3 15352.7 15401.2 15418.6 14018.9 14127.9 14130.6 14149.5 14168.2 688.6 714.8 852.8 863.9 891.3 895.7 899.2 901.3 901.6 901.8 952.1 953.7 955.7 956.4 956.6 727.4 754.3 904.1 925.9 949.3 690.6 690.6 692.0 694.1 696.5 13083.7 13084.0 13084.8 13099.1 13103.7 13801.7 14020.3 14094.7 14140.6 14261.2 12783.7 12909.3 13092.7 13132.3 13550.9 4462.8 4480.1 4562.9 4618.6 4692.8 78682.6 107769.0 108986.9 112636.0 115742.0 10919.1 11009.4 11064.8 11115.6 11526.6 22216.7 22283.0 22304.7 22310.4 22347.3 7755.8 7763.2 7842.9 7854.5 8035.9 4133.9 4169.1 4259.6 4341.5 4461.5 3446.0 3545.9 3545.9 3548.5 3555.5 543.5 650.4 660.9 661.0 662.0 550.9 579.9 596.1 669.4 682.0 8931.0 9557.2 9576.9 9620.7 9763.0 596.3 646.4 676.5 677.6 678.5 3919.1 4165.9 4667.2 5195.4 5210.9 128007.0 132074.0 152423.0 158367.0 158663.4 109410.9 122827.0 124081.0 124673.0 128069.0 73577.3 91238.5 106261.4 108242.0 109236.0 8555.6 9460.8 9918.5 9963.7 10002.6 53830.0 57333.7 60659.7 61755.1 64772.4 74742.6 89529.6 91529.5 93776.5 94071.1 12999.4 13201.2 13320.0 13374.4 13522.3 14895.1 15027.6 15104.2 15523.9 15597.4 13812.6 13831.3 14079.3 14106.2 14392.4 13546.4 13834.7 13893.7 14146.3 14233.3 13419.0 13469.3 13540.9 13777.0 13945.8 10834.8 10873.7 11356.7 11576.7 11622.8 9399.9 9708.0 11445.7 11510.6 11590.9 14:31:01 INFO - PROCESS | 1769 | -------- Summary: end -------- 14:31:01 INFO - PROCESS | 1769 | 14:31:01 INFO - TEST-INFO | 1769: exit 0 14:31:01 INFO - TEST-OK | dromaeo_css | took 1118598ms 14:31:01 INFO - TEST-START | kraken 14:31:01 INFO - operating with platform_type : mac_ 14:31:01 INFO - Initialising browser for kraken test... 14:31:01 INFO - TEST-INFO | started process 1775 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpZ3Zzib/profile http://localhost:49279/getInfo.html) 14:31:03 INFO - PROCESS | 1775 | __metrics Screen width/height:1600/1200 14:31:03 INFO - PROCESS | 1775 | colorDepth:24 14:31:03 INFO - PROCESS | 1775 | Browser inner width/height: 1024/689 14:31:03 INFO - PROCESS | 1775 | __metrics 14:31:03 INFO - PROCESS | 1775 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:31:03 INFO - PROCESS | 1775 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:04 INFO - TEST-INFO | 1775: exit 0 14:31:04 INFO - Browser initialized. 14:31:04 INFO - Running cycle 1/1 for kraken test... 14:31:04 INFO - TEST-INFO | started process 1776 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpZ3Zzib/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:16 INFO - PROCESS | 1776 | RSS: Main: 239472640 14:31:16 INFO - PROCESS | 1776 | 14:31:19 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:20 INFO - PROCESS | 1776 | RSS: Main: 290508800 14:31:20 INFO - PROCESS | 1776 | 14:31:23 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 14:31:23 INFO - PROCESS | 1776 | RSS: Main: 289652736 14:31:23 INFO - PROCESS | 1776 | 14:31:27 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 14:31:27 INFO - PROCESS | 1776 | RSS: Main: 387481600 14:31:27 INFO - PROCESS | 1776 | 14:31:29 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 14:31:30 INFO - PROCESS | 1776 | RSS: Main: 285511680 14:31:30 INFO - PROCESS | 1776 | 14:31:32 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:33 INFO - PROCESS | 1776 | RSS: Main: 289591296 14:31:33 INFO - PROCESS | 1776 | 14:31:35 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 14:31:36 INFO - PROCESS | 1776 | RSS: Main: 327622656 14:31:36 INFO - PROCESS | 1776 | 14:31:39 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:39 INFO - PROCESS | 1776 | RSS: Main: 329478144 14:31:39 INFO - PROCESS | 1776 | 14:31:42 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 14:31:43 INFO - PROCESS | 1776 | RSS: Main: 328515584 14:31:43 INFO - PROCESS | 1776 | 14:31:44 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:45 INFO - PROCESS | 1776 | RSS: Main: 303099904 14:31:45 INFO - PROCESS | 1776 | 14:31:47 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:47 INFO - PROCESS | 1776 | RSS: Main: 306511872 14:31:47 INFO - PROCESS | 1776 | 14:31:49 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:50 INFO - PROCESS | 1776 | RSS: Main: 309149696 14:31:50 INFO - PROCESS | 1776 | 14:31:53 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:54 INFO - PROCESS | 1776 | RSS: Main: 318894080 14:31:54 INFO - PROCESS | 1776 | 14:31:57 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:57 INFO - PROCESS | 1776 | RSS: Main: 318353408 14:31:57 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 14:31:59 INFO - PROCESS | 1776 | RSS: Main: 362303488 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | __start_tp_report 14:31:59 INFO - PROCESS | 1776 | _x_x_mozilla_page_load 14:31:59 INFO - PROCESS | 1776 | _x_x_mozilla_page_load_details 14:31:59 INFO - PROCESS | 1776 | |i|pagename|runs| 14:31:59 INFO - PROCESS | 1776 | |0;ai-astar;114;116;162;167;114;115;114;112;114;114 14:31:59 INFO - PROCESS | 1776 | |1;audio-beat-detection;149;117;143;134;131;142;142;115;144;112 14:31:59 INFO - PROCESS | 1776 | |2;audio-dft;185;183;184;190;213;182;184;182;181;183 14:31:59 INFO - PROCESS | 1776 | |3;audio-fft;77;59;58;89;62;60;58;59;81;58 14:31:59 INFO - PROCESS | 1776 | |4;audio-oscillator;87;69;94;87;97;74;91;67;68;89 14:31:59 INFO - PROCESS | 1776 | |5;imaging-gaussian-blur;88;83;88;86;88;83;90;86;87;129 14:31:59 INFO - PROCESS | 1776 | |6;imaging-darkroom;97;94;96;96;96;95;96;95;95;96 14:31:59 INFO - PROCESS | 1776 | |7;imaging-desaturate;84;84;80;81;82;83;88;99;83;82 14:31:59 INFO - PROCESS | 1776 | |8;json-parse-financial;54;52;53;52;52;55;54;54;53;53 14:31:59 INFO - PROCESS | 1776 | |9;json-stringify-tinderbox;71;73;68;68;77;71;69;71;70;72 14:31:59 INFO - PROCESS | 1776 | |10;stanford-crypto-aes;88;87;86;87;86;85;80;105;87;89 14:31:59 INFO - PROCESS | 1776 | |11;stanford-crypto-ccm;148;151;151;157;149;146;146;151;214;145 14:31:59 INFO - PROCESS | 1776 | |12;stanford-crypto-pbkdf2;172;171;172;172;173;172;171;171;171;175 14:31:59 INFO - PROCESS | 1776 | |13;stanford-crypto-sha256-iterative;69;67;68;68;69;69;69;68;69;69 14:31:59 INFO - PROCESS | 1776 | __end_tp_report 14:31:59 INFO - PROCESS | 1776 | __start_cc_report 14:31:59 INFO - PROCESS | 1776 | _x_x_mozilla_cycle_collect,1948 14:31:59 INFO - PROCESS | 1776 | __end_cc_report 14:31:59 INFO - PROCESS | 1776 | __startTimestamp1477085519901__endTimestamp 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | ------- Summary: start ------- 14:31:59 INFO - PROCESS | 1776 | Number of tests: 14 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#0] ai-astar Cycles:10 Average:124.20 Median:114.50 stddev:21.30 (18.6%) stddev-sans-first:22.27 14:31:59 INFO - PROCESS | 1776 | Values: 114.0 116.0 162.0 167.0 114.0 115.0 114.0 112.0 114.0 114.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:142.00 stddev:13.60 (9.6%) stddev-sans-first:13.12 14:31:59 INFO - PROCESS | 1776 | Values: 149.0 117.0 143.0 134.0 131.0 142.0 142.0 115.0 144.0 112.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#2] audio-dft Cycles:10 Average:186.70 Median:184.00 stddev:9.57 (5.2%) stddev-sans-first:10.13 14:31:59 INFO - PROCESS | 1776 | Values: 185.0 183.0 184.0 190.0 213.0 182.0 184.0 182.0 181.0 183.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.00 stddev:11.63 (19.1%) stddev-sans-first:11.65 14:31:59 INFO - PROCESS | 1776 | Values: 77.0 59.0 58.0 89.0 62.0 60.0 58.0 59.0 81.0 58.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#4] audio-oscillator Cycles:10 Average:82.30 Median:88.00 stddev:11.56 (13.1%) stddev-sans-first:12.13 14:31:59 INFO - PROCESS | 1776 | Values: 87.0 69.0 94.0 87.0 97.0 74.0 91.0 67.0 68.0 89.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:87.50 stddev:13.60 (15.5%) stddev-sans-first:14.39 14:31:59 INFO - PROCESS | 1776 | Values: 88.0 83.0 88.0 86.0 88.0 83.0 90.0 86.0 87.0 129.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.84 (0.9%) stddev-sans-first:0.73 14:31:59 INFO - PROCESS | 1776 | Values: 97.0 94.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:83.50 stddev:5.50 (6.6%) stddev-sans-first:5.83 14:31:59 INFO - PROCESS | 1776 | Values: 84.0 84.0 80.0 81.0 82.0 83.0 88.0 99.0 83.0 82.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.50 stddev:1.03 (1.9%) stddev-sans-first:1.05 14:31:59 INFO - PROCESS | 1776 | Values: 54.0 52.0 53.0 52.0 52.0 55.0 54.0 54.0 53.0 53.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.00 stddev:2.67 (3.8%) stddev-sans-first:2.83 14:31:59 INFO - PROCESS | 1776 | Values: 71.0 73.0 68.0 68.0 77.0 71.0 69.0 71.0 70.0 72.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.00 stddev:6.45 (7.4%) stddev-sans-first:6.84 14:31:59 INFO - PROCESS | 1776 | Values: 88.0 87.0 86.0 87.0 86.0 85.0 80.0 105.0 87.0 89.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#11] stanford-crypto-ccm Cycles:10 Average:155.80 Median:151.00 stddev:20.75 (13.7%) stddev-sans-first:21.81 14:31:59 INFO - PROCESS | 1776 | Values: 148.0 151.0 151.0 157.0 149.0 146.0 146.0 151.0 214.0 145.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:1.25 (0.7%) stddev-sans-first:1.32 14:31:59 INFO - PROCESS | 1776 | Values: 172.0 171.0 172.0 172.0 173.0 172.0 171.0 171.0 171.0 175.0 14:31:59 INFO - PROCESS | 1776 | 14:31:59 INFO - PROCESS | 1776 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:0.71 (1.0%) stddev-sans-first:0.73 14:31:59 INFO - PROCESS | 1776 | Values: 69.0 67.0 68.0 68.0 69.0 69.0 69.0 68.0 69.0 69.0 14:31:59 INFO - PROCESS | 1776 | -------- Summary: end -------- 14:31:59 INFO - PROCESS | 1776 | 14:32:00 INFO - TEST-INFO | 1776: exit 0 14:32:00 INFO - TEST-OK | kraken | took 59122ms 14:32:00 INFO - SUITE-END | took 1177s 14:32:01 INFO - Completed test suite (00:19:38) 14:32:01 INFO - javascript benchmark 14:32:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2931.648202215734, 3299.5215693724413, 3306.520554519593, 3324.634290228076, 3373.173572474744, 5506.174073888918, 5602.299712535933, 5606.635568688032, 5655.434456554348, 5656.151577263413, 5610.523105536025, 5629.183768353597, 5683.8579035524135, 5688.573356998231, 5729.111987641912, 4261.488621365433, 5185.948140518603, 5228.47715228478, 5235.188545775411, 5241.554467870235, 5154.92267615986, 5234.528892399683, 5236.528712415882, 5238.52853243208, 5245.8950820983555, 5103.9026609279, 5228.215767634847, 5237.109691352479, 5246.68519888806, 5294.285271488338, 5115.61632877532, 5203.895922081575, 5205.8958820823755, 5214.895702085975, 5259.974305010524, 5085.821996230115, 5114.43741188469, 5161.5870730341485, 5166.948330516684, 5187.221916712523, 5547.833564993057, 5596.104623260299, 5596.776128954837, 5599.496045355938, 5629.408912064216, 6201.751929922798, 6210.875782484325, 6215.223097112861, 6228.532860035515, 6234.438900498977, 4496.55034496551, 6007.759689612454, 6100.786472473442, 6139.8294713812775, 6262.655553944532, 5749.080147176432, 5756.827295181151, 5763.538916886681, 5765.596408251382, 5777.768889244468, 6326.398992095744, 6342.365763423713, 6351.428371446592, 6359.300476947532, 6370.076338930921, 5929.881402372014, 5989.670568118795, 6004.219451471281, 6085.330613632497, 6098.26820781509, 6105.611380716617, 6190.7523699052435, 6191.752329906843, 6248.094026366242, 6260.624362538262, 6116.174316467309, 6153.138560601519, 6158.538109641795, 6159.784407545714, 6175.96912015437, 6132.386761323832, 6185.876282474325, 6190.81427557174, 6191.226096737908, 6214.316425193225, 4826.469088400273, 4841.031793641286, 4874.976254986493, 4877.756112194376, 4918.631102667243, 4408.272635015251, 4461.754603496774, 4463.419755431838, 4489.393931819162, 4490.3040028795585, 5637.43625637433, 5643.717814109278, 5644.407337229614, 5645.01212287848, 5663.575231857627, 6103.35914728956, 6120.571559990847, 6245.656488893154, 6251.468625166912, 6275.121482992385, 5576.972115139399, 5610.270664813548, 5642.605017648807, 5649.491545760901, 5655.349634791969, 5402.459754024566, 5403.13549832025, 5403.783848646089, 5403.918941215885, 5424.023675738405, 6277.183966084471, 6277.686115694106, 6282.183316168869, 6294.4964402846745, 6296.748130074746, 6063.484603808549, 6143.788236234863, 6146.754129834757, 6202.4417802398, 6271.62370257786, 6219.346968568235, 6282.0, 6312.621242725451, 6333.1766870306565, 6336.0, 6107.097787096225, 6163.291221509405, 6185.134081228722, 6189.84525386869, 6191.380861913773, 6275.152854364785, 6281.0, 6288.182536270256, 6288.496920246461, 6297.52768542352, 5845.035569131046, 6086.087086936995, 6097.847553811012, 6112.786052488142, 6135.417135372132, 4443.022535042285, 5886.499647530008, 5895.469407753323, 5948.762049517971, 5966.910496342472, 5418.106012507892, 5437.918431223456, 5880.206172166702, 5930.703464826827, 5951.404859514014, 6052.334243233329, 6074.969625151846, 6079.361667024898, 6083.330833608211, 6087.512998960161, 5471.179323101566, 5758.395368486249, 5821.854453638523, 5915.911261330997, 5920.733566989582], "value": 5633.0278517153165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.6819762561458, 469.8989717210799, 521.7234865521273, 522.9006488767136, 531.6597377678287, 29761.55357669634, 39364.819055428314, 40061.59938400615, 40345.39481907774, 42196.78901605495, 41388.79305603475, 41976.0, 42012.0, 42043.0, 42136.0, 9403.38877972933, 9586.616535338579, 9591.808163836718, 9605.855912161323, 9608.2313414927, 9379.953100234488, 9476.478793666345, 9479.763005924839, 9487.71536853892, 9504.287178461609, 9442.858357124649, 9495.952520237424, 9507.619695212183, 9517.048295170496, 9525.5713492893, 9403.62385504579, 9484.14642682155, 9495.192908602778, 9500.762480937963, 9503.667371641994, 8066.354691624656, 9387.15515603599, 9470.14768670816, 9470.195033422098, 9483.715488535356, 39337.60662393368, 39671.60328396708, 39676.80161599174, 39748.0, 39774.20451590981, 2960.4967155583604, 3392.8303584820906, 3408.6109661871706, 3645.9453108203397, 4047.736897101679, 24351.14770983025, 29874.103776886728, 30441.895261845388, 30471.0, 31259.687403125907, 2891.872169853759, 3133.8903138390274, 3157.289609837791, 3196.6004249468815, 3295.4562497187935, 487048.95328663324, 487449.0, 487694.0, 487712.0, 488570.0, 52925.2061219082, 53198.73400632972, 53209.733951329996, 53221.0, 53272.0, 61288.0, 61304.77390452166, 61392.77214455686, 61484.69257653683, 61488.0, 15350.155741434104, 15524.534263972098, 15534.300956456986, 15554.066755994676, 15590.844091559165, 12012.579559715368, 12076.21504602198, 12094.455749491293, 12107.33409662477, 12109.576164834189, 14508.0, 15956.441524546584, 15977.760333595006, 16001.0, 16010.519684409486, 7170.677319520634, 7277.345038946521, 7282.890756638654, 7295.854082918312, 7301.306375894282, 866.7876370289193, 940.1726480696943, 957.8706874571983, 961.9951900240454, 1018.23123541727, 25343.85952632136, 28707.56938645922, 29468.11595652134, 29621.555676664866, 30204.94282700095, 987.7481242283316, 1024.5031159887449, 1046.3355769086684, 1089.6839916424308, 1104.309806371018, 14780.778288325684, 15390.461333853262, 15421.460248891235, 15748.0, 15844.841551584566, 627091.0, 631782.0, 631989.0, 633176.0, 633872.0, 57854.71072644694, 57880.421195788345, 57895.0, 57904.0, 57975.0, 1237.3751255615857, 1287.4077924154994, 1358.3140514040545, 1383.9930800345933, 1408.4718230663502, 25084.49831003406, 28714.425711485237, 29776.533519972178, 30293.394132116795, 30385.544216836322, 44530.3320450187, 44815.32777008413, 44912.87717807081, 44929.55070449254, 44934.0, 527118.0, 529901.0, 530738.0, 530825.0, 531163.0, 25545.74454255508, 25987.35031624149, 25995.48009039771, 38849.6115038846, 39255.41116883192, 46534.836629084544, 46554.06891862211, 46752.0, 46765.0, 47693.761531192125, 38610.709984959896, 38704.6129538701, 38991.6100838988, 39956.40065399079, 40079.1984160321, 32655.836720816245, 38187.61812381841, 38987.41518877162, 39947.40078898761, 39952.4007139899, 37122.44316335311, 37246.81376593208, 38037.42943855789, 38044.80977595094, 38070.2385952285, 30480.0, 30602.92889748937, 34453.82773086119, 34693.82653086718, 34819.82590087033, 24930.750692492842, 25203.99184032618, 25263.494730105664, 25535.461205261734, 25925.092621758147], "value": 19478.79199144032, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.0802260112409, 366.0811363477671, 375.6168707917924, 382.6517868739446, 403.5701977394075, 15000.174990375539, 15346.309416076276, 15893.761593576106, 20188.394348169542, 20638.38084857453, 20370.796292037114, 20787.376378708625, 21328.786712132875, 21415.892920535374, 21706.0, 4713.929291060628, 4870.805167793284, 4888.144574699413, 4890.510948905099, 4895.6083513318845, 4541.250693635546, 6191.876162476748, 6766.289539598345, 6836.179658440994, 6848.3494068063455, 5739.454751798572, 6054.424829641177, 6758.256591774901, 6775.62734049627, 6780.254172041096, 6066.363031881633, 6083.30042045166, 6127.325994140641, 6143.2320959880235, 6164.599301045462, 5901.822945311605, 5901.911471327933, 6013.939860601426, 6076.210092687922, 6081.0, 13237.669058273621, 13379.063465557414, 13428.86571134286, 13523.45906163762, 13540.119892206974, 1718.9398371056952, 2313.618252988255, 2450.8529488230765, 2937.8237305761722, 2977.880884764607, 9336.439813611138, 9824.870139933928, 10335.069843714102, 10367.22245831558, 10372.585096596127, 1384.4462215114036, 1797.9550511237194, 1798.856091512676, 1825.4614888607894, 1838.154448953483, 111038.32718083425, 113252.99999999917, 123027.15459268118, 123459.22069096501, 129009.70990290071, 9356.578953947088, 9541.47521886289, 11183.384913829655, 11587.452424679643, 11594.956453919187, 14657.413703451743, 14657.560273191608, 14669.926650366893, 14675.0, 14675.19286439256, 7926.207379262143, 8044.0, 8085.676572937135, 8175.7138500152205, 8183.468074575134, 7783.182765809622, 7799.06411230656, 7799.766007019798, 7933.484323518953, 7962.800929976797, 4432.246518091868, 4522.570355816258, 4538.2738761797955, 4598.195315819718, 4610.4697959734385, 1586.8651164651135, 1919.3378284491828, 1922.1350392323511, 1930.5945751392085, 1930.8744931579402, 848.8429640516524, 904.841652710773, 946.1437399153776, 963.3882484622176, 983.7638966648096, 20439.8978005112, 21905.890470547547, 21925.671114933288, 21989.890050549646, 22003.889980550313, 914.3371055984358, 926.8609708543772, 936.7634722166674, 941.7975135345933, 1022.7698767777339, 10453.738656533647, 11514.827277590843, 11524.711882203012, 11540.24988375753, 11549.36478493674, 552941.0, 556299.0, 558732.0, 560146.0, 563376.3662363406, 94078.83102982947, 102751.45872811913, 114696.85303146862, 123141.38429307975, 125519.28931726345, 940.0, 959.932804703664, 986.9309148359546, 994.0258546624493, 996.940183588987, 19098.52253693669, 19104.426867194008, 19819.009049547753, 19820.306289280383, 19848.50378740543, 41456.37815432831, 50917.0, 51132.79609670295, 52098.21852672137, 55874.0, 51652.22521662253, 63678.0, 74538.25461745313, 78808.60595696984, 80156.3968720634, 7577.0, 7748.334108166771, 8015.0, 8047.959760201162, 8284.25441710225, 8985.326100542356, 12260.75478490443, 12326.0, 12444.764361265956, 12904.0, 5295.788168473372, 5335.279737235423, 10844.993676169934, 10853.387789814946, 11143.832842507207, 10732.141428685842, 10774.461276935965, 10853.45732713377, 11197.0, 11412.885871141183, 9907.851382229417, 10361.171106311327, 11132.499037543492, 11164.385958772345, 11635.47640356169, 7815.765527034198, 7955.681772729026, 8005.679772809022, 8053.35573154158, 8075.798105047185, 8210.0, 8993.595288212176, 9104.90741111071, 10799.0, 10931.852155523555], "value": 9136.045626119621, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.2145145250195, 1553.7747026681132, 1747.5805806606418, 1838.4025191812664, 1898.0889173196856, 8311.376646751494, 8744.693935712252, 8750.562471876405, 8776.42953208041, 8785.297176225911, 7126.1804892437385, 7746.264104910038, 8050.4364694471415, 8074.354051675867, 8685.305175585954, 2075.63676356637, 2307.6615562973434, 2323.6398358254455, 2362.574736547421, 2373.0507796881298, 2324.0471406723245, 2337.4273303040695, 2357.5284943011466, 2361.126383238204, 2364.278894937052, 2325.0, 2334.2297041976194, 2344.5193735284224, 2346.1905642553293, 2361.0, 2299.1608063057033, 2320.9535809283802, 2325.069972011192, 2328.6623439601162, 2332.591796435634, 2322.256877799105, 2322.907083716649, 2326.732425771041, 2327.1389585853344, 2329.4409341757855, 8639.870401943976, 8721.520316382597, 8766.649334026632, 8770.693025744133, 8805.64777408903, 4269.466316710411, 5313.601479889024, 5322.121849894763, 5322.654027488201, 5323.680579165224, 3448.2930999145115, 3518.894433167009, 3668.7982160981137, 3672.8530858765616, 3678.6873115785193, 1059.2161800267822, 1062.9309094908806, 1067.1729409707539, 1086.0, 1101.5593762494987, 11239.550417983271, 11371.374574398405, 11388.71528211793, 11391.145664075144, 11405.714857128554, 4086.4687590613626, 4494.70784399013, 4622.791974361162, 4702.012577358724, 4736.905261894743, 9756.219502439788, 9771.120599145968, 9771.218302535923, 9783.266255030901, 9790.608375664893, 5293.232481290192, 5296.073187192226, 5309.203619457112, 5310.867228319323, 5323.494268044529, 4086.877393678135, 4356.390105385249, 4434.778261086933, 4869.829555965595, 4874.610031197567, 3249.3988612106837, 3783.5459744830796, 3905.297046531595, 3943.861964831217, 3951.3480275754755, 1262.6590820478602, 1269.5683467621054, 1273.1279073834453, 1280.8398950131234, 1282.179405180685, 851.3231980575457, 864.6109250837148, 880.3133555826465, 911.6125646600168, 914.0813482450228, 5835.649861008353, 5836.182934389189, 5984.431479009487, 6132.264128304543, 6313.305536390993, 823.3289868756943, 909.2862103248918, 953.113604347963, 956.7703751099685, 960.9039096090474, 3779.3952967525065, 3955.1891862168186, 4029.6977726670616, 4059.736117152435, 4104.979475102606, 10176.694699159038, 10601.151907847508, 10668.253222274521, 10689.144868410509, 10693.893061069446, 10640.78718425627, 10645.988631080036, 10646.840297395545, 10649.574017039231, 10676.199285053652, 7921.960390198012, 8119.715809946623, 8127.349812015024, 8148.714794982147, 8183.099859015503, 5652.576056795675, 5885.499732522783, 6044.516438684983, 6143.508519318533, 6146.139540464428, 9766.535019747094, 9900.653477128266, 9907.603695852085, 9915.801683966136, 9935.900640993497, 7821.608919553886, 10257.435841028815, 10266.691999240034, 10268.973102689672, 10307.742306442398, 6938.618375989167, 7164.89252661221, 7165.964170179116, 7488.438367122379, 7633.351165151024, 7859.84280314402, 7895.328897043815, 7947.960260198662, 8236.693725756797, 8396.034456037634, 7329.303716146957, 7433.851322973618, 7471.3649339806725, 7524.134724506533, 7565.470417070752, 7310.801247869569, 7334.449916256195, 7339.9633001834645, 7519.548827070394, 7562.395008399205, 5961.850953726018, 6847.315268473113, 6996.615186164606, 6999.370056694718, 7004.824879378057, 4948.678335908155, 5003.799848006039, 5031.496850314939, 5054.418741844588, 5113.948860511347, 4896.951030489649, 4986.12742770021, 5055.317532133115, 5116.846494605168, 5191.870203244949], "value": 4543.094808714309, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.2892222377371, 281.676072516606, 296.2962962962963, 303.1965291976262, 305.97552195824335, 4141.473701042361, 5263.420923747365, 5267.682219823279, 5357.812476563321, 5405.648632838867, 4651.604613607839, 4863.100326439602, 5102.285680004793, 5188.610854185932, 5221.373435187773, 3131.577237073, 3433.9484907726405, 3770.7360484766077, 4031.4154447605224, 4139.172165566883, 3672.6510981456718, 3791.184895247521, 3919.5492518360325, 4053.29067413203, 4069.308217603, 3709.610490898457, 3727.9440808387894, 4043.373277142033, 4096.87709368718, 4099.631033207011, 3603.8738644147593, 3751.3060083884434, 4017.7790221537803, 4037.1118353962083, 4087.9386809197886, 3552.626974167701, 3557.964420355789, 3567.9108022299392, 3569.0, 3583.964160358415, 3708.5364329458816, 5065.366829146356, 5135.870108576108, 5213.921791173136, 5268.972550352682, 3835.3096442640312, 4556.384888040106, 4569.903223226435, 4630.583247507707, 4684.6576711644175, 5289.444608316148, 5316.601254905859, 5509.862253443656, 5565.5493593972, 5578.944210557883, 3473.9131521711906, 3583.301256255031, 3765.9811700941596, 3895.8636447724475, 3936.665383442411, 5116.897662046776, 5819.301683797971, 5845.2401187845735, 5851.502622277111, 5873.2658417697785, 3524.6827785499427, 3962.821673024721, 3989.3617021276455, 3993.201359728066, 4014.397840323916, 3758.981205093957, 3990.8204130814183, 3996.6819244837925, 4055.97972010144, 4057.655099316532, 3894.7857867817543, 4540.773991022405, 4550.930531325136, 4601.3558101865765, 4603.976980115145, 5537.889242215214, 5545.195946587723, 5564.972175139098, 5614.466625670555, 5635.295588051494, 1284.653143651209, 1316.6510874618043, 1317.4598414649947, 1347.8786909178025, 1348.730253949214, 810.3314765318636, 907.2379201470796, 928.1390811423188, 937.6999360204805, 937.7749340158313, 4522.299043648174, 5121.8463446096675, 5221.216817477409, 5237.502437268454, 5239.0, 4995.100881841304, 5474.178873168977, 5650.0, 5683.602147849693, 5711.0, 4429.822807087745, 4442.777861106932, 4448.55514448559, 5311.628186027018, 5354.303940487712, 3004.7896647234484, 3024.470717624407, 3034.892264323506, 3038.8908048562116, 3067.3098552825436, 5494.120940649477, 5920.644761314335, 5945.989181839098, 6000.729967151488, 6014.458698717136, 4974.552290293818, 5414.130510829267, 5890.760081954908, 5930.309861689398, 5947.702614869239, 4971.950280497221, 5501.532369748536, 5556.16657501378, 5995.880082398415, 6044.486218671374, 5419.336793051192, 5575.968445837533, 5626.915596265977, 5641.943580564306, 5694.430556944272, 4519.5480451954545, 5648.926703926241, 5686.687232202103, 5724.282715185344, 5749.252597162342, 4538.841140560065, 4970.353853998957, 5571.582131340247, 5829.76680932758, 5991.850203744767, 3433.896983090511, 3645.828129527328, 3808.27642747877, 3821.2739579479808, 3830.712696547714, 4896.853094407174, 5055.0, 5584.553235741212, 5706.28671416073, 5778.479936805707, 5257.658252213594, 5521.641093328921, 5559.58303127259, 5574.749136288958, 5660.7169641518585, 5480.972595136999, 5510.476504732044, 5516.420775818642, 5531.308586426697, 5599.692016939108, 5144.408393034849, 5306.920396193983, 5323.893522129459, 5330.413654498079, 5489.8471321023035, 4821.349117869183, 5096.592272618256, 5588.692621905834, 5622.606417550732, 5629.605927585029, 5082.822101226439, 5394.919076213939, 5395.298611180521, 5465.890682186255, 5467.578429608251], "value": 4057.1821999754447, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.5454263813797, 769.8652735771238, 788.9329407000408, 814.8370325934815, 858.6393714639851, 14617.561473155809, 15338.309776060076, 15352.692946141098, 15401.152936588498, 15418.614534636627, 14018.929905350458, 14127.858721412782, 14130.64673383166, 14149.504767333145, 14168.220747858864, 688.5558814564603, 714.8177214810216, 852.7697521669146, 863.8617821148633, 891.2914233184601, 895.7491902267343, 899.2266650680409, 901.2789768185459, 901.5897766516252, 901.8196360727848, 952.0955092661965, 953.7091187187905, 955.69895482923, 956.3879117364892, 956.5934477846922, 727.3744579661487, 754.2608243920934, 904.1094521895927, 925.9259259259243, 949.3164921256719, 690.6063543780048, 690.623610132479, 692.0380670867498, 694.135800927843, 696.474162007686, 13083.738325233442, 13084.018698597643, 13084.803727944089, 13099.148555343872, 13103.672408189872, 13801.723965520634, 14020.298985050707, 14094.718105637932, 14140.575782726431, 14261.215633140173, 12783.680407989781, 12909.32084355954, 13092.672683182902, 13132.34338283082, 13550.932245338809, 4462.821487140511, 4480.14877173336, 4562.885927851797, 4618.607418369443, 4692.788824502905, 78682.60658696727, 107769.0, 108986.91013089847, 112636.0, 115742.0, 10919.13894790019, 11009.449527523591, 11064.778704425866, 11115.608525098101, 11526.59656912004, 22216.666749998763, 22283.0, 22304.665430018562, 22310.442238943833, 22347.329580112622, 7755.7673269802, 7763.1848655891445, 7842.882356764653, 7854.528728276322, 8035.919640803634, 4133.855315064018, 4169.082801783603, 4259.595338442843, 4341.479022517318, 4461.464624245112, 3446.0, 3545.8758943436856, 3545.8936231913085, 3548.503209550665, 3555.484454754046, 543.5461389739532, 650.4016304999412, 660.9372109649576, 660.96364699941, 661.9834504137435, 550.8595308196465, 579.8666306749471, 596.1385350318541, 669.3607604737464, 681.9522633415613, 8930.955345223232, 9557.23542116629, 9576.856347154799, 9620.71137865865, 9763.0, 596.2963702830701, 646.4311405962817, 676.5061505101205, 677.6239187251024, 678.4940210194238, 3919.1377896862646, 4165.937685890079, 4667.229907065364, 5195.428502864682, 5210.869728256748, 128007.0, 132074.0, 152423.0, 158367.0, 158663.40717188854, 109410.90589094166, 122827.0, 124081.0, 124673.0, 128069.0, 73577.26422735812, 91238.54380728054, 106261.40607890888, 108242.0, 109236.0, 8555.562762247368, 9460.763480912758, 9918.543363679832, 9963.651272205438, 10002.649907253211, 53830.0, 57333.71333143308, 60659.69670151621, 61755.07367389583, 64772.35227647663, 74742.62628686822, 89529.55235223782, 91529.54235228781, 93776.53111734397, 94071.05928940623, 12999.415026324028, 13201.20792752438, 13320.0, 13374.398152082986, 13522.25627590492, 14895.106293622417, 15027.624309392353, 15104.244787760788, 15523.922380388025, 15597.376104956129, 13812.585622431343, 13831.30843457803, 14079.296035198404, 14106.224157671017, 14392.352344144329, 13546.390412431661, 13834.723305534035, 13893.652658683613, 14146.292685365896, 14233.288335583387, 13419.0, 13469.259190744211, 13540.86459135396, 13777.0, 13945.790813137608, 10834.837477438003, 10873.728156796144, 11356.659300221007, 11576.710582235512, 11622.82565761531, 9399.906000940176, 9707.951460242653, 11445.713857153638, 11510.63450217039, 11590.884091159318], "value": 7834.430634324361, "unit": "score"}], "name": "dromaeo_css", "value": 7246.281807722704, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 162.0, 167.0, 114.0, 115.0, 114.0, 112.0, 114.0, 114.0], "value": 124.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 143.0, 134.0, 131.0, 142.0, 142.0, 115.0, 144.0, 112.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 184.0, 190.0, 213.0, 182.0, 184.0, 182.0, 181.0, 183.0], "value": 186.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 59.0, 58.0, 89.0, 62.0, 60.0, 58.0, 59.0, 81.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 94.0, 87.0, 97.0, 74.0, 91.0, 67.0, 68.0, 89.0], "value": 82.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 88.0, 86.0, 88.0, 83.0, 90.0, 86.0, 87.0, 129.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 80.0, 81.0, 82.0, 83.0, 88.0, 99.0, 83.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 52.0, 52.0, 55.0, 54.0, 54.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 68.0, 68.0, 77.0, 71.0, 69.0, 71.0, 70.0, 72.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 87.0, 86.0, 85.0, 80.0, 105.0, 87.0, 89.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 151.0, 157.0, 149.0, 146.0, 146.0, 151.0, 214.0, 145.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 172.0, 172.0, 173.0, 172.0, 171.0, 171.0, 171.0, 175.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1471.7, "alertThreshold": 2.0}]} 14:32:01 INFO - Return code: 0 14:32:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:32:01 INFO - # TBPL SUCCESS # 14:32:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:32:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:32:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:32:01 INFO - 2016-10-21 14:32:01.240 screenresolution[1780:19659] starting screenresolution argv=screenresolution get 14:32:01 INFO - 2016-10-21 14:32:01.243 screenresolution[1780:19659] Display 0: 1600x1200x32@60 14:32:01 INFO - 2016-10-21 14:32:01.248 screenresolution[1781:19662] starting screenresolution argv=screenresolution list 14:32:01 INFO - Available Modes on Display 0 14:32:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:32:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:32:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:32:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:32:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:32:01 INFO - Intel Iris: 14:32:01 INFO - Chipset Model: Intel Iris 14:32:01 INFO - Type: GPU 14:32:01 INFO - Bus: Built-In 14:32:01 INFO - VRAM (Dynamic, Max): 1536 MB 14:32:01 INFO - Vendor: Intel (0x8086) 14:32:01 INFO - Device ID: 0x0a2e 14:32:01 INFO - Revision ID: 0x0009 14:32:01 INFO - Displays: 14:32:01 INFO - Display: 14:32:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:32:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:32:01 INFO - Display Serial Number: 1600x1200 60 14:32:01 INFO - Main Display: Yes 14:32:01 INFO - Mirror: Off 14:32:01 INFO - Online: Yes 14:32:01 INFO - Rotation: Supported 14:32:01 INFO - Return code: 0 14:32:01 INFO - Running post-action listener: _resource_record_post_action 14:32:01 INFO - [mozharness: 2016-10-21 21:32:01.481709Z] Finished run-tests step (success) 14:32:01 INFO - Running post-run listener: _resource_record_post_run 14:32:01 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 31935488; Write bytes: 705951232; Read time: 202; Write time: 1957 14:32:01 INFO - TinderboxPrint: CPU usage
53.5% 14:32:01 INFO - TinderboxPrint: I/O read bytes / time
31,935,488 / 202 14:32:01 INFO - TinderboxPrint: I/O write bytes / time
705,951,232 / 1,957 14:32:01 INFO - TinderboxPrint: CPU idle
2,252.7 (46.5%) 14:32:01 INFO - TinderboxPrint: CPU system
968.6 (20.0%) 14:32:01 INFO - TinderboxPrint: CPU user
1,628.3 (33.6%) 14:32:01 INFO - TinderboxPrint: Swap in / out
432,242,688 / 0 14:32:01 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399600128; Write bytes: 395204608; Read time: 29367; Write time: 807 14:32:01 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29821952; Write bytes: 296373760; Read time: 174; Write time: 1108 14:32:01 INFO - Running post-run listener: _upload_blobber_files 14:32:01 INFO - Blob upload gear active. 14:32:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:32:01 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 14:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:32:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:32:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:32:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:32:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:03 INFO - (blobuploader) - INFO - Done attempting. 14:32:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:32:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:32:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:04 INFO - (blobuploader) - INFO - Done attempting. 14:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:32:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:06 INFO - (blobuploader) - INFO - Done attempting. 14:32:06 INFO - (blobuploader) - INFO - Iteration through files over. 14:32:06 INFO - Return code: 0 14:32:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:32:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:32:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcf83657d71f1e8f2b50c88bd5d2d2faa16ee8baa88454a03d1190649e39974848eb75910ad4ef6dd019565490e0e84f3b902ea708ac6ff4cb64cc9394137624", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e50d595582d9e3c77d7f1d2cfb9f6674812d35ac35fd43c79718a2b9b40022620db0a3f6df609e3220618eb1547fb9d2d6f0d479708aa14aedad06ab651809e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94abf3ab280dc0c2642d76bb0ec4df1879d7410bdb3ad781648b32e296607fb865f3ebf04b72ffe0e74e8cca0d6158d4c0cd6ade200e74e70cdd03c0927d3b81"} 14:32:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:32:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:32:06 INFO - Contents: 14:32:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcf83657d71f1e8f2b50c88bd5d2d2faa16ee8baa88454a03d1190649e39974848eb75910ad4ef6dd019565490e0e84f3b902ea708ac6ff4cb64cc9394137624", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e50d595582d9e3c77d7f1d2cfb9f6674812d35ac35fd43c79718a2b9b40022620db0a3f6df609e3220618eb1547fb9d2d6f0d479708aa14aedad06ab651809e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94abf3ab280dc0c2642d76bb0ec4df1879d7410bdb3ad781648b32e296607fb865f3ebf04b72ffe0e74e8cca0d6158d4c0cd6ade200e74e70cdd03c0927d3b81"} 14:32:06 INFO - Running post-run listener: copy_logs_to_upload_dir 14:32:06 INFO - Copying logs to upload dir... 14:32:06 INFO - mkdir: /builds/slave/test/build/upload/logs 14:32:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.191206 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-21 14:32:06.910094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 14:32:06.913840) ========= 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.oKbcTj4llB/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.4uUnBKpKsG/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcf83657d71f1e8f2b50c88bd5d2d2faa16ee8baa88454a03d1190649e39974848eb75910ad4ef6dd019565490e0e84f3b902ea708ac6ff4cb64cc9394137624", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e50d595582d9e3c77d7f1d2cfb9f6674812d35ac35fd43c79718a2b9b40022620db0a3f6df609e3220618eb1547fb9d2d6f0d479708aa14aedad06ab651809e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94abf3ab280dc0c2642d76bb0ec4df1879d7410bdb3ad781648b32e296607fb865f3ebf04b72ffe0e74e8cca0d6158d4c0cd6ade200e74e70cdd03c0927d3b81"} build_url:https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011108 build_url: 'https://queue.taskcluster.net/v1/task/CmFYiXX5RjKly5r6I5UikQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcf83657d71f1e8f2b50c88bd5d2d2faa16ee8baa88454a03d1190649e39974848eb75910ad4ef6dd019565490e0e84f3b902ea708ac6ff4cb64cc9394137624", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e50d595582d9e3c77d7f1d2cfb9f6674812d35ac35fd43c79718a2b9b40022620db0a3f6df609e3220618eb1547fb9d2d6f0d479708aa14aedad06ab651809e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94abf3ab280dc0c2642d76bb0ec4df1879d7410bdb3ad781648b32e296607fb865f3ebf04b72ffe0e74e8cca0d6158d4c0cd6ade200e74e70cdd03c0927d3b81"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 14:32:06.946408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 14:32:06.946753) ========= 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.oKbcTj4llB/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.4uUnBKpKsG/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.005260 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 14:32:06.995246) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 14:32:06.995568) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 14:32:06.995911) ========= ========= Total master_lag: 0.18 =========