builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0387 starttime: 1475873418.77 results: success (0) buildid: 20161007113100 builduid: d87b637329c447ddab13a697c31a1695 revision: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:18.773580) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:18.774006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:18.774280) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:18.798112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:18.798401) ========= 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.SkBknYAE9d/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.93Ay11bxhZ/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-07 13:50:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-10-07 13:50:18 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:18.924979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:18.925290) ========= 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.SkBknYAE9d/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.93Ay11bxhZ/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.027652 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:18.975075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-07 13:50:18.975670) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 259c110bf47100196fd28e35c47c4e23bf9ad0a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 259c110bf47100196fd28e35c47c4e23bf9ad0a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SkBknYAE9d/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.93Ay11bxhZ/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-07 13:50:19,058 truncating revision to first 12 chars 2016-10-07 13:50:19,058 Setting DEBUG logging. 2016-10-07 13:50:19,058 attempt 1/10 2016-10-07 13:50:19,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/259c110bf471?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 13:50:20,827 unpacking tar archive at: larch-259c110bf471/testing/mozharness/ program finished with exit code 0 elapsedTime=2.066025 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-07 13:50:21.064171) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:21.064563) ========= script_repo_revision: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:21.064956) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:21.065223) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 13:50:21.083069) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-07 13:50:21.083412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SkBknYAE9d/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.93Ay11bxhZ/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 13:50:21 INFO - MultiFileLogger online at 20161007 13:50:21 in /builds/slave/test 13:50:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 13:50:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:50:21 INFO - {'append_to_log': False, 13:50:21 INFO - 'base_work_dir': '/builds/slave/test', 13:50:21 INFO - 'blob_upload_branch': 'Larch', 13:50:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:50:21 INFO - 'branch': 'Larch', 13:50:21 INFO - 'buildbot_json_path': 'buildprops.json', 13:50:21 INFO - 'config_files': ('talos/mac_config.py',), 13:50:21 INFO - 'default_actions': ('clobber', 13:50:21 INFO - 'read-buildbot-config', 13:50:21 INFO - 'download-and-extract', 13:50:21 INFO - 'populate-webroot', 13:50:21 INFO - 'create-virtualenv', 13:50:21 INFO - 'install', 13:50:21 INFO - 'run-tests'), 13:50:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:50:21 INFO - 'download_minidump_stackwalk': True, 13:50:21 INFO - 'download_symbols': 'ondemand', 13:50:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:50:21 INFO - 'tooltool.py': '/tools/tooltool.py', 13:50:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:50:21 INFO - '/tools/misc-python/virtualenv.py')}, 13:50:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:50:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:50:21 INFO - 'installer_path': 'installer.exe', 13:50:21 INFO - 'log_level': 'info', 13:50:21 INFO - 'log_name': 'talos', 13:50:21 INFO - 'log_to_console': True, 13:50:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:50:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:50:21 INFO - 'opt_config_files': (), 13:50:21 INFO - 'pip_index': False, 13:50:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:21 INFO - 'cmd': ('bash', 13:50:21 INFO - '-c', 13:50:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:21 INFO - 'enabled': True, 13:50:21 INFO - 'halt_on_failure': False, 13:50:21 INFO - 'name': 'check_screen_resolution'},), 13:50:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:50:21 INFO - 'cmd': ('bash', 13:50:21 INFO - '-c', 13:50:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:50:21 INFO - 'enabled': True, 13:50:21 INFO - 'halt_on_failure': False, 13:50:21 INFO - 'name': 'check_screen_resolution'},), 13:50:21 INFO - 'run_cmd_checks_enabled': True, 13:50:21 INFO - 'sps_profile': False, 13:50:21 INFO - 'sps_profile_interval': 0, 13:50:21 INFO - 'suite': 'dromaeojs', 13:50:21 INFO - 'system_bits': '32', 13:50:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:50:21 INFO - 'title': 't-yosemite-r7-0387', 13:50:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:50:21 INFO - 'use_talos_json': True, 13:50:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:50:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:50:21 INFO - 'work_dir': 'build'} 13:50:21 INFO - [mozharness: 2016-10-07 20:50:21.286211Z] Running clobber step. 13:50:21 INFO - Running pre-action listener: _resource_record_pre_action 13:50:21 INFO - Running main action method: clobber 13:50:21 INFO - rmtree: /builds/slave/test/build 13:50:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:50:23 INFO - Running post-action listener: _resource_record_post_action 13:50:23 INFO - [mozharness: 2016-10-07 20:50:23.315292Z] Finished clobber step (success) 13:50:23 INFO - [mozharness: 2016-10-07 20:50:23.315428Z] Running read-buildbot-config step. 13:50:23 INFO - Running pre-action listener: _resource_record_pre_action 13:50:23 INFO - Running main action method: read_buildbot_config 13:50:23 INFO - Using buildbot properties: 13:50:23 INFO - { 13:50:23 INFO - "project": "", 13:50:23 INFO - "product": "firefox", 13:50:23 INFO - "script_repo_revision": "production", 13:50:23 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 13:50:23 INFO - "repository": "", 13:50:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 13:50:23 INFO - "buildid": "20161007113100", 13:50:23 INFO - "pgo_build": "False", 13:50:23 INFO - "basedir": "/builds/slave/test", 13:50:23 INFO - "buildnumber": 0, 13:50:23 INFO - "slavename": "t-yosemite-r7-0387", 13:50:23 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:50:23 INFO - "platform": "yosemite_r7", 13:50:23 INFO - "scheduler": "tests-larch-macosx64-talos", 13:50:23 INFO - "branch": "larch", 13:50:23 INFO - "repo_path": "projects/larch", 13:50:23 INFO - "revision": "259c110bf47100196fd28e35c47c4e23bf9ad0a9", 13:50:23 INFO - "stage_platform": "macosx64", 13:50:23 INFO - "builduid": "d87b637329c447ddab13a697c31a1695", 13:50:23 INFO - "slavebuilddir": "test" 13:50:23 INFO - } 13:50:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:50:23 INFO - Running post-action listener: _resource_record_post_action 13:50:23 INFO - [mozharness: 2016-10-07 20:50:23.319617Z] Finished read-buildbot-config step (success) 13:50:23 INFO - [mozharness: 2016-10-07 20:50:23.319787Z] Running download-and-extract step. 13:50:23 INFO - Running pre-action listener: _resource_record_pre_action 13:50:23 INFO - Running main action method: download_and_extract 13:50:23 INFO - mkdir: /builds/slave/test/build/tests 13:50:23 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')]} 13:50:23 INFO - trying https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:23 INFO - Downloading https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/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 13:50:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/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 13:50:24 INFO - Downloaded 1199 bytes. 13:50:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:50:24 INFO - Using the following test package requirements: 13:50:24 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:24 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:50:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:24 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:50:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:24 INFO - u'jsshell-mac.zip'], 13:50:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:24 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:50:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:50:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:24 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:50:24 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:24 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:50:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:24 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:50:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:50:24 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:50:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:50:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:50:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:50:24 INFO - Fetch https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:50:25 INFO - Http code: 200 13:50:25 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 13:50:25 INFO - x-amz-cf-id: SL-8PnJr0BXspd_-aXceRz-LbepGGSpE-qCSJ1uriShSab4WY5z7hw== 13:50:25 INFO - x-amz-version-id: uoRuJuWFVsBoBltmFRzNYqwhQAYRFNNk 13:50:25 INFO - Expected file size: 16476601 13:50:25 INFO - Obtained file size: 16476601 13:50:32 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 13:50:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:50:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:50:32 INFO - Fetch https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:50:32 INFO - Http code: 200 13:50:32 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 13:50:32 INFO - x-amz-cf-id: oLDhzj3bCwdqyiXjcaBbQ2cK2FjzsP-_tspNRSK03fjRJQujyJ-plA== 13:50:32 INFO - x-amz-version-id: uoRuJuWFVsBoBltmFRzNYqwhQAYRFNNk 13:50:33 INFO - Expected file size: 16476601 13:50:33 INFO - Obtained file size: 16476601 13:50:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:50:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:50:39 INFO - Fetch https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:50:40 INFO - Http code: 200 13:50:40 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 13:50:40 INFO - x-amz-cf-id: P8w2ZnJLfg3bK1BmXPWqNU3C3mnyUyBXx-671BurJOsJ24PvfyJKiw== 13:50:40 INFO - x-amz-version-id: ngPJjYaV5z1WIH9Cbzvo30ButOOxvblz 13:50:40 INFO - Expected file size: 14408522 13:50:40 INFO - Obtained file size: 14408522 13:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:40 INFO - trying https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:50:40 INFO - Downloading https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/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 13:50:43 INFO - Downloaded 111657336 bytes. 13:50:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:50:43 INFO - mkdir: /builds/slave/test/properties 13:50:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:50:43 INFO - Writing to file /builds/slave/test/properties/build_url 13:50:43 INFO - Contents: 13:50:43 INFO - build_url:https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:50:44 INFO - Running post-action listener: _resource_record_post_action 13:50:44 INFO - Running post-action listener: set_extra_try_arguments 13:50:44 INFO - [mozharness: 2016-10-07 20:50:44.124361Z] Finished download-and-extract step (success) 13:50:44 INFO - [mozharness: 2016-10-07 20:50:44.124481Z] Running populate-webroot step. 13:50:44 INFO - Running pre-action listener: _resource_record_pre_action 13:50:44 INFO - Running main action method: populate_webroot 13:50:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:50:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:50:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:50:44 INFO - '--tppagecycles', 13:50:44 INFO - '7'], 13:50:44 INFO - 'tests': ['tsvgm']}}, 13:50:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:50:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:50:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:50:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:50:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:50:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:50:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['damp', 'tps']}, 13:50:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'tests': ['damp', 'tps']}, 13:50:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['dromaeo_dom']}, 13:50:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:50:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['basic_compositor_video']}, 13:50:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:50:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'other-e10s': {'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['a11yr', 13:50:44 INFO - 'ts_paint', 13:50:44 INFO - 'tpaint', 13:50:44 INFO - 'sessionrestore', 13:50:44 INFO - 'sessionrestore_no_auto_restore', 13:50:44 INFO - 'tabpaint']}, 13:50:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['tsvgx', 13:50:44 INFO - 'tsvgr_opacity', 13:50:44 INFO - 'tart', 13:50:44 INFO - 'tscrollx', 13:50:44 INFO - 'cart']}, 13:50:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:50:44 INFO - 'tsvgr_opacity', 13:50:44 INFO - 'tart', 13:50:44 INFO - 'tscrollx', 13:50:44 INFO - 'cart']}, 13:50:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'talos_options': ['--disable-e10s'], 13:50:44 INFO - 'tests': ['tp5o']}, 13:50:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'tests': ['tp5o']}, 13:50:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'talos_options': ['--disable-e10s', 13:50:44 INFO - '--xperf_path', 13:50:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:50:44 INFO - 'tests': ['tp5n']}, 13:50:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:50:44 INFO - 'talos_options': ['--xperf_path', 13:50:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:50:44 INFO - 'tests': ['tp5n']}}, 13:50:44 INFO - 'talos.zip': {'path': '', 13:50:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:50:44 INFO - Running post-action listener: _resource_record_post_action 13:50:44 INFO - [mozharness: 2016-10-07 20:50:44.143246Z] Finished populate-webroot step (success) 13:50:44 INFO - [mozharness: 2016-10-07 20:50:44.143359Z] Running create-virtualenv step. 13:50:44 INFO - Running pre-action listener: _resource_record_pre_action 13:50:44 INFO - Running main action method: create_virtualenv 13:50:44 INFO - Creating virtualenv /builds/slave/test/build/venv 13:50:44 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 13:50:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:50:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:50:44 INFO - Using real prefix '/tools/python27' 13:50:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:50:44 INFO - Installing distribute.............................................................................................................................................................................................done. 13:50:47 INFO - Installing pip.................done. 13:50:47 INFO - Return code: 0 13:50:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:50:48 INFO - Reading from file tmpfile_stdout 13:50:48 INFO - Output received: 13:50:48 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) 13:50:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a253570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9542c761c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, '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.SkBknYAE9d/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.93Ay11bxhZ/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 13:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:48 INFO - 'HOME': '/Users/cltbld', 13:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:48 INFO - 'LOGNAME': 'cltbld', 13:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:48 INFO - 'MOZ_NO_REMOTE': '1', 13:50:48 INFO - 'NO_EM_RESTART': '1', 13:50:48 INFO - 'PAGER': '/bin/cat', 13:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:48 INFO - 'PWD': '/builds/slave/test', 13:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:48 INFO - 'SHELL': '/bin/bash', 13:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:50:48 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:48 INFO - 'USER': 'cltbld', 13:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:48 INFO - 'XPC_FLAGS': '0x0', 13:50:48 INFO - 'XPC_SERVICE_NAME': '0', 13:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:48 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 13:50:48 INFO - Cleaning up... 13:50:48 INFO - Return code: 0 13:50:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a2dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a253570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9542c761c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, '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.SkBknYAE9d/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.93Ay11bxhZ/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 13:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:50:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:50:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:48 INFO - 'HOME': '/Users/cltbld', 13:50:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:48 INFO - 'LOGNAME': 'cltbld', 13:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:48 INFO - 'MOZ_NO_REMOTE': '1', 13:50:48 INFO - 'NO_EM_RESTART': '1', 13:50:48 INFO - 'PAGER': '/bin/cat', 13:50:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:48 INFO - 'PWD': '/builds/slave/test', 13:50:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:48 INFO - 'SHELL': '/bin/bash', 13:50:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:50:48 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:50:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:48 INFO - 'USER': 'cltbld', 13:50:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:48 INFO - 'XPC_FLAGS': '0x0', 13:50:48 INFO - 'XPC_SERVICE_NAME': '0', 13:50:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:48 INFO - Downloading/unpacking psutil>=3.1.1 13:50:48 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 13:50:48 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 13:50:48 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 13:50:48 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 13:50:48 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 13:50:48 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 13:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:50:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:50:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:50:51 INFO - Installing collected packages: psutil 13:50:51 INFO - Running setup.py install for psutil 13:50:52 INFO - building 'psutil._psutil_osx' extension 13:50:52 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 13:50:52 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 13:50:52 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 13:50:52 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 13:50:52 INFO - building 'psutil._psutil_posix' extension 13:50:52 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 13:50:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:50:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:50:52 INFO - ^ 13:50:52 INFO - 1 warning generated. 13:50:52 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 13:50:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:50:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:50:53 INFO - Successfully installed psutil 13:50:53 INFO - Cleaning up... 13:50:53 INFO - Return code: 0 13:50:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:53 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 0x10a2dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a253570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9542c761c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, '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.SkBknYAE9d/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.93Ay11bxhZ/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 13:50:53 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 13:50:53 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 13:50:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:50:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:53 INFO - 'HOME': '/Users/cltbld', 13:50:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:53 INFO - 'LOGNAME': 'cltbld', 13:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:53 INFO - 'MOZ_NO_REMOTE': '1', 13:50:53 INFO - 'NO_EM_RESTART': '1', 13:50:53 INFO - 'PAGER': '/bin/cat', 13:50:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:53 INFO - 'PWD': '/builds/slave/test', 13:50:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:53 INFO - 'SHELL': '/bin/bash', 13:50:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:50:53 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:50:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:53 INFO - 'USER': 'cltbld', 13:50:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:53 INFO - 'XPC_FLAGS': '0x0', 13:50:53 INFO - 'XPC_SERVICE_NAME': '0', 13:50:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:50:53 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 13:50:53 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 13:50:53 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 13:50:53 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 13:50:53 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 13:50:53 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 13:50:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:50:55 INFO - Installing collected packages: mozsystemmonitor 13:50:55 INFO - Running setup.py install for mozsystemmonitor 13:50:56 INFO - Successfully installed mozsystemmonitor 13:50:56 INFO - Cleaning up... 13:50:56 INFO - Return code: 0 13:50:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:56 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 0x10a2dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a253570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9542c761c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, '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.SkBknYAE9d/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.93Ay11bxhZ/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 13:50:56 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 13:50:56 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 13:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:56 INFO - 'HOME': '/Users/cltbld', 13:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:56 INFO - 'LOGNAME': 'cltbld', 13:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:56 INFO - 'MOZ_NO_REMOTE': '1', 13:50:56 INFO - 'NO_EM_RESTART': '1', 13:50:56 INFO - 'PAGER': '/bin/cat', 13:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:56 INFO - 'PWD': '/builds/slave/test', 13:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:56 INFO - 'SHELL': '/bin/bash', 13:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:50:56 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:56 INFO - 'USER': 'cltbld', 13:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:56 INFO - 'XPC_FLAGS': '0x0', 13:50:56 INFO - 'XPC_SERVICE_NAME': '0', 13:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:56 INFO - Downloading/unpacking jsonschema==2.5.1 13:50:56 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 13:50:56 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 13:50:56 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 13:50:56 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 13:50:56 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 13:50:56 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 13:50:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:50:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:50:58 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 13:50:58 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 13:50:58 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 13:50:58 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 13:50:58 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 13:50:58 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 13:50:59 INFO - Downloading functools32-3.2.3-2.tar.gz 13:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:50:59 INFO - warning: no files found matching '*.txt' 13:50:59 INFO - no previously-included directories found matching 'build' 13:50:59 INFO - no previously-included directories found matching 'dist' 13:50:59 INFO - no previously-included directories found matching '.git*' 13:50:59 INFO - Installing collected packages: jsonschema, functools32 13:50:59 INFO - Running setup.py install for functools32 13:50:59 INFO - warning: no files found matching '*.txt' 13:50:59 INFO - no previously-included directories found matching 'build' 13:50:59 INFO - no previously-included directories found matching 'dist' 13:50:59 INFO - no previously-included directories found matching '.git*' 13:50:59 INFO - Successfully installed jsonschema functools32 13:50:59 INFO - Cleaning up... 13:50:59 INFO - Return code: 0 13:50:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:50:59 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')]} 13:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:59 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')]} 13:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:59 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 0x10a2dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a253570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9542c761c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, '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.SkBknYAE9d/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.93Ay11bxhZ/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 13:50:59 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 13:50:59 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 13:50:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:50:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:59 INFO - 'HOME': '/Users/cltbld', 13:50:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:59 INFO - 'LOGNAME': 'cltbld', 13:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:59 INFO - 'MOZ_NO_REMOTE': '1', 13:50:59 INFO - 'NO_EM_RESTART': '1', 13:50:59 INFO - 'PAGER': '/bin/cat', 13:50:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:59 INFO - 'PWD': '/builds/slave/test', 13:50:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:59 INFO - 'SHELL': '/bin/bash', 13:50:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:50:59 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:50:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:59 INFO - 'USER': 'cltbld', 13:50:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:59 INFO - 'XPC_FLAGS': '0x0', 13:50:59 INFO - 'XPC_SERVICE_NAME': '0', 13:50:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:50:59 INFO - Cleaning up... 13:50:59 INFO - Return code: 0 13:50:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:50:59 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')]} 13:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:59 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')]} 13:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:59 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 0x10a2dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a253570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9542c761c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, '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.SkBknYAE9d/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.93Ay11bxhZ/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 13:50:59 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 13:50:59 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 13:50:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:50:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:59 INFO - 'HOME': '/Users/cltbld', 13:50:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:59 INFO - 'LOGNAME': 'cltbld', 13:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:59 INFO - 'MOZ_NO_REMOTE': '1', 13:50:59 INFO - 'NO_EM_RESTART': '1', 13:50:59 INFO - 'PAGER': '/bin/cat', 13:50:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:59 INFO - 'PWD': '/builds/slave/test', 13:50:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:59 INFO - 'SHELL': '/bin/bash', 13:50:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:50:59 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:50:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:59 INFO - 'USER': 'cltbld', 13:50:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:59 INFO - 'XPC_FLAGS': '0x0', 13:50:59 INFO - 'XPC_SERVICE_NAME': '0', 13:50:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:00 INFO - Downloading/unpacking blobuploader==1.2.4 13:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:02 INFO - Downloading blobuploader-1.2.4.tar.gz 13:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:51:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:51:02 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 13:51:02 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 13:51:02 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 13:51:02 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 13:51:02 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 13:51:02 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 13:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:51:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:51:03 INFO - Downloading docopt-0.6.1.tar.gz 13:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:51:03 INFO - Installing collected packages: blobuploader, requests, docopt 13:51:03 INFO - Running setup.py install for blobuploader 13:51:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:51:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:51:04 INFO - Running setup.py install for requests 13:51:04 INFO - Running setup.py install for docopt 13:51:04 INFO - Successfully installed blobuploader requests docopt 13:51:04 INFO - Cleaning up... 13:51:04 INFO - Return code: 0 13:51:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:04 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 0x10a2dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a253570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9542c761c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, '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.SkBknYAE9d/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.93Ay11bxhZ/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 13:51:04 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 13:51:04 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 13:51:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:51:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:04 INFO - 'HOME': '/Users/cltbld', 13:51:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:04 INFO - 'LOGNAME': 'cltbld', 13:51:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:04 INFO - 'MOZ_NO_REMOTE': '1', 13:51:04 INFO - 'NO_EM_RESTART': '1', 13:51:04 INFO - 'PAGER': '/bin/cat', 13:51:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:04 INFO - 'PWD': '/builds/slave/test', 13:51:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:04 INFO - 'SHELL': '/bin/bash', 13:51:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:51:04 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:51:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:04 INFO - 'USER': 'cltbld', 13:51:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:04 INFO - 'XPC_FLAGS': '0x0', 13:51:04 INFO - 'XPC_SERVICE_NAME': '0', 13:51:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-GQtSNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-RvkTtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-_oDEqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-HllGpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-f6lWOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-QBlwLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-UxtLBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:05 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-nY7_Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-DcpWWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-AjEjXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-fHz_Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-bvcK3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-llUjgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-FPKW0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-mzl5tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-CzJZVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:06 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-co5qCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:51:06 INFO - Running setup.py install for manifestparser 13:51:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:51:07 INFO - Running setup.py install for mozcrash 13:51:07 INFO - Running setup.py install for mozdebug 13:51:07 INFO - Running setup.py install for mozdevice 13:51:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:51:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:51:07 INFO - Running setup.py install for mozfile 13:51:07 INFO - Running setup.py install for mozhttpd 13:51:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:51:07 INFO - Running setup.py install for mozinfo 13:51:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:51:07 INFO - Running setup.py install for mozInstall 13:51:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:51:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:51:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:51:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:51:08 INFO - Running setup.py install for mozleak 13:51:08 INFO - Running setup.py install for mozlog 13:51:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:51:08 INFO - Running setup.py install for moznetwork 13:51:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:51:08 INFO - Running setup.py install for mozprocess 13:51:08 INFO - Running setup.py install for mozprofile 13:51:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:51:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:51:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:51:08 INFO - Running setup.py install for mozrunner 13:51:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:51:09 INFO - Running setup.py install for mozscreenshot 13:51:09 INFO - Running setup.py install for moztest 13:51:09 INFO - Running setup.py install for mozversion 13:51:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:51:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:51:09 INFO - Cleaning up... 13:51:09 INFO - Return code: 0 13:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:09 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 0x10a2dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a253570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9542c761c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, '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.SkBknYAE9d/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.93Ay11bxhZ/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 13:51:09 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 13:51:09 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 13:51:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:09 INFO - 'HOME': '/Users/cltbld', 13:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:09 INFO - 'LOGNAME': 'cltbld', 13:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:09 INFO - 'MOZ_NO_REMOTE': '1', 13:51:09 INFO - 'NO_EM_RESTART': '1', 13:51:09 INFO - 'PAGER': '/bin/cat', 13:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:09 INFO - 'PWD': '/builds/slave/test', 13:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:09 INFO - 'SHELL': '/bin/bash', 13:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:51:09 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:09 INFO - 'USER': 'cltbld', 13:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:09 INFO - 'XPC_FLAGS': '0x0', 13:51:09 INFO - 'XPC_SERVICE_NAME': '0', 13:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:51:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-FN62cP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:51:09 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)) 13:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:51:09 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-95nS2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:51:10 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)) 13:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:51:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-8E9If9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:51:10 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)) 13:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:51:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-wAmcME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:51:10 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)) 13:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:51:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ndzvgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:51:10 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)) 13:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:51:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-OX4wR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:51:10 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)) 13:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:51:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-mybqdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:51:10 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)) 13:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:51:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-J329Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:51:10 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)) 13:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:51:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-bCDk70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:51:10 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)) 13:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:51:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-8wGKrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:51:10 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)) 13:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:51:10 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-IQOnKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:51:11 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)) 13:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:51:11 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-X0Uazr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:51:11 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)) 13:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:51:11 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-MoczEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:51:11 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)) 13:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:51:11 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-yOdqdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:51:11 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)) 13:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:11 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-bZ7i_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:51:11 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)) 13:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:51:11 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-uQ41Fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:51:11 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)) 13:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:51:11 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-WtqZnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:51:11 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)) 13:51:11 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)) 13:51:11 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)) 13:51:11 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)) 13:51:11 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)) 13:51:11 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)) 13:51:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:51:11 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 13:51:11 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 13:51:11 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 13:51:11 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 13:51:11 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 13:51:11 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 13:51:14 INFO - Downloading blessings-1.6.tar.gz 13:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:51:14 INFO - Installing collected packages: blessings 13:51:14 INFO - Running setup.py install for blessings 13:51:14 INFO - Successfully installed blessings 13:51:14 INFO - Cleaning up... 13:51:14 INFO - Return code: 0 13:51:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:14 INFO - Reading from file tmpfile_stdout 13:51:14 INFO - Current package versions: 13:51:14 INFO - blessings == 1.6 13:51:14 INFO - blobuploader == 1.2.4 13:51:14 INFO - docopt == 0.6.1 13:51:14 INFO - functools32 == 3.2.3-2 13:51:14 INFO - jsonschema == 2.5.1 13:51:14 INFO - manifestparser == 1.1 13:51:14 INFO - mozInstall == 1.12 13:51:14 INFO - mozcrash == 0.17 13:51:14 INFO - mozdebug == 0.1 13:51:14 INFO - mozdevice == 0.48 13:51:14 INFO - mozfile == 1.2 13:51:14 INFO - mozhttpd == 0.7 13:51:14 INFO - mozinfo == 0.9 13:51:14 INFO - mozleak == 0.1 13:51:14 INFO - mozlog == 3.4 13:51:14 INFO - moznetwork == 0.27 13:51:14 INFO - mozprocess == 0.23 13:51:14 INFO - mozprofile == 0.28 13:51:14 INFO - mozrunner == 6.12 13:51:14 INFO - mozscreenshot == 0.1 13:51:14 INFO - mozsystemmonitor == 0.3 13:51:14 INFO - moztest == 0.7 13:51:14 INFO - mozversion == 1.4 13:51:14 INFO - psutil == 3.1.1 13:51:14 INFO - requests == 1.2.3 13:51:14 INFO - wsgiref == 0.1.2 13:51:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:51:14 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')]} 13:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:14 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')]} 13:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:14 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 0x10a2dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a253570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9542c761c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, '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.SkBknYAE9d/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.93Ay11bxhZ/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 13:51:14 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 13:51:14 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 13:51:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:51:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:14 INFO - 'HOME': '/Users/cltbld', 13:51:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:14 INFO - 'LOGNAME': 'cltbld', 13:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:14 INFO - 'MOZ_NO_REMOTE': '1', 13:51:14 INFO - 'NO_EM_RESTART': '1', 13:51:14 INFO - 'PAGER': '/bin/cat', 13:51:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:14 INFO - 'PWD': '/builds/slave/test', 13:51:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:14 INFO - 'SHELL': '/bin/bash', 13:51:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:51:14 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:51:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:14 INFO - 'USER': 'cltbld', 13:51:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:14 INFO - 'XPC_FLAGS': '0x0', 13:51:14 INFO - 'XPC_SERVICE_NAME': '0', 13:51:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:15 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)) 13:51:15 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)) 13:51:15 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)) 13:51:15 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)) 13:51:15 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)) 13:51:15 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)) 13:51:15 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)) 13:51:15 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)) 13:51:15 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)) 13:51:15 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)) 13:51:15 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)) 13:51:15 INFO - Cleaning up... 13:51:15 INFO - Return code: 0 13:51:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:51:15 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')]} 13:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:15 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')]} 13:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:51:15 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 0x10a2dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a253570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9542c761c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, '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.SkBknYAE9d/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.93Ay11bxhZ/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 13:51:15 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 13:51:15 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 13:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:15 INFO - 'HOME': '/Users/cltbld', 13:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:15 INFO - 'LOGNAME': 'cltbld', 13:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:15 INFO - 'MOZ_NO_REMOTE': '1', 13:51:15 INFO - 'NO_EM_RESTART': '1', 13:51:15 INFO - 'PAGER': '/bin/cat', 13:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:15 INFO - 'PWD': '/builds/slave/test', 13:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:15 INFO - 'SHELL': '/bin/bash', 13:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:51:15 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:15 INFO - 'USER': 'cltbld', 13:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:15 INFO - 'XPC_FLAGS': '0x0', 13:51:15 INFO - 'XPC_SERVICE_NAME': '0', 13:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:51:15 INFO - Cleaning up... 13:51:15 INFO - Return code: 0 13:51:15 INFO - Running post-action listener: _resource_record_post_action 13:51:15 INFO - Running post-action listener: _start_resource_monitoring 13:51:15 INFO - Starting resource monitoring. 13:51:15 INFO - [mozharness: 2016-10-07 20:51:15.341111Z] Finished create-virtualenv step (success) 13:51:15 INFO - [mozharness: 2016-10-07 20:51:15.342096Z] Running install step. 13:51:15 INFO - Running pre-action listener: _resource_record_pre_action 13:51:15 INFO - Running main action method: install 13:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:51:15 INFO - Reading from file tmpfile_stdout 13:51:15 INFO - Detecting whether we're running mozinstall >=1.0... 13:51:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:51:15 INFO - Reading from file tmpfile_stdout 13:51:15 INFO - Output received: 13:51:15 INFO - Usage: mozinstall [options] installer 13:51:15 INFO - Options: 13:51:15 INFO - -h, --help show this help message and exit 13:51:15 INFO - -d DEST, --destination=DEST 13:51:15 INFO - Directory to install application into. [default: 13:51:15 INFO - "/builds/slave/test"] 13:51:15 INFO - --app=APP Application being installed. [default: firefox] 13:51:15 INFO - mkdir: /builds/slave/test/build/application 13:51:15 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'] 13:51:15 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 13:51:50 INFO - Reading from file tmpfile_stdout 13:51:50 INFO - Output received: 13:51:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:51:50 INFO - Running post-action listener: _resource_record_post_action 13:51:50 INFO - [mozharness: 2016-10-07 20:51:50.005332Z] Finished install step (success) 13:51:50 INFO - [mozharness: 2016-10-07 20:51:50.005465Z] Running run-tests step. 13:51:50 INFO - Running pre-action listener: _resource_record_pre_action 13:51:50 INFO - Running main action method: run_tests 13:51:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:51:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:51:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:51:50 INFO - 2016-10-07 13:51:50.019 screenresolution[1637:7448] starting screenresolution argv=screenresolution get 13:51:50 INFO - 2016-10-07 13:51:50.022 screenresolution[1637:7448] Display 0: 1600x1200x32@60 13:51:50 INFO - 2016-10-07 13:51:50.028 screenresolution[1638:7450] starting screenresolution argv=screenresolution list 13:51:50 INFO - Available Modes on Display 0 13:51:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:51:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:51:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:51:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:51:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:51:50 INFO - Intel Iris: 13:51:50 INFO - Chipset Model: Intel Iris 13:51:50 INFO - Type: GPU 13:51:50 INFO - Bus: Built-In 13:51:50 INFO - VRAM (Dynamic, Max): 1536 MB 13:51:50 INFO - Vendor: Intel (0x8086) 13:51:50 INFO - Device ID: 0x0a2e 13:51:50 INFO - Revision ID: 0x0009 13:51:50 INFO - Displays: 13:51:50 INFO - Display: 13:51:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:51:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:51:50 INFO - Display Serial Number: 1600x1200 60 13:51:50 INFO - Main Display: Yes 13:51:50 INFO - Mirror: Off 13:51:50 INFO - Online: Yes 13:51:50 INFO - Rotation: Supported 13:51:50 INFO - Return code: 0 13:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:51:50 INFO - Python 2.7.3 13:51:50 INFO - Return code: 0 13:51:50 INFO - grabbing minidump binary from tooltool 13:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:51:50 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 0x10a0f1d30>, '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 0x109f17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0e9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:51:50 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 13:51:50 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 13:51:50 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 13:51:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:51:50 INFO - Return code: 0 13:51:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:51:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:51:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:51:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:51:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:51:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/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 13:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/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 13:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SkBknYAE9d/Render', 13:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:51:50 INFO - 'HOME': '/Users/cltbld', 13:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:51:50 INFO - 'LOGNAME': 'cltbld', 13:51:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:51:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:51:50 INFO - 'MOZ_NO_REMOTE': '1', 13:51:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:51:50 INFO - 'NO_EM_RESTART': '1', 13:51:50 INFO - 'PAGER': '/bin/cat', 13:51:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:51:50 INFO - 'PWD': '/builds/slave/test', 13:51:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:51:50 INFO - 'SHELL': '/bin/bash', 13:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.93Ay11bxhZ/Listeners', 13:51:50 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:51:50 INFO - 'USER': 'cltbld', 13:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:51:50 INFO - 'XPC_FLAGS': '0x0', 13:51:50 INFO - 'XPC_SERVICE_NAME': '0', 13:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:51:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/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 13:51:50 INFO - mozversion application_buildid: 20161007113100 13:51:50 INFO - mozversion application_changeset: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 13:51:50 INFO - mozversion application_display_name: Nightly 13:51:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:51:50 INFO - mozversion application_name: Firefox 13:51:50 INFO - mozversion application_remotingname: firefox 13:51:50 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:51:50 INFO - mozversion application_vendor: Mozilla 13:51:50 INFO - mozversion application_version: 52.0a1 13:51:50 INFO - mozversion platform_buildid: 20161007113100 13:51:50 INFO - mozversion platform_changeset: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 13:51:50 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:51:50 INFO - mozversion platform_version: 52.0a1 13:51:50 INFO - using testdate: 1475873510 13:51:50 INFO - actual date: 1475873510 13:51:50 INFO - starting webserver on 'localhost:49271' 13:51:50 INFO - SUITE-START | Running 2 tests 13:51:50 INFO - TEST-START | dromaeo_css 13:51:50 INFO - operating with platform_type : mac_ 13:51:50 INFO - Initialising browser for dromaeo_css test... 13:51:50 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpVgRhLU/profile http://localhost:49271/getInfo.html) 13:51:53 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 13:51:53 INFO - PROCESS | 1648 | colorDepth:24 13:51:53 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 13:51:53 INFO - PROCESS | 1648 | __metrics 13:51:53 INFO - PROCESS | 1648 | 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" 13:51:53 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:51:53 INFO - TEST-INFO | 1648: exit 0 13:51:53 INFO - Browser initialized. 13:51:53 INFO - Running cycle 1/1 for dromaeo_css test... 13:51:53 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpVgRhLU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:06 INFO - PROCESS | 1650 | RSS: Main: 247095296 13:52:06 INFO - PROCESS | 1650 | 13:52:57 INFO - PROCESS | 1650 | 1475873577802 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] 13:55:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 13:55:11 INFO - PROCESS | 1650 | RSS: Main: 396406784 13:55:11 INFO - PROCESS | 1650 | 13:58:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 13:58:15 INFO - PROCESS | 1650 | RSS: Main: 386277376 13:58:15 INFO - PROCESS | 1650 | 14:01:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 14:01:18 INFO - PROCESS | 1650 | RSS: Main: 336621568 14:01:18 INFO - PROCESS | 1650 | 14:04:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 14:04:21 INFO - PROCESS | 1650 | RSS: Main: 331710464 14:04:21 INFO - PROCESS | 1650 | 14:07:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 14:07:25 INFO - PROCESS | 1650 | RSS: Main: 330686464 14:07:25 INFO - PROCESS | 1650 | 14:10:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 14:10:29 INFO - PROCESS | 1650 | RSS: Main: 381227008 14:10:29 INFO - PROCESS | 1650 | 14:10:29 INFO - PROCESS | 1650 | __start_tp_report 14:10:29 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 14:10:29 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 14:10:29 INFO - PROCESS | 1650 | |i|pagename|runs| 14:10:29 INFO - PROCESS | 1650 | |0;dojo.html;3178.856951437185;3325.8835940742065;3364.8317584120787;3385.6614338566133;3397.0318459239106;5224.719943613811;5349.43830897755;5735.139729040646;5824.534037277018;5863.560232982522;5738.254026976498;5746.9712651436685;5795.449432303935;5826.766929322833;5833.970830145854;5081.187010078388;5166.9224961625605;5196.168613021917;5216.504432078966;5257.710825904593;5296.496832800897;5310.256564081032;5314.202869569576;5325.281087053237;5325.360956685184;5279.736013199325;5293.6294459387855;5315.01672190646;5338.91991620126;5344.973275133619;5178.0679477694;5216.947830521684;5222.2427747976335;5253.737313134328;5263.921041184385;5163.432022477525;5193.221016847466;5203.947960520384;5216.895662086737;5222.2427747976335;5647.43525647436;5676.3188417389765;5723.484886360247;5733.455321744427;5791.594588378815;6161.599496032743;6231.4391704746795;6235.9376406235815;6237.282712488031;6276.686165691697;6183.783567575113;6311.463525600329;6318.241810982711;6326.177596912372;6332.461740752042;4745.383100196952;5731.484166425042;5755;5831.679257640871;5858.121281807763;6207.324022513896;6230.43926046658;6244.438000579969;6288.339724328971;6296.212973378328;6140.293866205354;6158.137860699506;6167;6170.228721409824;6175.752969881244;5332.973335133377;6112.290716697417;6286.497080233662;6287.874242515124;6290.748370065146;6145.555794388315;6154.599951003171;6206.317305096436;6217.036359364306;6263.749450022039;6274.749010039547;6288.402601752826;6290.4653104485715;6303.842403939938;6312.274088479883;4900.975495122501;4971.204607262821;4981.452040275567;4985.775640096204;4992.05151021312;4391.7584532851;4403.405540252089;4419.42547468827;4434.201843668171;4478.2610869206865;5741.942580574224;5743.282089738783;5747.712614369265;5799;5801.361850196559;6259.561830671809;6288.937110628835;6289.119523266746;6298;6304.968475157595;4770.332153498513;5665.235193248858;5707.1724599933605;5720.370759216483;5753.798617048383;5423.647462914977;5446.7276636168035;5476.479734425223;5510.338759348904;5515.979543784413;6322.241331040213;6329.810105696836;6331.493480521639;6343.55595108338;6349.904751428639;5072.391313042459;6117.188044311343;6330.968345158245;6339.017452294902;6356.046593011085;5628.971855140698;6130.356312587114;6230.844228894314;6242.250929888442;6327.873442531216;6228.159198508325;6230.127782110599;6249.562530622813;6249.718762655601;6250.499960003098;6230.7507699691505;6278.591891527036;6287.937120628918;6311.368863113652;6313.621182728867;6028.065649824284;6084.665343406155;6107.755689772537;6109.16175461965;6118.60229085108;6033.276006879202;6146.432659671755;6161.44546990773;6171.413715697002;6179.6910154493;5149.6910185389;5872.0898260769645;5902.173695682522;6014.879702405839;6036.63780173191;5958.612690175298;6050.576459647782;6108.251008765869;6123.265208174869;6136.785212517719;6005.6396616203165;6022.397760223943;6054.212952316171;6077.878442431038;6118.021116621319 14:10:29 INFO - PROCESS | 1650 | |1;ext.html;496.47869736776386;524.1090146750524;529.5869222006834;536.7933345661921;550.3973149401404;30319.696803031962;39727.801360993224;40932.18135637293;40997.79501102498;43038.35442468365;41413.58586414135;41868.58131418685;41902.58097419025;41985;42017.57982420175;9707.854382184272;9887.505624718771;9916.157126644244;9917.206623470141;9927.453990030546;9622.326437149402;9722.513874306256;9724.951375243114;9727.27045471589;9737;9699.321047526675;9757.658481953133;9760.4631745254;9779.75550611237;9794.706158815246;9666.613335466573;9730.075642813992;9733.805323893554;9737.513124343754;9749.951250243703;9699.466529340883;9765.511724413751;9769.853452198222;9769.90230097697;9772.071653192936;40342;40653.390199147034;40660.39009414861;40707.7964610178;40812.591874081474;3206.679332066798;3410.1645096951156;3613.7109031277437;3845.288621605012;3913.217356528677;30258.199302272133;30731.385372292654;30831.383372332428;31330;31721;3167.9366412671616;3180.8250546219947;3208.631007434152;3210.9036728897936;3320.2031512437084;457992;464025;466297.6685116587;467992;470044.64977675234;56727.71636141875;57059.42940570624;57095;57177;57208.42791572114;34087.65912340845;58111;58124.8375032497;58150.709246453494;58188.12717809236;15466.690666186612;16124.75812862808;16136.515904522883;16176.67646647084;16201.108939008232;12270.938645306895;12382.81425778614;12391.380430978415;12402.007839372829;12418.627441176779;15184.772228416583;18519.44441666725;18519.44441666752;18541.907290463463;18557.072146392627;7702.961485192538;7832.159442531;7836.647350869224;7900.604969751489;7945.721899733481;861.5003298087095;962.3744566031995;968.6416026070399;990.1880458024494;1081.3065042224516;29790.702092979227;30237;30481.390372192433;30931.226719331746;31598.842005789826;961.0197598449543;1010.8526822057019;1032.726327523207;1110.889110889111;1115.8493603363604;14588.416463341347;15018.098914065191;15021.69956600862;15158;15428.768568471482;659957;935439.8420118518;946073;947274;948933;54549;55174;55203.44796552063;55294;55393.723031385394;1237.3318408059727;1272.4337669737063;1336.9732605347838;1368.705728268427;1379.7585422551012;26133.607995879698;28852.855735721187;29489;29783;31768.682313177498;51847.48152518577;55171.72414137904;56055.59861003508;56106.8778624417;56154.71922640524;568622.1568892129;582990;613318;618125;618187;34697.826510867286;34742.82628586841;42003.57996419997;42180.78909605432;42403;40152;46404;46614.76692616515;46686.76656616831;47322.29016564685;38364.04089897775;38367.9683185654;38479.422808657335;39541.60458395494;39710.80144599258;38389.80805095957;38588.42117368298;38821.6117838818;39419;39688.80155599204;37257;37778;38399.80800095982;38435.42346864855;38446.615533844306;31580.052598422084;33316.1670958228;33921.660783392836;34119.82940085284;34153.146171345914;23866.642000370357;24966.62550061787;25226.36934076663;25478.23565293044;25531.723413829604 14:10:29 INFO - PROCESS | 1650 | |2;jquery.html;335.00336498915715;349.76041411633025;372.5510759534761;379.29261926507064;403.21373322022043;13525.594232173038;15045.172515511656;16013.119278439695;20485.07817148228;21046.473838154056;19307.420777376665;19904.303349382775;20345.389638310837;20562.588748225025;20786.272480463187;5768.653880767147;6097.817065488042;6104.08438734189;6109.389061093877;6113;4881.511848815107;6680.164979377578;6748.257691653914;6795.286494918037;6805.387515123638;5701.631608413972;6037.849053773647;6701.894187459064;6739.157605299338;6749.527533072687;6072.392760723937;6104.786332478387;6117.113018612298;6118.174046503709;6122.908156377658;5723.828285151452;5785.074388097926;5953.553483488756;5954;5967.16459695643;12871.935640321832;13120.015998800129;13137.802932956014;23618.763812361827;24515.264542063767;2135.7437107547194;2261.570301642699;2351.6237402015768;2391.928242152738;2667.5865240887692;8415.368847336413;9269.72190834276;9545.284103692251;10080.596776128947;10243.641472548425;1756.4379398592455;1833.7249412588085;1840.125940178418;1879.1637721214065;1884.5006073390562;118065;128864;132714;134281.6571834279;135513.28973420575;8476.449030812977;9413.435193888388;9947.502624868728;11304.604338848101;11394.202405831513;14222;14241.85758142426;14278.214698191492;14278.787272863523;14308.785368219485;8189.672413103528;8342.83314333722;8372.079071302152;8382.958085209535;8561.357898157663;8265.545395003333;8314.916850831414;8434.831303373898;8461.407701460961;8478.915210847936;4320.330348795942;4437.800298986554;4444.644428445717;4521.570450807168;4534.6372290216705;1833.7891142518515;1868.8349245335319;1893.1670065171281;1899.6960486322123;1947.8441724661993;836.3852568362249;844.7930257087053;908.5638893331106;912.6167009855876;921.801812610292;20318.187272508934;20505.38483845487;21490.14039438405;21555.892220538797;21569.568608628055;893.2496702769705;924.200566509964;944.2823454174877;989.4656885282011;1044.3107549017611;10627.415492147851;11139.80191690098;11180.832287515694;11299.717507062389;11317.49071291794;557255;579801;590121;594051;617251;131315;133758;137585.312073441;139868;139953;962.2927148545813;977.1938151025432;988.0662773678948;989.3223142147652;989.980200395988;14817;18616.906915465337;18778.342758003404;18943;19020.904895475433;54329;54586.181207282716;55793;55815;57525.424745753684;72941;73162.63418682873;74891;75696;76515.46969060699;6607.306232845482;7836.647350869339;7879.251471110236;8073.878891816745;8218.054923683852;9102.772430689285;11936.164468487123;12037.398130093636;12296.631101066982;12844.935775321064;8570.871436928575;10298.948505257425;11208.159388045766;11291.661250162508;11324.6036388726;10176.542055607664;11044.723881903017;11220.887791121984;11396.259243149168;11517.42412879336;8261.463004904663;9859.816821981409;10871.075958543612;11552.6534203974;11729.530818767495;7954.323882470055;7956.9602151988865;8043.919560804551;8184.831019779882;8235.34117270605;10548.314359566604;10778.191635627203;10846;11204;11425.885741142814 14:10:29 INFO - PROCESS | 1650 | |3;mootools.html;1366.747151776922;1486.7844162596423;1545.5672411724713;1751.8686098542605;1920.1743250402321;7939.206079392058;8406.243438090578;8740.956295218522;9030.86453703195;9031.187193152631;8774.780630484242;8880.689175878846;8896.466212027266;8909.020007799138;8914.420562663423;2349.3656712687566;2382.940426489334;2383.7020372453444;2385.916492922748;2388.2238272561485;2335.089315167086;2360.634101714237;2367.4318163640687;2371.205646108556;2392.5932591459405;2348.377679914824;2371.905123795046;2380.131252092991;2381.142788596104;2382.4758553118286;2331.6152834782242;2335.8131349492;2372.4543355028354;2375.394274460019;2379.7382287948312;2033.8169564739096;2332.4052366646397;2341.2156927429332;2375.643653451979;2378.940526486834;8825.205731484133;8832.911670883273;8920.018797932222;8922;8941.910580894173;4490.640748740093;5366.06093933564;5367.46325367464;5391.29913111293;5399.082156033483;3470.9132271693156;3629.328574213779;3684.797336146511;3685.2261025184744;3698.9260214795822;1053.7629033467408;1086.5870969031716;1093.0217455377392;1093.775775965925;1113.1261959361861;12007.879921200763;12085.637430877088;12145.089118316073;12163.391830408533;12191.024718022625;4371.344298355209;4441.755703436277;4641.907161856744;4652.464966528825;4686.320483529869;8974.820503589892;9027.187553120251;9282.303827212985;9291.117343852324;9305.95347023274;5159.793608255703;5250.081235783722;5259.947400525945;5269.631125821233;5298.947010529922;4142.79286035697;4379.189849877783;4547.272436410159;4562.406887104655;4933.629977751683;3237.2392487765355;3703.6481534254203;3748.362778327636;3806.5051543299746;3818.198178382571;1027.6454623155;1148.3454430974264;1155.1971379891063;1164.5283660117666;1165.1727273635645;825.6273124287234;847.3221422861686;892.7723430525175;900.0954041188694;937.634322614181;5610.635308704921;5755.309362876482;5902.527797776168;6036.818895433056;6052.243469566304;791.7268542352879;895.7984453498041;912.3339961827903;922.6586163119555;973.9269554783419;3774.8867533974026;3789.7536660117003;3823.1780167264174;3915.5497117831246;3961.623645753649;10681.092107170822;10986.285891417032;11098.61154859576;11112.277701949348;11127.221094523306;11074.280171788809;11084.390358530198;11089;11091.223614346918;11093.389863557582;7734.381249500027;8105.959470202493;8287.544185069759;8440.11378805229;8458.36562257833;5935.525157987437;5953.502205918665;5982.760689572542;6052.848678783065;6121.816345509642;8101.311388531805;9963.651272205438;9999.30004899679;10290.12533934624;10320.380777153396;9442.347589172005;10236.641717539851;10354.482275886025;10511.57953681844;10570.471476425993;6750.1562304711915;7055.858882822417;7429.108506979197;7624.008878845714;7712.498687585289;8309.293710034715;8315.12691167443;8320;8414.032386275412;8421;7509.249075092447;7538.53227515349;7549.131849837339;7570.280823321776;7607.695692172251;7428.517146385468;7441.404687625085;7499.175090740124;7509.136449308399;7655.808604784925;6926.168859736864;7000.299970002959;7065.57606543609;7072.222055573986;7083.7520686775715;4867.1969125093965;4905.337779399735;4955.628327875496;5019.7741101651245;5167.173252279617;4960.330355401975;4975.203967365204;4999.675021123615;5036.118679231193;5201.375834899836 14:10:29 INFO - PROCESS | 1650 | |4;prototype.html;296.658842331319;306.8370874386077;308.6681817046674;313.6628124765877;315.0532649388587;4584.083183363324;5145.716985565792;5178.384915617613;5190.948090519094;5210.661307015046;4810.735409552473;4871.001444703836;5162.948370516303;5170.689758614486;5177.559907407875;2940.397483371557;3091.4435401627698;3520.331137083946;3721.7394782365245;3744.7191460640424;3276.2464633134396;3975.0062484378905;4003.8198281077275;4008.599140085997;4037.5356833964174;3426.5031570422275;3827.483289755889;3945;3945.644891959723;3972.960270397288;3301.6533264007176;3599.2441587266703;3900.8634697785724;3955.940660890089;3975.7216994810374;3457.481377793326;3470.930581388358;3481.9206046125782;3483.9967018963944;3492.1793378556017;4008.498937632796;4153.7300075494995;4517.661175411825;5013.8718788272345;5048.697078175322;3807.477009196316;3959.6641677363527;4098.6516146127615;4503.482099558527;4523.36672865799;4709.882252943669;4806.975965120187;5384.5692344612335;5422.620416570841;5441.15000899696;3819.7708137511836;3828.3109040372724;3830.080780612661;3850.5764365919727;3882.475865758143;4984.451710311862;5006.599472042228;5564.998300305943;5689.9146512802345;5728.140778883159;3095.334503081803;3778.7165962552917;3821.910755434688;3824.4050592443014;3831.750936189139;3393.966060339365;3807.629253468749;3874.6900247980093;3890.8832735017995;3892.6107389261415;4465.397171381886;4470.284754439274;4473;4543.4775000875325;4556.97721511397;4542.705933503559;4737.407824021997;5180.740962951837;5421.620486565903;5542.334919809568;1135.2573799218326;1219.9935053580832;1270.314030423561;1290.445108603291;1301.4208677138583;768.5619197057736;779.6608475313257;786.984260314802;789.124072279769;796.7211475983476;4059.518275829301;4867.902641947141;5054.873628159252;5056.797728090835;5068.265101560253;5480.876420333822;5543.8891222176135;5573.637713548606;5694.544436445074;5708.914366284509;4795.832145874878;4815.855524334275;5136.4606716295;5138.743062846843;5185.662931909414;2650.443406884576;2922.8392438415667;2933.911982640524;2934.8679309431127;2937.8677959491874;4830.589399900978;4841.288878228203;5326.6005049621435;5404.459554044564;5747.310322761212;4296.505901821268;5664.631798933056;5692.104789880699;5716.885662286731;5784.4504772046585;4739.075880203327;5742.655440673573;5745.971270143623;5763.7982670606325;5824.912626310609;4901.411830580353;5538.280023596906;5553.305836770403;5587.245721827501;5610.214569960127;5227.634065615371;5432.402435731988;5519.957615682223;5529.668219906818;5550.916736248879;5729.71351432435;5736.942630573808;5771.826845194483;5782.942170578241;5797.362290147996;3475.3049390121573;3504.281622267378;3664.248828990104;3766.472693822922;3775.2826962876966;4920.138975679313;5209.489248118003;5490.423505531861;5544.889102218014;5570.944290557042;5342.839714808562;5348.43275227885;5384.19237114436;5388.353397592314;5427.945720542902;4170.645495132948;4737.763111844463;5338.57291416678;5357.571394288526;5428.6199966002005;4649.930515981276;4668.92996605058;5276.81531146408;5282.0984445600325;5315.920261196163;5127.359080114986;5258.710770907637;5287.444818294024;5312.442193569774;5389.21856330822;4538.773061346986;5254.395744489279;5257.237700533477;5293.247511294183;5343.118385466354 14:10:29 INFO - PROCESS | 1650 | |5;yui.html;663.422822144734;718.0485856240483;729.2962291388809;775.9883601745973;781.316348195329;12587.811182832265;15491.380344786223;15995.280212390428;16002.59993500163;16027.919860400696;14221.502247421342;14348.856511434882;14356.856431435683;14418.990670653058;14425.42298308069;682.6382017530692;701.442353329102;704.1409480433888;839.4082172068707;860.8149247911698;700.6671830880316;702.4836744992426;705.6718625838984;836.6235194162621;870.1559487297311;917.6604656277186;929.0894922975488;929.7861491856877;932.1051790281305;932.1843387036344;923.1091996223677;928.19247254888;928.3408779766374;929.159111004542;929.1776777551847;536.0538649284017;690.9136357955256;691.636890632422;693.040139406925;693.9583624982517;12364.938175309157;12662.240265584001;12662.873371266262;12670.113092083559;12682.429290681941;12703.983681305474;13317.800232996513;13623.637958287702;13784.655383615389;14194.290285485684;12658.683532911658;13128.6717832054;13193.60419187426;13534.864651353459;13816.654583635389;4607.953920460786;4639.002614437878;4704.529547045302;4820.228763397875;4846.830360937385;105117;105796.99999999923;120169;120342;126039;11221.270617409842;11290.209685322114;11350;11386.886131138583;11416.486258118404;15954.60113497172;21263.468413289793;22158.778412215994;22387.55224895493;22495.212667556556;8145.185481451807;8181.836363272821;8226.506409615442;8343.791405214919;8353.122922093215;4416.050549131952;4480.574345437179;4551.977240113778;4557.6581756368405;4653.208954477679;3050.8016978896744;3745.9438108428394;3750.981245093757;3752.587215406303;3757.5866654667966;609.439315829438;688.1466980943694;702.6592102830124;705.7565140026683;705.8059033765755;528.3452780999407;532.9573634109262;554.9639273447214;572.6057051080631;657.3861170825612;7941.483803552751;8945.329100317373;9079.228265597367;9687.17658998979;9764.609415623438;521.4264309259784;644.2719726708789;654.1496055128314;661.9702113404908;678.6504949950779;3956.624120708528;4346.678749072611;4683.976580117146;4699.365585645963;4839.733814640229;100079;167179;170407;170661;176986;109527;135526;140299.29850350888;140444.29777851046;143871;78449;119304;120672;120826.3958680201;121406.17890731645;7329.816754581178;8866.246369058703;8976.326775491734;8984.820303594022;8989;67884.6605766968;69174;70405;70455;72267.63866180636;78006.43987120112;78119.21880781346;92226;105957;108240;13099.279539625411;13335.799963000369;13450;13624.04631675773;13957.95315351373;12776.913962312936;14826.925865370604;14937.551873443814;14998.325075371853;15050;14026.438942442595;14218.289085545475;14229.217393043067;14291.571252862015;14504.709905801614;13713.520026799015;13977.510787122403;14060.789088163481;14193.858061419254;14275.571732848031;11218.887811121784;11249.606263781056;13537.72924541484;13596.252206128758;14335.498257560936;9522.666706665234;9982.95179006194;11337.206395552563;11535.480903359537;11787.941060294643;9845.704628861145;10738.46307684597;11504.309741415542;11512.36681982499;11642.476088575864 14:10:29 INFO - PROCESS | 1650 | __end_tp_report 14:10:29 INFO - PROCESS | 1650 | __start_cc_report 14:10:29 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1823 14:10:29 INFO - PROCESS | 1650 | __end_cc_report 14:10:29 INFO - PROCESS | 1650 | __startTimestamp1475874629069__endTimestamp 14:10:29 INFO - PROCESS | 1650 | 14:10:29 INFO - PROCESS | 1650 | ------- Summary: start ------- 14:10:29 INFO - PROCESS | 1650 | Number of tests: 6 14:10:29 INFO - PROCESS | 1650 | 14:10:29 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5738.30 Median:6005.64 stddev:654.27 (10.9%) stddev-sans-first:624.71 14:10:29 INFO - PROCESS | 1650 | Values: 3178.9 3325.9 3364.8 3385.7 3397.0 5224.7 5349.4 5735.1 5824.5 5863.6 5738.3 5747.0 5795.4 5826.8 5834.0 5081.2 5166.9 5196.2 5216.5 5257.7 5296.5 5310.3 5314.2 5325.3 5325.4 5279.7 5293.6 5315.0 5338.9 5345.0 5178.1 5216.9 5222.2 5253.7 5263.9 5163.4 5193.2 5203.9 5216.9 5222.2 5647.4 5676.3 5723.5 5733.5 5791.6 6161.6 6231.4 6235.9 6237.3 6276.7 6183.8 6311.5 6318.2 6326.2 6332.5 4745.4 5731.5 5755.0 5831.7 5858.1 6207.3 6230.4 6244.4 6288.3 6296.2 6140.3 6158.1 6167.0 6170.2 6175.8 5333.0 6112.3 6286.5 6287.9 6290.7 6145.6 6154.6 6206.3 6217.0 6263.7 6274.7 6288.4 6290.5 6303.8 6312.3 4901.0 4971.2 4981.5 4985.8 4992.1 4391.8 4403.4 4419.4 4434.2 4478.3 5741.9 5743.3 5747.7 5799.0 5801.4 6259.6 6288.9 6289.1 6298.0 6305.0 4770.3 5665.2 5707.2 5720.4 5753.8 5423.6 5446.7 5476.5 5510.3 5516.0 6322.2 6329.8 6331.5 6343.6 6349.9 5072.4 6117.2 6331.0 6339.0 6356.0 5629.0 6130.4 6230.8 6242.3 6327.9 6228.2 6230.1 6249.6 6249.7 6250.5 6230.8 6278.6 6287.9 6311.4 6313.6 6028.1 6084.7 6107.8 6109.2 6118.6 6033.3 6146.4 6161.4 6171.4 6179.7 5149.7 5872.1 5902.2 6014.9 6036.6 5958.6 6050.6 6108.3 6123.3 6136.8 6005.6 6022.4 6054.2 6077.9 6118.0 14:10:29 INFO - PROCESS | 1650 | 14:10:29 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:77042.97 Median:40872.39 stddev:182743.92 (447.1%) stddev-sans-first:183166.19 14:10:29 INFO - PROCESS | 1650 | Values: 496.5 524.1 529.6 536.8 550.4 30319.7 39727.8 40932.2 40997.8 43038.4 41413.6 41868.6 41902.6 41985.0 42017.6 9707.9 9887.5 9916.2 9917.2 9927.5 9622.3 9722.5 9725.0 9727.3 9737.0 9699.3 9757.7 9760.5 9779.8 9794.7 9666.6 9730.1 9733.8 9737.5 9750.0 9699.5 9765.5 9769.9 9769.9 9772.1 40342.0 40653.4 40660.4 40707.8 40812.6 3206.7 3410.2 3613.7 3845.3 3913.2 30258.2 30731.4 30831.4 31330.0 31721.0 3167.9 3180.8 3208.6 3210.9 3320.2 457992.0 464025.0 466297.7 467992.0 470044.6 56727.7 57059.4 57095.0 57177.0 57208.4 34087.7 58111.0 58124.8 58150.7 58188.1 15466.7 16124.8 16136.5 16176.7 16201.1 12270.9 12382.8 12391.4 12402.0 12418.6 15184.8 18519.4 18519.4 18541.9 18557.1 7703.0 7832.2 7836.6 7900.6 7945.7 861.5 962.4 968.6 990.2 1081.3 29790.7 30237.0 30481.4 30931.2 31598.8 961.0 1010.9 1032.7 1110.9 1115.8 14588.4 15018.1 15021.7 15158.0 15428.8 659957.0 935439.8 946073.0 947274.0 948933.0 54549.0 55174.0 55203.4 55294.0 55393.7 1237.3 1272.4 1337.0 1368.7 1379.8 26133.6 28852.9 29489.0 29783.0 31768.7 51847.5 55171.7 56055.6 56106.9 56154.7 568622.2 582990.0 613318.0 618125.0 618187.0 34697.8 34742.8 42003.6 42180.8 42403.0 40152.0 46404.0 46614.8 46686.8 47322.3 38364.0 38368.0 38479.4 39541.6 39710.8 38389.8 38588.4 38821.6 39419.0 39688.8 37257.0 37778.0 38399.8 38435.4 38446.6 31580.1 33316.2 33921.7 34119.8 34153.1 23866.6 24966.6 25226.4 25478.2 25531.7 14:10:29 INFO - PROCESS | 1650 | 14:10:29 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:34862.78 Median:2361.77 stddev:98829.75 (4184.6%) stddev-sans-first:99072.99 14:10:29 INFO - PROCESS | 1650 | Values: 335.0 349.8 372.6 379.3 403.2 13525.6 15045.2 16013.1 20485.1 21046.5 19307.4 19904.3 20345.4 20562.6 20786.3 5768.7 6097.8 6104.1 6109.4 6113.0 4881.5 6680.2 6748.3 6795.3 6805.4 5701.6 6037.8 6701.9 6739.2 6749.5 6072.4 6104.8 6117.1 6118.2 6122.9 5723.8 5785.1 5953.6 5954.0 5967.2 12871.9 13120.0 13137.8 23618.8 24515.3 2135.7 2261.6 2351.6 2391.9 2667.6 8415.4 9269.7 9545.3 10080.6 10243.6 1756.4 1833.7 1840.1 1879.2 1884.5 118065.0 128864.0 132714.0 134281.7 135513.3 8476.4 9413.4 9947.5 11304.6 11394.2 14222.0 14241.9 14278.2 14278.8 14308.8 8189.7 8342.8 8372.1 8383.0 8561.4 8265.5 8314.9 8434.8 8461.4 8478.9 4320.3 4437.8 4444.6 4521.6 4534.6 1833.8 1868.8 1893.2 1899.7 1947.8 836.4 844.8 908.6 912.6 921.8 20318.2 20505.4 21490.1 21555.9 21569.6 893.2 924.2 944.3 989.5 1044.3 10627.4 11139.8 11180.8 11299.7 11317.5 557255.0 579801.0 590121.0 594051.0 617251.0 131315.0 133758.0 137585.3 139868.0 139953.0 962.3 977.2 988.1 989.3 990.0 14817.0 18616.9 18778.3 18943.0 19020.9 54329.0 54586.2 55793.0 55815.0 57525.4 72941.0 73162.6 74891.0 75696.0 76515.5 6607.3 7836.6 7879.3 8073.9 8218.1 9102.8 11936.2 12037.4 12296.6 12844.9 8570.9 10298.9 11208.2 11291.7 11324.6 10176.5 11044.7 11220.9 11396.3 11517.4 8261.5 9859.8 10871.1 11552.7 11729.5 7954.3 7957.0 8043.9 8184.8 8235.3 10548.3 10778.2 10846.0 11204.0 11425.9 14:10:29 INFO - PROCESS | 1650 | 14:10:29 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5712.58 Median:4967.77 stddev:3254.73 (65.5%) stddev-sans-first:3247.47 14:10:29 INFO - PROCESS | 1650 | Values: 1366.7 1486.8 1545.6 1751.9 1920.2 7939.2 8406.2 8741.0 9030.9 9031.2 8774.8 8880.7 8896.5 8909.0 8914.4 2349.4 2382.9 2383.7 2385.9 2388.2 2335.1 2360.6 2367.4 2371.2 2392.6 2348.4 2371.9 2380.1 2381.1 2382.5 2331.6 2335.8 2372.5 2375.4 2379.7 2033.8 2332.4 2341.2 2375.6 2378.9 8825.2 8832.9 8920.0 8922.0 8941.9 4490.6 5366.1 5367.5 5391.3 5399.1 3470.9 3629.3 3684.8 3685.2 3698.9 1053.8 1086.6 1093.0 1093.8 1113.1 12007.9 12085.6 12145.1 12163.4 12191.0 4371.3 4441.8 4641.9 4652.5 4686.3 8974.8 9027.2 9282.3 9291.1 9306.0 5159.8 5250.1 5259.9 5269.6 5298.9 4142.8 4379.2 4547.3 4562.4 4933.6 3237.2 3703.6 3748.4 3806.5 3818.2 1027.6 1148.3 1155.2 1164.5 1165.2 825.6 847.3 892.8 900.1 937.6 5610.6 5755.3 5902.5 6036.8 6052.2 791.7 895.8 912.3 922.7 973.9 3774.9 3789.8 3823.2 3915.5 3961.6 10681.1 10986.3 11098.6 11112.3 11127.2 11074.3 11084.4 11089.0 11091.2 11093.4 7734.4 8106.0 8287.5 8440.1 8458.4 5935.5 5953.5 5982.8 6052.8 6121.8 8101.3 9963.7 9999.3 10290.1 10320.4 9442.3 10236.6 10354.5 10511.6 10570.5 6750.2 7055.9 7429.1 7624.0 7712.5 8309.3 8315.1 8320.0 8414.0 8421.0 7509.2 7538.5 7549.1 7570.3 7607.7 7428.5 7441.4 7499.2 7509.1 7655.8 6926.2 7000.3 7065.6 7072.2 7083.8 4867.2 4905.3 4955.6 5019.8 5167.2 4960.3 4975.2 4999.7 5036.1 5201.4 14:10:29 INFO - PROCESS | 1650 | 14:10:29 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4358.48 Median:4854.60 stddev:1351.12 (27.8%) stddev-sans-first:1320.06 14:10:29 INFO - PROCESS | 1650 | Values: 296.7 306.8 308.7 313.7 315.1 4584.1 5145.7 5178.4 5190.9 5210.7 4810.7 4871.0 5162.9 5170.7 5177.6 2940.4 3091.4 3520.3 3721.7 3744.7 3276.2 3975.0 4003.8 4008.6 4037.5 3426.5 3827.5 3945.0 3945.6 3973.0 3301.7 3599.2 3900.9 3955.9 3975.7 3457.5 3470.9 3481.9 3484.0 3492.2 4008.5 4153.7 4517.7 5013.9 5048.7 3807.5 3959.7 4098.7 4503.5 4523.4 4709.9 4807.0 5384.6 5422.6 5441.2 3819.8 3828.3 3830.1 3850.6 3882.5 4984.5 5006.6 5565.0 5689.9 5728.1 3095.3 3778.7 3821.9 3824.4 3831.8 3394.0 3807.6 3874.7 3890.9 3892.6 4465.4 4470.3 4473.0 4543.5 4557.0 4542.7 4737.4 5180.7 5421.6 5542.3 1135.3 1220.0 1270.3 1290.4 1301.4 768.6 779.7 787.0 789.1 796.7 4059.5 4867.9 5054.9 5056.8 5068.3 5480.9 5543.9 5573.6 5694.5 5708.9 4795.8 4815.9 5136.5 5138.7 5185.7 2650.4 2922.8 2933.9 2934.9 2937.9 4830.6 4841.3 5326.6 5404.5 5747.3 4296.5 5664.6 5692.1 5716.9 5784.5 4739.1 5742.7 5746.0 5763.8 5824.9 4901.4 5538.3 5553.3 5587.2 5610.2 5227.6 5432.4 5520.0 5529.7 5550.9 5729.7 5736.9 5771.8 5782.9 5797.4 3475.3 3504.3 3664.2 3766.5 3775.3 4920.1 5209.5 5490.4 5544.9 5570.9 5342.8 5348.4 5384.2 5388.4 5427.9 4170.6 4737.8 5338.6 5357.6 5428.6 4649.9 4668.9 5276.8 5282.1 5315.9 5127.4 5258.7 5287.4 5312.4 5389.2 4538.8 5254.4 5257.2 5293.2 5343.1 14:10:29 INFO - PROCESS | 1650 | 14:10:29 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:25647.14 Median:3751.78 stddev:41896.99 (1116.7%) stddev-sans-first:41972.52 14:10:29 INFO - PROCESS | 1650 | Values: 663.4 718.0 729.3 776.0 781.3 12587.8 15491.4 15995.3 16002.6 16027.9 14221.5 14348.9 14356.9 14419.0 14425.4 682.6 701.4 704.1 839.4 860.8 700.7 702.5 705.7 836.6 870.2 917.7 929.1 929.8 932.1 932.2 923.1 928.2 928.3 929.2 929.2 536.1 690.9 691.6 693.0 694.0 12364.9 12662.2 12662.9 12670.1 12682.4 12704.0 13317.8 13623.6 13784.7 14194.3 12658.7 13128.7 13193.6 13534.9 13816.7 4608.0 4639.0 4704.5 4820.2 4846.8 105117.0 105797.0 120169.0 120342.0 126039.0 11221.3 11290.2 11350.0 11386.9 11416.5 15954.6 21263.5 22158.8 22387.6 22495.2 8145.2 8181.8 8226.5 8343.8 8353.1 4416.1 4480.6 4552.0 4557.7 4653.2 3050.8 3745.9 3751.0 3752.6 3757.6 609.4 688.1 702.7 705.8 705.8 528.3 533.0 555.0 572.6 657.4 7941.5 8945.3 9079.2 9687.2 9764.6 521.4 644.3 654.1 662.0 678.7 3956.6 4346.7 4684.0 4699.4 4839.7 100079.0 167179.0 170407.0 170661.0 176986.0 109527.0 135526.0 140299.3 140444.3 143871.0 78449.0 119304.0 120672.0 120826.4 121406.2 7329.8 8866.2 8976.3 8984.8 8989.0 67884.7 69174.0 70405.0 70455.0 72267.6 78006.4 78119.2 92226.0 105957.0 108240.0 13099.3 13335.8 13450.0 13624.0 13958.0 12776.9 14826.9 14937.6 14998.3 15050.0 14026.4 14218.3 14229.2 14291.6 14504.7 13713.5 13977.5 14060.8 14193.9 14275.6 11218.9 11249.6 13537.7 13596.3 14335.5 9522.7 9983.0 11337.2 11535.5 11787.9 9845.7 10738.5 11504.3 11512.4 11642.5 14:10:29 INFO - PROCESS | 1650 | -------- Summary: end -------- 14:10:29 INFO - PROCESS | 1650 | 14:10:29 INFO - TEST-INFO | 1650: exit 0 14:10:29 INFO - TEST-OK | dromaeo_css | took 1119068ms 14:10:29 INFO - TEST-START | kraken 14:10:29 INFO - operating with platform_type : mac_ 14:10:29 INFO - Initialising browser for kraken test... 14:10:29 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpyvAP7B/profile http://localhost:49271/getInfo.html) 14:10:32 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 14:10:32 INFO - PROCESS | 1659 | colorDepth:24 14:10:32 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 14:10:32 INFO - PROCESS | 1659 | __metrics 14:10:32 INFO - PROCESS | 1659 | 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:10:32 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:10:32 INFO - TEST-INFO | 1659: exit 0 14:10:32 INFO - Browser initialized. 14:10:32 INFO - Running cycle 1/1 for kraken test... 14:10:32 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpyvAP7B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:44 INFO - PROCESS | 1660 | RSS: Main: 247357440 14:10:44 INFO - PROCESS | 1660 | 14:10:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 14:10:48 INFO - PROCESS | 1660 | RSS: Main: 297037824 14:10:48 INFO - PROCESS | 1660 | 14:10:51 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 14:10:51 INFO - PROCESS | 1660 | RSS: Main: 299094016 14:10:51 INFO - PROCESS | 1660 | 14:10:55 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 14:10:56 INFO - PROCESS | 1660 | RSS: Main: 389120000 14:10:56 INFO - PROCESS | 1660 | 14:10:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 14:10:58 INFO - PROCESS | 1660 | RSS: Main: 289570816 14:10:58 INFO - PROCESS | 1660 | 14:11:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:11:01 INFO - PROCESS | 1660 | RSS: Main: 293777408 14:11:01 INFO - PROCESS | 1660 | 14:11:03 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 14:11:04 INFO - PROCESS | 1660 | RSS: Main: 331259904 14:11:04 INFO - PROCESS | 1660 | 14:11:07 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 14:11:08 INFO - PROCESS | 1660 | RSS: Main: 330600448 14:11:08 INFO - PROCESS | 1660 | 14:11:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 14:11:11 INFO - PROCESS | 1660 | RSS: Main: 330616832 14:11:11 INFO - PROCESS | 1660 | 14:11:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:11:13 INFO - PROCESS | 1660 | RSS: Main: 302882816 14:11:13 INFO - PROCESS | 1660 | 14:11:15 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:11:16 INFO - PROCESS | 1660 | RSS: Main: 307441664 14:11:16 INFO - PROCESS | 1660 | 14:11:18 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:11:19 INFO - PROCESS | 1660 | RSS: Main: 311062528 14:11:19 INFO - PROCESS | 1660 | 14:11:21 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:11:22 INFO - PROCESS | 1660 | RSS: Main: 328839168 14:11:22 INFO - PROCESS | 1660 | 14:11:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:11:26 INFO - PROCESS | 1660 | RSS: Main: 322617344 14:11:26 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 14:11:28 INFO - PROCESS | 1660 | RSS: Main: 366718976 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | __start_tp_report 14:11:28 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 14:11:28 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 14:11:28 INFO - PROCESS | 1660 | |i|pagename|runs| 14:11:28 INFO - PROCESS | 1660 | |0;ai-astar;111;111;111;111;111;111;111;111;110;109 14:11:28 INFO - PROCESS | 1660 | |1;audio-beat-detection;152;114;111;149;114;114;114;113;145;114 14:11:28 INFO - PROCESS | 1660 | |2;audio-dft;185;184;186;187;185;181;230;184;179;183 14:11:28 INFO - PROCESS | 1660 | |3;audio-fft;82;60;59;90;60;59;58;60;84;57 14:11:28 INFO - PROCESS | 1660 | |4;audio-oscillator;89;75;89;69;69;70;92;67;69;89 14:11:28 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;87;83;86;84;87;84;87;83;88;83 14:11:28 INFO - PROCESS | 1660 | |6;imaging-darkroom;95;94;95;95;102;96;97;97;95;95 14:11:28 INFO - PROCESS | 1660 | |7;imaging-desaturate;85;83;87;84;85;84;86;84;84;85 14:11:28 INFO - PROCESS | 1660 | |8;json-parse-financial;56;52;53;53;54;54;53;53;54;52 14:11:28 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;69;68;63;75;72;67;68;68;69;71 14:11:28 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;88;88;88;81;75;100;94;105;105;84 14:11:28 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;148;146;148;147;145;147;152;160;190;136 14:11:28 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;159;171;174;172;172;175;173;171;169;172 14:11:28 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;70;69;69;71;68;69;69;70;69;68 14:11:28 INFO - PROCESS | 1660 | __end_tp_report 14:11:28 INFO - PROCESS | 1660 | __start_cc_report 14:11:28 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2087 14:11:28 INFO - PROCESS | 1660 | __end_cc_report 14:11:28 INFO - PROCESS | 1660 | __startTimestamp1475874688271__endTimestamp 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | ------- Summary: start ------- 14:11:28 INFO - PROCESS | 1660 | Number of tests: 14 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 14:11:28 INFO - PROCESS | 1660 | Values: 111.0 111.0 111.0 111.0 111.0 111.0 111.0 111.0 110.0 109.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:114.00 stddev:17.13 (15.0%) stddev-sans-first:14.87 14:11:28 INFO - PROCESS | 1660 | Values: 152.0 114.0 111.0 149.0 114.0 114.0 114.0 113.0 145.0 114.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:188.40 Median:185.00 stddev:14.80 (8.0%) stddev-sans-first:15.65 14:11:28 INFO - PROCESS | 1660 | Values: 185.0 184.0 186.0 187.0 185.0 181.0 230.0 184.0 179.0 183.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:66.90 Median:60.00 stddev:12.91 (21.5%) stddev-sans-first:12.48 14:11:28 INFO - PROCESS | 1660 | Values: 82.0 60.0 59.0 90.0 60.0 59.0 58.0 60.0 84.0 57.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:82.00 stddev:10.52 (12.8%) stddev-sans-first:10.35 14:11:28 INFO - PROCESS | 1660 | Values: 89.0 75.0 89.0 69.0 69.0 70.0 92.0 67.0 69.0 89.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.50 stddev:1.99 (2.3%) stddev-sans-first:2.00 14:11:28 INFO - PROCESS | 1660 | Values: 87.0 83.0 86.0 84.0 87.0 84.0 87.0 83.0 88.0 83.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:95.00 stddev:2.28 (2.4%) stddev-sans-first:2.39 14:11:28 INFO - PROCESS | 1660 | Values: 95.0 94.0 95.0 95.0 102.0 96.0 97.0 97.0 95.0 95.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:1.22 14:11:28 INFO - PROCESS | 1660 | Values: 85.0 83.0 87.0 84.0 85.0 84.0 86.0 84.0 84.0 85.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:1.17 (2.2%) stddev-sans-first:0.78 14:11:28 INFO - PROCESS | 1660 | Values: 56.0 52.0 53.0 53.0 54.0 54.0 53.0 53.0 54.0 52.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:3.20 (4.6%) stddev-sans-first:3.39 14:11:28 INFO - PROCESS | 1660 | Values: 69.0 68.0 63.0 75.0 72.0 67.0 68.0 68.0 69.0 71.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:86.00 stddev:10.08 (11.7%) stddev-sans-first:10.64 14:11:28 INFO - PROCESS | 1660 | Values: 88.0 88.0 88.0 81.0 75.0 100.0 94.0 105.0 105.0 84.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:148.00 stddev:14.65 (9.9%) stddev-sans-first:15.47 14:11:28 INFO - PROCESS | 1660 | Values: 148.0 146.0 148.0 147.0 145.0 147.0 152.0 160.0 190.0 136.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:172.00 stddev:4.47 (2.6%) stddev-sans-first:1.76 14:11:28 INFO - PROCESS | 1660 | Values: 159.0 171.0 174.0 172.0 172.0 175.0 173.0 171.0 169.0 172.0 14:11:28 INFO - PROCESS | 1660 | 14:11:28 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 14:11:28 INFO - PROCESS | 1660 | Values: 70.0 69.0 69.0 71.0 68.0 69.0 69.0 70.0 69.0 68.0 14:11:28 INFO - PROCESS | 1660 | -------- Summary: end -------- 14:11:28 INFO - PROCESS | 1660 | 14:11:29 INFO - TEST-INFO | 1660: exit 0 14:11:29 INFO - TEST-OK | kraken | took 59457ms 14:11:29 INFO - SUITE-END | took 1178s 14:11:29 INFO - Completed test suite (00:19:38) 14:11:29 INFO - javascript benchmark 14:11:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3178.856951437185, 3325.8835940742065, 3364.8317584120787, 3385.6614338566133, 3397.0318459239106, 5224.719943613811, 5349.43830897755, 5735.139729040646, 5824.534037277018, 5863.560232982522, 5738.254026976498, 5746.9712651436685, 5795.449432303935, 5826.766929322833, 5833.970830145854, 5081.187010078388, 5166.9224961625605, 5196.168613021917, 5216.504432078966, 5257.710825904593, 5296.496832800897, 5310.256564081032, 5314.202869569576, 5325.281087053237, 5325.360956685184, 5279.736013199325, 5293.6294459387855, 5315.01672190646, 5338.91991620126, 5344.973275133619, 5178.0679477694, 5216.947830521684, 5222.2427747976335, 5253.737313134328, 5263.921041184385, 5163.432022477525, 5193.221016847466, 5203.947960520384, 5216.895662086737, 5222.2427747976335, 5647.43525647436, 5676.3188417389765, 5723.484886360247, 5733.455321744427, 5791.594588378815, 6161.599496032743, 6231.4391704746795, 6235.9376406235815, 6237.282712488031, 6276.686165691697, 6183.783567575113, 6311.463525600329, 6318.241810982711, 6326.177596912372, 6332.461740752042, 4745.383100196952, 5731.484166425042, 5755.0, 5831.679257640871, 5858.121281807763, 6207.324022513896, 6230.43926046658, 6244.438000579969, 6288.339724328971, 6296.212973378328, 6140.293866205354, 6158.137860699506, 6167.0, 6170.228721409824, 6175.752969881244, 5332.973335133377, 6112.290716697417, 6286.497080233662, 6287.874242515124, 6290.748370065146, 6145.555794388315, 6154.599951003171, 6206.317305096436, 6217.036359364306, 6263.749450022039, 6274.749010039547, 6288.402601752826, 6290.4653104485715, 6303.842403939938, 6312.274088479883, 4900.975495122501, 4971.204607262821, 4981.452040275567, 4985.775640096204, 4992.05151021312, 4391.7584532851, 4403.405540252089, 4419.42547468827, 4434.201843668171, 4478.2610869206865, 5741.942580574224, 5743.282089738783, 5747.712614369265, 5799.0, 5801.361850196559, 6259.561830671809, 6288.937110628835, 6289.119523266746, 6298.0, 6304.968475157595, 4770.332153498513, 5665.235193248858, 5707.1724599933605, 5720.370759216483, 5753.798617048383, 5423.647462914977, 5446.7276636168035, 5476.479734425223, 5510.338759348904, 5515.979543784413, 6322.241331040213, 6329.810105696836, 6331.493480521639, 6343.55595108338, 6349.904751428639, 5072.391313042459, 6117.188044311343, 6330.968345158245, 6339.017452294902, 6356.046593011085, 5628.971855140698, 6130.356312587114, 6230.844228894314, 6242.250929888442, 6327.873442531216, 6228.159198508325, 6230.127782110599, 6249.562530622813, 6249.718762655601, 6250.499960003098, 6230.7507699691505, 6278.591891527036, 6287.937120628918, 6311.368863113652, 6313.621182728867, 6028.065649824284, 6084.665343406155, 6107.755689772537, 6109.16175461965, 6118.60229085108, 6033.276006879202, 6146.432659671755, 6161.44546990773, 6171.413715697002, 6179.6910154493, 5149.6910185389, 5872.0898260769645, 5902.173695682522, 6014.879702405839, 6036.63780173191, 5958.612690175298, 6050.576459647782, 6108.251008765869, 6123.265208174869, 6136.785212517719, 6005.6396616203165, 6022.397760223943, 6054.212952316171, 6077.878442431038, 6118.021116621319], "value": 5696.9323529498615, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.47869736776386, 524.1090146750524, 529.5869222006834, 536.7933345661921, 550.3973149401404, 30319.696803031962, 39727.801360993224, 40932.18135637293, 40997.79501102498, 43038.35442468365, 41413.58586414135, 41868.58131418685, 41902.58097419025, 41985.0, 42017.57982420175, 9707.854382184272, 9887.505624718771, 9916.157126644244, 9917.206623470141, 9927.453990030546, 9622.326437149402, 9722.513874306256, 9724.951375243114, 9727.27045471589, 9737.0, 9699.321047526675, 9757.658481953133, 9760.4631745254, 9779.75550611237, 9794.706158815246, 9666.613335466573, 9730.075642813992, 9733.805323893554, 9737.513124343754, 9749.951250243703, 9699.466529340883, 9765.511724413751, 9769.853452198222, 9769.90230097697, 9772.071653192936, 40342.0, 40653.390199147034, 40660.39009414861, 40707.7964610178, 40812.591874081474, 3206.679332066798, 3410.1645096951156, 3613.7109031277437, 3845.288621605012, 3913.217356528677, 30258.199302272133, 30731.385372292654, 30831.383372332428, 31330.0, 31721.0, 3167.9366412671616, 3180.8250546219947, 3208.631007434152, 3210.9036728897936, 3320.2031512437084, 457992.0, 464025.0, 466297.6685116587, 467992.0, 470044.64977675234, 56727.71636141875, 57059.42940570624, 57095.0, 57177.0, 57208.42791572114, 34087.65912340845, 58111.0, 58124.8375032497, 58150.709246453494, 58188.12717809236, 15466.690666186612, 16124.75812862808, 16136.515904522883, 16176.67646647084, 16201.108939008232, 12270.938645306895, 12382.81425778614, 12391.380430978415, 12402.007839372829, 12418.627441176779, 15184.772228416583, 18519.44441666725, 18519.44441666752, 18541.907290463463, 18557.072146392627, 7702.961485192538, 7832.159442531, 7836.647350869224, 7900.604969751489, 7945.721899733481, 861.5003298087095, 962.3744566031995, 968.6416026070399, 990.1880458024494, 1081.3065042224516, 29790.702092979227, 30237.0, 30481.390372192433, 30931.226719331746, 31598.842005789826, 961.0197598449543, 1010.8526822057019, 1032.726327523207, 1110.889110889111, 1115.8493603363604, 14588.416463341347, 15018.098914065191, 15021.69956600862, 15158.0, 15428.768568471482, 659957.0, 935439.8420118518, 946073.0, 947274.0, 948933.0, 54549.0, 55174.0, 55203.44796552063, 55294.0, 55393.723031385394, 1237.3318408059727, 1272.4337669737063, 1336.9732605347838, 1368.705728268427, 1379.7585422551012, 26133.607995879698, 28852.855735721187, 29489.0, 29783.0, 31768.682313177498, 51847.48152518577, 55171.72414137904, 56055.59861003508, 56106.8778624417, 56154.71922640524, 568622.1568892129, 582990.0, 613318.0, 618125.0, 618187.0, 34697.826510867286, 34742.82628586841, 42003.57996419997, 42180.78909605432, 42403.0, 40152.0, 46404.0, 46614.76692616515, 46686.76656616831, 47322.29016564685, 38364.04089897775, 38367.9683185654, 38479.422808657335, 39541.60458395494, 39710.80144599258, 38389.80805095957, 38588.42117368298, 38821.6117838818, 39419.0, 39688.80155599204, 37257.0, 37778.0, 38399.80800095982, 38435.42346864855, 38446.615533844306, 31580.052598422084, 33316.1670958228, 33921.660783392836, 34119.82940085284, 34153.146171345914, 23866.642000370357, 24966.62550061787, 25226.36934076663, 25478.23565293044, 25531.723413829604], "value": 20264.434289795623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.00336498915715, 349.76041411633025, 372.5510759534761, 379.29261926507064, 403.21373322022043, 13525.594232173038, 15045.172515511656, 16013.119278439695, 20485.07817148228, 21046.473838154056, 19307.420777376665, 19904.303349382775, 20345.389638310837, 20562.588748225025, 20786.272480463187, 5768.653880767147, 6097.817065488042, 6104.08438734189, 6109.389061093877, 6113.0, 4881.511848815107, 6680.164979377578, 6748.257691653914, 6795.286494918037, 6805.387515123638, 5701.631608413972, 6037.849053773647, 6701.894187459064, 6739.157605299338, 6749.527533072687, 6072.392760723937, 6104.786332478387, 6117.113018612298, 6118.174046503709, 6122.908156377658, 5723.828285151452, 5785.074388097926, 5953.553483488756, 5954.0, 5967.16459695643, 12871.935640321832, 13120.015998800129, 13137.802932956014, 23618.763812361827, 24515.264542063767, 2135.7437107547194, 2261.570301642699, 2351.6237402015768, 2391.928242152738, 2667.5865240887692, 8415.368847336413, 9269.72190834276, 9545.284103692251, 10080.596776128947, 10243.641472548425, 1756.4379398592455, 1833.7249412588085, 1840.125940178418, 1879.1637721214065, 1884.5006073390562, 118065.0, 128864.0, 132714.0, 134281.6571834279, 135513.28973420575, 8476.449030812977, 9413.435193888388, 9947.502624868728, 11304.604338848101, 11394.202405831513, 14222.0, 14241.85758142426, 14278.214698191492, 14278.787272863523, 14308.785368219485, 8189.672413103528, 8342.83314333722, 8372.079071302152, 8382.958085209535, 8561.357898157663, 8265.545395003333, 8314.916850831414, 8434.831303373898, 8461.407701460961, 8478.915210847936, 4320.330348795942, 4437.800298986554, 4444.644428445717, 4521.570450807168, 4534.6372290216705, 1833.7891142518515, 1868.8349245335319, 1893.1670065171281, 1899.6960486322123, 1947.8441724661993, 836.3852568362249, 844.7930257087053, 908.5638893331106, 912.6167009855876, 921.801812610292, 20318.187272508934, 20505.38483845487, 21490.14039438405, 21555.892220538797, 21569.568608628055, 893.2496702769705, 924.200566509964, 944.2823454174877, 989.4656885282011, 1044.3107549017611, 10627.415492147851, 11139.80191690098, 11180.832287515694, 11299.717507062389, 11317.49071291794, 557255.0, 579801.0, 590121.0, 594051.0, 617251.0, 131315.0, 133758.0, 137585.312073441, 139868.0, 139953.0, 962.2927148545813, 977.1938151025432, 988.0662773678948, 989.3223142147652, 989.980200395988, 14817.0, 18616.906915465337, 18778.342758003404, 18943.0, 19020.904895475433, 54329.0, 54586.181207282716, 55793.0, 55815.0, 57525.424745753684, 72941.0, 73162.63418682873, 74891.0, 75696.0, 76515.46969060699, 6607.306232845482, 7836.647350869339, 7879.251471110236, 8073.878891816745, 8218.054923683852, 9102.772430689285, 11936.164468487123, 12037.398130093636, 12296.631101066982, 12844.935775321064, 8570.871436928575, 10298.948505257425, 11208.159388045766, 11291.661250162508, 11324.6036388726, 10176.542055607664, 11044.723881903017, 11220.887791121984, 11396.259243149168, 11517.42412879336, 8261.463004904663, 9859.816821981409, 10871.075958543612, 11552.6534203974, 11729.530818767495, 7954.323882470055, 7956.9602151988865, 8043.919560804551, 8184.831019779882, 8235.34117270605, 10548.314359566604, 10778.191635627203, 10846.0, 11204.0, 11425.885741142814], "value": 9388.42623308926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.747151776922, 1486.7844162596423, 1545.5672411724713, 1751.8686098542605, 1920.1743250402321, 7939.206079392058, 8406.243438090578, 8740.956295218522, 9030.86453703195, 9031.187193152631, 8774.780630484242, 8880.689175878846, 8896.466212027266, 8909.020007799138, 8914.420562663423, 2349.3656712687566, 2382.940426489334, 2383.7020372453444, 2385.916492922748, 2388.2238272561485, 2335.089315167086, 2360.634101714237, 2367.4318163640687, 2371.205646108556, 2392.5932591459405, 2348.377679914824, 2371.905123795046, 2380.131252092991, 2381.142788596104, 2382.4758553118286, 2331.6152834782242, 2335.8131349492, 2372.4543355028354, 2375.394274460019, 2379.7382287948312, 2033.8169564739096, 2332.4052366646397, 2341.2156927429332, 2375.643653451979, 2378.940526486834, 8825.205731484133, 8832.911670883273, 8920.018797932222, 8922.0, 8941.910580894173, 4490.640748740093, 5366.06093933564, 5367.46325367464, 5391.29913111293, 5399.082156033483, 3470.9132271693156, 3629.328574213779, 3684.797336146511, 3685.2261025184744, 3698.9260214795822, 1053.7629033467408, 1086.5870969031716, 1093.0217455377392, 1093.775775965925, 1113.1261959361861, 12007.879921200763, 12085.637430877088, 12145.089118316073, 12163.391830408533, 12191.024718022625, 4371.344298355209, 4441.755703436277, 4641.907161856744, 4652.464966528825, 4686.320483529869, 8974.820503589892, 9027.187553120251, 9282.303827212985, 9291.117343852324, 9305.95347023274, 5159.793608255703, 5250.081235783722, 5259.947400525945, 5269.631125821233, 5298.947010529922, 4142.79286035697, 4379.189849877783, 4547.272436410159, 4562.406887104655, 4933.629977751683, 3237.2392487765355, 3703.6481534254203, 3748.362778327636, 3806.5051543299746, 3818.198178382571, 1027.6454623155, 1148.3454430974264, 1155.1971379891063, 1164.5283660117666, 1165.1727273635645, 825.6273124287234, 847.3221422861686, 892.7723430525175, 900.0954041188694, 937.634322614181, 5610.635308704921, 5755.309362876482, 5902.527797776168, 6036.818895433056, 6052.243469566304, 791.7268542352879, 895.7984453498041, 912.3339961827903, 922.6586163119555, 973.9269554783419, 3774.8867533974026, 3789.7536660117003, 3823.1780167264174, 3915.5497117831246, 3961.623645753649, 10681.092107170822, 10986.285891417032, 11098.61154859576, 11112.277701949348, 11127.221094523306, 11074.280171788809, 11084.390358530198, 11089.0, 11091.223614346918, 11093.389863557582, 7734.381249500027, 8105.959470202493, 8287.544185069759, 8440.11378805229, 8458.36562257833, 5935.525157987437, 5953.502205918665, 5982.760689572542, 6052.848678783065, 6121.816345509642, 8101.311388531805, 9963.651272205438, 9999.30004899679, 10290.12533934624, 10320.380777153396, 9442.347589172005, 10236.641717539851, 10354.482275886025, 10511.57953681844, 10570.471476425993, 6750.1562304711915, 7055.858882822417, 7429.108506979197, 7624.008878845714, 7712.498687585289, 8309.293710034715, 8315.12691167443, 8320.0, 8414.032386275412, 8421.0, 7509.249075092447, 7538.53227515349, 7549.131849837339, 7570.280823321776, 7607.695692172251, 7428.517146385468, 7441.404687625085, 7499.175090740124, 7509.136449308399, 7655.808604784925, 6926.168859736864, 7000.299970002959, 7065.57606543609, 7072.222055573986, 7083.7520686775715, 4867.1969125093965, 4905.337779399735, 4955.628327875496, 5019.7741101651245, 5167.173252279617, 4960.330355401975, 4975.203967365204, 4999.675021123615, 5036.118679231193, 5201.375834899836], "value": 4561.42295909765, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.658842331319, 306.8370874386077, 308.6681817046674, 313.6628124765877, 315.0532649388587, 4584.083183363324, 5145.716985565792, 5178.384915617613, 5190.948090519094, 5210.661307015046, 4810.735409552473, 4871.001444703836, 5162.948370516303, 5170.689758614486, 5177.559907407875, 2940.397483371557, 3091.4435401627698, 3520.331137083946, 3721.7394782365245, 3744.7191460640424, 3276.2464633134396, 3975.0062484378905, 4003.8198281077275, 4008.599140085997, 4037.5356833964174, 3426.5031570422275, 3827.483289755889, 3945.0, 3945.644891959723, 3972.960270397288, 3301.6533264007176, 3599.2441587266703, 3900.8634697785724, 3955.940660890089, 3975.7216994810374, 3457.481377793326, 3470.930581388358, 3481.9206046125782, 3483.9967018963944, 3492.1793378556017, 4008.498937632796, 4153.7300075494995, 4517.661175411825, 5013.8718788272345, 5048.697078175322, 3807.477009196316, 3959.6641677363527, 4098.6516146127615, 4503.482099558527, 4523.36672865799, 4709.882252943669, 4806.975965120187, 5384.5692344612335, 5422.620416570841, 5441.15000899696, 3819.7708137511836, 3828.3109040372724, 3830.080780612661, 3850.5764365919727, 3882.475865758143, 4984.451710311862, 5006.599472042228, 5564.998300305943, 5689.9146512802345, 5728.140778883159, 3095.334503081803, 3778.7165962552917, 3821.910755434688, 3824.4050592443014, 3831.750936189139, 3393.966060339365, 3807.629253468749, 3874.6900247980093, 3890.8832735017995, 3892.6107389261415, 4465.397171381886, 4470.284754439274, 4473.0, 4543.4775000875325, 4556.97721511397, 4542.705933503559, 4737.407824021997, 5180.740962951837, 5421.620486565903, 5542.334919809568, 1135.2573799218326, 1219.9935053580832, 1270.314030423561, 1290.445108603291, 1301.4208677138583, 768.5619197057736, 779.6608475313257, 786.984260314802, 789.124072279769, 796.7211475983476, 4059.518275829301, 4867.902641947141, 5054.873628159252, 5056.797728090835, 5068.265101560253, 5480.876420333822, 5543.8891222176135, 5573.637713548606, 5694.544436445074, 5708.914366284509, 4795.832145874878, 4815.855524334275, 5136.4606716295, 5138.743062846843, 5185.662931909414, 2650.443406884576, 2922.8392438415667, 2933.911982640524, 2934.8679309431127, 2937.8677959491874, 4830.589399900978, 4841.288878228203, 5326.6005049621435, 5404.459554044564, 5747.310322761212, 4296.505901821268, 5664.631798933056, 5692.104789880699, 5716.885662286731, 5784.4504772046585, 4739.075880203327, 5742.655440673573, 5745.971270143623, 5763.7982670606325, 5824.912626310609, 4901.411830580353, 5538.280023596906, 5553.305836770403, 5587.245721827501, 5610.214569960127, 5227.634065615371, 5432.402435731988, 5519.957615682223, 5529.668219906818, 5550.916736248879, 5729.71351432435, 5736.942630573808, 5771.826845194483, 5782.942170578241, 5797.362290147996, 3475.3049390121573, 3504.281622267378, 3664.248828990104, 3766.472693822922, 3775.2826962876966, 4920.138975679313, 5209.489248118003, 5490.423505531861, 5544.889102218014, 5570.944290557042, 5342.839714808562, 5348.43275227885, 5384.19237114436, 5388.353397592314, 5427.945720542902, 4170.645495132948, 4737.763111844463, 5338.57291416678, 5357.571394288526, 5428.6199966002005, 4649.930515981276, 4668.92996605058, 5276.81531146408, 5282.0984445600325, 5315.920261196163, 5127.359080114986, 5258.710770907637, 5287.444818294024, 5312.442193569774, 5389.21856330822, 4538.773061346986, 5254.395744489279, 5257.237700533477, 5293.247511294183, 5343.118385466354], "value": 3927.099847821879, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.422822144734, 718.0485856240483, 729.2962291388809, 775.9883601745973, 781.316348195329, 12587.811182832265, 15491.380344786223, 15995.280212390428, 16002.59993500163, 16027.919860400696, 14221.502247421342, 14348.856511434882, 14356.856431435683, 14418.990670653058, 14425.42298308069, 682.6382017530692, 701.442353329102, 704.1409480433888, 839.4082172068707, 860.8149247911698, 700.6671830880316, 702.4836744992426, 705.6718625838984, 836.6235194162621, 870.1559487297311, 917.6604656277186, 929.0894922975488, 929.7861491856877, 932.1051790281305, 932.1843387036344, 923.1091996223677, 928.19247254888, 928.3408779766374, 929.159111004542, 929.1776777551847, 536.0538649284017, 690.9136357955256, 691.636890632422, 693.040139406925, 693.9583624982517, 12364.938175309157, 12662.240265584001, 12662.873371266262, 12670.113092083559, 12682.429290681941, 12703.983681305474, 13317.800232996513, 13623.637958287702, 13784.655383615389, 14194.290285485684, 12658.683532911658, 13128.6717832054, 13193.60419187426, 13534.864651353459, 13816.654583635389, 4607.953920460786, 4639.002614437878, 4704.529547045302, 4820.228763397875, 4846.830360937385, 105117.0, 105796.99999999923, 120169.0, 120342.0, 126039.0, 11221.270617409842, 11290.209685322114, 11350.0, 11386.886131138583, 11416.486258118404, 15954.60113497172, 21263.468413289793, 22158.778412215994, 22387.55224895493, 22495.212667556556, 8145.185481451807, 8181.836363272821, 8226.506409615442, 8343.791405214919, 8353.122922093215, 4416.050549131952, 4480.574345437179, 4551.977240113778, 4557.6581756368405, 4653.208954477679, 3050.8016978896744, 3745.9438108428394, 3750.981245093757, 3752.587215406303, 3757.5866654667966, 609.439315829438, 688.1466980943694, 702.6592102830124, 705.7565140026683, 705.8059033765755, 528.3452780999407, 532.9573634109262, 554.9639273447214, 572.6057051080631, 657.3861170825612, 7941.483803552751, 8945.329100317373, 9079.228265597367, 9687.17658998979, 9764.609415623438, 521.4264309259784, 644.2719726708789, 654.1496055128314, 661.9702113404908, 678.6504949950779, 3956.624120708528, 4346.678749072611, 4683.976580117146, 4699.365585645963, 4839.733814640229, 100079.0, 167179.0, 170407.0, 170661.0, 176986.0, 109527.0, 135526.0, 140299.29850350888, 140444.29777851046, 143871.0, 78449.0, 119304.0, 120672.0, 120826.3958680201, 121406.17890731645, 7329.816754581178, 8866.246369058703, 8976.326775491734, 8984.820303594022, 8989.0, 67884.6605766968, 69174.0, 70405.0, 70455.0, 72267.63866180636, 78006.43987120112, 78119.21880781346, 92226.0, 105957.0, 108240.0, 13099.279539625411, 13335.799963000369, 13450.0, 13624.04631675773, 13957.95315351373, 12776.913962312936, 14826.925865370604, 14937.551873443814, 14998.325075371853, 15050.0, 14026.438942442595, 14218.289085545475, 14229.217393043067, 14291.571252862015, 14504.709905801614, 13713.520026799015, 13977.510787122403, 14060.789088163481, 14193.858061419254, 14275.571732848031, 11218.887811121784, 11249.606263781056, 13537.72924541484, 13596.252206128758, 14335.498257560936, 9522.666706665234, 9982.95179006194, 11337.206395552563, 11535.480903359537, 11787.941060294643, 9845.704628861145, 10738.46307684597, 11504.309741415542, 11512.36681982499, 11642.476088575864], "value": 7853.6573469823115, "unit": "score"}], "name": "dromaeo_css", "value": 7309.31785826816, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 111.0, 110.0, 109.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 114.0, 111.0, 149.0, 114.0, 114.0, 114.0, 113.0, 145.0, 114.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 186.0, 187.0, 185.0, 181.0, 230.0, 184.0, 179.0, 183.0], "value": 188.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 90.0, 60.0, 59.0, 58.0, 60.0, 84.0, 57.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 75.0, 89.0, 69.0, 69.0, 70.0, 92.0, 67.0, 69.0, 89.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 84.0, 87.0, 84.0, 87.0, 83.0, 88.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 102.0, 96.0, 97.0, 97.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 87.0, 84.0, 85.0, 84.0, 86.0, 84.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 54.0, 52.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 63.0, 75.0, 72.0, 67.0, 68.0, 68.0, 69.0, 71.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 81.0, 75.0, 100.0, 94.0, 105.0, 105.0, 84.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 148.0, 147.0, 145.0, 147.0, 152.0, 160.0, 190.0, 136.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 171.0, 174.0, 172.0, 172.0, 175.0, 173.0, 171.0, 169.0, 172.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 71.0, 68.0, 69.0, 69.0, 70.0, 69.0, 68.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1438.9, "alertThreshold": 2.0}]} 14:11:29 INFO - Return code: 0 14:11:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:11:29 INFO - # TBPL SUCCESS # 14:11:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:11:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:11:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:11:29 INFO - 2016-10-07 14:11:29.599 screenresolution[1664:9730] starting screenresolution argv=screenresolution get 14:11:29 INFO - 2016-10-07 14:11:29.603 screenresolution[1664:9730] Display 0: 1600x1200x32@60 14:11:29 INFO - 2016-10-07 14:11:29.609 screenresolution[1665:9734] starting screenresolution argv=screenresolution list 14:11:29 INFO - Available Modes on Display 0 14:11:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:11:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:11:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:11:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:11:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:11:29 INFO - Intel Iris: 14:11:29 INFO - Chipset Model: Intel Iris 14:11:29 INFO - Type: GPU 14:11:29 INFO - Bus: Built-In 14:11:29 INFO - VRAM (Dynamic, Max): 1536 MB 14:11:29 INFO - Vendor: Intel (0x8086) 14:11:29 INFO - Device ID: 0x0a2e 14:11:29 INFO - Revision ID: 0x0009 14:11:29 INFO - Displays: 14:11:29 INFO - Display: 14:11:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:11:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:11:29 INFO - Display Serial Number: 1600x1200 60 14:11:29 INFO - Main Display: Yes 14:11:29 INFO - Mirror: Off 14:11:29 INFO - Online: Yes 14:11:29 INFO - Rotation: Supported 14:11:29 INFO - Return code: 0 14:11:29 INFO - Running post-action listener: _resource_record_post_action 14:11:29 INFO - [mozharness: 2016-10-07 21:11:29.847167Z] Finished run-tests step (success) 14:11:29 INFO - Running post-run listener: _resource_record_post_run 14:11:29 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37487616; Write bytes: 708636160; Read time: 241; Write time: 2005 14:11:29 INFO - TinderboxPrint: CPU usage
53.7% 14:11:29 INFO - TinderboxPrint: I/O read bytes / time
37,487,616 / 241 14:11:29 INFO - TinderboxPrint: I/O write bytes / time
708,636,160 / 2,005 14:11:29 INFO - TinderboxPrint: CPU idle
2,247.8 (46.3%) 14:11:29 INFO - TinderboxPrint: CPU system
980.7 (20.2%) 14:11:29 INFO - TinderboxPrint: CPU user
1,629.3 (33.5%) 14:11:29 INFO - TinderboxPrint: Swap in / out
444,993,536 / 0 14:11:29 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395600384; Write bytes: 388282368; Read time: 29615; Write time: 831 14:11:29 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 35668992; Write bytes: 297088512; Read time: 226; Write time: 1121 14:11:30 INFO - Running post-run listener: _upload_blobber_files 14:11:30 INFO - Blob upload gear active. 14:11:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:11:30 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:11:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:11:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:11:30 INFO - (blobuploader) - INFO - Open directory for files ... 14:11:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:11:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:11:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:31 INFO - (blobuploader) - INFO - Done attempting. 14:11:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:11:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:11:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:32 INFO - (blobuploader) - INFO - Done attempting. 14:11:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:11:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:11:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:11:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:11:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:11:36 INFO - (blobuploader) - INFO - Done attempting. 14:11:36 INFO - (blobuploader) - INFO - Iteration through files over. 14:11:36 INFO - Return code: 0 14:11:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:11:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:11:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5c6b09077f4cc6802cc9c5aa696c11c6808c46668002eb0d298448c05ffc5de1dc5f41cf24109c6d4aeb9c0ad6fbdf3b2af5f724b895cbdb8db438c47dee3627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5ea57d075ef84bd57812bf87dcd8f7fced6d104cd23adcf0f1f16419a2fa2ef38e12e541309132d84d0471f1040a5e7d12102f98681e9c6111bfc1d23fa09fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4365bfd730d4c5b6d0bf8d871d658200773633f7b0a5008d219348600a7ed3ed66bcca3def7b715749482ac4ac92cd4318e646d2a9b2ff5a7f949b1a4d3bcfad"} 14:11:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:11:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:11:36 INFO - Contents: 14:11:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5c6b09077f4cc6802cc9c5aa696c11c6808c46668002eb0d298448c05ffc5de1dc5f41cf24109c6d4aeb9c0ad6fbdf3b2af5f724b895cbdb8db438c47dee3627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5ea57d075ef84bd57812bf87dcd8f7fced6d104cd23adcf0f1f16419a2fa2ef38e12e541309132d84d0471f1040a5e7d12102f98681e9c6111bfc1d23fa09fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4365bfd730d4c5b6d0bf8d871d658200773633f7b0a5008d219348600a7ed3ed66bcca3def7b715749482ac4ac92cd4318e646d2a9b2ff5a7f949b1a4d3bcfad"} 14:11:36 INFO - Running post-run listener: copy_logs_to_upload_dir 14:11:36 INFO - Copying logs to upload dir... 14:11:36 INFO - mkdir: /builds/slave/test/build/upload/logs 14:11:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.056543 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-07 14:11:36.178289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 14:11:36.182432) ========= 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.SkBknYAE9d/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.93Ay11bxhZ/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/Larch/sha512/5c6b09077f4cc6802cc9c5aa696c11c6808c46668002eb0d298448c05ffc5de1dc5f41cf24109c6d4aeb9c0ad6fbdf3b2af5f724b895cbdb8db438c47dee3627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5ea57d075ef84bd57812bf87dcd8f7fced6d104cd23adcf0f1f16419a2fa2ef38e12e541309132d84d0471f1040a5e7d12102f98681e9c6111bfc1d23fa09fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4365bfd730d4c5b6d0bf8d871d658200773633f7b0a5008d219348600a7ed3ed66bcca3def7b715749482ac4ac92cd4318e646d2a9b2ff5a7f949b1a4d3bcfad"} build_url:https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5c6b09077f4cc6802cc9c5aa696c11c6808c46668002eb0d298448c05ffc5de1dc5f41cf24109c6d4aeb9c0ad6fbdf3b2af5f724b895cbdb8db438c47dee3627", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/5ea57d075ef84bd57812bf87dcd8f7fced6d104cd23adcf0f1f16419a2fa2ef38e12e541309132d84d0471f1040a5e7d12102f98681e9c6111bfc1d23fa09fb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/4365bfd730d4c5b6d0bf8d871d658200773633f7b0a5008d219348600a7ed3ed66bcca3def7b715749482ac4ac92cd4318e646d2a9b2ff5a7f949b1a4d3bcfad"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 14:11:36.220126) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 14:11:36.220723) ========= 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.SkBknYAE9d/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.93Ay11bxhZ/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.005242 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 14:11:36.270933) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 14:11:36.271307) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 14:11:36.271708) ========= ========= Total master_lag: 0.18 =========