builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0303 starttime: 1479853649.99 results: success (0) buildid: 20161122113650 builduid: f73688ebcd404696896c5ac2efeb46d0 revision: 4cf8741bb86f96dcb62dc98594f109e7ed2733a1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:29.994326) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:29.994695) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:29.994970) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:30.028981) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:30.029367) ========= 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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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-11-22 14:27:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.6M=0s 2016-11-22 14:27:30 (25.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123216 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:30.179616) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:30.179939) ========= 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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.025166 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:30.228108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 14:27:30.231479) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 4cf8741bb86f96dcb62dc98594f109e7ed2733a1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 4cf8741bb86f96dcb62dc98594f109e7ed2733a1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oJINOobP5Z/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.sMbgg5Gt2y/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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-11-22 14:27:30,322 truncating revision to first 12 chars 2016-11-22 14:27:30,323 Setting DEBUG logging. 2016-11-22 14:27:30,323 attempt 1/10 2016-11-22 14:27:30,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/4cf8741bb86f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 14:27:31,419 unpacking tar archive at: graphics-4cf8741bb86f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.353279 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 14:27:31.611318) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:31.611647) ========= script_repo_revision: 4cf8741bb86f96dcb62dc98594f109e7ed2733a1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:31.612032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:31.612319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 14:27:31.631997) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-11-22 14:27:31.632317) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oJINOobP5Z/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.sMbgg5Gt2y/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:27:31 INFO - MultiFileLogger online at 20161122 14:27:31 in /builds/slave/test 14:27:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 14:27:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:27:31 INFO - {'append_to_log': False, 14:27:31 INFO - 'base_work_dir': '/builds/slave/test', 14:27:31 INFO - 'blob_upload_branch': 'Graphics', 14:27:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:27:31 INFO - 'branch': 'Graphics', 14:27:31 INFO - 'buildbot_json_path': 'buildprops.json', 14:27:31 INFO - 'config_files': ('talos/mac_config.py',), 14:27:31 INFO - 'default_actions': ('clobber', 14:27:31 INFO - 'read-buildbot-config', 14:27:31 INFO - 'download-and-extract', 14:27:31 INFO - 'populate-webroot', 14:27:31 INFO - 'create-virtualenv', 14:27:31 INFO - 'install', 14:27:31 INFO - 'run-tests'), 14:27:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:27:31 INFO - 'download_minidump_stackwalk': True, 14:27:31 INFO - 'download_symbols': 'ondemand', 14:27:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:27:31 INFO - 'tooltool.py': '/tools/tooltool.py', 14:27:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:27:31 INFO - '/tools/misc-python/virtualenv.py')}, 14:27:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:27:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:27:31 INFO - 'installer_path': 'installer.exe', 14:27:31 INFO - 'log_level': 'info', 14:27:31 INFO - 'log_name': 'talos', 14:27:31 INFO - 'log_to_console': True, 14:27:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:27:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:27:31 INFO - 'opt_config_files': (), 14:27:31 INFO - 'pip_index': False, 14:27:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:27:31 INFO - 'cmd': ('bash', 14:27:31 INFO - '-c', 14:27:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:27:31 INFO - 'enabled': True, 14:27:31 INFO - 'halt_on_failure': False, 14:27:31 INFO - 'name': 'check_screen_resolution'},), 14:27:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:27:31 INFO - 'cmd': ('bash', 14:27:31 INFO - '-c', 14:27:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:27:31 INFO - 'enabled': True, 14:27:31 INFO - 'halt_on_failure': False, 14:27:31 INFO - 'name': 'check_screen_resolution'},), 14:27:31 INFO - 'run_cmd_checks_enabled': True, 14:27:31 INFO - 'sps_profile': False, 14:27:31 INFO - 'sps_profile_interval': 0, 14:27:31 INFO - 'suite': 'dromaeojs', 14:27:31 INFO - 'system_bits': '32', 14:27:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:27:31 INFO - 'title': 't-yosemite-r7-0303', 14:27:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:27:31 INFO - 'use_talos_json': True, 14:27:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:27:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:27:31 INFO - 'work_dir': 'build'} 14:27:31 INFO - [mozharness: 2016-11-22 22:27:31.832463Z] Running clobber step. 14:27:31 INFO - Running pre-action listener: _resource_record_pre_action 14:27:31 INFO - Running main action method: clobber 14:27:31 INFO - rmtree: /builds/slave/test/build 14:27:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:27:34 INFO - Running post-action listener: _resource_record_post_action 14:27:34 INFO - [mozharness: 2016-11-22 22:27:34.251309Z] Finished clobber step (success) 14:27:34 INFO - [mozharness: 2016-11-22 22:27:34.251554Z] Running read-buildbot-config step. 14:27:34 INFO - Running pre-action listener: _resource_record_pre_action 14:27:34 INFO - Running main action method: read_buildbot_config 14:27:34 INFO - Using buildbot properties: 14:27:34 INFO - { 14:27:34 INFO - "project": "", 14:27:34 INFO - "product": "firefox", 14:27:34 INFO - "script_repo_revision": "default", 14:27:34 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 14:27:34 INFO - "repository": "", 14:27:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 14:27:34 INFO - "buildid": "20161122113650", 14:27:34 INFO - "pgo_build": "False", 14:27:34 INFO - "basedir": "/builds/slave/test", 14:27:34 INFO - "buildnumber": 3, 14:27:34 INFO - "slavename": "t-yosemite-r7-0303", 14:27:34 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:27:34 INFO - "platform": "yosemite_r7", 14:27:34 INFO - "scheduler": "tests-graphics-macosx64-talos", 14:27:34 INFO - "branch": "graphics", 14:27:34 INFO - "repo_path": "projects/graphics", 14:27:34 INFO - "revision": "4cf8741bb86f96dcb62dc98594f109e7ed2733a1", 14:27:34 INFO - "stage_platform": "macosx64", 14:27:34 INFO - "builduid": "f73688ebcd404696896c5ac2efeb46d0", 14:27:34 INFO - "slavebuilddir": "test" 14:27:34 INFO - } 14:27:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 14:27:34 INFO - Running post-action listener: _resource_record_post_action 14:27:34 INFO - [mozharness: 2016-11-22 22:27:34.257058Z] Finished read-buildbot-config step (success) 14:27:34 INFO - [mozharness: 2016-11-22 22:27:34.257272Z] Running download-and-extract step. 14:27:34 INFO - Running pre-action listener: _resource_record_pre_action 14:27:34 INFO - Running main action method: download_and_extract 14:27:34 INFO - mkdir: /builds/slave/test/build/tests 14:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:27:34 INFO - trying https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 14:27:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:27:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 14:27:35 INFO - Downloaded 1199 bytes. 14:27:35 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:27:35 INFO - Using the following test package requirements: 14:27:35 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:27:35 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:27:35 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 14:27:35 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:27:35 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 14:27:35 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:27:35 INFO - u'jsshell-mac.zip'], 14:27:35 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:27:35 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 14:27:35 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:27:35 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:27:35 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 14:27:35 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:27:35 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 14:27:35 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:27:35 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 14:27:35 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:27:35 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 14:27:35 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:27:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:27:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:27:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:27:36 INFO - Http code: 200 14:27:36 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 14:27:36 INFO - x-amz-cf-id: ICN3FcXY5yhgoWdeeJe3tm7GRaEClmCtILVEGv5a3HJGLz74xOdL_Q== 14:27:36 INFO - x-amz-version-id: 9QdWe88bhJonvVB2X6_EwShBvWC5MU97 14:27:37 INFO - Expected file size: 16248451 14:27:37 INFO - Obtained file size: 16248451 14:27:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:27:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:27:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:27:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:27:44 INFO - Http code: 200 14:27:44 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 14:27:44 INFO - x-amz-cf-id: D1h9yeI18Uivt7Tg1hE7fCCh1t3ntrRskdjAdZ86dc3o2-US78la9w== 14:27:44 INFO - x-amz-version-id: 9QdWe88bhJonvVB2X6_EwShBvWC5MU97 14:27:45 INFO - Expected file size: 16248451 14:27:45 INFO - Obtained file size: 16248451 14:27:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 14:27:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:27:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 14:27:52 INFO - Http code: 200 14:27:52 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 14:27:52 INFO - x-amz-cf-id: iXVLT8zTpUtqk-G-D6xR2QkNniPggDG3BH4aI3FiVmmnd5VJmtWubg== 14:27:52 INFO - x-amz-version-id: nTbaFWNf4sgO.XB3fY4MrSznt4zQCqvd 14:27:53 INFO - Expected file size: 14409392 14:27:53 INFO - Obtained file size: 14409392 14:27: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')]} 14:27:53 INFO - trying https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 14:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 14:27:57 INFO - Downloaded 107618658 bytes. 14:27:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:27:57 INFO - mkdir: /builds/slave/test/properties 14:27:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:27:57 INFO - Writing to file /builds/slave/test/properties/build_url 14:27:57 INFO - Contents: 14:27:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:27:58 INFO - Running post-action listener: _resource_record_post_action 14:27:58 INFO - Running post-action listener: set_extra_try_arguments 14:27:58 INFO - [mozharness: 2016-11-22 22:27:58.412863Z] Finished download-and-extract step (success) 14:27:58 INFO - [mozharness: 2016-11-22 22:27:58.413017Z] Running populate-webroot step. 14:27:58 INFO - Running pre-action listener: _resource_record_pre_action 14:27:58 INFO - Running main action method: populate_webroot 14:27:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:27:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:27:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:27:58 INFO - '--tppagecycles', 14:27:58 INFO - '7'], 14:27:58 INFO - 'tests': ['tsvgm']}}, 14:27:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:27:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:27:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:27:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:27:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:27:58 INFO - 'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:27:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:27:58 INFO - 'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['damp', 'tps']}, 14:27:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:27:58 INFO - 'tests': ['damp', 'tps']}, 14:27:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['dromaeo_dom']}, 14:27:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:27:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['basic_compositor_video']}, 14:27:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:27:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['a11yr', 14:27:58 INFO - 'ts_paint', 14:27:58 INFO - 'tpaint', 14:27:58 INFO - 'sessionrestore', 14:27:58 INFO - 'sessionrestore_no_auto_restore', 14:27:58 INFO - 'tabpaint']}, 14:27:58 INFO - 'other-e10s': {'tests': ['a11yr', 14:27:58 INFO - 'ts_paint', 14:27:58 INFO - 'tpaint', 14:27:58 INFO - 'sessionrestore', 14:27:58 INFO - 'sessionrestore_no_auto_restore', 14:27:58 INFO - 'tabpaint']}, 14:27:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:27:58 INFO - 'ts_paint', 14:27:58 INFO - 'tpaint', 14:27:58 INFO - 'sessionrestore', 14:27:58 INFO - 'sessionrestore_no_auto_restore', 14:27:58 INFO - 'tabpaint']}, 14:27:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:27:58 INFO - 'ts_paint', 14:27:58 INFO - 'tpaint', 14:27:58 INFO - 'sessionrestore', 14:27:58 INFO - 'sessionrestore_no_auto_restore', 14:27:58 INFO - 'tabpaint']}, 14:27:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['a11yr', 14:27:58 INFO - 'ts_paint', 14:27:58 INFO - 'tpaint', 14:27:58 INFO - 'sessionrestore', 14:27:58 INFO - 'sessionrestore_no_auto_restore', 14:27:58 INFO - 'tabpaint']}, 14:27:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['a11yr', 14:27:58 INFO - 'ts_paint', 14:27:58 INFO - 'tpaint', 14:27:58 INFO - 'sessionrestore', 14:27:58 INFO - 'sessionrestore_no_auto_restore', 14:27:58 INFO - 'tabpaint']}, 14:27:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['tsvgx', 14:27:58 INFO - 'tsvgr_opacity', 14:27:58 INFO - 'tart', 14:27:58 INFO - 'tscrollx', 14:27:58 INFO - 'cart']}, 14:27:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:27:58 INFO - 'tsvgr_opacity', 14:27:58 INFO - 'tart', 14:27:58 INFO - 'tscrollx', 14:27:58 INFO - 'cart']}, 14:27:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:27:58 INFO - 'talos_options': ['--disable-e10s'], 14:27:58 INFO - 'tests': ['tp5o']}, 14:27:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:27:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:27:58 INFO - 'talos_options': ['--disable-e10s', 14:27:58 INFO - '--xperf_path', 14:27:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:58 INFO - 'tests': ['tp5n']}, 14:27:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:27:58 INFO - 'talos_options': ['--xperf_path', 14:27:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:58 INFO - 'tests': ['tp5n']}}, 14:27:58 INFO - 'talos.zip': {'path': '', 14:27:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:27:58 INFO - Running post-action listener: _resource_record_post_action 14:27:58 INFO - [mozharness: 2016-11-22 22:27:58.430380Z] Finished populate-webroot step (success) 14:27:58 INFO - [mozharness: 2016-11-22 22:27:58.430515Z] Running create-virtualenv step. 14:27:58 INFO - Running pre-action listener: _resource_record_pre_action 14:27:58 INFO - Running main action method: create_virtualenv 14:27:58 INFO - Creating virtualenv /builds/slave/test/build/venv 14:27:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:27:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:27:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:27:58 INFO - Using real prefix '/tools/python27' 14:27:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:27:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:28:02 INFO - Installing pip.................done. 14:28:02 INFO - Return code: 0 14:28:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:28:02 INFO - Reading from file tmpfile_stdout 14:28:02 INFO - Output received: 14:28:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:28:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:02 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 0x105fee3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f64570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e1db89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, '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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:28:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:28:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:02 INFO - 'HOME': '/Users/cltbld', 14:28:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:02 INFO - 'LOGNAME': 'cltbld', 14:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:02 INFO - 'MOZ_NO_REMOTE': '1', 14:28:02 INFO - 'NO_EM_RESTART': '1', 14:28:02 INFO - 'PAGER': '/bin/cat', 14:28:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:02 INFO - 'PWD': '/builds/slave/test', 14:28:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:02 INFO - 'SHELL': '/bin/bash', 14:28:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:28:02 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:28:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:02 INFO - 'USER': 'cltbld', 14:28:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:02 INFO - 'XPC_FLAGS': '0x0', 14:28:02 INFO - 'XPC_SERVICE_NAME': '0', 14:28:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:28:02 INFO - Cleaning up... 14:28:02 INFO - Return code: 0 14:28:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:02 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 0x105fee3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f64570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e1db89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, '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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:28:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:28:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:28:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:02 INFO - 'HOME': '/Users/cltbld', 14:28:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:02 INFO - 'LOGNAME': 'cltbld', 14:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:02 INFO - 'MOZ_NO_REMOTE': '1', 14:28:02 INFO - 'NO_EM_RESTART': '1', 14:28:02 INFO - 'PAGER': '/bin/cat', 14:28:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:02 INFO - 'PWD': '/builds/slave/test', 14:28:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:02 INFO - 'SHELL': '/bin/bash', 14:28:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:28:02 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:28:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:02 INFO - 'USER': 'cltbld', 14:28:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:02 INFO - 'XPC_FLAGS': '0x0', 14:28:02 INFO - 'XPC_SERVICE_NAME': '0', 14:28:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:02 INFO - Downloading/unpacking psutil>=3.1.1 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:28:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:06 INFO - Installing collected packages: psutil 14:28:06 INFO - Running setup.py install for psutil 14:28:06 INFO - building 'psutil._psutil_osx' extension 14:28:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:28:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:28:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:28:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:28:07 INFO - building 'psutil._psutil_posix' extension 14:28:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:28:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:28:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:28:07 INFO - ^ 14:28:07 INFO - 1 warning generated. 14:28:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:28:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:28:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:28:07 INFO - Successfully installed psutil 14:28:07 INFO - Cleaning up... 14:28:07 INFO - Return code: 0 14:28:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:07 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 0x105fee3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f64570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e1db89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, '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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:28:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:28:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:28:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:07 INFO - 'HOME': '/Users/cltbld', 14:28:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:07 INFO - 'LOGNAME': 'cltbld', 14:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:07 INFO - 'MOZ_NO_REMOTE': '1', 14:28:07 INFO - 'NO_EM_RESTART': '1', 14:28:07 INFO - 'PAGER': '/bin/cat', 14:28:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:07 INFO - 'PWD': '/builds/slave/test', 14:28:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:07 INFO - 'SHELL': '/bin/bash', 14:28:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:28:07 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:28:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:07 INFO - 'USER': 'cltbld', 14:28:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:07 INFO - 'XPC_FLAGS': '0x0', 14:28:07 INFO - 'XPC_SERVICE_NAME': '0', 14:28:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:28:10 INFO - Installing collected packages: mozsystemmonitor 14:28:10 INFO - Running setup.py install for mozsystemmonitor 14:28:10 INFO - Successfully installed mozsystemmonitor 14:28:10 INFO - Cleaning up... 14:28:10 INFO - Return code: 0 14:28:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:10 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 0x105fee3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f64570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e1db89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, '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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:28:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:28:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:10 INFO - 'HOME': '/Users/cltbld', 14:28:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:10 INFO - 'LOGNAME': 'cltbld', 14:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:10 INFO - 'MOZ_NO_REMOTE': '1', 14:28:10 INFO - 'NO_EM_RESTART': '1', 14:28:10 INFO - 'PAGER': '/bin/cat', 14:28:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:10 INFO - 'PWD': '/builds/slave/test', 14:28:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:10 INFO - 'SHELL': '/bin/bash', 14:28:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:28:10 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:28:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:10 INFO - 'USER': 'cltbld', 14:28:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:10 INFO - 'XPC_FLAGS': '0x0', 14:28:10 INFO - 'XPC_SERVICE_NAME': '0', 14:28:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:11 INFO - Downloading/unpacking jsonschema==2.5.1 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28: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 14:28:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:28:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:14 INFO - Downloading functools32-3.2.3-2.tar.gz 14:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:28:14 INFO - warning: no files found matching '*.txt' 14:28:14 INFO - no previously-included directories found matching 'build' 14:28:14 INFO - no previously-included directories found matching 'dist' 14:28:14 INFO - no previously-included directories found matching '.git*' 14:28:14 INFO - Installing collected packages: jsonschema, functools32 14:28:14 INFO - Running setup.py install for functools32 14:28:14 INFO - warning: no files found matching '*.txt' 14:28:14 INFO - no previously-included directories found matching 'build' 14:28:14 INFO - no previously-included directories found matching 'dist' 14:28:14 INFO - no previously-included directories found matching '.git*' 14:28:14 INFO - Successfully installed jsonschema functools32 14:28:14 INFO - Cleaning up... 14:28:14 INFO - Return code: 0 14:28:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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', '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 0x105fee3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f64570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e1db89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, '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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:28: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:28: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 functools32==3.2.3-2 14:28:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:28:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:15 INFO - 'HOME': '/Users/cltbld', 14:28:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:15 INFO - 'LOGNAME': 'cltbld', 14:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:15 INFO - 'MOZ_NO_REMOTE': '1', 14:28:15 INFO - 'NO_EM_RESTART': '1', 14:28:15 INFO - 'PAGER': '/bin/cat', 14:28:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:15 INFO - 'PWD': '/builds/slave/test', 14:28:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:15 INFO - 'SHELL': '/bin/bash', 14:28:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:28:15 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:28:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:15 INFO - 'USER': 'cltbld', 14:28:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:15 INFO - 'XPC_FLAGS': '0x0', 14:28:15 INFO - 'XPC_SERVICE_NAME': '0', 14:28:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:28:15 INFO - Cleaning up... 14:28:15 INFO - Return code: 0 14:28:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:28: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')]} 14:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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')]} 14:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28: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', '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 0x105fee3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f64570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e1db89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, '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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:28: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 blobuploader==1.2.4 14:28:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:28:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:15 INFO - 'HOME': '/Users/cltbld', 14:28:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:15 INFO - 'LOGNAME': 'cltbld', 14:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:15 INFO - 'MOZ_NO_REMOTE': '1', 14:28:15 INFO - 'NO_EM_RESTART': '1', 14:28:15 INFO - 'PAGER': '/bin/cat', 14:28:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:15 INFO - 'PWD': '/builds/slave/test', 14:28:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:15 INFO - 'SHELL': '/bin/bash', 14:28:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:28:15 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:28:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:15 INFO - 'USER': 'cltbld', 14:28:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:15 INFO - 'XPC_FLAGS': '0x0', 14:28:15 INFO - 'XPC_SERVICE_NAME': '0', 14:28:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:16 INFO - Downloading/unpacking blobuploader==1.2.4 14:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:18 INFO - Downloading blobuploader-1.2.4.tar.gz 14:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:28:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:28:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:20 INFO - Downloading docopt-0.6.1.tar.gz 14:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:28:20 INFO - Installing collected packages: blobuploader, requests, docopt 14:28:20 INFO - Running setup.py install for blobuploader 14:28:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:28:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:28:20 INFO - Running setup.py install for requests 14:28:20 INFO - Running setup.py install for docopt 14:28:20 INFO - Successfully installed blobuploader requests docopt 14:28:20 INFO - Cleaning up... 14:28:21 INFO - Return code: 0 14:28:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:21 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 0x105fee3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f64570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e1db89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, '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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:28:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:28:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:21 INFO - 'HOME': '/Users/cltbld', 14:28:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:21 INFO - 'LOGNAME': 'cltbld', 14:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:21 INFO - 'MOZ_NO_REMOTE': '1', 14:28:21 INFO - 'NO_EM_RESTART': '1', 14:28:21 INFO - 'PAGER': '/bin/cat', 14:28:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:21 INFO - 'PWD': '/builds/slave/test', 14:28:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:21 INFO - 'SHELL': '/bin/bash', 14:28:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:28:21 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:28:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:21 INFO - 'USER': 'cltbld', 14:28:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:21 INFO - 'XPC_FLAGS': '0x0', 14:28:21 INFO - 'XPC_SERVICE_NAME': '0', 14:28:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:21 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-n_yQHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:21 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-DUaDRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:21 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Y1KvsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:21 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-k_Ryuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:21 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-D84nln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:21 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-iXuQMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:21 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Vala3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:22 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-R57NOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:22 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Z_V9ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:22 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-lYGaSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:22 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Mz6PuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:22 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-Y26GKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:22 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-ZYNNoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:22 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-XQ2PV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:22 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-L4dhh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:22 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-gUEE5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:23 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-YjDkNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:28:23 INFO - Running setup.py install for manifestparser 14:28:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:28:23 INFO - Running setup.py install for mozcrash 14:28:23 INFO - Running setup.py install for mozdebug 14:28:23 INFO - Running setup.py install for mozdevice 14:28:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:28:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:28:23 INFO - Running setup.py install for mozfile 14:28:23 INFO - Running setup.py install for mozhttpd 14:28:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:28:24 INFO - Running setup.py install for mozinfo 14:28:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:28:24 INFO - Running setup.py install for mozInstall 14:28:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:28:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:28:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:28:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:28:24 INFO - Running setup.py install for mozleak 14:28:24 INFO - Running setup.py install for mozlog 14:28:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:28:24 INFO - Running setup.py install for moznetwork 14:28:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:28:24 INFO - Running setup.py install for mozprocess 14:28:24 INFO - Running setup.py install for mozprofile 14:28:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:28:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:28:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:28:25 INFO - Running setup.py install for mozrunner 14:28:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:28:25 INFO - Running setup.py install for mozscreenshot 14:28:25 INFO - Running setup.py install for moztest 14:28:25 INFO - Running setup.py install for mozversion 14:28:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:28:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:28:25 INFO - Cleaning up... 14:28:25 INFO - Return code: 0 14:28:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:25 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 0x105fee3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f64570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e1db89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, '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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:28:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:25 INFO - 'HOME': '/Users/cltbld', 14:28:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:25 INFO - 'LOGNAME': 'cltbld', 14:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:25 INFO - 'MOZ_NO_REMOTE': '1', 14:28:25 INFO - 'NO_EM_RESTART': '1', 14:28:25 INFO - 'PAGER': '/bin/cat', 14:28:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:25 INFO - 'PWD': '/builds/slave/test', 14:28:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:25 INFO - 'SHELL': '/bin/bash', 14:28:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:28:25 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:28:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:25 INFO - 'USER': 'cltbld', 14:28:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:25 INFO - 'XPC_FLAGS': '0x0', 14:28:25 INFO - 'XPC_SERVICE_NAME': '0', 14:28:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:28:25 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-LFYHk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:28:26 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-GcwHmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:28:26 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-0j1okk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:28:26 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-FQgMbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:28:26 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-RwIgVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:28:26 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-LTDcSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:28:26 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-s3Lq53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:28:26 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-P5ouZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:28:26 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-0QoXUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:28:26 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-1RV0Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:28:27 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-MNV1fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:28:27 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-z2bE81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:28:27 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-4ud7FL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:28:27 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-21hIKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:27 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-oDkjOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:28:27 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-NRqhhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:28:27 INFO - Running setup.py (path:/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/pip-EvKsku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:28:27 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:27 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:28:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:28:30 INFO - Downloading blessings-1.6.tar.gz 14:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:28:30 INFO - Installing collected packages: blessings 14:28:30 INFO - Running setup.py install for blessings 14:28:30 INFO - Successfully installed blessings 14:28:30 INFO - Cleaning up... 14:28:30 INFO - Return code: 0 14:28:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:28:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:30 INFO - Reading from file tmpfile_stdout 14:28:30 INFO - Current package versions: 14:28:30 INFO - blessings == 1.6 14:28:30 INFO - blobuploader == 1.2.4 14:28:30 INFO - docopt == 0.6.1 14:28:30 INFO - functools32 == 3.2.3-2 14:28:30 INFO - jsonschema == 2.5.1 14:28:30 INFO - manifestparser == 1.1 14:28:30 INFO - mozInstall == 1.12 14:28:30 INFO - mozcrash == 1.0 14:28:30 INFO - mozdebug == 0.1 14:28:30 INFO - mozdevice == 0.49 14:28:30 INFO - mozfile == 1.2 14:28:30 INFO - mozhttpd == 0.7 14:28:30 INFO - mozinfo == 0.9 14:28:30 INFO - mozleak == 0.1 14:28:30 INFO - mozlog == 3.4 14:28:30 INFO - moznetwork == 0.27 14:28:30 INFO - mozprocess == 0.23 14:28:30 INFO - mozprofile == 0.28 14:28:30 INFO - mozrunner == 6.13 14:28:30 INFO - mozscreenshot == 0.1 14:28:30 INFO - mozsystemmonitor == 0.3 14:28:30 INFO - moztest == 0.7 14:28:30 INFO - mozversion == 1.4 14:28:30 INFO - psutil == 3.1.1 14:28:30 INFO - requests == 1.2.3 14:28:30 INFO - wsgiref == 0.1.2 14:28:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:30 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 0x105fee3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f64570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e1db89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, '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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:30 INFO - 'HOME': '/Users/cltbld', 14:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:30 INFO - 'LOGNAME': 'cltbld', 14:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:30 INFO - 'MOZ_NO_REMOTE': '1', 14:28:30 INFO - 'NO_EM_RESTART': '1', 14:28:30 INFO - 'PAGER': '/bin/cat', 14:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:30 INFO - 'PWD': '/builds/slave/test', 14:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:30 INFO - 'SHELL': '/bin/bash', 14:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:28:30 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:30 INFO - 'USER': 'cltbld', 14:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:30 INFO - 'XPC_FLAGS': '0x0', 14:28:30 INFO - 'XPC_SERVICE_NAME': '0', 14:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:28:31 INFO - Cleaning up... 14:28:31 INFO - Return code: 0 14:28:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:28:31 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 0x105fee3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f64570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90e1db89f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, '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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:28:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:28:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:31 INFO - 'HOME': '/Users/cltbld', 14:28:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:31 INFO - 'LOGNAME': 'cltbld', 14:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:31 INFO - 'MOZ_NO_REMOTE': '1', 14:28:31 INFO - 'NO_EM_RESTART': '1', 14:28:31 INFO - 'PAGER': '/bin/cat', 14:28:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:31 INFO - 'PWD': '/builds/slave/test', 14:28:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:31 INFO - 'SHELL': '/bin/bash', 14:28:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:28:31 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:28:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:31 INFO - 'USER': 'cltbld', 14:28:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:31 INFO - 'XPC_FLAGS': '0x0', 14:28:31 INFO - 'XPC_SERVICE_NAME': '0', 14:28:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:28:31 INFO - Cleaning up... 14:28:31 INFO - Return code: 0 14:28:31 INFO - Running post-action listener: _resource_record_post_action 14:28:31 INFO - Running post-action listener: _start_resource_monitoring 14:28:31 INFO - Starting resource monitoring. 14:28:31 INFO - [mozharness: 2016-11-22 22:28:31.536657Z] Finished create-virtualenv step (success) 14:28:31 INFO - [mozharness: 2016-11-22 22:28:31.537633Z] Running install step. 14:28:31 INFO - Running pre-action listener: _resource_record_pre_action 14:28:31 INFO - Running main action method: install 14:28:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:28:31 INFO - Reading from file tmpfile_stdout 14:28:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:28:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:28:31 INFO - Reading from file tmpfile_stdout 14:28:31 INFO - Output received: 14:28:31 INFO - Usage: mozinstall [options] installer 14:28:31 INFO - Options: 14:28:31 INFO - -h, --help show this help message and exit 14:28:31 INFO - -d DEST, --destination=DEST 14:28:31 INFO - Directory to install application into. [default: 14:28:31 INFO - "/builds/slave/test"] 14:28:31 INFO - --app=APP Application being installed. [default: firefox] 14:28:31 INFO - mkdir: /builds/slave/test/build/application 14:28:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:29:04 INFO - Reading from file tmpfile_stdout 14:29:04 INFO - Output received: 14:29:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:29:04 INFO - Running post-action listener: _resource_record_post_action 14:29:04 INFO - [mozharness: 2016-11-22 22:29:04.748817Z] Finished install step (success) 14:29:04 INFO - [mozharness: 2016-11-22 22:29:04.748952Z] Running run-tests step. 14:29:04 INFO - Running pre-action listener: _resource_record_pre_action 14:29:04 INFO - Running main action method: run_tests 14:29:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:29:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:29:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:29:04 INFO - 2016-11-22 14:29:04.763 screenresolution[1623:7450] starting screenresolution argv=screenresolution get 14:29:04 INFO - 2016-11-22 14:29:04.766 screenresolution[1623:7450] Display 0: 1600x1200x32@60 14:29:04 INFO - 2016-11-22 14:29:04.771 screenresolution[1624:7452] starting screenresolution argv=screenresolution list 14:29:04 INFO - Available Modes on Display 0 14:29:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:29:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:29:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:29:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:29:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:29:04 INFO - Intel Iris: 14:29:04 INFO - Chipset Model: Intel Iris 14:29:04 INFO - Type: GPU 14:29:04 INFO - Bus: Built-In 14:29:04 INFO - VRAM (Dynamic, Max): 1536 MB 14:29:05 INFO - Vendor: Intel (0x8086) 14:29:05 INFO - Device ID: 0x0a2e 14:29:05 INFO - Revision ID: 0x0009 14:29:05 INFO - Displays: 14:29:05 INFO - Display: 14:29:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:29:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:29:05 INFO - Display Serial Number: 1600x1200 60 14:29:05 INFO - Main Display: Yes 14:29:05 INFO - Mirror: Off 14:29:05 INFO - Online: Yes 14:29:05 INFO - Rotation: Supported 14:29:05 INFO - Return code: 0 14:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:29:05 INFO - Python 2.7.3 14:29:05 INFO - Return code: 0 14:29:05 INFO - grabbing minidump binary from tooltool 14:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:29:05 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 0x105e04d30>, '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 0x105c6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105dfcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:29:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:29:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:29:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:29:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:29:05 INFO - Return code: 0 14:29:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:29:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:29:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:29:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:29:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0303 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:29:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oJINOobP5Z/Render', 14:29:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:29:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:29:05 INFO - 'HOME': '/Users/cltbld', 14:29:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:29:05 INFO - 'LOGNAME': 'cltbld', 14:29:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:29:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:29:05 INFO - 'MOZ_NO_REMOTE': '1', 14:29:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:29:05 INFO - 'NO_EM_RESTART': '1', 14:29:05 INFO - 'PAGER': '/bin/cat', 14:29:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:29:05 INFO - 'PWD': '/builds/slave/test', 14:29:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:29:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:29:05 INFO - 'SHELL': '/bin/bash', 14:29:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sMbgg5Gt2y/Listeners', 14:29:05 INFO - 'TMPDIR': '/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/', 14:29:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:29:05 INFO - 'USER': 'cltbld', 14:29:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:29:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:29:05 INFO - 'XPC_FLAGS': '0x0', 14:29:05 INFO - 'XPC_SERVICE_NAME': '0', 14:29:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:29:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0303', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:29:05 INFO - mozversion application_buildid: 20161122113650 14:29:05 INFO - mozversion application_changeset: 4cf8741bb86f96dcb62dc98594f109e7ed2733a1 14:29:05 INFO - mozversion application_display_name: Nightly 14:29:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:29:05 INFO - mozversion application_name: Firefox 14:29:05 INFO - mozversion application_remotingname: firefox 14:29:05 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 14:29:05 INFO - mozversion application_vendor: Mozilla 14:29:05 INFO - mozversion application_version: 53.0a1 14:29:05 INFO - mozversion platform_buildid: 20161122113650 14:29:05 INFO - mozversion platform_changeset: 4cf8741bb86f96dcb62dc98594f109e7ed2733a1 14:29:05 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 14:29:05 INFO - mozversion platform_version: 53.0a1 14:29:05 INFO - using testdate: 1479853745 14:29:05 INFO - actual date: 1479853745 14:29:05 INFO - starting webserver on 'localhost:49236' 14:29:05 INFO - SUITE-START | Running 2 tests 14:29:05 INFO - TEST-START | dromaeo_css 14:29:05 INFO - operating with platform_type : mac_ 14:29:05 INFO - Initialising browser for dromaeo_css test... 14:29:05 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpJP5Tjd/profile http://localhost:49236/getInfo.html) 14:29:08 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 14:29:08 INFO - PROCESS | 1634 | colorDepth:24 14:29:08 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 14:29:08 INFO - PROCESS | 1634 | __metrics 14:29:08 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:29:08 INFO - PROCESS | 1634 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:29:09 INFO - TEST-INFO | 1634: exit 0 14:29:09 INFO - Browser initialized. 14:29:09 INFO - Running cycle 1/1 for dromaeo_css test... 14:29:09 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmpJP5Tjd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:21 INFO - PROCESS | 1636 | RSS: Main: 235368448 14:29:21 INFO - PROCESS | 1636 | 14:30:12 INFO - PROCESS | 1636 | 1479853812286 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:32:24 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 14:32:27 INFO - PROCESS | 1636 | RSS: Main: 483618816 14:32:27 INFO - PROCESS | 1636 | 14:35:30 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 14:35:30 INFO - PROCESS | 1636 | RSS: Main: 364953600 14:35:30 INFO - PROCESS | 1636 | 14:38:33 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 14:38:34 INFO - PROCESS | 1636 | RSS: Main: 341221376 14:38:34 INFO - PROCESS | 1636 | 14:41:36 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 14:41:37 INFO - PROCESS | 1636 | RSS: Main: 335908864 14:41:37 INFO - PROCESS | 1636 | 14:44:40 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 14:44:41 INFO - PROCESS | 1636 | RSS: Main: 325328896 14:44:41 INFO - PROCESS | 1636 | 14:47:44 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 14:47:45 INFO - PROCESS | 1636 | RSS: Main: 372506624 14:47:45 INFO - PROCESS | 1636 | 14:47:45 INFO - PROCESS | 1636 | __start_tp_report 14:47:45 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 14:47:45 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 14:47:45 INFO - PROCESS | 1636 | |i|pagename|runs| 14:47:45 INFO - PROCESS | 1636 | |0;dojo.html;3001.2796928737102;3303.174206448388;3308.5037244413334;3329.8834540791077;3386.153461634591;5485.862853428666;5594.720263986805;5604.8038318658855;5655.971720141399;5689.772409103636;5544.445555444454;5566.137248726443;5631.014572449825;5633.915491267624;5702.486776190152;5064.392272927235;5148.562372198349;5171.612129090315;5184.351956005499;5199.584033277348;5076.670016448919;5193.558547523447;5211.218317252424;5233.9738301308635;5244.763985620656;4362.25841606926;5202.791888324463;5241;5242.55438287746;5254.474552544753;5038.622103342264;5098.821541246039;5194.532492075694;5221.582273418117;5281.630285880009;5074.847754567332;5110.207917772751;5137.280780690707;5161.458046905059;5216.347956505437;5576.693281869496;5587.580931430159;5594.992901277768;5607.467290607386;5614.29821272341;6103.084537319438;6120.44915957566;6129.049997250433;6139.6009259398;6148.907766383508;6081.118237855486;6105.558094708191;6118.816435506942;6122.79460843403;6140.293866205354;5680.5455563554815;5717.113847353667;5730.455606717355;5733.82798516041;5739.942600574024;4608.815647374067;6218.9427797274575;6307.5269354798575;6322.557420980579;6334.398232167937;5782.132680098019;5822.184894114827;6008;6038.33578306386;6054.969725151346;6048.788292409745;6090.969545152246;6110.862540392742;6135.845176233341;6147.477464415485;6075.3924607539775;6115.240341084353;6122.418474876009;6140.894638965029;6142.955697531431;6099.022957501673;6128.147594116181;6174.598651087665;6184.041473571604;6193.411625895533;4774.069056534012;4844.660873738804;4846.418429788448;4864.927026094611;4891.828785992473;4307.935380969288;4370.847020354272;4381.737095774264;4426.601605855489;4443.178012067778;4747.83382581608;5668.461496157858;5671.914921276184;5690;5691.430856914359;6146.631202127886;6190.1952746142715;6191.4118158774845;6204.100405441276;6204.13142160098;5421.918671219935;5509.5041446270025;5545.473180047889;5611.831645050655;5612.102063669793;5240.371155461369;5334.11987022137;5339.41266460689;5343.919841202385;5388.407275199725;6234.407731265523;6234.9688251558455;6254.468370188494;6256.186695729526;6259.4679452246155;6038.154658347747;6156.353582873734;6218.22272215973;6230.283517395557;6237.1891654084675;6208.937910620836;6225.906611400742;6240.781572644935;6243.469305108935;6278.717457714322;6015.939840601538;6065.090236464565;6072.05883088122;6110.877782444238;6122.081687746873;6146.661933593696;6169.198004259597;6179.443850053517;6182.505399567934;6212.130301757667;5736.282964629421;5825.242718446575;5827.504662103769;5859.179714839841;5909.970450147722;5757.596968212185;5934.258217722785;5939.346671866005;5940.762369505172;5941;5750.194972703908;5754.913676294943;5767.221425107557;5767.971160144172;5771.59598828078;5238.947610523998;5704.229928959703;5889.440503152194;5927.110933360031;5971.850703732442;5757.193992841089;5759.481646651821;5760.942390576208;5775.047117225611;5779.7110144493445 14:47:45 INFO - PROCESS | 1636 | |1;ext.html;482.8267310435641;504.46022755651455;506.44797171083513;514.6783260462211;561.6040691312625;37885;38776;39047.41428878566;39135.608643913554;39277.41083883744;39379.683742694724;39784.80107599458;39852.00369990752;39887;39972;8379.329653627696;9082.500462474562;9142.588583513758;9158.404703694272;9221.631134754602;8452.957735211347;10881.782364352708;11220.943895280512;11232.943835280812;11377.829332560019;11153.386563738992;11216.102711783038;11236.438178091104;11238.49426775793;11277.605283815068;8427.494350338999;8626.353023523261;11150.888491115065;11218.439078046147;11241.943790281079;8552.315814734868;8608.268297194745;8635.179657932485;10765.13878889687;11100.888991110147;37846.86459406222;38068.80965595182;38076.42885356722;38095.238095238215;38130.42804357937;3153.9369212615848;3174.5238214267815;3178.3166619176986;3251.463508521091;3301.6863397977395;28289.292767680767;29705.554416683768;29731;29892.252693682614;30011.549826752616;3164.715175634204;3207.1180425382972;3228.6771322867526;3291.144302481348;3310.536524886518;488470;488832;493386;493664;494037;53027;53191.46808531942;54124.45875541273;54386;54402;57824.132638010466;57899.710501447225;58059.709701451226;58076.70961645165;58130.41869581334;15271.618209544627;15511.301991410413;15537.30082146306;15540.689186216212;15542.378304867678;10923.726906827234;11117.722056948642;11128.221024528368;12105.636830894911;12184.634460966185;11260.887391126147;13543.525976590772;13627.795583066261;14738.705225895423;15014.47449339268;5119.564836988823;5232.450592687789;5404.243405923174;6062.151298818169;6075.149479072933;887.6759982606302;951.7192428233687;1006.3509036671306;1020.9642662506776;1026.7022563456662;28256.71743282582;28537.714622853506;28587.714122858506;28763.712362876104;28767.136985890458;917.1516347378648;1006.0894890124449;1065.5950738719391;1069.5346333768139;1099.6474336566068;14419.42322307117;14506.347214375379;14650.340734666966;14948.476803311833;14998.47505337308;597941;608593;643058;643817;645151;53753.65615859635;54002.649933751185;54005.729971349894;54077.377678669705;54104.72947635237;1210.9455074521668;1254.6612414647993;1320.914140580859;1345.7375811716818;1364.5769811358512;23703.64444533299;27299.590506142027;29148.27129321784;29485;29681.40637187201;45148;45654.77172614116;45712.31431528463;45729.54270457253;45780;422143;486463;487573;488210;490334;24224.63663045091;25672.229833105037;25723.228303150936;25729.970801167743;25798.87100564485;43819.342709860015;48694.51305487042;49090;50561.49438505568;51796.741016294676;37456;39409.80295098506;39543.40684889672;41012.76961691154;41019.38470922879;38459.80770096132;38536;38810;38964.805175975074;39974.800126000344;38359;38814.6118538811;39295;39327.41008884812;39620.603793961694;33060.33879322352;33916.32167356589;34523.65476345305;34692;34735;24791;25152.49695006126;25368;25799.484010319313;25843.741562584135 14:47:45 INFO - PROCESS | 1636 | |2;jquery.html;337.972563407242;341.97948123112616;346.9895903122907;362.3170323939373;373.10454908220265;15216.467423640175;16078;18522.259109635597;19547.315843945464;20613.1754729811;19585;19916.302929397436;19993.500162495944;20440.386788396372;20787.584248315026;5324.520793128618;5758.654480731148;5797.36229014808;5870.618409803349;5874.353821079678;5654.349749778787;5746.224259724925;5881.7353219105025;5884.852878678046;5985.4912332451795;6021.939780602203;6053.303870054956;6067.605605635642;6067.939320606803;6076.118962750398;5802.622829516089;5997.940020599782;6070.453659170696;6076.6050206736645;6087.391260873877;5855.853603659943;5857.824265272048;5857.941420585782;5861.531077513789;5867.794627188028;12524.24660547524;12704.555340563036;12816.35918204086;13009.414576344087;13013.414396352187;2293.3693234360685;2328.4528135888054;2453.766892145243;2855.5431131018936;2862.8139170954028;8783.34124940632;9721.027897210293;9733.415995040321;10130.696079117564;10317.58729650813;1807.204829874864;1872.2885303584687;1893.1670065171281;1920.2606996306383;1920.9135588898532;116799.41600291945;121938;125032;126043;129060.35469822779;10992.725181870517;11318.037966772752;11425.714357140972;11436.885631143748;11612.535498579962;14315.355808988621;14321.928390358189;14330.856691432953;14341.713165736626;14364.209968451627;8040.959795200986;8357.91737787733;8411.495310281403;8525.275351595059;8540.658373664985;7027.578345299298;8122.106568277485;8278.8344233115;8287.254147126787;8500.574971251413;4000.239954408653;4458.7324760514475;4473;4521.796519156645;4596.080783843245;1567.6942996115877;1768.7435321878256;1825.8174182581902;1834.4955137337072;1908.274855554908;846.5597889097635;849.8470275350496;862.0388267082284;930.3022732950287;936.7423958411491;19311.130999105073;19407.320743774184;19847.60304793896;20811.583768324548;20887.47781305449;872.9301655867515;882.3073886998675;894.8434024045766;901.3735453859636;907.5932304927336;8105.878411823827;8832.690855820145;10059.949700251453;10768.730781730363;11660.017796974535;579163;602695;604453;617061.9146904236;617773;107424;126646.73353266534;131918;140681.5931840689;141105;896.744427838076;914.6890057380523;999.1507218864053;1012.9696109116738;1019.0675531888387;16193.838061619233;16202.918985404998;18186;18403.631927361646;18661.066946652343;45814.54185458236;49702;50720.74639626778;51242.74378628083;52300.95398092093;74218.62890685513;75912;77035.2296477028;77917;78669;6435.356464353527;6491.415772580491;7965.721199758213;8192.672293108448;8209.029832840195;11338.433078346216;12724.872751272369;12747.49010039588;13209.735805283648;13253.867461325262;10911;11066.889331106586;11337.489812958273;11405.486753095965;11436.542538298374;10925.344479331265;11167.49746261404;11248.493817778057;11269.492872820907;11561;10876.347419154876;11301.41780150763;11537;11586.594469193538;11662.70843228892;7859;8045.758627241192;8140.877886831584;8191.79520511992;8221.260086592236;10250.948745256226;11137.554497819996;11246.437678116225;11287.20989530725;11294.983451489405 14:47:45 INFO - PROCESS | 1636 | |3;mootools.html;1476.37254166979;1505.0593379138038;1674.430693564188;1808.385149049323;1846.8614853885954;8111.91888081119;8527.744167674971;8528.275096616795;8535.61589728463;8559.44363616366;7396.630168491581;7673.769786906388;7674.232576742337;7993.840123197532;8331.333493320535;2275.6131457652195;2313.9190128345513;2314.3172764034566;2320.582295186866;2322.2104484475276;1990.28349794074;2304.7119110111234;2331.3821837213154;2348.0842471436154;2349.1543044503965;2285.919992800252;2292.9770702293013;2314.594945884472;2314.8611083335054;2333.7899589036983;2285.405794493435;2313.7570555091643;2315.710536182977;2315.8494697844753;2319.4549280918973;2133.25336132354;2211.845170838042;2289.553537060274;2322.072679675865;2331.0209711920866;8252.381071419668;8264.793380165484;8368.748937531884;8375.958120209421;8386.748397548083;4997.375328083989;5152.278680984665;5155.175171972504;5167.9224811627855;5174.301469301634;3251.6098068231727;3279.5900512435946;3446.965530344715;3512.683858452726;3520.471929210639;1050.4275170032274;1069.5080263078994;1091.7106966653844;1092.1372116028328;1097.5554900265406;10345.534450949724;10703.83944240837;10892;10985.90140985903;11007;3754.81225938702;4342.804573794187;4433.024734558392;4447.466304043535;4448.621867141264;8645.870311945326;8646.048934617187;8660.263877570476;8663.78340541479;8673.349498787617;5085.084684756779;5092.083424983539;5093.5161159690515;5098.566621837185;5102.897942041139;4250.192463431938;4321.2005778931;4650.883727906762;4803.519648035239;4821.493743156988;3516.2440075383915;3543.1850674345046;3584.4085725854943;3600.369935261319;3623.1847834237087;1108.2851560743275;1117.379854180921;1117.580907159815;1129.1474936422949;1137.203957229926;753.7248904149945;761.4289283037722;843.7342237195264;877.7404424650647;904.7017529844562;5484.670919744828;5629.943700563023;5766.336871259775;5788.160716696056;5897.823065308047;839.937479088953;880.8898887639045;910.8022949820964;919.8758167647281;920.5121285718446;3561.412366959423;3709.795961222159;3783.4703141560203;3786.4888240087234;3932.3708206686792;7887.48731332473;10259.58961641541;10399.68800935958;10402.375857448576;10424.322419042737;10340.37957722539;10362.274640775224;10366.378017318984;10384;10391.37651740898;7406.962965185247;7721.382289416833;7867.449278550561;7912.525248485109;7941.285284324438;5513.531349835149;5803.448672376117;5852.092925596539;5909.674967876808;5917.260342457193;7786.805329866572;9058.818823623622;9107.772305692411;9356.859647105162;9389.859152112587;9334.626614935598;9496.905030949878;9569.234461242944;9590.712278631652;9707.66023189185;6066.726997285221;7159.928400715926;7163.2478589747325;7703.53778773253;7759.495632783851;7676.501027433199;7931.484453510503;7977.441579089408;8057.355411566943;8068.1528439513;7097.787066388017;7119;7126.964365178141;7143.178534468395;7159.785206443815;6831.966374305362;6902.094640854939;6909;7070.328318809705;7126.643667816485;5687.658740475585;6623.403893649402;6639.6680165992475;6704.06143139951;6716.093327400738;4773.9045219096115;4786.114568804782;4826.276058591239;4836.661433699607;4968.8757781055765;4500.703234880409;4519.276915693474;4583.54164583539;4620.745858977654;4743.1225223333795 14:47:45 INFO - PROCESS | 1636 | |4;prototype.html;264.8768322729929;267.6039461596837;298.76248382535886;305.18819938962366;312.88110518003157;4682.531746825316;4837.951620483798;5277.877661912183;5398.811041613544;5454.963327137914;4992.904399272456;5104.489551044893;5159.529534082787;5189.299444574981;5266.289050978116;3250.561174241471;4056.2495938251445;4084.060666046796;4088.6524645405175;4095.8736347504378;4075;4098.262312783698;4110.938335924963;4111.362738775495;4144.958550414487;3093.613298337708;3849.634284742945;3965.6430921217084;4047.9392809107885;4061.675065994728;3823.3118038753014;3987.288643722268;4005.499312585927;4009.3384591542363;4022.1955608878343;3327.4842399428126;3442.2599141184764;3483.494893240466;3492.0396890854963;3502.7215066500544;4961.627877909135;5035.471275516054;5152.330197074356;5236.476352364771;5260.8684782880355;4535;4544.7045942013665;4558.8632341029825;4568.200564901163;4594.402727645418;5101.923471147936;5524.613277070606;5531.197976293455;5554.861128471821;5617.662940223599;3191.1543440988157;3697.574778900434;3794.2790869734663;3794.4687743715904;3815.1797363566966;5108.66793658411;5739.794643124948;5767.653940763567;5793.623414478046;5828.446297601678;3236.158598764291;3256.1439979212096;3439.914002149966;3541.4864844597905;3862.8261728222296;3918.295541439483;3961.8217180226957;3971.0469487322835;3973.980130099331;3980.104476492766;3975.920481590352;4404.383386325917;4443.866683999485;4599.620113965797;4601.723896566216;5521.365043020024;5534.916976245359;5566.025945459528;5570.637908535932;5571.582131340085;1127.9679093629238;1174.4597485156924;1206.324458303353;1223.8164275358768;1258.5783762439503;805.9879101813477;840.5293035899915;847.559269180023;858.9785255368665;863.1972265792873;4492.842750503782;4875.878103047452;4950.480199579064;4969.925451118236;5028.371453568304;4835.637327200404;4963.801447942042;5051.318072060225;5446.782128714886;5457.426970168154;4236.618704316565;4656.092062047868;4714.915569419053;4861.440934292531;4992.72540010303;2401.6997875265592;2558.6950655166;2636.670416197975;2854.9857250713612;2916.606258155164;5061.797528098835;5107.540321371094;5273.973630131902;5331.680099194061;5772.451617096369;4957.652964292465;5499.532539734088;5519.972400138054;5534;5632.873425314953;4967.82612608557;5202.869928251824;5575.665460072328;5582.720863956786;5672.886542269214;5109.74451277442;5355.036093503207;5371.838844834661;5379.569634429315;5464.1257398816;4564.520725323793;5188.936268065113;5200.605488362327;5421.909511578362;5436.592255580927;4970.918030820914;5173.430922598586;5686.782154959652;5702.600817942704;5721.968701111045;3597.730170237295;3684.889453316405;3702.2052396294016;3873.6901047915535;3913.295606790805;5807.8548036299435;5839.824805255679;5850.6782126981725;5860;5861.531077513703;4650.930236046394;5584.441555844383;5654.264945557051;5681.2330335404195;5742.483176514133;4527.501974782837;4951.356323677899;4980.31063225854;5282.630215885005;5754.906567752114;4320.632746216606;5317.654352467077;5562.721863906708;5614.775408983595;5628.774849006158;5214.556762675215;5229.8755767510165;5314.654547454403;5333.146696528537;5512.724363781875;4577.221872281653;5473;5548.69482178484;5565.721713914207;5597.664140151441 14:47:45 INFO - PROCESS | 1636 | |5;yui.html;626.5363630913123;671.8320419895026;672.5762769455242;766.8006318357227;781.9873264122967;10272.794544109123;13765.105268157587;14219;14714.55856324312;14743.336549855256;11135.72160695983;13153.802692959613;13162.670933226675;13212.801807972864;13323;803.036356372354;816.1145157504086;817.166490180016;817.6116344736232;820.6430202861774;653.6927644007333;676.6988690032937;822.7984143884727;826.2522417212402;829.241244261503;697.2574208467965;835.4402550291289;858.4205661178679;864.7708357285293;869.9869501957476;857.3484152044429;858.9226969572705;859.2910848549972;862.6851199312206;864.6282098697558;503.7179179659366;642.7107801489349;645;645.1935081148564;645.9128017717595;11803.527858885634;13647.454101835914;13965.162090274514;14135;14187.503437379642;11406.372649504274;13449;13708.93145534266;13801.654958626013;13815.585532434043;11166.218364714392;11197.944010279978;11252.943735281353;11259.774804503864;11716.648500544998;3612.843889955215;3627.43774714917;3676.2279921216577;3703.6296370363016;3718.4980027696456;63323.6833815828;81065.59467202626;81309.78035329474;82770.58614706948;83125;10549.578016879239;10556.419396933243;10590.470476476145;10639.946800266103;11038.613648522263;20892.37322880316;21069.47326316824;21153.57692846165;21170.682439763415;21429.89285053565;7447.069116360455;7462.4776265660885;7528.887066694004;7531.322181003736;7725.768226953201;3788.3749181384765;4112.300908845504;4187.832486700559;4209.621134097946;4210.705250632426;3357.1271469418125;3573.446115852047;3739.457778622139;3746.3631182699005;3757.6242375762204;676.9153855768029;690.8411065454974;697.1390332938817;700.0129816958166;701.3197198717236;566.7591273708657;612.5191724496249;631.9083732858802;645.8837409266378;652.0910948500629;6973.978735310669;7871.291583757489;8397.489810441857;8509.155010233086;8595.097514760984;532.5792623827133;628.3622123544606;632.7975047984601;636.3763511758502;644.8774732800847;4060.6548443382644;4212.136512015029;4231.196072746168;4286.485621725351;4336.848210312624;82825.58587207025;99071;108919.01890792006;109884;118288.40855795838;97282.54076188862;102059;102896;103391;103725;81458.18541814624;82494;83364;85942.57028714941;89572.10427895767;7725.266099720518;8184.631691573774;8213.58932053383;8377.49735015901;8553.97352317726;45976.31035534536;49211.75394123006;49233.507664922894;53085.734571326895;55714.442855570924;46286.53713462822;55787.605309865954;58362.12456813066;70289;78382.6080869592;12185;12202.084843636585;12387.566435174725;12607.43266552989;12686.555970540987;13852.72294554083;13987.650308742363;14057.507987220399;14347.354369053626;14448.422063117358;12763.489460421479;12801.487940482277;12996.48014079464;13347.532836350681;13440.731185376433;12861.2926289055;12965.935170324088;13163.53927612529;13517.662058448617;13830.792538111735;10240.436775977392;12743.87256127427;12812.039097067944;12895.806562901376;13033.608991730263;8637.913620863963;10556.31816707028;10573.577056917637;10925.945370273097;10931.234813562975;10521.579136834442;10579.94710026445;10647.787044258917;10699.358038517403;10703.411312377893 14:47:45 INFO - PROCESS | 1636 | __end_tp_report 14:47:45 INFO - PROCESS | 1636 | __start_cc_report 14:47:45 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,3016 14:47:45 INFO - PROCESS | 1636 | __end_cc_report 14:47:45 INFO - PROCESS | 1636 | __startTimestamp1479854865001__endTimestamp 14:47:45 INFO - PROCESS | 1636 | 14:47:45 INFO - PROCESS | 1636 | ------- Summary: start ------- 14:47:45 INFO - PROCESS | 1636 | Number of tests: 6 14:47:45 INFO - PROCESS | 1636 | 14:47:45 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5628.80 Median:5757.60 stddev:639.52 (11.1%) stddev-sans-first:607.36 14:47:45 INFO - PROCESS | 1636 | Values: 3001.3 3303.2 3308.5 3329.9 3386.2 5485.9 5594.7 5604.8 5656.0 5689.8 5544.4 5566.1 5631.0 5633.9 5702.5 5064.4 5148.6 5171.6 5184.4 5199.6 5076.7 5193.6 5211.2 5234.0 5244.8 4362.3 5202.8 5241.0 5242.6 5254.5 5038.6 5098.8 5194.5 5221.6 5281.6 5074.8 5110.2 5137.3 5161.5 5216.3 5576.7 5587.6 5595.0 5607.5 5614.3 6103.1 6120.4 6129.0 6139.6 6148.9 6081.1 6105.6 6118.8 6122.8 6140.3 5680.5 5717.1 5730.5 5733.8 5739.9 4608.8 6218.9 6307.5 6322.6 6334.4 5782.1 5822.2 6008.0 6038.3 6055.0 6048.8 6091.0 6110.9 6135.8 6147.5 6075.4 6115.2 6122.4 6140.9 6143.0 6099.0 6128.1 6174.6 6184.0 6193.4 4774.1 4844.7 4846.4 4864.9 4891.8 4307.9 4370.8 4381.7 4426.6 4443.2 4747.8 5668.5 5671.9 5690.0 5691.4 6146.6 6190.2 6191.4 6204.1 6204.1 5421.9 5509.5 5545.5 5611.8 5612.1 5240.4 5334.1 5339.4 5343.9 5388.4 6234.4 6235.0 6254.5 6256.2 6259.5 6038.2 6156.4 6218.2 6230.3 6237.2 6208.9 6225.9 6240.8 6243.5 6278.7 6015.9 6065.1 6072.1 6110.9 6122.1 6146.7 6169.2 6179.4 6182.5 6212.1 5736.3 5825.2 5827.5 5859.2 5910.0 5757.6 5934.3 5939.3 5940.8 5941.0 5750.2 5754.9 5767.2 5768.0 5771.6 5238.9 5704.2 5889.4 5927.1 5971.9 5757.2 5759.5 5760.9 5775.0 5779.7 14:47:45 INFO - PROCESS | 1636 | 14:47:45 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:66154.89 Median:38085.83 stddev:143186.84 (376.0%) stddev-sans-first:143503.62 14:47:45 INFO - PROCESS | 1636 | Values: 482.8 504.5 506.4 514.7 561.6 37885.0 38776.0 39047.4 39135.6 39277.4 39379.7 39784.8 39852.0 39887.0 39972.0 8379.3 9082.5 9142.6 9158.4 9221.6 8453.0 10881.8 11220.9 11232.9 11377.8 11153.4 11216.1 11236.4 11238.5 11277.6 8427.5 8626.4 11150.9 11218.4 11241.9 8552.3 8608.3 8635.2 10765.1 11100.9 37846.9 38068.8 38076.4 38095.2 38130.4 3153.9 3174.5 3178.3 3251.5 3301.7 28289.3 29705.6 29731.0 29892.3 30011.5 3164.7 3207.1 3228.7 3291.1 3310.5 488470.0 488832.0 493386.0 493664.0 494037.0 53027.0 53191.5 54124.5 54386.0 54402.0 57824.1 57899.7 58059.7 58076.7 58130.4 15271.6 15511.3 15537.3 15540.7 15542.4 10923.7 11117.7 11128.2 12105.6 12184.6 11260.9 13543.5 13627.8 14738.7 15014.5 5119.6 5232.5 5404.2 6062.2 6075.1 887.7 951.7 1006.4 1021.0 1026.7 28256.7 28537.7 28587.7 28763.7 28767.1 917.2 1006.1 1065.6 1069.5 1099.6 14419.4 14506.3 14650.3 14948.5 14998.5 597941.0 608593.0 643058.0 643817.0 645151.0 53753.7 54002.6 54005.7 54077.4 54104.7 1210.9 1254.7 1320.9 1345.7 1364.6 23703.6 27299.6 29148.3 29485.0 29681.4 45148.0 45654.8 45712.3 45729.5 45780.0 422143.0 486463.0 487573.0 488210.0 490334.0 24224.6 25672.2 25723.2 25730.0 25798.9 43819.3 48694.5 49090.0 50561.5 51796.7 37456.0 39409.8 39543.4 41012.8 41019.4 38459.8 38536.0 38810.0 38964.8 39974.8 38359.0 38814.6 39295.0 39327.4 39620.6 33060.3 33916.3 34523.7 34692.0 34735.0 24791.0 25152.5 25368.0 25799.5 25843.7 14:47:45 INFO - PROCESS | 1636 | 14:47:45 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:34745.91 Median:2859.18 stddev:101078.57 (3535.2%) stddev-sans-first:101329.11 14:47:45 INFO - PROCESS | 1636 | Values: 338.0 342.0 347.0 362.3 373.1 15216.5 16078.0 18522.3 19547.3 20613.2 19585.0 19916.3 19993.5 20440.4 20787.6 5324.5 5758.7 5797.4 5870.6 5874.4 5654.3 5746.2 5881.7 5884.9 5985.5 6021.9 6053.3 6067.6 6067.9 6076.1 5802.6 5997.9 6070.5 6076.6 6087.4 5855.9 5857.8 5857.9 5861.5 5867.8 12524.2 12704.6 12816.4 13009.4 13013.4 2293.4 2328.5 2453.8 2855.5 2862.8 8783.3 9721.0 9733.4 10130.7 10317.6 1807.2 1872.3 1893.2 1920.3 1920.9 116799.4 121938.0 125032.0 126043.0 129060.4 10992.7 11318.0 11425.7 11436.9 11612.5 14315.4 14321.9 14330.9 14341.7 14364.2 8041.0 8357.9 8411.5 8525.3 8540.7 7027.6 8122.1 8278.8 8287.3 8500.6 4000.2 4458.7 4473.0 4521.8 4596.1 1567.7 1768.7 1825.8 1834.5 1908.3 846.6 849.8 862.0 930.3 936.7 19311.1 19407.3 19847.6 20811.6 20887.5 872.9 882.3 894.8 901.4 907.6 8105.9 8832.7 10059.9 10768.7 11660.0 579163.0 602695.0 604453.0 617061.9 617773.0 107424.0 126646.7 131918.0 140681.6 141105.0 896.7 914.7 999.2 1013.0 1019.1 16193.8 16202.9 18186.0 18403.6 18661.1 45814.5 49702.0 50720.7 51242.7 52301.0 74218.6 75912.0 77035.2 77917.0 78669.0 6435.4 6491.4 7965.7 8192.7 8209.0 11338.4 12724.9 12747.5 13209.7 13253.9 10911.0 11066.9 11337.5 11405.5 11436.5 10925.3 11167.5 11248.5 11269.5 11561.0 10876.3 11301.4 11537.0 11586.6 11662.7 7859.0 8045.8 8140.9 8191.8 8221.3 10250.9 11137.6 11246.4 11287.2 11295.0 14:47:45 INFO - PROCESS | 1636 | 14:47:45 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5389.15 Median:5088.58 stddev:2970.20 (58.4%) stddev-sans-first:2963.98 14:47:45 INFO - PROCESS | 1636 | Values: 1476.4 1505.1 1674.4 1808.4 1846.9 8111.9 8527.7 8528.3 8535.6 8559.4 7396.6 7673.8 7674.2 7993.8 8331.3 2275.6 2313.9 2314.3 2320.6 2322.2 1990.3 2304.7 2331.4 2348.1 2349.2 2285.9 2293.0 2314.6 2314.9 2333.8 2285.4 2313.8 2315.7 2315.8 2319.5 2133.3 2211.8 2289.6 2322.1 2331.0 8252.4 8264.8 8368.7 8376.0 8386.7 4997.4 5152.3 5155.2 5167.9 5174.3 3251.6 3279.6 3447.0 3512.7 3520.5 1050.4 1069.5 1091.7 1092.1 1097.6 10345.5 10703.8 10892.0 10985.9 11007.0 3754.8 4342.8 4433.0 4447.5 4448.6 8645.9 8646.0 8660.3 8663.8 8673.3 5085.1 5092.1 5093.5 5098.6 5102.9 4250.2 4321.2 4650.9 4803.5 4821.5 3516.2 3543.2 3584.4 3600.4 3623.2 1108.3 1117.4 1117.6 1129.1 1137.2 753.7 761.4 843.7 877.7 904.7 5484.7 5629.9 5766.3 5788.2 5897.8 839.9 880.9 910.8 919.9 920.5 3561.4 3709.8 3783.5 3786.5 3932.4 7887.5 10259.6 10399.7 10402.4 10424.3 10340.4 10362.3 10366.4 10384.0 10391.4 7407.0 7721.4 7867.4 7912.5 7941.3 5513.5 5803.4 5852.1 5909.7 5917.3 7786.8 9058.8 9107.8 9356.9 9389.9 9334.6 9496.9 9569.2 9590.7 9707.7 6066.7 7159.9 7163.2 7703.5 7759.5 7676.5 7931.5 7977.4 8057.4 8068.2 7097.8 7119.0 7127.0 7143.2 7159.8 6832.0 6902.1 6909.0 7070.3 7126.6 5687.7 6623.4 6639.7 6704.1 6716.1 4773.9 4786.1 4826.3 4836.7 4968.9 4500.7 4519.3 4583.5 4620.7 4743.1 14:47:45 INFO - PROCESS | 1636 | 14:47:45 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4424.73 Median:4970.42 stddev:1365.86 (27.5%) stddev-sans-first:1333.53 14:47:45 INFO - PROCESS | 1636 | Values: 264.9 267.6 298.8 305.2 312.9 4682.5 4838.0 5277.9 5398.8 5455.0 4992.9 5104.5 5159.5 5189.3 5266.3 3250.6 4056.2 4084.1 4088.7 4095.9 4075.0 4098.3 4110.9 4111.4 4145.0 3093.6 3849.6 3965.6 4047.9 4061.7 3823.3 3987.3 4005.5 4009.3 4022.2 3327.5 3442.3 3483.5 3492.0 3502.7 4961.6 5035.5 5152.3 5236.5 5260.9 4535.0 4544.7 4558.9 4568.2 4594.4 5101.9 5524.6 5531.2 5554.9 5617.7 3191.2 3697.6 3794.3 3794.5 3815.2 5108.7 5739.8 5767.7 5793.6 5828.4 3236.2 3256.1 3439.9 3541.5 3862.8 3918.3 3961.8 3971.0 3974.0 3980.1 3975.9 4404.4 4443.9 4599.6 4601.7 5521.4 5534.9 5566.0 5570.6 5571.6 1128.0 1174.5 1206.3 1223.8 1258.6 806.0 840.5 847.6 859.0 863.2 4492.8 4875.9 4950.5 4969.9 5028.4 4835.6 4963.8 5051.3 5446.8 5457.4 4236.6 4656.1 4714.9 4861.4 4992.7 2401.7 2558.7 2636.7 2855.0 2916.6 5061.8 5107.5 5274.0 5331.7 5772.5 4957.7 5499.5 5520.0 5534.0 5632.9 4967.8 5202.9 5575.7 5582.7 5672.9 5109.7 5355.0 5371.8 5379.6 5464.1 4564.5 5188.9 5200.6 5421.9 5436.6 4970.9 5173.4 5686.8 5702.6 5722.0 3597.7 3684.9 3702.2 3873.7 3913.3 5807.9 5839.8 5850.7 5860.0 5861.5 4650.9 5584.4 5654.3 5681.2 5742.5 4527.5 4951.4 4980.3 5282.6 5754.9 4320.6 5317.7 5562.7 5614.8 5628.8 5214.6 5229.9 5314.7 5333.1 5512.7 4577.2 5473.0 5548.7 5565.7 5597.7 14:47:45 INFO - PROCESS | 1636 | 14:47:45 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:19706.50 Median:4210.16 stddev:28914.80 (686.8%) stddev-sans-first:28960.42 14:47:45 INFO - PROCESS | 1636 | Values: 626.5 671.8 672.6 766.8 782.0 10272.8 13765.1 14219.0 14714.6 14743.3 11135.7 13153.8 13162.7 13212.8 13323.0 803.0 816.1 817.2 817.6 820.6 653.7 676.7 822.8 826.3 829.2 697.3 835.4 858.4 864.8 870.0 857.3 858.9 859.3 862.7 864.6 503.7 642.7 645.0 645.2 645.9 11803.5 13647.5 13965.2 14135.0 14187.5 11406.4 13449.0 13708.9 13801.7 13815.6 11166.2 11197.9 11252.9 11259.8 11716.6 3612.8 3627.4 3676.2 3703.6 3718.5 63323.7 81065.6 81309.8 82770.6 83125.0 10549.6 10556.4 10590.5 10639.9 11038.6 20892.4 21069.5 21153.6 21170.7 21429.9 7447.1 7462.5 7528.9 7531.3 7725.8 3788.4 4112.3 4187.8 4209.6 4210.7 3357.1 3573.4 3739.5 3746.4 3757.6 676.9 690.8 697.1 700.0 701.3 566.8 612.5 631.9 645.9 652.1 6974.0 7871.3 8397.5 8509.2 8595.1 532.6 628.4 632.8 636.4 644.9 4060.7 4212.1 4231.2 4286.5 4336.8 82825.6 99071.0 108919.0 109884.0 118288.4 97282.5 102059.0 102896.0 103391.0 103725.0 81458.2 82494.0 83364.0 85942.6 89572.1 7725.3 8184.6 8213.6 8377.5 8554.0 45976.3 49211.8 49233.5 53085.7 55714.4 46286.5 55787.6 58362.1 70289.0 78382.6 12185.0 12202.1 12387.6 12607.4 12686.6 13852.7 13987.7 14057.5 14347.4 14448.4 12763.5 12801.5 12996.5 13347.5 13440.7 12861.3 12965.9 13163.5 13517.7 13830.8 10240.4 12743.9 12812.0 12895.8 13033.6 8637.9 10556.3 10573.6 10925.9 10931.2 10521.6 10579.9 10647.8 10699.4 10703.4 14:47:45 INFO - PROCESS | 1636 | -------- Summary: end -------- 14:47:45 INFO - PROCESS | 1636 | 14:47:45 INFO - TEST-INFO | 1636: exit 0 14:47:45 INFO - TEST-OK | dromaeo_css | took 1120328ms 14:47:45 INFO - TEST-START | kraken 14:47:45 INFO - operating with platform_type : mac_ 14:47:45 INFO - Initialising browser for kraken test... 14:47:45 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmp6TXz8S/profile http://localhost:49236/getInfo.html) 14:47:48 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 14:47:48 INFO - PROCESS | 1647 | colorDepth:24 14:47:48 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 14:47:48 INFO - PROCESS | 1647 | __metrics 14:47:48 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:47:48 INFO - PROCESS | 1647 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:47:49 INFO - TEST-INFO | 1647: exit 0 14:47:49 INFO - Browser initialized. 14:47:49 INFO - Running cycle 1/1 for kraken test... 14:47:49 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/T/tmp6TXz8S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:01 INFO - PROCESS | 1648 | RSS: Main: 243765248 14:48:01 INFO - PROCESS | 1648 | 14:48:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 14:48:05 INFO - PROCESS | 1648 | RSS: Main: 293396480 14:48:05 INFO - PROCESS | 1648 | 14:48:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 14:48:08 INFO - PROCESS | 1648 | RSS: Main: 293572608 14:48:08 INFO - PROCESS | 1648 | 14:48:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 14:48:12 INFO - PROCESS | 1648 | RSS: Main: 385073152 14:48:12 INFO - PROCESS | 1648 | 14:48:14 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 14:48:15 INFO - PROCESS | 1648 | RSS: Main: 285720576 14:48:15 INFO - PROCESS | 1648 | 14:48:17 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:48:17 INFO - PROCESS | 1648 | RSS: Main: 291713024 14:48:17 INFO - PROCESS | 1648 | 14:48:20 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 14:48:21 INFO - PROCESS | 1648 | RSS: Main: 334192640 14:48:21 INFO - PROCESS | 1648 | 14:48:24 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 14:48:24 INFO - PROCESS | 1648 | RSS: Main: 334987264 14:48:24 INFO - PROCESS | 1648 | 14:48:27 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 14:48:28 INFO - PROCESS | 1648 | RSS: Main: 332222464 14:48:28 INFO - PROCESS | 1648 | 14:48:29 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:48:30 INFO - PROCESS | 1648 | RSS: Main: 310669312 14:48:30 INFO - PROCESS | 1648 | 14:48:32 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:48:33 INFO - PROCESS | 1648 | RSS: Main: 311242752 14:48:33 INFO - PROCESS | 1648 | 14:48:35 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:48:35 INFO - PROCESS | 1648 | RSS: Main: 312668160 14:48:35 INFO - PROCESS | 1648 | 14:48:38 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:48:39 INFO - PROCESS | 1648 | RSS: Main: 333324288 14:48:39 INFO - PROCESS | 1648 | 14:48:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:48:43 INFO - PROCESS | 1648 | RSS: Main: 327266304 14:48:43 INFO - PROCESS | 1648 | 14:48:44 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 14:48:45 INFO - PROCESS | 1648 | RSS: Main: 370520064 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | __start_tp_report 14:48:45 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 14:48:45 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 14:48:45 INFO - PROCESS | 1648 | |i|pagename|runs| 14:48:45 INFO - PROCESS | 1648 | |0;ai-astar;114;115;114;114;114;115;114;115;115;114 14:48:45 INFO - PROCESS | 1648 | |1;audio-beat-detection;149;113;112;149;115;113;112;112;145;115 14:48:45 INFO - PROCESS | 1648 | |2;audio-dft;186;182;183;185;183;182;181;183;183;183 14:48:45 INFO - PROCESS | 1648 | |3;audio-fft;80;60;60;87;59;59;59;60;83;58 14:48:45 INFO - PROCESS | 1648 | |4;audio-oscillator;85;72;94;73;69;72;93;68;70;94 14:48:45 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;87;85;87;83;88;85;88;85;88;84 14:48:45 INFO - PROCESS | 1648 | |6;imaging-darkroom;94;93;93;93;94;93;92;94;93;94 14:48:45 INFO - PROCESS | 1648 | |7;imaging-desaturate;85;87;85;87;85;85;85;85;85;85 14:48:45 INFO - PROCESS | 1648 | |8;json-parse-financial;56;56;54;54;55;54;59;64;75;81 14:48:45 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;65;67;80;75;75;69;70;71;70;71 14:48:45 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;90;89;92;88;88;86;86;88;88;91 14:48:45 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;147;149;148;148;146;146;149;149;195;164 14:48:45 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;175;172;175;175;176;174;174;173;174;220 14:48:45 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;61;84;84;85;67;69;66;66;67;67 14:48:45 INFO - PROCESS | 1648 | __end_tp_report 14:48:45 INFO - PROCESS | 1648 | __start_cc_report 14:48:45 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1975 14:48:45 INFO - PROCESS | 1648 | __end_cc_report 14:48:45 INFO - PROCESS | 1648 | __startTimestamp1479854925231__endTimestamp 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | ------- Summary: start ------- 14:48:45 INFO - PROCESS | 1648 | Number of tests: 14 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:48:45 INFO - PROCESS | 1648 | Values: 114.0 115.0 114.0 114.0 114.0 115.0 114.0 115.0 115.0 114.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:115.00 stddev:16.75 (14.6%) stddev-sans-first:15.01 14:48:45 INFO - PROCESS | 1648 | Values: 149.0 113.0 112.0 149.0 115.0 113.0 112.0 112.0 145.0 115.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.00 stddev:1.45 (0.8%) stddev-sans-first:1.09 14:48:45 INFO - PROCESS | 1648 | Values: 186.0 182.0 183.0 185.0 183.0 182.0 181.0 183.0 183.0 183.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:66.50 Median:60.00 stddev:11.75 (19.6%) stddev-sans-first:11.40 14:48:45 INFO - PROCESS | 1648 | Values: 80.0 60.0 60.0 87.0 59.0 59.0 59.0 60.0 83.0 58.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:79.00 stddev:11.15 (14.1%) stddev-sans-first:11.61 14:48:45 INFO - PROCESS | 1648 | Values: 85.0 72.0 94.0 73.0 69.0 72.0 93.0 68.0 70.0 94.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:1.83 (2.1%) stddev-sans-first:1.90 14:48:45 INFO - PROCESS | 1648 | Values: 87.0 85.0 87.0 83.0 88.0 85.0 88.0 85.0 88.0 84.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 14:48:45 INFO - PROCESS | 1648 | Values: 94.0 93.0 93.0 93.0 94.0 93.0 92.0 94.0 93.0 94.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:0.84 (1.0%) stddev-sans-first:0.88 14:48:45 INFO - PROCESS | 1648 | Values: 85.0 87.0 85.0 87.0 85.0 85.0 85.0 85.0 85.0 85.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:57.50 stddev:9.67 (16.8%) stddev-sans-first:10.10 14:48:45 INFO - PROCESS | 1648 | Values: 56.0 56.0 54.0 54.0 55.0 54.0 59.0 64.0 75.0 81.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.00 stddev:4.35 (6.1%) stddev-sans-first:3.97 14:48:45 INFO - PROCESS | 1648 | Values: 65.0 67.0 80.0 75.0 75.0 69.0 70.0 71.0 70.0 71.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:88.50 stddev:1.96 (2.2%) stddev-sans-first:2.01 14:48:45 INFO - PROCESS | 1648 | Values: 90.0 89.0 92.0 88.0 88.0 86.0 86.0 88.0 88.0 91.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:149.00 stddev:15.29 (10.3%) stddev-sans-first:16.00 14:48:45 INFO - PROCESS | 1648 | Values: 147.0 149.0 148.0 148.0 146.0 146.0 149.0 149.0 195.0 164.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:175.00 stddev:14.52 (8.3%) stddev-sans-first:15.34 14:48:45 INFO - PROCESS | 1648 | Values: 175.0 172.0 175.0 175.0 176.0 174.0 174.0 173.0 174.0 220.0 14:48:45 INFO - PROCESS | 1648 | 14:48:45 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:68.00 stddev:9.02 (13.3%) stddev-sans-first:8.71 14:48:45 INFO - PROCESS | 1648 | Values: 61.0 84.0 84.0 85.0 67.0 69.0 66.0 66.0 67.0 67.0 14:48:45 INFO - PROCESS | 1648 | -------- Summary: end -------- 14:48:45 INFO - PROCESS | 1648 | 14:48:46 INFO - TEST-INFO | 1648: exit 0 14:48:46 INFO - TEST-OK | kraken | took 60617ms 14:48:46 INFO - SUITE-END | took 1180s 14:48:46 INFO - Completed test suite (00:19:41) 14:48:46 INFO - javascript benchmark 14:48:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3001.2796928737102, 3303.174206448388, 3308.5037244413334, 3329.8834540791077, 3386.153461634591, 5485.862853428666, 5594.720263986805, 5604.8038318658855, 5655.971720141399, 5689.772409103636, 5544.445555444454, 5566.137248726443, 5631.014572449825, 5633.915491267624, 5702.486776190152, 5064.392272927235, 5148.562372198349, 5171.612129090315, 5184.351956005499, 5199.584033277348, 5076.670016448919, 5193.558547523447, 5211.218317252424, 5233.9738301308635, 5244.763985620656, 4362.25841606926, 5202.791888324463, 5241.0, 5242.55438287746, 5254.474552544753, 5038.622103342264, 5098.821541246039, 5194.532492075694, 5221.582273418117, 5281.630285880009, 5074.847754567332, 5110.207917772751, 5137.280780690707, 5161.458046905059, 5216.347956505437, 5576.693281869496, 5587.580931430159, 5594.992901277768, 5607.467290607386, 5614.29821272341, 6103.084537319438, 6120.44915957566, 6129.049997250433, 6139.6009259398, 6148.907766383508, 6081.118237855486, 6105.558094708191, 6118.816435506942, 6122.79460843403, 6140.293866205354, 5680.5455563554815, 5717.113847353667, 5730.455606717355, 5733.82798516041, 5739.942600574024, 4608.815647374067, 6218.9427797274575, 6307.5269354798575, 6322.557420980579, 6334.398232167937, 5782.132680098019, 5822.184894114827, 6008.0, 6038.33578306386, 6054.969725151346, 6048.788292409745, 6090.969545152246, 6110.862540392742, 6135.845176233341, 6147.477464415485, 6075.3924607539775, 6115.240341084353, 6122.418474876009, 6140.894638965029, 6142.955697531431, 6099.022957501673, 6128.147594116181, 6174.598651087665, 6184.041473571604, 6193.411625895533, 4774.069056534012, 4844.660873738804, 4846.418429788448, 4864.927026094611, 4891.828785992473, 4307.935380969288, 4370.847020354272, 4381.737095774264, 4426.601605855489, 4443.178012067778, 4747.83382581608, 5668.461496157858, 5671.914921276184, 5690.0, 5691.430856914359, 6146.631202127886, 6190.1952746142715, 6191.4118158774845, 6204.100405441276, 6204.13142160098, 5421.918671219935, 5509.5041446270025, 5545.473180047889, 5611.831645050655, 5612.102063669793, 5240.371155461369, 5334.11987022137, 5339.41266460689, 5343.919841202385, 5388.407275199725, 6234.407731265523, 6234.9688251558455, 6254.468370188494, 6256.186695729526, 6259.4679452246155, 6038.154658347747, 6156.353582873734, 6218.22272215973, 6230.283517395557, 6237.1891654084675, 6208.937910620836, 6225.906611400742, 6240.781572644935, 6243.469305108935, 6278.717457714322, 6015.939840601538, 6065.090236464565, 6072.05883088122, 6110.877782444238, 6122.081687746873, 6146.661933593696, 6169.198004259597, 6179.443850053517, 6182.505399567934, 6212.130301757667, 5736.282964629421, 5825.242718446575, 5827.504662103769, 5859.179714839841, 5909.970450147722, 5757.596968212185, 5934.258217722785, 5939.346671866005, 5940.762369505172, 5941.0, 5750.194972703908, 5754.913676294943, 5767.221425107557, 5767.971160144172, 5771.59598828078, 5238.947610523998, 5704.229928959703, 5889.440503152194, 5927.110933360031, 5971.850703732442, 5757.193992841089, 5759.481646651821, 5760.942390576208, 5775.047117225611, 5779.7110144493445], "value": 5588.398858397663, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.8267310435641, 504.46022755651455, 506.44797171083513, 514.6783260462211, 561.6040691312625, 37885.0, 38776.0, 39047.41428878566, 39135.608643913554, 39277.41083883744, 39379.683742694724, 39784.80107599458, 39852.00369990752, 39887.0, 39972.0, 8379.329653627696, 9082.500462474562, 9142.588583513758, 9158.404703694272, 9221.631134754602, 8452.957735211347, 10881.782364352708, 11220.943895280512, 11232.943835280812, 11377.829332560019, 11153.386563738992, 11216.102711783038, 11236.438178091104, 11238.49426775793, 11277.605283815068, 8427.494350338999, 8626.353023523261, 11150.888491115065, 11218.439078046147, 11241.943790281079, 8552.315814734868, 8608.268297194745, 8635.179657932485, 10765.13878889687, 11100.888991110147, 37846.86459406222, 38068.80965595182, 38076.42885356722, 38095.238095238215, 38130.42804357937, 3153.9369212615848, 3174.5238214267815, 3178.3166619176986, 3251.463508521091, 3301.6863397977395, 28289.292767680767, 29705.554416683768, 29731.0, 29892.252693682614, 30011.549826752616, 3164.715175634204, 3207.1180425382972, 3228.6771322867526, 3291.144302481348, 3310.536524886518, 488470.0, 488832.0, 493386.0, 493664.0, 494037.0, 53027.0, 53191.46808531942, 54124.45875541273, 54386.0, 54402.0, 57824.132638010466, 57899.710501447225, 58059.709701451226, 58076.70961645165, 58130.41869581334, 15271.618209544627, 15511.301991410413, 15537.30082146306, 15540.689186216212, 15542.378304867678, 10923.726906827234, 11117.722056948642, 11128.221024528368, 12105.636830894911, 12184.634460966185, 11260.887391126147, 13543.525976590772, 13627.795583066261, 14738.705225895423, 15014.47449339268, 5119.564836988823, 5232.450592687789, 5404.243405923174, 6062.151298818169, 6075.149479072933, 887.6759982606302, 951.7192428233687, 1006.3509036671306, 1020.9642662506776, 1026.7022563456662, 28256.71743282582, 28537.714622853506, 28587.714122858506, 28763.712362876104, 28767.136985890458, 917.1516347378648, 1006.0894890124449, 1065.5950738719391, 1069.5346333768139, 1099.6474336566068, 14419.42322307117, 14506.347214375379, 14650.340734666966, 14948.476803311833, 14998.47505337308, 597941.0, 608593.0, 643058.0, 643817.0, 645151.0, 53753.65615859635, 54002.649933751185, 54005.729971349894, 54077.377678669705, 54104.72947635237, 1210.9455074521668, 1254.6612414647993, 1320.914140580859, 1345.7375811716818, 1364.5769811358512, 23703.64444533299, 27299.590506142027, 29148.27129321784, 29485.0, 29681.40637187201, 45148.0, 45654.77172614116, 45712.31431528463, 45729.54270457253, 45780.0, 422143.0, 486463.0, 487573.0, 488210.0, 490334.0, 24224.63663045091, 25672.229833105037, 25723.228303150936, 25729.970801167743, 25798.87100564485, 43819.342709860015, 48694.51305487042, 49090.0, 50561.49438505568, 51796.741016294676, 37456.0, 39409.80295098506, 39543.40684889672, 41012.76961691154, 41019.38470922879, 38459.80770096132, 38536.0, 38810.0, 38964.805175975074, 39974.800126000344, 38359.0, 38814.6118538811, 39295.0, 39327.41008884812, 39620.603793961694, 33060.33879322352, 33916.32167356589, 34523.65476345305, 34692.0, 34735.0, 24791.0, 25152.49695006126, 25368.0, 25799.484010319313, 25843.741562584135], "value": 19162.91757432424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.972563407242, 341.97948123112616, 346.9895903122907, 362.3170323939373, 373.10454908220265, 15216.467423640175, 16078.0, 18522.259109635597, 19547.315843945464, 20613.1754729811, 19585.0, 19916.302929397436, 19993.500162495944, 20440.386788396372, 20787.584248315026, 5324.520793128618, 5758.654480731148, 5797.36229014808, 5870.618409803349, 5874.353821079678, 5654.349749778787, 5746.224259724925, 5881.7353219105025, 5884.852878678046, 5985.4912332451795, 6021.939780602203, 6053.303870054956, 6067.605605635642, 6067.939320606803, 6076.118962750398, 5802.622829516089, 5997.940020599782, 6070.453659170696, 6076.6050206736645, 6087.391260873877, 5855.853603659943, 5857.824265272048, 5857.941420585782, 5861.531077513789, 5867.794627188028, 12524.24660547524, 12704.555340563036, 12816.35918204086, 13009.414576344087, 13013.414396352187, 2293.3693234360685, 2328.4528135888054, 2453.766892145243, 2855.5431131018936, 2862.8139170954028, 8783.34124940632, 9721.027897210293, 9733.415995040321, 10130.696079117564, 10317.58729650813, 1807.204829874864, 1872.2885303584687, 1893.1670065171281, 1920.2606996306383, 1920.9135588898532, 116799.41600291945, 121938.0, 125032.0, 126043.0, 129060.35469822779, 10992.725181870517, 11318.037966772752, 11425.714357140972, 11436.885631143748, 11612.535498579962, 14315.355808988621, 14321.928390358189, 14330.856691432953, 14341.713165736626, 14364.209968451627, 8040.959795200986, 8357.91737787733, 8411.495310281403, 8525.275351595059, 8540.658373664985, 7027.578345299298, 8122.106568277485, 8278.8344233115, 8287.254147126787, 8500.574971251413, 4000.239954408653, 4458.7324760514475, 4473.0, 4521.796519156645, 4596.080783843245, 1567.6942996115877, 1768.7435321878256, 1825.8174182581902, 1834.4955137337072, 1908.274855554908, 846.5597889097635, 849.8470275350496, 862.0388267082284, 930.3022732950287, 936.7423958411491, 19311.130999105073, 19407.320743774184, 19847.60304793896, 20811.583768324548, 20887.47781305449, 872.9301655867515, 882.3073886998675, 894.8434024045766, 901.3735453859636, 907.5932304927336, 8105.878411823827, 8832.690855820145, 10059.949700251453, 10768.730781730363, 11660.017796974535, 579163.0, 602695.0, 604453.0, 617061.9146904236, 617773.0, 107424.0, 126646.73353266534, 131918.0, 140681.5931840689, 141105.0, 896.744427838076, 914.6890057380523, 999.1507218864053, 1012.9696109116738, 1019.0675531888387, 16193.838061619233, 16202.918985404998, 18186.0, 18403.631927361646, 18661.066946652343, 45814.54185458236, 49702.0, 50720.74639626778, 51242.74378628083, 52300.95398092093, 74218.62890685513, 75912.0, 77035.2296477028, 77917.0, 78669.0, 6435.356464353527, 6491.415772580491, 7965.721199758213, 8192.672293108448, 8209.029832840195, 11338.433078346216, 12724.872751272369, 12747.49010039588, 13209.735805283648, 13253.867461325262, 10911.0, 11066.889331106586, 11337.489812958273, 11405.486753095965, 11436.542538298374, 10925.344479331265, 11167.49746261404, 11248.493817778057, 11269.492872820907, 11561.0, 10876.347419154876, 11301.41780150763, 11537.0, 11586.594469193538, 11662.70843228892, 7859.0, 8045.758627241192, 8140.877886831584, 8191.79520511992, 8221.260086592236, 10250.948745256226, 11137.554497819996, 11246.437678116225, 11287.20989530725, 11294.983451489405], "value": 9233.788092967185, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.37254166979, 1505.0593379138038, 1674.430693564188, 1808.385149049323, 1846.8614853885954, 8111.91888081119, 8527.744167674971, 8528.275096616795, 8535.61589728463, 8559.44363616366, 7396.630168491581, 7673.769786906388, 7674.232576742337, 7993.840123197532, 8331.333493320535, 2275.6131457652195, 2313.9190128345513, 2314.3172764034566, 2320.582295186866, 2322.2104484475276, 1990.28349794074, 2304.7119110111234, 2331.3821837213154, 2348.0842471436154, 2349.1543044503965, 2285.919992800252, 2292.9770702293013, 2314.594945884472, 2314.8611083335054, 2333.7899589036983, 2285.405794493435, 2313.7570555091643, 2315.710536182977, 2315.8494697844753, 2319.4549280918973, 2133.25336132354, 2211.845170838042, 2289.553537060274, 2322.072679675865, 2331.0209711920866, 8252.381071419668, 8264.793380165484, 8368.748937531884, 8375.958120209421, 8386.748397548083, 4997.375328083989, 5152.278680984665, 5155.175171972504, 5167.9224811627855, 5174.301469301634, 3251.6098068231727, 3279.5900512435946, 3446.965530344715, 3512.683858452726, 3520.471929210639, 1050.4275170032274, 1069.5080263078994, 1091.7106966653844, 1092.1372116028328, 1097.5554900265406, 10345.534450949724, 10703.83944240837, 10892.0, 10985.90140985903, 11007.0, 3754.81225938702, 4342.804573794187, 4433.024734558392, 4447.466304043535, 4448.621867141264, 8645.870311945326, 8646.048934617187, 8660.263877570476, 8663.78340541479, 8673.349498787617, 5085.084684756779, 5092.083424983539, 5093.5161159690515, 5098.566621837185, 5102.897942041139, 4250.192463431938, 4321.2005778931, 4650.883727906762, 4803.519648035239, 4821.493743156988, 3516.2440075383915, 3543.1850674345046, 3584.4085725854943, 3600.369935261319, 3623.1847834237087, 1108.2851560743275, 1117.379854180921, 1117.580907159815, 1129.1474936422949, 1137.203957229926, 753.7248904149945, 761.4289283037722, 843.7342237195264, 877.7404424650647, 904.7017529844562, 5484.670919744828, 5629.943700563023, 5766.336871259775, 5788.160716696056, 5897.823065308047, 839.937479088953, 880.8898887639045, 910.8022949820964, 919.8758167647281, 920.5121285718446, 3561.412366959423, 3709.795961222159, 3783.4703141560203, 3786.4888240087234, 3932.3708206686792, 7887.48731332473, 10259.58961641541, 10399.68800935958, 10402.375857448576, 10424.322419042737, 10340.37957722539, 10362.274640775224, 10366.378017318984, 10384.0, 10391.37651740898, 7406.962965185247, 7721.382289416833, 7867.449278550561, 7912.525248485109, 7941.285284324438, 5513.531349835149, 5803.448672376117, 5852.092925596539, 5909.674967876808, 5917.260342457193, 7786.805329866572, 9058.818823623622, 9107.772305692411, 9356.859647105162, 9389.859152112587, 9334.626614935598, 9496.905030949878, 9569.234461242944, 9590.712278631652, 9707.66023189185, 6066.726997285221, 7159.928400715926, 7163.2478589747325, 7703.53778773253, 7759.495632783851, 7676.501027433199, 7931.484453510503, 7977.441579089408, 8057.355411566943, 8068.1528439513, 7097.787066388017, 7119.0, 7126.964365178141, 7143.178534468395, 7159.785206443815, 6831.966374305362, 6902.094640854939, 6909.0, 7070.328318809705, 7126.643667816485, 5687.658740475585, 6623.403893649402, 6639.6680165992475, 6704.06143139951, 6716.093327400738, 4773.9045219096115, 4786.114568804782, 4826.276058591239, 4836.661433699607, 4968.8757781055765, 4500.703234880409, 4519.276915693474, 4583.54164583539, 4620.745858977654, 4743.1225223333795], "value": 4358.176684433905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.8768322729929, 267.6039461596837, 298.76248382535886, 305.18819938962366, 312.88110518003157, 4682.531746825316, 4837.951620483798, 5277.877661912183, 5398.811041613544, 5454.963327137914, 4992.904399272456, 5104.489551044893, 5159.529534082787, 5189.299444574981, 5266.289050978116, 3250.561174241471, 4056.2495938251445, 4084.060666046796, 4088.6524645405175, 4095.8736347504378, 4075.0, 4098.262312783698, 4110.938335924963, 4111.362738775495, 4144.958550414487, 3093.613298337708, 3849.634284742945, 3965.6430921217084, 4047.9392809107885, 4061.675065994728, 3823.3118038753014, 3987.288643722268, 4005.499312585927, 4009.3384591542363, 4022.1955608878343, 3327.4842399428126, 3442.2599141184764, 3483.494893240466, 3492.0396890854963, 3502.7215066500544, 4961.627877909135, 5035.471275516054, 5152.330197074356, 5236.476352364771, 5260.8684782880355, 4535.0, 4544.7045942013665, 4558.8632341029825, 4568.200564901163, 4594.402727645418, 5101.923471147936, 5524.613277070606, 5531.197976293455, 5554.861128471821, 5617.662940223599, 3191.1543440988157, 3697.574778900434, 3794.2790869734663, 3794.4687743715904, 3815.1797363566966, 5108.66793658411, 5739.794643124948, 5767.653940763567, 5793.623414478046, 5828.446297601678, 3236.158598764291, 3256.1439979212096, 3439.914002149966, 3541.4864844597905, 3862.8261728222296, 3918.295541439483, 3961.8217180226957, 3971.0469487322835, 3973.980130099331, 3980.104476492766, 3975.920481590352, 4404.383386325917, 4443.866683999485, 4599.620113965797, 4601.723896566216, 5521.365043020024, 5534.916976245359, 5566.025945459528, 5570.637908535932, 5571.582131340085, 1127.9679093629238, 1174.4597485156924, 1206.324458303353, 1223.8164275358768, 1258.5783762439503, 805.9879101813477, 840.5293035899915, 847.559269180023, 858.9785255368665, 863.1972265792873, 4492.842750503782, 4875.878103047452, 4950.480199579064, 4969.925451118236, 5028.371453568304, 4835.637327200404, 4963.801447942042, 5051.318072060225, 5446.782128714886, 5457.426970168154, 4236.618704316565, 4656.092062047868, 4714.915569419053, 4861.440934292531, 4992.72540010303, 2401.6997875265592, 2558.6950655166, 2636.670416197975, 2854.9857250713612, 2916.606258155164, 5061.797528098835, 5107.540321371094, 5273.973630131902, 5331.680099194061, 5772.451617096369, 4957.652964292465, 5499.532539734088, 5519.972400138054, 5534.0, 5632.873425314953, 4967.82612608557, 5202.869928251824, 5575.665460072328, 5582.720863956786, 5672.886542269214, 5109.74451277442, 5355.036093503207, 5371.838844834661, 5379.569634429315, 5464.1257398816, 4564.520725323793, 5188.936268065113, 5200.605488362327, 5421.909511578362, 5436.592255580927, 4970.918030820914, 5173.430922598586, 5686.782154959652, 5702.600817942704, 5721.968701111045, 3597.730170237295, 3684.889453316405, 3702.2052396294016, 3873.6901047915535, 3913.295606790805, 5807.8548036299435, 5839.824805255679, 5850.6782126981725, 5860.0, 5861.531077513703, 4650.930236046394, 5584.441555844383, 5654.264945557051, 5681.2330335404195, 5742.483176514133, 4527.501974782837, 4951.356323677899, 4980.31063225854, 5282.630215885005, 5754.906567752114, 4320.632746216606, 5317.654352467077, 5562.721863906708, 5614.775408983595, 5628.774849006158, 5214.556762675215, 5229.8755767510165, 5314.654547454403, 5333.146696528537, 5512.724363781875, 4577.221872281653, 5473.0, 5548.69482178484, 5565.721713914207, 5597.664140151441], "value": 3978.7873470597237, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.5363630913123, 671.8320419895026, 672.5762769455242, 766.8006318357227, 781.9873264122967, 10272.794544109123, 13765.105268157587, 14219.0, 14714.55856324312, 14743.336549855256, 11135.72160695983, 13153.802692959613, 13162.670933226675, 13212.801807972864, 13323.0, 803.036356372354, 816.1145157504086, 817.166490180016, 817.6116344736232, 820.6430202861774, 653.6927644007333, 676.6988690032937, 822.7984143884727, 826.2522417212402, 829.241244261503, 697.2574208467965, 835.4402550291289, 858.4205661178679, 864.7708357285293, 869.9869501957476, 857.3484152044429, 858.9226969572705, 859.2910848549972, 862.6851199312206, 864.6282098697558, 503.7179179659366, 642.7107801489349, 645.0, 645.1935081148564, 645.9128017717595, 11803.527858885634, 13647.454101835914, 13965.162090274514, 14135.0, 14187.503437379642, 11406.372649504274, 13449.0, 13708.93145534266, 13801.654958626013, 13815.585532434043, 11166.218364714392, 11197.944010279978, 11252.943735281353, 11259.774804503864, 11716.648500544998, 3612.843889955215, 3627.43774714917, 3676.2279921216577, 3703.6296370363016, 3718.4980027696456, 63323.6833815828, 81065.59467202626, 81309.78035329474, 82770.58614706948, 83125.0, 10549.578016879239, 10556.419396933243, 10590.470476476145, 10639.946800266103, 11038.613648522263, 20892.37322880316, 21069.47326316824, 21153.57692846165, 21170.682439763415, 21429.89285053565, 7447.069116360455, 7462.4776265660885, 7528.887066694004, 7531.322181003736, 7725.768226953201, 3788.3749181384765, 4112.300908845504, 4187.832486700559, 4209.621134097946, 4210.705250632426, 3357.1271469418125, 3573.446115852047, 3739.457778622139, 3746.3631182699005, 3757.6242375762204, 676.9153855768029, 690.8411065454974, 697.1390332938817, 700.0129816958166, 701.3197198717236, 566.7591273708657, 612.5191724496249, 631.9083732858802, 645.8837409266378, 652.0910948500629, 6973.978735310669, 7871.291583757489, 8397.489810441857, 8509.155010233086, 8595.097514760984, 532.5792623827133, 628.3622123544606, 632.7975047984601, 636.3763511758502, 644.8774732800847, 4060.6548443382644, 4212.136512015029, 4231.196072746168, 4286.485621725351, 4336.848210312624, 82825.58587207025, 99071.0, 108919.01890792006, 109884.0, 118288.40855795838, 97282.54076188862, 102059.0, 102896.0, 103391.0, 103725.0, 81458.18541814624, 82494.0, 83364.0, 85942.57028714941, 89572.10427895767, 7725.266099720518, 8184.631691573774, 8213.58932053383, 8377.49735015901, 8553.97352317726, 45976.31035534536, 49211.75394123006, 49233.507664922894, 53085.734571326895, 55714.442855570924, 46286.53713462822, 55787.605309865954, 58362.12456813066, 70289.0, 78382.6080869592, 12185.0, 12202.084843636585, 12387.566435174725, 12607.43266552989, 12686.555970540987, 13852.72294554083, 13987.650308742363, 14057.507987220399, 14347.354369053626, 14448.422063117358, 12763.489460421479, 12801.487940482277, 12996.48014079464, 13347.532836350681, 13440.731185376433, 12861.2926289055, 12965.935170324088, 13163.53927612529, 13517.662058448617, 13830.792538111735, 10240.436775977392, 12743.87256127427, 12812.039097067944, 12895.806562901376, 13033.608991730263, 8637.913620863963, 10556.31816707028, 10573.577056917637, 10925.945370273097, 10931.234813562975, 10521.579136834442, 10579.94710026445, 10647.787044258917, 10699.358038517403, 10703.411312377893], "value": 7092.126886984779, "unit": "score"}], "name": "dromaeo_css", "value": 7038.844501186674, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 113.0, 112.0, 149.0, 115.0, 113.0, 112.0, 112.0, 145.0, 115.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 183.0, 185.0, 183.0, 182.0, 181.0, 183.0, 183.0, 183.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 87.0, 59.0, 59.0, 59.0, 60.0, 83.0, 58.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 72.0, 94.0, 73.0, 69.0, 72.0, 93.0, 68.0, 70.0, 94.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 83.0, 88.0, 85.0, 88.0, 85.0, 88.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 93.0, 94.0, 93.0, 92.0, 94.0, 93.0, 94.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 85.0, 87.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 54.0, 54.0, 55.0, 54.0, 59.0, 64.0, 75.0, 81.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 80.0, 75.0, 75.0, 69.0, 70.0, 71.0, 70.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 92.0, 88.0, 88.0, 86.0, 86.0, 88.0, 88.0, 91.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 148.0, 146.0, 146.0, 149.0, 149.0, 195.0, 164.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 175.0, 175.0, 176.0, 174.0, 174.0, 173.0, 174.0, 220.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 84.0, 84.0, 85.0, 67.0, 69.0, 66.0, 66.0, 67.0, 67.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1456.3999999999996, "alertThreshold": 2.0}]} 14:48:46 INFO - Return code: 0 14:48:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:48:46 INFO - # TBPL SUCCESS # 14:48:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:48:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:48:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:48:46 INFO - 2016-11-22 14:48:46.560 screenresolution[1652:10002] starting screenresolution argv=screenresolution get 14:48:46 INFO - 2016-11-22 14:48:46.565 screenresolution[1652:10002] Display 0: 1600x1200x32@60 14:48:46 INFO - 2016-11-22 14:48:46.570 screenresolution[1653:10005] starting screenresolution argv=screenresolution list 14:48:46 INFO - Available Modes on Display 0 14:48:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:48:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:48:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:48:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:48:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:48:46 INFO - Intel Iris: 14:48:46 INFO - Chipset Model: Intel Iris 14:48:46 INFO - Type: GPU 14:48:46 INFO - Bus: Built-In 14:48:46 INFO - VRAM (Dynamic, Max): 1536 MB 14:48:46 INFO - Vendor: Intel (0x8086) 14:48:46 INFO - Device ID: 0x0a2e 14:48:46 INFO - Revision ID: 0x0009 14:48:46 INFO - Displays: 14:48:46 INFO - Display: 14:48:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:48:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:48:46 INFO - Display Serial Number: 1600x1200 60 14:48:46 INFO - Main Display: Yes 14:48:46 INFO - Mirror: Off 14:48:46 INFO - Online: Yes 14:48:46 INFO - Rotation: Supported 14:48:46 INFO - Return code: 0 14:48:46 INFO - Running post-action listener: _resource_record_post_action 14:48:46 INFO - [mozharness: 2016-11-22 22:48:46.810397Z] Finished run-tests step (success) 14:48:46 INFO - Running post-run listener: _resource_record_post_run 14:48:46 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37680128; Write bytes: 691074048; Read time: 271; Write time: 1979 14:48:46 INFO - TinderboxPrint: CPU usage
53.7% 14:48:46 INFO - TinderboxPrint: I/O read bytes / time
37,680,128 / 271 14:48:46 INFO - TinderboxPrint: I/O write bytes / time
691,074,048 / 1,979 14:48:46 INFO - TinderboxPrint: CPU idle
2,247.4 (46.3%) 14:48:46 INFO - TinderboxPrint: CPU system
974.0 (20.0%) 14:48:46 INFO - TinderboxPrint: CPU user
1,636.3 (33.7%) 14:48:46 INFO - TinderboxPrint: Swap in / out
420,868,096 / 0 14:48:46 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 382589440; Write bytes: 377219072; Read time: 29129; Write time: 805 14:48:46 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 34481152; Write bytes: 303479808; Read time: 219; Write time: 1141 14:48:47 INFO - Running post-run listener: _upload_blobber_files 14:48:47 INFO - Blob upload gear active. 14:48:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:48:47 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:48:47 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:48:47 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:48:47 INFO - (blobuploader) - INFO - Open directory for files ... 14:48:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:48:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:48:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:48 INFO - (blobuploader) - INFO - Done attempting. 14:48:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:48:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:48:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:49 INFO - (blobuploader) - INFO - Done attempting. 14:48:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:48:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:48:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:52 INFO - (blobuploader) - INFO - Done attempting. 14:48:52 INFO - (blobuploader) - INFO - Iteration through files over. 14:48:52 INFO - Return code: 0 14:48:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:48:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:48:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eca857c2661bec221ca53a5700e10727acc29946f1720fd023785c4bcc5802becf97977fbb6a95ba3ba48e9bc07e5703069c67e57ec0f6e57364d47b668656fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f63a37df9ca9f45f14760f3d9b05991b8ddd645ad70c56146bf0ebcaf5b1bd7f6e2d4da588351e1ea5d228473ec88275f17eebb82892f58ad2b8261a31abafa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b3391946fdc6d3b867a292b4d68daaa32266ba4c92e575e33f6ad21a0cba662b30f909b628e2f236584f31770fbe441d8766383f4691df3656b20a549f22a97"} 14:48:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:48:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:48:52 INFO - Contents: 14:48:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eca857c2661bec221ca53a5700e10727acc29946f1720fd023785c4bcc5802becf97977fbb6a95ba3ba48e9bc07e5703069c67e57ec0f6e57364d47b668656fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f63a37df9ca9f45f14760f3d9b05991b8ddd645ad70c56146bf0ebcaf5b1bd7f6e2d4da588351e1ea5d228473ec88275f17eebb82892f58ad2b8261a31abafa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b3391946fdc6d3b867a292b4d68daaa32266ba4c92e575e33f6ad21a0cba662b30f909b628e2f236584f31770fbe441d8766383f4691df3656b20a549f22a97"} 14:48:52 INFO - Running post-run listener: copy_logs_to_upload_dir 14:48:52 INFO - Copying logs to upload dir... 14:48:52 INFO - mkdir: /builds/slave/test/build/upload/logs 14:48:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.757634 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-11-22 14:48:52.443983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 14:48:52.456663) ========= 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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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/Graphics/sha512/eca857c2661bec221ca53a5700e10727acc29946f1720fd023785c4bcc5802becf97977fbb6a95ba3ba48e9bc07e5703069c67e57ec0f6e57364d47b668656fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f63a37df9ca9f45f14760f3d9b05991b8ddd645ad70c56146bf0ebcaf5b1bd7f6e2d4da588351e1ea5d228473ec88275f17eebb82892f58ad2b8261a31abafa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b3391946fdc6d3b867a292b4d68daaa32266ba4c92e575e33f6ad21a0cba662b30f909b628e2f236584f31770fbe441d8766383f4691df3656b20a549f22a97"} build_url:https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010901 build_url: 'https://queue.taskcluster.net/v1/task/Dn6vgelbTQmaLPB-CzmrBw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/eca857c2661bec221ca53a5700e10727acc29946f1720fd023785c4bcc5802becf97977fbb6a95ba3ba48e9bc07e5703069c67e57ec0f6e57364d47b668656fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/f63a37df9ca9f45f14760f3d9b05991b8ddd645ad70c56146bf0ebcaf5b1bd7f6e2d4da588351e1ea5d228473ec88275f17eebb82892f58ad2b8261a31abafa6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9b3391946fdc6d3b867a292b4d68daaa32266ba4c92e575e33f6ad21a0cba662b30f909b628e2f236584f31770fbe441d8766383f4691df3656b20a549f22a97"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 14:48:52.493433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 14:48:52.493821) ========= 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.oJINOobP5Z/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.sMbgg5Gt2y/Listeners TMPDIR=/var/folders/74/b6n0j0694jj3lchy6lrg3v1w00000w/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.005172 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 14:48:52.543034) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 14:48:52.545470) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 14:48:52.545784) ========= ========= Total master_lag: 0.20 =========